-- Logs begin at Mon 2023-06-26 22:53:40 UTC, end at Tue 2025-06-24 19:13:20 UTC. -- Jun 24 19:12:40 ampit5 systemd[1]: Time has been changed Jun 24 19:12:42 ampit5 volumio[1091]: info: Loading plugin "upnp_browser"... Jun 24 19:12:45 ampit5 volumio[1091]: info: Loading plugin "networkfs"... Jun 24 19:12:46 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 24 19:12:46 ampit5 volumio[1091]: info: Loading plugin "alarm-clock"... Jun 24 19:12:47 ampit5 dhcpcd[1068]: wlan0: carrier lost Jun 24 19:12:47 ampit5 dhcpcd[1068]: wlan0: deleting host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:12:47 ampit5 dhcpcd[1068]: wlan0: deleting route to 10.0.0.0/24 Jun 24 19:12:47 ampit5 dhcpcd[1068]: wlan0: deleting default route via 10.0.0.1 Jun 24 19:12:47 ampit5 kernel: wlan0: deauthenticated from 42:75:c3:f6:b3:d9 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA) Jun 24 19:12:47 ampit5 avahi-daemon[539]: Withdrawing address record for 10.0.0.146 on wlan0. Jun 24 19:12:47 ampit5 avahi-daemon[539]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:12:47 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-DISCONNECTED bssid=42:75:c3:f6:b3:d9 reason=7 Jun 24 19:12:47 ampit5 avahi-daemon[539]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 24 19:12:47 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2412 MHz) Jun 24 19:12:47 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 24 19:12:47 ampit5 nmbd[794]: [2025/06/24 19:12:47.591520, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 24 19:12:47 ampit5 nmbd[794]: Packet send failed to 10.0.0.255(137) ERRNO=Network is unreachable Jun 24 19:12:47 ampit5 nmbd[794]: [2025/06/24 19:12:47.592076, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 24 19:12:47 ampit5 nmbd[794]: retransmit_or_expire_response_records: Failed to resend packet id 24819 to IP 10.0.0.255 on subnet 10.0.0.146 Jun 24 19:12:48 ampit5 volumio[1091]: info: Loading plugin "airplay_emulation"... Jun 24 19:12:48 ampit5 volumio[1091]: info: Starting Shairport Sync Jun 24 19:12:48 ampit5 volumio[1091]: info: Loading plugin "last_100"... Jun 24 19:12:48 ampit5 volumio[1091]: info: Loading plugin "webradio"... Jun 24 19:12:48 ampit5 nmbd[794]: [2025/06/24 19:12:48.596109, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 24 19:12:48 ampit5 nmbd[794]: Packet send failed to 10.0.0.255(138) ERRNO=Network is unreachable Jun 24 19:12:49 ampit5 ntpd[594]: Deleting interface #3 wlan0, 10.0.0.146#123, interface stats: received=17, sent=21, dropped=1, active_time=39 secs Jun 24 19:12:49 ampit5 ntpd[594]: 23.186.168.127 interface 10.0.0.146 -> (none) Jun 24 19:12:49 ampit5 ntpd[594]: 15.204.246.57 interface 10.0.0.146 -> (none) Jun 24 19:12:49 ampit5 ntpd[594]: 23.142.248.8 interface 10.0.0.146 -> (none) Jun 24 19:12:49 ampit5 ntpd[594]: 23.186.168.129 interface 10.0.0.146 -> (none) Jun 24 19:12:49 ampit5 ntpd[594]: peers refreshed Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:12:49 ampit5 kernel: wlan0: authenticate with 42:75:c3:f6:b3:d9 Jun 24 19:12:49 ampit5 kernel: wlan0: Wrong control channel: center-freq: 2462 ht-cfreq: 2412 ht->primary_chan: 1 band: 0 - Disabling HT Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: Trying to associate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:12:49 ampit5 kernel: wlan0: send auth to 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:12:49 ampit5 kernel: wlan0: authenticated Jun 24 19:12:49 ampit5 kernel: wlan0: associate with 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:12:49 ampit5 kernel: wlan0: RX AssocResp from 42:75:c3:f6:b3:d9 (capab=0x1411 status=0 aid=15) Jun 24 19:12:49 ampit5 kernel: wlan0: associated Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: Associated with 42:75:c3:f6:b3:d9 Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: WPA: Key negotiation completed with 42:75:c3:f6:b3:d9 [PTK=CCMP GTK=CCMP] Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 42:75:c3:f6:b3:d9 completed [id=0 id_str=] Jun 24 19:12:49 ampit5 dhcpcd[1068]: wlan0: carrier acquired Jun 24 19:12:49 ampit5 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 42:75:c3:f6:b3:d9 Jun 24 19:12:49 ampit5 volumio[1091]: info: Loading plugin "i2s_dacs"... Jun 24 19:12:49 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 24 19:12:49 ampit5 volumio[1091]: info: I2S DAC not set, start Auto-detection Jun 24 19:12:49 ampit5 dhcpcd[1068]: wlan0: soliciting a DHCP lease Jun 24 19:12:50 ampit5 volumio[1091]: info: Loading plugin "volumiodiscovery"... Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** For more information see Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:12:50 ampit5 node[1091]: *** WARNING *** For more information see Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** For more information see Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 24 19:12:50 ampit5 volumio[1091]: *** WARNING *** For more information see Jun 24 19:12:50 ampit5 volumio[1091]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 24 19:12:50 ampit5 volumio[1091]: Discovery: StartAdv! undefined Jun 24 19:12:50 ampit5 volumio[1091]: Discovery: Started advertising... ampit5 - undefined Jun 24 19:12:50 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 24 19:12:50 ampit5 volumio[1091]: info: Loading plugin "outputs"... Jun 24 19:12:50 ampit5 volumio[1091]: info: Loading plugin "albumart"... Jun 24 19:12:50 ampit5 volumio[1091]: info: Plugin example_plugin is not enabled Jun 24 19:12:50 ampit5 volumio[1091]: info: Loading plugin "inputs"... Jun 24 19:12:50 ampit5 volumio[1091]: info: Loading plugin "updater_comm"... Jun 24 19:12:52 ampit5 volumio[1091]: info: Plugin mpdemulation is not enabled Jun 24 19:12:53 ampit5 volumio[1091]: info: Loading plugin "rest_api"... Jun 24 19:12:53 ampit5 volumio-remote-updater[490]: [2025-06-24 19:12:53] [connect] Successful connection Jun 24 19:12:53 ampit5 volumio[1091]: info: Loading plugin "websocket"... Jun 24 19:12:53 ampit5 dhcpcd[1068]: wlan0: offered 10.0.0.146 from 10.0.0.1 Jun 24 19:12:53 ampit5 dhcpcd[1068]: wlan0: leased 10.0.0.146 for 172800 seconds Jun 24 19:12:53 ampit5 dhcpcd[1068]: wlan0: adding host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:12:53 ampit5 dhcpcd[1068]: wlan0: adding route to 10.0.0.0/24 Jun 24 19:12:53 ampit5 dhcpcd[1068]: wlan0: adding default route via 10.0.0.1 Jun 24 19:12:53 ampit5 avahi-daemon[539]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:12:53 ampit5 avahi-daemon[539]: New relevant interface wlan0.IPv4 for mDNS. Jun 24 19:12:53 ampit5 avahi-daemon[539]: Registering new address record for 10.0.0.146 on wlan0.IPv4. Jun 24 19:12:53 ampit5 volumio[1091]: info: Loading plugin "Systeminfo"... Jun 24 19:12:54 ampit5 dhcpcd[1068]: wlan0: carrier lost Jun 24 19:12:54 ampit5 dhcpcd[1068]: wlan0: deleting host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:12:54 ampit5 dhcpcd[1068]: wlan0: deleting route to 10.0.0.0/24 Jun 24 19:12:54 ampit5 dhcpcd[1068]: wlan0: deleting default route via 10.0.0.1 Jun 24 19:12:54 ampit5 avahi-daemon[539]: Withdrawing address record for 10.0.0.146 on wlan0. Jun 24 19:12:54 ampit5 avahi-daemon[539]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-DISCONNECTED bssid=42:75:c3:f6:b3:d9 reason=7 Jun 24 19:12:54 ampit5 avahi-daemon[539]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:12:54 ampit5 kernel: wlan0: deauthenticated from 42:75:c3:f6:b3:d9 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA) Jun 24 19:12:54 ampit5 kernel: wlan0: authenticate with 42:75:c3:f6:b3:d9 Jun 24 19:12:54 ampit5 kernel: wlan0: Wrong control channel: center-freq: 2462 ht-cfreq: 2412 ht->primary_chan: 1 band: 0 - Disabling HT Jun 24 19:12:54 ampit5 kernel: wlan0: send auth to 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:12:54 ampit5 kernel: wlan0: authenticated Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: Trying to associate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:12:54 ampit5 kernel: wlan0: associate with 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:12:54 ampit5 kernel: wlan0: RX AssocResp from 42:75:c3:f6:b3:d9 (capab=0x1411 status=0 aid=17) Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: Associated with 42:75:c3:f6:b3:d9 Jun 24 19:12:54 ampit5 kernel: wlan0: associated Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: WPA: Key negotiation completed with 42:75:c3:f6:b3:d9 [PTK=CCMP GTK=CCMP] Jun 24 19:12:54 ampit5 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 42:75:c3:f6:b3:d9 Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 42:75:c3:f6:b3:d9 completed [id=0 id_str=] Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 24 19:12:54 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 24 19:12:54 ampit5 dhcpcd[1068]: wlan0: carrier acquired Jun 24 19:12:55 ampit5 dhcpcd[1068]: wlan0: rebinding lease of 10.0.0.146 Jun 24 19:12:55 ampit5 dhcpcd[1068]: wlan0: leased 10.0.0.146 for 172800 seconds Jun 24 19:12:55 ampit5 avahi-daemon[539]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:12:55 ampit5 avahi-daemon[539]: New relevant interface wlan0.IPv4 for mDNS. Jun 24 19:12:55 ampit5 avahi-daemon[539]: Registering new address record for 10.0.0.146 on wlan0.IPv4. Jun 24 19:12:55 ampit5 dhcpcd[1068]: wlan0: adding host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:12:55 ampit5 dhcpcd[1068]: wlan0: adding route to 10.0.0.0/24 Jun 24 19:12:55 ampit5 dhcpcd[1068]: wlan0: adding default route via 10.0.0.1 Jun 24 19:12:55 ampit5 volumio[1091]: Forking 1 albumart workers Jun 24 19:12:56 ampit5 ntpd[594]: Listen normally on 4 wlan0 10.0.0.146 UDP 123 Jun 24 19:12:56 ampit5 ntpd[594]: peers refreshed Jun 24 19:12:59 ampit5 volumio[1091]: info: ___________ START PLUGINS ___________ Jun 24 19:12:59 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:12:59 ampit5 volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:12:59 ampit5 volumio[1091]: info: [1750792379579] CoreMusicLibrary::Adding element Media Servers Jun 24 19:12:59 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 19:13:00 ampit5 volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 24 19:13:00 ampit5 dhcpcd[1068]: wlan0: carrier lost Jun 24 19:13:00 ampit5 dhcpcd[1068]: wlan0: deleting host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:13:00 ampit5 dhcpcd[1068]: wlan0: deleting route to 10.0.0.0/24 Jun 24 19:13:00 ampit5 dhcpcd[1068]: wlan0: deleting default route via 10.0.0.1 Jun 24 19:13:00 ampit5 avahi-daemon[539]: Withdrawing address record for 10.0.0.146 on wlan0. Jun 24 19:13:00 ampit5 avahi-daemon[539]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:13:00 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-DISCONNECTED bssid=42:75:c3:f6:b3:d9 reason=1 Jun 24 19:13:00 ampit5 avahi-daemon[539]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 24 19:13:00 ampit5 kernel: wlan0: deauthenticated from 42:75:c3:f6:b3:d9 (Reason: 1=UNSPECIFIED) Jun 24 19:13:00 ampit5 volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 24 19:13:00 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:13:01 ampit5 volumio[1091]: info: [1750792381068] CoreMusicLibrary::Adding element Last_100 Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 24 19:13:01 ampit5 volumio[1091]: info: [1750792381175] CoreMusicLibrary::Adding element Webradio Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 24 19:13:01 ampit5 volumio[1091]: info: ------------------------------------------- Jun 24 19:13:01 ampit5 volumio[1091]: info: ----- MyVolumio plugins startup ---- Jun 24 19:13:01 ampit5 volumio[1091]: info: ------------------------------------------- Jun 24 19:13:01 ampit5 volumio[1091]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 24 19:13:01 ampit5 volumio[1091]: info: Loading i18n strings for locale en Jun 24 19:13:01 ampit5 volumio[1091]: Updating browse sources language Jun 24 19:13:01 ampit5 volumio[1091]: Cannot find translation for sourceMedia Servers Jun 24 19:13:01 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:02 ampit5 kernel: wlan0: authenticate with 42:75:c3:f6:b3:d9 Jun 24 19:13:02 ampit5 kernel: wlan0: send auth to 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: Trying to associate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:02 ampit5 kernel: wlan0: authenticated Jun 24 19:13:02 ampit5 kernel: wlan0: associate with 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:02 ampit5 kernel: wlan0: RX AssocResp from 42:75:c3:f6:b3:d9 (capab=0x1411 status=0 aid=21) Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: Associated with 42:75:c3:f6:b3:d9 Jun 24 19:13:02 ampit5 kernel: wlan0: associated Jun 24 19:13:02 ampit5 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 42:75:c3:f6:b3:d9 Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: WPA: Key negotiation completed with 42:75:c3:f6:b3:d9 [PTK=CCMP GTK=CCMP] Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 42:75:c3:f6:b3:d9 completed [id=0 id_str=] Jun 24 19:13:02 ampit5 dhcpcd[1068]: wlan0: carrier acquired Jun 24 19:13:02 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 24 19:13:02 ampit5 dhcpcd[1068]: wlan0: rebinding lease of 10.0.0.146 Jun 24 19:13:02 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:13:02 ampit5 volumio[1091]: info: CoreCommandRouter::initPlayerControls Jun 24 19:13:02 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:02 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 24 19:13:03 ampit5 ntpd[594]: Deleting interface #4 wlan0, 10.0.0.146#123, interface stats: received=6, sent=6, dropped=4, active_time=7 secs Jun 24 19:13:03 ampit5 ntpd[594]: 23.186.168.129 interface 10.0.0.146 -> (none) Jun 24 19:13:03 ampit5 ntpd[594]: 23.186.168.127 interface 10.0.0.146 -> (none) Jun 24 19:13:03 ampit5 ntpd[594]: 15.204.246.57 interface 10.0.0.146 -> (none) Jun 24 19:13:03 ampit5 ntpd[594]: 23.142.248.8 interface 10.0.0.146 -> (none) Jun 24 19:13:03 ampit5 ntpd[594]: peers refreshed Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 19:13:03 ampit5 volumio[1091]: info: BOOT COMPLETED Jun 24 19:13:03 ampit5 volumio[1091]: [Metrics] CommandRouter: 40s 297.05ms Jun 24 19:13:03 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:13:03 ampit5 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jun 24 19:13:05 ampit5 volumio[1091]: Starting albumart workers Jun 24 19:13:05 ampit5 kernel: wlan0: deauthenticated from 42:75:c3:f6:b3:d9 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA) Jun 24 19:13:05 ampit5 dhcpcd[1068]: wlan0: carrier lost Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-DISCONNECTED bssid=42:75:c3:f6:b3:d9 reason=7 Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:05 ampit5 kernel: wlan0: authenticate with 42:75:c3:f6:b3:d9 Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: Trying to associate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:05 ampit5 kernel: wlan0: send auth to 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:05 ampit5 kernel: wlan0: authenticated Jun 24 19:13:05 ampit5 kernel: wlan0: associate with 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:05 ampit5 kernel: wlan0: RX AssocResp from 42:75:c3:f6:b3:d9 (capab=0x1411 status=0 aid=24) Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: Associated with 42:75:c3:f6:b3:d9 Jun 24 19:13:05 ampit5 kernel: wlan0: associated Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: WPA: Key negotiation completed with 42:75:c3:f6:b3:d9 [PTK=CCMP GTK=CCMP] Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 42:75:c3:f6:b3:d9 completed [id=0 id_str=] Jun 24 19:13:05 ampit5 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 42:75:c3:f6:b3:d9 Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 24 19:13:05 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 24 19:13:06 ampit5 dhcpcd[1068]: wlan0: carrier acquired Jun 24 19:13:06 ampit5 dhcpcd[1068]: wlan0: rebinding lease of 10.0.0.146 Jun 24 19:13:08 ampit5 volumio-remote-updater[490]: [2025-06-24 19:13:08] [connect] Successful connection Jun 24 19:13:09 ampit5 volumio[1091]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 24 19:13:09 ampit5 volumio[1091]: info: CoreCommandRouter::Close All Modals sent Jun 24 19:13:09 ampit5 volumio[1091]: info: CoreCommandRouter::Close All Modals sent Jun 24 19:13:09 ampit5 volumio[1091]: Express server listening on port 3000 Jun 24 19:13:09 ampit5 volumio[1091]: [Metrics] WebUI: 49s 606.29ms Jun 24 19:13:09 ampit5 volumio[1091]: Volumio Calling Home Jun 24 19:13:10 ampit5 volumio[1091]: info: CoreStateMachine::resetVolumioState Jun 24 19:13:10 ampit5 volumio[1091]: info: CoreStateMachine::getcurrentVolume Jun 24 19:13:10 ampit5 volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 24 19:13:10 ampit5 dhcpcd[1068]: wlan0: carrier lost Jun 24 19:13:10 ampit5 kernel: wlan0: deauthenticated from 42:75:c3:f6:b3:d9 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA) Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-DISCONNECTED bssid=42:75:c3:f6:b3:d9 reason=7 Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: SME: Trying to authenticate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:10 ampit5 kernel: wlan0: authenticate with 42:75:c3:f6:b3:d9 Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: Trying to associate with 42:75:c3:f6:b3:d9 (SSID='marynettoo' freq=2462 MHz) Jun 24 19:13:10 ampit5 kernel: wlan0: send auth to 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:10 ampit5 kernel: wlan0: authenticated Jun 24 19:13:10 ampit5 kernel: wlan0: associate with 42:75:c3:f6:b3:d9 (try 1/3) Jun 24 19:13:10 ampit5 kernel: wlan0: RX AssocResp from 42:75:c3:f6:b3:d9 (capab=0x1411 status=0 aid=10) Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: Associated with 42:75:c3:f6:b3:d9 Jun 24 19:13:10 ampit5 kernel: wlan0: associated Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: WPA: Key negotiation completed with 42:75:c3:f6:b3:d9 [PTK=CCMP GTK=CCMP] Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 42:75:c3:f6:b3:d9 completed [id=0 id_str=] Jun 24 19:13:10 ampit5 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 42:75:c3:f6:b3:d9 Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 24 19:13:10 ampit5 wpa_supplicant[822]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jun 24 19:13:10 ampit5 dhcpcd[1068]: wlan0: carrier acquired Jun 24 19:13:10 ampit5 dhcpcd[1068]: wlan0: rebinding lease of 10.0.0.146 Jun 24 19:13:11 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 19:13:11 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 19:13:12 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 24 19:13:12 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 24 19:13:12 ampit5 sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 24 19:13:12 ampit5 sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:13:12 ampit5 sudo[1371]: pam_unix(sudo:session): session closed for user root Jun 24 19:13:12 ampit5 sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 24 19:13:12 ampit5 sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:13:12 ampit5 sudo[1373]: pam_unix(sudo:session): session closed for user root Jun 24 19:13:13 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 24 19:13:13 ampit5 volumio[1091]: info: Cannot read play queue from file Jun 24 19:13:13 ampit5 volumio[1091]: info: Setting Device type: Raspberry PI Jun 24 19:13:14 ampit5 volumio[1091]: info: MPD running with PID551 Jun 24 19:13:14 ampit5 volumio[1091]: ,establishing connection Jun 24 19:13:14 ampit5 sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jun 24 19:13:14 ampit5 sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 19:13:14 ampit5 sudo[1392]: pam_unix(sudo:session): session closed for user root Jun 24 19:13:15 ampit5 volumio[1091]: info: VolumeController:: Volume=0 Mute =true Jun 24 19:13:15 ampit5 volumio[1091]: info: CoreStateMachine::pushState Jun 24 19:13:15 ampit5 volumio[1091]: info: CorePlayQueue::getTrack 0 Jun 24 19:13:15 ampit5 volumio[1091]: info: CoreCommandRouter::volumioPushState Jun 24 19:13:15 ampit5 volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 19:13:15 ampit5 volumio[1091]: info: CoreStateMachine::updateTrackBlock Jun 24 19:13:15 ampit5 volumio[1091]: info: CorePlayQueue::getTrackBlock Jun 24 19:13:15 ampit5 volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Jun 24 19:13:15 ampit5 volumio[1091]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 19:13:15 ampit5 volumio[1091]: { Error: addMembership ENODEV Jun 24 19:13:15 ampit5 volumio[1091]: at _errnoException (util.js:1022:11) Jun 24 19:13:15 ampit5 volumio[1091]: at Socket.addMembership (dgram.js:615:11) Jun 24 19:13:15 ampit5 volumio[1091]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Jun 24 19:13:15 ampit5 volumio[1091]: at ontimeout (timers.js:482:11) Jun 24 19:13:15 ampit5 volumio[1091]: at tryOnTimeout (timers.js:317:5) Jun 24 19:13:15 ampit5 volumio[1091]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Jun 24 19:13:15 ampit5 volumio[1091]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 19:13:15 ampit5 dhcpcd[1068]: wlan0: leased 10.0.0.146 for 172800 seconds Jun 24 19:13:15 ampit5 dhcpcd[1068]: wlan0: adding host route to 10.0.0.146 via 127.0.0.1 Jun 24 19:13:15 ampit5 avahi-daemon[539]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.146. Jun 24 19:13:15 ampit5 avahi-daemon[539]: New relevant interface wlan0.IPv4 for mDNS. Jun 24 19:13:15 ampit5 avahi-daemon[539]: Registering new address record for 10.0.0.146 on wlan0.IPv4. Jun 24 19:13:15 ampit5 dhcpcd[1068]: wlan0: adding route to 10.0.0.0/24 Jun 24 19:13:15 ampit5 dhcpcd[1068]: wlan0: adding default route via 10.0.0.1 Jun 24 19:13:17 ampit5 ntpd[594]: Listen normally on 5 wlan0 10.0.0.146 UDP 123 Jun 24 19:13:17 ampit5 ntpd[594]: peers refreshed Jun 24 19:13:20 ampit5 sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 19:12 Jun 24 19:13:20 ampit5 sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"