-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-04-16 12:19:19 CEST. -- Apr 16 12:18:04 volumiowohnzimmer kernel: sdhci: Copyright(c) Pierre Ossman Apr 16 12:18:04 volumiowohnzimmer kernel: sdhci-pltfm: SDHCI platform and OF driver helper Apr 16 12:18:04 volumiowohnzimmer kernel: ledtrig-cpu: registered to indicate activity on CPUs Apr 16 12:18:04 volumiowohnzimmer kernel: hid: raw HID events driver (C) Jiri Kosina Apr 16 12:18:04 volumiowohnzimmer kernel: usbcore: registered new interface driver usbhid Apr 16 12:18:04 volumiowohnzimmer kernel: usbhid: USB HID core driver Apr 16 12:18:04 volumiowohnzimmer kernel: Initializing XFRM netlink socket Apr 16 12:18:04 volumiowohnzimmer kernel: NET: Registered PF_PACKET protocol family Apr 16 12:18:04 volumiowohnzimmer kernel: Key type dns_resolver registered Apr 16 12:18:04 volumiowohnzimmer kernel: Registering SWP/SWPB emulation handler Apr 16 12:18:04 volumiowohnzimmer kernel: registered taskstats version 1 Apr 16 12:18:04 volumiowohnzimmer kernel: Loading compiled-in X.509 certificates Apr 16 12:18:04 volumiowohnzimmer kernel: Key type .fscrypt registered Apr 16 12:18:04 volumiowohnzimmer kernel: Key type fscrypt-provisioning registered Apr 16 12:18:04 volumiowohnzimmer kernel: uart-pl011 3f201000.serial: cts_event_workaround enabled Apr 16 12:18:04 volumiowohnzimmer kernel: 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 114, base_baud = 0) is a PL011 rev2 Apr 16 12:18:04 volumiowohnzimmer kernel: printk: console [ttyAMA0] enabled Apr 16 12:18:04 volumiowohnzimmer kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Apr 16 12:18:04 volumiowohnzimmer kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Apr 16 12:18:04 volumiowohnzimmer kernel: sdhost: log_buf @ 3ee99535 (f4113000) Apr 16 12:18:04 volumiowohnzimmer kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Apr 16 12:18:04 volumiowohnzimmer kernel: of_cfs_init Apr 16 12:18:04 volumiowohnzimmer kernel: of_cfs_init: OK Apr 16 12:18:04 volumiowohnzimmer kernel: Freeing unused kernel image (initmem) memory: 1024K Apr 16 12:18:04 volumiowohnzimmer kernel: Indeed it is in host mode hprt0 = 00021501 Apr 16 12:18:04 volumiowohnzimmer kernel: mmc0: host does not support reading read-only switch, assuming write-enable Apr 16 12:18:04 volumiowohnzimmer kernel: mmc0: new high speed SDHC card at address aaaa Apr 16 12:18:04 volumiowohnzimmer kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB Apr 16 12:18:04 volumiowohnzimmer kernel: Run /init as init process Apr 16 12:18:04 volumiowohnzimmer kernel: with arguments: Apr 16 12:18:04 volumiowohnzimmer kernel: /init Apr 16 12:18:04 volumiowohnzimmer kernel: splash Apr 16 12:18:04 volumiowohnzimmer kernel: with environment: Apr 16 12:18:04 volumiowohnzimmer kernel: HOME=/ Apr 16 12:18:04 volumiowohnzimmer kernel: TERM=linux Apr 16 12:18:04 volumiowohnzimmer kernel: imgpart=/dev/mmcblk0p2 Apr 16 12:18:04 volumiowohnzimmer kernel: imgfile=/volumio_current.sqsh Apr 16 12:18:04 volumiowohnzimmer kernel: bootdelay=5 Apr 16 12:18:04 volumiowohnzimmer kernel: mmcblk0: p1 p2 p3 Apr 16 12:18:04 volumiowohnzimmer kernel: mmcblk0: mmc0:aaaa SC16G 14.8 GiB (quirks 0x00004000) Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg Apr 16 12:18:04 volumiowohnzimmer kernel: Indeed it is in host mode hprt0 = 00001101 Apr 16 12:18:04 volumiowohnzimmer initramfs: Booting Volumio for BCM2835 Apr 16 12:18:04 volumiowohnzimmer initramfs: This script mounts rootfs RO with an overlay RW layer. Apr 16 12:18:04 volumiowohnzimmer kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 16 12:18:04 volumiowohnzimmer kernel: hub 1-1:1.0: USB hub found Apr 16 12:18:04 volumiowohnzimmer kernel: hub 1-1:1.0: 5 ports detected Apr 16 12:18:04 volumiowohnzimmer initramfs: IMGPART=/dev/mmcblk0p2 Apr 16 12:18:04 volumiowohnzimmer initramfs: IMGFILE=/volumio_current.sqsh Apr 16 12:18:04 volumiowohnzimmer initramfs: Boot delay (except first time) will be 5 seconds Apr 16 12:18:04 volumiowohnzimmer initramfs: /dev/mmcblk0p2: Apr 16 12:18:04 volumiowohnzimmer kernel: EXT4-fs (mmcblk0p2): recovery complete Apr 16 12:18:04 volumiowohnzimmer kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Apr 16 12:18:04 volumiowohnzimmer initramfs: Doing a 5 second delay here to give kernel load a headstart Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 Apr 16 12:18:04 volumiowohnzimmer kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Apr 16 12:18:04 volumiowohnzimmer kernel: smsc95xx v2.0.0 Apr 16 12:18:04 volumiowohnzimmer kernel: SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=199) Apr 16 12:18:04 volumiowohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:0d:ca:64 Apr 16 12:18:04 volumiowohnzimmer initramfs: Checking for USB updates Apr 16 12:18:04 volumiowohnzimmer initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Apr 16 12:18:04 volumiowohnzimmer kernel: loop0: detected capacity change from 0 to 967536 Apr 16 12:18:04 volumiowohnzimmer kernel: EXT4-fs (mmcblk0p3): recovery complete Apr 16 12:18:04 volumiowohnzimmer kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Apr 16 12:18:04 volumiowohnzimmer initramfs: With Option: Apr 16 12:18:04 volumiowohnzimmer initramfs: VOLUMIO_VERSION="3.631" Apr 16 12:18:04 volumiowohnzimmer initramfs: Finish initramfs, continue booting Volumio Apr 16 12:18:04 volumiowohnzimmer systemd[1]: System time before build time, advancing clock. Apr 16 12:18:04 volumiowohnzimmer kernel: NET: Registered PF_INET6 protocol family Apr 16 12:18:04 volumiowohnzimmer kernel: Segment Routing with IPv6 Apr 16 12:18:04 volumiowohnzimmer kernel: In-situ OAM (IOAM) with IPv6 Apr 16 12:18:04 volumiowohnzimmer 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) Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Detected architecture arm. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Set hostname to . Apr 16 12:18:04 volumiowohnzimmer kernel: uart-pl011 3f201000.serial: no DMA platform data Apr 16 12:18:04 volumiowohnzimmer 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. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Listening on Journal Socket (/dev/log). Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Listening on RPCbind Server Activation Socket. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Created slice system-getty.slice. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Created slice User and Session Slice. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Created slice system-systemd\x2dfsck.slice. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Listening on fsck to fsckd communication Socket. Apr 16 12:18:04 volumiowohnzimmer kernel: i2c_dev: i2c /dev entries driver Apr 16 12:18:04 volumiowohnzimmer systemd-journald[196]: Journal started Apr 16 12:18:04 volumiowohnzimmer systemd-journald[196]: Runtime journal (/run/log/journal/4f62df4b7e374c47e98bbc1f6425ae06) is 7.5M, max 30.0M, 22.5M free. Apr 16 12:18:04 volumiowohnzimmer systemd-modules-load[191]: Inserted module 'i2c_dev' Apr 16 12:18:04 volumiowohnzimmer fake-hwclock[190]: Tue Apr 16 10:18:04 UTC 2024 Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Apply Kernel Variables. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Load/Save Random Seed. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: dynamicswap.service: Succeeded. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Create System Users. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Starting Create Static Device Nodes in /dev... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started udev Coldplug all Devices. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Starting Helper to synchronize boot up for ifupdown... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Create Static Device Nodes in /dev. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Starting udev Kernel Device Manager... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Reached target Local File Systems (Pre). Apr 16 12:18:04 volumiowohnzimmer systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounting /tmp... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounting /var/spool/cups... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounting /var/log... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounted /tmp. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Helper to synchronize boot up for ifupdown. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounted /var/spool/cups. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounted /var/log. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Starting Flush Journal to Persistent Storage... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounting /var/spool/cups/tmp... Apr 16 12:18:04 volumiowohnzimmer systemd-udevd[222]: Network interface NamePolicy= disabled on kernel command line, ignoring. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Mounted /var/spool/cups/tmp. Apr 16 12:18:04 volumiowohnzimmer systemd-journald[196]: Runtime journal (/run/log/journal/4f62df4b7e374c47e98bbc1f6425ae06) is 7.5M, max 30.0M, 22.5M free. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Flush Journal to Persistent Storage. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started udev Kernel Device Manager. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Starting Show Plymouth Boot Screen... Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Received SIGRTMIN+20 from PID 242 (plymouthd). Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Show Plymouth Boot Screen. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Reached target Local Encrypted Volumes. Apr 16 12:18:04 volumiowohnzimmer systemd[1]: Reached target Paths. Apr 16 12:18:05 volumiowohnzimmer kernel: mc: Linux media interface: v0.10 Apr 16 12:18:05 volumiowohnzimmer kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Apr 16 12:18:05 volumiowohnzimmer kernel: [vc_sm_connected_init]: start Apr 16 12:18:05 volumiowohnzimmer kernel: [vc_sm_connected_init]: installed successfully Apr 16 12:18:05 volumiowohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Apr 16 12:18:05 volumiowohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Apr 16 12:18:05 volumiowohnzimmer kernel: videodev: Linux video capture interface: v2.00 Apr 16 12:18:05 volumiowohnzimmer systemd[1]: Found device /dev/ttyAMA0. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 16 12:18:05 volumiowohnzimmer kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Apr 16 12:18:06 volumiowohnzimmer systemd-udevd[231]: Using default interface naming scheme 'v240'. Apr 16 12:18:06 volumiowohnzimmer systemd-udevd[231]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 16 12:18:06 volumiowohnzimmer systemd-udevd[235]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 16 12:18:07 volumiowohnzimmer systemd[1]: Found device /dev/mmcblk0p1. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in Huge Pages File System being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 16 12:18:08 volumiowohnzimmer systemd[1]: Starting File System Check on /dev/mmcblk0p1... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started File System Check Daemon to report status. Apr 16 12:18:09 volumiowohnzimmer systemd-fsck[357]: fsck.fat 4.1 (2017-01-24) Apr 16 12:18:09 volumiowohnzimmer systemd-fsck[357]: /dev/mmcblk0p1: 371 files, 33358/46774 clusters Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started File System Check on /dev/mmcblk0p1. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Mounting /boot... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Mounted /boot. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Reached target Local File Systems. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting Create Volatile Files and Directories... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting Raise network interfaces... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started ifup for eth0. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting Preprocess NFS configuration... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Received SIGRTMIN+20 from PID 242 (plymouthd). Apr 16 12:18:09 volumiowohnzimmer systemd[1]: plymouth-read-write.service: Succeeded. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: nfs-config.service: Succeeded. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started Preprocess NFS configuration. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Reached target NFS client services. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started Create Volatile Files and Directories. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Starting RPC bind portmap service... Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Apr 16 12:18:09 volumiowohnzimmer kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Reached target System Initialization. Apr 16 12:18:09 volumiowohnzimmer systemd[1]: Listening on triggerhappy.socket. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Volumio Splash. Apr 16 12:18:10 volumiowohnzimmer systemd[394]: volumiosplash.service: Failed to execute command: No such file or directory Apr 16 12:18:10 volumiowohnzimmer systemd[394]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Daily apt download activities. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Daily apt upgrade and clean activities. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Sockets. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Timers. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Basic System. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started volumio-remote-updater.service. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Manage Sound Card State (restore and store). Apr 16 12:18:10 volumiowohnzimmer kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Apr 16 12:18:10 volumiowohnzimmer kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Apr 16 12:18:10 volumiowohnzimmer kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting triggerhappy global hotkey daemon... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Apr 16 12:18:10 volumiowohnzimmer alsactl[404]: alsactl 1.1.8 daemon started Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting Login Service... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Volumio Iptables Module. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting Wireless Services... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting dhcpcd on all interfaces... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting Save/Restore Sound Card State... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started D-Bus System Message Bus. Apr 16 12:18:10 volumiowohnzimmer thd[405]: Unable to parse trigger line: Apr 16 12:18:10 volumiowohnzimmer ifup[364]: command failed: No such device (-19) Apr 16 12:18:10 volumiowohnzimmer thd[405]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Apr 16 12:18:10 volumiowohnzimmer thd[405]: Unable to parse trigger line: Apr 16 12:18:10 volumiowohnzimmer thd[405]: Found socket passed from systemd Apr 16 12:18:10 volumiowohnzimmer dhcpcd[414]: Not running dhcpcd because /etc/network/interfaces Apr 16 12:18:10 volumiowohnzimmer dhcpcd[414]: defines some interfaces that will use a Apr 16 12:18:10 volumiowohnzimmer dhcpcd[414]: DHCP client or static address Apr 16 12:18:10 volumiowohnzimmer sh[365]: command failed: No such device (-19) Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting WPA supplicant... Apr 16 12:18:10 volumiowohnzimmer avahi-daemon[401]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Volumio Log Rotation Service. Apr 16 12:18:10 volumiowohnzimmer avahi-daemon[401]: Successfully dropped root privileges. Apr 16 12:18:10 volumiowohnzimmer avahi-daemon[401]: avahi-daemon 0.7 starting up. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started RPC bind portmap service. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started triggerhappy global hotkey daemon. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Apr 16 12:18:10 volumiowohnzimmer systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Apr 16 12:18:10 volumiowohnzimmer systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Failed to start dhcpcd on all interfaces. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Started Save/Restore Sound Card State. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Sound Card. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Remote File Systems (Pre). Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target Remote File Systems. Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 16 12:18:10 volumiowohnzimmer systemd[1]: Reached target RPC Port Mapper. Apr 16 12:18:10 volumiowohnzimmer systemd-logind[409]: New seat seat0. Apr 16 12:18:11 volumiowohnzimmer ifup[364]: command failed: No such device (-19) Apr 16 12:18:11 volumiowohnzimmer kernel: 8021q: 802.1Q VLAN Support v1.8 Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Started Login Service. Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Successfully called chroot(). Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Successfully dropped remaining capabilities. Apr 16 12:18:12 volumiowohnzimmer wpa_supplicant[420]: Successfully initialized wpa_supplicant Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Loading service file /services/volumio.service. Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Network interface enumeration completed. Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Server startup complete. Host name is volumiowohnzimmer.local. Local service cookie is 3922455056. Apr 16 12:18:12 volumiowohnzimmer avahi-daemon[401]: Service "VolumioWohnzimmer" (/services/volumio.service) successfully established. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Started WPA supplicant. Apr 16 12:18:12 volumiowohnzimmer volumio-remote-updater[402]: Error: No active session Apr 16 12:18:12 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:12] [info] asio async_connect error: system:111 (Connection refused) Apr 16 12:18:12 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 16 12:18:12 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:12] [error] handle_connect error: Underlying Transport Error Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Started Raise network interfaces. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Reached target Network. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Reached target Network is Online. Apr 16 12:18:12 volumiowohnzimmer volumio[403]: Could not open config: /tmp/upmpdcli.conf Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Starting LSB: Brings up/down network automatically... Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Starting Samba NMB Daemon... Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Starting Network Time Service... Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Starting Permit User Sessions... Apr 16 12:18:12 volumiowohnzimmer systemd[1]: Starting /etc/rc.local Compatibility... Apr 16 12:18:12 volumiowohnzimmer sh[365]: eth0: waiting for carrier Apr 16 12:18:12 volumiowohnzimmer dhcpcd[445]: eth0: waiting for carrier Apr 16 12:18:12 volumiowohnzimmer dhcpcd[445]: eth0: carrier acquired Apr 16 12:18:12 volumiowohnzimmer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 16 12:18:12 volumiowohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Apr 16 12:18:12 volumiowohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Apr 16 12:18:12 volumiowohnzimmer sh[365]: eth0: carrier acquired Apr 16 12:18:12 volumiowohnzimmer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started /etc/rc.local Compatibility. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: iptables.service: Succeeded. Apr 16 12:18:13 volumiowohnzimmer sh[365]: DUID 00:01:00:01:2b:b8:71:41:7c:dd:90:8c:7c:7e Apr 16 12:18:13 volumiowohnzimmer sh[365]: eth0: IAID eb:0d:ca:64 Apr 16 12:18:13 volumiowohnzimmer dhcpcd[445]: DUID 00:01:00:01:2b:b8:71:41:7c:dd:90:8c:7c:7e Apr 16 12:18:13 volumiowohnzimmer dhcpcd[445]: eth0: IAID eb:0d:ca:64 Apr 16 12:18:13 volumiowohnzimmer sh[365]: eth0: adding address fe80::cfd0:5a19:eef6:70d0 Apr 16 12:18:13 volumiowohnzimmer sh[365]: ipv6_addaddr1: Permission denied Apr 16 12:18:13 volumiowohnzimmer dhcpcd[445]: eth0: adding address fe80::cfd0:5a19:eef6:70d0 Apr 16 12:18:13 volumiowohnzimmer dhcpcd[445]: ipv6_addaddr1: Permission denied Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Permit User Sessions. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Starting Hold until boot process finishes up... Apr 16 12:18:13 volumiowohnzimmer systemd[1]: plymouth-quit.service: Succeeded. Apr 16 12:18:13 volumiowohnzimmer loadcpufreq[427]: Loading cpufreq kernel modules...done (none). Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Terminate Plymouth Boot Screen. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: plymouth-start.service: Succeeded. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: plymouth-quit-wait.service: Succeeded. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Hold until boot process finishes up. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 242 (n/a). Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 242 (n/a). Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Getty on tty1. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Serial Getty on ttyAMA0. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Reached target Login Prompts. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 16 12:18:13 volumiowohnzimmer haveged[390]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Apr 16 12:18:13 volumiowohnzimmer haveged[390]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Apr 16 12:18:13 volumiowohnzimmer haveged[390]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0009 Apr 16 12:18:13 volumiowohnzimmer haveged[390]: haveged: fills: 0, generated: 0 Apr 16 12:18:13 volumiowohnzimmer ntpd[535]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 16 12:18:13 volumiowohnzimmer ntpd[535]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started Network Time Service. Apr 16 12:18:13 volumiowohnzimmer ifplugd(eth0)[603]: ifplugd 0.28 initializing. Apr 16 12:18:13 volumiowohnzimmer ifplugd(eth0)[603]: Using interface eth0/B8:27:EB:0D:CA:64 with driver (version: 6.1.69-v7+) Apr 16 12:18:13 volumiowohnzimmer ifplugd(eth0)[603]: Using detection mode: SIOCETHTOOL Apr 16 12:18:13 volumiowohnzimmer ifplugd(eth0)[603]: Initialization complete, link beat detected. Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: proto: precision = 1.667 usec (-19) Apr 16 12:18:13 volumiowohnzimmer ifplugd(eth0)[603]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: Listen and drop on 0 v6wildcard [::]:123 Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: Listen normally on 2 lo 127.0.0.1:123 Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: Listening on routing socket on fd #19 for interface updates Apr 16 12:18:13 volumiowohnzimmer dhcpcd[445]: eth0: soliciting a DHCP lease Apr 16 12:18:13 volumiowohnzimmer sh[365]: eth0: soliciting a DHCP lease Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 16 12:18:13 volumiowohnzimmer ntpd[591]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 16 12:18:13 volumiowohnzimmer cpufrequtils[584]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 16 12:18:13 volumiowohnzimmer systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 16 12:18:14 volumiowohnzimmer sh[365]: eth0: soliciting an IPv6 router Apr 16 12:18:14 volumiowohnzimmer dhcpcd[445]: eth0: soliciting an IPv6 router Apr 16 12:18:14 volumiowohnzimmer sh[365]: eth0: offered 192.168.178.22 from 192.168.178.1 Apr 16 12:18:14 volumiowohnzimmer dhcpcd[445]: eth0: offered 192.168.178.22 from 192.168.178.1 Apr 16 12:18:14 volumiowohnzimmer sh[365]: eth0: probing address 192.168.178.22/24 Apr 16 12:18:14 volumiowohnzimmer dhcpcd[445]: eth0: probing address 192.168.178.22/24 Apr 16 12:18:14 volumiowohnzimmer ifplugd(eth0)[603]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Apr 16 12:18:14 volumiowohnzimmer ntpd[591]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: [2024/04/16 12:18:14.844341, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: started asyncdns process 616 Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: [2024/04/16 12:18:14.848867, 0] ../lib/util/become_daemon.c:149(daemon_status) Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: [2024/04/16 12:18:14.849217, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Apr 16 12:18:14 volumiowohnzimmer nmbd[539]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 16 12:18:15 volumiowohnzimmer wireless.js[413]: WIRELESS: No wireless interface, exiting Apr 16 12:18:15 volumiowohnzimmer ntpd[591]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 16 12:18:15 volumiowohnzimmer iw[621]: command failed: No such device (-19) Apr 16 12:18:15 volumiowohnzimmer iwconfig[624]: Error for wireless request "Set Power Management" (8B2C) : Apr 16 12:18:15 volumiowohnzimmer iwconfig[624]: SET failed on device wlan0 ; No such device. Apr 16 12:18:15 volumiowohnzimmer systemd[1]: wireless.service: Succeeded. Apr 16 12:18:15 volumiowohnzimmer systemd[1]: Started Wireless Services. Apr 16 12:18:15 volumiowohnzimmer systemd[1]: Started Volumio Backend Module. Apr 16 12:18:15 volumiowohnzimmer systemd[1]: Started Volumio Cpu Tweaker. Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: Setting RT Priority for mpd Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: pid 35's current scheduling policy: SCHED_OTHER Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: pid 35's current scheduling priority: 0 Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: Setting MPD Affinity Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: pid 3's current affinity mask: f Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Apr 16 12:18:16 volumiowohnzimmer volumio-cpu-tweak[628]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Apr 16 12:18:16 volumiowohnzimmer systemd[1]: volumio_cpu_tweak.service: Succeeded. Apr 16 12:18:16 volumiowohnzimmer ntpd[591]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 16 12:18:17 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:17] [info] asio async_connect error: system:111 (Connection refused) Apr 16 12:18:17 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 16 12:18:17 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:17] [error] handle_connect error: Underlying Transport Error Apr 16 12:18:17 volumiowohnzimmer ntpd[591]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 16 12:18:18 volumiowohnzimmer sh[365]: eth0: leased 192.168.178.22 for 864000 seconds Apr 16 12:18:18 volumiowohnzimmer dhcpcd[445]: eth0: leased 192.168.178.22 for 864000 seconds Apr 16 12:18:18 volumiowohnzimmer sh[365]: eth0: adding route to 192.168.178.0/24 Apr 16 12:18:18 volumiowohnzimmer sh[365]: eth0: adding default route via 192.168.178.1 Apr 16 12:18:18 volumiowohnzimmer avahi-daemon[401]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.22. Apr 16 12:18:18 volumiowohnzimmer dhcpcd[445]: eth0: adding route to 192.168.178.0/24 Apr 16 12:18:18 volumiowohnzimmer avahi-daemon[401]: New relevant interface eth0.IPv4 for mDNS. Apr 16 12:18:18 volumiowohnzimmer dhcpcd[445]: eth0: adding default route via 192.168.178.1 Apr 16 12:18:18 volumiowohnzimmer avahi-daemon[401]: Registering new address record for 192.168.178.22 on eth0.IPv4. Apr 16 12:18:18 volumiowohnzimmer sh[365]: forked to background, child pid 665 Apr 16 12:18:18 volumiowohnzimmer dhcpcd[445]: forked to background, child pid 665 Apr 16 12:18:18 volumiowohnzimmer ifplugd(eth0)[603]: client: ifup: interface eth0 already configured Apr 16 12:18:18 volumiowohnzimmer sh[365]: eth0=eth0 Apr 16 12:18:19 volumiowohnzimmer ifplugd(eth0)[603]: Program executed successfully. Apr 16 12:18:19 volumiowohnzimmer ifplugd[521]: Network Interface Plugging Daemon...start eth0...done. Apr 16 12:18:19 volumiowohnzimmer systemd[1]: Started LSB: Brings up/down network automatically. Apr 16 12:18:19 volumiowohnzimmer ntpd[591]: Listen normally on 3 eth0 192.168.178.22:123 Apr 16 12:18:19 volumiowohnzimmer ntpd[591]: new interface(s) found: waking up resolver Apr 16 12:18:19 volumiowohnzimmer nmbd[539]: [2024/04/16 12:18:19.863428, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 16 12:18:19 volumiowohnzimmer nmbd[539]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 16 12:18:19 volumiowohnzimmer systemd[1]: Started Samba NMB Daemon. Apr 16 12:18:19 volumiowohnzimmer systemd[1]: Starting Samba Winbind Daemon... Apr 16 12:18:20 volumiowohnzimmer winbindd[691]: [2024/04/16 12:18:20.650807, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 16 12:18:20 volumiowohnzimmer winbindd[691]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 16 12:18:20 volumiowohnzimmer systemd[1]: Started Samba Winbind Daemon. Apr 16 12:18:20 volumiowohnzimmer winbindd[691]: [2024/04/16 12:18:20.696952, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 16 12:18:20 volumiowohnzimmer winbindd[691]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 16 12:18:20 volumiowohnzimmer systemd[1]: Starting Samba SMB Daemon... Apr 16 12:18:21 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:18:21 volumiowohnzimmer volumio[627]: info: ----- Volumio3 ---- Apr 16 12:18:21 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:18:21 volumiowohnzimmer volumio[627]: info: ----- System startup ---- Apr 16 12:18:21 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Started Samba SMB Daemon. Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Reached target Multi-User System. Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Reached target Graphical Interface. Apr 16 12:18:21 volumiowohnzimmer smbd[696]: [2024/04/16 12:18:21.753825, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 16 12:18:21 volumiowohnzimmer smbd[696]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 16 12:18:21 volumiowohnzimmer systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 16 12:18:21 volumiowohnzimmer systemd[1]: Startup finished in 10.785s (kernel) + 20.660s (userspace) = 31.445s. Apr 16 12:18:23 volumiowohnzimmer volumio[627]: info: MYVOLUMIO Environment detected Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Plugin folders cleanup Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning into folder /volumio/app/plugins/ Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category audio_interface Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category miscellanea Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category music_service Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category plugins.json Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category system_controller Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category user_interface Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning into folder /data/plugins/ Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category audio_interface Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category music_service Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Scanning category system_hardware Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Plugin folders cleanup completed Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: ----- Core plugins startup ---- Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Loading plugins from folder /volumio/app/plugins/ Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Adding plugin upnp to MyMusic Plugins Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Loading plugins from folder /data/plugins/ Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Loading plugin "system"... Apr 16 12:18:24 volumiowohnzimmer volumio[627]: info: Loading plugin "appearance"... Apr 16 12:18:25 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:25] [connect] Successful connection Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "network"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Refreshing Cached IP Addresses Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "services"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "alsa_controller"... Apr 16 12:18:27 volumiowohnzimmer sudo[721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 16 12:18:27 volumiowohnzimmer sudo[719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 16 12:18:27 volumiowohnzimmer sudo[719]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer sudo[723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 16 12:18:27 volumiowohnzimmer sudo[723]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer sudo[719]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:27 volumiowohnzimmer sudo[721]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:27 volumiowohnzimmer sudo[723]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "wizard"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "networkfs"... Apr 16 12:18:27 volumiowohnzimmer sudo[736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Samsung500GB/Muziek/Bart /mnt/NAS/Bart Apr 16 12:18:27 volumiowohnzimmer sudo[736]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer sudo[738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Job /mnt/NAS/Job Apr 16 12:18:27 volumiowohnzimmer sudo[738]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Starting Udev Watcher for removable devices Apr 16 12:18:27 volumiowohnzimmer sudo[741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Harm /mnt/NAS/Harm Apr 16 12:18:27 volumiowohnzimmer sudo[741]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer sudo[747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Mattias /mnt/NAS/Mattias Apr 16 12:18:27 volumiowohnzimmer sudo[747]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Ignoring mount for partition: boot Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Ignoring mount for partition: volumio Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Ignoring mount for partition: volumio_data Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "volumio_command_line_client"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "upnp"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: [1713262707866] Starting Upmpd Daemon Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "my_music"... Apr 16 12:18:27 volumiowohnzimmer volumio[627]: info: Loading plugin "mpd"... Apr 16 12:18:28 volumiowohnzimmer kernel: Key type cifs.spnego registered Apr 16 12:18:28 volumiowohnzimmer kernel: Key type cifs.idmap registered Apr 16 12:18:28 volumiowohnzimmer 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. Apr 16 12:18:28 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:18:28 volumiowohnzimmer volumio[627]: info: Loading plugin "upnp_browser"... Apr 16 12:18:29 volumiowohnzimmer volumio[627]: info: Loading plugin "alarm-clock"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "airplay_emulation"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "last_100"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "webradio"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "i2s_dacs"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "volumiodiscovery"... Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** For more information see Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** For more information see Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 16 12:18:30 volumiowohnzimmer volumio[627]: *** WARNING *** For more information see Apr 16 12:18:30 volumiowohnzimmer node[627]: *** WARNING *** For more information see Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Discovery: Started advertising with name: VolumioWohnzimmer Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 16 12:18:30 volumiowohnzimmer volumio[627]: info: Loading plugin "spop"... Apr 16 12:18:33 volumiowohnzimmer volumio[627]: info: Loading plugin "outputs"... Apr 16 12:18:33 volumiowohnzimmer volumio[627]: info: Loading plugin "albumart"... Apr 16 12:18:33 volumiowohnzimmer volumio[627]: info: Plugin example_plugin is not enabled Apr 16 12:18:33 volumiowohnzimmer volumio[627]: info: Loading plugin "inputs"... Apr 16 12:18:33 volumiowohnzimmer volumio[627]: info: Loading plugin "updater_comm"... Apr 16 12:18:34 volumiowohnzimmer volumio[627]: info: Plugin mpdemulation is not enabled Apr 16 12:18:34 volumiowohnzimmer volumio[627]: info: Loading plugin "rest_api"... Apr 16 12:18:34 volumiowohnzimmer sudo[738]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:34 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:18:34 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:18:34 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\Samsung500GB Apr 16 12:18:34 volumiowohnzimmer volumio[627]: info: Loading plugin "websocket"... Apr 16 12:18:34 volumiowohnzimmer volumio[627]: info: Loading plugin "fusiondsp"... Apr 16 12:18:34 volumiowohnzimmer volumio[627]: Forking 3 albumart workers Apr 16 12:18:35 volumiowohnzimmer volumio[627]: info: Applying required configuration parameters for plugin fusiondsp Apr 16 12:18:35 volumiowohnzimmer volumio[627]: info: Loading plugin "mpd_oled"... Apr 16 12:18:36 volumiowohnzimmer volumio[627]: Starting albumart workers Apr 16 12:18:36 volumiowohnzimmer volumio[627]: Starting albumart workers Apr 16 12:18:36 volumiowohnzimmer volumio[627]: Starting albumart workers Apr 16 12:18:36 volumiowohnzimmer volumio[627]: info: Applying required configuration parameters for plugin mpd_oled Apr 16 12:18:36 volumiowohnzimmer volumio[627]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Apr 16 12:18:36 volumiowohnzimmer volumio[627]: info: Loading plugin "rotaryencoder2"... Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: Loading i18n strings for locale en Apr 16 12:18:38 volumiowohnzimmer volumio[627]: Updating browse sources language Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::initPlayerControls Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 12:18:38 volumiowohnzimmer volumio[627]: Express server listening on port 3000 Apr 16 12:18:38 volumiowohnzimmer volumio[627]: [Metrics] WebUI: 19s 264.76ms Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreStateMachine::resetVolumioState Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreStateMachine::getcurrentVolume Apr 16 12:18:38 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioRetrievevolume Apr 16 12:18:38 volumiowohnzimmer sudo[828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 16 12:18:38 volumiowohnzimmer sudo[828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:38 volumiowohnzimmer sudo[828]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:38 volumiowohnzimmer sudo[830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 16 12:18:38 volumiowohnzimmer sudo[830]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:38 volumiowohnzimmer sudo[830]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Job at system boot, trial number 1 ,retrying in 5 seconds Apr 16 12:18:39 volumiowohnzimmer volumio[627]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 16 12:18:39 volumiowohnzimmer volumio[627]: wlan0 Interface doesn't support scanning. Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: Cannot use regular scanning, forcing with ap-force Apr 16 12:18:39 volumiowohnzimmer sudo[837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 16 12:18:39 volumiowohnzimmer sudo[837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:39 volumiowohnzimmer sudo[837]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:39 volumiowohnzimmer volumio[627]: command failed: No such device (-19) Apr 16 12:18:39 volumiowohnzimmer volumio[627]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 16 12:18:39 volumiowohnzimmer volumio[627]: command failed: No such device (-19) Apr 16 12:18:39 volumiowohnzimmer systemd[1]: systemd-fsckd.service: Succeeded. Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: VolumeController:: Volume=18 Mute =false Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::pushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioPushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::updateTrackBlock Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrackBlock Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioRetrievevolume Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: Reloading queue from file Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::setRepeat null single undefined Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::pushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioPushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::setRandom true Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::pushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioPushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: Setting Device type: Raspberry PI Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: VolumeController:: Volume=18 Mute =false Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreStateMachine::pushState Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioPushState Apr 16 12:18:39 volumiowohnzimmer sudo[849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 16 12:18:39 volumiowohnzimmer sudo[849]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:39 volumiowohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Apr 16 12:18:39 volumiowohnzimmer sudo[849]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:39 volumiowohnzimmer volumio[627]: info: Upmpdcli Daemon Started Apr 16 12:18:39 volumiowohnzimmer volumio[627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 16 12:18:40 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:40] [connect] Successful connection Apr 16 12:18:40 volumiowohnzimmer volumio-remote-updater[402]: [2024-04-16 12:18:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713262720 101 Apr 16 12:18:40 volumiowohnzimmer volumio[627]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Apr 16 12:18:40 volumiowohnzimmer sudo[736]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:40 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:18:40 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:18:40 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:18:40 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Bart at system boot, trial number 1 ,retrying in 5 seconds Apr 16 12:18:41 volumiowohnzimmer volumio[627]: info: Discovery: adding a042ef1f-379c-4448-aea8-b0af1bdb3603 Apr 16 12:18:41 volumiowohnzimmer volumio[627]: info: Discovery: Found device VolumioWohnzimmer Apr 16 12:18:41 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:18:41 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:18:43 volumiowohnzimmer volumio[627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 16 12:18:44 volumiowohnzimmer sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Job /mnt/NAS/Job Apr 16 12:18:44 volumiowohnzimmer sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:45 volumiowohnzimmer sudo[858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Samsung500GB/Muziek/Bart /mnt/NAS/Bart Apr 16 12:18:45 volumiowohnzimmer sudo[858]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:46 volumiowohnzimmer sudo[747]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:46 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:18:46 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:18:46 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:18:46 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Mattias at system boot, trial number 1 ,retrying in 5 seconds Apr 16 12:18:49 volumiowohnzimmer volumio[627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 16 12:18:51 volumiowohnzimmer sudo[863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Mattias /mnt/NAS/Mattias Apr 16 12:18:51 volumiowohnzimmer sudo[863]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:53 volumiowohnzimmer sudo[741]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:53 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:18:53 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:18:53 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:18:53 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Harm at system boot, trial number 1 ,retrying in 5 seconds Apr 16 12:18:58 volumiowohnzimmer sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Harm /mnt/NAS/Harm Apr 16 12:18:58 volumiowohnzimmer sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:18:59 volumiowohnzimmer sudo[853]: pam_unix(sudo:session): session closed for user root Apr 16 12:18:59 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:18:59 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:18:59 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\Samsung500GB Apr 16 12:18:59 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Job at system boot, trial number 2 ,retrying in 5 seconds Apr 16 12:18:59 volumiowohnzimmer volumio[627]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 16 12:19:04 volumiowohnzimmer sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Job /mnt/NAS/Job Apr 16 12:19:04 volumiowohnzimmer sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:05 volumiowohnzimmer sudo[858]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:05 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:19:05 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:19:05 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:19:05 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Bart at system boot, trial number 2 ,retrying in 5 seconds Apr 16 12:19:08 volumiowohnzimmer volumio[627]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Preparing to generate the ALSA configuration file Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Reading ALSA contributions from plugins. Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Asound.conf file unchanged, so no further update is needed Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting MPD Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting Shairport Sync Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:08 volumiowohnzimmer sudo[878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 16 12:19:08 volumiowohnzimmer sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:08 volumiowohnzimmer sudo[878]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:08 volumiowohnzimmer sudo[880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 16 12:19:08 volumiowohnzimmer sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: ___________ START PLUGINS ___________ Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: ControllerMpd::onStart: Initializing MPD Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Creating MPD Configuration file Apr 16 12:19:08 volumiowohnzimmer systemd[1]: Listening on mpd.socket. Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: [1713262748343] CoreMusicLibrary::Adding element Media Servers Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 12:19:08 volumiowohnzimmer systemd[1]: Starting Music Player Daemon... Apr 16 12:19:08 volumiowohnzimmer sudo[888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 16 12:19:08 volumiowohnzimmer sudo[888]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:08 volumiowohnzimmer sudo[888]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:08 volumiowohnzimmer sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 16 12:19:08 volumiowohnzimmer sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:08 volumiowohnzimmer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 16 12:19:08 volumiowohnzimmer systemd[1]: mpd.service: Succeeded. Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:08 volumiowohnzimmer systemd[1]: Stopped Music Player Daemon. Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:08 volumiowohnzimmer systemd[1]: Starting Music Player Daemon... Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: [1713262748640] CoreMusicLibrary::Adding element Last_100 Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: [1713262748646] CoreMusicLibrary::Adding element Webradio Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Creating Spotify config file Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: Loading i18n strings for locale en Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: FusionDsp - mixtype--------------------- Hardware Apr 16 12:19:08 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 16 12:19:08 volumiowohnzimmer sudo[904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Apr 16 12:19:08 volumiowohnzimmer sudo[904]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:08 volumiowohnzimmer sudo[904]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:08 volumiowohnzimmer sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Apr 16 12:19:08 volumiowohnzimmer sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: Volumio Calling Home Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: Preparing to generate the ALSA configuration file Apr 16 12:19:09 volumiowohnzimmer sudo[913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=24 pin_b=23 relative_axis=true steps-per-period=2 Apr 16 12:19:09 volumiowohnzimmer sudo[913]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: Reading ALSA contributions from plugins. Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: MPD Permissions set Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: MPD Permissions set Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: Volumio called home Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: Spotify config file written Apr 16 12:19:09 volumiowohnzimmer kernel: rotary-encoder rotary@18: gray Apr 16 12:19:09 volumiowohnzimmer kernel: input: rotary@18 as /devices/platform/rotary@18/input/input0 Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh Apr 16 12:19:09 volumiowohnzimmer sudo[913]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:09 volumiowohnzimmer sudo[928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 16 12:19:09 volumiowohnzimmer sudo[928]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:09 volumiowohnzimmer volumio[627]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Apr 16 12:19:09 volumiowohnzimmer volumio[627]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer go-librespot[935]: Librespot-go daemon starting... Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer systemd[1]: Started go-librespot Daemon. Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:09 volumiowohnzimmer sudo[928]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:09 volumiowohnzimmer systemd-udevd[919]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 16 12:19:09 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:19:10 volumiowohnzimmer sudo[947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 16 12:19:10 volumiowohnzimmer sudo[947]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 16 12:19:10 volumiowohnzimmer sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 16 12:19:10 volumiowohnzimmer systemd[1]: shairport-sync.service: Succeeded. Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:10 volumiowohnzimmer sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 16 12:19:10 volumiowohnzimmer sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:10 volumiowohnzimmer sudo[947]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:10 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:10+02:00" level=info msg="generated new device id: 2cf69c9d5b4ac312d1b01627a5bba784116467de" Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 16 12:19:10 volumiowohnzimmer systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 16 12:19:10 volumiowohnzimmer systemd[1]: shairport-sync.service: Succeeded. Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Asound.conf file unchanged, so no further update is needed Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting MPD Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:10 volumiowohnzimmer sudo[949]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting Shairport Sync Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:10 volumiowohnzimmer sudo[951]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:10 volumiowohnzimmer sudo[958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/Samsung500GB/Muziek/Bart /mnt/NAS/Bart Apr 16 12:19:10 volumiowohnzimmer sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 16 12:19:10 volumiowohnzimmer sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer sudo[962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 16 12:19:10 volumiowohnzimmer sudo[962]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:10 volumiowohnzimmer sudo[961]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:10 volumiowohnzimmer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 16 12:19:10 volumiowohnzimmer systemd[1]: mpd.service: Succeeded. Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Stopped Music Player Daemon. Apr 16 12:19:10 volumiowohnzimmer volumio[627]: info: Preparing to generate the ALSA configuration file Apr 16 12:19:10 volumiowohnzimmer systemd[1]: Starting Music Player Daemon... Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Shairport-Sync Started Apr 16 12:19:11 volumiowohnzimmer volumio[627]: Error adding Membership: Error: addMembership EINVAL Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: camilladsp spawned new process with pid 980, instance 1, run: true Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: camilladsp service started and running in background, instance 1 Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: FusionDsp loaded Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 16 12:19:11 volumiowohnzimmer sudo[986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 16 12:19:11 volumiowohnzimmer sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Adding Signal Path Element [object Object] Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Adding fusiondspeq DSP Signal Path Element Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: FusionDsp - ---- installed callbackRead Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Reading ALSA contributions from plugins. Apr 16 12:19:11 volumiowohnzimmer systemd[1]: Started FusionDsp Daemon. Apr 16 12:19:11 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:11+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 16 12:19:11 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:11+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 16 12:19:11 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:11+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 16 12:19:11 volumiowohnzimmer sudo[986]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:11 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:11+02:00" level=debug msg="zeroconf server listening on port 36385" Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: MPD Permissions set Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Shairport-Sync Started Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Shairport-Sync Started Apr 16 12:19:11 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:19:11 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:19:11 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:19:11 volumiowohnzimmer sudo[863]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: Cannot mount NAS Mattias at system boot, trial number 2 ,retrying in 5 seconds Apr 16 12:19:11 volumiowohnzimmer volumio[627]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Apr 16 12:19:11 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:19:12 volumiowohnzimmer sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 16 12:19:12 volumiowohnzimmer sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Asound.conf file unchanged, so no further update is needed Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting MPD Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 16 12:19:12 volumiowohnzimmer systemd[1]: shairport-sync.service: Succeeded. Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Output device has changed, restarting Shairport Sync Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:12 volumiowohnzimmer sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 16 12:19:12 volumiowohnzimmer sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:12 volumiowohnzimmer sudo[1048]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:12 volumiowohnzimmer sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 16 12:19:12 volumiowohnzimmer sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:12 volumiowohnzimmer sudo[1045]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:12 volumiowohnzimmer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 16 12:19:12 volumiowohnzimmer systemd[1]: mpd.service: Succeeded. Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Stopped Music Player Daemon. Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: MPD Permissions set Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Shairport-Sync Started Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Starting Music Player Daemon... Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 16 12:19:12 volumiowohnzimmer volumio[627]: info: Starting Shairport Sync Apr 16 12:19:12 volumiowohnzimmer sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 16 12:19:12 volumiowohnzimmer sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 16 12:19:12 volumiowohnzimmer systemd[1]: shairport-sync.service: Succeeded. Apr 16 12:19:12 volumiowohnzimmer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:13 volumiowohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 16 12:19:13 volumiowohnzimmer sudo[1065]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:13 volumiowohnzimmer volumio[627]: info: Shairport-Sync Started Apr 16 12:19:13 volumiowohnzimmer volumio[627]: info: go-librespot daemon successfully initialized Apr 16 12:19:14 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:14+02:00" level=debug msg="obtained new client token: AADkd4LeUF7cuULv5QaabVs84lac6dxU+C3f5vA4oEP/mJ5TAFAJ7Lkhp/g/8C3dp3DI/IDLR+hXi/hn+I+yYQ6EMx+aFG6CpBleMV8oYclGZNhQkVIYxYjRituihLgIt7nJcTpGJEo75TrNp7fmKr/ChHUFhfTThWXtrwXIOGUjr0XZbFkymGSQ69iHd1bod/u1jZuZMVYZzmERmjvr+qmNzMfNbNTYsNZ+szMT1Kjg9hCUREL8HHp9IZxpBEJe" Apr 16 12:19:14 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:14+02:00" level=debug msg="completed keyexchange" Apr 16 12:19:14 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:14+02:00" level=debug msg="completed challenge" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="authenticated as bfm.zonderland" Apr 16 12:19:15 volumiowohnzimmer mpd[1059]: Apr 16 12:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 16 12:19:15 volumiowohnzimmer systemd[1]: Started Music Player Daemon. Apr 16 12:19:15 volumiowohnzimmer sudo[962]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:15 volumiowohnzimmer sudo[880]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:15 volumiowohnzimmer sudo[1050]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:15 volumiowohnzimmer sudo[891]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="authenticated as bfm.zonderland" Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: Completed starting Core Plugins Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: ----- MyVolumio plugins startup ---- Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: ------------------------------------------- Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 16 12:19:15 volumiowohnzimmer systemd[1]: Started MPD OLED Plugin. Apr 16 12:19:15 volumiowohnzimmer sudo[906]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="dealer connection opened" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=info msg="accepted zeroconf user bfm.zonderland from FP5" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 16 12:19:15 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:15+02:00" level=debug msg="received connection id: ZTdhNjAyM2MtMmNkNi00M2JkLTk5MGQtNmIxNTcwMGM5MmFjK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXpzemMuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwKzE4NzY1MTEwNEIzREU1QzkyNTdCMjBCNjhDOUNBRDYwQjVFMTBCOTA4MDIxQUFGNjBGQkNFQUJEMEFFOEU5RUY=" Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: MPD error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: MPD error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: MPD error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: The expression evaluated to a falsy value: Apr 16 12:19:15 volumiowohnzimmer volumio[627]: assert.ok(self.idling) Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: MPD running with PID1059 Apr 16 12:19:15 volumiowohnzimmer volumio[627]: ,establishing connection Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: updateQueue error: null Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:15 volumiowohnzimmer volumio[627]: error: updateQueue error: null Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:15 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: Initializing connection to go-librespot Websocket Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="new websocket client" Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: Connection to go-librespot Websocket established Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="handling transfer player command from ab20eb52474a00b4424f9b86896794fd7d6b920b" Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=trace msg="fetched new page 0 with 10 items (list: 10)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=trace msg="fetched new page 1 with 9 items (list: 19)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=warning msg="returning empty context page (hm://artistplaycontext/v1/page/spotify/album/14N1fgzW3BWvBvqSG9ySpk/km_artist) for spotify:artist:4CMC2nnStv4EENjKBSDpKR" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=error msg="failed fetching all tracks" error="failed moving to next index 19 (page 2): loaded an empty page for 2" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="shuffled context with seed 15958360231195351449 (len: 19, keep: 2)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=trace msg="fetched new page 1 with 9 items (list: 28)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=trace msg="fetched new page 2 with 11 items (list: 39)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="loading track spotify:track:6ozOxS87YQPBgxOGcwl3Kn (paused: false, position: -83895626ms)" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=trace msg="emitting websocket event: will_play" Apr 16 12:19:16 volumiowohnzimmer volumio[627]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6ozOxS87YQPBgxOGcwl3Kn","play_origin":"free-tier-artist"}} Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:6ozOxS87YQPBgxOGcwl3Kn" Apr 16 12:19:16 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:16+02:00" level=debug msg="requested aes key for file 65a1bd2caec88655819582e82de6d5e6807c4d88, gid: 6ozOxS87YQPBgxOGcwl3Kn" Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:16 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:16 volumiowohnzimmer sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=bart,password=qwertz,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.55/samsung500GB/Muziek/Mattias /mnt/NAS/Mattias Apr 16 12:19:16 volumiowohnzimmer sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="fetched first chunk of 5, total size is 2352052 bytes" Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=trace msg="seek to -83895626ms (diff: -83895626ms, samples: -3699797106, bytes: 0)" Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=info msg="loaded track \"Strange Symptoms\" (uri: spotify:track:6ozOxS87YQPBgxOGcwl3Kn, paused: false, position: -83895626ms, duration: 77880ms)" Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: camilladsp stopping service pid 980... Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: camilladsp service terminated, instance 1 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: camilladsp service started and running in background, instance 1 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 16 12:19:17 volumiowohnzimmer volumio[627]: error: FusionDsp - WebSocket error: [object Object] Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: camilladsp spawned new process with pid 1086, instance 1, run: true Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="fetched chunk 1/4, size: 524288" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=trace msg="emitting websocket event: metadata" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=trace msg="emitting websocket event: active" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="sending successful reply for delaer request" Apr 16 12:19:17 volumiowohnzimmer volumio[627]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6ozOxS87YQPBgxOGcwl3Kn","name":"Strange Symptoms","artist_names":["Christina Vantzou"],"album_name":"No. 2","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c0a202401d64e593dce38a36","position":-83895626,"duration":77880,"release_date":"year:2014 month:2 day:24","track_number":4,"disc_number":1}} Apr 16 12:19:17 volumiowohnzimmer volumio[627]: SPOTIFY: received: {"type":"active","data":null} Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: Aligning Spotify Volume to Volumio Volume Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: Setting Spotify Volume from Volumio: 18 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CoreCommandRouter::volumioGetState Apr 16 12:19:17 volumiowohnzimmer volumio[627]: info: CorePlayQueue::getTrack 0 Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=trace msg="emitting websocket event: playing" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="fetched chunk 3/4, size: 524288" Apr 16 12:19:17 volumiowohnzimmer volumio[627]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6ozOxS87YQPBgxOGcwl3Kn","play_origin":"free-tier-artist"}} Apr 16 12:19:17 volumiowohnzimmer volumio[627]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Apr 16 12:19:17 volumiowohnzimmer volumio[627]: TypeError: Cannot read property 'service' of undefined Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at WebSocket.emit (events.js:315:20) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1203:20) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at Receiver.emit (events.js:315:20) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:608:16 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at internal/process/task_queues.js:149:7 Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at AsyncResource.runMicrotask (internal/process/task_queues.js:146:8) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Apr 16 12:19:17 volumiowohnzimmer volumio[627]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1573" Apr 16 12:19:17 volumiowohnzimmer sudo[868]: pam_unix(sudo:session): session closed for user root Apr 16 12:19:17 volumiowohnzimmer kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Apr 16 12:19:17 volumiowohnzimmer kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Apr 16 12:19:17 volumiowohnzimmer kernel: CIFS: Attempting to mount \\192.168.178.55\samsung500GB Apr 16 12:19:17 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:17+02:00" level=debug msg="fetched chunk 2/4, size: 524288" Apr 16 12:19:18 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1339" Apr 16 12:19:18 volumiowohnzimmer go-librespot[935]: time="2024-04-16T12:19:18+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 16 12:19:18 volumiowohnzimmer ntpd[591]: Soliciting pool server 146.255.56.84 Apr 16 12:19:19 volumiowohnzimmer sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-16 12:18 Apr 16 12:19:19 volumiowohnzimmer sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"