Dec 19 14:04:46 volumio dhcpcd[951]: eth0: carrier lost Dec 19 14:04:46 volumio kernel: e1000e 0000:00:19.0 eth0: NIC Link is Down Dec 19 14:04:46 volumio avahi-daemon[882]: Withdrawing address record for 192.168.0.1 on eth0. Dec 19 14:04:46 volumio avahi-daemon[882]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.1. Dec 19 14:04:46 volumio avahi-daemon[882]: Interface eth0.IPv4 no longer relevant for mDNS. Dec 19 14:04:46 volumio dhcpcd[951]: eth0: deleting route to 192.168.0.0/24 Dec 19 14:04:46 volumio dhcpcd[951]: eth0: deleting default route via 192.168.0.1 Dec 19 14:04:46 volumio volumio[1270]: info: Discovery: A device disappeared from network Dec 19 14:04:46 volumio volumio[1270]: info: Discovery: Device volumio disappeared from network Dec 19 14:04:46 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 19 14:04:46 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 19 14:04:46 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 19 14:04:46 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 19 14:04:46 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 19 14:04:46 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 19 14:04:46 volumio welcome[23580]: Resolved ip:[0] Dec 19 14:04:46 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 19 14:04:46 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 19 14:04:47 volumio ifplugd(eth0)[1169]: Link beat lost. Dec 19 14:04:48 volumio ntpd[1152]: IO: Deleting interface #5 eth0, 192.168.0.1#123, interface stats: received=0, sent=0, dropped=0, active_time=5934 secs Dec 19 14:04:50 volumio volumio[1270]: info: Volumio Network Manager: Network status updated: 0 Dec 19 14:04:57 volumio ifplugd(eth0)[1169]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Dec 19 14:04:57 volumio kernel: e1000e 0000:00:19.0 eth0: NIC Link is Down Dec 19 14:04:57 volumio wireless.js[22378]: WIRELESS.JS: Wired network status changed to: ---disconnected--- Dec 19 14:04:57 volumio wireless.js[22378]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 19 14:04:57 volumio wireless.js[22378]: WIRELESS.JS: Cleaning previous... Dec 19 14:04:57 volumio ifplugd(eth0)[1169]: Program executed successfully. Dec 19 14:04:57 volumio volumio[1270]: info: CorePlayQueue::getTrack 23 Dec 19 14:04:57 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:04:57 volumio volumio[1270]: info: Prefetching next song Dec 19 14:04:57 volumio volumio[1270]: info: DOING PREFETCH IN MPD Dec 19 14:04:57 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand add "NAS/Flamenko/Un Amor.flac" Dec 19 14:04:57 volumio volumio[1270]: info: sendMpdCommand add "NAS/Flamenko/Un Amor.flac" took 1 milliseconds Dec 19 14:04:57 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 19 14:04:57 volumio volumio[1270]: info: Dec 19 14:04:57 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:04:57 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:04:57 volumio volumio[1270]: info: sendMpdCommand consume 1 took 1 milliseconds Dec 19 14:04:57 volumio volumio[1270]: info: Dec 19 14:04:57 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:04:57 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:04:57 volumio volumio[1270]: info: Dec 19 14:04:57 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:04:57 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:04:57 volumio volumio[1270]: info: ------------------------------ 2ms Dec 19 14:04:57 volumio volumio[1270]: info: ------------------------------ 1ms Dec 19 14:04:57 volumio volumio[1270]: info: ------------------------------ 1ms Dec 19 14:04:57 volumio sudo[23659]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 14:04:57 volumio sudo[23659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 14:04:57 volumio sudo[23659]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:57 volumio sudo[23663]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 14:04:57 volumio sudo[23663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 14:04:58 volumio sudo[23663]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:58 volumio wireless.js[22378]: WIRELESS.JS: Stopped aP Dec 19 14:04:58 volumio sudo[23674]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 14:04:58 volumio sudo[23674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:58 volumio sudo[23674]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:58 volumio sudo[23676]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 19 14:04:58 volumio sudo[23676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:58 volumio sudo[23676]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:58 volumio sudo[23684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 14:04:58 volumio sudo[23684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:58 volumio sudo[23684]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:58 volumio sudo[23686]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 19 14:04:58 volumio sudo[23686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:59 volumio sudo[23686]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: DE Dec 19 14:04:59 volumio sudo[23695]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 14:04:59 volumio sudo[23695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:59 volumio sudo[23695]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio sudo[23697]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Dec 19 14:04:59 volumio sudo[23697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:04:59 volumio sudo[23697]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: DE Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: Start wireless flow Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: Stopped hotspot (if there).. Dec 19 14:04:59 volumio sudo[23705]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 14:04:59 volumio sudo[23705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 14:04:59 volumio sudo[23705]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio sudo[23707]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 14:04:59 volumio sudo[23707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 14:04:59 volumio sudo[23707]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: DHCP IP fallback Dec 19 14:04:59 volumio wireless.js[22378]: WIRELESS.JS: Start ap Dec 19 14:04:59 volumio wpa_supplicant[23712]: Successfully initialized wpa_supplicant Dec 19 14:04:59 volumio sudo[23713]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 19 14:04:59 volumio sudo[23713]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 14:04:59 volumio sudo[23713]: pam_unix(sudo:session): session closed for user root Dec 19 14:04:59 volumio dhcpcd[951]: control_free: No such file or directory Dec 19 14:04:59 volumio dhcpcd[951]: control command: /sbin/dhcpcd Dec 19 14:05:00 volumio dhcpcd[951]: lo: IAID 00:00:00:00 Dec 19 14:05:00 volumio dhcpcd[951]: lo: ipv6_start: Operation not supported Dec 19 14:05:00 volumio dhcpcd[951]: lo: using static address 127.0.0.1/8 Dec 19 14:05:00 volumio dhcpcd[951]: lo: adding route to 127.0.0.0/8 Dec 19 14:05:00 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Dec 19 14:05:00 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:00 volumio sudo[23748]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:00 volumio sudo[23748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:00 volumio sudo[23748]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: SME: Trying to authenticate with 04:b4:fe:d3:a7:7e (SSID='FRITZ!Box 5590 DN' freq=2437 MHz) Dec 19 14:05:01 volumio kernel: wlan0: authenticate with 04:b4:fe:d3:a7:7e (local address=60:d8:19:d5:05:9c) Dec 19 14:05:01 volumio kernel: wlan0: send auth to 04:b4:fe:d3:a7:7e (try 1/3) Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: Trying to associate with 04:b4:fe:d3:a7:7e (SSID='FRITZ!Box 5590 DN' freq=2437 MHz) Dec 19 14:05:01 volumio kernel: wlan0: authenticated Dec 19 14:05:01 volumio kernel: wlan0: associate with 04:b4:fe:d3:a7:7e (try 1/3) Dec 19 14:05:01 volumio kernel: wlan0: RX AssocResp from 04:b4:fe:d3:a7:7e (capab=0x1431 status=0 aid=1) Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: Associated with 04:b4:fe:d3:a7:7e Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Dec 19 14:05:01 volumio kernel: wlan0: associated Dec 19 14:05:01 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 19 14:05:01 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 04:b4:fe:d3:a7:7e Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: WPA: Key negotiation completed with 04:b4:fe:d3:a7:7e [PTK=CCMP GTK=CCMP] Dec 19 14:05:01 volumio wpa_supplicant[23745]: wlan0: CTRL-EVENT-CONNECTED - Connection to 04:b4:fe:d3:a7:7e completed [id=0 id_str=] Dec 19 14:05:01 volumio dhcpcd[951]: wlan0: carrier acquired Dec 19 14:05:01 volumio dhcpcd[951]: wlan0: connected to Access Point: FRITZ!Box 5590 DN Dec 19 14:05:01 volumio dhcpcd[951]: wlan0: IAID 19:d5:05:9c Dec 19 14:05:01 volumio dhcpcd[951]: wlan0: adding address fe80::62d8:19ff:fed5:59c Dec 19 14:05:01 volumio dhcpcd[951]: ipv6_addaddr1: Permission denied Dec 19 14:05:01 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:01 volumio sudo[23802]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:01 volumio dhcpcd[951]: wlan0: soliciting an IPv6 router Dec 19 14:05:01 volumio sudo[23802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:01 volumio sudo[23802]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::startPlaybackTimer Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:02 volumio sudo[23825]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:02 volumio sudo[23825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:02 volumio sudo[23825]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:05:02 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces state update: player Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::getState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand status Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:05:02 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces state update: player Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::getState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand status Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces system playlist update Dec 19 14:05:02 volumio volumio[1270]: info: Ignoring MPD Status Update Dec 19 14:05:02 volumio volumio[1270]: info: Dec 19 14:05:02 volumio volumio[1270]: ---------------------------- MPD announces state update: player Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::getState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand status Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 2ms Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand status took 1 milliseconds Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 1ms Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand status took 1 milliseconds Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 1ms Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand status took 1 milliseconds Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseState Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseTrackInfo Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseTrackInfo Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"818 Kbps","isStreaming":false,"title":"Un Amor","artist":"Gypsy Kings","album":"King Size Hits","uri":"NAS/Flamenko/Un Amor.flac","trackType":"flac"} Dec 19 14:05:02 volumio volumio[1270]: verbose: CURRENT POSITION 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState stateService play Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus play Dec 19 14:05:02 volumio volumio[1270]: info: Received an update from plugin. extracting info from payload Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"818 Kbps","isStreaming":false,"title":"Un Amor","artist":"Gypsy Kings","album":"King Size Hits","uri":"NAS/Flamenko/Un Amor.flac","trackType":"flac"} Dec 19 14:05:02 volumio volumio[1270]: verbose: CURRENT POSITION 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState stateService play Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus play Dec 19 14:05:02 volumio volumio[1270]: info: Received an update from plugin. extracting info from payload Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 10ms Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 10ms Dec 19 14:05:02 volumio volumio[1270]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 19 14:05:02 volumio volumio[1270]: verbose: ControllerMpd::parseTrackInfo Dec 19 14:05:02 volumio volumio[1270]: info: ControllerMpd::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"818 Kbps","isStreaming":false,"title":"Un Amor","artist":"Gypsy Kings","album":"King Size Hits","uri":"NAS/Flamenko/Un Amor.flac","trackType":"flac"} Dec 19 14:05:02 volumio volumio[1270]: verbose: CURRENT POSITION 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState stateService play Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::syncState currentStatus play Dec 19 14:05:02 volumio volumio[1270]: info: Received an update from plugin. extracting info from payload Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 19 14:05:02 volumio volumio[1270]: info: CorePlayQueue::getTrack 29 Dec 19 14:05:02 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 19 14:05:02 volumio volumio[1270]: info: ------------------------------ 13ms Dec 19 14:05:03 volumio dhcpcd[951]: wlan0: rebinding lease of 192.168.178.143 Dec 19 14:05:03 volumio dhcpcd[951]: wlan0: probing address 192.168.178.143/24 Dec 19 14:05:03 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:03 volumio sudo[23842]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:03 volumio sudo[23842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:03 volumio sudo[23842]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:04 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:04 volumio sudo[23855]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:04 volumio sudo[23855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:04 volumio sudo[23855]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:05 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:05 volumio sudo[23868]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:05 volumio sudo[23868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:05 volumio sudo[23868]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:06 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:06 volumio sudo[23881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:06 volumio sudo[23881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:06 volumio sudo[23881]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:06 volumio bash[23786]: setdatetime-helper: all HTTPS Date fallbacks failed Dec 19 14:05:06 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 19 14:05:06 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 19 14:05:07 volumio wireless.js[22378]: WIRELESS.JS: trying... Dec 19 14:05:07 volumio sudo[23890]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 14:05:07 volumio sudo[23890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 14:05:07 volumio sudo[23890]: pam_unix(sudo:session): session closed for user root Dec 19 14:05:08 volumio dhcpcd[951]: wlan0: leased 192.168.178.143 for 864000 seconds Dec 19 14:05:08 volumio avahi-daemon[882]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.143. Dec 19 14:05:08 volumio avahi-daemon[882]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 14:05:08 volumio avahi-daemon[882]: Registering new address record for 192.168.178.143 on wlan0.IPv4. Dec 19 14:05:08 volumio dhcpcd[951]: wlan0: adding route to 192.168.178.0/24 Dec 19 14:05:08 volumio dhcpcd[951]: wlan0: adding default route via 192.168.178.1 Dec 19 14:05:08 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 19 14:05:08 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 19 14:05:08 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 19 14:05:08 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 19 14:05:08 volumio welcome[23907]: Resolved ip:[1] 192.168.178.143 Dec 19 14:05:08 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 19 14:05:08 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 19 14:05:08 volumio volumio[1270]: compat.c: read() failed: Resource temporarily unavailable Dec 19 14:05:08 volumio volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 14:05:08 volumio volumio[1270]: Error: dns service error: unknown Dec 19 14:05:08 volumio volumio[1270]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 19 14:05:08 volumio volumio[1270]: errorCode: -65537 Dec 19 14:05:08 volumio volumio[1270]: } Dec 19 14:05:08 volumio volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 14:05:08 volumio sudo[23941]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-19 14:04' Dec 19 14:05:08 volumio sudo[23941]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 12:15:37 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="3ca59a0b3ec3a926fd3274a2fb539106"