-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Mon 2024-07-22 11:53:34 CST. --
Jul 22 11:52:25 volumio systemd[1]: Started Network Time Synchronization.
Jul 22 11:52:25 volumio systemd[1]: Reached target System Time Set.
Jul 22 11:52:25 volumio systemd[1]: Reached target System Time Synchronized.
Jul 22 11:52:25 volumio systemd[1]: Started udev Kernel Device Manager.
Jul 22 11:52:25 volumio systemd[1]: Reached target System Initialization.
Jul 22 11:52:25 volumio systemd[1]: Started Daily apt download activities.
Jul 22 11:52:25 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Jul 22 11:52:25 volumio systemd[1]: Started Periodic ext4 Online Metadata Check for All Filesystems.
Jul 22 11:52:26 volumio systemd[1]: Started Discard unused blocks once a week.
Jul 22 11:52:26 volumio systemd[1]: Started Daily rotation of log files.
Jul 22 11:52:26 volumio systemd[1]: Started Message of the Day.
Jul 22 11:52:26 volumio systemd[1]: Started Daily Cleanup of Temporary Directories.
Jul 22 11:52:26 volumio systemd[1]: Reached target Timers.
Jul 22 11:52:26 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jul 22 11:52:26 volumio systemd[1]: Listening on D-Bus System Message Bus Socket.
Jul 22 11:52:26 volumio systemd-udevd[2102]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:26 volumio systemd[1]: Listening on mpd.socket.
Jul 22 11:52:26 volumio systemd-udevd[2096]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:26 volumio systemd[1]: Reached target Sockets.
Jul 22 11:52:26 volumio systemd[1]: Reached target Basic System.
Jul 22 11:52:26 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jul 22 11:52:26 volumio systemd[1]: Started D-Bus System Message Bus.
Jul 22 11:52:26 volumio avahi-daemon[2107]: Found user 'avahi' (UID 107) and group 'avahi' (GID 114).
Jul 22 11:52:26 volumio avahi-daemon[2107]: Successfully dropped root privileges.
Jul 22 11:52:26 volumio avahi-daemon[2107]: avahi-daemon 0.7 starting up.
Jul 22 11:52:26 volumio systemd[1]: Starting Remove Stale Online ext4 Metadata Check Snapshots...
Jul 22 11:52:26 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Jul 22 11:52:26 volumio systemd[1]: Started Volumio Iptables Module.
Jul 22 11:52:26 volumio systemd[1]: Starting Dispatcher daemon for systemd-networkd...
Jul 22 11:52:26 volumio avahi-daemon[2107]: Successfully called chroot().
Jul 22 11:52:26 volumio avahi-daemon[2107]: Successfully dropped remaining capabilities.
Jul 22 11:52:26 volumio avahi-daemon[2115]: chroot.c: open() failed: No such file or directory
Jul 22 11:52:26 volumio avahi-daemon[2107]: Failed to open /etc/resolv.conf: Invalid argument
Jul 22 11:52:26 volumio avahi-daemon[2107]: No service file found in /etc/avahi/services.
Jul 22 11:52:26 volumio systemd[1]: Started Set the CPU Frequency Scaling governor.
Jul 22 11:52:26 volumio systemd[1]: Starting Login Service...
Jul 22 11:52:26 volumio systemd[1]: Starting Network Service...
Jul 22 11:52:26 volumio systemd[1]: Starting LSB: Start busybox udhcpd at boot time...
Jul 22 11:52:27 volumio kernel: random: crng init done
Jul 22 11:52:27 volumio kernel: random: 7 urandom warning(s) missed due to ratelimiting
Jul 22 11:52:27 volumio systemd[1]: Started mount disks automatically with standby.
Jul 22 11:52:27 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 22 11:52:27 volumio systemd-udevd[2102]: Using default interface naming scheme 'v245'.
Jul 22 11:52:27 volumio systemd[1]: Started Volumio Log Rotation Service.
Jul 22 11:52:27 volumio systemd[1]: Started Volumio SSH enabler.
Jul 22 11:52:27 volumio systemd[1]: Starting Wireless Services...
Jul 22 11:52:27 volumio systemd[1]: Starting WPA supplicant...
Jul 22 11:52:27 volumio systemd[1]: Finished Load/Save Random Seed.
Jul 22 11:52:27 volumio systemd[1]: volumiossh.service: Succeeded.
Jul 22 11:52:27 volumio dbus-daemon[2108]: [system] Activating systemd to hand-off: service name='org.freedesktop.UDisks' unit='udisks.service' requested by ':1.2' (uid=1000 pid=2144 comm="/usr/bin/udisks-glue --foreground ")
Jul 22 11:52:27 volumio systemd-udevd[2098]: Using default interface naming scheme 'v245'.
Jul 22 11:52:27 volumio dbus-daemon[2108]: [system] Successfully activated service 'org.freedesktop.systemd1'
Jul 22 11:52:27 volumio systemd-udevd[2094]: Using default interface naming scheme 'v245'.
Jul 22 11:52:27 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Jul 22 11:52:27 volumio systemd-udevd[2102]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:27 volumio avahi-daemon[2107]: New relevant interface lo.IPv4 for mDNS.
Jul 22 11:52:27 volumio systemd-udevd[2102]: ethtool: could not get ethtool features for eth0
Jul 22 11:52:27 volumio avahi-daemon[2107]: Network interface enumeration completed.
Jul 22 11:52:27 volumio systemd-udevd[2102]: Could not set offload features of eth0: Device or resource busy
Jul 22 11:52:27 volumio avahi-daemon[2107]: Registering new address record for 127.0.0.1 on lo.IPv4.
Jul 22 11:52:27 volumio systemd-udevd[2098]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:27 volumio systemd-udevd[2094]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:27 volumio wpa_supplicant[2171]: Successfully initialized wpa_supplicant
Jul 22 11:52:27 volumio systemd-networkd[2139]: Configuration file /etc/systemd/network/10-eth0.network is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
Jul 22 11:52:27 volumio systemd-networkd[2139]: Configuration file /etc/systemd/network/11-wlan0.network is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
Jul 22 11:52:27 volumio udhcpd[2140]: udhcpd: Disabled. Edit /etc/default/udhcpd to enable it.
Jul 22 11:52:27 volumio systemd[1]: Started LSB: Start busybox udhcpd at boot time.
Jul 22 11:52:28 volumio systemd-logind[2137]: New seat seat0.
Jul 22 11:52:28 volumio sudo[2177]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off
Jul 22 11:52:28 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jul 22 11:52:28 volumio kernel: libphy: 4500000.eth: probed
Jul 22 11:52:28 volumio sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:28 volumio systemd[1]: Found device /dev/ttyAS0.
Jul 22 11:52:28 volumio systemd[1]: Started WPA supplicant.
Jul 22 11:52:28 volumio kernel: sunxi-gmac 4500000.eth eth0: eth0: Type(8) PHY ID 0000011a at 0 IRQ poll (4500000.eth-0:00)
Jul 22 11:52:28 volumio volumio[2151]: Could not open config: /tmp/upmpdcli.conf
Jul 22 11:52:28 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Jul 22 11:52:28 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Jul 22 11:52:28 volumio avahi-daemon[2107]: Server startup complete. Host name is volumio.local. Local service cookie is 767798838.
Jul 22 11:52:28 volumio systemd-udevd[2096]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:28 volumio systemd-udevd[2096]: Using default interface naming scheme 'v245'.
Jul 22 11:52:28 volumio systemd-udevd[2096]: ip6tnl0: Could not generate persistent MAC: No data available
Jul 22 11:52:28 volumio systemd-udevd[2098]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:28 volumio systemd-udevd[2095]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 22 11:52:28 volumio sudo[2177]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:28 volumio systemd-networkd[2139]: Enumeration completed
Jul 22 11:52:28 volumio systemd[1]: Started Network Service.
Jul 22 11:52:28 volumio systemd-networkd[2139]: wlan0: found matching network '/etc/systemd/network/11-wlan0.network', based on potentially unpredictable ifname
Jul 22 11:52:28 volumio systemd-networkd[2139]: wlan0: IPv6 successfully enabled
Jul 22 11:52:28 volumio systemd-networkd[2139]: eth1: Link UP
Jul 22 11:52:28 volumio systemd-networkd[2139]: eth1: Gained carrier
Jul 22 11:52:28 volumio systemd-networkd[2139]: eth1: Lost carrier
Jul 22 11:52:28 volumio systemd-networkd[2139]: eth0: Link UP
Jul 22 11:52:28 volumio systemd-networkd[2139]: eth0: IPv6 successfully enabled
Jul 22 11:52:29 volumio kernel: ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
Jul 22 11:52:29 volumio kernel: ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.36
Jul 22 11:52:29 volumio systemd[1]: iptables.service: Succeeded.
Jul 22 11:52:29 volumio systemd[1]: e2scrub_reap.service: Succeeded.
Jul 22 11:52:29 volumio systemd[1]: Finished Remove Stale Online ext4 Metadata Check Snapshots.
Jul 22 11:52:29 volumio systemd[1]: Started Login Service.
Jul 22 11:52:29 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jul 22 11:52:29 volumio systemd[1]: Condition check resulted in Manage Sound Card State (restore and store) being skipped.
Jul 22 11:52:29 volumio systemd-networkd[2139]: wlan0: Link UP
Jul 22 11:52:29 volumio systemd[1]: Starting Save/Restore Sound Card State...
Jul 22 11:52:29 volumio systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped.
Jul 22 11:52:29 volumio systemd[1]: Starting Network Name Resolution...
Jul 22 11:52:29 volumio systemd[1]: Starting Disk Manager (legacy version)...
Jul 22 11:52:29 volumio systemd[1]: Starting Load/Save RF Kill Switch Status...
Jul 22 11:52:29 volumio systemd[1]: Finished Save/Restore Sound Card State.
Jul 22 11:52:29 volumio systemd[1]: Reached target Sound Card.
Jul 22 11:52:29 volumio dbus-daemon[2108]: [system] Successfully activated service 'org.freedesktop.UDisks'
Jul 22 11:52:29 volumio systemd[1]: Started Disk Manager (legacy version).
Jul 22 11:52:29 volumio systemd[1]: Started Load/Save RF Kill Switch Status.
Jul 22 11:52:29 volumio dbus-daemon[2108]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=2310 comm="/usr/lib/udisks/udisks-daemon --no-debug ")
Jul 22 11:52:29 volumio systemd[1]: Starting Authorization Manager...
Jul 22 11:52:29 volumio systemd-resolved[2309]: Positive Trust Anchors:
Jul 22 11:52:29 volumio systemd-resolved[2309]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jul 22 11:52:29 volumio systemd-resolved[2309]: Negative trust anchors: 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test
Jul 22 11:52:29 volumio polkitd[2317]: started daemon version 0.105 using authority implementation `local' version `0.105'
Jul 22 11:52:29 volumio dbus-daemon[2108]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jul 22 11:52:29 volumio systemd[1]: Started Authorization Manager.
Jul 22 11:52:30 volumio systemd[1]: Started Dispatcher daemon for systemd-networkd.
Jul 22 11:52:30 volumio systemd-resolved[2309]: Using system hostname 'volumio'.
Jul 22 11:52:30 volumio systemd[1]: Started Network Name Resolution.
Jul 22 11:52:30 volumio systemd[1]: Reached target Network.
Jul 22 11:52:30 volumio systemd[1]: Reached target Network is Online.
Jul 22 11:52:30 volumio systemd[1]: Reached target Host and Network Name Lookups.
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p6 inserted
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0 inserted
Jul 22 11:52:30 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator...
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p4 inserted
Jul 22 11:52:30 volumio systemd[1]: Starting Music Player Daemon...
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p3 inserted
Jul 22 11:52:30 volumio systemd[1]: Starting Samba NMB Daemon...
Jul 22 11:52:30 volumio hostapd[2322]: Configuration file: /etc/hostapd/hostapd.conf
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p2 inserted
Jul 22 11:52:30 volumio systemd[1]: Started NQPTP -- Not Quite PTP.
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p8 inserted
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p1 inserted
Jul 22 11:52:30 volumio udisks-glue[2144]: Trying to automount /dev/mmcblk0p1...
Jul 22 11:52:30 volumio systemd[1]: Starting /etc/rc.local Compatibility...
Jul 22 11:52:30 volumio systemd[1]: Starting Permit User Sessions...
Jul 22 11:52:30 volumio rc.local[2328]: no find file
Jul 22 11:52:30 volumio systemd[1]: Started /etc/rc.local Compatibility.
Jul 22 11:52:30 volumio rc.local[2329]: websocket connect
Jul 22 11:52:30 volumio rc.local[2329]: Error: No active session
Jul 22 11:52:30 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jul 22 11:52:30 volumio systemd[1]: Finished Permit User Sessions.
Jul 22 11:52:30 volumio udisks-glue[2144]: Successfully automounted /dev/mmcblk0p1 at /media/Volumn
Jul 22 11:52:30 volumio systemd[1]: Started Getty on tty1.
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p7 inserted
Jul 22 11:52:30 volumio udisks-glue[2144]: Device file /dev/mmcblk0p1 mounted at /media/Volumn
Jul 22 11:52:30 volumio systemd[1]: Started Serial Getty on ttyAS0.
Jul 22 11:52:30 volumio kernel: sunxi-gmac 4500000.eth eth0: Link is Up - 100Mbps/Full - flow control off
Jul 22 11:52:30 volumio systemd-networkd[2139]: wlan0: Link DOWN
Jul 22 11:52:30 volumio systemd[1]: Reached target Login Prompts.
Jul 22 11:52:30 volumio rc.local[2355]: opt = r
Jul 22 11:52:30 volumio rc.local[2355]: optarg = 90
Jul 22 11:52:30 volumio rc.local[2355]: optind = 3
Jul 22 11:52:30 volumio rc.local[2355]: argv[optind - 1] = 90
Jul 22 11:52:30 volumio rc.local[2355]: opt = t
Jul 22 11:52:30 volumio rc.local[2355]: optarg = /dev/ttyAS2
Jul 22 11:52:30 volumio rc.local[2355]: optind = 5
Jul 22 11:52:30 volumio rc.local[2355]: argv[optind - 1] = /dev/ttyAS2
Jul 22 11:52:30 volumio rc.local[2355]: tty driver /dev/ttyAS2
Jul 22 11:52:31 volumio rc.local[2355]: SCREEN_SIZE_960X376
Jul 22 11:52:31 volumio rc.local[2329]: [2024-07-22 11:52:31] [info] asio async_connect error: asio.system:111 (Connection refused)
Jul 22 11:52:31 volumio rc.local[2329]: [2024-07-22 11:52:31] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected)
Jul 22 11:52:31 volumio rc.local[2329]: [2024-07-22 11:52:31] [error] handle_connect error: Connection refused
Jul 22 11:52:31 volumio kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Jul 22 11:52:31 volumio nmbd[2324]: [2024/07/22 11:52:31.266510, 0] ../../source3/nmbd/nmbd.c:901(main)
Jul 22 11:52:31 volumio systemd-networkd[2139]: wlan0: Link UP
Jul 22 11:52:31 volumio rc.local[2359]: cat: /workdir/version.txt: No such file or directory
Jul 22 11:52:31 volumio kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jul 22 11:52:31 volumio hostapd[2322]: Using interface wlan0 with hwaddr 7c:dd:90:39:2a:5e and ssid "Volumio"
Jul 22 11:52:31 volumio nmbd[2324]: nmbd version 4.15.13-Ubuntu started.
Jul 22 11:52:31 volumio systemd-networkd[2139]: eth0: Gained carrier
Jul 22 11:52:31 volumio nmbd[2324]: Copyright Andrew Tridgell and the Samba Team 1992-2021
Jul 22 11:52:31 volumio systemd-networkd[2139]: wlan0: Gained carrier
Jul 22 11:52:31 volumio nmbd[2324]: [2024/07/22 11:52:31.311047, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns)
Jul 22 11:52:31 volumio systemd-networkd[2139]: wlan0: found matching network '/etc/systemd/network/11-wlan0.network', based on potentially unpredictable ifname
Jul 22 11:52:31 volumio nmbd[2324]: started asyncdns process 2370
Jul 22 11:52:31 volumio hostapd[2322]: wlan0: interface state UNINITIALIZED->ENABLED
Jul 22 11:52:31 volumio nmbd[2324]: [2024/07/22 11:52:31.465990, 0] ../../lib/util/become_daemon.c:150(daemon_status)
Jul 22 11:52:31 volumio nmbd[2324]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Jul 22 11:52:31 volumio nmbd[2324]: [2024/07/22 11:52:31.466425, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets)
Jul 22 11:52:31 volumio nmbd[2324]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Jul 22 11:52:31 volumio hostapd[2322]: wlan0: AP-ENABLED
Jul 22 11:52:31 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator.
Jul 22 11:52:31 volumio rc.local[2372]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:31 volumio set-cpufreq[2133]: Setting ondemand scheduler for all CPUs
Jul 22 11:52:31 volumio systemd[1]: ondemand.service: Succeeded.
Jul 22 11:52:32 volumio rc.local[2390]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:32 volumio systemd-networkd[2139]: eth0: DHCPv4 address 192.168.23.115/24 via 192.168.23.1
Jul 22 11:52:32 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.23.115.
Jul 22 11:52:32 volumio avahi-daemon[2107]: New relevant interface eth0.IPv4 for mDNS.
Jul 22 11:52:32 volumio avahi-daemon[2107]: Registering new address record for 192.168.23.115 on eth0.IPv4.
Jul 22 11:52:32 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:32 volumio wireless.js[2291]: Cleaning previous...
Jul 22 11:52:32 volumio systemd[1]: Started Samba NMB Daemon.
Jul 22 11:52:32 volumio systemd-networkd[2139]: eth0: Gained IPv6LL
Jul 22 11:52:32 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::60b3:72ff:fe15:dfbe.
Jul 22 11:52:32 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:32 volumio avahi-daemon[2107]: New relevant interface eth0.IPv6 for mDNS.
Jul 22 11:52:32 volumio avahi-daemon[2107]: Registering new address record for fe80::60b3:72ff:fe15:dfbe on eth0.*.
Jul 22 11:52:32 volumio systemd[1]: Starting Samba SMB Daemon...
Jul 22 11:52:32 volumio nmbd[2324]: [2024/07/22 11:52:32.575691, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jul 22 11:52:32 volumio nmbd[2324]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.23.115 for name WORKGROUP<1d>.
Jul 22 11:52:32 volumio nmbd[2324]: This response was from IP 192.168.23.83, reporting an IP address of 192.168.23.83.
Jul 22 11:52:32 volumio rc.local[2402]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:33 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::7edd:90ff:fe39:2a5e.
Jul 22 11:52:33 volumio avahi-daemon[2107]: New relevant interface wlan0.IPv6 for mDNS.
Jul 22 11:52:33 volumio systemd-networkd[2139]: wlan0: Gained IPv6LL
Jul 22 11:52:33 volumio avahi-daemon[2107]: Registering new address record for fe80::7edd:90ff:fe39:2a5e on wlan0.*.
Jul 22 11:52:33 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:33 volumio wireless.js[2291]: Stopped aP
Jul 22 11:52:33 volumio wireless.js[2291]: Start wireless flow
Jul 22 11:52:33 volumio wireless.js[2291]: Stopped hotspot (if there)..
Jul 22 11:52:33 volumio rc.local[2414]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:33 volumio wireless.js[2291]: DHCP IP
Jul 22 11:52:33 volumio wpa_supplicant[2417]: Successfully initialized wpa_supplicant
Jul 22 11:52:33 volumio wireless.js[2291]: Start ap
Jul 22 11:52:33 volumio wpa_supplicant[2417]: nl80211: Could not configure driver mode
Jul 22 11:52:33 volumio wpa_supplicant[2417]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Jul 22 11:52:33 volumio systemd-networkd[2139]: wlan0: Lost carrier
Jul 22 11:52:33 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:34 volumio rc.local[2423]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:34 volumio systemd-networkd[2139]: wlan0: Link DOWN
Jul 22 11:52:34 volumio avahi-daemon[2107]: Interface wlan0.IPv6 no longer relevant for mDNS.
Jul 22 11:52:34 volumio avahi-daemon[2107]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::7edd:90ff:fe39:2a5e.
Jul 22 11:52:34 volumio avahi-daemon[2107]: Withdrawing address record for fe80::7edd:90ff:fe39:2a5e on wlan0.
Jul 22 11:52:34 volumio wireless.js[2291]: trying...
Jul 22 11:52:34 volumio smbd[2400]: [2024/07/22 11:52:34.472528, 0] ../../source3/smbd/server.c:1734(main)
Jul 22 11:52:34 volumio smbd[2400]: smbd version 4.15.13-Ubuntu started.
Jul 22 11:52:34 volumio smbd[2400]: Copyright Andrew Tridgell and the Samba Team 1992-2021
Jul 22 11:52:34 volumio systemd-networkd[2139]: wlan0: Link UP
Jul 22 11:52:34 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:34 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:34 volumio wpa_supplicant[2417]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 22 11:52:34 volumio wpa_supplicant[2417]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 22 11:52:34 volumio sudo[2429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:34 volumio sudo[2429]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:34 volumio systemd[1]: systemd-rfkill.service: Succeeded.
Jul 22 11:52:34 volumio rc.local[2428]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:34 volumio sudo[2429]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:34 volumio systemd[1]: Started Samba SMB Daemon.
Jul 22 11:52:35 volumio rc.local[2444]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:35 volumio mpd[2323]: config_file: config parameter "gapless_mp3_playback" on line 19 is deprecated
Jul 22 11:52:35 volumio mpd[2323]: config_file: config parameter "buffer_before_play" on line 85 is deprecated
Jul 22 11:52:35 volumio mpd[2323]: config_file: config parameter "id3v1_encoding" on line 99 is deprecated
Jul 22 11:52:35 volumio mpd[2323]: Jul 22 11:52 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 22 11:52:35 volumio mpd[2323]: Jul 22 11:52 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jul 22 11:52:35 volumio mpd[2323]: Jul 22 11:52 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jul 22 11:52:35 volumio systemd[1]: Started Music Player Daemon.
Jul 22 11:52:35 volumio udisks-glue[2353]: Updating DB (#1) ...
Jul 22 11:52:35 volumio udisks-glue[2353]: volume: n/a repeat: off random: off single: off consume: off
Jul 22 11:52:35 volumio wireless.js[2291]: trying...
Jul 22 11:52:35 volumio rc.local[2450]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:36 volumio sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:36 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:36 volumio sudo[2452]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:36 volumio rc.local[2329]: IP is 127.0.0.1
Jul 22 11:52:36 volumio rc.local[2329]: Port is 47670
Jul 22 11:52:36 volumio rc.local[2329]: 8
Jul 22 11:52:36 volumio rc.local[2329]: [2024-07-22 11:52:36] [info] asio async_connect error: asio.system:111 (Connection refused)
Jul 22 11:52:36 volumio rc.local[2329]: [2024-07-22 11:52:36] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected)
Jul 22 11:52:36 volumio rc.local[2329]: [2024-07-22 11:52:36] [error] handle_connect error: Connection refused
Jul 22 11:52:36 volumio rc.local[2462]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:37 volumio wireless.js[2291]: trying...
Jul 22 11:52:37 volumio rc.local[2464]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:37 volumio sudo[2466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:37 volumio sudo[2466]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:37 volumio sudo[2466]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:37 volumio rc.local[2476]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:38 volumio wireless.js[2291]: trying...
Jul 22 11:52:38 volumio rc.local[2478]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:38 volumio sudo[2480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:38 volumio sudo[2480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:38 volumio sudo[2480]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:38 volumio rc.local[2490]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:39 volumio rc.local[2492]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:39 volumio wireless.js[2291]: trying...
Jul 22 11:52:39 volumio sudo[2494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:39 volumio sudo[2494]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:39 volumio sudo[2494]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:40 volumio rc.local[2504]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:40 volumio rc.local[2506]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:40 volumio wireless.js[2291]: trying...
Jul 22 11:52:40 volumio sudo[2508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:40 volumio sudo[2508]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:40 volumio sudo[2508]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:41 volumio rc.local[2518]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:41 volumio rc.local[2520]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:41 volumio wireless.js[2291]: trying...
Jul 22 11:52:42 volumio sudo[2522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:42 volumio sudo[2522]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:42 volumio sudo[2522]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:42 volumio rc.local[2532]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:43 volumio rc.local[2534]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:43 volumio wireless.js[2291]: trying...
Jul 22 11:52:43 volumio sudo[2536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:43 volumio sudo[2536]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:43 volumio sudo[2536]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:43 volumio rc.local[2546]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:43 volumio rc.local[2329]: [2024-07-22 11:52:43] [info] asio async_connect error: asio.system:111 (Connection refused)
Jul 22 11:52:43 volumio rc.local[2329]: [2024-07-22 11:52:43] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected)
Jul 22 11:52:43 volumio rc.local[2329]: [2024-07-22 11:52:43] [error] handle_connect error: Connection refused
Jul 22 11:52:44 volumio rc.local[2548]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:44 volumio wireless.js[2291]: trying...
Jul 22 11:52:44 volumio sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:44 volumio sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:44 volumio sudo[2550]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:44 volumio rc.local[2560]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:45 volumio rc.local[2562]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:45 volumio wireless.js[2291]: trying...
Jul 22 11:52:45 volumio sudo[2564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:45 volumio sudo[2564]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:45 volumio sudo[2564]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:46 volumio rc.local[2574]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:46 volumio rc.local[2576]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:46 volumio wireless.js[2291]: trying...
Jul 22 11:52:46 volumio sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:46 volumio sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:46 volumio sudo[2578]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:47 volumio rc.local[2588]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:47 volumio rc.local[2590]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:47 volumio wireless.js[2291]: trying...
Jul 22 11:52:47 volumio sudo[2592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:47 volumio sudo[2592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:47 volumio sudo[2592]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:48 volumio rc.local[2602]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:48 volumio rc.local[2604]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:52:48 volumio wireless.js[2291]: trying...
Jul 22 11:52:49 volumio sudo[2606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:52:49 volumio sudo[2606]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:52:49 volumio wpa_supplicant[2436]: wlan0: Trying to associate with 14:d8:64:4c:f2:43 (SSID='FORTEX' freq=2412 MHz)
Jul 22 11:52:49 volumio wpa_supplicant[2436]: Failed to add supported operating classes IE
Jul 22 11:52:49 volumio kernel: wlan0: authenticate with 14:d8:64:4c:f2:43
Jul 22 11:52:49 volumio kernel: wlan0: send auth to 14:d8:64:4c:f2:43 (try 1/3)
Jul 22 11:52:49 volumio kernel: wlan0: authenticated
Jul 22 11:52:49 volumio sudo[2606]: pam_unix(sudo:session): session closed for user root
Jul 22 11:52:49 volumio kernel: wlan0: associate with 14:d8:64:4c:f2:43 (try 1/3)
Jul 22 11:52:49 volumio kernel: wlan0: RX AssocResp from 14:d8:64:4c:f2:43 (capab=0x1c11 status=0 aid=2)
Jul 22 11:52:49 volumio kernel: wlan0: associated
Jul 22 11:52:49 volumio systemd-timesyncd[2088]: Network configuration changed, trying to establish connection.
Jul 22 11:52:49 volumio kernel: wlan0: Limiting TX power to 35 (35 - 0) dBm as advertised by 14:d8:64:4c:f2:43
Jul 22 11:52:49 volumio kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jul 22 11:52:49 volumio systemd-networkd[2139]: wlan0: Gained carrier
Jul 22 11:52:49 volumio wpa_supplicant[2436]: wlan0: Associated with 14:d8:64:4c:f2:43
Jul 22 11:52:49 volumio systemd-networkd[2139]: wlan0: Connected WiFi access point: FORTEX (14:d8:64:4c:f2:43)
Jul 22 11:52:49 volumio systemd-networkd[2139]: wlan0: found matching network '/etc/systemd/network/11-wlan0.network', based on potentially unpredictable ifname
Jul 22 11:52:49 volumio systemd-networkd[2139]: wlan0: Lost carrier
Jul 22 11:52:49 volumio systemd-networkd[2139]: wlan0: Gained carrier
Jul 22 11:52:49 volumio wpa_supplicant[2436]: wlan0: WPA: Key negotiation completed with 14:d8:64:4c:f2:43 [PTK=CCMP GTK=CCMP]
Jul 22 11:52:49 volumio wpa_supplicant[2436]: wlan0: CTRL-EVENT-CONNECTED - Connection to 14:d8:64:4c:f2:43 completed [id=0 id_str=]
Jul 22 11:52:49 volumio systemd-resolved[2309]: Using degraded feature set (UDP) for DNS server 211.136.192.6.
Jul 22 11:53:00 volumio systemd-timesyncd[2088]: Initial synchronization to time server 185.125.190.56:123 (ntp.ubuntu.com).
Jul 22 11:53:00 volumio rc.local[2620]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:00 volumio systemd-networkd[2139]: wlan0: DHCPv4 address 192.168.23.121/24 via 192.168.23.1
Jul 22 11:53:00 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.23.121.
Jul 22 11:53:00 volumio avahi-daemon[2107]: New relevant interface wlan0.IPv4 for mDNS.
Jul 22 11:53:00 volumio avahi-daemon[2107]: Registering new address record for 192.168.23.121 on wlan0.IPv4.
Jul 22 11:53:01 volumio rc.local[2623]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:01 volumio wireless.js[2291]: trying...
Jul 22 11:53:01 volumio sudo[2625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 22 11:53:01 volumio sudo[2625]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:01 volumio sudo[2625]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:01 volumio wireless.js[2291]: Connected to: ----FORTEX
Jul 22 11:53:01 volumio wireless.js[2291]: ----
Jul 22 11:53:01 volumio sudo[2635]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 22 11:53:01 volumio sudo[2635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:01 volumio sudo[2635]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:01 volumio wireless.js[2291]: ... joined AP, wlan0 IPv4 is 192.168.23.121, ipV6 is fe80::7edd:90ff:fe39:2a5e
Jul 22 11:53:01 volumio wireless.js[2291]: It's done! AP
Jul 22 11:53:01 volumio avahi-daemon[2107]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::7edd:90ff:fe39:2a5e.
Jul 22 11:53:01 volumio avahi-daemon[2107]: New relevant interface wlan0.IPv6 for mDNS.
Jul 22 11:53:01 volumio systemd-networkd[2139]: wlan0: Gained IPv6LL
Jul 22 11:53:01 volumio avahi-daemon[2107]: Registering new address record for fe80::7edd:90ff:fe39:2a5e on wlan0.*.
Jul 22 11:53:01 volumio systemd[1]: Started Wireless Services.
Jul 22 11:53:01 volumio systemd[1]: Started Volumio Backend Module.
Jul 22 11:53:01 volumio systemd[1]: Reached target Multi-User System.
Jul 22 11:53:01 volumio systemd[1]: Reached target Graphical Interface.
Jul 22 11:53:01 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jul 22 11:53:01 volumio rc.local[2648]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:01 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jul 22 11:53:01 volumio systemd[1]: Finished Update UTMP about System Runlevel Changes.
Jul 22 11:53:01 volumio systemd[1]: Startup finished in 3.790s (kernel) + 29.335s (userspace) = 33.126s.
Jul 22 11:53:02 volumio rc.local[2656]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:02 volumio kernel: usb0-vbus: disabling
Jul 22 11:53:03 volumio rc.local[2658]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:03 volumio rc.local[2660]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:04 volumio rc.local[2662]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:04 volumio rc.local[2664]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:05 volumio rc.local[2666]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Jul 22 11:53:06 volumio rc.local[2329]: [2024-07-22 11:53:06] [connect] Successful connection
Jul 22 11:53:07 volumio volumio[2645]: info: -------------------------------------------
Jul 22 11:53:07 volumio volumio[2645]: info: ----- Volumio2 ----
Jul 22 11:53:07 volumio volumio[2645]: info: -------------------------------------------
Jul 22 11:53:07 volumio volumio[2645]: info: ----- System startup ----
Jul 22 11:53:07 volumio volumio[2645]: info: -------------------------------------------
Jul 22 11:53:09 volumio volumio[2645]: info: Plugin folders cleanup
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning into folder /volumio/app/plugins/
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category audio_interface
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category miscellanea
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category music_service
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category plugins.json
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category system_controller
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning category user_interface
Jul 22 11:53:09 volumio volumio[2645]: info: Scanning into folder /data/plugins/
Jul 22 11:53:09 volumio volumio[2645]: info: Plugin folders cleanup completed
Jul 22 11:53:09 volumio volumio[2645]: info: -------------------------------------------
Jul 22 11:53:09 volumio volumio[2645]: info: ----- Core plugins startup ----
Jul 22 11:53:09 volumio volumio[2645]: info: -------------------------------------------
Jul 22 11:53:09 volumio volumio[2645]: info: Loading plugins from folder /volumio/app/plugins/
Jul 22 11:53:09 volumio volumio[2645]: info: Adding plugin upnp to MyMusic Plugins
Jul 22 11:53:09 volumio volumio[2645]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 22 11:53:09 volumio volumio[2645]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 22 11:53:09 volumio volumio[2645]: info: Loading plugins from folder /data/plugins/
Jul 22 11:53:09 volumio volumio[2645]: info: Loading plugin "system"...
Jul 22 11:53:09 volumio volumio[2645]: info: Loading plugin "appearance"...
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "network"...
Jul 22 11:53:16 volumio volumio[2645]: info: Refreshing Cached IP Addresses
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "services"...
Jul 22 11:53:16 volumio sudo[2680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "alsa_controller"...
Jul 22 11:53:16 volumio sudo[2684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 22 11:53:16 volumio sudo[2680]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:16 volumio sudo[2684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:16 volumio sudo[2680]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:16 volumio sudo[2684]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "wizard"...
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "volumio_command_line_client"...
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "upnp"...
Jul 22 11:53:16 volumio volumio[2645]: info: [1721620396835] Starting Upmpd Daemon
Jul 22 11:53:16 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "my_music"...
Jul 22 11:53:16 volumio volumio[2645]: info: Loading plugin "mpd"...
Jul 22 11:53:18 volumio volumio[2645]: info: Loading plugin "upnp_browser"...
Jul 22 11:53:19 volumio volumio[2645]: info: Loading plugin "networkfs"...
Jul 22 11:53:19 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 22 11:53:19 volumio volumio[2645]: info: Loading plugin "alarm-clock"...
Jul 22 11:53:19 volumio volumio[2645]: info: Loading plugin "airplay_emulation"...
Jul 22 11:53:19 volumio volumio[2645]: info: Starting Shairport Sync
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "last_100"...
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "webradio"...
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "i2s_dacs"...
Jul 22 11:53:20 volumio volumio[2645]: info: I2S DAC not set, start Auto-detection
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "volumiodiscovery"...
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** For more information see
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 22 11:53:20 volumio volumio[2645]: *** WARNING *** For more information see
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** For more information see
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 22 11:53:20 volumio node[2645]: *** WARNING *** For more information see
Jul 22 11:53:20 volumio volumio[2645]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 22 11:53:20 volumio volumio[2645]: Discovery: StartAdv! undefined
Jul 22 11:53:20 volumio volumio[2645]: Discovery: Started advertising... Volumio - undefined
Jul 22 11:53:20 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "outputs"...
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "albumart"...
Jul 22 11:53:20 volumio volumio[2645]: info: Plugin example_plugin is not enabled
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "inputs"...
Jul 22 11:53:20 volumio volumio[2645]: info: Loading plugin "updater_comm"...
Jul 22 11:53:21 volumio volumio[2709]: Forking 1 albumart workers
Jul 22 11:53:21 volumio volumio[2645]: info: Plugin mpdemulation is not enabled
Jul 22 11:53:21 volumio volumio[2645]: info: Loading plugin "rest_api"...
Jul 22 11:53:21 volumio volumio[2645]: info: Loading plugin "websocket"...
Jul 22 11:53:22 volumio volumio[2645]: info: ___________ START PLUGINS ___________
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 22 11:53:22 volumio volumio[2645]: info: [1721620402050] CoreMusicLibrary::Adding element Media Servers
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 22 11:53:22 volumio volumio[2645]: info: [1721620402524] CoreMusicLibrary::Adding element Last_100
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 22 11:53:22 volumio volumio[2645]: info: [1721620402543] CoreMusicLibrary::Adding element Webradio
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 22 11:53:22 volumio volumio[2645]: info: Loading i18n strings for locale zh
Jul 22 11:53:22 volumio volumio[2645]: Updating browse sources language
Jul 22 11:53:22 volumio volumio[2645]: Cannot find translation for sourceMedia Servers
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::initPlayerControls
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 22 11:53:22 volumio volumio[2715]: Starting albumart workers
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 22 11:53:22 volumio volumio[2645]: info: BOOT COMPLETED
Jul 22 11:53:22 volumio volumio[2645]: [Metrics] CommandRouter: 15s 793.76ms
Jul 22 11:53:22 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 22 11:53:23 volumio kernel: sunxi-spdif 2036000.spdif: active: 1
Jul 22 11:53:27 volumio rc.local[2329]: [2024-07-22 11:53:27] [connect] Successful connection
Jul 22 11:53:28 volumio volumio[2645]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Jul 22 11:53:28 volumio volumio[2645]: info: CoreCommandRouter::Close All Modals sent
Jul 22 11:53:28 volumio volumio[2645]: info: CoreCommandRouter::Close All Modals sent
Jul 22 11:53:28 volumio volumio[2645]: Express server listening on port 3000
Jul 22 11:53:28 volumio volumio[2645]: [Metrics] WebUI: 22s 751.12ms
Jul 22 11:53:28 volumio volumio[2645]: info: Cannot retrieve data for calling home
Jul 22 11:53:28 volumio volumio[2645]: info: CoreStateMachine::resetVolumioState
Jul 22 11:53:28 volumio volumio[2645]: info: CoreStateMachine::getcurrentVolume
Jul 22 11:53:28 volumio volumio[2645]: info: CoreCommandRouter::volumioRetrievevolume
Jul 22 11:53:28 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 22 11:53:28 volumio sudo[2747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 22 11:53:28 volumio volumio[2645]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jul 22 11:53:29 volumio sudo[2747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:29 volumio sudo[2750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 22 11:53:29 volumio sudo[2747]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:29 volumio sudo[2750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:29 volumio systemd-resolved[2309]: Using degraded feature set (UDP) for DNS server 211.136.192.6.
Jul 22 11:53:29 volumio sudo[2750]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:29 volumio volumio[2645]: info: CoreStateMachine::pushState
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioPushState
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 11:53:29 volumio volumio[2645]: info: CoreStateMachine::updateTrackBlock
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getTrackBlock
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioRetrievevolume
Jul 22 11:53:29 volumio volumio[2645]: info: MPD running with PID2323
Jul 22 11:53:29 volumio volumio[2645]: ,establishing connection
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 22 11:53:29 volumio rc.local[2329]: [2024-07-22 11:53:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1721620407 101
Jul 22 11:53:29 volumio rc.local[2329]: sio connected
Jul 22 11:53:29 volumio volumio[2645]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Jul 22 11:53:29 volumio volumio[2645]: sudo: /usr/sbin/i2cdetect: command not found
Jul 22 11:53:29 volumio volumio[2645]: info: CoreStateMachine::pushState
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioPushState
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioGetState
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:29 volumio rc.local[2329]: command_len 9
Jul 22 11:53:29 volumio rc.local[2329]: getQueue
Jul 22 11:53:29 volumio rc.local[2329]:
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioGetQueue
Jul 22 11:53:29 volumio volumio[2645]: info: CoreStateMachine::getQueue
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getQueue
Jul 22 11:53:29 volumio volumio[2645]: info: CoreCommandRouter::volumioGetQueue
Jul 22 11:53:29 volumio volumio[2645]: info: CoreStateMachine::getQueue
Jul 22 11:53:29 volumio volumio[2645]: info: CorePlayQueue::getQueue
Jul 22 11:53:29 volumio rc.local[2329]: socket send
Jul 22 11:53:29 volumio rc.local[2329]: socket send
Jul 22 11:53:30 volumio volumio[2645]: info: Reloading queue from file
Jul 22 11:53:30 volumio volumio[2645]: error: updateQueue error: null
Jul 22 11:53:30 volumio volumio[2645]: info: CoreStateMachine::setRepeat null single undefined
Jul 22 11:53:30 volumio volumio[2645]: info: CoreStateMachine::pushState
Jul 22 11:53:30 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:30 volumio volumio[2645]: info: CoreCommandRouter::volumioPushState
Jul 22 11:53:30 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 11:53:30 volumio volumio[2645]: info: CoreStateMachine::setRandom null
Jul 22 11:53:30 volumio volumio[2645]: info: CoreStateMachine::pushState
Jul 22 11:53:30 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:30 volumio volumio[2645]: info: CoreCommandRouter::volumioPushState
Jul 22 11:53:30 volumio volumio[2645]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 11:53:30 volumio volumio[2645]: Discovery: adding c5f1452e-5715-489b-b731-347381f23cb3
Jul 22 11:53:30 volumio volumio[2645]: info: mDNS: Found device abcd
Jul 22 11:53:30 volumio volumio[2645]: error: Could not retrieve plugin audio_interface multiroom
Jul 22 11:53:30 volumio volumio[2645]: Discovery: this is already registered, c5f1452e-5715-489b-b731-347381f23cb3
Jul 22 11:53:30 volumio volumio[2645]: info: mDNS: Found device abcd
Jul 22 11:53:30 volumio volumio[2645]: info: CoreCommandRouter::volumioGetState
Jul 22 11:53:30 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:30 volumio volumio[2645]: error: Could not retrieve plugin audio_interface multiroom
Jul 22 11:53:30 volumio volumio[2645]: error: Could not retrieve plugin audio_interface multiroom
Jul 22 11:53:30 volumio volumio[2645]: info: Starting Shairport Sync
Jul 22 11:53:30 volumio volumio[2645]: info: Starting Shairport Sync
Jul 22 11:53:31 volumio sudo[2784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 22 11:53:31 volumio sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:31 volumio volumio[2645]: info: CoreCommandRouter::volumioGetState
Jul 22 11:53:31 volumio volumio[2645]: info: CorePlayQueue::getTrack 0
Jul 22 11:53:31 volumio sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 22 11:53:31 volumio sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:31 volumio sudo[2792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 22 11:53:31 volumio sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 11:53:31 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 22 11:53:31 volumio sudo[2784]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:31 volumio sudo[2786]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:31 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 22 11:53:31 volumio sudo[2792]: pam_unix(sudo:session): session closed for user root
Jul 22 11:53:32 volumio volumio[2645]: info: Upmpdcli Daemon Started
Jul 22 11:53:32 volumio volumio[2645]: info: Shairport-Sync Started
Jul 22 11:53:32 volumio volumio[2645]: Error adding Membership: Error: addMembership EINVAL
Jul 22 11:53:32 volumio volumio[2645]: info: Shairport-Sync Started
Jul 22 11:53:32 volumio volumio[2645]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 11:53:32 volumio volumio[2645]: TypeError: Cannot read property 'UUID' of undefined
Jul 22 11:53:32 volumio volumio[2645]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:174:53)
Jul 22 11:53:32 volumio volumio[2645]: at emitTwo (events.js:126:13)
Jul 22 11:53:32 volumio volumio[2645]: at Browser.emit (events.js:214:7)
Jul 22 11:53:32 volumio volumio[2645]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Jul 22 11:53:32 volumio volumio[2645]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Jul 22 11:53:32 volumio volumio[2645]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Jul 22 11:53:32 volumio volumio[2645]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Jul 22 11:53:32 volumio volumio[2645]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Jul 22 11:53:32 volumio volumio[2645]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 11:53:34 volumio sudo[2845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 11:52
Jul 22 11:53:34 volumio sudo[2845]: pam_unix(sudo:session): session opened for user root by (uid=0)
NAME="Ubuntu"
VERSION="20.04.5 LTS (Focal Fossa)"
ID=ubuntu
ID_LIKE=debian
PRETTY_NAME="Ubuntu 20.04.5 LTS"
VERSION_ID="20.04"
HOME_URL="https://www.ubuntu.com/"
SUPPORT_URL="https://help.ubuntu.com/"
BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/"
PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy"
VERSION_CODENAME=focal
UBUNTU_CODENAME=focal
VOLUMIO_BUILD_VERSION=""
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="armv7"