Jan 11 08:46:16 volumio-patio ntpd[1017]: PROTO: 162.159.200.1 unlink local addr 192.168.4.212 -> Jan 11 08:46:50 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jan 11 08:46:50 volumio-patio volumio[1156]: info: Saving new wireless network Jan 11 08:46:50 volumio-patio sudo[3554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jan 11 08:46:50 volumio-patio sudo[3554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:50 volumio-patio sudo[3554]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:50 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jan 11 08:46:50 volumio-patio volumio[1156]: info: Discovery: Restarting Advertising due to device name change Jan 11 08:46:50 volumio-patio sudo[3557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jan 11 08:46:50 volumio-patio sudo[3557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:50 volumio-patio systemd[1]: Stopping wireless.service - Wireless Services... Jan 11 08:46:50 volumio-patio systemd[1]: wireless.service: Deactivated successfully. Jan 11 08:46:50 volumio-patio systemd[1]: Stopped wireless.service - Wireless Services. Jan 11 08:46:50 volumio-patio systemd[1]: wireless.service: Consumed 8min 53.724s CPU time. Jan 11 08:46:50 volumio-patio systemd[1]: Starting wireless.service - Wireless Services... Jan 11 08:46:50 volumio-patio wireless.js[3564]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Jan 11 08:46:50 volumio-patio wireless.js[3564]: WIRELESS.JS: Wired network status changed to: ---connected--- Jan 11 08:46:50 volumio-patio wireless.js[3564]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 11 08:46:50 volumio-patio wireless.js[3564]: WIRELESS.JS: Cleaning previous... Jan 11 08:46:50 volumio-patio sudo[3583]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 11 08:46:50 volumio-patio sudo[3583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:46:50 volumio-patio sudo[3583]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:50 volumio-patio sudo[3585]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 11 08:46:50 volumio-patio sudo[3585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:46:51 volumio-patio volumio[1156]: info: Discovery: A device disappeared from network Jan 11 08:46:51 volumio-patio volumio[1156]: info: Discovery: A device disappeared from network Jan 11 08:46:51 volumio-patio sudo[3585]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:51 volumio-patio sudo[3588]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:51 volumio-patio sudo[3588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:51 volumio-patio sudo[3588]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:51 volumio-patio wireless.js[3564]: WIRELESS.JS: Stopped aP Jan 11 08:46:51 volumio-patio sudo[3596]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:46:51 volumio-patio sudo[3596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:51 volumio-patio sudo[3596]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:51 volumio-patio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 11 08:46:51 volumio-patio sudo[3598]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 11 08:46:51 volumio-patio sudo[3598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:51 volumio-patio sudo[3598]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:51 volumio-patio sudo[3606]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:46:51 volumio-patio sudo[3606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:51 volumio-patio sudo[3606]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:51 volumio-patio sudo[3608]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 11 08:46:51 volumio-patio sudo[3608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:52 volumio-patio sudo[3613]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:52 volumio-patio sudo[3613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:52 volumio-patio sudo[3613]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:53 volumio-patio sudo[3617]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:53 volumio-patio sudo[3617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:53 volumio-patio sudo[3617]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:53 volumio-patio sudo[3608]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:53 volumio-patio wireless.js[3564]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: AU Jan 11 08:46:53 volumio-patio sudo[3622]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:46:53 volumio-patio sudo[3622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:53 volumio-patio sudo[3622]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:53 volumio-patio sudo[3624]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set AU Jan 11 08:46:53 volumio-patio sudo[3624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:53 volumio-patio sudo[3624]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:53 volumio-patio wireless.js[3564]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: AU Jan 11 08:46:53 volumio-patio wireless.js[3564]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Jan 11 08:46:54 volumio-patio wireless.js[3564]: WIRELESS.JS: Notified systemd about wireless ready Jan 11 08:46:54 volumio-patio systemd[1]: Started wireless.service - Wireless Services. Jan 11 08:46:54 volumio-patio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 11 08:46:54 volumio-patio sudo[3557]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:54 volumio-patio sudo[3633]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:54 volumio-patio sudo[3633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:54 volumio-patio sudo[3633]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:55 volumio-patio volumio[1156]: info: Discovery: Started advertising with name: Volumio Patio Jan 11 08:46:55 volumio-patio sudo[3638]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:55 volumio-patio sudo[3638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:55 volumio-patio sudo[3638]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:56 volumio-patio volumio[1156]: info: Discovery: adding 5ac2fd53-caf3-42d0-976b-c6f04ea119d1 Jan 11 08:46:56 volumio-patio volumio[1156]: info: Discovery: Found device Volumio Patio Jan 11 08:46:56 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:46:56 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:56 volumio-patio volumio[1156]: info: Discovery: this is already registered, 5ac2fd53-caf3-42d0-976b-c6f04ea119d1 Jan 11 08:46:56 volumio-patio volumio[1156]: info: Discovery: Found device Volumio Patio Jan 11 08:46:56 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:46:56 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:56 volumio-patio sudo[3658]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:56 volumio-patio sudo[3658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:56 volumio-patio sudo[3658]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:57 volumio-patio sudo[3662]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:57 volumio-patio sudo[3662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:57 volumio-patio sudo[3662]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:46:57 volumio-patio volumio[1156]: info: Prefetching next song Jan 11 08:46:57 volumio-patio volumio[1156]: info: DOING PREFETCH IN MPD Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand add "USB/0403-0201/music/ff8/blue-sky.mp3" Jan 11 08:46:57 volumio-patio volumio[1156]: info: Jan 11 08:46:57 volumio-patio volumio[1156]: ---------------------------- MPD announces system playlist update Jan 11 08:46:57 volumio-patio volumio[1156]: info: Ignoring MPD Status Update Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand add "USB/0403-0201/music/ff8/blue-sky.mp3" took 1 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 11 08:46:57 volumio-patio volumio[1156]: info: Jan 11 08:46:57 volumio-patio volumio[1156]: ---------------------------- MPD announces system playlist update Jan 11 08:46:57 volumio-patio volumio[1156]: info: Ignoring MPD Status Update Jan 11 08:46:57 volumio-patio volumio[1156]: info: Jan 11 08:46:57 volumio-patio volumio[1156]: ---------------------------- MPD announces state update: options Jan 11 08:46:57 volumio-patio volumio[1156]: info: ------------------------------ 3ms Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand consume 1 took 3 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: info: ControllerMpd::getState Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 11 08:46:57 volumio-patio volumio[1156]: info: Jan 11 08:46:57 volumio-patio volumio[1156]: ---------------------------- MPD announces state update: options Jan 11 08:46:57 volumio-patio volumio[1156]: info: ControllerMpd::getState Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 11 08:46:57 volumio-patio volumio[1156]: info: ------------------------------ 4ms Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand status took 9 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::parseState Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand status took 9 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::parseState Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::parseTrackInfo Jan 11 08:46:57 volumio-patio volumio[1156]: info: ControllerMpd::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::servicePushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: STATE SERVICE {"status":"play","position":0,"seek":169073,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"blue-fields.mp3","artist":null,"album":null,"uri":"USB/0403-0201/music/ff8/blue-fields.mp3","trackType":"mp3"} Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: CURRENT POSITION 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::syncState stateService play Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::syncState currentStatus play Jan 11 08:46:57 volumio-patio volumio[1156]: info: Received an update from plugin. extracting info from payload Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: ------------------------------ 26ms Jan 11 08:46:57 volumio-patio volumio[1156]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: ControllerMpd::parseTrackInfo Jan 11 08:46:57 volumio-patio volumio[1156]: info: ControllerMpd::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::servicePushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: STATE SERVICE {"status":"play","position":0,"seek":169073,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"blue-fields.mp3","artist":null,"album":null,"uri":"USB/0403-0201/music/ff8/blue-fields.mp3","trackType":"mp3"} Jan 11 08:46:57 volumio-patio volumio[1156]: verbose: CURRENT POSITION 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::syncState stateService play Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::syncState currentStatus play Jan 11 08:46:57 volumio-patio volumio[1156]: info: Received an update from plugin. extracting info from payload Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 3 Jan 11 08:46:57 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:46:57 volumio-patio volumio[1156]: info: ------------------------------ 39ms Jan 11 08:46:58 volumio-patio sudo[3668]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:58 volumio-patio sudo[3668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:58 volumio-patio sudo[3668]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:59 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jan 11 08:46:59 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jan 11 08:46:59 volumio-patio sudo[3671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:59 volumio-patio sudo[3671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:59 volumio-patio sudo[3671]: pam_unix(sudo:session): session closed for user root Jan 11 08:46:59 volumio-patio sudo[3674]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:46:59 volumio-patio sudo[3674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:46:59 volumio-patio sudo[3674]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:00 volumio-patio sudo[3677]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:00 volumio-patio sudo[3677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:00 volumio-patio sudo[3677]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:01 volumio-patio sudo[3680]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:01 volumio-patio sudo[3680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:01 volumio-patio sudo[3680]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:02 volumio-patio sudo[3683]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:02 volumio-patio sudo[3683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:02 volumio-patio sudo[3683]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::startPlaybackTimer Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: Jan 11 08:47:02 volumio-patio volumio[1156]: ---------------------------- MPD announces system playlist update Jan 11 08:47:02 volumio-patio volumio[1156]: info: Ignoring MPD Status Update Jan 11 08:47:02 volumio-patio volumio[1156]: info: Jan 11 08:47:02 volumio-patio volumio[1156]: ---------------------------- MPD announces state update: player Jan 11 08:47:02 volumio-patio volumio[1156]: info: ControllerMpd::getState Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 11 08:47:02 volumio-patio volumio[1156]: info: Jan 11 08:47:02 volumio-patio volumio[1156]: ---------------------------- MPD announces system playlist update Jan 11 08:47:02 volumio-patio volumio[1156]: info: Ignoring MPD Status Update Jan 11 08:47:02 volumio-patio volumio[1156]: info: Jan 11 08:47:02 volumio-patio volumio[1156]: ---------------------------- MPD announces state update: player Jan 11 08:47:02 volumio-patio volumio[1156]: info: ControllerMpd::getState Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 11 08:47:02 volumio-patio volumio[1156]: info: ------------------------------ 6ms Jan 11 08:47:02 volumio-patio volumio[1156]: info: sendMpdCommand status took 6 milliseconds Jan 11 08:47:02 volumio-patio volumio[1156]: info: ------------------------------ 6ms Jan 11 08:47:02 volumio-patio volumio[1156]: info: sendMpdCommand status took 5 milliseconds Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::parseState Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::parseState Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 08:47:02 volumio-patio volumio[1156]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 08:47:02 volumio-patio volumio[1156]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::parseTrackInfo Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: ControllerMpd::parseTrackInfo Jan 11 08:47:02 volumio-patio volumio[1156]: info: ControllerMpd::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::servicePushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"blue-sky.mp3","artist":null,"album":null,"uri":"USB/0403-0201/music/ff8/blue-sky.mp3","trackType":"mp3"} Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: CURRENT POSITION 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::syncState stateService play Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::syncState currentStatus play Jan 11 08:47:02 volumio-patio volumio[1156]: info: Received an update from plugin. extracting info from payload Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: ControllerMpd::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::servicePushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":45,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"blue-sky.mp3","artist":null,"album":null,"uri":"USB/0403-0201/music/ff8/blue-sky.mp3","trackType":"mp3"} Jan 11 08:47:02 volumio-patio volumio[1156]: verbose: CURRENT POSITION 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::syncState stateService play Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::syncState currentStatus play Jan 11 08:47:02 volumio-patio volumio[1156]: info: Received an update from plugin. extracting info from payload Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreStateMachine::pushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:02 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 11 08:47:02 volumio-patio volumio[1156]: info: ------------------------------ 33ms Jan 11 08:47:02 volumio-patio volumio[1156]: info: ------------------------------ 33ms Jan 11 08:47:03 volumio-patio sudo[3686]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:03 volumio-patio sudo[3686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:03 volumio-patio sudo[3686]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:04 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jan 11 08:47:04 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jan 11 08:47:04 volumio-patio volumio[1156]: info: Refreshing Cached IP Addresses Jan 11 08:47:04 volumio-patio sudo[3690]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jan 11 08:47:04 volumio-patio sudo[3690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:04 volumio-patio sudo[3692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 08:47:04 volumio-patio sudo[3692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:04 volumio-patio sudo[3692]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:04 volumio-patio sudo[3690]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:04 volumio-patio sudo[3694]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:04 volumio-patio sudo[3694]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:04 volumio-patio sudo[3694]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:04 volumio-patio sudo[3699]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:04 volumio-patio sudo[3699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:04 volumio-patio sudo[3699]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3702]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3702]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3705]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 08:47:05 volumio-patio sudo[3705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3705]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3707]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3707]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio volumio[1156]: verbose: New Socket.io Connection to 192.168.4.212 from 192.168.4.249 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:47:05 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 08:47:05 volumio-patio volumio[1156]: info: Received Get System Info Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 08:47:05 volumio-patio volumio[1156]: info: Discovery: Getting this device information Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:47:05 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:47:05 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:05 volumio-patio volumio[1156]: info: Listing playlists Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 11 08:47:05 volumio-patio sudo[3715]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jan 11 08:47:05 volumio-patio sudo[3715]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3720]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3715]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3726]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3720]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3726]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jan 11 08:47:05 volumio-patio sudo[3733]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3740]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 08:47:05 volumio-patio sudo[3733]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3740]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3740]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3742]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:05 volumio-patio sudo[3742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio sudo[3742]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:05 volumio-patio sudo[3746]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 11 08:47:05 volumio-patio sudo[3746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:05 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 11 08:47:06 volumio-patio sudo[3764]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:06 volumio-patio sudo[3764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:06 volumio-patio sudo[3764]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 11 08:47:07 volumio-patio sudo[3767]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:07 volumio-patio sudo[3767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:07 volumio-patio sudo[3767]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 11 08:47:07 volumio-patio volumio[1156]: info: Received Get System Info Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 08:47:07 volumio-patio volumio[1156]: info: Discovery: Getting this device information Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 11 08:47:07 volumio-patio volumio[1156]: info: CorePlayQueue::getTrack 4 Jan 11 08:47:07 volumio-patio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 08:47:08 volumio-patio sudo[3770]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:08 volumio-patio sudo[3770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:08 volumio-patio sudo[3770]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:08 volumio-patio sudo[3746]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:09 volumio-patio sudo[3773]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:09 volumio-patio sudo[3773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:09 volumio-patio sudo[3773]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:10 volumio-patio sudo[3776]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:10 volumio-patio sudo[3776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:10 volumio-patio sudo[3776]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:11 volumio-patio sudo[3779]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:11 volumio-patio sudo[3779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:11 volumio-patio sudo[3779]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:12 volumio-patio sudo[3782]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:12 volumio-patio sudo[3782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:12 volumio-patio sudo[3782]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:13 volumio-patio sudo[3786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:13 volumio-patio sudo[3786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:13 volumio-patio sudo[3786]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:14 volumio-patio sudo[3789]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 08:47:14 volumio-patio sudo[3789]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:14 volumio-patio sudo[3791]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:14 volumio-patio sudo[3791]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:14 volumio-patio sudo[3791]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:14 volumio-patio sudo[3789]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:14 volumio-patio sudo[3795]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 11 08:47:14 volumio-patio sudo[3795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:14 volumio-patio sudo[3798]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:14 volumio-patio sudo[3798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:14 volumio-patio sudo[3798]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:14 volumio-patio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Jan 11 08:47:14 volumio-patio sudo[3795]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:14 volumio-patio volumio[1156]: info: Upmpdcli Daemon Started Jan 11 08:47:14 volumio-patio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Jan 11 08:47:14 volumio-patio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Jan 11 08:47:14 volumio-patio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully. Jan 11 08:47:15 volumio-patio sudo[3803]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:15 volumio-patio sudo[3803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:15 volumio-patio sudo[3803]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:15 volumio-patio dhcpcd[672]: eth0: carrier lost Jan 11 08:47:15 volumio-patio dhcpcd[787]: eth0: carrier lost Jan 11 08:47:15 volumio-patio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jan 11 08:47:15 volumio-patio dhcpcd[787]: eth0: deleting route to 192.168.4.0/22 Jan 11 08:47:15 volumio-patio dhcpcd[787]: eth0: deleting default route via 192.168.4.1 Jan 11 08:47:15 volumio-patio avahi-daemon[719]: Withdrawing address record for 192.168.4.212 on eth0. Jan 11 08:47:15 volumio-patio avahi-daemon[719]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.4.212. Jan 11 08:47:15 volumio-patio dhcpcd[672]: eth0: deleting route to 192.168.4.0/22 Jan 11 08:47:15 volumio-patio dhcpcd[672]: eth0: deleting default route via 192.168.4.1 Jan 11 08:47:15 volumio-patio avahi-daemon[719]: Interface eth0.IPv4 no longer relevant for mDNS. Jan 11 08:47:15 volumio-patio volumio[1156]: info: Discovery: A device disappeared from network Jan 11 08:47:15 volumio-patio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jan 11 08:47:15 volumio-patio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jan 11 08:47:15 volumio-patio systemd[1]: welcome.service: Deactivated successfully. Jan 11 08:47:15 volumio-patio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jan 11 08:47:15 volumio-patio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jan 11 08:47:15 volumio-patio systemd[1]: Starting welcome.service - Show a welcome message on console... Jan 11 08:47:15 volumio-patio welcome[3857]: Resolved ip:[0] Jan 11 08:47:15 volumio-patio systemd[1]: Finished welcome.service - Show a welcome message on console. Jan 11 08:47:15 volumio-patio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jan 11 08:47:16 volumio-patio volumio[1156]: info: Volumio Network Manager: Network status updated: 0 Jan 11 08:47:16 volumio-patio sudo[3877]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:16 volumio-patio sudo[3877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:16 volumio-patio sudo[3877]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:16 volumio-patio ifplugd(eth0)[1002]: Link beat lost. Jan 11 08:47:17 volumio-patio sudo[3881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:17 volumio-patio sudo[3881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:17 volumio-patio sudo[3881]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:17 volumio-patio ntpd[1017]: IO: Deleting interface #3 eth0, 192.168.4.212#123, interface stats: received=290, sent=290, dropped=1, active_time=882 secs Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 162.159.200.123 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 160.30.139.11 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 203.29.241.127 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 139.99.135.247 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 159.196.178.7 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 172.105.173.191 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 119.18.6.37 unlink local addr 192.168.4.212 -> Jan 11 08:47:17 volumio-patio ntpd[1017]: PROTO: 27.124.125.251 unlink local addr 192.168.4.212 -> Jan 11 08:47:18 volumio-patio sudo[3887]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:18 volumio-patio sudo[3887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:18 volumio-patio sudo[3887]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:19 volumio-patio sudo[3890]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:19 volumio-patio sudo[3890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:19 volumio-patio sudo[3890]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:20 volumio-patio sudo[3893]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 08:47:20 volumio-patio sudo[3893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:20 volumio-patio sudo[3893]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:26 volumio-patio ifplugd(eth0)[1002]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Jan 11 08:47:26 volumio-patio ifplugd(eth0)[1002]: client: sending signal ALRM to pid 671 Jan 11 08:47:26 volumio-patio dhcpcd[3919]: sending signal ALRM to pid 671 Jan 11 08:47:26 volumio-patio dhcpcd[3919]: waiting for pid 671 to exit Jan 11 08:47:26 volumio-patio ifplugd(eth0)[1002]: client: waiting for pid 671 to exit Jan 11 08:47:26 volumio-patio dhcpcd[672]: received SIGALRM, releasing Jan 11 08:47:26 volumio-patio dhcpcd[672]: eth0: removing interface Jan 11 08:47:26 volumio-patio wireless.js[3564]: WIRELESS.JS: Wired network status changed to: ---disconnected--- Jan 11 08:47:26 volumio-patio wireless.js[3564]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 11 08:47:26 volumio-patio wireless.js[3564]: WIRELESS.JS: Cleaning previous... Jan 11 08:47:26 volumio-patio ifplugd(eth0)[1002]: Program executed successfully. Jan 11 08:47:26 volumio-patio kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Jan 11 08:47:26 volumio-patio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Jan 11 08:47:26 volumio-patio sudo[3944]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 11 08:47:26 volumio-patio sudo[3944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:47:26 volumio-patio sudo[3944]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:26 volumio-patio sudo[3946]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 11 08:47:26 volumio-patio sudo[3946]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:47:27 volumio-patio sudo[3946]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:27 volumio-patio wireless.js[3564]: WIRELESS.JS: Stopped aP Jan 11 08:47:27 volumio-patio sudo[3954]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:47:27 volumio-patio sudo[3954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:27 volumio-patio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 11 08:47:27 volumio-patio sudo[3954]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:27 volumio-patio sudo[3956]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 11 08:47:27 volumio-patio sudo[3956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:27 volumio-patio sudo[3956]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:27 volumio-patio sudo[3964]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:47:27 volumio-patio sudo[3964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:27 volumio-patio sudo[3964]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:27 volumio-patio sudo[3966]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 11 08:47:27 volumio-patio sudo[3966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:29 volumio-patio sudo[3966]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:29 volumio-patio wireless.js[3564]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: AU Jan 11 08:47:29 volumio-patio sudo[3972]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 11 08:47:29 volumio-patio sudo[3972]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:29 volumio-patio sudo[3972]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:29 volumio-patio sudo[3974]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set AU Jan 11 08:47:29 volumio-patio sudo[3974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:29 volumio-patio sudo[3974]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:29 volumio-patio wireless.js[3564]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: AU Jan 11 08:47:29 volumio-patio wireless.js[3564]: WIRELESS.JS: Start wireless flow Jan 11 08:47:29 volumio-patio wireless.js[3564]: WIRELESS.JS: Stopped hotspot (if there).. Jan 11 08:47:30 volumio-patio sudo[3982]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 11 08:47:30 volumio-patio sudo[3982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:47:30 volumio-patio sudo[3982]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:30 volumio-patio sudo[3984]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 11 08:47:30 volumio-patio sudo[3984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:47:30 volumio-patio sudo[3984]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:30 volumio-patio wireless.js[3564]: WIRELESS.JS: DHCP IP fallback Jan 11 08:47:30 volumio-patio wireless.js[3564]: WIRELESS.JS: Start ap Jan 11 08:47:30 volumio-patio wpa_supplicant[3989]: Successfully initialized wpa_supplicant Jan 11 08:47:30 volumio-patio sudo[3990]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 11 08:47:30 volumio-patio sudo[3990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 08:47:30 volumio-patio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 11 08:47:30 volumio-patio sudo[3990]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:30 volumio-patio dhcpcd[787]: control command: /sbin/dhcpcd Jan 11 08:47:30 volumio-patio dhcpcd[787]: control_free: No such file or directory Jan 11 08:47:30 volumio-patio dhcpcd[787]: lo: IAID 00:00:00:00 Jan 11 08:47:30 volumio-patio dhcpcd[787]: lo: adding address fe80::8b0c:3b4a:2c62:ac1 Jan 11 08:47:30 volumio-patio dhcpcd[787]: ipv6_addaddr1: Permission denied Jan 11 08:47:30 volumio-patio dhcpcd[787]: lo: using static address 127.0.0.1/8 Jan 11 08:47:30 volumio-patio dhcpcd[787]: lo: adding route to 127.0.0.0/8 Jan 11 08:47:30 volumio-patio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Jan 11 08:47:30 volumio-patio wpa_supplicant[3989]: nl80211: kernel reports: Registration to specific type not supported Jan 11 08:47:31 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:31 volumio-patio sudo[4024]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:31 volumio-patio sudo[4024]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:31 volumio-patio sudo[4024]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:32 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:32 volumio-patio sudo[4028]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:32 volumio-patio sudo[4028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:32 volumio-patio sudo[4028]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: Trying to associate with 34:bc:5e:d8:8e:06 (SSID='Yarrow Euro' freq=5745 MHz) Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: Associated with 34:bc:5e:d8:8e:06 Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=AU Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: WPA: Key negotiation completed with 34:bc:5e:d8:8e:06 [PTK=CCMP GTK=CCMP] Jan 11 08:47:33 volumio-patio wpa_supplicant[4021]: wlan0: CTRL-EVENT-CONNECTED - Connection to 34:bc:5e:d8:8e:06 completed [id=0 id_str=] Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: carrier acquired Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: connected to Access Point: Yarrow Euro Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: IAID 67:2a:bb:fa Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: adding address fe80::8226:a68f:7019:3984 Jan 11 08:47:33 volumio-patio dhcpcd[787]: ipv6_addaddr1: Permission denied Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: soliciting an IPv6 router Jan 11 08:47:33 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: soliciting a DHCP lease Jan 11 08:47:33 volumio-patio sudo[4033]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:33 volumio-patio sudo[4033]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:33 volumio-patio sudo[4033]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: offered 192.168.4.211 from 192.168.4.1 Jan 11 08:47:33 volumio-patio dhcpcd[787]: wlan0: probing address 192.168.4.211/22 Jan 11 08:47:34 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:34 volumio-patio sudo[4039]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:34 volumio-patio sudo[4039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:34 volumio-patio sudo[4039]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:35 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:35 volumio-patio sudo[4043]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:35 volumio-patio sudo[4043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:35 volumio-patio sudo[4043]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:36 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:36 volumio-patio sudo[4061]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:36 volumio-patio sudo[4061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:36 volumio-patio sudo[4061]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:37 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:37 volumio-patio sudo[4066]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:37 volumio-patio sudo[4066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:37 volumio-patio sudo[4066]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:38 volumio-patio wireless.js[3564]: WIRELESS.JS: trying... Jan 11 08:47:38 volumio-patio sudo[4073]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 11 08:47:38 volumio-patio sudo[4073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 08:47:38 volumio-patio sudo[4073]: pam_unix(sudo:session): session closed for user root Jan 11 08:47:38 volumio-patio dhcpcd[787]: wlan0: leased 192.168.4.211 for 14400 seconds Jan 11 08:47:38 volumio-patio avahi-daemon[719]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.211. Jan 11 08:47:38 volumio-patio avahi-daemon[719]: New relevant interface wlan0.IPv4 for mDNS. Jan 11 08:47:38 volumio-patio avahi-daemon[719]: Registering new address record for 192.168.4.211 on wlan0.IPv4. Jan 11 08:47:38 volumio-patio dhcpcd[787]: wlan0: adding route to 192.168.4.0/22 Jan 11 08:47:38 volumio-patio systemd[1]: welcome.service: Deactivated successfully. Jan 11 08:47:38 volumio-patio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jan 11 08:47:38 volumio-patio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jan 11 08:47:38 volumio-patio dhcpcd[787]: wlan0: adding default route via 192.168.4.1 Jan 11 08:47:38 volumio-patio systemd[1]: Starting welcome.service - Show a welcome message on console... Jan 11 08:47:38 volumio-patio welcome[4087]: Resolved ip:[1] 192.168.4.211 Jan 11 08:47:38 volumio-patio systemd[1]: Finished welcome.service - Show a welcome message on console. Jan 11 08:47:38 volumio-patio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jan 11 08:47:38 volumio-patio volumio[1156]: compat.c: read() failed: Resource temporarily unavailable Jan 11 08:47:38 volumio-patio volumio[1156]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 08:47:38 volumio-patio volumio[1156]: Error: dns service error: unknown Jan 11 08:47:38 volumio-patio volumio[1156]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jan 11 08:47:38 volumio-patio volumio[1156]: errorCode: -65537 Jan 11 08:47:38 volumio-patio volumio[1156]: } Jan 11 08:47:38 volumio-patio volumio[1156]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 08:47:39 volumio-patio sudo[4114]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 08:46' Jan 11 08:47:39 volumio-patio sudo[4114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"