-- Logs begin at Tue 2025-06-10 23:25:55 CST, end at Thu 2025-06-26 08:04:59 CST. -- Jun 26 08:03:00 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetQueue Jun 26 08:03:00 volumiomini volumio[1351]: info: CoreStateMachine::getQueue Jun 26 08:03:00 volumiomini volumio[1351]: info: CorePlayQueue::getQueue Jun 26 08:03:05 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 26 08:03:05 volumiomini volumio[1351]: info: Received Get System Info Jun 26 08:03:05 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 08:03:05 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 08:03:05 volumiomini volumio[1351]: info: Discovery: Getting this device information Jun 26 08:03:05 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:03:05 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:03:05 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 08:03:06 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:03:06 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 08:03:07 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jun 26 08:03:07 volumiomini sudo[3717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jun 26 08:03:07 volumiomini sudo[3717]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 26 08:03:07 volumiomini sudo[3723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3723]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3717]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 26 08:03:07 volumiomini sudo[3730]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3730]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 26 08:03:07 volumiomini sudo[3735]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3735]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 26 08:03:07 volumiomini sudo[3742]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 26 08:03:07 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 26 08:03:07 volumiomini sudo[3742]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 08:03:07 volumiomini sudo[3745]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3745]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:07 volumiomini sudo[3749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 26 08:03:07 volumiomini sudo[3749]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:07 volumiomini sudo[3749]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:18 volumiomini volumio[1351]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object] Jun 26 08:03:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Jun 26 08:03:19 volumiomini sudo[3771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Jun 26 08:03:19 volumiomini sudo[3771]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:19 volumiomini sudo[3771]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:19 volumiomini volumio[1351]: info: Permissions for /etc/hostapd/hostapd.conf Jun 26 08:03:19 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jun 26 08:03:19 volumiomini volumio[1351]: info: Discovery: Restarting Advertising due to device name change Jun 26 08:03:19 volumiomini sudo[3774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jun 26 08:03:19 volumiomini sudo[3774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:19 volumiomini systemd[1]: Stopping Wireless Services... Jun 26 08:03:19 volumiomini wpa_supplicant[1097]: wlan0: CTRL-EVENT-DISCONNECTED bssid=20:28:3e:1c:94:41 reason=3 locally_generated=1 Jun 26 08:03:19 volumiomini dhcpcd[941]: wlan0: carrier lost Jun 26 08:03:19 volumiomini wpa_supplicant[1097]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 26 08:03:19 volumiomini avahi-daemon[814]: Withdrawing address record for 192.168.35.106 on wlan0. Jun 26 08:03:19 volumiomini avahi-daemon[814]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.35.106. Jun 26 08:03:19 volumiomini avahi-daemon[814]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 26 08:03:19 volumiomini volumio[1351]: info: Discovery: A device disappeared from network Jun 26 08:03:19 volumiomini volumio[1351]: info: Discovery: A device disappeared from network Jun 26 08:03:19 volumiomini wpa_supplicant[1097]: wlan0: CTRL-EVENT-TERMINATING Jun 26 08:03:19 volumiomini systemd[1]: wireless.service: Succeeded. Jun 26 08:03:19 volumiomini systemd[1]: Stopped Wireless Services. Jun 26 08:03:19 volumiomini dhcpcd[941]: wlan0: deleting route to 192.168.32.0/22 Jun 26 08:03:19 volumiomini dhcpcd[941]: wlan0: deleting default route via 192.168.32.1 Jun 26 08:03:19 volumiomini systemd[1]: Starting Wireless Services... Jun 26 08:03:20 volumiomini wireless.js[3793]: Cleaning previous... Jun 26 08:03:20 volumiomini sudo[3825]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 26 08:03:20 volumiomini sudo[3825]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini sudo[3825]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:20 volumiomini sudo[3827]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 26 08:03:20 volumiomini sudo[3827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini sudo[3827]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:20 volumiomini wireless.js[3793]: Stopped aP Jun 26 08:03:20 volumiomini sudo[3834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 26 08:03:20 volumiomini sudo[3834]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini sudo[3834]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:20 volumiomini volumio[1351]: info: Volumio Network Manager: Network status updated: 1 Jun 26 08:03:20 volumiomini sudo[3847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 26 08:03:20 volumiomini sudo[3847]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini sudo[3847]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:20 volumiomini sudo[3857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 26 08:03:20 volumiomini sudo[3857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini sudo[3857]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:20 volumiomini sudo[3859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 26 08:03:20 volumiomini sudo[3859]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:20 volumiomini volumio[1351]: info: Discovery: A device disappeared from network Jun 26 08:03:21 volumiomini sudo[3859]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:21 volumiomini wireless.js[3793]: SETTING APPROPRIATE REG DOMAIN: CN Jun 26 08:03:21 volumiomini sudo[3864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 26 08:03:21 volumiomini sudo[3864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:21 volumiomini sudo[3864]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:21 volumiomini sudo[3866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Jun 26 08:03:21 volumiomini sudo[3866]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:21 volumiomini sudo[3866]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:21 volumiomini wireless.js[3793]: SUCCESSFULLY SET NEW REGDOMAIN: CN Jun 26 08:03:21 volumiomini wireless.js[3793]: Start wireless flow Jun 26 08:03:21 volumiomini wireless.js[3793]: Stopped hotspot (if there).. Jun 26 08:03:21 volumiomini sudo[3871]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 26 08:03:21 volumiomini sudo[3871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:21 volumiomini sudo[3871]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:21 volumiomini sudo[3873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 26 08:03:21 volumiomini sudo[3873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:21 volumiomini sudo[3873]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:21 volumiomini wireless.js[3793]: DHCP IP Jun 26 08:03:21 volumiomini wireless.js[3793]: Start ap Jun 26 08:03:21 volumiomini wpa_supplicant[3875]: Successfully initialized wpa_supplicant Jun 26 08:03:21 volumiomini sudo[3876]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 26 08:03:21 volumiomini sudo[3876]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:22 volumiomini dhcpcd[3877]: sending commands to master dhcpcd process Jun 26 08:03:22 volumiomini dhcpcd[941]: control command: /sbin/dhcpcd Jun 26 08:03:22 volumiomini sudo[3876]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:22 volumiomini wireless.js[3793]: trying... Jun 26 08:03:23 volumiomini sudo[3885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:23 volumiomini sudo[3885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:23 volumiomini sudo[3885]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:23 volumiomini ntpd[1314]: Deleting interface #4 wlan0, 192.168.35.106#123, interface stats: received=0, sent=0, dropped=0, active_time=281 secs Jun 26 08:03:23 volumiomini wireless.js[3793]: trying... Jun 26 08:03:23 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with d4:c8:b0:06:d0:41 (SSID='encrypt' freq=2437 MHz) Jun 26 08:03:24 volumiomini sudo[3888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:24 volumiomini sudo[3888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:24 volumiomini sudo[3888]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:24 volumiomini volumio[1351]: info: Discovery: Started advertising with name: Volumiomini Jun 26 08:03:24 volumiomini wireless.js[3793]: trying... Jun 26 08:03:25 volumiomini sudo[3892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:25 volumiomini sudo[3892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:25 volumiomini sudo[3892]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:25 volumiomini volumio[1351]: info: Discovery: adding 05a20189-f040-496d-8bc1-996259c7a03d Jun 26 08:03:25 volumiomini volumio[1351]: info: Discovery: Found device Volumiomini Jun 26 08:03:25 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:03:25 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:03:25 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 26 08:03:25 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 26 08:03:25 volumiomini volumio[1351]: info: Discovery: Getting this device information Jun 26 08:03:25 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:03:25 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:03:25 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 26 08:03:25 volumiomini wireless.js[3793]: trying... Jun 26 08:03:26 volumiomini sudo[3896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:26 volumiomini sudo[3896]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:26 volumiomini sudo[3896]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:26 volumiomini wireless.js[3793]: trying... Jun 26 08:03:27 volumiomini sudo[3899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:27 volumiomini sudo[3899]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:27 volumiomini sudo[3899]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:27 volumiomini wireless.js[3793]: trying... Jun 26 08:03:28 volumiomini sudo[3902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:28 volumiomini sudo[3902]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:28 volumiomini sudo[3902]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:28 volumiomini wireless.js[3793]: trying... Jun 26 08:03:29 volumiomini sudo[3905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:29 volumiomini sudo[3905]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:29 volumiomini sudo[3905]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:29 volumiomini wireless.js[3793]: trying... Jun 26 08:03:30 volumiomini sudo[3908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:30 volumiomini sudo[3908]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:30 volumiomini sudo[3908]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:30 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:30 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:30 volumiomini wireless.js[3793]: trying... Jun 26 08:03:31 volumiomini sudo[3972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:31 volumiomini sudo[3972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:31 volumiomini sudo[3972]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:31 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with 20:28:3e:1c:94:41 (SSID='encrypt' freq=2412 MHz) Jun 26 08:03:32 volumiomini wireless.js[3793]: trying... Jun 26 08:03:32 volumiomini sudo[3975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:32 volumiomini sudo[3975]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:32 volumiomini sudo[3975]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:33 volumiomini wireless.js[3793]: trying... Jun 26 08:03:33 volumiomini sudo[3978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:33 volumiomini sudo[3978]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:33 volumiomini sudo[3978]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:34 volumiomini wireless.js[3793]: trying... Jun 26 08:03:34 volumiomini sudo[3984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:34 volumiomini sudo[3984]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:34 volumiomini sudo[3984]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:34 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:03:34 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 26 08:03:34 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 26 08:03:34 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 26 08:03:35 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 26 08:03:35 volumiomini wireless.js[3793]: trying... Jun 26 08:03:35 volumiomini sudo[4001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:35 volumiomini sudo[4001]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:35 volumiomini sudo[4001]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:35 volumiomini volumio[1351]: info: Received Get System Version Jun 26 08:03:35 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 26 08:03:35 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jun 26 08:03:36 volumiomini wireless.js[3793]: trying... Jun 26 08:03:36 volumiomini sudo[4004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:36 volumiomini sudo[4004]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:36 volumiomini sudo[4004]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:37 volumiomini wireless.js[3793]: trying... Jun 26 08:03:37 volumiomini sudo[4007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:37 volumiomini sudo[4007]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:37 volumiomini sudo[4007]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:38 volumiomini wireless.js[3793]: trying... Jun 26 08:03:38 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:38 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:38 volumiomini sudo[4010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:38 volumiomini sudo[4010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:38 volumiomini sudo[4010]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:38 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with 20:28:3e:1c:9d:81 (SSID='encrypt' freq=2462 MHz) Jun 26 08:03:39 volumiomini wireless.js[3793]: trying... Jun 26 08:03:39 volumiomini sudo[4013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:39 volumiomini sudo[4013]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:39 volumiomini sudo[4013]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:39 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:03:40 volumiomini wireless.js[3793]: trying... Jun 26 08:03:40 volumiomini sudo[4021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:40 volumiomini sudo[4021]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:40 volumiomini sudo[4021]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:41 volumiomini wireless.js[3793]: trying... Jun 26 08:03:41 volumiomini sudo[4039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:41 volumiomini sudo[4039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:41 volumiomini sudo[4039]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:41 volumiomini nmbd[2708]: [2025/06/26 08:03:41.684966, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 26 08:03:41 volumiomini nmbd[2708]: Packet send failed to 192.168.35.255(138) ERRNO=Network is unreachable Jun 26 08:03:42 volumiomini wireless.js[3793]: trying... Jun 26 08:03:42 volumiomini sudo[4042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 26 08:03:42 volumiomini sudo[4042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:42 volumiomini sudo[4042]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:43 volumiomini wireless.js[3793]: Overtime, starting plan B Jun 26 08:03:43 volumiomini systemd[1]: Started Wireless Services. Jun 26 08:03:43 volumiomini sudo[3774]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 26 08:03:43 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 08:03:45 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:45 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:46 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with 10:c1:72:19:e6:41 (SSID='encrypt' freq=2462 MHz) Jun 26 08:03:48 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jun 26 08:03:48 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jun 26 08:03:48 volumiomini sudo[4052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 08:03:48 volumiomini sudo[4052]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:48 volumiomini sudo[4052]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:52 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:52 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:03:53 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jun 26 08:03:53 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jun 26 08:03:53 volumiomini volumio[1351]: info: Refreshing Cached IP Addresses Jun 26 08:03:53 volumiomini sudo[4069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 26 08:03:53 volumiomini sudo[4069]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:53 volumiomini sudo[4071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 26 08:03:53 volumiomini sudo[4069]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:53 volumiomini sudo[4071]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:53 volumiomini sudo[4071]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:53 volumiomini sudo[4074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 08:03:53 volumiomini sudo[4074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:03:53 volumiomini systemd[1]: upmpdcli.service: Succeeded. Jun 26 08:03:53 volumiomini sudo[4074]: pam_unix(sudo:session): session closed for user root Jun 26 08:03:54 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with d4:c8:b0:06:d0:41 (SSID='encrypt' freq=2437 MHz) Jun 26 08:04:01 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:04:01 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="encrypt" auth_failures=1 duration=10 reason=CONN_FAILED Jun 26 08:04:01 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:04:03 volumiomini sudo[4096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 26 08:04:03 volumiomini sudo[4096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:03 volumiomini sudo[4096]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:03 volumiomini sudo[4098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 26 08:04:03 volumiomini sudo[4098]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:03 volumiomini sudo[4098]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:03 volumiomini sudo[4102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 26 08:04:03 volumiomini sudo[4102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:03 volumiomini systemd[1]: Started UPnP Renderer front-end to MPD. Jun 26 08:04:03 volumiomini sudo[4102]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:03 volumiomini volumio[1351]: info: Upmpdcli Daemon Started Jun 26 08:04:03 volumiomini volumio[4104]: writing RSA key Jun 26 08:04:12 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="encrypt" Jun 26 08:04:12 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with 20:28:3e:1c:94:41 (SSID='encrypt' freq=2412 MHz) Jun 26 08:04:18 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:04:18 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="encrypt" auth_failures=2 duration=23 reason=CONN_FAILED Jun 26 08:04:18 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1 Jun 26 08:04:18 volumiomini volumio[1351]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jun 26 08:04:18 volumiomini sudo[4337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 26 08:04:18 volumiomini sudo[4337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:18 volumiomini sudo[4337]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:18 volumiomini volumio[1351]: info: MPD Permissions set Jun 26 08:04:18 volumiomini sudo[4340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 26 08:04:18 volumiomini sudo[4340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini systemd[1]: Stopping Music Player Daemon... Jun 26 08:04:18 volumiomini systemd[1]: mpd.service: Succeeded. Jun 26 08:04:18 volumiomini systemd[1]: Stopped Music Player Daemon. Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 26 08:04:18 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:18 volumiomini systemd[1]: Starting Music Player Daemon... Jun 26 08:04:19 volumiomini sudo[4346]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 26 08:04:19 volumiomini sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:19 volumiomini sudo[4346]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:19 volumiomini mpd[4350]: Jun 26 08:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 26 08:04:19 volumiomini systemd[1]: Started Music Player Daemon. Jun 26 08:04:19 volumiomini sudo[4340]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:19 volumiomini volumio[1351]: error: updateQueue error: null Jun 26 08:04:26 volumiomini volumio[1351]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:04:26 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:26 volumiomini volumio[1351]: info: Restoring Previous Volume level: 100 false true Jun 26 08:04:26 volumiomini volumio[1351]: info: VolumeController::SetAlsaVolume100 Jun 26 08:04:26 volumiomini volumio[1351]: info: Enable softmixer device for audio device number 0,0 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioStop Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreStateMachine::stop Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 26 08:04:26 volumiomini volumio[1351]: info: Enable softmixer device for audio device undefined Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 26 08:04:26 volumiomini volumio[1351]: info: Updating Volume Controller Parameters: Device: 0,0 Name: HDMI 0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 26 08:04:26 volumiomini volumio[1351]: info: Disabling external Volume Control Jun 26 08:04:26 volumiomini volumio[1351]: info: Output device has changed, restarting MPD Jun 26 08:04:26 volumiomini sudo[4383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 26 08:04:26 volumiomini sudo[4383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini volumio[1351]: info: Output device has changed, restarting Shairport Sync Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:26 volumiomini sudo[4383]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:26 volumiomini sudo[4386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 26 08:04:26 volumiomini sudo[4386]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini systemd[1]: Stopping Music Player Daemon... Jun 26 08:04:26 volumiomini volumio[1351]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 26 08:04:26 volumiomini volumio[1351]: info: Volume configurations have been set Jun 26 08:04:26 volumiomini systemd[1]: mpd.service: Succeeded. Jun 26 08:04:26 volumiomini systemd[1]: Stopped Music Player Daemon. Jun 26 08:04:26 volumiomini systemd[1]: Starting Music Player Daemon... Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 26 08:04:26 volumiomini volumio[1351]: info: Updating Volume Controller Parameters: Device: 0,0 Name: HDMI 0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 26 08:04:26 volumiomini volumio[1351]: info: Disabling external Volume Control Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:26 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:26 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:26 volumiomini sudo[4391]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 26 08:04:26 volumiomini sudo[4391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini sudo[4391]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:26 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:26 volumiomini volumio[1351]: info: MPD Permissions set Jun 26 08:04:26 volumiomini volumio[1351]: info: Software Volume ALSA configuration written Jun 26 08:04:26 volumiomini volumio[1351]: info: Preparing to generate the ALSA configuration file Jun 26 08:04:26 volumiomini volumio[1351]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 26 08:04:26 volumiomini volumio[1351]: info: Reading ALSA contributions from plugins. Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 08:04:26 volumiomini volumio[1351]: info: Starting Shairport Sync Jun 26 08:04:26 volumiomini volumio[1351]: info: Asound.conf file written Jun 26 08:04:26 volumiomini sudo[4415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 26 08:04:26 volumiomini sudo[4415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 26 08:04:26 volumiomini systemd[1]: shairport-sync.service: Succeeded. Jun 26 08:04:26 volumiomini systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:26 volumiomini sudo[4418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 26 08:04:26 volumiomini sudo[4418]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:26 volumiomini sudo[4415]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:26 volumiomini sudo[4418]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:26 volumiomini volumio[1351]: info: Output device has changed, restarting MPD Jun 26 08:04:26 volumiomini sudo[4427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 26 08:04:26 volumiomini sudo[4427]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini volumio[1351]: info: Output device has changed, restarting Shairport Sync Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:26 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:26 volumiomini sudo[4427]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:26 volumiomini sudo[4429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 26 08:04:26 volumiomini sudo[4429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 26 08:04:26 volumiomini systemd[1]: mpd.service: Succeeded. Jun 26 08:04:26 volumiomini systemd[1]: Stopped Music Player Daemon. Jun 26 08:04:26 volumiomini volumio[1351]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 26 08:04:26 volumiomini systemd[1]: Starting Music Player Daemon... Jun 26 08:04:26 volumiomini sudo[4435]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 26 08:04:26 volumiomini sudo[4435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:26 volumiomini sudo[4435]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:27 volumiomini volumio[1351]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 26 08:04:27 volumiomini volumio[1351]: underrun!!! (at least 0.013 ms long) Jun 26 08:04:27 volumiomini volumio[1351]: underrun!!! (at least 0.008 ms long) Jun 26 08:04:27 volumiomini volumio[1351]: Found hardware: "HdmiLpeAudio" "" "" "" "" Jun 26 08:04:27 volumiomini volumio[1351]: Hardware is initialized using a generic method Jun 26 08:04:27 volumiomini volumio[1351]: info: Output device has changed, restarting MPD Jun 26 08:04:27 volumiomini volumio[1351]: info: Output device has changed, restarting Shairport Sync Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:27 volumiomini sudo[4443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 26 08:04:27 volumiomini sudo[4443]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:27 volumiomini sudo[4443]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:27 volumiomini sudo[4445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 26 08:04:27 volumiomini sudo[4445]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:27 volumiomini systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 26 08:04:27 volumiomini systemd[1]: mpd.service: Succeeded. Jun 26 08:04:27 volumiomini systemd[1]: Stopped Music Player Daemon. Jun 26 08:04:27 volumiomini volumio[1351]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 26 08:04:27 volumiomini systemd[1]: Starting Music Player Daemon... Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 26 08:04:27 volumiomini volumio[1351]: info: Updating Volume Controller Parameters: Device: 0,0 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 26 08:04:27 volumiomini volumio[1351]: info: Disabling external Volume Control Jun 26 08:04:27 volumiomini sudo[4451]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 26 08:04:27 volumiomini sudo[4451]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:27 volumiomini sudo[4451]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:27 volumiomini volumio[1351]: info: VolumeController::SetAlsaVolume0 Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:27 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:27 volumiomini volumio[1351]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jun 26 08:04:27 volumiomini volumio[1351]: info: MPD Permissions set Jun 26 08:04:27 volumiomini volumio[1351]: info: MPD Permissions set Jun 26 08:04:27 volumiomini volumio[1351]: info: Shairport-Sync Started Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:27 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 26 08:04:27 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:27 volumiomini volumio[1351]: info: Starting Shairport Sync Jun 26 08:04:27 volumiomini volumio[1351]: info: Starting Shairport Sync Jun 26 08:04:27 volumiomini sudo[4477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 26 08:04:27 volumiomini sudo[4477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:27 volumiomini systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 26 08:04:27 volumiomini sudo[4480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 26 08:04:27 volumiomini systemd[1]: shairport-sync.service: Succeeded. Jun 26 08:04:27 volumiomini sudo[4480]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:27 volumiomini systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:27 volumiomini systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:27 volumiomini sudo[4477]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:27 volumiomini volumio[1351]: info: Shairport-Sync Started Jun 26 08:04:27 volumiomini systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 26 08:04:27 volumiomini systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 26 08:04:27 volumiomini systemd[1]: shairport-sync.service: Succeeded. Jun 26 08:04:27 volumiomini systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:27 volumiomini systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 26 08:04:27 volumiomini sudo[4480]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:27 volumiomini volumio[1351]: info: Shairport-Sync Started Jun 26 08:04:28 volumiomini mpd[4462]: Jun 26 08:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 26 08:04:28 volumiomini systemd[1]: Started Music Player Daemon. Jun 26 08:04:28 volumiomini sudo[4429]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:28 volumiomini sudo[4386]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:28 volumiomini sudo[4445]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:28 volumiomini volumio[1351]: error: MPD error: The expression evaluated to a falsy value: Jun 26 08:04:28 volumiomini volumio[1351]: assert.ok(self.idling) Jun 26 08:04:28 volumiomini volumio[1351]: error: The expression evaluated to a falsy value: Jun 26 08:04:28 volumiomini volumio[1351]: assert.ok(self.idling) Jun 26 08:04:28 volumiomini volumio[1351]: error: MPD error: The expression evaluated to a falsy value: Jun 26 08:04:28 volumiomini volumio[1351]: assert.ok(self.idling) Jun 26 08:04:28 volumiomini volumio[1351]: error: The expression evaluated to a falsy value: Jun 26 08:04:28 volumiomini volumio[1351]: assert.ok(self.idling) Jun 26 08:04:28 volumiomini volumio[1351]: error: updateQueue error: null Jun 26 08:04:29 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jun 26 08:04:29 volumiomini sudo[4490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 26 08:04:29 volumiomini sudo[4490]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:29 volumiomini systemd[1]: Stopping Music Player Daemon... Jun 26 08:04:29 volumiomini systemd[1]: mpd.service: Succeeded. Jun 26 08:04:29 volumiomini systemd[1]: Stopped Music Player Daemon. Jun 26 08:04:29 volumiomini systemd[1]: Starting Music Player Daemon... Jun 26 08:04:29 volumiomini sudo[4492]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 26 08:04:29 volumiomini sudo[4492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:29 volumiomini sudo[4492]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:30 volumiomini mpd[4494]: Jun 26 08:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 26 08:04:30 volumiomini systemd[1]: Started Music Player Daemon. Jun 26 08:04:30 volumiomini sudo[4490]: pam_unix(sudo:session): session closed for user root Jun 26 08:04:30 volumiomini volumio[1351]: error: updateQueue error: null Jun 26 08:04:30 volumiomini volumio[1351]: info: VolumeController::SetAlsaVolume100 Jun 26 08:04:30 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:30 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:30 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:30 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:31 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 26 08:04:36 volumiomini volumio[1351]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:04:36 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:36 volumiomini volumio[1351]: info: Restoring Previous Volume level: 100 false true Jun 26 08:04:36 volumiomini volumio[1351]: info: VolumeController::SetAlsaVolume100 Jun 26 08:04:36 volumiomini volumio[1351]: info: Volume configurations have been set Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 26 08:04:36 volumiomini volumio[1351]: info: Updating Volume Controller Parameters: Device: 0,0 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 26 08:04:36 volumiomini volumio[1351]: info: Disabling external Volume Control Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:36 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:36 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 26 08:04:36 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 08:04:40 volumiomini volumio[1351]: info: VolumeController::SetAlsaVolume100 Jun 26 08:04:40 volumiomini volumio[1351]: info: CoreStateMachine::pushState Jun 26 08:04:40 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:40 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 26 08:04:40 volumiomini volumio[1351]: info: CoreCommandRouter::volumioPushState Jun 26 08:04:43 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="encrypt" Jun 26 08:04:43 volumiomini wpa_supplicant[3878]: wlan0: Trying to associate with 20:28:3e:1c:9d:81 (SSID='encrypt' freq=2462 MHz) Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: Associated with 20:28:3e:1c:9d:81 Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: WPA: Key negotiation completed with 20:28:3e:1c:9d:81 [PTK=CCMP GTK=TKIP] Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: CTRL-EVENT-CONNECTED - Connection to 20:28:3e:1c:9d:81 completed [id=0 id_str=] Jun 26 08:04:44 volumiomini dhcpcd[941]: wlan0: carrier acquired Jun 26 08:04:44 volumiomini dhcpcd[941]: wlan0: IAID 36:78:c1:38 Jun 26 08:04:44 volumiomini wpa_supplicant[3878]: wlan0: WPA: Group rekeying completed with 20:28:3e:1c:9d:81 [GTK=TKIP] Jun 26 08:04:44 volumiomini dhcpcd[941]: wlan0: soliciting an IPv6 router Jun 26 08:04:44 volumiomini dhcpcd[941]: wlan0: rebinding lease of 192.168.35.106 Jun 26 08:04:44 volumiomini dhcpcd[941]: wlan0: probing address 192.168.35.106/22 Jun 26 08:04:50 volumiomini dhcpcd[941]: wlan0: leased 192.168.35.106 for 259800 seconds Jun 26 08:04:50 volumiomini dhcpcd[941]: wlan0: adding route to 192.168.32.0/22 Jun 26 08:04:50 volumiomini avahi-daemon[814]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.35.106. Jun 26 08:04:50 volumiomini avahi-daemon[814]: New relevant interface wlan0.IPv4 for mDNS. Jun 26 08:04:50 volumiomini dhcpcd[941]: wlan0: adding default route via 192.168.32.1 Jun 26 08:04:50 volumiomini avahi-daemon[814]: Registering new address record for 192.168.35.106 on wlan0.IPv4. Jun 26 08:04:50 volumiomini ntpd[1314]: ntpd exiting on signal 15 (Terminated) Jun 26 08:04:50 volumiomini systemd[1]: Stopping Network Time Service... Jun 26 08:04:50 volumiomini ntpd[1314]: 108.59.2.24 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 101.43.66.2 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini systemd[1]: ntp.service: Succeeded. Jun 26 08:04:50 volumiomini ntpd[1314]: 116.203.151.74 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 193.182.111.12 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 139.199.214.202 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 202.118.1.81 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 119.28.206.193 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 119.28.183.184 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 162.159.200.123 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini ntpd[1314]: 14.103.157.44 local addr 192.168.35.105 -> Jun 26 08:04:50 volumiomini systemd[1]: Stopped Network Time Service. Jun 26 08:04:50 volumiomini systemd[1]: Starting Network Time Service... Jun 26 08:04:50 volumiomini ntpd[4627]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 26 08:04:50 volumiomini ntpd[4627]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 26 08:04:50 volumiomini systemd[1]: Started Network Time Service. Jun 26 08:04:50 volumiomini ntpd[4634]: proto: precision = 0.252 usec (-22) Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: adding 1cd3cecc-309e-4c8a-b141-60892392768e Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: Found device Volumio Jun 26 08:04:50 volumiomini ntpd[4634]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 26 08:04:50 volumiomini ntpd[4634]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 26 08:04:50 volumiomini ntpd[4634]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 912 days ago Jun 26 08:04:50 volumiomini ntpd[4634]: Listen and drop on 0 v6wildcard [::]:123 Jun 26 08:04:50 volumiomini ntpd[4634]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 26 08:04:50 volumiomini ntpd[4634]: Listen normally on 2 lo 127.0.0.1:123 Jun 26 08:04:50 volumiomini ntpd[4634]: Listen normally on 3 eth0 192.168.35.105:123 Jun 26 08:04:50 volumiomini ntpd[4634]: Listen normally on 4 wlan0 192.168.35.106:123 Jun 26 08:04:50 volumiomini ntpd[4634]: Listening on routing socket on fd #21 for interface updates Jun 26 08:04:50 volumiomini ntpd[4634]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 26 08:04:50 volumiomini ntpd[4634]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: Connecting to remote: 192.168.35.44 Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: Connected to remote: 192.168.35.44 Jun 26 08:04:50 volumiomini volumio[1351]: verbose: New Socket.io Connection to 192.168.35.106:3000 from 192.168.35.44 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 26 08:04:50 volumiomini volumio[1351]: info: Volumio Network Manager: Network status updated: 3 Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: this is already registered, 05a20189-f040-496d-8bc1-996259c7a03d Jun 26 08:04:50 volumiomini volumio[1351]: info: Discovery: Found device Volumiomini Jun 26 08:04:50 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:04:50 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:51 volumiomini ntpd[4634]: Soliciting pool server 84.16.67.12 Jun 26 08:04:52 volumiomini ntpd[4634]: Soliciting pool server 202.118.1.130 Jun 26 08:04:52 volumiomini ntpd[4634]: Soliciting pool server 202.118.1.81 Jun 26 08:04:53 volumiomini ntpd[4634]: Soliciting pool server 101.43.66.2 Jun 26 08:04:53 volumiomini ntpd[4634]: Soliciting pool server 108.59.2.24 Jun 26 08:04:53 volumiomini ntpd[4634]: Soliciting pool server 139.199.214.202 Jun 26 08:04:54 volumiomini ntpd[4634]: Soliciting pool server 162.159.200.123 Jun 26 08:04:54 volumiomini ntpd[4634]: Soliciting pool server 193.182.111.12 Jun 26 08:04:54 volumiomini ntpd[4634]: Soliciting pool server 14.103.157.44 Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: info: Retrieving Cloud Streaming UI Jun 26 08:04:54 volumiomini volumio[1351]: info: Getting Tidal Cloud Configuration Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: info: Getting Qobuz Cloud Configuration Jun 26 08:04:54 volumiomini volumio[1351]: info: Asking plugin for UI Config Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: info: Getting Spotify Cloud Configuration Jun 26 08:04:54 volumiomini volumio[1351]: info: Asking plugin for UI Config Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: info: Saving Spotify Acccount Jun 26 08:04:54 volumiomini volumio[1351]: info: Got Tidal Cloud Configuration Jun 26 08:04:54 volumiomini volumio[1351]: info: Got it Jun 26 08:04:54 volumiomini volumio[1351]: info: Got it Jun 26 08:04:54 volumiomini volumio[1351]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 26 08:04:54 volumiomini volumio[1351]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetBrowseSources Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetBrowseSources Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 26 08:04:54 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 26 08:04:55 volumiomini volumio[1351]: verbose: New Socket.io Connection to 192.168.35.106:3000 from 192.168.35.44 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 26 08:04:55 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 26 08:04:55 volumiomini volumio[1351]: info: CoreCommandRouter::volumioGetState Jun 26 08:04:55 volumiomini volumio[1351]: info: CorePlayQueue::getTrack 0 Jun 26 08:04:55 volumiomini ntpd[4634]: Soliciting pool server 119.28.206.193 Jun 26 08:04:55 volumiomini ntpd[4634]: Soliciting pool server 116.203.151.74 Jun 26 08:04:55 volumiomini volumio[1351]: verbose: New Socket.io Connection to 192.168.35.106:3000 from 192.168.33.120 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Jun 26 08:04:56 volumiomini ntpd[4634]: Soliciting pool server 119.28.183.184 Jun 26 08:04:56 volumiomini ntpd[4634]: Soliciting pool server 2408:4003:10b1:4000:a72a:af72:9dd2:c44a Jun 26 08:04:58 volumiomini volumio[1351]: info: Disabling MyMusic plugin upnp Jun 26 08:04:58 volumiomini sudo[4672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 26 08:04:58 volumiomini sudo[4672]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 26 08:04:58 volumiomini systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 26 08:04:58 volumiomini volumio[1351]: error: Upnp client error: Error: This socket has been ended by the other party Jun 26 08:04:58 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 26 08:04:59 volumiomini volumio[1351]: info: Enabling MyMusic plugin upnp Jun 26 08:04:59 volumiomini volumio[1351]: info: Enabling plugin upnp Jun 26 08:04:59 volumiomini volumio[1351]: info: Loading plugin "upnp"... Jun 26 08:04:59 volumiomini volumio[1351]: info: [1750896299255] Starting Upmpd Daemon Jun 26 08:04:59 volumiomini volumio[1351]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 26 08:04:59 volumiomini volumio[1351]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 08:04:59 volumiomini volumio[1351]: Error: listen EADDRINUSE: address already in use :::6599 Jun 26 08:04:59 volumiomini volumio[1351]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jun 26 08:04:59 volumiomini volumio[1351]: at listenInCluster (net.js:1379:12) Jun 26 08:04:59 volumiomini volumio[1351]: at Server.listen (net.js:1465:7) Jun 26 08:04:59 volumiomini volumio[1351]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 26 08:04:59 volumiomini volumio[1351]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 26 08:04:59 volumiomini volumio[1351]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 26 08:04:59 volumiomini volumio[1351]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 26 08:04:59 volumiomini volumio[1351]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jun 26 08:04:59 volumiomini volumio[1351]: code: 'EADDRINUSE', Jun 26 08:04:59 volumiomini volumio[1351]: errno: -98, Jun 26 08:04:59 volumiomini volumio[1351]: syscall: 'listen', Jun 26 08:04:59 volumiomini volumio[1351]: address: '::', Jun 26 08:04:59 volumiomini volumio[1351]: port: 6599 Jun 26 08:04:59 volumiomini volumio[1351]: } Jun 26 08:04:59 volumiomini volumio[1351]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 26 08:04:59 volumiomini sudo[4683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-26 08:03 Jun 26 08:04:59 volumiomini sudo[4683]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"