-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-04-26 18:53:59 CEST. -- Apr 26 18:53:15 musique fake-hwclock[192]: Fri Apr 26 16:53:15 UTC 2024 Apr 26 18:53:15 musique systemd[1]: Starting Load/Save Random Seed... Apr 26 18:53:15 musique systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 26 18:53:15 musique systemd[1]: Starting Apply Kernel Variables... Apr 26 18:53:15 musique systemd[1]: Mounting Kernel Configuration File System... Apr 26 18:53:15 musique systemd[1]: Started Restore / save the current clock. Apr 26 18:53:15 musique systemd[1]: Mounted Kernel Configuration File System. Apr 26 18:53:15 musique systemd[1]: Started Load/Save Random Seed. Apr 26 18:53:15 musique systemd[1]: Started udev Coldplug all Devices. Apr 26 18:53:15 musique systemd[1]: Starting Helper to synchronize boot up for ifupdown... Apr 26 18:53:15 musique systemd[1]: dynamicswap.service: Succeeded. Apr 26 18:53:15 musique systemd[1]: Started Create System Users. Apr 26 18:53:15 musique systemd[1]: Started Apply Kernel Variables. Apr 26 18:53:15 musique systemd[1]: Starting Create Static Device Nodes in /dev... Apr 26 18:53:15 musique systemd[1]: Started Helper to synchronize boot up for ifupdown. Apr 26 18:53:15 musique systemd[1]: Started Create Static Device Nodes in /dev. Apr 26 18:53:15 musique systemd[1]: Starting udev Kernel Device Manager... Apr 26 18:53:15 musique systemd[1]: Reached target Local File Systems (Pre). Apr 26 18:53:15 musique systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Apr 26 18:53:15 musique systemd[1]: Mounting /var/log... Apr 26 18:53:15 musique systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 26 18:53:15 musique systemd[1]: Mounting /tmp... Apr 26 18:53:15 musique systemd[1]: Mounting /var/spool/cups... Apr 26 18:53:15 musique systemd[1]: Mounted /var/log. Apr 26 18:53:15 musique systemd[1]: Starting Flush Journal to Persistent Storage... Apr 26 18:53:15 musique systemd[1]: Mounted /tmp. Apr 26 18:53:15 musique systemd[1]: Mounted /var/spool/cups. Apr 26 18:53:15 musique systemd[1]: Mounting /var/spool/cups/tmp... Apr 26 18:53:15 musique systemd[1]: Mounted /var/spool/cups/tmp. Apr 26 18:53:15 musique systemd-udevd[227]: Network interface NamePolicy= disabled on kernel command line, ignoring. Apr 26 18:53:15 musique systemd-journald[204]: Runtime journal (/run/log/journal/a615280fd3b4564a2a95d8e26513f6fc) is 7.5M, max 30.0M, 22.5M free. Apr 26 18:53:15 musique systemd[1]: Started Flush Journal to Persistent Storage. Apr 26 18:53:15 musique systemd[1]: Started udev Kernel Device Manager. Apr 26 18:53:15 musique systemd[1]: Starting Show Plymouth Boot Screen... Apr 26 18:53:15 musique systemd[1]: Received SIGRTMIN+20 from PID 245 (plymouthd). Apr 26 18:53:15 musique systemd[1]: Started Show Plymouth Boot Screen. Apr 26 18:53:15 musique systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 26 18:53:15 musique systemd[1]: Reached target Paths. Apr 26 18:53:15 musique systemd[1]: Reached target Local Encrypted Volumes. Apr 26 18:53:15 musique systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Apr 26 18:53:16 musique kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Apr 26 18:53:16 musique kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Apr 26 18:53:16 musique kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Apr 26 18:53:16 musique kernel: [vc_sm_connected_init]: start Apr 26 18:53:16 musique kernel: [vc_sm_connected_init]: installed successfully Apr 26 18:53:16 musique kernel: mc: Linux media interface: v0.10 Apr 26 18:53:16 musique kernel: videodev: Linux video capture interface: v2.00 Apr 26 18:53:16 musique kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Apr 26 18:53:16 musique kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Apr 26 18:53:16 musique kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Apr 26 18:53:16 musique kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Apr 26 18:53:16 musique kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Apr 26 18:53:16 musique kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Apr 26 18:53:16 musique kernel: Bluetooth: Core ver 2.22 Apr 26 18:53:16 musique kernel: NET: Registered PF_BLUETOOTH protocol family Apr 26 18:53:16 musique kernel: Bluetooth: HCI device and connection manager initialized Apr 26 18:53:16 musique kernel: Bluetooth: HCI socket layer initialized Apr 26 18:53:16 musique kernel: Bluetooth: L2CAP socket layer initialized Apr 26 18:53:16 musique kernel: Bluetooth: SCO socket layer initialized Apr 26 18:53:17 musique kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Apr 26 18:53:17 musique kernel: Bluetooth: HCI UART driver ver 2.3 Apr 26 18:53:17 musique kernel: Bluetooth: HCI UART protocol H4 registered Apr 26 18:53:17 musique kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Apr 26 18:53:17 musique kernel: Bluetooth: HCI UART protocol Broadcom registered Apr 26 18:53:17 musique kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Apr 26 18:53:17 musique kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Apr 26 18:53:17 musique kernel: uart-pl011 3f201000.serial: no DMA platform data Apr 26 18:53:17 musique kernel: Bluetooth: hci0: BCM: chip id 94 Apr 26 18:53:17 musique kernel: Bluetooth: hci0: BCM: features 0x2e Apr 26 18:53:17 musique kernel: Bluetooth: hci0: BCM43430A1 Apr 26 18:53:17 musique kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Apr 26 18:53:17 musique systemd-udevd[238]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 26 18:53:18 musique kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Apr 26 18:53:18 musique kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Apr 26 18:53:18 musique kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Apr 26 18:53:18 musique kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Apr 26 18:53:18 musique systemd-udevd[235]: Using default interface naming scheme 'v240'. Apr 26 18:53:18 musique systemd-udevd[235]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 26 18:53:18 musique systemd[1]: Found device /dev/mmcblk0p1. Apr 26 18:53:18 musique kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Apr 26 18:53:18 musique kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Apr 26 18:53:18 musique kernel: usbcore: registered new interface driver brcmfmac Apr 26 18:53:19 musique kernel: Bluetooth: hci0: BCM: features 0x2e Apr 26 18:53:19 musique kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Apr 26 18:53:19 musique kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Apr 26 18:53:19 musique 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 Apr 26 18:53:19 musique systemd-udevd[237]: Using default interface naming scheme 'v240'. Apr 26 18:53:19 musique systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Apr 26 18:53:20 musique systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Apr 26 18:53:21 musique systemd[1]: Created slice system-bthelper.slice. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in Huge Pages File System being skipped. Apr 26 18:53:21 musique systemd[1]: Condition check resulted in FUSE Control File System being skipped. Apr 26 18:53:21 musique systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Apr 26 18:53:21 musique systemd[1]: Starting File System Check on /dev/mmcblk0p1... Apr 26 18:53:21 musique systemd[1]: Starting Load/Save RF Kill Switch Status... Apr 26 18:53:21 musique systemd[1]: Started File System Check Daemon to report status. Apr 26 18:53:21 musique systemd[1]: Started Load/Save RF Kill Switch Status. Apr 26 18:53:21 musique systemd-fsck[394]: fsck.fat 4.1 (2017-01-24) Apr 26 18:53:21 musique systemd-fsck[394]: /dev/mmcblk0p1: 374 files, 33361/46774 clusters Apr 26 18:53:21 musique systemd[1]: Started File System Check on /dev/mmcblk0p1. Apr 26 18:53:21 musique systemd[1]: Mounting /boot... Apr 26 18:53:21 musique systemd[1]: Mounted /boot. Apr 26 18:53:21 musique systemd[1]: Reached target Local File Systems. Apr 26 18:53:21 musique systemd[1]: Started ifup for wlan0. Apr 26 18:53:21 musique systemd[1]: Started ifup for eth0. Apr 26 18:53:21 musique systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Apr 26 18:53:21 musique systemd[1]: Starting Preprocess NFS configuration... Apr 26 18:53:21 musique systemd[1]: Starting Raise network interfaces... Apr 26 18:53:21 musique systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Apr 26 18:53:21 musique systemd[1]: Starting Create Volatile Files and Directories... Apr 26 18:53:21 musique systemd[1]: plymouth-read-write.service: Succeeded. Apr 26 18:53:21 musique systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Apr 26 18:53:21 musique systemd[1]: Received SIGRTMIN+20 from PID 245 (plymouthd). Apr 26 18:53:22 musique systemd[1]: nfs-config.service: Succeeded. Apr 26 18:53:22 musique systemd[1]: Started Preprocess NFS configuration. Apr 26 18:53:22 musique systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Apr 26 18:53:22 musique systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Apr 26 18:53:22 musique systemd[1]: Reached target NFS client services. Apr 26 18:53:22 musique systemd[1]: Started Create Volatile Files and Directories. Apr 26 18:53:22 musique systemd[1]: Starting RPC bind portmap service... Apr 26 18:53:22 musique systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 26 18:53:22 musique systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Apr 26 18:53:22 musique systemd[1]: Starting Update UTMP about System Boot/Shutdown... Apr 26 18:53:22 musique kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 26 18:53:22 musique systemd[1]: Started Update UTMP about System Boot/Shutdown. Apr 26 18:53:22 musique systemd[1]: Reached target System Initialization. Apr 26 18:53:22 musique systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 26 18:53:22 musique kernel: 8021q: 802.1Q VLAN Support v1.8 Apr 26 18:53:22 musique systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 26 18:53:22 musique systemd[1]: Started Daily apt download activities. Apr 26 18:53:22 musique systemd[1]: Started Daily apt upgrade and clean activities. Apr 26 18:53:22 musique systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 26 18:53:22 musique systemd[1]: Reached target Timers. Apr 26 18:53:22 musique systemd[1]: Started Volumio Splash. Apr 26 18:53:22 musique systemd[1]: Listening on triggerhappy.socket. Apr 26 18:53:22 musique systemd[1]: Reached target Sockets. Apr 26 18:53:22 musique systemd[1]: Reached target Basic System. Apr 26 18:53:22 musique systemd[491]: volumiosplash.service: Failed to execute command: No such file or directory Apr 26 18:53:22 musique systemd[491]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Apr 26 18:53:22 musique systemd[1]: Starting Login Service... Apr 26 18:53:22 musique systemd[1]: Starting triggerhappy global hotkey daemon... Apr 26 18:53:22 musique systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Apr 26 18:53:22 musique systemd[1]: Starting dhcpcd on all interfaces... Apr 26 18:53:22 musique systemd[1]: Started Manage Sound Card State (restore and store). Apr 26 18:53:22 musique systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Apr 26 18:53:22 musique systemd[1]: Starting Wireless Services... Apr 26 18:53:22 musique alsactl[502]: alsactl 1.1.8 daemon started Apr 26 18:53:22 musique systemd[1]: Started D-Bus System Message Bus. Apr 26 18:53:22 musique systemd[1]: Starting WPA supplicant... Apr 26 18:53:22 musique systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 26 18:53:22 musique systemd[1]: Started Volumio Log Rotation Service. Apr 26 18:53:22 musique systemd[1]: Started UPnP Renderer front-end to MPD. Apr 26 18:53:22 musique systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Apr 26 18:53:22 musique thd[499]: Unable to parse trigger line: Apr 26 18:53:22 musique thd[499]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Apr 26 18:53:22 musique thd[499]: Unable to parse trigger line: Apr 26 18:53:22 musique thd[499]: Found socket passed from systemd Apr 26 18:53:22 musique systemd[1]: Started Volumio Iptables Module. Apr 26 18:53:22 musique dhcpcd[501]: Not running dhcpcd because /etc/network/interfaces Apr 26 18:53:22 musique dhcpcd[501]: defines some interfaces that will use a Apr 26 18:53:22 musique dhcpcd[501]: DHCP client or static address Apr 26 18:53:22 musique systemd[1]: Starting Configure Bluetooth Modems connected by UART... Apr 26 18:53:22 musique systemd[1]: Started volumio-remote-updater.service. Apr 26 18:53:22 musique systemd[1]: Starting Save/Restore Sound Card State... Apr 26 18:53:22 musique systemd[1]: Started RPC bind portmap service. Apr 26 18:53:22 musique systemd[1]: Started triggerhappy global hotkey daemon. Apr 26 18:53:22 musique systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Apr 26 18:53:22 musique systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Apr 26 18:53:22 musique systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Apr 26 18:53:22 musique systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Apr 26 18:53:22 musique systemd[1]: Failed to start dhcpcd on all interfaces. Apr 26 18:53:22 musique systemd[1]: Reached target Remote File Systems (Pre). Apr 26 18:53:22 musique systemd[1]: Reached target Remote File Systems. Apr 26 18:53:22 musique systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 26 18:53:22 musique systemd[1]: Reached target RPC Port Mapper. Apr 26 18:53:23 musique sh[401]: wlan0=wlan0 Apr 26 18:53:23 musique systemd-logind[498]: New seat seat0. Apr 26 18:53:23 musique sh[402]: eth0: waiting for carrier Apr 26 18:53:23 musique dhcpcd[447]: eth0: waiting for carrier Apr 26 18:53:23 musique kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Apr 26 18:53:23 musique kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Apr 26 18:53:23 musique avahi-daemon[507]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Apr 26 18:53:23 musique avahi-daemon[507]: Successfully dropped root privileges. Apr 26 18:53:23 musique avahi-daemon[507]: avahi-daemon 0.7 starting up. Apr 26 18:53:24 musique dbus-daemon[504]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 26 18:53:24 musique avahi-daemon[507]: Successfully called chroot(). Apr 26 18:53:24 musique avahi-daemon[507]: Successfully dropped remaining capabilities. Apr 26 18:53:24 musique systemd[1]: Started Login Service. Apr 26 18:53:24 musique systemd[1]: hciuart.service: Succeeded. Apr 26 18:53:24 musique systemd[1]: Started Configure Bluetooth Modems connected by UART. Apr 26 18:53:24 musique systemd[1]: Started Save/Restore Sound Card State. Apr 26 18:53:24 musique wpa_supplicant[505]: Successfully initialized wpa_supplicant Apr 26 18:53:24 musique avahi-daemon[507]: Loading service file /services/volumio.service. Apr 26 18:53:24 musique avahi-daemon[507]: Network interface enumeration completed. Apr 26 18:53:24 musique avahi-daemon[507]: Server startup complete. Host name is musique.local. Local service cookie is 3383579699. Apr 26 18:53:24 musique avahi-daemon[507]: Service "Musique" (/services/volumio.service) successfully established. Apr 26 18:53:24 musique systemd[1]: Started Raise network interfaces. Apr 26 18:53:24 musique systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 26 18:53:24 musique systemd[1]: Started WPA supplicant. Apr 26 18:53:24 musique systemd[1]: Reached target Network. Apr 26 18:53:24 musique systemd[1]: Reached target Network is Online. Apr 26 18:53:24 musique systemd[1]: Starting LSB: Brings up/down network automatically... Apr 26 18:53:24 musique systemd[1]: Starting Samba NMB Daemon... Apr 26 18:53:24 musique systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Apr 26 18:53:24 musique systemd[1]: Starting /etc/rc.local Compatibility... Apr 26 18:53:24 musique systemd[1]: Starting Network Time Service... Apr 26 18:53:24 musique systemd[1]: Starting Permit User Sessions... Apr 26 18:53:24 musique systemd[1]: Reached target Sound Card. Apr 26 18:53:24 musique systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 26 18:53:24 musique systemd[1]: Starting Raspberry Pi bluetooth helper... Apr 26 18:53:24 musique systemd[1]: Started /etc/rc.local Compatibility. Apr 26 18:53:24 musique volumio-remote-updater[514]: Error: No active session Apr 26 18:53:24 musique volumio-remote-updater[514]: [2024-04-26 18:53:24] [info] asio async_connect error: system:111 (Connection refused) Apr 26 18:53:24 musique volumio-remote-updater[514]: [2024-04-26 18:53:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 26 18:53:24 musique volumio-remote-updater[514]: [2024-04-26 18:53:24] [error] handle_connect error: Underlying Transport Error Apr 26 18:53:24 musique systemd[1]: Started Permit User Sessions. Apr 26 18:53:25 musique systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 26 18:53:25 musique systemd[1]: Starting Hold until boot process finishes up... Apr 26 18:53:25 musique systemd[1]: plymouth-quit.service: Succeeded. Apr 26 18:53:25 musique systemd[1]: Started Terminate Plymouth Boot Screen. Apr 26 18:53:25 musique systemd[1]: plymouth-start.service: Succeeded. Apr 26 18:53:25 musique systemd[1]: plymouth-quit-wait.service: Succeeded. Apr 26 18:53:25 musique volumio[511]: Could not open config: /tmp/upmpdcli.conf Apr 26 18:53:25 musique systemd[1]: Started Hold until boot process finishes up. Apr 26 18:53:25 musique ifplugd(eth0)[637]: ifplugd 0.28 initializing. Apr 26 18:53:25 musique systemd[1]: Received SIGRTMIN+21 from PID 245 (n/a). Apr 26 18:53:25 musique haveged[461]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Apr 26 18:53:25 musique haveged[461]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Apr 26 18:53:25 musique haveged[461]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00229 Apr 26 18:53:25 musique haveged[461]: haveged: fills: 0, generated: 0 Apr 26 18:53:25 musique ifplugd(eth0)[637]: Using interface eth0/B8:27:EB:C4:2B:4D with driver (version: 6.1.69-v7+) Apr 26 18:53:25 musique systemd[1]: Received SIGRTMIN+21 from PID 245 (n/a). Apr 26 18:53:25 musique ifplugd(eth0)[637]: Using detection mode: SIOCETHTOOL Apr 26 18:53:25 musique systemd[1]: Started Getty on tty1. Apr 26 18:53:25 musique ifplugd(eth0)[637]: Initialization complete, link beat not detected. Apr 26 18:53:25 musique systemd[1]: Reached target Login Prompts. Apr 26 18:53:25 musique systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 26 18:53:25 musique systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 26 18:53:25 musique systemd[1]: iptables.service: Succeeded. Apr 26 18:53:25 musique ifplugd[591]: Network Interface Plugging Daemon...start eth0...done. Apr 26 18:53:25 musique systemd[1]: Started LSB: Brings up/down network automatically. Apr 26 18:53:25 musique loadcpufreq[518]: Loading cpufreq kernel modules...done (none). Apr 26 18:53:25 musique systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 26 18:53:25 musique systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 26 18:53:25 musique ntpd[600]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 26 18:53:25 musique ntpd[600]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Apr 26 18:53:25 musique systemd[1]: Started Network Time Service. Apr 26 18:53:25 musique ntpd[662]: proto: precision = 1.458 usec (-19) Apr 26 18:53:25 musique cpufrequtils[650]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 26 18:53:25 musique systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 26 18:53:25 musique ntpd[662]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 26 18:53:25 musique ntpd[662]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 26 18:53:25 musique ntpd[662]: Listen and drop on 0 v6wildcard [::]:123 Apr 26 18:53:25 musique ntpd[662]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 26 18:53:25 musique ntpd[662]: Listen normally on 2 lo 127.0.0.1:123 Apr 26 18:53:25 musique ntpd[662]: Listening on routing socket on fd #19 for interface updates Apr 26 18:53:25 musique ntpd[662]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 26 18:53:25 musique ntpd[662]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 26 18:53:26 musique systemd[1]: systemd-rfkill.service: Succeeded. Apr 26 18:53:26 musique ntpd[662]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 26 18:53:26 musique bthelper[603]: Can't init device hci0: Connection timed out (110) Apr 26 18:53:26 musique systemd[1]: bthelper@hci0.service: Main process exited, code=exited, status=1/FAILURE Apr 26 18:53:26 musique systemd[1]: bthelper@hci0.service: Failed with result 'exit-code'. Apr 26 18:53:26 musique systemd[1]: Failed to start Raspberry Pi bluetooth helper. Apr 26 18:53:26 musique kernel: Bluetooth: hci0: Opcode 0x1002 failed: -110 Apr 26 18:53:26 musique kernel: Bluetooth: hci0: command 0x1002 tx timeout Apr 26 18:53:26 musique nmbd[605]: [2024/04/26 18:53:26.919282, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 26 18:53:26 musique systemd[1]: Starting Bluetooth service... Apr 26 18:53:26 musique nmbd[605]: started asyncdns process 674 Apr 26 18:53:26 musique nmbd[605]: [2024/04/26 18:53:26.921585, 0] ../lib/util/become_daemon.c:149(daemon_status) Apr 26 18:53:26 musique nmbd[605]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Apr 26 18:53:26 musique nmbd[605]: [2024/04/26 18:53:26.921741, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Apr 26 18:53:26 musique nmbd[605]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 26 18:53:27 musique bluetoothd[673]: Bluetooth daemon 5.50 Apr 26 18:53:27 musique bluetoothd[673]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Apr 26 18:53:27 musique systemd[1]: Started Bluetooth service. Apr 26 18:53:27 musique systemd[1]: Reached target Bluetooth. Apr 26 18:53:27 musique bluetoothd[673]: Starting SDP server Apr 26 18:53:27 musique bluetoothd[673]: Excluding (cli) sap Apr 26 18:53:27 musique bluetoothd[673]: Bluetooth management interface 1.22 initialized Apr 26 18:53:27 musique dbus-daemon[504]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=673 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Apr 26 18:53:27 musique kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 26 18:53:27 musique kernel: Bluetooth: BNEP filters: protocol multicast Apr 26 18:53:27 musique kernel: Bluetooth: BNEP socket layer initialized Apr 26 18:53:27 musique kernel: Bluetooth: MGMT ver 1.22 Apr 26 18:53:27 musique kernel: Bluetooth: hci0: Frame reassembly failed (-84) Apr 26 18:53:27 musique kernel: Bluetooth: hci0: unexpected event for opcode 0x1002 Apr 26 18:53:27 musique systemd[1]: Starting Hostname Service... Apr 26 18:53:27 musique dbus-daemon[504]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 26 18:53:27 musique systemd[1]: Started Hostname Service. Apr 26 18:53:27 musique wireless.js[503]: Cleaning previous... Apr 26 18:53:27 musique ntpd[662]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 26 18:53:27 musique sudo[684]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 26 18:53:27 musique sudo[684]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:27 musique sudo[684]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:27 musique sudo[686]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 26 18:53:27 musique sudo[686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:28 musique sudo[686]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:28 musique wireless.js[503]: Stopped aP Apr 26 18:53:28 musique sudo[693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 26 18:53:28 musique sudo[693]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:28 musique kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 26 18:53:28 musique sudo[693]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:28 musique sudo[695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 26 18:53:28 musique sudo[695]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:28 musique sudo[695]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:28 musique sudo[702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 26 18:53:28 musique sudo[702]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:28 musique sudo[702]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:28 musique sudo[704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 26 18:53:28 musique sudo[704]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:28 musique ntpd[662]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 26 18:53:29 musique bluetoothd[673]: Loading LTKs timed out for hci0 Apr 26 18:53:29 musique bluetoothd[673]: Failed to set mode: Authentication Failed (0x05) Apr 26 18:53:29 musique kernel: Bluetooth: hci0: Opcode 0x0c03 failed: -110 Apr 26 18:53:29 musique sudo[704]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:29 musique wireless.js[503]: Start wireless flow Apr 26 18:53:29 musique wireless.js[503]: Stopped hotspot (if there).. Apr 26 18:53:29 musique sudo[709]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 26 18:53:29 musique sudo[709]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:29 musique sudo[709]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:29 musique sudo[711]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 26 18:53:29 musique sudo[711]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:29 musique ntpd[662]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 26 18:53:29 musique sudo[711]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:29 musique wireless.js[503]: DHCP IP Apr 26 18:53:29 musique wireless.js[503]: Start ap Apr 26 18:53:29 musique wpa_supplicant[713]: Successfully initialized wpa_supplicant Apr 26 18:53:29 musique sudo[714]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 26 18:53:29 musique sudo[714]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:29 musique kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 26 18:53:29 musique dhcpcd[715]: dev: loaded udev Apr 26 18:53:29 musique volumio-remote-updater[514]: [2024-04-26 18:53:29] [info] asio async_connect error: system:111 (Connection refused) Apr 26 18:53:29 musique volumio-remote-updater[514]: [2024-04-26 18:53:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 26 18:53:29 musique volumio-remote-updater[514]: [2024-04-26 18:53:29] [error] handle_connect error: Underlying Transport Error Apr 26 18:53:29 musique dhcpcd-run-hooks[733]: wlan0: starting wpa_supplicant Apr 26 18:53:30 musique dhcpcd-run-hooks[738]: wlan0: failed to start wpa_supplicant Apr 26 18:53:30 musique dhcpcd-run-hooks[739]: 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 Apr 26 18:53:30 musique dhcpcd[715]: wlan0: connected to Access Point `' Apr 26 18:53:30 musique dhcpcd[715]: no interfaces have a carrier Apr 26 18:53:30 musique dhcpcd[715]: forked to background, child pid 749 Apr 26 18:53:30 musique dhcpcd[749]: eth0: waiting for carrier Apr 26 18:53:30 musique dhcpcd[749]: wlan0: waiting for carrier Apr 26 18:53:30 musique sudo[714]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:30 musique wpa_supplicant[737]: wlan0: Trying to associate with SSID 'Freebox-A0FB9E' Apr 26 18:53:30 musique wireless.js[503]: trying... Apr 26 18:53:30 musique sudo[751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:30 musique sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:30 musique sudo[751]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:31 musique dhcpcd[749]: wlan0: carrier acquired Apr 26 18:53:31 musique wpa_supplicant[737]: wlan0: Associated with 3a:07:16:79:df:00 Apr 26 18:53:31 musique dhcpcd[749]: wlan0: connected to Access Point `Freebox-A0FB9E' Apr 26 18:53:31 musique wpa_supplicant[737]: wlan0: CTRL-EVENT-CONNECTED - Connection to 3a:07:16:79:df:00 completed [id=0 id_str=] Apr 26 18:53:31 musique wpa_supplicant[737]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 26 18:53:31 musique dhcpcd[749]: DUID 00:01:00:01:2c:a6:b7:35:b8:27:eb:91:7e:18 Apr 26 18:53:31 musique dhcpcd[749]: wlan0: IAID eb:91:7e:18 Apr 26 18:53:31 musique dhcpcd[749]: wlan0: adding address fe80::eb4c:22e2:672f:4829 Apr 26 18:53:31 musique dhcpcd[749]: ipv6_addaddr1: Permission denied Apr 26 18:53:31 musique dhcpcd[749]: wlan0: carrier lost Apr 26 18:53:31 musique dhcpcd[749]: wlan0: carrier acquired Apr 26 18:53:31 musique dhcpcd[749]: wlan0: IAID eb:91:7e:18 Apr 26 18:53:31 musique dhcpcd[749]: wlan0: soliciting an IPv6 router Apr 26 18:53:31 musique wireless.js[503]: trying... Apr 26 18:53:31 musique sudo[766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:31 musique sudo[766]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:31 musique sudo[766]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:31 musique dhcpcd[749]: wlan0: rebinding lease of 192.168.1.110 Apr 26 18:53:32 musique dhcpcd[749]: wlan0: probing address 192.168.1.110/24 Apr 26 18:53:32 musique wireless.js[503]: trying... Apr 26 18:53:32 musique sudo[769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:32 musique sudo[769]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:32 musique sudo[769]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:33 musique wireless.js[503]: trying... Apr 26 18:53:33 musique sudo[772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:33 musique sudo[772]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:33 musique sudo[772]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:34 musique wireless.js[503]: trying... Apr 26 18:53:34 musique sudo[775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:34 musique sudo[775]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:34 musique sudo[775]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:35 musique wireless.js[503]: trying... Apr 26 18:53:35 musique sudo[778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:35 musique sudo[778]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:35 musique sudo[778]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:36 musique dhcpcd[749]: wlan0: leased 192.168.1.110 for 43200 seconds Apr 26 18:53:36 musique avahi-daemon[507]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.110. Apr 26 18:53:36 musique dhcpcd[749]: wlan0: adding route to 192.168.1.0/24 Apr 26 18:53:36 musique avahi-daemon[507]: New relevant interface wlan0.IPv4 for mDNS. Apr 26 18:53:36 musique dhcpcd[749]: wlan0: adding default route via 192.168.1.254 Apr 26 18:53:36 musique avahi-daemon[507]: Registering new address record for 192.168.1.110 on wlan0.IPv4. Apr 26 18:53:36 musique wireless.js[503]: trying... Apr 26 18:53:36 musique sudo[785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 26 18:53:36 musique sudo[785]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:36 musique sudo[785]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:36 musique wireless.js[503]: Connected to: ----Freebox-A0FB9E Apr 26 18:53:36 musique wireless.js[503]: ---- Apr 26 18:53:36 musique sudo[800]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 18:53:36 musique sudo[800]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:36 musique sudo[800]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:36 musique nmbd[605]: [2024/04/26 18:53:36.928276, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 26 18:53:36 musique wireless.js[503]: ... joined AP, wlan0 IPv4 is 192.168.1.110, ipV6 is undefined Apr 26 18:53:36 musique wireless.js[503]: It's done! AP Apr 26 18:53:36 musique systemd[1]: Started Samba NMB Daemon. Apr 26 18:53:36 musique nmbd[605]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 26 18:53:36 musique systemd[1]: Starting Samba Winbind Daemon... Apr 26 18:53:37 musique systemd[1]: Started Wireless Services. Apr 26 18:53:37 musique kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 26 18:53:37 musique systemd[1]: Started Volumio Backend Module. Apr 26 18:53:37 musique systemd[1]: Started Volumio Cpu Tweaker. Apr 26 18:53:37 musique volumio-cpu-tweak[812]: Setting RT Priority for mpd Apr 26 18:53:37 musique volumio-cpu-tweak[812]: pid 35's current scheduling policy: SCHED_OTHER Apr 26 18:53:37 musique volumio-cpu-tweak[812]: pid 35's current scheduling priority: 0 Apr 26 18:53:37 musique volumio-cpu-tweak[812]: Setting MPD Affinity Apr 26 18:53:37 musique volumio-cpu-tweak[812]: pid 3's current affinity mask: f Apr 26 18:53:37 musique volumio-cpu-tweak[812]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Apr 26 18:53:37 musique volumio-cpu-tweak[812]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Apr 26 18:53:37 musique systemd[1]: volumio_cpu_tweak.service: Succeeded. Apr 26 18:53:37 musique volumio-remote-updater[514]: [2024-04-26 18:53:37] [info] asio async_connect error: system:111 (Connection refused) Apr 26 18:53:37 musique volumio-remote-updater[514]: [2024-04-26 18:53:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 26 18:53:37 musique volumio-remote-updater[514]: [2024-04-26 18:53:37] [error] handle_connect error: Underlying Transport Error Apr 26 18:53:37 musique winbindd[806]: [2024/04/26 18:53:37.450021, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 26 18:53:37 musique winbindd[806]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 26 18:53:37 musique winbindd[806]: [2024/04/26 18:53:37.490986, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 26 18:53:37 musique systemd[1]: Started Samba Winbind Daemon. Apr 26 18:53:37 musique winbindd[806]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 26 18:53:37 musique systemd[1]: Starting Samba SMB Daemon... Apr 26 18:53:38 musique systemd[1]: Started Samba SMB Daemon. Apr 26 18:53:38 musique smbd[831]: [2024/04/26 18:53:38.255865, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 26 18:53:38 musique smbd[831]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 26 18:53:38 musique systemd[1]: Reached target Multi-User System. Apr 26 18:53:38 musique systemd[1]: Reached target Graphical Interface. Apr 26 18:53:38 musique systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 26 18:53:38 musique systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 26 18:53:38 musique systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 26 18:53:38 musique systemd[1]: Startup finished in 10.637s (kernel) + 25.684s (userspace) = 36.321s. Apr 26 18:53:38 musique ntpd[662]: Listen normally on 3 wlan0 192.168.1.110:123 Apr 26 18:53:38 musique ntpd[662]: new interface(s) found: waking up resolver Apr 26 18:53:40 musique volumio[811]: info: ------------------------------------------- Apr 26 18:53:40 musique volumio[811]: info: ----- Volumio3 ---- Apr 26 18:53:40 musique volumio[811]: info: ------------------------------------------- Apr 26 18:53:40 musique volumio[811]: info: ----- System startup ---- Apr 26 18:53:40 musique volumio[811]: info: ------------------------------------------- Apr 26 18:53:41 musique volumio[811]: info: MYVOLUMIO Environment detected Apr 26 18:53:41 musique volumio[811]: info: Plugin folders cleanup Apr 26 18:53:41 musique volumio[811]: info: Scanning into folder /volumio/app/plugins/ Apr 26 18:53:41 musique volumio[811]: info: Scanning category audio_interface Apr 26 18:53:41 musique volumio[811]: info: Scanning category miscellanea Apr 26 18:53:41 musique volumio[811]: info: Scanning category music_service Apr 26 18:53:41 musique volumio[811]: info: Scanning category plugins.json Apr 26 18:53:41 musique volumio[811]: info: Scanning category system_controller Apr 26 18:53:41 musique volumio[811]: info: Scanning category user_interface Apr 26 18:53:41 musique volumio[811]: info: Scanning into folder /data/plugins/ Apr 26 18:53:41 musique volumio[811]: info: Plugin folders cleanup completed Apr 26 18:53:41 musique volumio[811]: info: ------------------------------------------- Apr 26 18:53:41 musique volumio[811]: info: ----- Core plugins startup ---- Apr 26 18:53:41 musique volumio[811]: info: ------------------------------------------- Apr 26 18:53:41 musique volumio[811]: info: Loading plugins from folder /volumio/app/plugins/ Apr 26 18:53:41 musique volumio[811]: info: Adding plugin upnp to MyMusic Plugins Apr 26 18:53:41 musique volumio[811]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 26 18:53:41 musique volumio[811]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 26 18:53:41 musique volumio[811]: info: Loading plugins from folder /data/plugins/ Apr 26 18:53:41 musique volumio[811]: info: Loading plugin "system"... Apr 26 18:53:41 musique volumio[811]: info: Loading plugin "appearance"... Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "network"... Apr 26 18:53:43 musique volumio[811]: info: Refreshing Cached IP Addresses Apr 26 18:53:43 musique sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 18:53:43 musique sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "services"... Apr 26 18:53:43 musique sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 18:53:43 musique sudo[856]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:43 musique sudo[854]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "alsa_controller"... Apr 26 18:53:43 musique sudo[856]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:43 musique sudo[858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 26 18:53:43 musique sudo[858]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:43 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "wizard"... Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "networkfs"... Apr 26 18:53:43 musique volumio[811]: info: Starting Udev Watcher for removable devices Apr 26 18:53:43 musique sudo[865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=tv,password=aucun,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.100/media /mnt/NAS/NAS Apr 26 18:53:43 musique sudo[865]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:43 musique volumio[811]: info: Ignoring mount for partition: boot Apr 26 18:53:43 musique volumio[811]: info: Ignoring mount for partition: volumio Apr 26 18:53:43 musique volumio[811]: info: Ignoring mount for partition: volumio_data Apr 26 18:53:43 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "volumio_command_line_client"... Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "upnp"... Apr 26 18:53:43 musique volumio[811]: info: [1714150423933] Starting Upmpd Daemon Apr 26 18:53:43 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "my_music"... Apr 26 18:53:43 musique volumio[811]: info: Loading plugin "mpd"... Apr 26 18:53:44 musique kernel: Key type cifs.spnego registered Apr 26 18:53:44 musique kernel: Key type cifs.idmap registered Apr 26 18:53:44 musique kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Apr 26 18:53:44 musique kernel: CIFS: Attempting to mount \\192.168.1.100\media Apr 26 18:53:44 musique volumio[811]: info: Loading plugin "upnp_browser"... Apr 26 18:53:44 musique sudo[865]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:44 musique sudo[858]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:44 musique volumio[811]: info: Loading plugin "alarm-clock"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "airplay_emulation"... Apr 26 18:53:45 musique volumio[811]: info: Starting Shairport Sync Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "last_100"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "webradio"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "i2s_dacs"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "volumiodiscovery"... Apr 26 18:53:45 musique volumio[811]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 26 18:53:45 musique volumio[811]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 18:53:45 musique volumio[811]: *** WARNING *** For more information see Apr 26 18:53:45 musique volumio[811]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 26 18:53:45 musique volumio[811]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 18:53:45 musique volumio[811]: *** WARNING *** For more information see Apr 26 18:53:45 musique node[811]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 26 18:53:45 musique node[811]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 18:53:45 musique node[811]: *** WARNING *** For more information see Apr 26 18:53:45 musique node[811]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 26 18:53:45 musique node[811]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 26 18:53:45 musique node[811]: *** WARNING *** For more information see Apr 26 18:53:45 musique volumio[811]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 26 18:53:45 musique volumio[811]: info: Discovery: Started advertising with name: Musique Apr 26 18:53:45 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "outputs"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "albumart"... Apr 26 18:53:45 musique volumio[811]: info: Plugin example_plugin is not enabled Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "inputs"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "updater_comm"... Apr 26 18:53:45 musique volumio[811]: info: Plugin mpdemulation is not enabled Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "rest_api"... Apr 26 18:53:45 musique volumio[811]: info: Loading plugin "websocket"... Apr 26 18:53:45 musique volumio[811]: info: Loading i18n strings for locale fr Apr 26 18:53:45 musique volumio[811]: Updating browse sources language Apr 26 18:53:45 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 18:53:46 musique volumio[811]: Forking 3 albumart workers Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::initPlayerControls Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 18:53:46 musique volumio[811]: Express server listening on port 3000 Apr 26 18:53:46 musique volumio[811]: [Metrics] WebUI: 7s 133.33ms Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::resetVolumioState Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::getcurrentVolume Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 1 Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 2 Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 3 Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 4 Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 5 Apr 26 18:53:46 musique volumio[811]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 26 18:53:46 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 6 Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 18:53:46 musique volumio[811]: info: Reloading queue from file Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::setRepeat null single undefined Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::pushState Apr 26 18:53:46 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::volumioPushState Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::setRandom null Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::pushState Apr 26 18:53:46 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::volumioPushState Apr 26 18:53:46 musique volumio[811]: info: Setting Device type: Raspberry PI Apr 26 18:53:46 musique volumio[811]: info: VolumeController:: Volume=undefined Mute =false Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::pushState Apr 26 18:53:46 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::volumioPushState Apr 26 18:53:46 musique volumio[811]: info: CoreStateMachine::updateTrackBlock Apr 26 18:53:46 musique volumio[811]: info: CorePlayQueue::getTrackBlock Apr 26 18:53:46 musique volumio[811]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 26 18:53:47 musique volumio[811]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 26 18:53:47 musique volumio[811]: info: Discovery: adding 5b4860b6-dcf4-4990-9ae2-b185172705de Apr 26 18:53:47 musique volumio[811]: info: Discovery: Found device Musique Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: Starting albumart workers Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetVisibleSources Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 26 18:53:47 musique volumio[811]: info: Received Get System Info Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 18:53:47 musique volumio[811]: info: Discovery: Getting this device information Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: Starting albumart workers Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: Starting albumart workers Apr 26 18:53:47 musique volumio[811]: info: Listing playlists Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetQueue Apr 26 18:53:47 musique volumio[811]: info: CoreStateMachine::getQueue Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getQueue Apr 26 18:53:47 musique volumio[811]: info: Received Get System Info Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 18:53:47 musique volumio[811]: info: Discovery: Getting this device information Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: VolumeController:: Volume=undefined Mute =false Apr 26 18:53:47 musique volumio[811]: info: CoreStateMachine::pushState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioPushState Apr 26 18:53:47 musique volumio[811]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.157 UA: okhttp/4.9.2 Total Clients: 7 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::volumioGetState Apr 26 18:53:47 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 26 18:53:47 musique volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 26 18:53:47 musique volumio-remote-updater[514]: [2024-04-26 18:53:47] [connect] Successful connection Apr 26 18:53:47 musique volumio-remote-updater[514]: [2024-04-26 18:53:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714150427 101 Apr 26 18:53:47 musique volumio[811]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 Apr 26 18:53:49 musique volumio[811]: info: CoreCommandRouter::volumioPlay Apr 26 18:53:49 musique volumio[811]: info: CoreStateMachine::play index undefined Apr 26 18:53:49 musique volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 18:53:49 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:49 musique volumio[811]: info: CoreStateMachine::startPlaybackTimer Apr 26 18:53:49 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:49 musique volumio[811]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/musique/Divers/Outcast-Hey Yah.mp3 Apr 26 18:53:49 musique volumio[811]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 18:53:51 musique systemd[1]: systemd-fsckd.service: Succeeded. Apr 26 18:53:53 musique sh[402]: timed out Apr 26 18:53:53 musique dhcpcd[447]: timed out Apr 26 18:53:53 musique sh[402]: dhcpcd exited Apr 26 18:53:53 musique dhcpcd[447]: dhcpcd exited Apr 26 18:53:53 musique sh[402]: ifup: failed to bring up eth0 Apr 26 18:53:53 musique systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 26 18:53:53 musique systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 26 18:53:53 musique sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 26 18:53:53 musique sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:53 musique sudo[963]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:53 musique sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 26 18:53:53 musique sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:53 musique sudo[965]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:54 musique sudo[969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 26 18:53:54 musique sudo[969]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 18:53:54 musique systemd[1]: Started UPnP Renderer front-end to MPD. Apr 26 18:53:54 musique sudo[969]: pam_unix(sudo:session): session closed for user root Apr 26 18:53:54 musique volumio[811]: info: Upmpdcli Daemon Started Apr 26 18:53:54 musique volumio[811]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 26 18:53:54 musique volumio[811]: info: CoreCommandRouter::volumioPlay Apr 26 18:53:54 musique volumio[811]: info: CoreStateMachine::play index undefined Apr 26 18:53:54 musique volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 18:53:54 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:54 musique volumio[811]: info: CoreStateMachine::startPlaybackTimer Apr 26 18:53:54 musique volumio[811]: info: CorePlayQueue::getTrack 0 Apr 26 18:53:54 musique volumio[811]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/musique/Divers/Outcast-Hey Yah.mp3 Apr 26 18:53:54 musique volumio[811]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 18:53:57 musique systemd[1]: systemd-hostnamed.service: Succeeded. Apr 26 18:53:58 musique volumio[811]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::ClearQueue Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::stop Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 18:53:58 musique volumio[811]: info: CorePlayQueue::clearPlayQueue Apr 26 18:53:58 musique volumio[811]: info: CorePlayQueue::saveQueue Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioPushQueue Apr 26 18:53:58 musique volumio[811]: info: Play playlist Pour rire Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioClearQueue Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::ClearQueue Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::stop Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 18:53:58 musique volumio[811]: info: CorePlayQueue::clearPlayQueue Apr 26 18:53:58 musique volumio[811]: info: CorePlayQueue::saveQueue Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioPushState Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioPushQueue Apr 26 18:53:58 musique volumio[811]: info: CoreCommandRouter::volumioAddQueueItems Apr 26 18:53:58 musique volumio[811]: info: CoreStateMachine::addQueueItems Apr 26 18:53:58 musique volumio[811]: info: CorePlayQueue::addQueueItems Apr 26 18:53:58 musique volumio[811]: info: Preload queue cleared Apr 26 18:53:58 musique volumio[811]: info: Adding Item to queue: mnt/NAS/NAS/musique/Divers/Outcast-Hey Yah.mp3 Apr 26 18:53:58 musique volumio[811]: info: Exploding uri mnt/NAS/NAS/musique/Divers/Outcast-Hey Yah.mp3 in service mpd Apr 26 18:53:59 musique volumio[811]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 18:53:59 musique volumio[811]: TypeError: Cannot read property 'then' of undefined Apr 26 18:53:59 musique volumio[811]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Apr 26 18:53:59 musique volumio[811]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Apr 26 18:53:59 musique volumio[811]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Apr 26 18:53:59 musique volumio[811]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Apr 26 18:53:59 musique volumio[811]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Apr 26 18:53:59 musique volumio[811]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Apr 26 18:53:59 musique volumio[811]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Apr 26 18:53:59 musique volumio[811]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:447:28) Apr 26 18:53:59 musique volumio[811]: at /volumio/app/playlistManager.js:726:30 Apr 26 18:53:59 musique volumio[811]: at /volumio/node_modules/jsonfile/index.js:46:5 Apr 26 18:53:59 musique volumio[811]: at /volumio/node_modules/graceful-fs/graceful-fs.js:123:16 Apr 26 18:53:59 musique volumio[811]: at FSReqCallback.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:63:3) Apr 26 18:53:59 musique volumio[811]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 18:53:59 musique sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-26 18:52 Apr 26 18:53:59 musique sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"