-- Logs begin at Wed 2024-04-17 01:28:55 UTC, end at Wed 2024-04-17 01:30:25 UTC. -- Apr 17 01:28:59 volumio systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Apr 17 01:28:59 volumio systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Apr 17 01:29:00 volumio kernel: uart-pl011 fe201000.serial: no DMA platform data Apr 17 01:29:00 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 17 01:29:00 volumio systemd[1]: Starting Music Player Daemon... Apr 17 01:29:00 volumio systemd[1]: Starting D-Bus System Message Bus... Apr 17 01:29:00 volumio systemd[1]: Started D-Bus System Message Bus. Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio triggerhappy[630]: Unable to parse trigger line: Apr 17 01:29:00 volumio btuart[595]: Patch not found for BCM4345C0, continue anyway Apr 17 01:29:00 volumio dhcpcd[650]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Apr 17 01:29:00 volumio dhcpcd[650]: /var/run/dhcpcd-eth0.pid ... failed! Apr 17 01:29:00 volumio ifplugd(eth0)[724]: ifplugd 0.28 initializing. Apr 17 01:29:00 volumio ifplugd(eth0)[724]: Using interface eth0/DC:A6:32:BC:BE:A2 with driver (version: v2.0) Apr 17 01:29:00 volumio ifplugd(eth0)[724]: Using detection mode: SIOCETHTOOL Apr 17 01:29:00 volumio ifplugd(eth0)[724]: Initialization complete, link beat not detected. Apr 17 01:29:00 volumio avahi-daemon[652]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Apr 17 01:29:00 volumio avahi-daemon[652]: Successfully dropped root privileges. Apr 17 01:29:00 volumio avahi-daemon[652]: avahi-daemon 0.6.31 starting up. Apr 17 01:29:00 volumio ntpd[703]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Apr 17 01:29:00 volumio ntp[639]: Starting NTP server: ntpd. Apr 17 01:29:00 volumio ifplugd[642]: Network Interface Plugging Daemon...start eth0...done. Apr 17 01:29:00 volumio ntpd[731]: proto: precision = 1.203 usec Apr 17 01:29:00 volumio ntpd[731]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 17 01:29:00 volumio ntpd[731]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 17 01:29:00 volumio ntpd[731]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 17 01:29:00 volumio ntpd[731]: peers refreshed Apr 17 01:29:00 volumio ntpd[731]: Listening on routing socket on fd #19 for interface updates Apr 17 01:29:00 volumio loadcpufreq[641]: Loading cpufreq kernel modules...done (none). Apr 17 01:29:00 volumio avahi-daemon[652]: Successfully called chroot(). Apr 17 01:29:00 volumio avahi-daemon[652]: Successfully dropped remaining capabilities. Apr 17 01:29:00 volumio avahi-daemon[652]: No service file found in /etc/avahi/services. Apr 17 01:29:00 volumio dbus[669]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 17 01:29:00 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 17 01:29:00 volumio systemd[1]: Starting Permit User Sessions... Apr 17 01:29:00 volumio avahi-daemon[652]: Network interface enumeration completed. Apr 17 01:29:00 volumio avahi-daemon[652]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Apr 17 01:29:00 volumio avahi-daemon[652]: Server startup complete. Host name is volumio.local. Local service cookie is 688805724. Apr 17 01:29:00 volumio systemd[1]: Started Restore Sound Card State. Apr 17 01:29:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 17 01:29:00 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:00 volumio systemd[1]: Started /etc/rc.local Compatibility. Apr 17 01:29:00 volumio systemd[1]: Started LSB: triggerhappy hotkey daemon. Apr 17 01:29:00 volumio systemd[1]: Started LSB: Start NTP daemon. Apr 17 01:29:00 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 17 01:29:00 volumio systemd[1]: Started LSB: Brings up/down network automatically. Apr 17 01:29:00 volumio systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Apr 17 01:29:00 volumio systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Apr 17 01:29:00 volumio systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Apr 17 01:29:00 volumio systemd[1]: Unit dhcpcd.service entered failed state. Apr 17 01:29:00 volumio systemd[1]: Started Permit User Sessions. Apr 17 01:29:00 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 17 01:29:00 volumio systemd[1]: Stopping cd.service... Apr 17 01:29:00 volumio systemd[1]: Starting cd.service... Apr 17 01:29:00 volumio dbus[669]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Apr 17 01:29:00 volumio systemd[1]: Started cd.service. Apr 17 01:29:00 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 17 01:29:00 volumio systemd[1]: Starting Hold until boot process finishes up... Apr 17 01:29:00 volumio systemd-logind[623]: New seat seat0. Apr 17 01:29:00 volumio kernel: Bluetooth: Core ver 2.22 Apr 17 01:29:00 volumio kernel: NET: Registered protocol family 31 Apr 17 01:29:00 volumio kernel: Bluetooth: HCI device and connection manager initialized Apr 17 01:29:00 volumio kernel: Bluetooth: HCI socket layer initialized Apr 17 01:29:00 volumio kernel: Bluetooth: L2CAP socket layer initialized Apr 17 01:29:00 volumio kernel: Bluetooth: SCO socket layer initialized Apr 17 01:29:00 volumio sudo[656]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Apr 17 01:29:00 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 17 01:29:00 volumio volumio[741]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 17 01:29:00 volumio sudo[656]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:00 volumio kernel: Bluetooth: HCI UART driver ver 2.3 Apr 17 01:29:00 volumio kernel: Bluetooth: HCI UART protocol H4 registered Apr 17 01:29:00 volumio kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Apr 17 01:29:00 volumio kernel: Bluetooth: HCI UART protocol Broadcom registered Apr 17 01:29:00 volumio btuart[595]: bcm43xx_init Apr 17 01:29:00 volumio btuart[595]: Set BDADDR UART: b8:27:eb:c4:84:ff Apr 17 01:29:00 volumio btuart[595]: Set Controller UART speed to 3000000 bit/s Apr 17 01:29:00 volumio btuart[595]: Device setup complete Apr 17 01:29:00 volumio systemd[1]: Received SIGRTMIN+21 from PID 246 (plymouthd). Apr 17 01:29:00 volumio systemd[1]: Started Configure Bluetooth Modems connected by UART. Apr 17 01:29:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 17 01:29:00 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:00 volumio systemd[1]: Started Hold until boot process finishes up. Apr 17 01:29:00 volumio cpufrequtils[742]: CPUFreq Utilities: Setting performance CPUFreq governor...error: unexpectedly disconnected from boot status daemon Apr 17 01:29:00 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Apr 17 01:29:00 volumio sudo[656]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:00 volumio systemd[1]: Started Login Service. Apr 17 01:29:00 volumio systemd-udevd[765]: failed to execute '/usr/bin/hciconfig' '/usr/bin/hciconfig hci0 up': No such file or directory Apr 17 01:29:00 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 17 01:29:00 volumio cpufrequtils[742]: CPU0...CPU1...CPU2...CPU3...done. Apr 17 01:29:00 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 17 01:29:00 volumio systemd[1]: Stopping cd.service... Apr 17 01:29:00 volumio systemd[1]: Starting cd.service... Apr 17 01:29:00 volumio systemd[1]: Started cd.service. Apr 17 01:29:00 volumio systemd[1]: Starting Disk Manager (legacy version)... Apr 17 01:29:00 volumio systemd[1]: Starting Getty on tty1... Apr 17 01:29:00 volumio systemd[1]: Started Getty on tty1. Apr 17 01:29:00 volumio systemd[1]: Starting Login Prompts. Apr 17 01:29:00 volumio systemd[1]: Reached target Login Prompts. Apr 17 01:29:00 volumio volumio[776]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 17 01:29:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 17 01:29:00 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:01 volumio systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1... Apr 17 01:29:01 volumio systemd[1]: Starting Bluetooth service... Apr 17 01:29:01 volumio systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1. Apr 17 01:29:01 volumio dbus[669]: [system] Successfully activated service 'org.freedesktop.UDisks' Apr 17 01:29:01 volumio systemd[1]: Started Disk Manager (legacy version). Apr 17 01:29:01 volumio dbus[669]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Apr 17 01:29:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 17 01:29:01 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Apr 17 01:29:01 volumio systemd[1]: Stopping cd.service... Apr 17 01:29:01 volumio systemd[1]: Starting cd.service... Apr 17 01:29:01 volumio systemd[1]: Started cd.service. Apr 17 01:29:01 volumio volumio[786]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 17 01:29:01 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 17 01:29:01 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:01 volumio polkitd[785]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 17 01:29:01 volumio dbus[669]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 17 01:29:01 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Apr 17 01:29:01 volumio bluetoothd[783]: Bluetooth daemon 5.23 Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/mmcblk0p3 inserted Apr 17 01:29:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 17 01:29:01 volumio systemd[1]: Stopping cd.service... Apr 17 01:29:01 volumio systemd[1]: Starting cd.service... Apr 17 01:29:01 volumio systemd[1]: Started cd.service. Apr 17 01:29:01 volumio systemd[1]: Started Bluetooth service. Apr 17 01:29:01 volumio systemd[1]: Starting Bluetooth. Apr 17 01:29:01 volumio systemd[1]: Reached target Bluetooth. Apr 17 01:29:01 volumio bluetoothd[783]: Starting SDP server Apr 17 01:29:01 volumio bluetoothd[783]: Excluding (cli) sap Apr 17 01:29:01 volumio volumio[791]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 17 01:29:01 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 17 01:29:01 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sda inserted Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sdb inserted Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/mmcblk0 inserted Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sdb1 inserted Apr 17 01:29:01 volumio udisks-glue[597]: Trying to automount /dev/sdb1... Apr 17 01:29:01 volumio kernel: random: crng init done Apr 17 01:29:01 volumio kernel: random: 7 urandom warning(s) missed due to ratelimiting Apr 17 01:29:01 volumio kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 17 01:29:01 volumio udisks-glue[597]: Successfully automounted /dev/sdb1 at /media/C895-DFB8 Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sda1 inserted Apr 17 01:29:01 volumio udisks-glue[597]: Trying to automount /dev/sda1... Apr 17 01:29:01 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 17 01:29:01 volumio kernel: Bluetooth: BNEP filters: protocol multicast Apr 17 01:29:01 volumio kernel: Bluetooth: BNEP socket layer initialized Apr 17 01:29:01 volumio bluetoothd[783]: Bluetooth management interface 1.14 initialized Apr 17 01:29:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 17 01:29:01 volumio systemd[1]: Stopping cd.service... Apr 17 01:29:01 volumio systemd[1]: Starting cd.service... Apr 17 01:29:01 volumio systemd[1]: cd.service start request repeated too quickly, refusing to start. Apr 17 01:29:01 volumio systemd[1]: Failed to start cd.service. Apr 17 01:29:01 volumio systemd[1]: Unit cd.service entered failed state. Apr 17 01:29:01 volumio dbus[669]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Apr 17 01:29:01 volumio systemd[1]: Starting Hostname Service... Apr 17 01:29:01 volumio udisks-glue[597]: Successfully automounted /dev/sda1 at /media/AC97-5A0D Apr 17 01:29:01 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sdb1 mounted at /media/C895-DFB8 Apr 17 01:29:01 volumio udisks-glue[597]: Device file /dev/sda1 mounted at /media/AC97-5A0D Apr 17 01:29:01 volumio volumio-remote-updater[604]: Error: No active session Apr 17 01:29:01 volumio volumio-remote-updater[604]: [2024-04-17 01:29:01] [info] asio async_connect error: system:111 (Connection refused) Apr 17 01:29:01 volumio volumio-remote-updater[604]: [2024-04-17 01:29:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 17 01:29:01 volumio volumio-remote-updater[604]: [2024-04-17 01:29:01] [error] handle_connect error: Underlying Transport Error Apr 17 01:29:01 volumio systemd-hostnamed[796]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Apr 17 01:29:01 volumio dbus[669]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 17 01:29:01 volumio systemd[1]: Started Hostname Service. Apr 17 01:29:01 volumio volumio[598]: Could not open config: /tmp/upmpdcli.conf Apr 17 01:29:01 volumio haveged[593]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Apr 17 01:29:01 volumio haveged[593]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Apr 17 01:29:01 volumio haveged[593]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00101 Apr 17 01:29:01 volumio haveged[593]: haveged: fills: 0, generated: 0 Apr 17 01:29:01 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Apr 17 01:29:01 volumio systemd[1]: Unit upmpdcli.service entered failed state. Apr 17 01:29:01 volumio ntpd[731]: Deferring DNS for 0.debian.pool.ntp.org 1 Apr 17 01:29:01 volumio ntpd[731]: Deferring DNS for 1.debian.pool.ntp.org 1 Apr 17 01:29:01 volumio ntpd[731]: Deferring DNS for 2.debian.pool.ntp.org 1 Apr 17 01:29:01 volumio ntpd[731]: Deferring DNS for 3.debian.pool.ntp.org 1 Apr 17 01:29:01 volumio ntpd[809]: signal_no_reset: signal 17 had flags 4000000 Apr 17 01:29:03 volumio wireless.js[774]: Cleaning previous... Apr 17 01:29:03 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Apr 17 01:29:03 volumio systemd[1]: Stopped hotspot.service. Apr 17 01:29:03 volumio sudo[833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 17 01:29:03 volumio sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:03 volumio sudo[833]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:03 volumio sudo[842]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 17 01:29:03 volumio sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:03 volumio winbind[629]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 17 01:29:03 volumio winbind[629]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 17 01:29:03 volumio winbind[629]: Unable to setup corepath for winbindd: No such file or directory Apr 17 01:29:03 volumio winbind[629]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 17 01:29:03 volumio winbind[629]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 17 01:29:03 volumio winbind[629]: Unable to setup corepath for winbindd: No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbind[629]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbind[629]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../source3/winbindd/winbindd.c:1549(main) Apr 17 01:29:03 volumio winbind[629]: winbindd version 4.2.14-Debian started. Apr 17 01:29:03 volumio winbind[629]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 17 01:29:03 volumio winbind[629]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 17 01:29:03 volumio winbind[629]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 17 01:29:03 volumio winbind[629]: Unable to setup corepath for winbindd: No such file or directory Apr 17 01:29:03 volumio winbindd[831]: [2024/04/17 01:29:03.318509, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbindd[831]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio winbindd[831]: [2024/04/17 01:29:03.319078, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbindd[831]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03.318509, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbind[629]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio winbind[629]: [2024/04/17 01:29:03.319078, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbind[629]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 17 01:29:03 volumio nmbd[640]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 17 01:29:03 volumio nmbd[640]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 17 01:29:03 volumio nmbd[640]: Unable to setup corepath for nmbd: No such file or directory Apr 17 01:29:03 volumio nmbd[845]: [2024/04/17 01:29:03.349852, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[845]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[845]: [2024/04/17 01:29:03.350743, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[845]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[852]: [2024/04/17 01:29:03.354614, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Apr 17 01:29:03 volumio nmbd[852]: started asyncdns process 853 Apr 17 01:29:03 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Apr 17 01:29:03 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Apr 17 01:29:03 volumio nmbd[640]: [2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[640]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[640]: [2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[640]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[640]: [2024/04/17 01:29:03, 0] ../source3/nmbd/nmbd.c:908(main) Apr 17 01:29:03 volumio nmbd[640]: nmbd version 4.2.14-Debian started. Apr 17 01:29:03 volumio nmbd[640]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 17 01:29:03 volumio nmbd[640]: [2024/04/17 01:29:03.349852, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[640]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[640]: [2024/04/17 01:29:03.350743, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio nmbd[640]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 17 01:29:03 volumio nmbd[640]: . Apr 17 01:29:03 volumio nmbd[852]: [2024/04/17 01:29:03.812976, 0] ../lib/util/become_daemon.c:135(daemon_status) Apr 17 01:29:03 volumio nmbd[852]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Apr 17 01:29:03 volumio sudo[842]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:03 volumio winbind[629]: . Apr 17 01:29:03 volumio winbindd[867]: [2024/04/17 01:29:03.826563, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Apr 17 01:29:03 volumio winbindd[867]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 17 01:29:03 volumio systemd[1]: Started LSB: start Winbind daemon. Apr 17 01:29:03 volumio smbd[854]: Starting SMB/CIFS daemon: smbd[2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 17 01:29:03 volumio smbd[854]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 17 01:29:03 volumio smbd[854]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 17 01:29:03 volumio smbd[854]: Unable to setup corepath for smbd: No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03, 0] ../source3/smbd/server.c:1241(main) Apr 17 01:29:03 volumio smbd[854]: smbd version 4.2.14-Debian started. Apr 17 01:29:03 volumio smbd[854]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 17 01:29:03 volumio winbindd[867]: [2024/04/17 01:29:03.857814, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 17 01:29:03 volumio winbindd[867]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 17 01:29:03 volumio winbindd[870]: [2024/04/17 01:29:03.862503, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbindd[870]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 17 01:29:03 volumio smbd[863]: [2024/04/17 01:29:03.879336, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[863]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[863]: [2024/04/17 01:29:03.880223, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[863]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[863]: [2024/04/17 01:29:03.880406, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[863]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03.879336, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03.880223, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: [2024/04/17 01:29:03.880406, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio smbd[854]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:03 volumio smbd[854]: . Apr 17 01:29:03 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Apr 17 01:29:03 volumio wireless.js[774]: Stopped aP Apr 17 01:29:03 volumio wireless.js[774]: Start wireless flow Apr 17 01:29:03 volumio wireless.js[774]: Stopped hotspot (if there).. Apr 17 01:29:03 volumio sudo[875]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 17 01:29:03 volumio sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:03 volumio sudo[875]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:03 volumio winbindd[882]: [2024/04/17 01:29:03.946808, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbindd[882]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Apr 17 01:29:03 volumio ntpd_intres[809]: host name not found: 0.debian.pool.ntp.org Apr 17 01:29:03 volumio ntpd_intres[809]: host name not found: 1.debian.pool.ntp.org Apr 17 01:29:03 volumio ntpd_intres[809]: host name not found: 2.debian.pool.ntp.org Apr 17 01:29:03 volumio ntpd_intres[809]: host name not found: 3.debian.pool.ntp.org Apr 17 01:29:03 volumio sudo[886]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 17 01:29:03 volumio sudo[886]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:03 volumio sudo[886]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:03 volumio winbindd[895]: [2024/04/17 01:29:03.995360, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:03 volumio winbindd[895]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Apr 17 01:29:04 volumio wireless.js[774]: DHCP IP Apr 17 01:29:04 volumio wireless.js[774]: Start ap Apr 17 01:29:04 volumio sudo[896]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 17 01:29:04 volumio sudo[896]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:04 volumio dhcpcd[900]: version 6.0.5 starting Apr 17 01:29:04 volumio smbd[873]: [2024/04/17 01:29:04.048963, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 17 01:29:04 volumio smbd[873]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 17 01:29:04 volumio smbd[901]: [2024/04/17 01:29:04.053619, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 17 01:29:04 volumio smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 17 01:29:04 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 17 01:29:04 volumio wpa_supplicant[894]: Successfully initialized wpa_supplicant Apr 17 01:29:04 volumio dhcpcd[553]: eth0: carrier acquired Apr 17 01:29:04 volumio ifup[531]: dhcpcd[553]: eth0: carrier acquired Apr 17 01:29:04 volumio kernel: bcmgenet fd580000.genet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 17 01:29:04 volumio dhcpcd[900]: eth0: carrier acquired Apr 17 01:29:04 volumio dhcpcd[553]: eth0: soliciting an IPv6 router Apr 17 01:29:04 volumio ifup[531]: dhcpcd[553]: eth0: soliciting an IPv6 router Apr 17 01:29:04 volumio dhcpcd[900]: eth0: soliciting an IPv6 router Apr 17 01:29:04 volumio dhcpcd[553]: eth0: soliciting a DHCP lease Apr 17 01:29:04 volumio ifup[531]: dhcpcd[553]: eth0: soliciting a DHCP lease Apr 17 01:29:04 volumio ifup[531]: dhcpcd[553]: eth0: offered 192.168.68.110 from 192.168.68.1 Apr 17 01:29:04 volumio dhcpcd[553]: eth0: offered 192.168.68.110 from 192.168.68.1 Apr 17 01:29:04 volumio dhcpcd[900]: eth0: soliciting a DHCP lease Apr 17 01:29:04 volumio dhcpcd[900]: eth0: soliciting an IPv6 router Apr 17 01:29:04 volumio dhcpcd[900]: eth0: soliciting a DHCP lease Apr 17 01:29:04 volumio dhcpcd[900]: wlan0: waiting for carrier Apr 17 01:29:04 volumio dhcpcd[900]: eth0: offered 192.168.68.110 from 192.168.68.1 Apr 17 01:29:04 volumio ifplugd(eth0)[724]: Link beat detected. Apr 17 01:29:04 volumio ifplugd(eth0)[724]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 17 01:29:04 volumio ifplugd(eth0)[724]: client: /sbin/ifup: interface eth0 already configured Apr 17 01:29:05 volumio wireless.js[774]: trying... Apr 17 01:29:05 volumio ifplugd(eth0)[724]: Program executed successfully. Apr 17 01:29:05 volumio sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:05 volumio sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:05 volumio sudo[955]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:06 volumio wireless.js[774]: trying... Apr 17 01:29:06 volumio sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:06 volumio sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:06 volumio sudo[965]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:06 volumio volumio-remote-updater[604]: [2024-04-17 01:29:06] [info] asio async_connect error: system:111 (Connection refused) Apr 17 01:29:06 volumio volumio-remote-updater[604]: [2024-04-17 01:29:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 17 01:29:06 volumio volumio-remote-updater[604]: [2024-04-17 01:29:06] [error] handle_connect error: Underlying Transport Error Apr 17 01:29:06 volumio wpa_supplicant[947]: wlan0: Trying to associate with SSID 'deco-sl' Apr 17 01:29:07 volumio wireless.js[774]: trying... Apr 17 01:29:07 volumio sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:07 volumio sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:07 volumio sudo[974]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:08 volumio wireless.js[774]: trying... Apr 17 01:29:08 volumio sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:08 volumio sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:08 volumio sudo[983]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:09 volumio wireless.js[774]: trying... Apr 17 01:29:09 volumio sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:09 volumio sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:09 volumio sudo[992]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:09 volumio dhcpcd[900]: eth0: leased 192.168.68.110 for 7200 seconds Apr 17 01:29:09 volumio dhcpcd[900]: eth0: adding host route to 192.168.68.110 via 127.0.0.1 Apr 17 01:29:09 volumio dhcpcd[900]: eth0: adding route to 192.168.68.0/24 Apr 17 01:29:09 volumio dhcpcd[900]: eth0: adding default route via 192.168.68.1 Apr 17 01:29:09 volumio avahi-daemon[652]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.68.110. Apr 17 01:29:09 volumio avahi-daemon[652]: New relevant interface eth0.IPv4 for mDNS. Apr 17 01:29:09 volumio avahi-daemon[652]: Registering new address record for 192.168.68.110 on eth0.IPv4. Apr 17 01:29:09 volumio dhcpcd[900]: forked to background, child pid 1044 Apr 17 01:29:09 volumio sudo[896]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:09 volumio ifup[531]: dhcpcd[553]: eth0: leased 192.168.68.110 for 7200 seconds Apr 17 01:29:09 volumio dhcpcd[553]: eth0: leased 192.168.68.110 for 7200 seconds Apr 17 01:29:09 volumio dhcpcd[553]: eth0: adding host route to 192.168.68.110 via 127.0.0.1 Apr 17 01:29:09 volumio dhcpcd[553]: eth0: adding route to 192.168.68.0/24 Apr 17 01:29:09 volumio dhcpcd[553]: eth0: adding default route via 192.168.68.1 Apr 17 01:29:09 volumio dhcpcd[1044]: eth0: removing route to 192.168.68.0/24 Apr 17 01:29:09 volumio dhcpcd[1044]: eth0: removing default route via 192.168.68.1 Apr 17 01:29:09 volumio ifup[531]: dhcpcd[553]: eth0: adding host route to 192.168.68.110 via 127.0.0.1 Apr 17 01:29:09 volumio ifup[531]: dhcpcd[553]: eth0: adding route to 192.168.68.0/24 Apr 17 01:29:09 volumio ifup[531]: dhcpcd[553]: eth0: adding default route via 192.168.68.1 Apr 17 01:29:09 volumio dhcpcd[553]: forked to background, child pid 1073 Apr 17 01:29:09 volumio ifup[531]: dhcpcd[553]: forked to background, child pid 1073 Apr 17 01:29:09 volumio dhcpcd[1073]: eth0: removing route to 192.168.68.0/24 Apr 17 01:29:09 volumio dhcpcd[1073]: eth0: removing default route via 192.168.68.1 Apr 17 01:29:10 volumio wpa_supplicant[947]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Apr 17 01:29:10 volumio wireless.js[774]: trying... Apr 17 01:29:10 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:10 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:10 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:10 volumio systemd[1]: Started Music Player Daemon. Apr 17 01:29:10 volumio udisks-glue[597]: Updating DB (#1) ... Apr 17 01:29:10 volumio udisks-glue[597]: volume: 40% repeat: off random: off single: off consume: off Apr 17 01:29:10 volumio udisks-glue[597]: Updating DB (#1) ... Apr 17 01:29:10 volumio udisks-glue[597]: volume: 40% repeat: off random: off single: off consume: off Apr 17 01:29:10 volumio wpa_supplicant[947]: wlan0: Trying to associate with SSID 'deco-sl' Apr 17 01:29:11 volumio wireless.js[774]: trying... Apr 17 01:29:11 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:11 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:11 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:11 volumio ntpd[731]: Listen normally on 3 eth0 192.168.68.110 UDP 123 Apr 17 01:29:11 volumio ntpd[731]: peers refreshed Apr 17 01:29:12 volumio wireless.js[774]: trying... Apr 17 01:29:12 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:12 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:12 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:12 volumio wpa_supplicant[947]: wlan0: Associated with ac:84:c6:5c:73:56 Apr 17 01:29:13 volumio wpa_supplicant[947]: wlan0: WPA: Key negotiation completed with ac:84:c6:5c:73:56 [PTK=CCMP GTK=CCMP] Apr 17 01:29:13 volumio wpa_supplicant[947]: wlan0: CTRL-EVENT-CONNECTED - Connection to ac:84:c6:5c:73:56 completed [id=0 id_str=] Apr 17 01:29:13 volumio dhcpcd[1044]: wlan0: carrier acquired Apr 17 01:29:13 volumio wpa_supplicant[947]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Apr 17 01:29:13 volumio dhcpcd[1044]: wlan0: soliciting an IPv6 router Apr 17 01:29:13 volumio wireless.js[774]: trying... Apr 17 01:29:13 volumio sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:13 volumio sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:13 volumio sudo[1178]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:13 volumio ntpd_intres[809]: DNS 0.debian.pool.ntp.org -> 162.159.200.123 Apr 17 01:29:13 volumio ntpd_intres[809]: DNS 1.debian.pool.ntp.org -> 203.123.48.1 Apr 17 01:29:13 volumio ntpd_intres[809]: DNS 2.debian.pool.ntp.org -> 162.159.200.1 Apr 17 01:29:13 volumio ntpd_intres[809]: DNS 3.debian.pool.ntp.org -> 167.71.195.165 Apr 17 01:29:13 volumio nmbd[852]: [2024/04/17 01:29:13.817907, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 17 01:29:13 volumio nmbd[852]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 17 01:29:14 volumio volumio-remote-updater[604]: [2024-04-17 01:29:14] [info] asio async_connect error: system:111 (Connection refused) Apr 17 01:29:14 volumio volumio-remote-updater[604]: [2024-04-17 01:29:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 17 01:29:14 volumio volumio-remote-updater[604]: [2024-04-17 01:29:14] [error] handle_connect error: Underlying Transport Error Apr 17 01:29:14 volumio wireless.js[774]: trying... Apr 17 01:29:14 volumio sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:14 volumio sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:14 volumio sudo[1188]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:15 volumio wireless.js[774]: trying... Apr 17 01:29:15 volumio sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:15 volumio sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:15 volumio sudo[1197]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:16 volumio wireless.js[774]: trying... Apr 17 01:29:16 volumio sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:16 volumio sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:16 volumio sudo[1206]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:17 volumio wireless.js[774]: trying... Apr 17 01:29:17 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:17 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:17 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:18 volumio wireless.js[774]: trying... Apr 17 01:29:18 volumio sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:18 volumio sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:18 volumio sudo[1224]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:18 volumio dhcpcd[1044]: wlan0: using IPv4LL address 169.254.215.198 Apr 17 01:29:18 volumio avahi-daemon[652]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.215.198. Apr 17 01:29:18 volumio dhcpcd[1044]: eth0: adding route to 192.168.68.0/24 Apr 17 01:29:18 volumio dhcpcd[1044]: eth0: adding default route via 192.168.68.1 Apr 17 01:29:18 volumio dhcpcd[1044]: wlan0: adding host route to 169.254.215.198 via 127.0.0.1 Apr 17 01:29:18 volumio dhcpcd[1044]: wlan0: adding route to 169.254.0.0/16 Apr 17 01:29:18 volumio avahi-daemon[652]: New relevant interface wlan0.IPv4 for mDNS. Apr 17 01:29:18 volumio avahi-daemon[652]: Registering new address record for 169.254.215.198 on wlan0.IPv4. Apr 17 01:29:18 volumio dhcpcd[1044]: eth0: removing route to 192.168.68.0/24 Apr 17 01:29:18 volumio dhcpcd[1044]: eth0: removing default route via 192.168.68.1 Apr 17 01:29:19 volumio wireless.js[774]: trying... Apr 17 01:29:19 volumio sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 17 01:29:19 volumio sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:19 volumio sudo[1256]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:19 volumio wireless.js[774]: Connected to: ----deco-sl Apr 17 01:29:19 volumio wireless.js[774]: ---- Apr 17 01:29:19 volumio sudo[1265]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 17 01:29:19 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:29:19 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root Apr 17 01:29:19 volumio wireless.js[774]: ... joined AP, wlan0 IPv4 is 169.254.215.198, ipV6 is undefined Apr 17 01:29:19 volumio wireless.js[774]: It's done! AP Apr 17 01:29:19 volumio systemd[1]: Started Wireless Services. Apr 17 01:29:19 volumio systemd[1]: Starting Volumio Backend Module... Apr 17 01:29:19 volumio systemd[1]: Started Volumio Backend Module. Apr 17 01:29:19 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 17 01:29:19 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 17 01:29:19 volumio systemd[1]: Starting Multi-User System. Apr 17 01:29:19 volumio systemd[1]: Reached target Multi-User System. Apr 17 01:29:19 volumio systemd[1]: Starting Graphical Interface. Apr 17 01:29:19 volumio systemd[1]: Reached target Graphical Interface. Apr 17 01:29:19 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 17 01:29:19 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 17 01:29:19 volumio systemd[1]: Startup finished in 8.661s (kernel) + 25.284s (userspace) = 33.946s. Apr 17 01:29:19 volumio volumio-streaming-daemon[1275]: ############################ Apr 17 01:29:19 volumio volumio-streaming-daemon[1275]: # Volumio Streaming Daemon # Apr 17 01:29:19 volumio volumio-streaming-daemon[1275]: # Running on port 7777 # Apr 17 01:29:19 volumio volumio-streaming-daemon[1275]: ############################ Apr 17 01:29:19 volumio volumio-streaming-daemon[1275]: Environment: production Apr 17 01:29:20 volumio ntpd[731]: Listen normally on 4 wlan0 169.254.215.198 UDP 123 Apr 17 01:29:20 volumio ntpd[731]: peers refreshed Apr 17 01:30:08 volumio systemd[1]: Time has been changed Apr 17 01:30:09 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:09 volumio volumio[1274]: info: ----- Volumio2 ---- Apr 17 01:30:09 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:09 volumio volumio[1274]: info: ----- System startup ---- Apr 17 01:30:09 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:09 volumio volumio[1274]: info: MYVOLUMIO Environment detected Apr 17 01:30:09 volumio volumio[1274]: info: Plugin folders cleanup Apr 17 01:30:09 volumio volumio[1274]: info: Scanning into folder /volumio/app/plugins/ Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category audio_interface Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category miscellanea Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category music_service Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category plugins.json Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category system_controller Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category user_interface Apr 17 01:30:09 volumio volumio[1274]: info: Scanning into folder /data/plugins/ Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category miscellanea Apr 17 01:30:09 volumio volumio[1274]: info: Scanning category music_service Apr 17 01:30:09 volumio volumio[1274]: info: Plugin folders cleanup completed Apr 17 01:30:09 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:09 volumio volumio[1274]: info: ----- Core plugins startup ---- Apr 17 01:30:09 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:09 volumio volumio[1274]: info: Loading plugins from folder /volumio/app/plugins/ Apr 17 01:30:09 volumio volumio[1274]: info: Adding plugin upnp to MyMusic Plugins Apr 17 01:30:09 volumio volumio[1274]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 17 01:30:09 volumio volumio[1274]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 17 01:30:09 volumio volumio[1274]: info: Loading plugins from folder /data/plugins/ Apr 17 01:30:09 volumio volumio[1274]: info: Loading plugin "system"... Apr 17 01:30:09 volumio volumio[1274]: info: Loading plugin "appearance"... Apr 17 01:30:10 volumio dhcpcd[1044]: wlan0: soliciting a DHCP lease Apr 17 01:30:10 volumio volumio[1274]: info: Loading plugin "network"... Apr 17 01:30:10 volumio volumio[1274]: info: Refreshing Cached IP Addresses Apr 17 01:30:10 volumio volumio[1274]: info: Loading plugin "touch_display"... Apr 17 01:30:10 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 17 01:30:10 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:10 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 17 01:30:10 volumio sudo[1300]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:10 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:10 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:11 volumio volumio[1274]: info: Applying required configuration parameters for plugin touch_display Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "services"... Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "alsa_controller"... Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "wizard"... Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "volumio_command_line_client"... Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "upnp"... Apr 17 01:30:11 volumio volumio[1274]: info: [1713317411168] Starting Upmpd Daemon Apr 17 01:30:11 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "my_music"... Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "mpd"... Apr 17 01:30:11 volumio dhcpcd[1044]: wlan0: offered 192.168.68.111 from 192.168.68.1 Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "upnp_browser"... Apr 17 01:30:11 volumio volumio-remote-updater[604]: [2024-04-17 01:30:11] [connect] Successful connection Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "networkfs"... Apr 17 01:30:11 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 17 01:30:11 volumio volumio[1274]: info: Loading plugin "alarm-clock"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "airplay_emulation"... Apr 17 01:30:12 volumio volumio[1274]: info: Starting Shairport Sync Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "last_100"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "webradio"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "i2s_dacs"... Apr 17 01:30:12 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "volumiodiscovery"... Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 17 01:30:12 volumio node[1274]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 17 01:30:12 volumio node[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 17 01:30:12 volumio node[1274]: *** WARNING *** For more information see Apr 17 01:30:12 volumio node[1274]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 17 01:30:12 volumio node[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 17 01:30:12 volumio node[1274]: *** WARNING *** For more information see Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** For more information see Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 17 01:30:12 volumio volumio[1274]: *** WARNING *** For more information see Apr 17 01:30:12 volumio volumio[1274]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 17 01:30:12 volumio volumio[1274]: Discovery: StartAdv! undefined Apr 17 01:30:12 volumio volumio[1274]: Discovery: Started advertising... Volumio - undefined Apr 17 01:30:12 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "outputs"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "albumart"... Apr 17 01:30:12 volumio volumio[1274]: info: Plugin example_plugin is not enabled Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "inputs"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "updater_comm"... Apr 17 01:30:12 volumio volumio[1274]: info: Plugin mpdemulation is not enabled Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "rest_api"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "websocket"... Apr 17 01:30:12 volumio volumio[1274]: info: Loading plugin "spop"... Apr 17 01:30:12 volumio volumio[1274]: Forking 3 albumart workers Apr 17 01:30:13 volumio volumio[1274]: Starting albumart workers Apr 17 01:30:13 volumio volumio[1274]: Starting albumart workers Apr 17 01:30:13 volumio volumio[1274]: Starting albumart workers Apr 17 01:30:13 volumio volumio[1274]: info: ___________ START PLUGINS ___________ Apr 17 01:30:13 volumio volumio[1274]: info: Loading i18n strings for locale en Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 17 01:30:13 volumio volumio[1274]: info: [1713317413706] CoreMusicLibrary::Adding element Media Servers Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 01:30:13 volumio sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 17 01:30:13 volumio sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio systemd[1]: Reloading. Apr 17 01:30:13 volumio volumio[1274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Apr 17 01:30:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Apr 17 01:30:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Apr 17 01:30:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Apr 17 01:30:13 volumio volumio[1274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 17 01:30:13 volumio volumio[1274]: info: [1713317413818] CoreMusicLibrary::Adding element Last_100 Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 17 01:30:13 volumio volumio[1274]: info: [1713317413821] CoreMusicLibrary::Adding element Webradio Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 01:30:13 volumio sudo[1374]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 17 01:30:13 volumio volumio[1274]: [SpotifyConnect] Creating VLS config file Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 17 01:30:13 volumio volumio[1274]: [SpotifyConnect] Starting metadata listener Apr 17 01:30:13 volumio sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:13 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:13 volumio volumio[1274]: info: ----- MyVolumio plugins startup ---- Apr 17 01:30:13 volumio volumio[1274]: info: ------------------------------------------- Apr 17 01:30:13 volumio volumio[1274]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 17 01:30:13 volumio sudo[1399]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:13 volumio volumio[1274]: info: Loading i18n strings for locale en Apr 17 01:30:13 volumio volumio[1274]: Updating browse sources language Apr 17 01:30:13 volumio volumio[1274]: Cannot find translation for sourceMedia Servers Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 01:30:13 volumio sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Apr 17 01:30:13 volumio sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::initPlayerControls Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 17 01:30:13 volumio systemd[1]: Failed to reset devices.list on /system.slice: Invalid argument Apr 17 01:30:13 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 17 01:30:13 volumio volumio[1274]: info: BOOT COMPLETED Apr 17 01:30:13 volumio volumio[1274]: [Metrics] CommandRouter: 4s 936.45ms Apr 17 01:30:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:14 volumio volumio[1414]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Apr 17 01:30:14 volumio volumio[1414]: Reading Config from "/tmp/volspotify.toml" Apr 17 01:30:14 volumio volumio[1414]: Malformed config key: missing field `Authentication` Apr 17 01:30:14 volumio sudo[1406]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: leased 192.168.68.111 for 7200 seconds Apr 17 01:30:16 volumio avahi-daemon[652]: Registering new address record for 192.168.68.111 on wlan0.IPv4. Apr 17 01:30:16 volumio avahi-daemon[652]: Withdrawing address record for 169.254.215.198 on wlan0. Apr 17 01:30:16 volumio avahi-daemon[652]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.215.198. Apr 17 01:30:16 volumio avahi-daemon[652]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.111. Apr 17 01:30:16 volumio dhcpcd[1044]: eth0: adding route to 192.168.68.0/24 Apr 17 01:30:16 volumio dhcpcd[1044]: eth0: adding default route via 192.168.68.1 Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: adding host route to 192.168.68.111 via 127.0.0.1 Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: adding route to 192.168.68.0/24 Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: adding default route via 192.168.68.1 Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: deleting host route to 169.254.215.198 via 127.0.0.1 Apr 17 01:30:16 volumio dhcpcd[1044]: wlan0: deleting route to 169.254.0.0/16 Apr 17 01:30:16 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 17 01:30:16 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 17 01:30:16 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 17 01:30:16 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 17 01:30:16 volumio volumio[1444]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Apr 17 01:30:16 volumio volumio[1444]: Reading Config from "/tmp/volspotify.toml" Apr 17 01:30:16 volumio volumio[1444]: Malformed config key: missing field `Authentication` Apr 17 01:30:16 volumio systemd[1]: Stopping LSB: Start NTP daemon... Apr 17 01:30:16 volumio ntpd[731]: ntpd exiting on signal 15 Apr 17 01:30:16 volumio ntp[1525]: Stopping NTP server: ntpd. Apr 17 01:30:16 volumio systemd[1]: Starting LSB: Start NTP daemon... Apr 17 01:30:16 volumio ntpd[1543]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Apr 17 01:30:16 volumio ntp[1535]: Starting NTP server: ntpd. Apr 17 01:30:16 volumio ntpd[1544]: proto: precision = 0.463 usec Apr 17 01:30:16 volumio ntpd[1544]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 17 01:30:16 volumio systemd[1]: Started LSB: Start NTP daemon. Apr 17 01:30:16 volumio ntpd[1544]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 17 01:30:16 volumio ntpd[1544]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 17 01:30:16 volumio ntpd[1544]: Listen normally on 3 eth0 192.168.68.110 UDP 123 Apr 17 01:30:16 volumio ntpd[1544]: Listen normally on 4 wlan0 192.168.68.111 UDP 123 Apr 17 01:30:16 volumio ntpd[1544]: peers refreshed Apr 17 01:30:16 volumio ntpd[1544]: Listening on routing socket on fd #21 for interface updates Apr 17 01:30:16 volumio dhcpcd[1044]: eth0: removing route to 192.168.68.0/24 Apr 17 01:30:16 volumio dhcpcd[1044]: eth0: removing default route via 192.168.68.1 Apr 17 01:30:18 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 17 01:30:18 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 17 01:30:18 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 17 01:30:18 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 17 01:30:18 volumio volumio[1545]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Apr 17 01:30:18 volumio volumio[1545]: Reading Config from "/tmp/volspotify.toml" Apr 17 01:30:18 volumio volumio[1545]: Malformed config key: missing field `Authentication` Apr 17 01:30:19 volumio volumio[1274]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::Close All Modals sent Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::Close All Modals sent Apr 17 01:30:19 volumio volumio[1274]: Express server listening on port 3000 Apr 17 01:30:19 volumio volumio[1274]: [Metrics] WebUI: 10s 720.41ms Apr 17 01:30:19 volumio volumio[1274]: Volumio Calling Home Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::resetVolumioState Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::getcurrentVolume Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioRetrievevolume Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::pushState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::updateTrackBlock Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrackBlock Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioRetrievevolume Apr 17 01:30:19 volumio volumio[1274]: info: Setting Device type: Raspberry PI Apr 17 01:30:19 volumio volumio[1274]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 17 01:30:19 volumio volumio[1274]: [Metrics] SpotifyConnect: 5s 711.64ms Apr 17 01:30:19 volumio volumio[1274]: info: touch_display: systemctl daemon-reload succeeded. Apr 17 01:30:19 volumio volumio[1274]: info: MPD running with PID653 Apr 17 01:30:19 volumio volumio[1274]: ,establishing connection Apr 17 01:30:19 volumio sudo[1573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 17 01:30:19 volumio sudo[1573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:19 volumio systemd[1]: Starting Volumio Kiosk... Apr 17 01:30:19 volumio systemd[1]: Started Volumio Kiosk. Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::pushState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 01:30:19 volumio volumio[1274]: info: Apr 17 01:30:19 volumio volumio[1274]: ---------------------------- Client requests Volume 50 Apr 17 01:30:19 volumio volumio[1274]: info: VolumeController::SetAlsaVolume50 Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::pushState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 01:30:19 volumio sudo[1573]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:19 volumio startx[1578]: X.Org X Server 1.18.4 Apr 17 01:30:19 volumio startx[1578]: Release Date: 2016-07-19 Apr 17 01:30:19 volumio startx[1578]: X Protocol Version 11, Revision 0 Apr 17 01:30:19 volumio startx[1578]: Build Operating System: Linux 4.4.26-v7+ armv7l Raspbian Apr 17 01:30:19 volumio startx[1578]: Current Operating System: Linux volumio 4.19.118-v7l+ #1311 SMP Mon Apr 27 14:26:42 BST 2020 armv7l Apr 17 01:30:19 volumio startx[1578]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 cma=64M bcm2708_fb.fbwidth=1024 bcm2708_fb.fbheight=600 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:BC:BE:A2 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash quiet plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 console=ttyS0,115200 kgdboc=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 snd-bcm2835.enable_compat_alsa=1 snd_bcm2835.enable_headphones=1 Apr 17 01:30:19 volumio startx[1578]: Build Date: 11 November 2016 11:59:59AM Apr 17 01:30:19 volumio startx[1578]: xorg-server 2:1.18.4-2+rpi1 (https://www.debian.org/support) Apr 17 01:30:19 volumio startx[1578]: Current version of pixman: 0.32.6 Apr 17 01:30:19 volumio startx[1578]: Before reporting problems, check http://wiki.x.org Apr 17 01:30:19 volumio startx[1578]: to make sure that you have the latest version. Apr 17 01:30:19 volumio startx[1578]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 17 01:30:19 volumio startx[1578]: (++) from command line, (!!) notice, (II) informational, Apr 17 01:30:19 volumio startx[1578]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 17 01:30:19 volumio startx[1578]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Apr 17 01:30:19 2024 Apr 17 01:30:19 volumio startx[1578]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 17 01:30:19 volumio startx[1578]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 17 01:30:19 volumio volumio[1274]: info: Reloading queue from file Apr 17 01:30:19 volumio volumio[1274]: error: updateQueue error: null Apr 17 01:30:19 volumio startx[1578]: modprobe: FATAL: Module g2d_23 not found. Apr 17 01:30:19 volumio volumio[1274]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 17 01:30:19 volumio volumio[1274]: info: touch_display: Volumio Kiosk started Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: Setting volume on startup at 50 Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::setRepeat true single undefined Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::pushState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::setRandom null Apr 17 01:30:19 volumio volumio[1274]: info: CoreStateMachine::pushState Apr 17 01:30:19 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Apr 17 01:30:19 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 17 01:30:19 volumio volumio[1274]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 17 01:30:19 volumio volumio[1274]: info: Starting Shairport Sync Apr 17 01:30:20 volumio volumio[1274]: info: Starting Shairport Sync Apr 17 01:30:20 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 17 01:30:20 volumio sudo[1613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 17 01:30:20 volumio sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:20 volumio sudo[1613]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:20 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 17 01:30:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 17 01:30:20 volumio sudo[1611]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 17 01:30:20 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 17 01:30:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 17 01:30:20 volumio sudo[1613]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:20 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 17 01:30:20 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 17 01:30:20 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 17 01:30:20 volumio volumio[1274]: Discovery: adding 580b2d1b-a957-4f7c-9ef9-0459144ede76 Apr 17 01:30:20 volumio volumio[1274]: info: mDNS: Found device Volumio Apr 17 01:30:20 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Apr 17 01:30:20 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:20 volumio volumio[1274]: Discovery: this is already registered, 580b2d1b-a957-4f7c-9ef9-0459144ede76 Apr 17 01:30:20 volumio volumio[1274]: info: mDNS: Found device Volumio Apr 17 01:30:20 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Apr 17 01:30:20 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:20 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 17 01:30:20 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 17 01:30:20 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 17 01:30:20 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 17 01:30:20 volumio volumio[1646]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Apr 17 01:30:20 volumio volumio[1646]: Reading Config from "/tmp/volspotify.toml" Apr 17 01:30:20 volumio volumio[1646]: [Vollibrespot] : Using Alsa backend with device: softvolume Apr 17 01:30:20 volumio volumio[1646]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 17 01:30:21 volumio volumio[1274]: info: Shairport-Sync Started Apr 17 01:30:21 volumio volumio[1274]: Error adding Membership: Error: addMembership EINVAL Apr 17 01:30:21 volumio volumio[1274]: info: Shairport-Sync Started Apr 17 01:30:21 volumio sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 17 01:30:21 volumio sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:21 volumio volumio[1274]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 17 01:30:21 volumio sudo[1680]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:21 volumio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 17 01:30:21 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:21 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:21 volumio volumio[1274]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 17 01:30:21 volumio volumio[1274]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 17 01:30:21 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Apr 17 01:30:21 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:21 volumio sudo[1696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 17 01:30:21 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Apr 17 01:30:21 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Apr 17 01:30:21 volumio sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:21 volumio sudo[1696]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:21 volumio volumio[1274]: info: touch_display: Touchscreen transformation matrix removed. Apr 17 01:30:21 volumio sudo[1719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 17 01:30:21 volumio sudo[1719]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:21 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 17 01:30:21 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 17 01:30:21 volumio sudo[1719]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:21 volumio volumio[1274]: info: Upmpdcli Daemon Started Apr 17 01:30:22 volumio dbus[669]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Apr 17 01:30:22 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 17 01:30:22 volumio dbus[669]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 17 01:30:22 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Successfully called chroot. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Successfully dropped privileges. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Successfully limited resources. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Running. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Canary thread running. Apr 17 01:30:22 volumio rtkit-daemon[1757]: Watchdog thread running. Apr 17 01:30:22 volumio pulseaudio[1756]: Unable to contact D-Bus: org.freedesktop.DBus.Error.Spawn.ExecFailed: /usr/bin/dbus-launch terminated abnormally without any error message Apr 17 01:30:22 volumio pulseaudio[1756]: Unable to contact D-Bus: org.freedesktop.DBus.Error.Spawn.ExecFailed: /usr/bin/dbus-launch terminated abnormally without any error message Apr 17 01:30:22 volumio pulseaudio[1756]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Apr 17 01:30:22 volumio bluetoothd[783]: Endpoint registered: sender=:1.20 path=/MediaEndpoint/A2DPSource Apr 17 01:30:22 volumio bluetoothd[783]: Endpoint registered: sender=:1.20 path=/MediaEndpoint/A2DPSink Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 17 01:30:22 volumio volumio[1274]: info: Adding plugin bluetooth to MyMusic Plugins Apr 17 01:30:22 volumio volumio[1274]: info: Adding plugin cd_controller to MyMusic Plugins Apr 17 01:30:22 volumio volumio[1274]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 17 01:30:22 volumio volumio[1274]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 17 01:30:24 volumio volumio[1274]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 17 01:30:25 volumio volumio[1274]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 17 01:30:25 volumio volumio[1274]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 17 01:30:25 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:25 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 01:30:25 volumio volumio[1274]: info: Starting MyVolumio Remote Streaming Endpoints Apr 17 01:30:25 volumio volumio[1274]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 17 01:30:25 volumio volumio[1274]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 17 01:30:25 volumio volumio[1274]: info: Streaming services startup Apr 17 01:30:25 volumio volumio[1274]: info: Starting Streaming Daemon Apr 17 01:30:25 volumio volumio[1274]: info: MyVolumio not started Apr 17 01:30:25 volumio volumio[1274]: info: Initializing device activation check Apr 17 01:30:25 volumio sudo[1825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 17 01:30:25 volumio sudo[1825]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 01:30:25 volumio volumio[1274]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 17 01:30:25 volumio systemd[1]: Stopping Volumio Streaming Daemon... Apr 17 01:30:25 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 17 01:30:25 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 17 01:30:25 volumio sudo[1825]: pam_unix(sudo:session): session closed for user root Apr 17 01:30:25 volumio volumio[1274]: info: Checking Spotify Web API Apr 17 01:30:25 volumio volumio[1274]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 01:30:25 volumio volumio-streaming-daemon[1831]: ############################ Apr 17 01:30:25 volumio volumio-streaming-daemon[1831]: # Volumio Streaming Daemon # Apr 17 01:30:25 volumio volumio-streaming-daemon[1831]: # Running on port 7777 # Apr 17 01:30:25 volumio volumio-streaming-daemon[1831]: ############################ Apr 17 01:30:25 volumio volumio-streaming-daemon[1831]: Environment: production Apr 17 01:30:25 volumio volumio[1274]: { Error: addMembership ENODEV Apr 17 01:30:25 volumio volumio[1274]: at _errnoException (util.js:1022:11) Apr 17 01:30:25 volumio volumio[1274]: at Socket.addMembership (dgram.js:615:11) Apr 17 01:30:25 volumio volumio[1274]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Apr 17 01:30:25 volumio volumio[1274]: at ontimeout (timers.js:482:11) Apr 17 01:30:25 volumio volumio[1274]: at tryOnTimeout (timers.js:317:5) Apr 17 01:30:25 volumio volumio[1274]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Apr 17 01:30:25 volumio volumio[1274]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 01:30:25 volumio sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-17 01:29 Apr 17 01:30:25 volumio sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="2c20ceacdd8365d3bd2fdff070d8c78700ff2903" VOLUMIO_FE_VERSION="fa55af43e5eb642e968aa6de2f8a985962941d63" VOLUMIO_BE_VERSION="c9e4849495e810bd6ebb6833232daba25d86dd4c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Nov 20 20:05:14 CET 2020" VOLUMIO_VERSION="2.853" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="f7f9725bb5ce7d6da77135f468c28964"