-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2024-08-08 19:22:00 CEST. -- Aug 08 19:21:25 volumio-salon fake-hwclock[191]: Thu Aug 8 17:21:25 UTC 2024 Aug 08 19:21:25 volumio-salon systemd[1]: Started Restore / save the current clock. Aug 08 19:21:25 volumio-salon systemd-modules-load[199]: Inserted module 'i2c_dev' Aug 08 19:21:25 volumio-salon kernel: i2c_dev: i2c /dev entries driver Aug 08 19:21:25 volumio-salon systemd[1]: Started Load Kernel Modules. Aug 08 19:21:25 volumio-salon systemd[1]: Condition check resulted in FUSE Control File System being skipped. Aug 08 19:21:25 volumio-salon systemd[1]: Starting Apply Kernel Variables... Aug 08 19:21:25 volumio-salon systemd[1]: Mounting Kernel Configuration File System... Aug 08 19:21:25 volumio-salon systemd[1]: Started Load/Save Random Seed. Aug 08 19:21:25 volumio-salon systemd[1]: Mounted Kernel Configuration File System. Aug 08 19:21:25 volumio-salon systemd[1]: Started Create System Users. Aug 08 19:21:25 volumio-salon systemd[1]: Starting Create Static Device Nodes in /dev... Aug 08 19:21:25 volumio-salon systemd[1]: Started Apply Kernel Variables. Aug 08 19:21:25 volumio-salon systemd[1]: dynamicswap.service: Succeeded. Aug 08 19:21:25 volumio-salon systemd[1]: Started Create Static Device Nodes in /dev. Aug 08 19:21:25 volumio-salon systemd[1]: Starting udev Kernel Device Manager... Aug 08 19:21:25 volumio-salon systemd[1]: Reached target Local File Systems (Pre). Aug 08 19:21:25 volumio-salon systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 08 19:21:25 volumio-salon systemd[1]: Mounting /var/log... Aug 08 19:21:25 volumio-salon systemd[1]: Mounting /var/spool/cups... Aug 08 19:21:25 volumio-salon systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Aug 08 19:21:25 volumio-salon systemd[1]: Mounting /tmp... Aug 08 19:21:25 volumio-salon systemd[1]: Started udev Coldplug all Devices. Aug 08 19:21:25 volumio-salon systemd[1]: Mounted /var/log. Aug 08 19:21:25 volumio-salon systemd[1]: Mounted /var/spool/cups. Aug 08 19:21:25 volumio-salon systemd[1]: Mounted /tmp. Aug 08 19:21:25 volumio-salon systemd[1]: Mounting /var/spool/cups/tmp... Aug 08 19:21:25 volumio-salon systemd[1]: Starting Flush Journal to Persistent Storage... Aug 08 19:21:25 volumio-salon systemd-udevd[222]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 08 19:21:25 volumio-salon systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 08 19:21:25 volumio-salon systemd[1]: Mounted /var/spool/cups/tmp. Aug 08 19:21:25 volumio-salon systemd-journald[194]: Runtime journal (/run/log/journal/4ceeebcde4a5f04b591e77826532825c) is 7.5M, max 30.0M, 22.5M free. Aug 08 19:21:25 volumio-salon systemd[1]: Started Flush Journal to Persistent Storage. Aug 08 19:21:25 volumio-salon systemd[1]: Started udev Kernel Device Manager. Aug 08 19:21:25 volumio-salon systemd[1]: Starting Show Plymouth Boot Screen... Aug 08 19:21:25 volumio-salon systemd[1]: Received SIGRTMIN+20 from PID 247 (plymouthd). Aug 08 19:21:25 volumio-salon systemd[1]: Started Show Plymouth Boot Screen. Aug 08 19:21:25 volumio-salon systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 08 19:21:25 volumio-salon systemd[1]: Reached target Paths. Aug 08 19:21:25 volumio-salon systemd[1]: Reached target Local Encrypted Volumes. Aug 08 19:21:25 volumio-salon systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 08 19:21:25 volumio-salon kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:25 volumio-salon kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Aug 08 19:21:25 volumio-salon kernel: [vc_sm_connected_init]: start Aug 08 19:21:25 volumio-salon kernel: mc: Linux media interface: v0.10 Aug 08 19:21:25 volumio-salon kernel: [vc_sm_connected_init]: installed successfully Aug 08 19:21:26 volumio-salon kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Aug 08 19:21:26 volumio-salon kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Aug 08 19:21:26 volumio-salon kernel: videodev: Linux video capture interface: v2.00 Aug 08 19:21:26 volumio-salon kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon systemd[1]: Found device /dev/mmcblk0p1. Aug 08 19:21:26 volumio-salon kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Aug 08 19:21:26 volumio-salon kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Aug 08 19:21:26 volumio-salon kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 08 19:21:26 volumio-salon kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Aug 08 19:21:26 volumio-salon kernel: Bluetooth: Core ver 2.22 Aug 08 19:21:26 volumio-salon kernel: NET: Registered PF_BLUETOOTH protocol family Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI device and connection manager initialized Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI socket layer initialized Aug 08 19:21:26 volumio-salon kernel: Bluetooth: L2CAP socket layer initialized Aug 08 19:21:26 volumio-salon kernel: Bluetooth: SCO socket layer initialized Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Aug 08 19:21:26 volumio-salon kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI UART driver ver 2.3 Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI UART protocol H4 registered Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Aug 08 19:21:26 volumio-salon kernel: Bluetooth: HCI UART protocol Broadcom registered Aug 08 19:21:26 volumio-salon kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Aug 08 19:21:26 volumio-salon kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Aug 08 19:21:26 volumio-salon kernel: uart-pl011 3f201000.serial: no DMA platform data Aug 08 19:21:26 volumio-salon systemd-udevd[236]: Using default interface naming scheme 'v240'. Aug 08 19:21:26 volumio-salon systemd-udevd[236]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 08 19:21:27 volumio-salon systemd[1]: Starting File System Check on /dev/mmcblk0p1... Aug 08 19:21:27 volumio-salon kernel: Bluetooth: hci0: BCM: chip id 94 Aug 08 19:21:27 volumio-salon kernel: Bluetooth: hci0: BCM: features 0x2e Aug 08 19:21:27 volumio-salon kernel: Bluetooth: hci0: BCM43430A1 Aug 08 19:21:27 volumio-salon kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Aug 08 19:21:27 volumio-salon kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Aug 08 19:21:27 volumio-salon systemd[1]: Started File System Check Daemon to report status. Aug 08 19:21:27 volumio-salon kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Aug 08 19:21:27 volumio-salon systemd-fsck[321]: fsck.fat 4.1 (2017-01-24) Aug 08 19:21:27 volumio-salon systemd-fsck[321]: /dev/mmcblk0p1: 360 files, 33264/46774 clusters Aug 08 19:21:27 volumio-salon kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Aug 08 19:21:27 volumio-salon kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Aug 08 19:21:27 volumio-salon systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 08 19:21:27 volumio-salon systemd[1]: Started File System Check on /dev/mmcblk0p1. Aug 08 19:21:27 volumio-salon kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Aug 08 19:21:27 volumio-salon kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Aug 08 19:21:27 volumio-salon kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Aug 08 19:21:27 volumio-salon kernel: usbcore: registered new interface driver brcmfmac Aug 08 19:21:28 volumio-salon kernel: Bluetooth: hci0: BCM: features 0x2e Aug 08 19:21:28 volumio-salon kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Aug 08 19:21:28 volumio-salon kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Aug 08 19:21:28 volumio-salon kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 Aug 08 19:21:28 volumio-salon systemd-udevd[233]: Using default interface naming scheme 'v240'. Aug 08 19:21:28 volumio-salon systemd-udevd[233]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 08 19:21:28 volumio-salon kernel: wm8804 1-003b: revision E Aug 08 19:21:29 volumio-salon systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Created slice system-bthelper.slice. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Huge Pages File System being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in FUSE Control File System being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 08 19:21:29 volumio-salon systemd[1]: Mounting /boot... Aug 08 19:21:29 volumio-salon systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 08 19:21:29 volumio-salon systemd[1]: Mounted /boot. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target Local File Systems. Aug 08 19:21:29 volumio-salon systemd[1]: Starting Preprocess NFS configuration... Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Starting Raise network interfaces... Aug 08 19:21:29 volumio-salon systemd[1]: Starting Create Volatile Files and Directories... Aug 08 19:21:29 volumio-salon systemd[1]: Started ifup for eth0. Aug 08 19:21:29 volumio-salon systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 08 19:21:29 volumio-salon systemd[1]: Started ifup for wlan0. Aug 08 19:21:29 volumio-salon systemd[1]: Started Load/Save RF Kill Switch Status. Aug 08 19:21:29 volumio-salon systemd[1]: Received SIGRTMIN+20 from PID 247 (plymouthd). Aug 08 19:21:29 volumio-salon systemd[1]: nfs-config.service: Succeeded. Aug 08 19:21:29 volumio-salon systemd[1]: Started Preprocess NFS configuration. Aug 08 19:21:29 volumio-salon systemd[1]: plymouth-read-write.service: Succeeded. Aug 08 19:21:29 volumio-salon systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target NFS client services. Aug 08 19:21:29 volumio-salon systemd[1]: Started Create Volatile Files and Directories. Aug 08 19:21:29 volumio-salon systemd[1]: Starting RPC bind portmap service... Aug 08 19:21:29 volumio-salon systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Aug 08 19:21:29 volumio-salon systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target System Initialization. Aug 08 19:21:29 volumio-salon kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 08 19:21:29 volumio-salon kernel: 8021q: 802.1Q VLAN Support v1.8 Aug 08 19:21:29 volumio-salon systemd[1]: Listening on mpd.socket. Aug 08 19:21:29 volumio-salon systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 08 19:21:29 volumio-salon systemd[1]: Listening on triggerhappy.socket. Aug 08 19:21:29 volumio-salon systemd[1]: Started Daily apt download activities. Aug 08 19:21:29 volumio-salon systemd[1]: Started Daily apt upgrade and clean activities. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target Timers. Aug 08 19:21:29 volumio-salon systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 08 19:21:29 volumio-salon systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target Sockets. Aug 08 19:21:29 volumio-salon systemd[1]: Reached target Basic System. Aug 08 19:21:29 volumio-salon systemd[1]: Started D-Bus System Message Bus. Aug 08 19:21:29 volumio-salon systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 08 19:21:29 volumio-salon systemd[1]: Starting Configure Bluetooth Modems connected by UART... Aug 08 19:21:29 volumio-salon systemd[1]: Started Manage Sound Card State (restore and store). Aug 08 19:21:29 volumio-salon systemd[1]: Starting Login Service... Aug 08 19:21:29 volumio-salon alsactl[508]: alsactl 1.1.8 daemon started Aug 08 19:21:29 volumio-salon systemd[1]: Starting Save/Restore Sound Card State... Aug 08 19:21:29 volumio-salon systemd[1]: Started Volumio Iptables Module. Aug 08 19:21:30 volumio-salon systemd[1]: Starting WPA supplicant... Aug 08 19:21:30 volumio-salon systemd[1]: Starting Wireless Services... Aug 08 19:21:30 volumio-salon systemd[1]: Starting triggerhappy global hotkey daemon... Aug 08 19:21:30 volumio-salon systemd[1]: Started volumio-remote-updater.service. Aug 08 19:21:30 volumio-salon systemd[1]: Started UPnP Renderer front-end to MPD. Aug 08 19:21:30 volumio-salon systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 08 19:21:30 volumio-salon systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Aug 08 19:21:30 volumio-salon systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Aug 08 19:21:30 volumio-salon systemd[1]: Starting dhcpcd on all interfaces... Aug 08 19:21:30 volumio-salon systemd[1]: Started RPC bind portmap service. Aug 08 19:21:30 volumio-salon systemd[1]: Started Save/Restore Sound Card State. Aug 08 19:21:30 volumio-salon systemd-logind[510]: New seat seat0. Aug 08 19:21:30 volumio-salon thd[518]: Unable to parse trigger line: Aug 08 19:21:30 volumio-salon thd[518]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Aug 08 19:21:30 volumio-salon thd[518]: Unable to parse trigger line: Aug 08 19:21:30 volumio-salon thd[518]: Unable to parse trigger line: Aug 08 19:21:30 volumio-salon thd[518]: Found socket passed from systemd Aug 08 19:21:30 volumio-salon systemd[1]: Started triggerhappy global hotkey daemon. Aug 08 19:21:30 volumio-salon ifup[410]: ifup: waiting for lock on /run/network/ifstate.wlan0 Aug 08 19:21:30 volumio-salon dhcpcd[526]: Not running dhcpcd because /etc/network/interfaces Aug 08 19:21:30 volumio-salon dhcpcd[526]: defines some interfaces that will use a Aug 08 19:21:30 volumio-salon dhcpcd[526]: DHCP client or static address Aug 08 19:21:30 volumio-salon systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Aug 08 19:21:30 volumio-salon systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Aug 08 19:21:30 volumio-salon systemd[1]: Failed to start dhcpcd on all interfaces. Aug 08 19:21:30 volumio-salon systemd[1]: Reached target Sound Card. Aug 08 19:21:30 volumio-salon systemd[1]: Reached target RPC Port Mapper. Aug 08 19:21:30 volumio-salon systemd[1]: Reached target Remote File Systems (Pre). Aug 08 19:21:30 volumio-salon systemd[1]: Reached target Remote File Systems. Aug 08 19:21:30 volumio-salon sh[418]: wlan0=wlan0 Aug 08 19:21:30 volumio-salon systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 08 19:21:30 volumio-salon systemd[1]: hciuart.service: Succeeded. Aug 08 19:21:30 volumio-salon systemd[1]: Started Configure Bluetooth Modems connected by UART. Aug 08 19:21:30 volumio-salon systemd[1]: Starting Raspberry Pi bluetooth helper... Aug 08 19:21:30 volumio-salon sh[413]: eth0: waiting for carrier Aug 08 19:21:30 volumio-salon dhcpcd[459]: eth0: waiting for carrier Aug 08 19:21:30 volumio-salon kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Aug 08 19:21:30 volumio-salon sh[413]: eth0: carrier acquired Aug 08 19:21:30 volumio-salon dhcpcd[459]: eth0: carrier acquired Aug 08 19:21:30 volumio-salon kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Aug 08 19:21:30 volumio-salon sh[413]: DUID 00:01:00:01:2c:c5:40:e6:b8:27:eb:23:3c:29 Aug 08 19:21:30 volumio-salon sh[413]: eth0: IAID eb:23:3c:29 Aug 08 19:21:30 volumio-salon sh[413]: eth0: adding address fe80::ba27:ebff:fe23:3c29 Aug 08 19:21:30 volumio-salon sh[413]: ipv6_addaddr1: Permission denied Aug 08 19:21:30 volumio-salon dhcpcd[459]: DUID 00:01:00:01:2c:c5:40:e6:b8:27:eb:23:3c:29 Aug 08 19:21:30 volumio-salon dhcpcd[459]: eth0: IAID eb:23:3c:29 Aug 08 19:21:30 volumio-salon dhcpcd[459]: eth0: adding address fe80::ba27:ebff:fe23:3c29 Aug 08 19:21:30 volumio-salon dhcpcd[459]: ipv6_addaddr1: Permission denied Aug 08 19:21:30 volumio-salon avahi-daemon[525]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Aug 08 19:21:30 volumio-salon avahi-daemon[525]: Successfully dropped root privileges. Aug 08 19:21:30 volumio-salon avahi-daemon[525]: avahi-daemon 0.7 starting up. Aug 08 19:21:30 volumio-salon bthelper[559]: Raspberry Pi BDADDR already set Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Successfully called chroot(). Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Successfully dropped remaining capabilities. Aug 08 19:21:31 volumio-salon systemd[1]: Started Login Service. Aug 08 19:21:31 volumio-salon systemd[1]: Started Raspberry Pi bluetooth helper. Aug 08 19:21:31 volumio-salon wpa_supplicant[513]: Successfully initialized wpa_supplicant Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Loading service file /services/volumio.service. Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Network interface enumeration completed. Aug 08 19:21:31 volumio-salon sh[413]: eth0: soliciting an IPv6 router Aug 08 19:21:31 volumio-salon dhcpcd[459]: eth0: soliciting an IPv6 router Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Server startup complete. Host name is volumio-salon.local. Local service cookie is 1808477768. Aug 08 19:21:31 volumio-salon avahi-daemon[525]: Service "Volumio salon" (/services/volumio.service) successfully established. Aug 08 19:21:31 volumio-salon systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 08 19:21:31 volumio-salon systemd[1]: Started WPA supplicant. Aug 08 19:21:31 volumio-salon systemd[1]: Starting Bluetooth service... Aug 08 19:21:31 volumio-salon systemd[1]: Started Raise network interfaces. Aug 08 19:21:31 volumio-salon systemd[1]: Reached target Network. Aug 08 19:21:31 volumio-salon sh[413]: eth0: soliciting a DHCP lease Aug 08 19:21:31 volumio-salon dhcpcd[459]: eth0: soliciting a DHCP lease Aug 08 19:21:31 volumio-salon systemd[1]: Starting Permit User Sessions... Aug 08 19:21:31 volumio-salon systemd[1]: Starting Music Player Daemon... Aug 08 19:21:31 volumio-salon systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 08 19:21:31 volumio-salon sh[413]: eth0: offered 10.16.1.249 from 10.16.1.1 Aug 08 19:21:31 volumio-salon dhcpcd[459]: eth0: offered 10.16.1.249 from 10.16.1.1 Aug 08 19:21:31 volumio-salon dhcpcd[459]: eth0: probing address 10.16.1.249/24 Aug 08 19:21:31 volumio-salon sh[413]: eth0: probing address 10.16.1.249/24 Aug 08 19:21:31 volumio-salon systemd[1]: Starting Network Time Service... Aug 08 19:21:31 volumio-salon systemd[1]: Reached target Network is Online. Aug 08 19:21:31 volumio-salon systemd[1]: Starting /etc/rc.local Compatibility... Aug 08 19:21:31 volumio-salon systemd[1]: Starting LSB: Brings up/down network automatically... Aug 08 19:21:31 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 08 19:21:31 volumio-salon systemd[1]: Starting Samba NMB Daemon... Aug 08 19:21:31 volumio-salon systemd[1]: Started Permit User Sessions. Aug 08 19:21:31 volumio-salon systemd[1]: Started /etc/rc.local Compatibility. Aug 08 19:21:31 volumio-salon volumio-remote-updater[520]: Error: No active session Aug 08 19:21:31 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:31] [info] asio async_connect error: system:111 (Connection refused) Aug 08 19:21:31 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:31] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 08 19:21:31 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:31] [error] handle_connect error: Underlying Transport Error Aug 08 19:21:31 volumio-salon systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 08 19:21:31 volumio-salon systemd[1]: Starting Hold until boot process finishes up... Aug 08 19:21:32 volumio-salon systemd[1]: Received SIGRTMIN+21 from PID 247 (plymouthd). Aug 08 19:21:32 volumio-salon volumio[524]: Could not open config: /tmp/upmpdcli.conf Aug 08 19:21:32 volumio-salon systemd[1]: plymouth-start.service: Succeeded. Aug 08 19:21:32 volumio-salon systemd[1]: plymouth-quit.service: Succeeded. Aug 08 19:21:32 volumio-salon systemd[1]: Started Terminate Plymouth Boot Screen. Aug 08 19:21:32 volumio-salon systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 08 19:21:32 volumio-salon systemd[1]: Started Hold until boot process finishes up. Aug 08 19:21:32 volumio-salon systemd[1]: Received SIGRTMIN+21 from PID 247 (n/a). Aug 08 19:21:32 volumio-salon bluetoothd[595]: Bluetooth daemon 5.50 Aug 08 19:21:32 volumio-salon systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 08 19:21:32 volumio-salon systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 08 19:21:32 volumio-salon loadcpufreq[548]: Loading cpufreq kernel modules...done (none). Aug 08 19:21:32 volumio-salon bluetoothd[595]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 08 19:21:32 volumio-salon systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 08 19:21:32 volumio-salon bluetoothd[595]: Starting SDP server Aug 08 19:21:32 volumio-salon bluetoothd[595]: Excluding (cli) sap Aug 08 19:21:32 volumio-salon systemd[1]: iptables.service: Succeeded. Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: ifplugd 0.28 initializing. Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: Using interface eth0/B8:27:EB:23:3C:29 with driver (version: 6.1.58-v7+) Aug 08 19:21:32 volumio-salon systemd[1]: Started Bluetooth service. Aug 08 19:21:32 volumio-salon systemd[1]: Reached target Bluetooth. Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: Using detection mode: SIOCETHTOOL Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: Initialization complete, link beat detected. Aug 08 19:21:32 volumio-salon ntpd[603]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 08 19:21:32 volumio-salon ntpd[603]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Aug 08 19:21:32 volumio-salon ntpd[658]: proto: precision = 1.406 usec (-19) Aug 08 19:21:32 volumio-salon systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 08 19:21:32 volumio-salon systemd[1]: Started Getty on tty1. Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Aug 08 19:21:32 volumio-salon kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Aug 08 19:21:32 volumio-salon kernel: Bluetooth: BNEP filters: protocol multicast Aug 08 19:21:32 volumio-salon kernel: Bluetooth: BNEP socket layer initialized Aug 08 19:21:32 volumio-salon systemd[1]: Reached target Login Prompts. Aug 08 19:21:32 volumio-salon bluetoothd[595]: Bluetooth management interface 1.22 initialized Aug 08 19:21:32 volumio-salon dbus-daemon[506]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=595 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 08 19:21:32 volumio-salon kernel: Bluetooth: MGMT ver 1.22 Aug 08 19:21:32 volumio-salon systemd[1]: Started Network Time Service. Aug 08 19:21:32 volumio-salon ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 08 19:21:32 volumio-salon ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 08 19:21:32 volumio-salon ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 225 days ago Aug 08 19:21:32 volumio-salon ntpd[658]: Listen and drop on 0 v6wildcard [::]:123 Aug 08 19:21:32 volumio-salon ntpd[658]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 08 19:21:32 volumio-salon ntpd[658]: Listen normally on 2 lo 127.0.0.1:123 Aug 08 19:21:32 volumio-salon ntpd[658]: Listening on routing socket on fd #19 for interface updates Aug 08 19:21:32 volumio-salon ntpd[658]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 08 19:21:32 volumio-salon ntpd[658]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 08 19:21:32 volumio-salon bluetoothd[595]: Failed to set privacy: Rejected (0x0b) Aug 08 19:21:32 volumio-salon ifplugd(eth0)[656]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Aug 08 19:21:33 volumio-salon haveged[472]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Aug 08 19:21:33 volumio-salon haveged[472]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Aug 08 19:21:33 volumio-salon haveged[472]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0021 Aug 08 19:21:33 volumio-salon haveged[472]: haveged: fills: 0, generated: 0 Aug 08 19:21:33 volumio-salon systemd[1]: Starting Hostname Service... Aug 08 19:21:33 volumio-salon cpufrequtils[659]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 08 19:21:33 volumio-salon systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 08 19:21:33 volumio-salon dbus-daemon[506]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 08 19:21:33 volumio-salon systemd[1]: Started Hostname Service. Aug 08 19:21:33 volumio-salon ntpd[658]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 08 19:21:34 volumio-salon nmbd[619]: [2024/08/08 19:21:34.065389, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 08 19:21:34 volumio-salon nmbd[619]: started asyncdns process 690 Aug 08 19:21:34 volumio-salon nmbd[619]: [2024/08/08 19:21:34.069609, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 08 19:21:34 volumio-salon nmbd[619]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 08 19:21:34 volumio-salon nmbd[619]: [2024/08/08 19:21:34.069842, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 08 19:21:34 volumio-salon nmbd[619]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 08 19:21:34 volumio-salon systemd[1]: systemd-rfkill.service: Succeeded. Aug 08 19:21:34 volumio-salon ntpd[658]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 08 19:21:34 volumio-salon wireless.js[514]: Cleaning previous... Aug 08 19:21:34 volumio-salon sudo[698]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 08 19:21:34 volumio-salon sudo[698]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:34 volumio-salon sudo[698]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:34 volumio-salon sudo[700]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 08 19:21:34 volumio-salon sudo[700]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:35 volumio-salon sudo[700]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:35 volumio-salon wireless.js[514]: Stopped aP Aug 08 19:21:35 volumio-salon wireless.js[514]: Wireless Networking DISABLED, not starting wireless flow Aug 08 19:21:35 volumio-salon ntpd[658]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 08 19:21:35 volumio-salon systemd[1]: wireless.service: Succeeded. Aug 08 19:21:35 volumio-salon systemd[1]: Started Wireless Services. Aug 08 19:21:35 volumio-salon systemd[1]: Started Volumio Backend Module. Aug 08 19:21:35 volumio-salon systemd[1]: Started Volumio Cpu Tweaker. Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: Setting RT Priority for mpd Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: Setting MPD Affinity Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: pid 678's current affinity mask: f Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: pid 678's new affinity mask: 3 Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 08 19:21:35 volumio-salon volumio-cpu-tweak[709]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Aug 08 19:21:35 volumio-salon systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 08 19:21:35 volumio-salon mpd[678]: Aug 08 19:21 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 08 19:21:36 volumio-salon bthelper[559]: Changing power off succeeded Aug 08 19:21:36 volumio-salon bthelper[559]: [CHG] Controller B8:27:EB:89:96:83 Powered: no Aug 08 19:21:36 volumio-salon bthelper[559]: [CHG] Controller B8:27:EB:89:96:83 Discovering: no Aug 08 19:21:36 volumio-salon bthelper[559]: [CHG] Controller B8:27:EB:89:96:83 Class: 0x00000000 Aug 08 19:21:36 volumio-salon bthelper[559]: [CHG] Controller B8:27:EB:89:96:83 Class: 0x0000041c Aug 08 19:21:36 volumio-salon bthelper[559]: Changing power on succeeded Aug 08 19:21:36 volumio-salon mpd[678]: Aug 08 19:21 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 08 19:21:36 volumio-salon mpd[678]: Aug 08 19:21 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 08 19:21:36 volumio-salon systemd[1]: Started Music Player Daemon. Aug 08 19:21:36 volumio-salon ntpd[658]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 08 19:21:36 volumio-salon sh[413]: eth0: leased 10.16.1.249 for 7200 seconds Aug 08 19:21:36 volumio-salon dhcpcd[459]: eth0: leased 10.16.1.249 for 7200 seconds Aug 08 19:21:36 volumio-salon sh[413]: eth0: adding route to 10.16.1.0/24 Aug 08 19:21:36 volumio-salon sh[413]: eth0: adding default route via 10.16.1.1 Aug 08 19:21:36 volumio-salon avahi-daemon[525]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.16.1.249. Aug 08 19:21:36 volumio-salon avahi-daemon[525]: New relevant interface eth0.IPv4 for mDNS. Aug 08 19:21:36 volumio-salon dhcpcd[459]: eth0: adding route to 10.16.1.0/24 Aug 08 19:21:36 volumio-salon avahi-daemon[525]: Registering new address record for 10.16.1.249 on eth0.IPv4. Aug 08 19:21:36 volumio-salon dhcpcd[459]: eth0: adding default route via 10.16.1.1 Aug 08 19:21:36 volumio-salon sh[413]: forked to background, child pid 754 Aug 08 19:21:36 volumio-salon dhcpcd[459]: forked to background, child pid 754 Aug 08 19:21:36 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:36] [info] asio async_connect error: system:111 (Connection refused) Aug 08 19:21:36 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:36] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 08 19:21:36 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:36] [error] handle_connect error: Underlying Transport Error Aug 08 19:21:36 volumio-salon ifplugd(eth0)[656]: client: ifup: interface eth0 already configured Aug 08 19:21:36 volumio-salon sh[413]: eth0=eth0 Aug 08 19:21:37 volumio-salon ifplugd(eth0)[656]: Program executed successfully. Aug 08 19:21:37 volumio-salon ifplugd[605]: Network Interface Plugging Daemon...start eth0...done. Aug 08 19:21:37 volumio-salon systemd[1]: Started LSB: Brings up/down network automatically. Aug 08 19:21:38 volumio-salon ntpd[658]: Listen normally on 3 eth0 10.16.1.249:123 Aug 08 19:21:38 volumio-salon ntpd[658]: new interface(s) found: waking up resolver Aug 08 19:21:38 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:38 volumio-salon volumio[708]: info: ----- Volumio3 ---- Aug 08 19:21:38 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:38 volumio-salon volumio[708]: info: ----- System startup ---- Aug 08 19:21:38 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:39 volumio-salon nmbd[619]: [2024/08/08 19:21:39.078444, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 08 19:21:39 volumio-salon systemd[1]: Started Samba NMB Daemon. Aug 08 19:21:39 volumio-salon nmbd[619]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 08 19:21:39 volumio-salon systemd[1]: Starting Samba Winbind Daemon... Aug 08 19:21:39 volumio-salon winbindd[788]: [2024/08/08 19:21:39.477034, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 08 19:21:39 volumio-salon winbindd[788]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 08 19:21:39 volumio-salon winbindd[788]: [2024/08/08 19:21:39.505449, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 08 19:21:39 volumio-salon winbindd[788]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 08 19:21:39 volumio-salon systemd[1]: Started Samba Winbind Daemon. Aug 08 19:21:39 volumio-salon systemd[1]: Starting Samba SMB Daemon... Aug 08 19:21:40 volumio-salon smbd[793]: [2024/08/08 19:21:40.144905, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 08 19:21:40 volumio-salon smbd[793]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 08 19:21:40 volumio-salon systemd[1]: Started Samba SMB Daemon. Aug 08 19:21:40 volumio-salon systemd[1]: Reached target Multi-User System. Aug 08 19:21:40 volumio-salon systemd[1]: Reached target Graphical Interface. Aug 08 19:21:40 volumio-salon volumio[708]: info: MYVOLUMIO Environment detected Aug 08 19:21:40 volumio-salon systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 08 19:21:40 volumio-salon systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 08 19:21:40 volumio-salon systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 08 19:21:40 volumio-salon systemd[1]: Startup finished in 10.119s (kernel) + 17.317s (userspace) = 27.437s. Aug 08 19:21:40 volumio-salon volumio[708]: info: Plugin folders cleanup Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning into folder /volumio/app/plugins/ Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category audio_interface Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category miscellanea Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category music_service Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category plugins.json Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category system_controller Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category user_interface Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning into folder /data/plugins/ Aug 08 19:21:40 volumio-salon volumio[708]: info: Scanning category music_service Aug 08 19:21:40 volumio-salon volumio[708]: info: Plugin folders cleanup completed Aug 08 19:21:40 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:40 volumio-salon volumio[708]: info: ----- Core plugins startup ---- Aug 08 19:21:40 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:40 volumio-salon volumio[708]: info: Loading plugins from folder /volumio/app/plugins/ Aug 08 19:21:40 volumio-salon volumio[708]: info: Adding plugin upnp to MyMusic Plugins Aug 08 19:21:40 volumio-salon volumio[708]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 08 19:21:40 volumio-salon volumio[708]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 08 19:21:40 volumio-salon volumio[708]: info: Loading plugins from folder /data/plugins/ Aug 08 19:21:40 volumio-salon volumio[708]: info: Loading plugin "system"... Aug 08 19:21:40 volumio-salon volumio[708]: info: Loading plugin "appearance"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "network"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Refreshing Cached IP Addresses Aug 08 19:21:42 volumio-salon sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 08 19:21:42 volumio-salon sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "services"... Aug 08 19:21:42 volumio-salon sudo[805]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "alsa_controller"... Aug 08 19:21:42 volumio-salon sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 08 19:21:42 volumio-salon sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:42 volumio-salon sudo[807]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:42 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "wizard"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "volumio_command_line_client"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "upnp"... Aug 08 19:21:42 volumio-salon volumio[708]: info: [1723137702265] Starting Upmpd Daemon Aug 08 19:21:42 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "my_music"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "mpd"... Aug 08 19:21:42 volumio-salon volumio[708]: info: Creating MPD Configuration file Aug 08 19:21:42 volumio-salon volumio[708]: info: Loading plugin "upnp_browser"... Aug 08 19:21:42 volumio-salon sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 08 19:21:42 volumio-salon sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:42 volumio-salon sudo[813]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:42 volumio-salon sudo[815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 08 19:21:42 volumio-salon sudo[815]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:42 volumio-salon systemd[1]: Stopping Music Player Daemon... Aug 08 19:21:42 volumio-salon systemd[1]: mpd.service: Succeeded. Aug 08 19:21:42 volumio-salon systemd[1]: Stopped Music Player Daemon. Aug 08 19:21:43 volumio-salon systemd[1]: Starting Music Player Daemon... Aug 08 19:21:43 volumio-salon volumio[708]: info: Loading plugin "networkfs"... Aug 08 19:21:43 volumio-salon volumio[708]: info: Starting Udev Watcher for removable devices Aug 08 19:21:43 volumio-salon sudo[823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=mk85ak87bk89jm58,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.16.1.246/Multimedia/Music /mnt/NAS/Musicserver Aug 08 19:21:43 volumio-salon sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:44 volumio-salon kernel: Key type cifs.spnego registered Aug 08 19:21:44 volumio-salon kernel: Key type cifs.idmap registered Aug 08 19:21:44 volumio-salon 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. Aug 08 19:21:44 volumio-salon kernel: CIFS: Attempting to mount \\10.16.1.246\Multimedia Aug 08 19:21:44 volumio-salon volumio[708]: info: Ignoring mount for partition: boot Aug 08 19:21:44 volumio-salon volumio[708]: info: Ignoring mount for partition: volumio Aug 08 19:21:44 volumio-salon volumio[708]: info: Ignoring mount for partition: volumio_data Aug 08 19:21:44 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "alarm-clock"... Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "airplay_emulation"... Aug 08 19:21:44 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:44] [connect] Successful connection Aug 08 19:21:44 volumio-salon volumio[708]: info: Starting Shairport Sync Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "last_100"... Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "webradio"... Aug 08 19:21:44 volumio-salon mpd[820]: Aug 08 19:21 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "i2s_dacs"... Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "volumiodiscovery"... Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** For more information see Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 19:21:44 volumio-salon volumio[708]: *** WARNING *** For more information see Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** For more information see Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 08 19:21:44 volumio-salon node[708]: *** WARNING *** For more information see Aug 08 19:21:44 volumio-salon volumio[708]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 08 19:21:44 volumio-salon volumio[708]: info: Discovery: Started advertising with name: Volumio salon Aug 08 19:21:44 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 19:21:44 volumio-salon volumio[708]: info: Loading plugin "jellyfin"... Aug 08 19:21:45 volumio-salon mpd[820]: Aug 08 19:21 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 08 19:21:45 volumio-salon mpd[820]: Aug 08 19:21 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 08 19:21:45 volumio-salon systemd[1]: Started Music Player Daemon. Aug 08 19:21:45 volumio-salon sudo[815]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:46 volumio-salon volumio[708]: info: Loading plugin "spop"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "outputs"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "albumart"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Plugin example_plugin is not enabled Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "inputs"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "updater_comm"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Plugin mpdemulation is not enabled Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "rest_api"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading plugin "websocket"... Aug 08 19:21:48 volumio-salon volumio[708]: info: Loading i18n strings for locale en Aug 08 19:21:48 volumio-salon volumio[708]: Updating browse sources language Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:48 volumio-salon volumio[708]: Forking 3 albumart workers Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::initPlayerControls Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 19:21:48 volumio-salon volumio[708]: Express server listening on port 3000 Aug 08 19:21:48 volumio-salon volumio[708]: [Metrics] WebUI: 11s 167.38ms Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreStateMachine::resetVolumioState Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreStateMachine::getcurrentVolume Aug 08 19:21:48 volumio-salon volumio[708]: info: CoreCommandRouter::volumioRetrievevolume Aug 08 19:21:49 volumio-salon volumio[708]: info: MPD Permissions set Aug 08 19:21:49 volumio-salon volumio-remote-updater[520]: [2024-08-08 19:21:49] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723137704 101 Aug 08 19:21:49 volumio-salon volumio[708]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Aug 08 19:21:49 volumio-salon volumio[708]: info: MPD running with PID820 Aug 08 19:21:49 volumio-salon volumio[708]: ,establishing connection Aug 08 19:21:49 volumio-salon volumio[708]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:49 volumio-salon volumio[708]: info: Reloading queue from file Aug 08 19:21:49 volumio-salon volumio[708]: error: updateQueue error: null Aug 08 19:21:49 volumio-salon volumio[708]: info: Setting Device type: Raspberry PI Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::setRepeat null single undefined Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::pushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioPushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::setRandom null Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::pushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioPushState Aug 08 19:21:49 volumio-salon volumio[708]: info: VolumeController:: Volume=undefined Mute =false Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::pushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioPushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::updateTrackBlock Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrackBlock Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioRetrievevolume Aug 08 19:21:49 volumio-salon volumio[708]: error: updateQueue error: null Aug 08 19:21:49 volumio-salon volumio[708]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Aug 08 19:21:49 volumio-salon volumio[708]: info: VolumeController:: Volume=undefined Mute =false Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreStateMachine::pushState Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioPushState Aug 08 19:21:49 volumio-salon volumio[708]: Starting albumart workers Aug 08 19:21:49 volumio-salon volumio[708]: info: Discovery: adding 3b5cb3d6-7d41-493b-b3ab-efe439c8f9b8 Aug 08 19:21:49 volumio-salon volumio[708]: info: Discovery: Found device Volumio salon Aug 08 19:21:49 volumio-salon volumio[708]: info: CoreCommandRouter::volumioGetState Aug 08 19:21:49 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:49 volumio-salon volumio[708]: Starting albumart workers Aug 08 19:21:49 volumio-salon volumio[708]: Starting albumart workers Aug 08 19:21:50 volumio-salon sudo[823]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:50 volumio-salon kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 08 19:21:50 volumio-salon kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Aug 08 19:21:50 volumio-salon volumio[708]: info: Cannot mount NAS Musicserver at system boot, trial number 1 ,retrying in 5 seconds Aug 08 19:21:50 volumio-salon volumio[708]: info: Completed loading Core Plugins Aug 08 19:21:50 volumio-salon volumio[708]: info: Preparing to generate the ALSA configuration file Aug 08 19:21:50 volumio-salon volumio[708]: info: Asound.conf file unchanged, so no further update is needed Aug 08 19:21:50 volumio-salon volumio[708]: info: Output device has changed, restarting MPD Aug 08 19:21:50 volumio-salon sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 08 19:21:50 volumio-salon sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:50 volumio-salon volumio[708]: info: Output device has changed, restarting Shairport Sync Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:50 volumio-salon sudo[891]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:50 volumio-salon sudo[898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 08 19:21:50 volumio-salon sudo[898]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:50 volumio-salon volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 19:21:50 volumio-salon volumio[708]: info: ___________ START PLUGINS ___________ Aug 08 19:21:50 volumio-salon systemd[1]: Stopping Music Player Daemon... Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 19:21:50 volumio-salon volumio[708]: info: [1723137710575] CoreMusicLibrary::Adding element Media Servers Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:50 volumio-salon systemd[1]: mpd.service: Succeeded. Aug 08 19:21:50 volumio-salon systemd[1]: Stopped Music Player Daemon. Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:50 volumio-salon systemd[1]: Starting Music Player Daemon... Aug 08 19:21:50 volumio-salon volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:50 volumio-salon volumio[708]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 19:21:50 volumio-salon volumio[708]: info: [1723137710749] CoreMusicLibrary::Adding element Last_100 Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 19:21:50 volumio-salon volumio[708]: info: [1723137710753] CoreMusicLibrary::Adding element Webradio Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 08 19:21:50 volumio-salon volumio[708]: info: Discovery: Getting this device information Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::volumioGetState Aug 08 19:21:50 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 19:21:50 volumio-salon volumio[708]: info: [1723137710810] CoreMusicLibrary::Adding element Jellyfin Aug 08 19:21:50 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:50 volumio-salon volumio[708]: Cannot find translation for source Jellyfin Aug 08 19:21:50 volumio-salon volumio[708]: info: [jellyfin] Initialized plugin with device info: {"id":"3b5cb3d6-7d41-493b-b3ab-efe439c8f9b8","host":"http://10.16.1.249","name":"Volumio salon","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"","mute":false,"artist":"Wir Sind Helden","track":"Ist das So?","albumart":"http://10.16.1.248:8096/Items/6fe3c5e2e31fc00333d78297b452129a/Images/Primary?maxWidth=500&maxHeight=500&quality=90"}} Aug 08 19:21:50 volumio-salon volumio[708]: info: Creating Spotify config file Aug 08 19:21:50 volumio-salon volumio[708]: info: Volumio Calling Home Aug 08 19:21:51 volumio-salon volumio[708]: info: Completed starting Core Plugins Aug 08 19:21:51 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:51 volumio-salon volumio[708]: info: ----- MyVolumio plugins startup ---- Aug 08 19:21:51 volumio-salon volumio[708]: info: ------------------------------------------- Aug 08 19:21:51 volumio-salon volumio[708]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 08 19:21:51 volumio-salon volumio[708]: info: MPD Permissions set Aug 08 19:21:51 volumio-salon volumio[708]: info: [jellyfin-poller] Polled http://10.16.1.248:8096: online Aug 08 19:21:51 volumio-salon volumio[708]: info: Spotify config file written Aug 08 19:21:51 volumio-salon sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 08 19:21:51 volumio-salon sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:51 volumio-salon volumio[708]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Aug 08 19:21:51 volumio-salon volumio[708]: info: Volumio called home Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 08 19:21:51 volumio-salon systemd[1]: Started go-librespot Daemon. Aug 08 19:21:51 volumio-salon go-librespot[938]: Librespot-go daemon starting... Aug 08 19:21:51 volumio-salon sudo[932]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:51 volumio-salon volumio[708]: info: Starting Shairport Sync Aug 08 19:21:51 volumio-salon volumio[708]: info: Starting Shairport Sync Aug 08 19:21:51 volumio-salon volumio[708]: info: Starting Shairport Sync Aug 08 19:21:51 volumio-salon sudo[941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 19:21:51 volumio-salon sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:51 volumio-salon sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 19:21:51 volumio-salon sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:51 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 08 19:21:51 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Aug 08 19:21:51 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 08 19:21:51 volumio-salon sudo[946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 08 19:21:51 volumio-salon sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:51 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 08 19:21:51 volumio-salon sudo[941]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:51 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 08 19:21:51 volumio-salon systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 08 19:21:51 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Aug 08 19:21:51 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 08 19:21:51 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 08 19:21:51 volumio-salon sudo[943]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:51 volumio-salon sudo[946]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:51 volumio-salon volumio[708]: info: Shairport-Sync Started Aug 08 19:21:51 volumio-salon volumio[708]: Error adding Membership: Error: addMembership EINVAL Aug 08 19:21:51 volumio-salon volumio[708]: info: Shairport-Sync Started Aug 08 19:21:51 volumio-salon volumio[708]: info: Shairport-Sync Started Aug 08 19:21:51 volumio-salon volumio[708]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Aug 08 19:21:51 volumio-salon volumio[708]: SPOTIFY: BQD3QzZ5aBJlbaVsjRSArRJW9MfkFZSh86YRReP6mY90rmwlcAoCXvMuJYdvgT4dNiN5BkFgJxhovfiUW8HPdz2MrCTsEJ028PQPv4qX4bm5TXAT9idi3f4MzfdJm9lafwAaFR-YOHccjV-jWaQiV_04rihjqtsheUqVFSm9NqkLIzg1k9pWwRvn8DpkcpmVwBLSEcMEecrFAG2WSnJhT-VL9BpZ96BD8NJswYrsUni4_N0vZvO2NXCT_MQ83Ur36dD48vK-y9YzfC5GuTM Aug 08 19:21:51 volumio-salon volumio[708]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Aug 08 19:21:51 volumio-salon volumio[708]: info: New Spotify access token = BQD3QzZ5aBJlbaVsjRSArRJW9MfkFZSh86YRReP6mY90rmwlcAoCXvMuJYdvgT4dNiN5BkFgJxhovfiUW8HPdz2MrCTsEJ028PQPv4qX4bm5TXAT9idi3f4MzfdJm9lafwAaFR-YOHccjV-jWaQiV_04rihjqtsheUqVFSm9NqkLIzg1k9pWwRvn8DpkcpmVwBLSEcMEecrFAG2WSnJhT-VL9BpZ96BD8NJswYrsUni4_N0vZvO2NXCT_MQ83Ur36dD48vK-y9YzfC5GuTM Aug 08 19:21:51 volumio-salon volumio[708]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::volumioGetState Aug 08 19:21:51 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:51 volumio-salon go-librespot[938]: time="2024-08-08T19:21:51+02:00" level=info msg="generated new device id: dfea252ce08c72512624b76315c3fddf02790b81" Aug 08 19:21:51 volumio-salon go-librespot[938]: time="2024-08-08T19:21:51+02:00" level=debug msg="stored credentials found for 31svera36eisww4kc2rtybuu2m4y" Aug 08 19:21:51 volumio-salon volumio[708]: SPOTIFY: User informations: {"display_name":"joka91400","external_urls":{"spotify":"https://open.spotify.com/user/31svera36eisww4kc2rtybuu2m4y"},"href":"https://api.spotify.com/v1/users/31svera36eisww4kc2rtybuu2m4y","id":"31svera36eisww4kc2rtybuu2m4y","images":[],"type":"user","uri":"spotify:user:31svera36eisww4kc2rtybuu2m4y","followers":{"href":null,"total":0},"country":"FR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"joerg.kalkbrenner@gmail.com"} Aug 08 19:21:51 volumio-salon volumio[708]: info: Spotify Successfully logged in Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 08 19:21:51 volumio-salon volumio[708]: info: [1723137711843] CoreMusicLibrary::Adding element Spotify Aug 08 19:21:51 volumio-salon volumio[708]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 08 19:21:51 volumio-salon volumio[708]: Cannot find translation for source Jellyfin Aug 08 19:21:51 volumio-salon volumio[708]: Cannot find translation for source Spotify Aug 08 19:21:52 volumio-salon go-librespot[938]: time="2024-08-08T19:21:52+02:00" level=debug msg="obtained new client token: AAC9X+oQqbwNMoLpdnHci59dymQ1PZO/cA0fkdoFCxC6dl5/nsc57Q3c11C1ZfH/2semGXEiO52dAtpPEtpBf7VYp1yoeXR4PAxLCZDD9eVJDc5+vB398UGwHx66Lc1b2/O3bWbux3Y+bbgLiro8Rs0R/JnhzAkdJz2S2LpaNl6d9NyBz/oWEX7lSn1Poc5KpTE+vvPhLCJzyQaBFA857b/nxKbhnH+ICf1Axz50Vs/8k9CiiLTRQJs7YGA=" Aug 08 19:21:52 volumio-salon mpd[927]: Aug 08 19:21 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 08 19:21:52 volumio-salon sudo[960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 08 19:21:52 volumio-salon sudo[960]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:52 volumio-salon sudo[960]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:52 volumio-salon go-librespot[938]: time="2024-08-08T19:21:52+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 08 19:21:52 volumio-salon sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 08 19:21:52 volumio-salon sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:52 volumio-salon sudo[963]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:52 volumio-salon sudo[966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 08 19:21:52 volumio-salon sudo[966]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:52 volumio-salon go-librespot[938]: time="2024-08-08T19:21:52+02:00" level=debug msg="completed keyexchange" Aug 08 19:21:52 volumio-salon systemd[1]: Started UPnP Renderer front-end to MPD. Aug 08 19:21:52 volumio-salon sudo[966]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:52 volumio-salon volumio[708]: info: Upmpdcli Daemon Started Aug 08 19:21:52 volumio-salon mpd[927]: Aug 08 19:21 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Aug 08 19:21:52 volumio-salon mpd[927]: Aug 08 19:21 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Aug 08 19:21:52 volumio-salon systemd[1]: Started Music Player Daemon. Aug 08 19:21:52 volumio-salon sudo[898]: pam_unix(sudo:session): session closed for user root Aug 08 19:21:52 volumio-salon volumio[708]: error: updateQueue error: null Aug 08 19:21:52 volumio-salon volumio[968]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 08 19:21:52 volumio-salon go-librespot[938]: time="2024-08-08T19:21:52+02:00" level=debug msg="completed challenge" Aug 08 19:21:52 volumio-salon go-librespot[938]: time="2024-08-08T19:21:52+02:00" level=debug msg="authenticated as 31svera36eisww4kc2rtybuu2m4y" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="authenticated as 31svera36eisww4kc2rtybuu2m4y" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="dealer connection opened" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="received connection id: MTAxMDk2MWQtMTQ2OC00OTY3LWJjNmQtOWRlOGNjMDNkZTQ2K2RlYWxlcit0Y3A6Ly8wYWNhNDA0Yi5pcC5nZXcxLnNwb3RpZnkubmV0OjU3MDArNjk2OUUzRkU0MzIxQTVEMkZGMDZEMjQyNTBGOTdFMjk1OEE4RTBBODYyQ0U2Rjc2REQwRTUyQzQ5Q0QzMkQzQQ==" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Aug 08 19:21:53 volumio-salon go-librespot[938]: time="2024-08-08T19:21:53+02:00" level=debug msg="put connect state because NEW_DEVICE" Aug 08 19:21:54 volumio-salon volumio[708]: info: go-librespot daemon successfully initialized Aug 08 19:21:54 volumio-salon volumio[708]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 08 19:21:56 volumio-salon sudo[987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=mk85ak87bk89jm58,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.16.1.246/Multimedia/Music /mnt/NAS/Musicserver Aug 08 19:21:56 volumio-salon sudo[987]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 08 19:21:56 volumio-salon kernel: CIFS: Attempting to mount \\10.16.1.246\Multimedia Aug 08 19:21:57 volumio-salon systemd[1]: systemd-fsckd.service: Succeeded. Aug 08 19:21:57 volumio-salon volumio[708]: info: Initializing connection to go-librespot Websocket Aug 08 19:21:57 volumio-salon volumio[968]: .................................++++ Aug 08 19:21:57 volumio-salon go-librespot[938]: time="2024-08-08T19:21:57+02:00" level=debug msg="new websocket client" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="handling transfer player command from 69d92c4e2060abf305d639188e6a3a816d950673" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="loading track spotify:track:7M9w4C8WenlvWfNRAulZOX (paused: false, position: -783019445ms)" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=trace msg="emitting websocket event: will_play" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:7M9w4C8WenlvWfNRAulZOX" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="requested aes key for file f240377ee87e0f8d9181a1f310e6c806cb46da30, gid: 7M9w4C8WenlvWfNRAulZOX" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=debug msg="fetched first chunk of 17, total size is 8466788 bytes" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=trace msg="seek to -783019445ms (diff: -783019445ms, samples: -34531157524, bytes: 0)" Aug 08 19:21:58 volumio-salon go-librespot[938]: time="2024-08-08T19:21:58+02:00" level=info msg="loaded track \"Narcotic\" (uri: spotify:track:7M9w4C8WenlvWfNRAulZOX, paused: false, position: -783019445ms, duration: 192386ms)" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="fetched chunk 2/16, size: 524288" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=trace msg="emitting websocket event: metadata" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=trace msg="emitting websocket event: active" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="sending successful reply for delaer request" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="fetched chunk 3/16, size: 524288" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="fetched chunk 1/16, size: 524288" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1400" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=trace msg="emitting websocket event: playing" Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Aug 08 19:21:59 volumio-salon go-librespot[938]: time="2024-08-08T19:21:59+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1157" Aug 08 19:21:59 volumio-salon volumio[708]: info: Connection to go-librespot Websocket established Aug 08 19:21:59 volumio-salon volumio[708]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7M9w4C8WenlvWfNRAulZOX","play_origin":"playlist"}} Aug 08 19:21:59 volumio-salon volumio[708]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7M9w4C8WenlvWfNRAulZOX","name":"Narcotic","artist_names":["YouNotUs","Janieck","Senex"],"album_name":"Narcotic","album_cover_url":"https://i.scdn.co/image/ab67616d00001e029fb1a607a6e20866292fe960","position":-783019445,"duration":192386}} Aug 08 19:21:59 volumio-salon volumio[708]: SPOTIFY: received: {"type":"active","data":null} Aug 08 19:21:59 volumio-salon volumio[708]: info: Aligning Spotify Volume to Volumio Volume Aug 08 19:21:59 volumio-salon volumio[708]: info: CoreCommandRouter::volumioGetState Aug 08 19:21:59 volumio-salon volumio[708]: info: CorePlayQueue::getTrack 0 Aug 08 19:21:59 volumio-salon volumio[708]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7M9w4C8WenlvWfNRAulZOX","play_origin":"playlist"}} Aug 08 19:21:59 volumio-salon volumio[708]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 08 19:21:59 volumio-salon volumio[708]: TypeError: Cannot read property 'service' of undefined Aug 08 19:21:59 volumio-salon volumio[708]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:322:50) Aug 08 19:21:59 volumio-salon volumio[708]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:248:18) Aug 08 19:21:59 volumio-salon volumio[708]: at WebSocket.message (/data/plugins/music_service/spop/index.js:175:14) Aug 08 19:21:59 volumio-salon volumio[708]: at WebSocket.emit (events.js:315:20) Aug 08 19:21:59 volumio-salon volumio[708]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1192:20) Aug 08 19:21:59 volumio-salon volumio[708]: at Receiver.emit (events.js:315:20) Aug 08 19:21:59 volumio-salon volumio[708]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:560:14) Aug 08 19:21:59 volumio-salon volumio[708]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:478:17) Aug 08 19:21:59 volumio-salon volumio[708]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:22) Aug 08 19:21:59 volumio-salon volumio[708]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:180:18 Aug 08 19:21:59 volumio-salon volumio[708]: at internal/process/task_queues.js:149:7 Aug 08 19:21:59 volumio-salon volumio[708]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Aug 08 19:21:59 volumio-salon volumio[708]: at AsyncResource.runMicrotask (internal/process/task_queues.js:146:8) Aug 08 19:21:59 volumio-salon volumio[708]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Aug 08 19:21:59 volumio-salon volumio[708]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 08 19:22:00 volumio-salon sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-08 19:21 Aug 08 19:22:00 volumio-salon sudo[1002]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"