-- Logs begin at Sat 2025-03-29 16:26:10 JST, end at Sat 2025-03-29 16:37:15 JST. -- Mar 29 16:36:01 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:36:01 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:36:04 smsl-n100 ntpd[731]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 29 16:36:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Retrieving Cloud Streaming UI Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Getting Tidal Cloud Configuration Mar 29 16:36:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Getting Qobuz Cloud Configuration Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Asking plugin for UI Config Mar 29 16:36:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Getting Spotify Cloud Configuration Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Asking plugin for UI Config Mar 29 16:36:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Saving Spotify Acccount Mar 29 16:36:04 smsl-n100 volumio[2952]: info: Got it Mar 29 16:36:04 smsl-n100 volumio[2952]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 29 16:36:05 smsl-n100 volumio[2952]: info: Got Tidal Cloud Configuration Mar 29 16:36:05 smsl-n100 volumio[2952]: info: Got it Mar 29 16:36:05 smsl-n100 volumio[2952]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 16:36:06 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:36:09 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 29 16:36:24 smsl-n100 ntpd[731]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 29 16:36:26 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:36:26 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:36:31 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:36:32 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 29 16:36:35 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Mar 29 16:36:35 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 29 16:36:35 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Mar 29 16:36:35 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Mar 29 16:36:35 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 29 16:36:43 smsl-n100 volumio[2952]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Mar 29 16:36:43 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Mar 29 16:36:43 smsl-n100 volumio[2952]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined Mar 29 16:36:44 smsl-n100 ntpd[731]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 29 16:36:49 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::Reload Ui Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Mar 29 16:36:51 smsl-n100 volumio[2952]: info: Wizard terminated Successfully Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumiosetStartupVolume Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 16:36:51 smsl-n100 volumio[2952]: info: Executing Deferred Wifi Connection Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Mar 29 16:36:51 smsl-n100 volumio[2952]: info: Saving new wireless network Mar 29 16:36:51 smsl-n100 sudo[4348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Mar 29 16:36:51 smsl-n100 sudo[4348]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:51 smsl-n100 sudo[4348]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:51 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Mar 29 16:36:51 smsl-n100 volumio[2952]: info: Discovery: Restarting Advertising due to device name change Mar 29 16:36:51 smsl-n100 sudo[4351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Mar 29 16:36:51 smsl-n100 sudo[4351]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:51 smsl-n100 systemd[1]: Starting Wireless Services... Mar 29 16:36:51 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 16:36:51 smsl-n100 sudo[4361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 16:36:51 smsl-n100 sudo[4361]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:51 smsl-n100 sudo[4361]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:51 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:36:51 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:36:51 smsl-n100 sudo[4363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 16:36:51 smsl-n100 sudo[4363]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:51 smsl-n100 sudo[4363]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:51 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.198 UA: Mozilla/5.0 (Linux; Android 14; ASUS_AI2401_D Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 29 16:36:52 smsl-n100 sudo[4368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 16:36:52 smsl-n100 sudo[4368]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:52 smsl-n100 sudo[4368]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:52 smsl-n100 sudo[4371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 16:36:52 smsl-n100 sudo[4371]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:52 smsl-n100 sudo[4371]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:52 smsl-n100 volumio[2952]: info: Discovery: A device disappeared from network Mar 29 16:36:52 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.198 UA: Mozilla/5.0 (Linux; Android 14; ASUS_AI2401_D Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.111 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 16:36:52 smsl-n100 volumio[2952]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 29 16:36:52 smsl-n100 volumio[2952]: info: Received Get System Info Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 16:36:52 smsl-n100 volumio[2952]: info: Discovery: Getting this device information Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:52 smsl-n100 volumio[2952]: info: Listing playlists Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 29 16:36:52 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 16:36:52 smsl-n100 wireless.js[4353]: Cleaning previous... Mar 29 16:36:52 smsl-n100 systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Mar 29 16:36:52 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 16:36:52 smsl-n100 dnsmasq[1626]: exiting on receipt of SIGTERM Mar 29 16:36:52 smsl-n100 systemd[1]: dnsmasq.service: Succeeded. Mar 29 16:36:52 smsl-n100 systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Mar 29 16:36:52 smsl-n100 systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Mar 29 16:36:52 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 16:36:52 smsl-n100 dhcpcd[946]: wlan0: carrier lost Mar 29 16:36:52 smsl-n100 systemd[1]: hostapd.service: Succeeded. Mar 29 16:36:52 smsl-n100 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Mar 29 16:36:52 smsl-n100 dhcpcd[946]: wlan0: deleting route to 169.254.0.0/16 Mar 29 16:36:52 smsl-n100 dhcpcd[946]: wlan0: deleting default route Mar 29 16:36:52 smsl-n100 avahi-daemon[566]: Withdrawing address record for 169.254.125.93 on wlan0. Mar 29 16:36:52 smsl-n100 sudo[4400]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 29 16:36:52 smsl-n100 sudo[4400]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:52 smsl-n100 avahi-daemon[566]: Withdrawing address record for 192.168.211.1 on wlan0. Mar 29 16:36:52 smsl-n100 avahi-daemon[566]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 29 16:36:52 smsl-n100 avahi-daemon[566]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 29 16:36:52 smsl-n100 sudo[4400]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:52 smsl-n100 sudo[4408]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 29 16:36:52 smsl-n100 sudo[4408]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:52 smsl-n100 sudo[4408]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:53 smsl-n100 wireless.js[4353]: Stopped aP Mar 29 16:36:53 smsl-n100 sudo[4415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 29 16:36:53 smsl-n100 sudo[4415]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:53 smsl-n100 sudo[4415]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:53 smsl-n100 sudo[4417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 29 16:36:53 smsl-n100 sudo[4417]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:53 smsl-n100 sudo[4417]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:53 smsl-n100 sudo[4424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 29 16:36:53 smsl-n100 sudo[4424]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:53 smsl-n100 sudo[4424]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:53 smsl-n100 sudo[4426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 29 16:36:53 smsl-n100 sudo[4426]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:53 smsl-n100 dhcpcd[946]: wlan0: carrier acquired Mar 29 16:36:53 smsl-n100 dhcpcd[946]: wlan0: IAID 2b:ee:c7:8d Mar 29 16:36:54 smsl-n100 dhcpcd[946]: wlan0: soliciting a DHCP lease Mar 29 16:36:54 smsl-n100 dhcpcd[946]: wlan0: soliciting an IPv6 router Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 ntpd[731]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Mar 29 16:36:54 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 28 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 29 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:36:55 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:36:55 smsl-n100 ntpd[731]: Deleting interface #3 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=540 secs Mar 29 16:36:55 smsl-n100 ntpd[731]: Deleting interface #4 wlan0, 169.254.125.93#123, interface stats: received=0, sent=0, dropped=0, active_time=528 secs Mar 29 16:36:55 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:55 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:56 smsl-n100 volumio[2952]: info: Discovery: Started advertising with name: SMSL N100 Mar 29 16:36:56 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:36:56 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:56 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:56 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:36:56 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:36:56 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:36:57 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:36:57 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:57 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:57 smsl-n100 sudo[4426]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:57 smsl-n100 wireless.js[4353]: Start wireless flow Mar 29 16:36:57 smsl-n100 wireless.js[4353]: Stopped hotspot (if there).. Mar 29 16:36:57 smsl-n100 sudo[4456]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 29 16:36:57 smsl-n100 sudo[4456]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:57 smsl-n100 sudo[4456]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:57 smsl-n100 sudo[4458]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 29 16:36:57 smsl-n100 sudo[4458]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:57 smsl-n100 dhcpcd[946]: wlan0: carrier lost Mar 29 16:36:57 smsl-n100 sudo[4458]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:57 smsl-n100 wireless.js[4353]: DHCP IP Mar 29 16:36:57 smsl-n100 wireless.js[4353]: Start ap Mar 29 16:36:57 smsl-n100 wpa_supplicant[4463]: Successfully initialized wpa_supplicant Mar 29 16:36:57 smsl-n100 sudo[4467]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Mar 29 16:36:57 smsl-n100 sudo[4467]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:57 smsl-n100 dhcpcd[4475]: sending commands to master dhcpcd process Mar 29 16:36:57 smsl-n100 sudo[4467]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:57 smsl-n100 dhcpcd[946]: wlan0: carrier acquired Mar 29 16:36:57 smsl-n100 dhcpcd[946]: wlan0: IAID 2b:ee:c7:8d Mar 29 16:36:57 smsl-n100 dhcpcd[946]: control command: /sbin/dhcpcd Mar 29 16:36:57 smsl-n100 dhcpcd[946]: wlan0: carrier lost Mar 29 16:36:58 smsl-n100 wireless.js[4353]: trying... Mar 29 16:36:58 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:36:58 smsl-n100 sudo[4487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:36:58 smsl-n100 sudo[4487]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:58 smsl-n100 sudo[4487]: pam_unix(sudo:session): session closed for user root Mar 29 16:36:59 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:59 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:59 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:36:59 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:36:59 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:36:59 smsl-n100 wireless.js[4353]: trying... Mar 29 16:36:59 smsl-n100 sudo[4490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:36:59 smsl-n100 sudo[4490]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:36:59 smsl-n100 sudo[4490]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:00 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:00 smsl-n100 sudo[4493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:00 smsl-n100 sudo[4493]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:00 smsl-n100 sudo[4493]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:01 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:37:01 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:01 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:01 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:37:01 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:01 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:37:01 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:37:01 smsl-n100 sudo[4500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:01 smsl-n100 sudo[4500]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:01 smsl-n100 sudo[4500]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:02 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:37:02 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:02 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:02 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:02 smsl-n100 sudo[4504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:02 smsl-n100 sudo[4504]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:02 smsl-n100 sudo[4504]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:03 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:03 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:03 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:03 smsl-n100 wpa_supplicant[4478]: wlan0: Trying to associate with 04:42:1a:11:81:a8 (SSID='Republic of GAMERS_5G-2' freq=5640 MHz) Mar 29 16:37:03 smsl-n100 wpa_supplicant[4478]: wlan0: Associated with 04:42:1a:11:81:a8 Mar 29 16:37:03 smsl-n100 wpa_supplicant[4478]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 29 16:37:03 smsl-n100 wpa_supplicant[4478]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Mar 29 16:37:03 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:03 smsl-n100 sudo[4509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:03 smsl-n100 sudo[4509]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:03 smsl-n100 sudo[4509]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:04 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:04 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:04 smsl-n100 wpa_supplicant[4478]: wlan0: WPA: Key negotiation completed with 04:42:1a:11:81:a8 [PTK=CCMP GTK=CCMP] Mar 29 16:37:04 smsl-n100 wpa_supplicant[4478]: wlan0: CTRL-EVENT-CONNECTED - Connection to 04:42:1a:11:81:a8 completed [id=0 id_str=] Mar 29 16:37:04 smsl-n100 dhcpcd[946]: wlan0: carrier acquired Mar 29 16:37:04 smsl-n100 dhcpcd[946]: wlan0: IAID 2b:ee:c7:8d Mar 29 16:37:04 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:04 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:04 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:04 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:04 smsl-n100 sudo[4513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:04 smsl-n100 sudo[4513]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:04 smsl-n100 sudo[4513]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:05 smsl-n100 dhcpcd[946]: wlan0: soliciting a DHCP lease Mar 29 16:37:05 smsl-n100 dhcpcd[946]: wlan0: soliciting an IPv6 router Mar 29 16:37:05 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:05 smsl-n100 sudo[4516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:05 smsl-n100 sudo[4516]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:05 smsl-n100 sudo[4516]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:06 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:06 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:06 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:06 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:06 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:37:06 smsl-n100 sudo[4522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:06 smsl-n100 sudo[4522]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:06 smsl-n100 sudo[4522]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:06 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:37:06 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:37:07 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:07 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:07 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:07 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:07 smsl-n100 sudo[4544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:07 smsl-n100 sudo[4544]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:07 smsl-n100 sudo[4544]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:08 smsl-n100 dhcpcd[946]: wlan0: offered 192.168.51.248 from 192.168.51.1 Mar 29 16:37:08 smsl-n100 dhcpcd[946]: wlan0: probing address 192.168.51.248/24 Mar 29 16:37:08 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:08 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:08 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:08 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:08 smsl-n100 sudo[4547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:08 smsl-n100 sudo[4547]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:08 smsl-n100 sudo[4547]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:09 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:09 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:09 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:09 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:09 smsl-n100 sudo[4550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:09 smsl-n100 sudo[4550]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:09 smsl-n100 sudo[4550]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:10 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:10 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:10 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:10 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:10 smsl-n100 sudo[4553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:10 smsl-n100 sudo[4553]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:10 smsl-n100 sudo[4553]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:11 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:11 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:11 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:11 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:11 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:11 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:11 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:11 smsl-n100 sudo[4556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:11 smsl-n100 sudo[4556]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:11 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Fetching time from Volumio... Mar 29 16:37:11 smsl-n100 sudo[4556]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:11 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Date not found in response Mar 29 16:37:11 smsl-n100 volumio-time-update[565]: volumio-time-update-util: Retrying in 5 seconds... Mar 29 16:37:12 smsl-n100 ntpd[731]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 29 16:37:12 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:12 smsl-n100 sudo[4564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:12 smsl-n100 sudo[4564]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:12 smsl-n100 sudo[4564]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:13 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Mar 29 16:37:13 smsl-n100 ntpd[731]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 29 16:37:13 smsl-n100 ntpd[731]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 29 16:37:13 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:13 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:13 smsl-n100 dhcpcd[946]: wlan0: leased 192.168.51.248 for 86400 seconds Mar 29 16:37:13 smsl-n100 dhcpcd[946]: wlan0: adding route to 192.168.51.0/24 Mar 29 16:37:13 smsl-n100 dhcpcd[946]: wlan0: adding default route via 192.168.51.1 Mar 29 16:37:13 smsl-n100 avahi-daemon[566]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.51.248. Mar 29 16:37:13 smsl-n100 avahi-daemon[566]: New relevant interface wlan0.IPv4 for mDNS. Mar 29 16:37:13 smsl-n100 avahi-daemon[566]: Registering new address record for 192.168.51.248 on wlan0.IPv4. Mar 29 16:37:13 smsl-n100 wireless.js[4353]: trying... Mar 29 16:37:13 smsl-n100 sudo[4597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 29 16:37:13 smsl-n100 sudo[4597]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:13 smsl-n100 sudo[4597]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:13 smsl-n100 wireless.js[4353]: Connected to: ----Republic of GAMERS_5G-2 Mar 29 16:37:13 smsl-n100 wireless.js[4353]: ---- Mar 29 16:37:14 smsl-n100 sudo[4601]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 16:37:14 smsl-n100 sudo[4601]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:37:14 smsl-n100 sudo[4601]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:14 smsl-n100 ntpd[731]: ntpd exiting on signal 15 (Terminated) Mar 29 16:37:14 smsl-n100 systemd[1]: Stopping Network Time Service... Mar 29 16:37:14 smsl-n100 wireless.js[4353]: ... joined AP, wlan0 IPv4 is 192.168.51.248, ipV6 is undefined Mar 29 16:37:14 smsl-n100 wireless.js[4353]: It's done! AP Mar 29 16:37:14 smsl-n100 systemd[1]: ntp.service: Succeeded. Mar 29 16:37:14 smsl-n100 systemd[1]: Stopped Network Time Service. Mar 29 16:37:14 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 16:37:14 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 29 16:37:14 smsl-n100 systemd[1]: Starting Network Time Service... Mar 29 16:37:14 smsl-n100 volumio[2952]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 16:37:14 smsl-n100 iwconfig[4614]: Error for wireless request "Set Power Management" (8B2C) : Mar 29 16:37:14 smsl-n100 iwconfig[4614]: SET failed on device wlan0 ; Operation not permitted. Mar 29 16:37:14 smsl-n100 systemd[1]: Started Wireless Services. Mar 29 16:37:14 smsl-n100 ntpd[4608]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 29 16:37:14 smsl-n100 ntpd[4608]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 29 16:37:14 smsl-n100 sudo[4351]: pam_unix(sudo:session): session closed for user root Mar 29 16:37:14 smsl-n100 systemd[1]: Started Network Time Service. Mar 29 16:37:14 smsl-n100 ntpd[4616]: proto: precision = 1.166 usec (-20) Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 16:37:14 smsl-n100 ntpd[4616]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 16:37:14 smsl-n100 ntpd[4616]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 29 16:37:14 smsl-n100 ntpd[4616]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 823 days ago Mar 29 16:37:14 smsl-n100 volumio[2952]: info: Discovery: Getting this device information Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:14 smsl-n100 ntpd[4616]: Listen and drop on 0 v6wildcard [::]:123 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:14 smsl-n100 ntpd[4616]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 16:37:14 smsl-n100 ntpd[4616]: Listen normally on 2 lo 127.0.0.1:123 Mar 29 16:37:14 smsl-n100 ntpd[4616]: Listen normally on 3 wlan0 192.168.51.248:123 Mar 29 16:37:14 smsl-n100 ntpd[4616]: Listening on routing socket on fd #20 for interface updates Mar 29 16:37:14 smsl-n100 ntpd[4616]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 16:37:14 smsl-n100 ntpd[4616]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 29 16:37:14 smsl-n100 volumio[2952]: info: MRS: Found cast device: BRAVIA-4K-GB-ATV3-0f9c7352e26bfbe133b2809736e26461 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: Adding audio output: Mar 29 16:37:14 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to 192.168.51.248:3000 from 192.168.51.153 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 30 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 16:37:14 smsl-n100 volumio[2952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 16:37:14 smsl-n100 volumio[2952]: info: Discovery: Getting this device information Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 16:37:14 smsl-n100 volumio[2952]: info: Discovery: adding 515ab9b9-1d76-4bdd-bfa9-a5f65b5ead68 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: Discovery: Found device SMSL N100 Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CoreCommandRouter::volumioGetState Mar 29 16:37:14 smsl-n100 volumio[2952]: info: CorePlayQueue::getTrack 0 Mar 29 16:37:14 smsl-n100 volumio[2952]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 16:37:14 smsl-n100 volumio[2952]: Error: The value NaN is not a number Mar 29 16:37:14 smsl-n100 volumio[2952]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Mar 29 16:37:14 smsl-n100 volumio[2952]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Mar 29 16:37:14 smsl-n100 volumio[2952]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Mar 29 16:37:14 smsl-n100 volumio[2952]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Mar 29 16:37:14 smsl-n100 volumio[2952]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Mar 29 16:37:14 smsl-n100 volumio[2952]: at Browser.emit (events.js:400:28) Mar 29 16:37:14 smsl-n100 volumio[2952]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Mar 29 16:37:14 smsl-n100 volumio[2952]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Mar 29 16:37:14 smsl-n100 volumio[2952]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Mar 29 16:37:14 smsl-n100 volumio[2952]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Mar 29 16:37:14 smsl-n100 volumio[2952]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Mar 29 16:37:14 smsl-n100 volumio[2952]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Mar 29 16:37:14 smsl-n100 volumio[2952]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Mar 29 16:37:14 smsl-n100 volumio[2952]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 16:37:15 smsl-n100 ntpd[4616]: Soliciting pool server 133.130.121.141 Mar 29 16:37:15 smsl-n100 sudo[4627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-29 16:36 Mar 29 16:37:15 smsl-n100 sudo[4627]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8205c9d25502d90d2bb411bb156e1d5a8ef7404e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Jan 2025 07:23:13 PM CET" VOLUMIO_VERSION="3.788" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="b3195a7f5841a4bc08e3e196c1a91b34"