-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-01-18 14:59:57 CET. -- Jan 18 14:58:43 wohnzimmer fake-hwclock[304]: Sat Jan 18 13:58:43 UTC 2025 Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Create System Users... Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Load/Save Random Seed... Jan 18 14:58:43 wohnzimmer systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Restore / save the current clock. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Apply Kernel Variables. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Load/Save Random Seed. Jan 18 14:58:43 wohnzimmer systemd[1]: dynamicswap.service: Succeeded. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Create System Users. Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Create Static Device Nodes in /dev... Jan 18 14:58:43 wohnzimmer systemd[1]: Started udev Coldplug all Devices. Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jan 18 14:58:43 wohnzimmer systemd[1]: Started Helper to synchronize boot up for ifupdown. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Create Static Device Nodes in /dev. Jan 18 14:58:43 wohnzimmer systemd[1]: Starting udev Kernel Device Manager... Jan 18 14:58:43 wohnzimmer systemd[1]: Reached target Local File Systems (Pre). Jan 18 14:58:43 wohnzimmer systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounting /tmp... Jan 18 14:58:43 wohnzimmer systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounting /var/log... Jan 18 14:58:43 wohnzimmer systemd[1]: Mounting /var/spool/cups... Jan 18 14:58:43 wohnzimmer systemd[1]: Mounted /tmp. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounted /var/log. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounted /var/spool/cups. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounting /var/spool/cups/tmp... Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Flush Journal to Persistent Storage... Jan 18 14:58:43 wohnzimmer systemd-udevd[337]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jan 18 14:58:43 wohnzimmer systemd[1]: Mounted /var/spool/cups/tmp. Jan 18 14:58:43 wohnzimmer systemd[1]: Started udev Kernel Device Manager. Jan 18 14:58:43 wohnzimmer systemd[1]: Starting Show Plymouth Boot Screen... Jan 18 14:58:43 wohnzimmer systemd-journald[311]: Runtime journal (/run/log/journal/b09207998001defae5f73bf26405b501) is 7.5M, max 30.0M, 22.5M free. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Flush Journal to Persistent Storage. Jan 18 14:58:43 wohnzimmer systemd[1]: plymouth-start.service: Succeeded. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Show Plymouth Boot Screen. Jan 18 14:58:43 wohnzimmer systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jan 18 14:58:43 wohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 18 14:58:43 wohnzimmer systemd[1]: Reached target Local Encrypted Volumes. Jan 18 14:58:43 wohnzimmer systemd[1]: Reached target Paths. Jan 18 14:58:43 wohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Jan 18 14:58:43 wohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Jan 18 14:58:43 wohnzimmer kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:43 wohnzimmer kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Jan 18 14:58:43 wohnzimmer kernel: [vc_sm_connected_init]: start Jan 18 14:58:43 wohnzimmer kernel: [vc_sm_connected_init]: installed successfully Jan 18 14:58:43 wohnzimmer kernel: mc: Linux media interface: v0.10 Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: Core ver 2.22 Jan 18 14:58:43 wohnzimmer kernel: NET: Registered PF_BLUETOOTH protocol family Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: HCI device and connection manager initialized Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: HCI socket layer initialized Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: L2CAP socket layer initialized Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: SCO socket layer initialized Jan 18 14:58:43 wohnzimmer kernel: videodev: Linux video capture interface: v2.00 Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: HCI UART driver ver 2.3 Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: HCI UART protocol H4 registered Jan 18 14:58:43 wohnzimmer kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Jan 18 14:58:43 wohnzimmer kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Jan 18 14:58:44 wohnzimmer kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Jan 18 14:58:44 wohnzimmer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: HCI UART protocol Broadcom registered Jan 18 14:58:44 wohnzimmer kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Jan 18 14:58:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Jan 18 14:58:44 wohnzimmer kernel: uart-pl011 3f201000.serial: no DMA platform data Jan 18 14:58:44 wohnzimmer kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jan 18 14:58:44 wohnzimmer kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Jan 18 14:58:44 wohnzimmer kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Jan 18 14:58:44 wohnzimmer kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jan 18 14:58:44 wohnzimmer kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Jan 18 14:58:43 wohnzimmer systemd[1]: Found device /dev/disk/by-uuid/5883-B9C7. Jan 18 14:58:44 wohnzimmer systemd-udevd[349]: Using default interface naming scheme 'v240'. Jan 18 14:58:44 wohnzimmer systemd[1]: Starting File System Check on /dev/disk/by-uuid/5883-B9C7... Jan 18 14:58:44 wohnzimmer systemd-udevd[349]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 18 14:58:44 wohnzimmer kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:44 wohnzimmer kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:44 wohnzimmer kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Jan 18 14:58:44 wohnzimmer kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: hci0: BCM: chip id 94 Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: hci0: BCM: features 0x2e Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Jan 18 14:58:44 wohnzimmer systemd[1]: Started File System Check Daemon to report status. Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Jan 18 14:58:44 wohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Jan 18 14:58:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Jan 18 14:58:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Jan 18 14:58:44 wohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Jan 18 14:58:44 wohnzimmer kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Jan 18 14:58:44 wohnzimmer kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Jan 18 14:58:44 wohnzimmer kernel: usbcore: registered new interface driver brcmfmac Jan 18 14:58:44 wohnzimmer systemd-fsck[389]: fsck.fat 4.1 (2017-01-24) Jan 18 14:58:44 wohnzimmer systemd-fsck[389]: /dev/mmcblk0p1: 411 files, 41753/46774 clusters Jan 18 14:58:44 wohnzimmer systemd[1]: Started File System Check on /dev/disk/by-uuid/5883-B9C7. Jan 18 14:58:44 wohnzimmer systemd-udevd[353]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 18 14:58:44 wohnzimmer kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Jan 18 14:58:44 wohnzimmer 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 Jan 18 14:58:44 wohnzimmer kernel: usb 1-1.3: clock source 41 is not valid, cannot use Jan 18 14:58:45 wohnzimmer kernel: Bluetooth: hci0: BCM: features 0x2e Jan 18 14:58:45 wohnzimmer kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Jan 18 14:58:45 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Jan 18 14:58:45 wohnzimmer kernel: alsactl[490]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Jan 18 14:58:45 wohnzimmer kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Jan 18 14:58:45 wohnzimmer kernel: usbcore: registered new interface driver snd-usb-audio Jan 18 14:58:45 wohnzimmer alsactl[571]: alsactl 1.1.8 daemon started Jan 18 14:58:44 wohnzimmer systemd-udevd[344]: Using default interface naming scheme 'v240'. Jan 18 14:58:44 wohnzimmer systemd-udevd[344]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Created slice system-bthelper.slice. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Show Plymouth Boot Screen... Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Huge Pages File System being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jan 18 14:58:45 wohnzimmer systemd[1]: Mounting /boot... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Load/Save RF Kill Switch Status... Jan 18 14:58:45 wohnzimmer systemd[1]: plymouth-start.service: Succeeded. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Show Plymouth Boot Screen. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 18 14:58:45 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Jan 18 14:58:45 wohnzimmer systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Load/Save RF Kill Switch Status. Jan 18 14:58:45 wohnzimmer systemd[1]: Mounted /boot. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target Local File Systems. Jan 18 14:58:45 wohnzimmer systemd[1]: Started ifup for eth0. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Create Volatile Files and Directories... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Raise network interfaces... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Preprocess NFS configuration... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jan 18 14:58:45 wohnzimmer systemd[1]: Started ifup for wlan0. Jan 18 14:58:45 wohnzimmer systemd[1]: plymouth-read-write.service: Succeeded. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jan 18 14:58:45 wohnzimmer systemd[1]: Received SIGRTMIN+20 from PID 199 (plymouthd). Jan 18 14:58:45 wohnzimmer systemd[1]: nfs-config.service: Succeeded. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Preprocess NFS configuration. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target NFS client services. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Create Volatile Files and Directories. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting RPC bind portmap service... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jan 18 14:58:45 wohnzimmer systemd[1]: Started Update UTMP about System Boot/Shutdown. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target System Initialization. Jan 18 14:58:45 wohnzimmer systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 18 14:58:45 wohnzimmer systemd[1]: Listening on triggerhappy.socket. Jan 18 14:58:45 wohnzimmer systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target Sockets. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target Basic System. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Volumio Time Update Utility... Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Wireless Services... Jan 18 14:58:45 wohnzimmer systemd[1]: Started Volumio Log Rotation Service. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Manage Sound Card State (restore and store). Jan 18 14:58:45 wohnzimmer systemd[1]: Starting triggerhappy global hotkey daemon... Jan 18 14:58:45 wohnzimmer systemd[1]: Started D-Bus System Message Bus. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting WPA supplicant... Jan 18 14:58:45 wohnzimmer systemd[1]: Started MPD Monitor Service. Jan 18 14:58:45 wohnzimmer systemd[1]: Started volumio-remote-updater.service. Jan 18 14:58:45 wohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Save/Restore Sound Card State... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Configure Bluetooth Modems connected by UART... Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jan 18 14:58:45 wohnzimmer systemd[1]: Starting dhcpcd on all interfaces... Jan 18 14:58:45 wohnzimmer systemd[1]: Starting Login Service... Jan 18 14:58:45 wohnzimmer systemd[1]: Started Daily apt download activities. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Daily apt upgrade and clean activities. Jan 18 14:58:45 wohnzimmer systemd[1]: Reached target Timers. Jan 18 14:58:45 wohnzimmer systemd[1]: Started Volumio Iptables Module. Jan 18 14:58:46 wohnzimmer thd[573]: Unable to parse trigger line: Jan 18 14:58:46 wohnzimmer thd[573]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jan 18 14:58:46 wohnzimmer thd[573]: Unable to parse trigger line: Jan 18 14:58:46 wohnzimmer thd[573]: Found socket passed from systemd Jan 18 14:58:46 wohnzimmer dhcpcd[590]: Not running dhcpcd because /etc/network/interfaces Jan 18 14:58:46 wohnzimmer dhcpcd[590]: defines some interfaces that will use a Jan 18 14:58:46 wohnzimmer dhcpcd[590]: DHCP client or static address Jan 18 14:58:46 wohnzimmer kernel: hwmon hwmon1: Undervoltage detected! Jan 18 14:58:46 wohnzimmer mpd_monitor.sh[577]: MPD error: Connection refused Jan 18 14:58:46 wohnzimmer systemd-logind[594]: New seat seat0. Jan 18 14:58:46 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 18 14:58:46 wohnzimmer mpd_monitor.sh[577]: mpd: no process found Jan 18 14:58:46 wohnzimmer kernel: 8021q: 802.1Q VLAN Support v1.8 Jan 18 14:58:46 wohnzimmer avahi-daemon[564]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Jan 18 14:58:46 wohnzimmer avahi-daemon[564]: Successfully dropped root privileges. Jan 18 14:58:46 wohnzimmer avahi-daemon[564]: avahi-daemon 0.7 starting up. Jan 18 14:58:47 wohnzimmer volumio-remote-updater[578]: Error: No active session Jan 18 14:58:47 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:47] [info] asio async_connect error: system:111 (Connection refused) Jan 18 14:58:47 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 14:58:47 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:47] [error] handle_connect error: Underlying Transport Error Jan 18 14:58:47 wohnzimmer haveged[544]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Jan 18 14:58:47 wohnzimmer haveged[544]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Jan 18 14:58:47 wohnzimmer haveged[544]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00047 Jan 18 14:58:47 wohnzimmer haveged[544]: haveged: fills: 0, generated: 0 Jan 18 14:58:47 wohnzimmer volumio[579]: Could not open config: /tmp/upmpdcli.conf Jan 18 14:58:47 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Date not found in response Jan 18 14:58:47 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 14:58:47 wohnzimmer systemd-udevd[343]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Jan 18 14:58:47 wohnzimmer sh[506]: eth0: waiting for carrier Jan 18 14:58:47 wohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Jan 18 14:58:47 wohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Jan 18 14:58:47 wohnzimmer dhcpcd[560]: eth0: waiting for carrier Jan 18 14:58:47 wohnzimmer dbus-daemon[574]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 18 14:58:47 wohnzimmer systemd[1]: Started Login Service. Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Successfully called chroot(). Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Successfully dropped remaining capabilities. Jan 18 14:58:47 wohnzimmer wpa_supplicant[575]: Successfully initialized wpa_supplicant Jan 18 14:58:47 wohnzimmer systemd[1]: Started triggerhappy global hotkey daemon. Jan 18 14:58:47 wohnzimmer systemd[1]: Started RPC bind portmap service. Jan 18 14:58:47 wohnzimmer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 18 14:58:47 wohnzimmer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 18 14:58:47 wohnzimmer systemd[1]: Started Save/Restore Sound Card State. Jan 18 14:58:47 wohnzimmer systemd[1]: hciuart.service: Succeeded. Jan 18 14:58:47 wohnzimmer systemd[1]: Started Configure Bluetooth Modems connected by UART. Jan 18 14:58:47 wohnzimmer systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Loading service file /services/volumio.service. Jan 18 14:58:47 wohnzimmer systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Network interface enumeration completed. Jan 18 14:58:47 wohnzimmer systemd[1]: Failed to start dhcpcd on all interfaces. Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Server startup complete. Host name is wohnzimmer.local. Local service cookie is 800345728. Jan 18 14:58:47 wohnzimmer avahi-daemon[564]: Service "Wohnzimmer" (/services/volumio.service) successfully established. Jan 18 14:58:47 wohnzimmer systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jan 18 14:58:47 wohnzimmer systemd[1]: Started WPA supplicant. Jan 18 14:58:47 wohnzimmer sh[517]: wlan0=wlan0 Jan 18 14:58:47 wohnzimmer systemd[1]: Listening on mpd.socket. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Raspberry Pi bluetooth helper... Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target Sound Card. Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target RPC Port Mapper. Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target Remote File Systems (Pre). Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target Remote File Systems. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jan 18 14:58:47 wohnzimmer systemd[1]: iptables.service: Succeeded. Jan 18 14:58:47 wohnzimmer systemd[1]: Started Raise network interfaces. Jan 18 14:58:47 wohnzimmer bthelper[703]: Raspberry Pi BDADDR already set Jan 18 14:58:47 wohnzimmer systemd[1]: Started Raspberry Pi bluetooth helper. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Bluetooth service... Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target Network. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Network Time Service... Jan 18 14:58:47 wohnzimmer systemd[1]: Reached target Network is Online. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting LSB: Brings up/down network automatically... Jan 18 14:58:47 wohnzimmer systemd[1]: Starting /etc/rc.local Compatibility... Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Samba NMB Daemon... Jan 18 14:58:47 wohnzimmer systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Permit User Sessions... Jan 18 14:58:47 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 18 14:58:47 wohnzimmer systemd[1]: Starting Music Player Daemon... Jan 18 14:58:47 wohnzimmer systemd[1]: Started /etc/rc.local Compatibility. Jan 18 14:58:48 wohnzimmer systemd[1]: Started Permit User Sessions. Jan 18 14:58:48 wohnzimmer systemd[1]: Starting Hold until boot process finishes up... Jan 18 14:58:48 wohnzimmer systemd[1]: Starting Terminate Plymouth Boot Screen... Jan 18 14:58:48 wohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 199 (plymouthd). Jan 18 14:58:48 wohnzimmer loadcpufreq[704]: Loading cpufreq kernel modules...done (none). Jan 18 14:58:48 wohnzimmer systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jan 18 14:58:48 wohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 199 (plymouthd). Jan 18 14:58:48 wohnzimmer systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jan 18 14:58:48 wohnzimmer ifplugd(eth0)[784]: ifplugd 0.28 initializing. Jan 18 14:58:48 wohnzimmer systemd[1]: plymouth-quit.service: Succeeded. Jan 18 14:58:48 wohnzimmer ifplugd(eth0)[784]: Using interface eth0/B8:27:EB:85:E4:83 with driver (version: 6.6.62-v7+) Jan 18 14:58:48 wohnzimmer systemd[1]: Started Terminate Plymouth Boot Screen. Jan 18 14:58:48 wohnzimmer kernel: hwmon hwmon1: Voltage normalised Jan 18 14:58:48 wohnzimmer systemd[1]: plymouth-quit-wait.service: Succeeded. Jan 18 14:58:48 wohnzimmer ifplugd(eth0)[784]: Using detection mode: SIOCETHTOOL Jan 18 14:58:48 wohnzimmer systemd[1]: Started Hold until boot process finishes up. Jan 18 14:58:48 wohnzimmer ifplugd(eth0)[784]: Initialization complete, link beat not detected. Jan 18 14:58:48 wohnzimmer systemd[1]: Started Getty on tty1. Jan 18 14:58:48 wohnzimmer systemd[1]: Reached target Login Prompts. Jan 18 14:58:48 wohnzimmer ifplugd[738]: Network Interface Plugging Daemon...start eth0...done. Jan 18 14:58:48 wohnzimmer systemd[1]: Started LSB: Brings up/down network automatically. Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Bluetooth daemon 5.50 Jan 18 14:58:48 wohnzimmer ntpd[737]: ntpd 4.2.8p12@1.3728-o (1): Starting Jan 18 14:58:48 wohnzimmer ntpd[737]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Jan 18 14:58:48 wohnzimmer systemd[1]: Started Network Time Service. Jan 18 14:58:48 wohnzimmer ntpd[797]: proto: precision = 0.729 usec (-20) Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jan 18 14:58:48 wohnzimmer systemd[1]: Started Bluetooth service. Jan 18 14:58:48 wohnzimmer systemd[1]: Reached target Bluetooth. Jan 18 14:58:48 wohnzimmer ntpd[797]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jan 18 14:58:48 wohnzimmer ntpd[797]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jan 18 14:58:48 wohnzimmer ntpd[797]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 22 days ago Jan 18 14:58:48 wohnzimmer ntpd[797]: Listen and drop on 0 v6wildcard [::]:123 Jan 18 14:58:48 wohnzimmer ntpd[797]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 18 14:58:48 wohnzimmer ntpd[797]: Listen normally on 2 lo 127.0.0.1:123 Jan 18 14:58:48 wohnzimmer ntpd[797]: Listening on routing socket on fd #19 for interface updates Jan 18 14:58:48 wohnzimmer ntpd[797]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 18 14:58:48 wohnzimmer ntpd[797]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 18 14:58:48 wohnzimmer cpufrequtils[785]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Starting SDP server Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Excluding (cli) sap Jan 18 14:58:48 wohnzimmer systemd[1]: Started LSB: set CPUFreq kernel parameters. Jan 18 14:58:48 wohnzimmer kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jan 18 14:58:48 wohnzimmer kernel: Bluetooth: BNEP filters: protocol multicast Jan 18 14:58:48 wohnzimmer kernel: Bluetooth: BNEP socket layer initialized Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Bluetooth management interface 1.22 initialized Jan 18 14:58:48 wohnzimmer dbus-daemon[574]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=732 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jan 18 14:58:48 wohnzimmer kernel: Bluetooth: MGMT ver 1.22 Jan 18 14:58:48 wohnzimmer sudo[746]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 14:58:48 wohnzimmer sudo[746]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:48 wohnzimmer sudo[746]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 18 14:58:48 wohnzimmer sudo[746]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:48 wohnzimmer bluetoothd[732]: Failed to set privacy: Rejected (0x0b) Jan 18 14:58:48 wohnzimmer systemd[1]: Starting Hostname Service... Jan 18 14:58:48 wohnzimmer dbus-daemon[574]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 18 14:58:48 wohnzimmer systemd[1]: Started Hostname Service. Jan 18 14:58:49 wohnzimmer nmbd[749]: [2025/01/18 14:58:49.303855, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jan 18 14:58:49 wohnzimmer nmbd[749]: started asyncdns process 808 Jan 18 14:58:49 wohnzimmer nmbd[749]: [2025/01/18 14:58:49.306162, 0] ../lib/util/become_daemon.c:149(daemon_status) Jan 18 14:58:49 wohnzimmer nmbd[749]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jan 18 14:58:49 wohnzimmer nmbd[749]: [2025/01/18 14:58:49.306322, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jan 18 14:58:49 wohnzimmer nmbd[749]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jan 18 14:58:49 wohnzimmer ntpd[797]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 18 14:58:49 wohnzimmer wireless.js[567]: Cleaning previous... Jan 18 14:58:49 wohnzimmer sudo[816]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jan 18 14:58:49 wohnzimmer sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:49 wohnzimmer sudo[816]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:49 wohnzimmer sudo[818]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jan 18 14:58:49 wohnzimmer sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:50 wohnzimmer ntpd[797]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 18 14:58:50 wohnzimmer sudo[818]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:50 wohnzimmer wireless.js[567]: Stopped aP Jan 18 14:58:50 wohnzimmer systemd[1]: systemd-rfkill.service: Succeeded. Jan 18 14:58:50 wohnzimmer sudo[825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 18 14:58:50 wohnzimmer sudo[825]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:50 wohnzimmer sudo[825]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:50 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 18 14:58:50 wohnzimmer sudo[827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 18 14:58:50 wohnzimmer sudo[827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:50 wohnzimmer sudo[827]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:50 wohnzimmer sudo[834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 18 14:58:50 wohnzimmer sudo[834]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:50 wohnzimmer sudo[834]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:50 wohnzimmer sudo[836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 18 14:58:50 wohnzimmer sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:51 wohnzimmer sudo[836]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:51 wohnzimmer wireless.js[567]: SETTING APPROPRIATE REG DOMAIN: DE Jan 18 14:58:51 wohnzimmer sudo[841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 18 14:58:51 wohnzimmer sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:51 wohnzimmer sudo[841]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:51 wohnzimmer sudo[843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Jan 18 14:58:51 wohnzimmer sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:51 wohnzimmer sudo[843]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:51 wohnzimmer wireless.js[567]: SUCCESSFULLY SET NEW REGDOMAIN: DE Jan 18 14:58:51 wohnzimmer wireless.js[567]: Start wireless flow Jan 18 14:58:51 wohnzimmer wireless.js[567]: Stopped hotspot (if there).. Jan 18 14:58:51 wohnzimmer sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jan 18 14:58:51 wohnzimmer sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:51 wohnzimmer sudo[848]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:51 wohnzimmer ntpd[797]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 18 14:58:51 wohnzimmer sudo[850]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jan 18 14:58:51 wohnzimmer sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:51 wohnzimmer sudo[850]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:52 wohnzimmer wireless.js[567]: DHCP IP Jan 18 14:58:52 wohnzimmer wpa_supplicant[852]: Successfully initialized wpa_supplicant Jan 18 14:58:52 wohnzimmer wireless.js[567]: Start ap Jan 18 14:58:52 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 18 14:58:52 wohnzimmer sudo[853]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 18 14:58:52 wohnzimmer sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:52 wohnzimmer dhcpcd[854]: dev: loaded udev Jan 18 14:58:52 wohnzimmer dhcpcd-run-hooks[872]: wlan0: starting wpa_supplicant Jan 18 14:58:52 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:52] [info] asio async_connect error: system:111 (Connection refused) Jan 18 14:58:52 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:52] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 14:58:52 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:52] [error] handle_connect error: Underlying Transport Error Jan 18 14:58:52 wohnzimmer mpd[806]: Jan 18 14:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 14:58:52 wohnzimmer systemd[1]: Started Music Player Daemon. Jan 18 14:58:52 wohnzimmer mpd_monitor.sh[577]: MPD restarted due to no mpc output. Jan 18 14:58:52 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Jan 18 14:58:52 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Date not found in response Jan 18 14:58:52 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 14:58:52 wohnzimmer ntpd[797]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 18 14:58:52 wohnzimmer dhcpcd-run-hooks[885]: wlan0: failed to start wpa_supplicant Jan 18 14:58:52 wohnzimmer dhcpcd-run-hooks[886]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Jan 18 14:58:52 wohnzimmer dhcpcd[854]: wlan0: connected to Access Point `' Jan 18 14:58:52 wohnzimmer dhcpcd[854]: no interfaces have a carrier Jan 18 14:58:52 wohnzimmer dhcpcd[854]: forked to background, child pid 896 Jan 18 14:58:52 wohnzimmer dhcpcd[896]: eth0: waiting for carrier Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: waiting for carrier Jan 18 14:58:52 wohnzimmer sudo[853]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:52 wohnzimmer bthelper[703]: Changing power off succeeded Jan 18 14:58:52 wohnzimmer wpa_supplicant[876]: wlan0: Trying to associate with SSID 'Stuemper' Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: carrier acquired Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: connected to Access Point `Stuemper' Jan 18 14:58:52 wohnzimmer wpa_supplicant[876]: wlan0: Associated with 98:9b:cb:0b:a0:5d Jan 18 14:58:52 wohnzimmer wpa_supplicant[876]: wlan0: CTRL-EVENT-CONNECTED - Connection to 98:9b:cb:0b:a0:5d completed [id=0 id_str=] Jan 18 14:58:52 wohnzimmer wpa_supplicant[876]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 18 14:58:52 wohnzimmer wpa_supplicant[876]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Jan 18 14:58:52 wohnzimmer dhcpcd[896]: DUID 00:01:00:01:2b:98:74:13:b8:27:eb:d0:b1:d6 Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: IAID eb:d0:b1:d6 Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: adding address fe80::f3e0:be5c:5193:b72f Jan 18 14:58:52 wohnzimmer dhcpcd[896]: ipv6_addaddr1: Permission denied Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: carrier lost Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: carrier acquired Jan 18 14:58:52 wohnzimmer dhcpcd[896]: wlan0: IAID eb:d0:b1:d6 Jan 18 14:58:52 wohnzimmer bthelper[703]: [CHG] Controller B8:27:EB:2F:4E:29 Class: 0x0000041c Jan 18 14:58:52 wohnzimmer bthelper[703]: Changing power on succeeded Jan 18 14:58:53 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:53 wohnzimmer sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:53 wohnzimmer sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:53 wohnzimmer sudo[917]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:53 wohnzimmer dhcpcd[896]: wlan0: soliciting an IPv6 router Jan 18 14:58:53 wohnzimmer dhcpcd[896]: wlan0: rebinding lease of 192.168.178.181 Jan 18 14:58:53 wohnzimmer dhcpcd[896]: wlan0: probing address 192.168.178.181/24 Jan 18 14:58:54 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:54 wohnzimmer sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:54 wohnzimmer sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:54 wohnzimmer sudo[920]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:55 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:55 wohnzimmer sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:55 wohnzimmer sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:55 wohnzimmer sudo[923]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:56 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:56 wohnzimmer sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:56 wohnzimmer sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:56 wohnzimmer sudo[926]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:57 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:57 wohnzimmer sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:57 wohnzimmer sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:57 wohnzimmer sudo[929]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:57 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Jan 18 14:58:57 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Date not found in response Jan 18 14:58:57 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Retrying in 5 seconds... Jan 18 14:58:58 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:58 wohnzimmer sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:58 wohnzimmer sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:58 wohnzimmer sudo[937]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:58 wohnzimmer dhcpcd[896]: wlan0: leased 192.168.178.181 for 864000 seconds Jan 18 14:58:58 wohnzimmer avahi-daemon[564]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.181. Jan 18 14:58:58 wohnzimmer dhcpcd[896]: wlan0: adding route to 192.168.178.0/24 Jan 18 14:58:58 wohnzimmer dhcpcd[896]: wlan0: adding default route via 192.168.178.1 Jan 18 14:58:58 wohnzimmer avahi-daemon[564]: New relevant interface wlan0.IPv4 for mDNS. Jan 18 14:58:58 wohnzimmer avahi-daemon[564]: Registering new address record for 192.168.178.181 on wlan0.IPv4. Jan 18 14:58:59 wohnzimmer wireless.js[567]: trying... Jan 18 14:58:59 wohnzimmer sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 18 14:58:59 wohnzimmer sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:59 wohnzimmer sudo[961]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:59 wohnzimmer wireless.js[567]: Connected to: ----Stuemper Jan 18 14:58:59 wohnzimmer wireless.js[567]: ---- Jan 18 14:58:59 wohnzimmer sudo[964]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 14:58:59 wohnzimmer sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:58:59 wohnzimmer sudo[964]: pam_unix(sudo:session): session closed for user root Jan 18 14:58:59 wohnzimmer wireless.js[567]: ... joined AP, wlan0 IPv4 is 192.168.178.181, ipV6 is undefined Jan 18 14:58:59 wohnzimmer wireless.js[567]: It's done! AP Jan 18 14:58:59 wohnzimmer systemd[1]: Started Wireless Services. Jan 18 14:58:59 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 18 14:58:59 wohnzimmer systemd[1]: Started Volumio Backend Module. Jan 18 14:58:59 wohnzimmer systemd[1]: Started Volumio Cpu Tweaker. Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: Setting RT Priority for mpd Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: Setting MPD Affinity Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: pid 806's current affinity mask: f Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: pid 806's new affinity mask: 3 Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 18 14:58:59 wohnzimmer volumio-cpu-tweak[970]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 18 14:58:59 wohnzimmer nmbd[749]: [2025/01/18 14:58:59.311763, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 18 14:58:59 wohnzimmer systemd[1]: Started Samba NMB Daemon. Jan 18 14:58:59 wohnzimmer nmbd[749]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 18 14:58:59 wohnzimmer systemd[1]: Starting Samba Winbind Daemon... Jan 18 14:58:59 wohnzimmer systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 18 14:58:59 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:59] [info] asio async_connect error: system:111 (Connection refused) Jan 18 14:58:59 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:59] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 14:58:59 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:58:59] [error] handle_connect error: Underlying Transport Error Jan 18 14:58:59 wohnzimmer winbindd[986]: [2025/01/18 14:58:59.690051, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 18 14:58:59 wohnzimmer winbindd[986]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 18 14:58:59 wohnzimmer winbindd[986]: [2025/01/18 14:58:59.748188, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 18 14:58:59 wohnzimmer winbindd[986]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 18 14:58:59 wohnzimmer systemd[1]: Started Samba Winbind Daemon. Jan 18 14:58:59 wohnzimmer systemd[1]: Starting Samba SMB Daemon... Jan 18 14:59:00 wohnzimmer smbd[991]: [2025/01/18 14:59:00.416169, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 18 14:59:00 wohnzimmer smbd[991]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 18 14:59:00 wohnzimmer systemd[1]: Started Samba SMB Daemon. Jan 18 14:59:00 wohnzimmer ntpd[797]: Listen normally on 3 wlan0 192.168.178.181:123 Jan 18 14:59:00 wohnzimmer ntpd[797]: new interface(s) found: waking up resolver Jan 18 14:59:02 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:02 wohnzimmer volumio[969]: info: ----- Volumio3 ---- Jan 18 14:59:02 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:02 wohnzimmer volumio[969]: info: ----- System startup ---- Jan 18 14:59:02 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:02 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Jan 18 14:59:02 wohnzimmer volumio-time-update[563]: volumio-time-update-util: Setting system time to: 2025-01-18 14:59:23 Jan 18 14:59:02 wohnzimmer sudo[1015]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-18 14:59:23 Jan 18 14:59:02 wohnzimmer sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:02 wohnzimmer dbus-daemon[574]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.10' (uid=0 pid=1016 comm="timedatectl set-time 2025-01-18 14:59:23 ") Jan 18 14:59:02 wohnzimmer systemd[1]: Starting Time & Date Service... Jan 18 14:59:02 wohnzimmer dbus-daemon[574]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 18 14:59:02 wohnzimmer systemd[1]: Started Time & Date Service. Jan 18 14:59:23 wohnzimmer systemd-timedated[1017]: Changed local time to Sat Jan 18 14:59:23 2025 Jan 18 14:59:23 wohnzimmer sudo[1015]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:23 wohnzimmer volumio-time-update[563]: volumio-time-update-util: System time updated successfully. Jan 18 14:59:23 wohnzimmer systemd[1]: Started Volumio Time Update Utility. Jan 18 14:59:23 wohnzimmer systemd[1]: Reached target Multi-User System. Jan 18 14:59:23 wohnzimmer systemd[1]: Reached target Graphical Interface. Jan 18 14:59:23 wohnzimmer systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 18 14:59:23 wohnzimmer systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 18 14:59:23 wohnzimmer systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 18 14:59:23 wohnzimmer systemd[1]: Startup finished in 14.181s (kernel) + 21.378s (userspace) = 35.559s. Jan 18 14:59:23 wohnzimmer volumio[969]: info: MYVOLUMIO Environment detected Jan 18 14:59:23 wohnzimmer volumio[969]: info: Plugin folders cleanup Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning into folder /volumio/app/plugins/ Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category audio_interface Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category miscellanea Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category music_service Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category plugins.json Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category system_controller Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category user_interface Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning into folder /data/plugins/ Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category audio_interface Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category music_service Jan 18 14:59:23 wohnzimmer volumio[969]: info: Scanning category user_interface Jan 18 14:59:23 wohnzimmer volumio[969]: info: Plugin folders cleanup completed Jan 18 14:59:23 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:23 wohnzimmer volumio[969]: info: ----- Core plugins startup ---- Jan 18 14:59:23 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:23 wohnzimmer volumio[969]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 14:59:23 wohnzimmer volumio[969]: info: Adding plugin upnp to MyMusic Plugins Jan 18 14:59:23 wohnzimmer volumio[969]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 14:59:23 wohnzimmer volumio[969]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 14:59:23 wohnzimmer volumio[969]: info: Loading plugins from folder /data/plugins/ Jan 18 14:59:23 wohnzimmer volumio[969]: info: Loading plugin "system"... Jan 18 14:59:23 wohnzimmer volumio[969]: info: Loading plugin "appearance"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "network"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Refreshing Cached IP Addresses Jan 18 14:59:25 wohnzimmer sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 14:59:25 wohnzimmer sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:25 wohnzimmer sudo[1025]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:25 wohnzimmer sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 14:59:25 wohnzimmer sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "services"... Jan 18 14:59:25 wohnzimmer sudo[1027]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "alsa_controller"... Jan 18 14:59:25 wohnzimmer sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 14:59:25 wohnzimmer sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:25 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "wizard"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "networkfs"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Starting Udev Watcher for removable devices Jan 18 14:59:25 wohnzimmer sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=TC2pehwT7Y7C,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.160/music/Musik - flac /mnt/NAS/DS220+ Jan 18 14:59:25 wohnzimmer sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:25 wohnzimmer volumio[969]: info: Ignoring mount for partition: boot Jan 18 14:59:25 wohnzimmer volumio[969]: info: Ignoring mount for partition: volumio Jan 18 14:59:25 wohnzimmer volumio[969]: info: Ignoring mount for partition: volumio_data Jan 18 14:59:25 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "volumio_command_line_client"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "upnp"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: [1737208765838] Starting Upmpd Daemon Jan 18 14:59:25 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "my_music"... Jan 18 14:59:25 wohnzimmer volumio[969]: info: Loading plugin "mpd"... Jan 18 14:59:26 wohnzimmer kernel: Key type cifs.spnego registered Jan 18 14:59:26 wohnzimmer kernel: Key type cifs.idmap registered Jan 18 14:59:26 wohnzimmer 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. Jan 18 14:59:26 wohnzimmer kernel: CIFS: Attempting to mount //192.168.178.160/music/Musik - flac Jan 18 14:59:26 wohnzimmer kernel: cryptd: max_cpu_qlen set to 1000 Jan 18 14:59:26 wohnzimmer sudo[1035]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:26 wohnzimmer volumio[969]: info: Plugin upnp_browser is not enabled Jan 18 14:59:26 wohnzimmer volumio[969]: info: Loading plugin "alarm-clock"... Jan 18 14:59:26 wohnzimmer sudo[1051]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:26 wohnzimmer volumio[969]: info: Plugin airplay_emulation is not enabled Jan 18 14:59:26 wohnzimmer volumio[969]: info: Loading plugin "last_100"... Jan 18 14:59:26 wohnzimmer volumio[969]: info: Loading plugin "webradio"... Jan 18 14:59:26 wohnzimmer volumio[969]: info: Loading plugin "i2s_dacs"... Jan 18 14:59:27 wohnzimmer volumio[969]: info: I2S DAC not set, start Auto-detection Jan 18 14:59:27 wohnzimmer volumio[969]: info: Loading plugin "volumiodiscovery"... Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** For more information see Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 14:59:27 wohnzimmer volumio[969]: *** WARNING *** For more information see Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** For more information see Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 14:59:27 wohnzimmer node[969]: *** WARNING *** For more information see Jan 18 14:59:27 wohnzimmer volumio[969]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 14:59:27 wohnzimmer volumio[969]: info: Discovery: Started advertising with name: Wohnzimmer Jan 18 14:59:27 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 14:59:27 wohnzimmer volumio[969]: info: Loading plugin "spop"... Jan 18 14:59:29 wohnzimmer volumio[969]: info: Loading plugin "youtube2"... Jan 18 14:59:29 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:59:29] [connect] Successful connection Jan 18 14:59:34 wohnzimmer systemd[1]: systemd-fsckd.service: Succeeded. Jan 18 14:59:35 wohnzimmer volumio[969]: info: Loading plugin "ytcr"... Jan 18 14:59:37 wohnzimmer sh[506]: timed out Jan 18 14:59:37 wohnzimmer dhcpcd[560]: timed out Jan 18 14:59:37 wohnzimmer sh[506]: dhcpcd exited Jan 18 14:59:37 wohnzimmer dhcpcd[560]: dhcpcd exited Jan 18 14:59:37 wohnzimmer sh[506]: ifup: failed to bring up eth0 Jan 18 14:59:37 wohnzimmer systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 18 14:59:37 wohnzimmer systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 18 14:59:39 wohnzimmer systemd[1]: systemd-hostnamed.service: Succeeded. Jan 18 14:59:41 wohnzimmer volumio[969]: info: Loading plugin "outputs"... Jan 18 14:59:41 wohnzimmer volumio[969]: info: Loading plugin "albumart"... Jan 18 14:59:41 wohnzimmer volumio[969]: info: Plugin example_plugin is not enabled Jan 18 14:59:41 wohnzimmer volumio[969]: info: Loading plugin "inputs"... Jan 18 14:59:41 wohnzimmer volumio[969]: info: Loading plugin "updater_comm"... Jan 18 14:59:42 wohnzimmer volumio[969]: info: Plugin mpdemulation is not enabled Jan 18 14:59:42 wohnzimmer volumio[969]: info: Loading plugin "rest_api"... Jan 18 14:59:42 wohnzimmer volumio[969]: info: Loading plugin "websocket"... Jan 18 14:59:42 wohnzimmer volumio[969]: info: Starting Socket.io Server version 2.3.0 Jan 18 14:59:42 wohnzimmer volumio[969]: info: Loading plugin "fusiondsp"... Jan 18 14:59:42 wohnzimmer volumio[969]: Forking 3 albumart workers Jan 18 14:59:42 wohnzimmer volumio[969]: info: Applying required configuration parameters for plugin fusiondsp Jan 18 14:59:43 wohnzimmer volumio[969]: info: Loading plugin "Systeminfo"... Jan 18 14:59:43 wohnzimmer volumio[969]: Starting albumart workers Jan 18 14:59:43 wohnzimmer volumio[969]: Starting albumart workers Jan 18 14:59:43 wohnzimmer volumio[969]: Starting albumart workers Jan 18 14:59:43 wohnzimmer volumio[969]: info: Loading i18n strings for locale de Jan 18 14:59:43 wohnzimmer volumio[969]: Updating browse sources language Jan 18 14:59:43 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::initPlayerControls Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 14:59:44 wohnzimmer volumio[969]: Express server listening on port 3000 Jan 18 14:59:44 wohnzimmer volumio[969]: [Metrics] WebUI: 22s 783.69ms Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::resetVolumioState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::getcurrentVolume Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 14:59:44 wohnzimmer sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 14:59:44 wohnzimmer sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:44 wohnzimmer sudo[1177]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:44 wohnzimmer sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 14:59:44 wohnzimmer sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:44 wohnzimmer sudo[1180]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:44 wohnzimmer volumio[969]: info: Volumio Network Manager: Network status updated: 2 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::pushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioPushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::updateTrackBlock Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrackBlock Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 14:59:44 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Jan 18 14:59:44 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 2 Jan 18 14:59:44 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Jan 18 14:59:44 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 14:59:44 wohnzimmer volumio[969]: info: Discovery: Getting this device information Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 14:59:44 wohnzimmer volumio[969]: info: Discovery: Getting this device information Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 14:59:44 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::pushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioPushState Jan 18 14:59:44 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:59:44] [connect] Successful connection Jan 18 14:59:44 wohnzimmer volumio[969]: info: Reloading queue from file Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::setRepeat true single undefined Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::pushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioPushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::setRandom null Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::pushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioPushState Jan 18 14:59:44 wohnzimmer volumio[969]: info: Setting Device type: Raspberry PI Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 14:59:44 wohnzimmer volumio[969]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 18 14:59:44 wohnzimmer volumio[969]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a52082 Jan 18 14:59:44 wohnzimmer volumio[969]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 18 14:59:44 wohnzimmer volumio[969]: info: Received Get System Info Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 14:59:44 wohnzimmer volumio[969]: info: Discovery: Getting this device information Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:44 wohnzimmer volumio[969]: info: Listing playlists Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetQueue Jan 18 14:59:44 wohnzimmer volumio[969]: info: CoreStateMachine::getQueue Jan 18 14:59:44 wohnzimmer volumio[969]: info: CorePlayQueue::getQueue Jan 18 14:59:45 wohnzimmer volumio-remote-updater[578]: [2025-01-18 14:59:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737208784 101 Jan 18 14:59:45 wohnzimmer volumio[969]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Jan 18 14:59:45 wohnzimmer sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 18 14:59:45 wohnzimmer sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Jan 18 14:59:45 wohnzimmer volumio[969]: info: Completed loading Core Plugins Jan 18 14:59:45 wohnzimmer volumio[969]: info: Preparing to generate the ALSA configuration file Jan 18 14:59:45 wohnzimmer sudo[1194]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:45 wohnzimmer volumio[969]: info: Discovery: adding 86ef962c-6315-407f-a8f4-3cc54f83ed48 Jan 18 14:59:45 wohnzimmer volumio[969]: info: Discovery: Found device Wohnzimmer Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:45 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:45 wohnzimmer volumio[969]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 18 14:59:45 wohnzimmer volumio[969]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 18 14:59:45 wohnzimmer volumio[969]: info: Reading ALSA contributions from plugins. Jan 18 14:59:45 wohnzimmer volumio[969]: info: Upmpdcli Daemon Started Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 14:59:45 wohnzimmer volumio[969]: info: Asound.conf file unchanged, so no further update is needed Jan 18 14:59:45 wohnzimmer volumio[969]: info: Output device has changed, restarting MPD Jan 18 14:59:45 wohnzimmer sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 14:59:45 wohnzimmer sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer sudo[1210]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:45 wohnzimmer volumio[969]: info: ___________ START PLUGINS ___________ Jan 18 14:59:45 wohnzimmer volumio[969]: info: ControllerMpd::onStart: Initializing MPD Jan 18 14:59:45 wohnzimmer volumio[969]: info: Creating MPD Configuration file Jan 18 14:59:45 wohnzimmer sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 14:59:45 wohnzimmer sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer volumio[1196]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 18 14:59:45 wohnzimmer systemd[1]: Stopping Music Player Daemon... Jan 18 14:59:45 wohnzimmer sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 14:59:45 wohnzimmer sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 14:59:45 wohnzimmer volumio[969]: info: [1737208785385] CoreMusicLibrary::Adding element Last_100 Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:45 wohnzimmer sudo[1217]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 14:59:45 wohnzimmer volumio[969]: info: [1737208785395] CoreMusicLibrary::Adding element Webradio Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 14:59:45 wohnzimmer sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 14:59:45 wohnzimmer sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer volumio[969]: info: Initializing BBC Radios Jan 18 14:59:45 wohnzimmer systemd[1]: mpd.service: Succeeded. Jan 18 14:59:45 wohnzimmer systemd[1]: Stopped Music Player Daemon. Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 14:59:45 wohnzimmer systemd[1]: Starting Music Player Daemon... Jan 18 14:59:45 wohnzimmer volumio[969]: info: Creating Spotify config file Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:45 wohnzimmer sudo[1228]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 14:59:45 wohnzimmer sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:45 wohnzimmer sudo[1228]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 14:59:45 wohnzimmer volumio[969]: info: [1737208785727] CoreMusicLibrary::Adding element YouTube2 Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:45 wohnzimmer volumio[969]: Cannot find translation for source YouTube2 Jan 18 14:59:45 wohnzimmer volumio[969]: info: Loading i18n strings for locale de Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 18 14:59:45 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:45 wohnzimmer volumio[969]: info: FusionDsp - mixtype--------------------- Software Jan 18 14:59:45 wohnzimmer volumio[969]: info: Volumio Calling Home Jan 18 14:59:45 wohnzimmer volumio[969]: info: Preparing to generate the ALSA configuration file Jan 18 14:59:46 wohnzimmer volumio[969]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jan 18 14:59:46 wohnzimmer volumio[969]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 18 14:59:46 wohnzimmer volumio[969]: info: Reading ALSA contributions from plugins. Jan 18 14:59:46 wohnzimmer volumio[969]: info: MPD Permissions set Jan 18 14:59:46 wohnzimmer volumio[969]: info: Volumio called home Jan 18 14:59:46 wohnzimmer volumio[969]: info: Spotify config file written Jan 18 14:59:46 wohnzimmer sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jan 18 14:59:46 wohnzimmer sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:46 wohnzimmer volumio[969]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 18 14:59:46 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:46 wohnzimmer systemd[1]: Started go-librespot Daemon. Jan 18 14:59:46 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:46 wohnzimmer go-librespot[1255]: Librespot-go daemon starting... Jan 18 14:59:46 wohnzimmer sudo[1253]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: No need to fix Spotify hosts Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer mpd[1248]: Jan 18 14:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:47 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:47 wohnzimmer systemd[1]: Started Music Player Daemon. Jan 18 14:59:47 wohnzimmer sudo[1214]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:47 wohnzimmer sudo[1219]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:47 wohnzimmer volumio[969]: info: Asound.conf file unchanged, so no further update is needed Jan 18 14:59:47 wohnzimmer volumio[969]: info: Output device has changed, restarting MPD Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01:00" level=info msg="generated new device id: 98c2f8a8332497621c8d319eacd635f0f6f5121b" Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01:00" level=debug msg="stored credentials found for stümper" Jan 18 14:59:47 wohnzimmer sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 14:59:47 wohnzimmer sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:47 wohnzimmer sudo[1273]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:47 wohnzimmer volumio[969]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jan 18 14:59:47 wohnzimmer volumio[969]: SPOTIFY: BQBIOn2Mzu6OoePhkLnZg5uMozOWgyJfQLTQ78mbVzcub4po2A94e6fpbaoGMPdA9pqBqfGijiaBIwlVyq1TZbM-tk_5jobjzBaZR8w1KqaMkiu0OsZi2S1uqHs_3o9dhaX0yVc9v8xhKjYJGwgkwy9sIJ-wm3EmQgM6qRYgpVCldAW6bDneTUuM9xhFnf7naCg36WG2uXkPOGzpO25zErYLAdl_sOnEWZutOeIGRT9fYckM-vAA8zqT Jan 18 14:59:47 wohnzimmer volumio[969]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jan 18 14:59:47 wohnzimmer volumio[969]: info: New Spotify access token = BQBIOn2Mzu6OoePhkLnZg5uMozOWgyJfQLTQ78mbVzcub4po2A94e6fpbaoGMPdA9pqBqfGijiaBIwlVyq1TZbM-tk_5jobjzBaZR8w1KqaMkiu0OsZi2S1uqHs_3o9dhaX0yVc9v8xhKjYJGwgkwy9sIJ-wm3EmQgM6qRYgpVCldAW6bDneTUuM9xhFnf7naCg36WG2uXkPOGzpO25zErYLAdl_sOnEWZutOeIGRT9fYckM-vAA8zqT Jan 18 14:59:47 wohnzimmer volumio[969]: info: Spotify credentials grant success - running version from March 24, 2019 Jan 18 14:59:47 wohnzimmer sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 14:59:47 wohnzimmer sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:47 wohnzimmer systemd[1]: Stopping Music Player Daemon... Jan 18 14:59:47 wohnzimmer volumio[969]: error: Upnp client error: Error: This socket has been ended by the other party Jan 18 14:59:47 wohnzimmer volumio[969]: info: MPD Permissions set Jan 18 14:59:47 wohnzimmer systemd[1]: mpd.service: Succeeded. Jan 18 14:59:47 wohnzimmer systemd[1]: Stopped Music Player Daemon. Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer systemd[1]: Starting Music Player Daemon... Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:47 wohnzimmer volumio[969]: error: Cannot initialize MPD Connection: MPD is not running Jan 18 14:59:47 wohnzimmer sudo[1279]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 14:59:47 wohnzimmer sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:47 wohnzimmer sudo[1279]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01: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]" Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01: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]" Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01: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]" Jan 18 14:59:47 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:47+01:00" level=debug msg="zeroconf server listening on port 36855" Jan 18 14:59:47 wohnzimmer volumio[969]: info: camilladsp spawned new process with pid 1295, instance 1, run: true Jan 18 14:59:47 wohnzimmer volumio[969]: info: camilladsp service started and running in background, instance 1 Jan 18 14:59:47 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=debug msg="obtained new client token: AAABz5fHehDLHr7p55dOXrpvOmF040wQpfzbrosMZ9YsVO8W6eS1HZ7xSLnAy75IycK5baazdB+fExOPd6O/Q6YMHyb8QGdzsEYqlh2pHsUfalEDm2haJQw9y3a+vWpqObTs4OAOyGiXyn7nxThK5X6AsKdWvdWMRKODvHeMC2zKKWi3rEYn7ttdmObb2An/rm1nkx4Wby/w/4pxQ7J/iz5Frf6HfjgPF3k+7KpTptPzKPHd7WTQg2V2EbEY" Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp loaded Jan 18 14:59:48 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 14:59:48 wohnzimmer sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 18 14:59:48 wohnzimmer sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=info msg="connected to ap-gew4.spotify.com:4070" Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 18 14:59:48 wohnzimmer volumio[969]: info: Adding Signal Path Element [object Object] Jan 18 14:59:48 wohnzimmer volumio[969]: info: Adding fusiondspeq DSP Signal Path Element Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - ---- installed callbackRead Jan 18 14:59:48 wohnzimmer volumio[969]: SPOTIFY: User informations: {"country":"DE","display_name":"stümper","email":"ralfstuemper@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/stümper"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/stümper","id":"stümper","images":[],"product":"premium","type":"user","uri":"spotify:user:st%C3%BCmper"} Jan 18 14:59:48 wohnzimmer volumio[969]: info: Spotify Successfully logged in Jan 18 14:59:48 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 14:59:48 wohnzimmer volumio[969]: info: [1737208788170] CoreMusicLibrary::Adding element Spotify Jan 18 14:59:48 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 14:59:48 wohnzimmer volumio[969]: Cannot find translation for source YouTube2 Jan 18 14:59:48 wohnzimmer volumio[969]: Cannot find translation for source Spotify Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=debug msg="completed keyexchange" Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - Effects disabled Jan 18 14:59:48 wohnzimmer systemd[1]: Started FusionDsp Daemon. Jan 18 14:59:48 wohnzimmer sudo[1299]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:48 wohnzimmer volumio[969]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jan 18 14:59:48 wohnzimmer volumio[969]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=debug msg="completed challenge" Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=debug msg="authenticated as stümper" Jan 18 14:59:48 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:48+01:00" level=debug msg="authenticated as stümper" Jan 18 14:59:48 wohnzimmer volumio[969]: info: [yt-cast-receiver] DIAL server listening on port 8098 Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="dealer connection opened" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="initializing zeroconf session, username: stümper" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="autoplay enabled: false" Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="received connection id: YTQ1MmFhNDYtNDQwMC00MDIxLWFlZDMtMmQ4YWE2NjE2NjYyK2RlYWxlcit0Y3A6Ly8wYWNhNTgxZS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArOUVERjU5QjJGMjdENEJFNjEyQ0UxQUFGOUY2QkVDQ0U1RTA2QTI3NkMxNzBDOUM5NDdCN0ZFMjBDNDkwOEZDQg==" Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:49 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreStateMachine::pushState Jan 18 14:59:49 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioPushState Jan 18 14:59:49 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:49+01:00" level=debug msg="put connect state because NEW_DEVICE" Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 14:59:49 wohnzimmer volumio[969]: info: Discovery: Getting this device information Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:49 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:49 wohnzimmer volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 14:59:49 wohnzimmer mpd[1289]: Jan 18 14:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 14:59:49 wohnzimmer systemd[1]: Started Music Player Daemon. Jan 18 14:59:49 wohnzimmer sudo[1275]: pam_unix(sudo:session): session closed for user root Jan 18 14:59:49 wohnzimmer volumio[969]: error: MPD error: The expression evaluated to a falsy value: Jan 18 14:59:49 wohnzimmer volumio[969]: assert.ok(self.idling) Jan 18 14:59:49 wohnzimmer volumio[969]: error: The expression evaluated to a falsy value: Jan 18 14:59:49 wohnzimmer volumio[969]: assert.ok(self.idling) Jan 18 14:59:49 wohnzimmer volumio[969]: error: updateQueue error: null Jan 18 14:59:49 wohnzimmer volumio[969]: error: Upnp client error: Error: This socket has been ended by the other party Jan 18 14:59:49 wohnzimmer volumio[969]: error: updateQueue error: null Jan 18 14:59:50 wohnzimmer volumio[969]: info: Completed starting Core Plugins Jan 18 14:59:50 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:50 wohnzimmer volumio[969]: info: ----- MyVolumio plugins startup ---- Jan 18 14:59:50 wohnzimmer volumio[969]: info: ------------------------------------------- Jan 18 14:59:50 wohnzimmer volumio[969]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 18 14:59:50 wohnzimmer volumio[969]: info: go-librespot daemon successfully initialized Jan 18 14:59:50 wohnzimmer volumio[1196]: ....................................++++ Jan 18 14:59:53 wohnzimmer systemd[1]: systemd-timedated.service: Succeeded. Jan 18 14:59:53 wohnzimmer volumio[969]: info: Initializing connection to go-librespot Websocket Jan 18 14:59:53 wohnzimmer volumio[969]: info: Connection to go-librespot Websocket established Jan 18 14:59:53 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:53+01:00" level=debug msg="new websocket client" Jan 18 14:59:54 wohnzimmer volumio[969]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="handling transfer player command from 44bb90a134afb721191a64c28939d21f9ad469f4" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="resolved context of track" uri="spotify:user:st%C3%BCmper:collection" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=trace msg="fetched new page 0 with 31 items (list: 31)" uri="spotify:user:st%C3%BCmper:collection" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="loading track (paused: true, position: 14679ms)" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=trace msg="emitting websocket event: will_play" Jan 18 14:59:55 wohnzimmer volumio[969]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1ZsvO30l2rnBUACBJIQWCA","play_origin":"com.spotify.service.yourlibrarymusic.ui"}} Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="selected format OGG_VORBIS_320 (9549d0cd06415057f3fbc3e105e039c91b8e9c7b)" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="requested aes key for file 9549d0cd06415057f3fbc3e105e039c91b8e9c7b, gid: 1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1339" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="fetched first chunk of 26, total size is 13354732 bytes" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:55 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:55+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1117" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="fetched chunk 2/25, size: 524288" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="fetched chunk 1/25, size: 524288" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=trace msg="seek to 14679ms (diff: 134ms, samples: 647343, bytes: 535097)" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="created new output device" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=info msg="loaded track \"Red Stones\" (paused: true, position: 14679ms, duration: 348443ms, prefetched: false)" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 14:59:56 wohnzimmer volumio[969]: info: camilladsp stopping service pid 1295... Jan 18 14:59:56 wohnzimmer volumio[969]: info: camilladsp service terminated, instance 1 Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - Effects disabled Jan 18 14:59:56 wohnzimmer volumio[969]: info: camilladsp service started and running in background, instance 1 Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 14:59:56 wohnzimmer volumio[969]: info: FusionDsp - Effects disabled Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="fetched chunk 4/25, size: 524288" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=trace msg="emitting websocket event: metadata" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=trace msg="emitting websocket event: active" Jan 18 14:59:56 wohnzimmer volumio[969]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1ZsvO30l2rnBUACBJIQWCA","name":"Red Stones","artist_names":["Natalia Sarsgård"],"album_name":"Red Stones","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02469f82ffbbf4c7b24db5958b","position":14679,"duration":348443,"release_date":"year:2020 month:5 day:6","track_number":1,"disc_number":1}} Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="sending successful reply for dealer request" Jan 18 14:59:56 wohnzimmer volumio[969]: SPOTIFY: received: {"type":"active","data":null} Jan 18 14:59:56 wohnzimmer volumio[969]: info: Aligning Spotify Volume to Volumio Volume Jan 18 14:59:56 wohnzimmer volumio[969]: info: CoreCommandRouter::volumioGetState Jan 18 14:59:56 wohnzimmer volumio[969]: info: CorePlayQueue::getTrack 0 Jan 18 14:59:56 wohnzimmer volumio[969]: info: Setting Spotify Volume from Volumio: 74 Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="fetched chunk 3/25, size: 524288" uri="spotify:track:1ZsvO30l2rnBUACBJIQWCA" Jan 18 14:59:56 wohnzimmer volumio[969]: error: FusionDsp - WebSocket error: [object Object] Jan 18 14:59:56 wohnzimmer volumio[969]: info: camilladsp spawned new process with pid 1340, instance 1, run: true Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jan 18 14:59:56 wohnzimmer go-librespot[1255]: time="2025-01-18T14:59:56+01:00" level=trace msg="emitting websocket event: paused" Jan 18 14:59:56 wohnzimmer volumio[969]: info: Getting Spotify volume Jan 18 14:59:56 wohnzimmer volumio[969]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:1ZsvO30l2rnBUACBJIQWCA","play_origin":"com.spotify.service.yourlibrarymusic.ui"}} Jan 18 14:59:56 wohnzimmer volumio[969]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 14:59:56 wohnzimmer volumio[969]: TypeError: Cannot read property 'service' of undefined Jan 18 14:59:56 wohnzimmer volumio[969]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:337:50) Jan 18 14:59:56 wohnzimmer volumio[969]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:271:18) Jan 18 14:59:56 wohnzimmer volumio[969]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Jan 18 14:59:56 wohnzimmer volumio[969]: at WebSocket.emit (events.js:315:20) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver.emit (events.js:315:20) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jan 18 14:59:56 wohnzimmer volumio[969]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jan 18 14:59:56 wohnzimmer volumio[969]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 14:59:57 wohnzimmer sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 14:58 Jan 18 14:59:57 wohnzimmer sudo[1356]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"