-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2025-06-25 21:45:56 CST. -- Jun 25 21:44:01 volumiopi3 volumio[876]: info: Discovery: A device disappeared from network Jun 25 21:44:01 volumiopi3 volumio[876]: info: Discovery: Device volumiopi3 disappeared from network Jun 25 21:44:01 volumiopi3 systemd[1]: Starting Daily apt download activities... Jun 25 21:44:02 volumiopi3 ntpd[730]: Soliciting pool server 114.35.131.27 Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::servicePushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreStateMachine::pushState Jun 25 21:44:02 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioPushState Jun 25 21:44:03 volumiopi3 ntpd[730]: Soliciting pool server 123.204.232.128 Jun 25 21:44:03 volumiopi3 systemd[1]: apt-daily.service: Succeeded. Jun 25 21:44:03 volumiopi3 systemd[1]: Started Daily apt download activities. Jun 25 21:44:03 volumiopi3 systemd[1]: Starting Daily apt upgrade and clean activities... Jun 25 21:44:05 volumiopi3 systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 25 21:44:05 volumiopi3 systemd[1]: Started Daily apt upgrade and clean activities. Jun 25 21:44:05 volumiopi3 ntpd[730]: Soliciting pool server 103.186.118.213 Jun 25 21:44:06 volumiopi3 ntpd[730]: Soliciting pool server 103.186.118.218 Jun 25 21:44:07 volumiopi3 ntpd[730]: Soliciting pool server 103.186.118.223 Jun 25 21:44:10 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba7.53839ccc does not match aorg 0xec067ba9.53953ec4 from server@114.35.131.27 xmt 0xec067ba7.6d076158 Jun 25 21:44:10 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba7.53967a02 does not match aorg 0xec067ba9.53a42262 from server@103.186.118.215 xmt 0xec067ba7.7662dfb3 Jun 25 21:44:11 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba7.539deff5 does not match aorg 0xec067bab.53a355e7 from server@103.186.118.221 xmt 0xec067ba8.80519c47 Jun 25 21:44:11 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba8.53a59458 does not match aorg 0xec067baa.539b9daf from server@103.186.118.214 xmt 0xec067ba8.81999198 Jun 25 21:44:11 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba8.539db1f1 does not match aorg 0xec067baa.5394e866 from server@125.229.162.223 xmt 0xec067ba8.822bc464 Jun 25 21:44:12 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba9.53ab5fa2 does not match aorg 0xec067bab.53a355e7 from server@103.186.118.221 xmt 0xec067baa.244f7777 Jun 25 21:44:12 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba9.539cf3c1 does not match aorg 0xec067bab.53945534 from server@103.186.118.217 xmt 0xec067baa.244ca320 Jun 25 21:44:12 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba9.53a42262 does not match aorg 0xec067bab.539c03ea from server@103.186.118.215 xmt 0xec067baa.244b9377 Jun 25 21:44:12 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067ba9.53953ec4 does not match aorg 0xec067bab.53857bab from server@114.35.131.27 xmt 0xec067baa.250c248c Jun 25 21:44:12 volumiopi3 ntpd[730]: Soliciting pool server 103.186.118.212 Jun 25 21:44:12 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067baa.5394e866 does not match aorg 0xec067bac.53936644 from server@125.229.162.223 xmt 0xec067baa.890c5422 Jun 25 21:44:13 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067bab.53a355e7 does not match aorg 0xec067bad.53b012e6 from server@103.186.118.221 xmt 0xec067bab.8de85fdd Jun 25 21:44:13 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067bab.53945534 does not match aorg 0xec067bad.53a0f8e5 from server@103.186.118.217 xmt 0xec067bab.8de5a4c1 Jun 25 21:44:13 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067bab.539c03ea does not match aorg 0xec067bad.53a8d7e5 from server@103.186.118.215 xmt 0xec067bab.8deeca38 Jun 25 21:44:13 volumiopi3 ntpd[730]: receive: Unexpected origin timestamp 0xec067bab.53857bab does not match aorg 0xec067bad.539b4529 from server@114.35.131.27 xmt 0xec067bab.8e9531f8 Jun 25 21:44:14 volumiopi3 shairport-sync[1083]: {"time":1750776546238,"response":"startAirplayPlayback Success"}Very large sync error: -4294964585 frames, with delay: -4294876385, td_in_frames: 168652, rt: 5212935827, nt: 9507980864, current_delay: 0, seqno: 31915, given timestamp: 918046272. Jun 25 21:44:14 volumiopi3 shairport-sync[1083]: Very large sync error: -4294964162 frames, with delay: -4294875962, td_in_frames: 169107, rt: 5212935827, nt: 9507981216, current_delay: 320, seqno: 31916, given timestamp: 918046624. Jun 25 21:44:14 volumiopi3 shairport-sync[1083]: Very large sync error: -4294964165 frames, with delay: -4294875965, td_in_frames: 169176, rt: 5212935827, nt: 9507981568, current_delay: 600, seqno: 31917, given timestamp: 918046976. Jun 25 21:44:14 volumiopi3 shairport-sync[1083]: Very large sync error: -4294964158 frames, with delay: -4294875958, td_in_frames: 169246, rt: 5212935827, nt: 9507981920, current_delay: 889, seqno: 31918, given timestamp: 918047328. Jun 25 21:44:14 volumiopi3 shairport-sync[1083]: fatal error: Failed to allocate memory for a long_silence buffer of -3138 frames. Jun 25 21:44:14 volumiopi3 systemd[1]: shairport-sync.service: Main process exited, code=exited, status=1/FAILURE Jun 25 21:44:14 volumiopi3 systemd[1]: shairport-sync.service: Failed with result 'exit-code'. Jun 25 21:44:15 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:16 volumiopi3 ntpd[730]: Soliciting pool server 210.243.152.155 Jun 25 21:44:16 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:44:16 volumiopi3 go-librespot[1050]: time="2025-06-25T21:44:16+08:00" level=debug msg="put connect state because NEW_DEVICE" Jun 25 21:44:16 volumiopi3 go-librespot[1050]: time="2025-06-25T21:44:16+08:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 25 21:44:16 volumiopi3 go-librespot[1050]: time="2025-06-25T21:44:16+08:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 25 21:44:16 volumiopi3 go-librespot[1050]: time="2025-06-25T21:44:16+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 25 21:44:16 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:44:17 volumiopi3 ntpd[730]: Soliciting pool server 17.253.116.253 Jun 25 21:44:18 volumiopi3 ntpd[730]: Soliciting pool server 2406:2000:fc:437::1001 Jun 25 21:44:20 volumiopi3 volumio[876]: info: Discovery: adding 24b4e22c-7c0d-488a-a493-56b38ba9e9e7 Jun 25 21:44:20 volumiopi3 volumio[876]: info: Discovery: Found device VolumioPI3 Jun 25 21:44:20 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:20 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:21 volumiopi3 ntpd[730]: Soliciting pool server 203.175.104.126 Jun 25 21:44:27 volumiopi3 ntpd[730]: Soliciting pool server 103.147.22.149 Jun 25 21:44:30 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:32 volumiopi3 ntpd[730]: Soliciting pool server 118.163.81.61 Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin bluetooth to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin multiroom to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin metavolumio to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin cd_controller to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 25 21:44:34 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 25 21:44:37 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 25 21:44:37 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 25 21:44:37 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 25 21:44:37 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 25 21:44:37 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 25 21:44:37 volumiopi3 volumio[876]: info: Starting MyVolumio Remote Streaming Endpoints Jun 25 21:44:37 volumiopi3 volumio[876]: info: MyVolumio login type: Token Jun 25 21:44:37 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 25 21:44:37 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 25 21:44:40 volumiopi3 volumio[876]: info: Starting Streaming Service Transparent Proxy Jun 25 21:44:40 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 25 21:44:40 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 25 21:44:40 volumiopi3 volumio[876]: info: Streaming services startup Jun 25 21:44:40 volumiopi3 volumio[876]: info: Starting Streaming Daemon Jun 25 21:44:40 volumiopi3 sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 25 21:44:40 volumiopi3 sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 25 21:44:40 volumiopi3 volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 25 21:44:40 volumiopi3 sudo[1308]: pam_unix(sudo:session): session closed for user root Jun 25 21:44:41 volumiopi3 volumio[876]: error: Cannot start Volumio Streaming Daemon Jun 25 21:44:41 volumiopi3 volumio[876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 25 21:44:41 volumiopi3 volumio[876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 25 21:44:43 volumiopi3 volumio[876]: STREAMING PROXY: Starting server on port 3245 Jun 25 21:44:43 volumiopi3 volumio[876]: Node JS runtime: 14 Jun 25 21:44:47 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:51 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:44:51 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:44:51 volumiopi3 volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 25 21:44:51 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:52 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 25 21:44:52 volumiopi3 volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 25 21:44:52 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:44:57 volumiopi3 volumio[1072]: ..............................................................................................................................................................................................................................++++ Jun 25 21:44:57 volumiopi3 volumio[1072]: e is 65537 (0x010001) Jun 25 21:44:57 volumiopi3 volumio[1072]: writing RSA key Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetBrowseSources Jun 25 21:44:57 volumiopi3 volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 25 21:45:05 volumiopi3 volumio[876]: error: MyVolumio Custom Token format not valid, refreshing it Jun 25 21:45:05 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:45:06 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:45:06 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:45:11 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:45:17 volumiopi3 volumio[876]: info: MyVolumio login type: Token Jun 25 21:45:20 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:45:28 volumiopi3 volumio[876]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 25 21:45:30 volumiopi3 volumio[876]: info: CoreCommandRouter::volumioGetState Jun 25 21:45:30 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:45:30 volumiopi3 volumio[876]: info: Listing playlists Jun 25 21:45:37 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-DISCONNECTED bssid=bc:fc:e7:30:6c:94 reason=0 locally_generated=1 Jun 25 21:45:37 volumiopi3 dhcpcd[813]: wlan0: carrier lost Jun 25 21:45:37 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 25 21:45:37 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Jun 25 21:45:37 volumiopi3 avahi-daemon[588]: Withdrawing address record for 192.168.1.111 on wlan0. Jun 25 21:45:37 volumiopi3 avahi-daemon[588]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.111. Jun 25 21:45:37 volumiopi3 avahi-daemon[588]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 25 21:45:37 volumiopi3 dhcpcd[813]: wlan0: deleting route to 192.168.1.0/24 Jun 25 21:45:37 volumiopi3 dhcpcd[813]: wlan0: deleting default route via 192.168.1.1 Jun 25 21:45:37 volumiopi3 volumio[876]: info: Discovery: A device disappeared from network Jun 25 21:45:37 volumiopi3 volumio[876]: info: Discovery: Device volumiopi3 disappeared from network Jun 25 21:45:38 volumiopi3 ntpd[730]: Deleting interface #3 wlan0, 192.168.1.111#123, interface stats: received=133, sent=140, dropped=1, active_time=156 secs Jun 25 21:45:38 volumiopi3 ntpd[730]: 118.163.81.61 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.147.22.149 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 203.175.104.126 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 17.253.116.253 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 210.243.152.155 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.212 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.223 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.218 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.213 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 123.204.232.128 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 114.35.131.27 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.217 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 125.229.162.223 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.215 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.214 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.221 local addr 192.168.1.111 -> Jun 25 21:45:38 volumiopi3 ntpd[730]: 103.186.118.220 local addr 192.168.1.111 -> Jun 25 21:45:42 volumiopi3 volumio[876]: error: Myvolumio warning! Token not refreshed Jun 25 21:45:42 volumiopi3 volumio[876]: info: MyVolumio token set successfully Jun 25 21:45:42 volumiopi3 volumio[876]: info: MYVOLUMIO: Adding device Jun 25 21:45:42 volumiopi3 volumio[876]: info: MYVOLUMIO: Evaluating Server Jun 25 21:45:47 volumiopi3 wpa_supplicant[800]: wlan0: Trying to associate with SSID 'philiveroom' Jun 25 21:45:51 volumiopi3 wpa_supplicant[800]: wlan0: Associated with bc:4d:fb:3c:8b:08 Jun 25 21:45:51 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-CONNECTED - Connection to bc:4d:fb:3c:8b:08 completed [id=1 id_str=] Jun 25 21:45:51 volumiopi3 dhcpcd[813]: wlan0: carrier acquired Jun 25 21:45:51 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 25 21:45:51 volumiopi3 dhcpcd[813]: wlan0: connected to Access Point `philiveroom' Jun 25 21:45:51 volumiopi3 wpa_supplicant[800]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 25 21:45:51 volumiopi3 dhcpcd[813]: wlan0: IAID eb:10:5e:8d Jun 25 21:45:51 volumiopi3 dhcpcd[813]: wlan0: probing address 192.168.1.111/24 Jun 25 21:45:51 volumiopi3 dhcpcd[813]: wlan0: soliciting an IPv6 router Jun 25 21:45:54 volumiopi3 volumio[876]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 25 21:45:54 volumiopi3 volumio[876]: Error: send ENETUNREACH 255.255.255.255:3483 Jun 25 21:45:54 volumiopi3 volumio[876]: at doSend (dgram.js:692:16) Jun 25 21:45:54 volumiopi3 volumio[876]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jun 25 21:45:54 volumiopi3 volumio[876]: at afterDns (dgram.js:638:5) Jun 25 21:45:54 volumiopi3 volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jun 25 21:45:54 volumiopi3 volumio[876]: errno: -101, Jun 25 21:45:54 volumiopi3 volumio[876]: code: 'ENETUNREACH', Jun 25 21:45:54 volumiopi3 volumio[876]: syscall: 'send', Jun 25 21:45:54 volumiopi3 volumio[876]: address: '255.255.255.255', Jun 25 21:45:54 volumiopi3 volumio[876]: port: 3483 Jun 25 21:45:54 volumiopi3 volumio[876]: } Jun 25 21:45:54 volumiopi3 volumio[876]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 25 21:45:55 volumiopi3 dhcpcd[813]: wlan0: using static address 192.168.1.111/24 Jun 25 21:45:55 volumiopi3 avahi-daemon[588]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.111. Jun 25 21:45:55 volumiopi3 avahi-daemon[588]: New relevant interface wlan0.IPv4 for mDNS. Jun 25 21:45:55 volumiopi3 dhcpcd[813]: wlan0: adding route to 192.168.1.0/24 Jun 25 21:45:55 volumiopi3 avahi-daemon[588]: Registering new address record for 192.168.1.111 on wlan0.IPv4. Jun 25 21:45:55 volumiopi3 dhcpcd[813]: wlan0: adding default route via 192.168.1.1 Jun 25 21:45:56 volumiopi3 sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-25 21:44 Jun 25 21:45:56 volumiopi3 sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"