-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-11-26 21:42:55 CET. -- Nov 26 21:41:42 wohnzimmer kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg Nov 26 21:41:42 wohnzimmer kernel: Indeed it is in host mode hprt0 = 00001101 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 26 21:41:42 wohnzimmer kernel: hub 1-1:1.0: USB hub found Nov 26 21:41:42 wohnzimmer kernel: hub 1-1:1.0: 5 ports detected Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Nov 26 21:41:42 wohnzimmer kernel: smsc95xx v2.0.0 Nov 26 21:41:42 wohnzimmer kernel: fuse: init (API version 7.39) Nov 26 21:41:42 wohnzimmer kernel: SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=199) Nov 26 21:41:42 wohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:85:e4:83 Nov 26 21:41:42 wohnzimmer kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 26 21:41:42 wohnzimmer kernel: usbcore: registered new interface driver uas Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.3: new high-speed USB device number 4 using dwc_otg Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.3: New USB device found, idVendor=0644, idProduct=8043, bcdDevice= 1.00 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.3: Product: TEAC UD-501 Nov 26 21:41:42 wohnzimmer kernel: usb 1-1.3: Manufacturer: TEAC Corporation Nov 26 21:41:42 wohnzimmer kernel: hid-generic 0003:0644:8043.0001: hiddev96,hidraw0: USB HID v1.10 Device [TEAC Corporation TEAC UD-501] on usb-3f980000.usb-1.3/input2 Nov 26 21:41:42 wohnzimmer kernel: EXT4-fs (mmcblk0p2): recovery complete Nov 26 21:41:42 wohnzimmer kernel: EXT4-fs (mmcblk0p2): mounted filesystem aad048ad-7eb3-4549-8020-f5742baed86d r/w with ordered data mode. Quota mode: none. Nov 26 21:41:42 wohnzimmer kernel: loop0: detected capacity change from 0 to 994880 Nov 26 21:41:42 wohnzimmer kernel: EXT4-fs (mmcblk0p3): recovery complete Nov 26 21:41:42 wohnzimmer kernel: EXT4-fs (mmcblk0p3): mounted filesystem cfbe554b-d5ac-4dfd-b89b-effce104ffff r/w with ordered data mode. Quota mode: none. Nov 26 21:41:42 wohnzimmer systemd[1]: System time before build time, advancing clock. Nov 26 21:41:42 wohnzimmer kernel: NET: Registered PF_INET6 protocol family Nov 26 21:41:42 wohnzimmer kernel: Segment Routing with IPv6 Nov 26 21:41:42 wohnzimmer kernel: In-situ OAM (IOAM) with IPv6 Nov 26 21:41:42 wohnzimmer systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Nov 26 21:41:42 wohnzimmer systemd[1]: Detected architecture arm. Nov 26 21:41:42 wohnzimmer systemd[1]: Set hostname to . Nov 26 21:41:42 wohnzimmer systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 26 21:41:42 wohnzimmer systemd[1]: Listening on Journal Socket (/dev/log). Nov 26 21:41:42 wohnzimmer systemd[1]: Listening on udev Kernel Socket. Nov 26 21:41:42 wohnzimmer systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 26 21:41:42 wohnzimmer systemd[1]: Listening on initctl Compatibility Named Pipe. Nov 26 21:41:42 wohnzimmer systemd[1]: Listening on RPCbind Server Activation Socket. Nov 26 21:41:42 wohnzimmer systemd[1]: Listening on fsck to fsckd communication Socket. Nov 26 21:41:42 wohnzimmer kernel: i2c_dev: i2c /dev entries driver Nov 26 21:41:42 wohnzimmer systemd-journald[311]: Journal started Nov 26 21:41:42 wohnzimmer systemd-journald[311]: Runtime journal (/run/log/journal/b09207998001defae5f73bf26405b501) is 7.5M, max 30.0M, 22.5M free. Nov 26 21:41:42 wohnzimmer systemd-modules-load[305]: Inserted module 'i2c_dev' Nov 26 21:41:42 wohnzimmer fake-hwclock[312]: Tue Nov 26 20:41:42 UTC 2024 Nov 26 21:41:42 wohnzimmer systemd[1]: Started Restore / save the current clock. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Load/Save Random Seed. Nov 26 21:41:42 wohnzimmer systemd[1]: dynamicswap.service: Succeeded. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Create System Users. Nov 26 21:41:42 wohnzimmer systemd[1]: Starting Create Static Device Nodes in /dev... Nov 26 21:41:42 wohnzimmer systemd[1]: Started Create Static Device Nodes in /dev. Nov 26 21:41:42 wohnzimmer systemd[1]: Reached target Local File Systems (Pre). Nov 26 21:41:42 wohnzimmer systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounting /var/log... Nov 26 21:41:42 wohnzimmer systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounting /tmp... Nov 26 21:41:42 wohnzimmer systemd[1]: Mounting /var/spool/cups... Nov 26 21:41:42 wohnzimmer systemd[1]: Starting udev Kernel Device Manager... Nov 26 21:41:42 wohnzimmer systemd[1]: Started udev Coldplug all Devices. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounted /var/log. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounted /tmp. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounted /var/spool/cups. Nov 26 21:41:42 wohnzimmer systemd[1]: Mounting /var/spool/cups/tmp... Nov 26 21:41:42 wohnzimmer systemd[1]: Starting Flush Journal to Persistent Storage... Nov 26 21:41:42 wohnzimmer systemd[1]: Starting Helper to synchronize boot up for ifupdown... Nov 26 21:41:42 wohnzimmer systemd[1]: Mounted /var/spool/cups/tmp. Nov 26 21:41:42 wohnzimmer systemd-udevd[338]: Network interface NamePolicy= disabled on kernel command line, ignoring. Nov 26 21:41:42 wohnzimmer systemd-journald[311]: Runtime journal (/run/log/journal/b09207998001defae5f73bf26405b501) is 7.5M, max 30.0M, 22.5M free. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Flush Journal to Persistent Storage. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Helper to synchronize boot up for ifupdown. Nov 26 21:41:42 wohnzimmer systemd[1]: Started udev Kernel Device Manager. Nov 26 21:41:42 wohnzimmer systemd[1]: Starting Show Plymouth Boot Screen... Nov 26 21:41:42 wohnzimmer systemd[1]: plymouth-start.service: Succeeded. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Show Plymouth Boot Screen. Nov 26 21:41:42 wohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 26 21:41:42 wohnzimmer systemd[1]: Reached target Local Encrypted Volumes. Nov 26 21:41:42 wohnzimmer systemd[1]: Reached target Paths. Nov 26 21:41:42 wohnzimmer systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 26 21:41:43 wohnzimmer kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:43 wohnzimmer kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Nov 26 21:41:43 wohnzimmer kernel: [vc_sm_connected_init]: start Nov 26 21:41:43 wohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Nov 26 21:41:43 wohnzimmer kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Nov 26 21:41:43 wohnzimmer kernel: [vc_sm_connected_init]: installed successfully Nov 26 21:41:43 wohnzimmer kernel: mc: Linux media interface: v0.10 Nov 26 21:41:43 wohnzimmer kernel: videodev: Linux video capture interface: v2.00 Nov 26 21:41:43 wohnzimmer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:43 wohnzimmer kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:43 wohnzimmer kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:43 wohnzimmer systemd[1]: Found device /dev/disk/by-uuid/5883-B9C7. Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Nov 26 21:41:43 wohnzimmer kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: Core ver 2.22 Nov 26 21:41:43 wohnzimmer kernel: NET: Registered PF_BLUETOOTH protocol family Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI device and connection manager initialized Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI socket layer initialized Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: L2CAP socket layer initialized Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: SCO socket layer initialized Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI UART driver ver 2.3 Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI UART protocol H4 registered Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Nov 26 21:41:43 wohnzimmer kernel: Bluetooth: HCI UART protocol Broadcom registered Nov 26 21:41:43 wohnzimmer kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Nov 26 21:41:43 wohnzimmer kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Nov 26 21:41:43 wohnzimmer kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Nov 26 21:41:43 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Nov 26 21:41:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Nov 26 21:41:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Nov 26 21:41:44 wohnzimmer kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Nov 26 21:41:44 wohnzimmer kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Nov 26 21:41:44 wohnzimmer kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Nov 26 21:41:44 wohnzimmer kernel: uart-pl011 3f201000.serial: no DMA platform data Nov 26 21:41:44 wohnzimmer kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Nov 26 21:41:44 wohnzimmer kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Nov 26 21:41:44 wohnzimmer systemd-udevd[344]: Using default interface naming scheme 'v240'. Nov 26 21:41:44 wohnzimmer systemd[1]: Starting File System Check on /dev/disk/by-uuid/5883-B9C7... Nov 26 21:41:44 wohnzimmer systemd-udevd[344]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 26 21:41:44 wohnzimmer kernel: Bluetooth: hci0: BCM: chip id 94 Nov 26 21:41:44 wohnzimmer kernel: Bluetooth: hci0: BCM: features 0x2e Nov 26 21:41:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 Nov 26 21:41:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Nov 26 21:41:44 wohnzimmer kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Nov 26 21:41:44 wohnzimmer kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Nov 26 21:41:44 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Nov 26 21:41:44 wohnzimmer systemd[1]: Started File System Check Daemon to report status. Nov 26 21:41:44 wohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Nov 26 21:41:44 wohnzimmer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Nov 26 21:41:44 wohnzimmer systemd-fsck[400]: fsck.fat 4.1 (2017-01-24) Nov 26 21:41:44 wohnzimmer systemd-fsck[400]: /dev/mmcblk0p1: 408 files, 41695/46774 clusters Nov 26 21:41:44 wohnzimmer systemd[1]: Started File System Check on /dev/disk/by-uuid/5883-B9C7. Nov 26 21:41:44 wohnzimmer systemd[1]: Mounting /boot... Nov 26 21:41:44 wohnzimmer systemd[1]: Mounted /boot. Nov 26 21:41:44 wohnzimmer systemd[1]: Reached target Local File Systems. Nov 26 21:41:44 wohnzimmer systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 26 21:41:44 wohnzimmer kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Nov 26 21:41:44 wohnzimmer systemd[1]: Starting Raise network interfaces... Nov 26 21:41:44 wohnzimmer kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Nov 26 21:41:44 wohnzimmer kernel: usbcore: registered new interface driver brcmfmac Nov 26 21:41:44 wohnzimmer systemd[1]: Starting Create Volatile Files and Directories... Nov 26 21:41:44 wohnzimmer systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 26 21:41:44 wohnzimmer systemd[1]: Starting Preprocess NFS configuration... Nov 26 21:41:44 wohnzimmer systemd[1]: Received SIGRTMIN+20 from PID 197 (plymouthd). Nov 26 21:41:44 wohnzimmer systemd[1]: plymouth-read-write.service: Succeeded. Nov 26 21:41:44 wohnzimmer systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 26 21:41:44 wohnzimmer systemd[1]: nfs-config.service: Succeeded. Nov 26 21:41:44 wohnzimmer systemd[1]: Started Preprocess NFS configuration. Nov 26 21:41:44 wohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Nov 26 21:41:44 wohnzimmer systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Nov 26 21:41:44 wohnzimmer systemd[1]: Reached target NFS client services. Nov 26 21:41:45 wohnzimmer systemd[1]: Started Create Volatile Files and Directories. Nov 26 21:41:45 wohnzimmer ifup[455]: command failed: No such device (-19) Nov 26 21:41:45 wohnzimmer systemd[1]: Starting RPC bind portmap service... Nov 26 21:41:45 wohnzimmer systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 26 21:41:45 wohnzimmer kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Nov 26 21:41:45 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 Nov 26 21:41:45 wohnzimmer systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Nov 26 21:41:45 wohnzimmer kernel: Bluetooth: hci0: BCM: features 0x2e Nov 26 21:41:45 wohnzimmer kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Nov 26 21:41:45 wohnzimmer kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Nov 26 21:41:45 wohnzimmer systemd-udevd[346]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 26 21:41:45 wohnzimmer kernel: usb 1-1.3: clock source 41 is not valid, cannot use Nov 26 21:41:45 wohnzimmer systemd[1]: Started RPC bind portmap service. Nov 26 21:41:45 wohnzimmer systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 26 21:41:46 wohnzimmer systemd-udevd[354]: Using default interface naming scheme 'v240'. Nov 26 21:41:46 wohnzimmer systemd-udevd[354]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 26 21:41:46 wohnzimmer kernel: hwmon hwmon1: Undervoltage detected! Nov 26 21:41:46 wohnzimmer kernel: usbcore: registered new interface driver snd-usb-audio Nov 26 21:41:46 wohnzimmer kernel: alsactl[547]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Nov 26 21:41:46 wohnzimmer systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Nov 26 21:41:46 wohnzimmer systemd[1]: Started Raise network interfaces. Nov 26 21:41:47 wohnzimmer systemd[1]: Created slice system-bthelper.slice. Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Show Plymouth Boot Screen... Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Huge Pages File System being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Nov 26 21:41:47 wohnzimmer systemd[1]: Started ifup for eth0. Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target RPC Port Mapper. Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target Remote File Systems (Pre). Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target Remote File Systems. Nov 26 21:41:47 wohnzimmer systemd[1]: plymouth-read-write.service: Succeeded. Nov 26 21:41:47 wohnzimmer systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 26 21:41:47 wohnzimmer systemd[1]: Received SIGRTMIN+20 from PID 197 (plymouthd). Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Load/Save RF Kill Switch Status... Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target System Initialization. Nov 26 21:41:47 wohnzimmer systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 26 21:41:47 wohnzimmer systemd[1]: Started Daily apt download activities. Nov 26 21:41:47 wohnzimmer systemd[1]: Listening on triggerhappy.socket. Nov 26 21:41:47 wohnzimmer systemd[1]: Started Daily apt upgrade and clean activities. Nov 26 21:41:47 wohnzimmer systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target Sockets. Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target Basic System. Nov 26 21:41:47 wohnzimmer systemd[1]: Started MPD Monitor Service. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Volumio Time Update Utility... Nov 26 21:41:47 wohnzimmer systemd[1]: Started Volumio Iptables Module. Nov 26 21:41:47 wohnzimmer systemd[1]: Started Manage Sound Card State (restore and store). Nov 26 21:41:47 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Fetching time from Volumio... Nov 26 21:41:47 wohnzimmer alsactl[586]: alsactl 1.1.8 daemon started Nov 26 21:41:47 wohnzimmer systemd-udevd[344]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Nov 26 21:41:47 wohnzimmer systemd[1]: Started volumio-remote-updater.service. Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Save/Restore Sound Card State... Nov 26 21:41:47 wohnzimmer systemd[1]: Started Volumio Log Rotation Service. Nov 26 21:41:47 wohnzimmer systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Login Service... Nov 26 21:41:47 wohnzimmer systemd[1]: Starting triggerhappy global hotkey daemon... Nov 26 21:41:47 wohnzimmer systemd[1]: Started D-Bus System Message Bus. Nov 26 21:41:47 wohnzimmer systemd[1]: Starting WPA supplicant... Nov 26 21:41:47 wohnzimmer systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Wireless Services... Nov 26 21:41:47 wohnzimmer systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 26 21:41:47 wohnzimmer systemd[1]: Reached target Timers. Nov 26 21:41:47 wohnzimmer haveged[487]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Nov 26 21:41:47 wohnzimmer haveged[487]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Nov 26 21:41:47 wohnzimmer haveged[487]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99568 Nov 26 21:41:47 wohnzimmer haveged[487]: haveged: fills: 0, generated: 0 Nov 26 21:41:47 wohnzimmer systemd[1]: Starting Configure Bluetooth Modems connected by UART... Nov 26 21:41:47 wohnzimmer systemd[1]: Started Load/Save RF Kill Switch Status. Nov 26 21:41:47 wohnzimmer systemd[1]: plymouth-start.service: Succeeded. Nov 26 21:41:47 wohnzimmer systemd[1]: Started Show Plymouth Boot Screen. Nov 26 21:41:48 wohnzimmer thd[608]: Unable to parse trigger line: Nov 26 21:41:48 wohnzimmer thd[608]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Nov 26 21:41:48 wohnzimmer thd[608]: Unable to parse trigger line: Nov 26 21:41:48 wohnzimmer thd[608]: Found socket passed from systemd Nov 26 21:41:48 wohnzimmer systemd-logind[607]: New seat seat0. Nov 26 21:41:48 wohnzimmer mpd_monitor.sh[579]: MPD error: Connection refused Nov 26 21:41:48 wohnzimmer avahi-daemon[600]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Nov 26 21:41:48 wohnzimmer avahi-daemon[600]: Successfully dropped root privileges. Nov 26 21:41:48 wohnzimmer avahi-daemon[600]: avahi-daemon 0.7 starting up. Nov 26 21:41:48 wohnzimmer kernel: hwmon hwmon1: Voltage normalised Nov 26 21:41:48 wohnzimmer mpd_monitor.sh[579]: mpd: no process found Nov 26 21:41:48 wohnzimmer kernel: 8021q: 802.1Q VLAN Support v1.8 Nov 26 21:41:48 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Date not found in response Nov 26 21:41:48 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Retrying in 5 seconds... Nov 26 21:41:48 wohnzimmer volumio-remote-updater[591]: Error: No active session Nov 26 21:41:48 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:48] [info] asio async_connect error: system:111 (Connection refused) Nov 26 21:41:48 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 21:41:48 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:48] [error] handle_connect error: Underlying Transport Error Nov 26 21:41:48 wohnzimmer systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Nov 26 21:41:48 wohnzimmer systemd[1]: Started triggerhappy global hotkey daemon. Nov 26 21:41:48 wohnzimmer systemd[1]: Started Save/Restore Sound Card State. Nov 26 21:41:48 wohnzimmer systemd[1]: hciuart.service: Succeeded. Nov 26 21:41:48 wohnzimmer systemd[1]: Started Configure Bluetooth Modems connected by UART. Nov 26 21:41:49 wohnzimmer systemd[1]: Listening on mpd.socket. Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Raspberry Pi bluetooth helper... Nov 26 21:41:49 wohnzimmer systemd[1]: Reached target Sound Card. Nov 26 21:41:49 wohnzimmer systemd[1]: Started ifup for wlan0. Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Successfully called chroot(). Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Successfully dropped remaining capabilities. Nov 26 21:41:49 wohnzimmer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 26 21:41:49 wohnzimmer systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Loading service file /services/volumio.service. Nov 26 21:41:49 wohnzimmer wpa_supplicant[611]: Successfully initialized wpa_supplicant Nov 26 21:41:49 wohnzimmer systemd[1]: Starting dhcpcd on all interfaces... Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Network interface enumeration completed. Nov 26 21:41:49 wohnzimmer volumio[599]: Could not open config: /tmp/upmpdcli.conf Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Server startup complete. Host name is wohnzimmer.local. Local service cookie is 3991936776. Nov 26 21:41:49 wohnzimmer avahi-daemon[600]: Service "Wohnzimmer" (/services/volumio.service) successfully established. Nov 26 21:41:49 wohnzimmer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Nov 26 21:41:49 wohnzimmer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Nov 26 21:41:49 wohnzimmer dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 26 21:41:49 wohnzimmer dhcpcd[676]: Not running dhcpcd because /etc/network/interfaces Nov 26 21:41:49 wohnzimmer dhcpcd[676]: defines some interfaces that will use a Nov 26 21:41:49 wohnzimmer dhcpcd[676]: DHCP client or static address Nov 26 21:41:49 wohnzimmer systemd[1]: Started Login Service. Nov 26 21:41:49 wohnzimmer systemd[1]: Started WPA supplicant. Nov 26 21:41:49 wohnzimmer systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 26 21:41:49 wohnzimmer systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Nov 26 21:41:49 wohnzimmer systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Nov 26 21:41:49 wohnzimmer systemd[1]: Failed to start dhcpcd on all interfaces. Nov 26 21:41:49 wohnzimmer systemd[1]: iptables.service: Succeeded. Nov 26 21:41:49 wohnzimmer systemd[1]: Reached target Network. Nov 26 21:41:49 wohnzimmer kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Nov 26 21:41:49 wohnzimmer bthelper[666]: Raspberry Pi BDADDR already set Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Music Player Daemon... Nov 26 21:41:49 wohnzimmer sh[571]: eth0: waiting for carrier Nov 26 21:41:49 wohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Nov 26 21:41:49 wohnzimmer kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Nov 26 21:41:49 wohnzimmer dhcpcd[606]: eth0: waiting for carrier Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Network Time Service... Nov 26 21:41:49 wohnzimmer systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Nov 26 21:41:49 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Permit User Sessions... Nov 26 21:41:49 wohnzimmer systemd[1]: Reached target Network is Online. Nov 26 21:41:49 wohnzimmer systemd[1]: Starting /etc/rc.local Compatibility... Nov 26 21:41:49 wohnzimmer systemd[1]: Starting LSB: Brings up/down network automatically... Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Samba NMB Daemon... Nov 26 21:41:49 wohnzimmer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 26 21:41:49 wohnzimmer systemd[1]: Started Raspberry Pi bluetooth helper. Nov 26 21:41:49 wohnzimmer systemd[1]: Started Permit User Sessions. Nov 26 21:41:49 wohnzimmer systemd[1]: Started /etc/rc.local Compatibility. Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Hold until boot process finishes up... Nov 26 21:41:49 wohnzimmer loadcpufreq[612]: Loading cpufreq kernel modules...done (none). Nov 26 21:41:49 wohnzimmer systemd[1]: Starting Bluetooth service... Nov 26 21:41:49 wohnzimmer systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 26 21:41:50 wohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 197 (plymouthd). Nov 26 21:41:50 wohnzimmer systemd[1]: plymouth-quit.service: Succeeded. Nov 26 21:41:50 wohnzimmer systemd[1]: Started Terminate Plymouth Boot Screen. Nov 26 21:41:50 wohnzimmer systemd[1]: plymouth-quit-wait.service: Succeeded. Nov 26 21:41:50 wohnzimmer systemd[1]: Started Hold until boot process finishes up. Nov 26 21:41:50 wohnzimmer systemd[1]: Received SIGRTMIN+21 from PID 197 (n/a). Nov 26 21:41:50 wohnzimmer ntpd[722]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 26 21:41:50 wohnzimmer systemd[1]: Started Getty on tty1. Nov 26 21:41:50 wohnzimmer ntpd[722]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Nov 26 21:41:50 wohnzimmer systemd[1]: Reached target Login Prompts. Nov 26 21:41:50 wohnzimmer ntpd[788]: proto: precision = 1.458 usec (-19) Nov 26 21:41:50 wohnzimmer ifplugd(eth0)[795]: ifplugd 0.28 initializing. Nov 26 21:41:50 wohnzimmer ifplugd(eth0)[795]: Using interface eth0/B8:27:EB:85:E4:83 with driver (version: 6.6.56-v7+) Nov 26 21:41:50 wohnzimmer systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 26 21:41:50 wohnzimmer ifplugd(eth0)[795]: Using detection mode: SIOCETHTOOL Nov 26 21:41:50 wohnzimmer ifplugd(eth0)[795]: Initialization complete, link beat not detected. Nov 26 21:41:50 wohnzimmer systemd[1]: Started Network Time Service. Nov 26 21:41:50 wohnzimmer ntpd[788]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 26 21:41:50 wohnzimmer ntpd[788]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 26 21:41:50 wohnzimmer ntpd[788]: Listen and drop on 0 v6wildcard [::]:123 Nov 26 21:41:50 wohnzimmer ntpd[788]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 26 21:41:50 wohnzimmer ntpd[788]: Listen normally on 2 lo 127.0.0.1:123 Nov 26 21:41:50 wohnzimmer ntpd[788]: Listening on routing socket on fd #19 for interface updates Nov 26 21:41:50 wohnzimmer ntpd[788]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 26 21:41:50 wohnzimmer ntpd[788]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 26 21:41:50 wohnzimmer sh[669]: wlan0=wlan0 Nov 26 21:41:50 wohnzimmer ifplugd[736]: Network Interface Plugging Daemon...start eth0...done. Nov 26 21:41:50 wohnzimmer systemd[1]: Started LSB: Brings up/down network automatically. Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Bluetooth daemon 5.50 Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Nov 26 21:41:50 wohnzimmer systemd[1]: Started Bluetooth service. Nov 26 21:41:50 wohnzimmer systemd[1]: Reached target Bluetooth. Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Starting SDP server Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Excluding (cli) sap Nov 26 21:41:50 wohnzimmer cpufrequtils[797]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Nov 26 21:41:50 wohnzimmer systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 26 21:41:50 wohnzimmer sudo[701]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 21:41:50 wohnzimmer sudo[701]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:50 wohnzimmer sudo[701]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 26 21:41:50 wohnzimmer sudo[701]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:50 wohnzimmer dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=780 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Bluetooth management interface 1.22 initialized Nov 26 21:41:50 wohnzimmer kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Nov 26 21:41:50 wohnzimmer kernel: Bluetooth: BNEP filters: protocol multicast Nov 26 21:41:50 wohnzimmer kernel: Bluetooth: BNEP socket layer initialized Nov 26 21:41:50 wohnzimmer kernel: Bluetooth: MGMT ver 1.22 Nov 26 21:41:50 wohnzimmer bluetoothd[780]: Failed to set privacy: Rejected (0x0b) Nov 26 21:41:51 wohnzimmer systemd[1]: Starting Hostname Service... Nov 26 21:41:51 wohnzimmer ntpd[788]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 26 21:41:51 wohnzimmer dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 26 21:41:51 wohnzimmer systemd[1]: Started Hostname Service. Nov 26 21:41:51 wohnzimmer nmbd[764]: [2024/11/26 21:41:51.943115, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Nov 26 21:41:51 wohnzimmer nmbd[764]: started asyncdns process 825 Nov 26 21:41:51 wohnzimmer nmbd[764]: [2024/11/26 21:41:51.945872, 0] ../lib/util/become_daemon.c:149(daemon_status) Nov 26 21:41:51 wohnzimmer nmbd[764]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Nov 26 21:41:51 wohnzimmer nmbd[764]: [2024/11/26 21:41:51.946103, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Nov 26 21:41:51 wohnzimmer nmbd[764]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Nov 26 21:41:52 wohnzimmer ntpd[788]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 26 21:41:52 wohnzimmer wireless.js[613]: Cleaning previous... Nov 26 21:41:52 wohnzimmer systemd[1]: systemd-rfkill.service: Succeeded. Nov 26 21:41:52 wohnzimmer sudo[833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 26 21:41:52 wohnzimmer sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:52 wohnzimmer sudo[833]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:52 wohnzimmer sudo[835]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 26 21:41:52 wohnzimmer sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:53 wohnzimmer sudo[835]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:53 wohnzimmer ntpd[788]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 26 21:41:53 wohnzimmer wireless.js[613]: Stopped aP Nov 26 21:41:53 wohnzimmer sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 21:41:53 wohnzimmer sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:53 wohnzimmer sudo[842]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:53 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 21:41:53 wohnzimmer sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Nov 26 21:41:53 wohnzimmer sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:53 wohnzimmer sudo[844]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:53 wohnzimmer sudo[851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 21:41:53 wohnzimmer sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:53 wohnzimmer sudo[851]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:53 wohnzimmer sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Nov 26 21:41:53 wohnzimmer sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:53 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Fetching time from Volumio... Nov 26 21:41:53 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Date not found in response Nov 26 21:41:53 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Retrying in 5 seconds... Nov 26 21:41:53 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:53] [info] asio async_connect error: system:111 (Connection refused) Nov 26 21:41:53 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 21:41:53 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:41:53] [error] handle_connect error: Underlying Transport Error Nov 26 21:41:54 wohnzimmer sudo[853]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:54 wohnzimmer wireless.js[613]: SETTING APPROPRIATE REG DOMAIN: DE Nov 26 21:41:54 wohnzimmer sudo[863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 21:41:54 wohnzimmer sudo[863]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:54 wohnzimmer sudo[863]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:54 wohnzimmer sudo[865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Nov 26 21:41:54 wohnzimmer sudo[865]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:54 wohnzimmer sudo[865]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:54 wohnzimmer wireless.js[613]: SUCCESSFULLY SET NEW REGDOMAIN: DE Nov 26 21:41:54 wohnzimmer wireless.js[613]: Start wireless flow Nov 26 21:41:54 wohnzimmer wireless.js[613]: Stopped hotspot (if there).. Nov 26 21:41:54 wohnzimmer sudo[870]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 26 21:41:54 wohnzimmer sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:54 wohnzimmer sudo[870]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:54 wohnzimmer sudo[872]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 26 21:41:54 wohnzimmer sudo[872]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:54 wohnzimmer ntpd[788]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 26 21:41:54 wohnzimmer bthelper[666]: Changing power off succeeded Nov 26 21:41:54 wohnzimmer sudo[872]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:54 wohnzimmer wireless.js[613]: DHCP IP Nov 26 21:41:54 wohnzimmer wireless.js[613]: Start ap Nov 26 21:41:54 wohnzimmer wpa_supplicant[879]: Successfully initialized wpa_supplicant Nov 26 21:41:54 wohnzimmer bthelper[666]: [CHG] Controller B8:27:EB:2F:4E:29 Class: 0x0000041c Nov 26 21:41:54 wohnzimmer bthelper[666]: Changing power on succeeded Nov 26 21:41:54 wohnzimmer mpd[821]: Nov 26 21:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 21:41:54 wohnzimmer sudo[881]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Nov 26 21:41:54 wohnzimmer sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:54 wohnzimmer dhcpcd[882]: dev: loaded udev Nov 26 21:41:54 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 21:41:54 wohnzimmer systemd[1]: Started Music Player Daemon. Nov 26 21:41:54 wohnzimmer mpd_monitor.sh[579]: MPD restarted due to no mpc output. Nov 26 21:41:54 wohnzimmer dhcpcd-run-hooks[902]: wlan0: starting wpa_supplicant Nov 26 21:41:55 wohnzimmer dhcpcd-run-hooks[908]: wlan0: failed to start wpa_supplicant Nov 26 21:41:55 wohnzimmer dhcpcd-run-hooks[909]: 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 Nov 26 21:41:55 wohnzimmer dhcpcd[882]: wlan0: connected to Access Point `' Nov 26 21:41:55 wohnzimmer dhcpcd[882]: no interfaces have a carrier Nov 26 21:41:55 wohnzimmer dhcpcd[882]: forked to background, child pid 919 Nov 26 21:41:55 wohnzimmer dhcpcd[919]: eth0: waiting for carrier Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: waiting for carrier Nov 26 21:41:55 wohnzimmer sudo[881]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:55 wohnzimmer wpa_supplicant[907]: wlan0: Trying to associate with SSID 'Stuemper' Nov 26 21:41:55 wohnzimmer wireless.js[613]: trying... Nov 26 21:41:55 wohnzimmer sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:41:55 wohnzimmer sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: carrier acquired Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: connected to Access Point `Stuemper' Nov 26 21:41:55 wohnzimmer wpa_supplicant[907]: wlan0: Associated with 98:9b:cb:0b:a0:5d Nov 26 21:41:55 wohnzimmer wpa_supplicant[907]: wlan0: CTRL-EVENT-CONNECTED - Connection to 98:9b:cb:0b:a0:5d completed [id=0 id_str=] Nov 26 21:41:55 wohnzimmer wpa_supplicant[907]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 26 21:41:55 wohnzimmer sudo[921]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:55 wohnzimmer wpa_supplicant[907]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Nov 26 21:41:55 wohnzimmer dhcpcd[919]: DUID 00:01:00:01:2b:98:74:13:b8:27:eb:d0:b1:d6 Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: IAID eb:d0:b1:d6 Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: adding address fe80::f3e0:be5c:5193:b72f Nov 26 21:41:55 wohnzimmer dhcpcd[919]: ipv6_addaddr1: Permission denied Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: carrier lost Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: carrier acquired Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: IAID eb:d0:b1:d6 Nov 26 21:41:55 wohnzimmer dhcpcd[919]: wlan0: rebinding lease of 192.168.178.181 Nov 26 21:41:56 wohnzimmer dhcpcd[919]: wlan0: probing address 192.168.178.181/24 Nov 26 21:41:56 wohnzimmer dhcpcd[919]: wlan0: soliciting an IPv6 router Nov 26 21:41:56 wohnzimmer wireless.js[613]: trying... Nov 26 21:41:56 wohnzimmer sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:41:56 wohnzimmer sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:56 wohnzimmer sudo[937]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:57 wohnzimmer wireless.js[613]: trying... Nov 26 21:41:57 wohnzimmer sudo[940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:41:57 wohnzimmer sudo[940]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:57 wohnzimmer sudo[940]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:58 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Fetching time from Volumio... Nov 26 21:41:58 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Date not found in response Nov 26 21:41:58 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Retrying in 5 seconds... Nov 26 21:41:58 wohnzimmer wireless.js[613]: trying... Nov 26 21:41:58 wohnzimmer sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:41:58 wohnzimmer sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:58 wohnzimmer sudo[948]: pam_unix(sudo:session): session closed for user root Nov 26 21:41:59 wohnzimmer wireless.js[613]: trying... Nov 26 21:41:59 wohnzimmer sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:41:59 wohnzimmer sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:41:59 wohnzimmer sudo[951]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:00 wohnzimmer wireless.js[613]: trying... Nov 26 21:42:00 wohnzimmer sudo[954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:42:00 wohnzimmer sudo[954]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:00 wohnzimmer sudo[954]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:01 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:01] [info] asio async_connect error: system:111 (Connection refused) Nov 26 21:42:01 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 21:42:01 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:01] [error] handle_connect error: Underlying Transport Error Nov 26 21:42:01 wohnzimmer wireless.js[613]: trying... Nov 26 21:42:01 wohnzimmer sudo[957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:42:01 wohnzimmer sudo[957]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:01 wohnzimmer sudo[957]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:01 wohnzimmer dhcpcd[919]: wlan0: leased 192.168.178.181 for 864000 seconds Nov 26 21:42:01 wohnzimmer avahi-daemon[600]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.181. Nov 26 21:42:01 wohnzimmer dhcpcd[919]: wlan0: adding route to 192.168.178.0/24 Nov 26 21:42:01 wohnzimmer dhcpcd[919]: wlan0: adding default route via 192.168.178.1 Nov 26 21:42:01 wohnzimmer avahi-daemon[600]: New relevant interface wlan0.IPv4 for mDNS. Nov 26 21:42:01 wohnzimmer avahi-daemon[600]: Registering new address record for 192.168.178.181 on wlan0.IPv4. Nov 26 21:42:02 wohnzimmer wireless.js[613]: trying... Nov 26 21:42:02 wohnzimmer sudo[981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 21:42:02 wohnzimmer sudo[981]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:02 wohnzimmer sudo[981]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:02 wohnzimmer wireless.js[613]: Connected to: ----Stuemper Nov 26 21:42:02 wohnzimmer wireless.js[613]: ---- Nov 26 21:42:02 wohnzimmer sudo[984]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 21:42:02 wohnzimmer sudo[984]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:02 wohnzimmer sudo[984]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:02 wohnzimmer wireless.js[613]: ... joined AP, wlan0 IPv4 is 192.168.178.181, ipV6 is undefined Nov 26 21:42:02 wohnzimmer wireless.js[613]: It's done! AP Nov 26 21:42:02 wohnzimmer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 21:42:02 wohnzimmer systemd[1]: Started Wireless Services. Nov 26 21:42:02 wohnzimmer systemd[1]: Started Volumio Backend Module. Nov 26 21:42:02 wohnzimmer systemd[1]: Started Volumio Cpu Tweaker. Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: Setting RT Priority for mpd Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: Setting MPD Affinity Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: pid 821's current affinity mask: f Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: pid 821's new affinity mask: 3 Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 26 21:42:03 wohnzimmer volumio-cpu-tweak[990]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 26 21:42:03 wohnzimmer systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 26 21:42:03 wohnzimmer ntpd[788]: Listen normally on 3 wlan0 192.168.178.181:123 Nov 26 21:42:03 wohnzimmer ntpd[788]: new interface(s) found: waking up resolver Nov 26 21:42:03 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Fetching time from Volumio... Nov 26 21:42:03 wohnzimmer volumio-time-update[581]: volumio-time-update-util: Setting system time to: 2024-11-26 21:42:28 Nov 26 21:42:03 wohnzimmer sudo[1011]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2024-11-26 21:42:28 Nov 26 21:42:03 wohnzimmer sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:03 wohnzimmer dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1012 comm="timedatectl set-time 2024-11-26 21:42:28 ") Nov 26 21:42:03 wohnzimmer systemd[1]: Starting Time & Date Service... Nov 26 21:42:04 wohnzimmer dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 26 21:42:04 wohnzimmer systemd[1]: Started Time & Date Service. Nov 26 21:42:28 wohnzimmer systemd-timedated[1013]: Changed local time to Tue Nov 26 21:42:28 2024 Nov 26 21:42:28 wohnzimmer sudo[1011]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:28 wohnzimmer volumio-time-update[581]: volumio-time-update-util: System time updated successfully. Nov 26 21:42:28 wohnzimmer systemd[1]: Started Volumio Time Update Utility. Nov 26 21:42:29 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:29 wohnzimmer volumio[989]: info: ----- Volumio3 ---- Nov 26 21:42:29 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:29 wohnzimmer volumio[989]: info: ----- System startup ---- Nov 26 21:42:29 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:30 wohnzimmer nmbd[764]: [2024/11/26 21:42:30.853348, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 21:42:30 wohnzimmer systemd[1]: Started Samba NMB Daemon. Nov 26 21:42:30 wohnzimmer nmbd[764]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 26 21:42:30 wohnzimmer systemd[1]: Starting Samba Winbind Daemon... Nov 26 21:42:31 wohnzimmer volumio[989]: info: MYVOLUMIO Environment detected Nov 26 21:42:31 wohnzimmer winbindd[1025]: [2024/11/26 21:42:31.251738, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 26 21:42:31 wohnzimmer winbindd[1025]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 26 21:42:31 wohnzimmer volumio[989]: info: Plugin folders cleanup Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning into folder /volumio/app/plugins/ Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category audio_interface Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category miscellanea Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category music_service Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category plugins.json Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category system_controller Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category user_interface Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning into folder /data/plugins/ Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category audio_interface Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category music_service Nov 26 21:42:31 wohnzimmer volumio[989]: info: Scanning category user_interface Nov 26 21:42:31 wohnzimmer volumio[989]: info: Plugin folders cleanup completed Nov 26 21:42:31 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:31 wohnzimmer volumio[989]: info: ----- Core plugins startup ---- Nov 26 21:42:31 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:31 wohnzimmer volumio[989]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 21:42:31 wohnzimmer volumio[989]: info: Adding plugin upnp to MyMusic Plugins Nov 26 21:42:31 wohnzimmer volumio[989]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 21:42:31 wohnzimmer volumio[989]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 21:42:31 wohnzimmer volumio[989]: info: Loading plugins from folder /data/plugins/ Nov 26 21:42:31 wohnzimmer volumio[989]: info: Loading plugin "system"... Nov 26 21:42:31 wohnzimmer winbindd[1025]: [2024/11/26 21:42:31.301783, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 21:42:31 wohnzimmer systemd[1]: Started Samba Winbind Daemon. Nov 26 21:42:31 wohnzimmer winbindd[1025]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 26 21:42:31 wohnzimmer volumio[989]: info: Loading plugin "appearance"... Nov 26 21:42:31 wohnzimmer systemd[1]: Starting Samba SMB Daemon... Nov 26 21:42:31 wohnzimmer smbd[1035]: [2024/11/26 21:42:31.947323, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 21:42:31 wohnzimmer systemd[1]: Started Samba SMB Daemon. Nov 26 21:42:31 wohnzimmer smbd[1035]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 26 21:42:31 wohnzimmer systemd[1]: Reached target Multi-User System. Nov 26 21:42:31 wohnzimmer systemd[1]: Reached target Graphical Interface. Nov 26 21:42:32 wohnzimmer systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 26 21:42:32 wohnzimmer systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 26 21:42:32 wohnzimmer systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 26 21:42:32 wohnzimmer systemd[1]: Startup finished in 16.091s (kernel) + 28.386s (userspace) = 44.478s. Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "network"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: Refreshing Cached IP Addresses Nov 26 21:42:33 wohnzimmer sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 21:42:33 wohnzimmer sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:33 wohnzimmer sudo[1045]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:33 wohnzimmer sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 21:42:33 wohnzimmer sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "services"... Nov 26 21:42:33 wohnzimmer sudo[1047]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "alsa_controller"... Nov 26 21:42:33 wohnzimmer sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 21:42:33 wohnzimmer sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:33 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "wizard"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "networkfs"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: Starting Udev Watcher for removable devices Nov 26 21:42:33 wohnzimmer sudo[1071]: 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+ Nov 26 21:42:33 wohnzimmer sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:33 wohnzimmer volumio[989]: info: Ignoring mount for partition: boot Nov 26 21:42:33 wohnzimmer volumio[989]: info: Ignoring mount for partition: volumio Nov 26 21:42:33 wohnzimmer volumio[989]: info: Ignoring mount for partition: volumio_data Nov 26 21:42:33 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "volumio_command_line_client"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "upnp"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: [1732653753434] Starting Upmpd Daemon Nov 26 21:42:33 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "my_music"... Nov 26 21:42:33 wohnzimmer volumio[989]: info: Loading plugin "mpd"... Nov 26 21:42:33 wohnzimmer kernel: Key type cifs.spnego registered Nov 26 21:42:33 wohnzimmer kernel: Key type cifs.idmap registered Nov 26 21:42:33 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. Nov 26 21:42:33 wohnzimmer kernel: CIFS: Attempting to mount //192.168.178.160/music/Musik - flac Nov 26 21:42:34 wohnzimmer volumio[989]: info: Plugin upnp_browser is not enabled Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "alarm-clock"... Nov 26 21:42:34 wohnzimmer sudo[1055]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:34 wohnzimmer sudo[1071]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:34 wohnzimmer volumio[989]: info: Plugin airplay_emulation is not enabled Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "last_100"... Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "webradio"... Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "i2s_dacs"... Nov 26 21:42:34 wohnzimmer volumio[989]: info: I2S DAC not set, start Auto-detection Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "volumiodiscovery"... Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** For more information see Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 21:42:34 wohnzimmer volumio[989]: *** WARNING *** For more information see Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** For more information see Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 21:42:34 wohnzimmer node[989]: *** WARNING *** For more information see Nov 26 21:42:34 wohnzimmer volumio[989]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 21:42:34 wohnzimmer volumio[989]: info: Discovery: Started advertising with name: Wohnzimmer Nov 26 21:42:34 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 21:42:34 wohnzimmer volumio[989]: info: Loading plugin "spop"... Nov 26 21:42:35 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:35] [connect] Successful connection Nov 26 21:42:36 wohnzimmer volumio[989]: info: Loading plugin "youtube2"... Nov 26 21:42:38 wohnzimmer systemd[1]: systemd-fsckd.service: Succeeded. Nov 26 21:42:43 wohnzimmer volumio[989]: info: Loading plugin "ytcr"... Nov 26 21:42:43 wohnzimmer sh[571]: timed out Nov 26 21:42:43 wohnzimmer dhcpcd[606]: timed out Nov 26 21:42:43 wohnzimmer sh[571]: dhcpcd exited Nov 26 21:42:43 wohnzimmer dhcpcd[606]: dhcpcd exited Nov 26 21:42:43 wohnzimmer sh[571]: ifup: failed to bring up eth0 Nov 26 21:42:43 wohnzimmer systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 26 21:42:43 wohnzimmer systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "outputs"... Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "albumart"... Nov 26 21:42:45 wohnzimmer volumio[989]: info: Plugin example_plugin is not enabled Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "inputs"... Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "updater_comm"... Nov 26 21:42:45 wohnzimmer systemd[1]: systemd-hostnamed.service: Succeeded. Nov 26 21:42:45 wohnzimmer volumio[989]: info: Plugin mpdemulation is not enabled Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "rest_api"... Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "websocket"... Nov 26 21:42:45 wohnzimmer volumio[989]: info: Starting Socket.io Server version 2.3.0 Nov 26 21:42:45 wohnzimmer volumio[989]: info: Loading plugin "fusiondsp"... Nov 26 21:42:45 wohnzimmer volumio[989]: Forking 3 albumart workers Nov 26 21:42:46 wohnzimmer volumio[989]: info: Applying required configuration parameters for plugin fusiondsp Nov 26 21:42:46 wohnzimmer volumio[989]: info: Loading plugin "Systeminfo"... Nov 26 21:42:46 wohnzimmer volumio[989]: Starting albumart workers Nov 26 21:42:46 wohnzimmer volumio[989]: Starting albumart workers Nov 26 21:42:46 wohnzimmer volumio[989]: Starting albumart workers Nov 26 21:42:47 wohnzimmer volumio[989]: info: Loading i18n strings for locale de Nov 26 21:42:47 wohnzimmer volumio[989]: Updating browse sources language Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::initPlayerControls Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 21:42:47 wohnzimmer volumio[989]: Express server listening on port 3000 Nov 26 21:42:47 wohnzimmer volumio[989]: [Metrics] WebUI: 18s 836.38ms Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreStateMachine::resetVolumioState Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreStateMachine::getcurrentVolume Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 21:42:47 wohnzimmer sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 21:42:47 wohnzimmer sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:47 wohnzimmer sudo[1181]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:47 wohnzimmer sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 21:42:47 wohnzimmer sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:47 wohnzimmer sudo[1183]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:47 wohnzimmer volumio[989]: info: Volumio Network Manager: Network status updated: 2 Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreStateMachine::pushState Nov 26 21:42:47 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioPushState Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreStateMachine::updateTrackBlock Nov 26 21:42:47 wohnzimmer volumio[989]: info: CorePlayQueue::getTrackBlock Nov 26 21:42:47 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 21:42:47 wohnzimmer volumio[989]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Nov 26 21:42:48 wohnzimmer volumio[989]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 2 Nov 26 21:42:48 wohnzimmer volumio[989]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreStateMachine::pushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioPushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: Reloading queue from file Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreStateMachine::setRepeat false single undefined Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreStateMachine::pushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioPushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreStateMachine::setRandom null Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreStateMachine::pushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioPushState Nov 26 21:42:48 wohnzimmer volumio[989]: info: Setting Device type: Raspberry PI Nov 26 21:42:48 wohnzimmer volumio[989]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 26 21:42:48 wohnzimmer volumio[989]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a52082 Nov 26 21:42:48 wohnzimmer volumio[989]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 26 21:42:48 wohnzimmer volumio[989]: info: Completed loading Core Plugins Nov 26 21:42:48 wohnzimmer volumio[989]: info: Preparing to generate the ALSA configuration file Nov 26 21:42:48 wohnzimmer sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 26 21:42:48 wohnzimmer sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer volumio[989]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 26 21:42:48 wohnzimmer volumio[989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 26 21:42:48 wohnzimmer volumio[989]: info: Reading ALSA contributions from plugins. Nov 26 21:42:48 wohnzimmer volumio[989]: info: Discovery: adding 86ef962c-6315-407f-a8f4-3cc54f83ed48 Nov 26 21:42:48 wohnzimmer volumio[989]: info: Discovery: Found device Wohnzimmer Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetState Nov 26 21:42:48 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:48 wohnzimmer volumio[989]: info: Asound.conf file unchanged, so no further update is needed Nov 26 21:42:48 wohnzimmer volumio[989]: info: Output device has changed, restarting MPD Nov 26 21:42:48 wohnzimmer sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 21:42:48 wohnzimmer sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer systemd[1]: Started UPnP Renderer front-end to MPD. Nov 26 21:42:48 wohnzimmer volumio[989]: info: ___________ START PLUGINS ___________ Nov 26 21:42:48 wohnzimmer sudo[1202]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:48 wohnzimmer sudo[1198]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:48 wohnzimmer volumio[989]: info: ControllerMpd::onStart: Initializing MPD Nov 26 21:42:48 wohnzimmer volumio[989]: info: Creating MPD Configuration file Nov 26 21:42:48 wohnzimmer sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 21:42:48 wohnzimmer sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 21:42:48 wohnzimmer sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer systemd[1]: Stopping Music Player Daemon... Nov 26 21:42:48 wohnzimmer sudo[1208]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 21:42:48 wohnzimmer volumio[989]: info: [1732653768317] CoreMusicLibrary::Adding element Last_100 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 21:42:48 wohnzimmer volumio[989]: info: [1732653768322] CoreMusicLibrary::Adding element Webradio Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:48 wohnzimmer sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 21:42:48 wohnzimmer sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 21:42:48 wohnzimmer volumio[989]: info: Initializing BBC Radios Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: Creating Spotify config file Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer systemd[1]: mpd.service: Succeeded. Nov 26 21:42:48 wohnzimmer systemd[1]: Stopped Music Player Daemon. Nov 26 21:42:48 wohnzimmer systemd[1]: Starting Music Player Daemon... Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 21:42:48 wohnzimmer volumio[989]: info: [1732653768591] CoreMusicLibrary::Adding element YouTube2 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:48 wohnzimmer volumio[989]: Cannot find translation for source YouTube2 Nov 26 21:42:48 wohnzimmer volumio[989]: info: Loading i18n strings for locale de Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: FusionDsp - mixtype--------------------- Software Nov 26 21:42:48 wohnzimmer volumio[989]: info: Volumio Calling Home Nov 26 21:42:48 wohnzimmer sudo[1223]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 21:42:48 wohnzimmer sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer sudo[1223]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:48 wohnzimmer volumio[989]: info: Preparing to generate the ALSA configuration file Nov 26 21:42:48 wohnzimmer volumio[989]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 26 21:42:48 wohnzimmer volumio[989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 26 21:42:48 wohnzimmer volumio[989]: info: Reading ALSA contributions from plugins. Nov 26 21:42:48 wohnzimmer volumio[989]: info: MPD Permissions set Nov 26 21:42:48 wohnzimmer volumio[989]: info: MPD Permissions set Nov 26 21:42:48 wohnzimmer volumio[989]: info: Upmpdcli Daemon Started Nov 26 21:42:48 wohnzimmer volumio[989]: info: Volumio called home Nov 26 21:42:48 wohnzimmer volumio[989]: info: Spotify config file written Nov 26 21:42:48 wohnzimmer volumio[989]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 21:42:48 wohnzimmer systemd[1]: Started go-librespot Daemon. Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: No need to fix Spotify hosts Nov 26 21:42:48 wohnzimmer go-librespot[1238]: Librespot-go daemon starting... Nov 26 21:42:48 wohnzimmer sudo[1230]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:48 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: verbose: New Socket.io Connection to 192.168.178.181 from 192.168.178.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetState Nov 26 21:42:49 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:49 wohnzimmer volumio[989]: info: Asound.conf file unchanged, so no further update is needed Nov 26 21:42:49 wohnzimmer volumio[989]: info: Output device has changed, restarting MPD Nov 26 21:42:49 wohnzimmer sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 21:42:49 wohnzimmer sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:49 wohnzimmer sudo[1250]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:49 wohnzimmer sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 21:42:49 wohnzimmer sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 26 21:42:49 wohnzimmer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 26 21:42:49 wohnzimmer systemd[1]: mpd.service: Succeeded. Nov 26 21:42:49 wohnzimmer systemd[1]: Stopped Music Player Daemon. Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetVisibleSources Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetState Nov 26 21:42:49 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 26 21:42:49 wohnzimmer volumio[989]: info: Received Get System Info Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 21:42:49 wohnzimmer volumio[989]: info: Discovery: Getting this device information Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetState Nov 26 21:42:49 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetState Nov 26 21:42:49 wohnzimmer volumio[989]: info: CorePlayQueue::getTrack 0 Nov 26 21:42:49 wohnzimmer volumio[989]: info: Listing playlists Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioGetQueue Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreStateMachine::getQueue Nov 26 21:42:49 wohnzimmer volumio[989]: info: CorePlayQueue::getQueue Nov 26 21:42:49 wohnzimmer volumio[989]: info: MPD Permissions set Nov 26 21:42:49 wohnzimmer systemd[1]: Starting Music Player Daemon... Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=info msg="generated new device id: 0b2a2fa43295ff9e5b6aed4634cf88c9f11857e9" Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=debug msg="stored credentials found for stümper" Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 26 21:42:49 wohnzimmer volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 26 21:42:49 wohnzimmer sudo[1255]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 21:42:49 wohnzimmer sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:49 wohnzimmer sudo[1255]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 26 21:42:49 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:49+01:00" level=debug msg="zeroconf server listening on port 41489" Nov 26 21:42:50 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:50+01:00" level=debug msg="obtained new client token: AAAstg02NWE3OmTb40AAVxzu/AXEMmuvpyxoiN4h0r02e1EkSCnBMQTFyNXOyj31rz31dQ76UxPXc5CZnwZRO+cCGaNJRt6MamwH9scnVvtm4mcYz7jUPipwziT4iqu+uSs+w1zEe9wMHu10iOnauM7dLaQDhGFeo7sO+NWK5pBonXFnRu1em4pNFkUnX3lci8ytVjrHGbjJcgimnDNGN3xNe0wbq1MjPdEk+h5/oMjgKEmuMr0m2jhwwoVOVYE=" Nov 26 21:42:50 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:50+01:00" level=info msg="connected to ap-gew4.spotify.com:4070" Nov 26 21:42:50 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:50] [connect] Successful connection Nov 26 21:42:50 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:50+01:00" level=debug msg="completed keyexchange" Nov 26 21:42:50 wohnzimmer volumio-remote-updater[591]: [2024-11-26 21:42:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732653770 101 Nov 26 21:42:50 wohnzimmer volumio[989]: 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 Nov 26 21:42:50 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:50+01:00" level=debug msg="completed challenge" Nov 26 21:42:50 wohnzimmer volumio[989]: info: camilladsp spawned new process with pid 1271, instance 1, run: true Nov 26 21:42:50 wohnzimmer volumio[989]: info: camilladsp service started and running in background, instance 1 Nov 26 21:42:50 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 21:42:50 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:50+01:00" level=debug msg="authenticated as stümper" Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp loaded Nov 26 21:42:50 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 26 21:42:50 wohnzimmer volumio[989]: info: Adding Signal Path Element [object Object] Nov 26 21:42:50 wohnzimmer volumio[989]: info: Adding fusiondspeq DSP Signal Path Element Nov 26 21:42:50 wohnzimmer sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 26 21:42:50 wohnzimmer sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp - ---- installed callbackRead Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 26 21:42:50 wohnzimmer volumio[989]: info: FusionDsp - Effects disabled Nov 26 21:42:50 wohnzimmer volumio[989]: error: FusionDsp - WebSocket error: [object Object] Nov 26 21:42:50 wohnzimmer volumio[989]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 26 21:42:50 wohnzimmer systemd[1]: Started FusionDsp Daemon. Nov 26 21:42:50 wohnzimmer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 26 21:42:50 wohnzimmer systemd[1]: mpd.service: Failed with result 'protocol'. Nov 26 21:42:50 wohnzimmer systemd[1]: Failed to start Music Player Daemon. Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="authenticated as stümper" Nov 26 21:42:51 wohnzimmer sudo[1211]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:51 wohnzimmer sudo[1204]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:51 wohnzimmer systemd[1]: Starting Music Player Daemon... Nov 26 21:42:51 wohnzimmer sudo[1252]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:51 wohnzimmer sudo[1275]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:51 wohnzimmer volumio[989]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 26 21:42:51 wohnzimmer volumio[989]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 26 21:42:51 wohnzimmer volumio[989]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 26 21:42:51 wohnzimmer volumio[989]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 26 21:42:51 wohnzimmer volumio[989]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 26 21:42:51 wohnzimmer volumio[989]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 26 21:42:51 wohnzimmer volumio[989]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 26 21:42:51 wohnzimmer volumio[989]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 26 21:42:51 wohnzimmer volumio[989]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 26 21:42:51 wohnzimmer sudo[1286]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 21:42:51 wohnzimmer sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 21:42:51 wohnzimmer sudo[1286]: pam_unix(sudo:session): session closed for user root Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="dealer connection opened" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="initializing zeroconf session, username: stümper" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="received connection id: YjA5MGFjNzUtMmUyZC00NmUyLThjZmEtYThmNzVhZGQyODBiK2RlYWxlcit0Y3A6Ly8wYWNhNTg3My5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNjI2MDAyMDQxQkE4REUzRDU3OUU4MkY3QzZEREQwQkI3NkNDMUJGNzEyRTNBMDdDOTRGQzM3RDM4OUE5RkEwMA==" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="put connect state because NEW_DEVICE" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Nov 26 21:42:51 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:51+01:00" level=debug msg="autoplay enabled: false" Nov 26 21:42:52 wohnzimmer volumio[989]: info: go-librespot daemon successfully initialized Nov 26 21:42:52 wohnzimmer mpd[1288]: Nov 26 21:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 21:42:52 wohnzimmer systemd[1]: Started Music Player Daemon. Nov 26 21:42:52 wohnzimmer mpd_monitor.sh[579]: MPD restarted due to no mpc output. Nov 26 21:42:52 wohnzimmer volumio[989]: error: MPD error: The expression evaluated to a falsy value: Nov 26 21:42:52 wohnzimmer volumio[989]: assert.ok(self.idling) Nov 26 21:42:52 wohnzimmer volumio[989]: error: The expression evaluated to a falsy value: Nov 26 21:42:52 wohnzimmer volumio[989]: assert.ok(self.idling) Nov 26 21:42:52 wohnzimmer volumio[989]: Upnp client error: Error: This socket has been ended by the other party Nov 26 21:42:52 wohnzimmer volumio[989]: error: MPD error: The expression evaluated to a falsy value: Nov 26 21:42:52 wohnzimmer volumio[989]: assert.ok(self.idling) Nov 26 21:42:52 wohnzimmer volumio[989]: error: The expression evaluated to a falsy value: Nov 26 21:42:52 wohnzimmer volumio[989]: assert.ok(self.idling) Nov 26 21:42:52 wohnzimmer volumio[989]: error: updateQueue error: null Nov 26 21:42:53 wohnzimmer volumio[1200]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 26 21:42:53 wohnzimmer volumio[989]: [yt-cast-receiver] Listening on port 8098 Nov 26 21:42:53 wohnzimmer volumio[989]: info: Completed starting Core Plugins Nov 26 21:42:53 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:53 wohnzimmer volumio[989]: info: ----- MyVolumio plugins startup ---- Nov 26 21:42:53 wohnzimmer volumio[989]: info: ------------------------------------------- Nov 26 21:42:53 wohnzimmer volumio[989]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="handling transfer player command from 7ca7e328a7bbdcd2456f1f04ab4cd02e34354e6a" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="resolved context of track" uri="spotify:artist:3PhoLpVuITZKcymswpck5b" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=trace msg="fetched new page 0 with 5 items (list: 5)" uri="spotify:artist:3PhoLpVuITZKcymswpck5b" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=trace msg="fetched new page 1 with 49 items (list: 54)" uri="spotify:artist:3PhoLpVuITZKcymswpck5b" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="loading track (paused: false, position: 71255ms)" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=trace msg="emitting websocket event: will_play" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="selected format OGG_VORBIS_320 (d19fc152dd2b68fe364c8006670d25a3749a309e)" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="requested aes key for file d19fc152dd2b68fe364c8006670d25a3749a309e, gid: 38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1339" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="fetched first chunk of 20, total size is 10322112 bytes" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1117" Nov 26 21:42:53 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:53+01:00" level=debug msg="fetched chunk 3/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 1/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 8/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 5/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=trace msg="seek to 71255ms (diff: 76ms, samples: 3142345, bytes: 3065113)" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer volumio[989]: info: FusionDsp - ---- read samplerate, raw: Nov 26 21:42:54 wohnzimmer volumio[989]: error: FusionDsp - invalid sample rate Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="created new output device" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=info msg="loaded track \"Your Song\" (paused: false, position: 71255ms, duration: 241786ms, prefetched: false)" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer volumio[989]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 26 21:42:54 wohnzimmer volumio[989]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 26 21:42:54 wohnzimmer volumio[989]: info: camilladsp stopping service pid 1271... Nov 26 21:42:54 wohnzimmer volumio[989]: info: camilladsp service terminated, instance 1 Nov 26 21:42:54 wohnzimmer volumio[989]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 26 21:42:54 wohnzimmer volumio[989]: info: FusionDsp - Effects disabled Nov 26 21:42:54 wohnzimmer volumio[989]: info: camilladsp service started and running in background, instance 1 Nov 26 21:42:54 wohnzimmer volumio[989]: info: camilladsp spawned new process with pid 1324, instance 1, run: true Nov 26 21:42:54 wohnzimmer volumio[989]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 26 21:42:54 wohnzimmer volumio[989]: SPOTIFY: BQArE2VrsM6QmpYUq2lermCWWO6Whd_S_7xfvSOl9dZ-B0DDoHtMRUhfnDezlwaOajIs1TIH4sa4Yzk4rW_lYXJ_rU-yUv0HHJVizAGjjla2_QDZ7Nic1VGZ1OP2zpTtzno9wRgmCc7qoq1dFD6Q4pecubNPYTVa1L8HAljETQfY00yccRlJHg7qK023FK_DQ7aQS9dRrB8an9NpQbVK3bSzQx6cZlOywzIB-OIZVaBWbX1n5JaTQ2yY Nov 26 21:42:54 wohnzimmer volumio[989]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 26 21:42:54 wohnzimmer volumio[989]: info: New Spotify access token = BQArE2VrsM6QmpYUq2lermCWWO6Whd_S_7xfvSOl9dZ-B0DDoHtMRUhfnDezlwaOajIs1TIH4sa4Yzk4rW_lYXJ_rU-yUv0HHJVizAGjjla2_QDZ7Nic1VGZ1OP2zpTtzno9wRgmCc7qoq1dFD6Q4pecubNPYTVa1L8HAljETQfY00yccRlJHg7qK023FK_DQ7aQS9dRrB8an9NpQbVK3bSzQx6cZlOywzIB-OIZVaBWbX1n5JaTQ2yY Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 26 21:42:54 wohnzimmer volumio[989]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 2/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 7/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:54+01:00" level=debug msg="fetched chunk 6/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:54 wohnzimmer volumio[989]: 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"} Nov 26 21:42:54 wohnzimmer volumio[989]: info: Spotify Successfully logged in Nov 26 21:42:54 wohnzimmer volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 21:42:54 wohnzimmer volumio[989]: info: [1732653774817] CoreMusicLibrary::Adding element Spotify Nov 26 21:42:54 wohnzimmer volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 21:42:54 wohnzimmer volumio[989]: Cannot find translation for source YouTube2 Nov 26 21:42:54 wohnzimmer volumio[989]: Cannot find translation for source Spotify Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=trace msg="scheduling prefetch in 140s" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=trace msg="emitting websocket event: metadata" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=trace msg="emitting websocket event: active" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="sending successful reply for dealer request" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Nov 26 21:42:55 wohnzimmer volumio[989]: info: Initializing connection to go-librespot Websocket Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="new websocket client" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=trace msg="emitting websocket event: playing" Nov 26 21:42:55 wohnzimmer volumio[989]: info: Connection to go-librespot Websocket established Nov 26 21:42:55 wohnzimmer volumio[989]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:38zsOOcu31XbbYj9BIPUF1","play_origin":"com.spotify.service.freetierartist"}} Nov 26 21:42:55 wohnzimmer volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 21:42:55 wohnzimmer volumio[989]: TypeError: Cannot read property 'service' of undefined Nov 26 21:42:55 wohnzimmer volumio[989]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:337:50) Nov 26 21:42:55 wohnzimmer volumio[989]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:263:18) Nov 26 21:42:55 wohnzimmer volumio[989]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Nov 26 21:42:55 wohnzimmer volumio[989]: at WebSocket.emit (events.js:315:20) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver.emit (events.js:315:20) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Nov 26 21:42:55 wohnzimmer volumio[989]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Nov 26 21:42:55 wohnzimmer volumio[989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 21:42:55 wohnzimmer volumio[1200]: .............++++ Nov 26 21:42:55 wohnzimmer go-librespot[1238]: time="2024-11-26T21:42:55+01:00" level=debug msg="fetched chunk 9/19, size: 524288" uri="spotify:track:38zsOOcu31XbbYj9BIPUF1" Nov 26 21:42:55 wohnzimmer volumio[1200]: ..++++ Nov 26 21:42:55 wohnzimmer volumio[1200]: e is 65537 (0x010001) Nov 26 21:42:55 wohnzimmer volumio[1200]: writing RSA key Nov 26 21:42:55 wohnzimmer sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 21:41 Nov 26 21:42:55 wohnzimmer sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"