No wireless connection with a RPI3

champ · April 26, 2017, 2:27pm

Hi,
I run the latest version of Volumio (System Version: 2.129 Released: Thu Mar 23 00:15:25 CET 2017) on a RPI3 and everything works fine except that I can not connect via wifi; by ethernet I connect without problem.
The wireless network is well detected, the key is registered, the wireless restart successfully but it does not reconnect if RPI is restart without the Ethernet connection.
See the wpa-supplicant.conf, the wireless network is well recorded:
ctrl_interface=/var/run/wpa_supplicant
network={
scan_ssid=1
ssid=“OpenWrt”
psk=“8292001473”
priority=1
}
network={
ssid=“OpenWrt”
key_mgmt=NONE
wep_key0=“8292001473”
wep_tx_keyidx=0
priority=1
}

Someone can help me ?

macmpi · April 26, 2017, 6:23pm

You may want to check this and report if it solves your issue.

champ · April 27, 2017, 10:14am

Thank you for your help but it still does not work.
I did the modification in / etc / default / crda (FR for me) but without success.
I can specify that the wifi with RuneAudio works perfectly well … but I would prefer to be able to use Volumio!

Regards

chsims1 · April 27, 2017, 10:31am

Can you try the latest version (v2.141) please?

champ · April 29, 2017, 2:34pm

I use the last version now but it still does not work.
I think the problem comes from the network, when I put Wirelress Networking ON it always returns to OFF even if I save the configuration
If someone could tell me what I do not do well …

Regards

chsims1 · April 29, 2017, 2:49pm

Run ‘sudo journalctl -f’.’ to start system logging. Set your wifi configuration from the UI in your browser and save it. Post the result of the logging here.

champ · April 29, 2017, 4:37pm

Here is a piece of what I got:
Apr 29 16:34:39 volumio wpa_supplicant[6414]: WPS: * Manufacturer
Apr 29 16:34:39 volumio wpa_supplicant[6414]: WPS: * Model Name
Apr 29 16:34:39 volumio wpa_supplicant[6414]: WPS: * Model Number
Apr 29 16:34:39 volumio wpa_supplicant[6414]: WPS: * Device Name
Apr 29 16:34:39 volumio wpa_supplicant[6414]: WPS: * Version2 (0x20)
Apr 29 16:34:39 volumio wpa_supplicant[6414]: P2P: * P2P IE header
Apr 29 16:34:39 volumio wpa_supplicant[6414]: P2P: * Capability dev=25 group=00
Apr 29 16:34:39 volumio wpa_supplicant[6414]: P2P: * Listen Channel: Regulatory Class 81 Channel 1
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: Add radio work ‘scan’@0x5640ab08
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: First radio work item in the queue - schedule start immediately
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: Starting radio work ‘scan’@0x5640ab08 after 0.001258 second wait
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: nl80211: scan request
Apr 29 16:34:39 volumio wpa_supplicant[6414]: Scan requested (ret=0) - scan timeout 10 seconds
Apr 29 16:34:39 volumio wpa_supplicant[6414]: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlan0
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: nl80211: Scan trigger
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: Event SCAN_STARTED (49) received
Apr 29 16:34:39 volumio wpa_supplicant[6414]: wlan0: Own scan request started a scan in 0.000207 seconds
Apr 29 16:34:40 volumio wpa_supplicant[6414]: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 29 16:34:40 volumio wpa_supplicant[6414]: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlan0
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: nl80211: New scan results available
Apr 29 16:34:40 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘OpenWrt’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Event SCAN_RESULTS (3) received
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Scan completed in 0.480229 seconds
Apr 29 16:34:40 volumio wpa_supplicant[6414]: nl80211: Received scan results (12 BSSes)
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Start scan result update 1
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 0 BSSID 00:24:d4:98:61:aa SSID ‘FreeWifi_secure’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 1 BSSID 00:24:d4:98:61:a8 SSID ‘monwifi’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 2 BSSID e0:a1:d7:24:56:48 SSID ‘NEUF_5644’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 3 BSSID c2:a1:d7:24:56:4b SSID ‘SFR WiFi Mobile’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 4 BSSID 24:7f:20:be:de:30 SSID ‘Livebox-DE30’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 5 BSSID 00:24:d4:c7:4c:9a SSID ‘FreeWifi_secure’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 6 BSSID 00:24:d4:c7:4c:98 SSID ‘freebox_MTZFTI’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 7 BSSID f0:b4:29:8e:68:bd SSID ‘monwifi’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 8 BSSID 00:18:84:d0:90:51 SSID ‘OpenWrt’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 9 BSSID 00:24:d4:98:61:a9 SSID ‘FreeWifi’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 10 BSSID c2:a1:d7:24:56:49 SSID ‘SFR WiFi FON’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: BSS: Add new id 11 BSSID 00:24:d4:c7:4c:99 SSID ‘FreeWifi’
Apr 29 16:34:40 volumio wpa_supplicant[6414]: BSS: last_scan_res_used=12/32
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: New scan results available (own=1 ext=0)
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP e0:a1:d7:24:56:48 type 0 added
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP 24:7f:20:be:de:30 type 0 added
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP f0:b4:29:8e:68:bd type 0 added
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP[0] e0:a1:d7:24:56:48 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP[1] 24:7f:20:be:de:30 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:40 volumio wpa_supplicant[6414]: WPS: AP[2] f0:b4:29:8e:68:bd type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Radio work ‘scan’@0x5640ab08 done in 0.544135 seconds
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Selecting BSS from priority group 1
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 0: 00:24:d4:98:61:aa ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-80
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 1: 00:24:d4:98:61:a8 ssid=‘monwifi’ wpa_ie_len=22 rsn_ie_len=0 caps=0x411 level=-81
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 2: e0:a1:d7:24:56:48 ssid=‘NEUF_5644’ wpa_ie_len=28 rsn_ie_len=0 caps=0x411 level=-82 wps
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 3: c2:a1:d7:24:56:4b ssid=‘SFR WiFi Mobile’ wpa_ie_len=0 rsn_ie_len=20 caps=0x411 level=-83
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 4: 24:7f:20:be:de:30 ssid=‘Livebox-DE30’ wpa_ie_len=26 rsn_ie_len=24 caps=0x431 level=-87 wps
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 5: 00:24:d4:c7:4c:9a ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-91
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 6: 00:24:d4:c7:4c:98 ssid=‘freebox_MTZFTI’ wpa_ie_len=26 rsn_ie_len=0 caps=0x411 level=-94
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 7: f0:b4:29:8e:68:bd ssid=‘monwifi’ wpa_ie_len=0 rsn_ie_len=20 caps=0xc11 level=-97 wps
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 8: 00:18:84:d0:90:51 ssid=‘OpenWrt’ wpa_ie_len=0 rsn_ie_len=0 caps=0x431 level=-63
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - no WPA/RSN proto match
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 9: 00:24:d4:98:61:a9 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-80
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 10: c2:a1:d7:24:56:49 ssid=‘SFR WiFi FON’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-83
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: 11: 00:24:d4:c7:4c:99 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-93
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: No suitable network found
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Use normal scan instead of sched_scan for initial scans (normal_scans=1)
Apr 29 16:34:40 volumio wpa_supplicant[6414]: wlan0: Setting scan request: 5.000000 sec
Apr 29 16:34:40 volumio wireless.js[6333]: trying…
Apr 29 16:34:40 volumio sudo[6416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:40 volumio sudo[6416]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:40 volumio sudo[6416]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:40 volumio wpa_supplicant[6414]: EAPOL: disable timer tick
Apr 29 16:34:41 volumio wireless.js[6333]: trying…
Apr 29 16:34:41 volumio sudo[6425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:41 volumio sudo[6425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:41 volumio sudo[6425]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:42 volumio wireless.js[6333]: trying…
Apr 29 16:34:42 volumio sudo[6434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:42 volumio sudo[6434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:42 volumio sudo[6434]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:43 volumio wireless.js[6333]: trying…
Apr 29 16:34:43 volumio sudo[6443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:43 volumio sudo[6443]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:43 volumio sudo[6443]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:44 volumio dhcpcd[6386]: eth0: leased 192.168.0.27 for 43200 seconds
Apr 29 16:34:44 volumio avahi-daemon[563]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.27.
Apr 29 16:34:44 volumio avahi-daemon[563]: New relevant interface eth0.IPv4 for mDNS.
Apr 29 16:34:44 volumio avahi-daemon[563]: Registering new address record for 192.168.0.27 on eth0.IPv4.
Apr 29 16:34:44 volumio dhcpcd[6386]: eth0: adding host route to 192.168.0.27 via 127.0.0.1
Apr 29 16:34:44 volumio dhcpcd[6386]: eth0: adding route to 192.168.0.0/24
Apr 29 16:34:44 volumio dhcpcd[6386]: eth0: adding default route via 192.168.0.254
Apr 29 16:34:44 volumio wireless.js[6333]: dhclientstderr: dhcpcd[6386]: eth0: leased 192.168.0.27 for 43200 seconds
Apr 29 16:34:44 volumio wireless.js[6333]: dhclientstderr: dhcpcd[6386]: eth0: adding host route to 192.168.0.27 via 127.0.0.1
Apr 29 16:34:44 volumio wireless.js[6333]: dhcpcd[6386]: eth0: adding route to 192.168.0.0/24
Apr 29 16:34:44 volumio wireless.js[6333]: dhclientstderr: dhcpcd[6386]: eth0: adding default route via 192.168.0.254
Apr 29 16:34:44 volumio dhcpcd[6386]: forked to background, child pid 6471
Apr 29 16:34:44 volumio wireless.js[6333]: dhclientstderr: dhcpcd[6386]: forked to background, child pid 6471
Apr 29 16:34:44 volumio sudo[6382]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:44 volumio wireless.js[6333]: dhclientchild process exited with code 0
Apr 29 16:34:44 volumio wireless.js[6333]: trying…
Apr 29 16:34:44 volumio sudo[6476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:44 volumio sudo[6476]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:44 volumio sudo[6476]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Starting AP scan for wildcard SSID
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: Building WPS IE for Probe Request
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Version (hardcoded 0x10)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Request Type
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Config Methods (2148)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * UUID-E
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Primary Device Type
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * RF Bands (1)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Association State
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Configuration Error (0)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Device Password ID (0)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Manufacturer
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Model Name
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Model Number
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Device Name
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: * Version2 (0x20)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: P2P: * P2P IE header
Apr 29 16:34:45 volumio wpa_supplicant[6414]: P2P: * Capability dev=25 group=00
Apr 29 16:34:45 volumio wpa_supplicant[6414]: P2P: * Listen Channel: Regulatory Class 81 Channel 1
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Determining shared radio frequencies (max len 2)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Shared frequencies (len=0): completed iteration
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Add radio work ‘scan’@0x5640abb0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: First radio work item in the queue - schedule start immediately
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Starting radio work ‘scan’@0x5640abb0 after 0.001241 second wait
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: nl80211: scan request
Apr 29 16:34:45 volumio wpa_supplicant[6414]: Scan requested (ret=0) - scan timeout 30 seconds
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlan0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: nl80211: Scan trigger
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Event SCAN_STARTED (49) received
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Own scan request started a scan in 0.000182 seconds
Apr 29 16:34:45 volumio volumio[1359]: Discovery: adding 24592338-33cf-4734-8c7f-a2e8c8e020b1
Apr 29 16:34:45 volumio volumio[1359]: info: mDNS: Found device Volumio
Apr 29 16:34:45 volumio ntpd[596]: Listen normally on 10 eth0 192.168.0.27 UDP 123
Apr 29 16:34:45 volumio ntpd[596]: peers refreshed
Apr 29 16:34:45 volumio wireless.js[6333]: trying…
Apr 29 16:34:45 volumio sudo[6488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:45 volumio sudo[6488]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:45 volumio sudo[6488]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlan0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: nl80211: New scan results available
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘OpenWrt’
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘’
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Event SCAN_RESULTS (3) received
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Scan completed in 0.480597 seconds
Apr 29 16:34:45 volumio wpa_supplicant[6414]: nl80211: Received scan results (11 BSSes)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: BSS: Start scan result update 2
Apr 29 16:34:45 volumio wpa_supplicant[6414]: BSS: last_scan_res_used=11/32
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: New scan results available (own=1 ext=0)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: AP[0] e0:a1:d7:24:56:48 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: AP[1] 24:7f:20:be:de:30 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: WPS: AP[2] f0:b4:29:8e:68:bd type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Radio work ‘scan’@0x5640abb0 done in 0.526533 seconds
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Selecting BSS from priority group 1
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 0: 00:24:d4:98:61:a8 ssid=‘monwifi’ wpa_ie_len=22 rsn_ie_len=0 caps=0x411 level=-80
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 1: 00:24:d4:98:61:aa ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-81
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 2: e0:a1:d7:24:56:48 ssid=‘NEUF_5644’ wpa_ie_len=28 rsn_ie_len=0 caps=0x411 level=-84 wps
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 3: c2:a1:d7:24:56:4b ssid=‘SFR WiFi Mobile’ wpa_ie_len=0 rsn_ie_len=20 caps=0x411 level=-85
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 4: 24:7f:20:be:de:30 ssid=‘Livebox-DE30’ wpa_ie_len=26 rsn_ie_len=24 caps=0x431 level=-88 wps
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 5: 00:24:d4:c7:4c:9a ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-91
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 6: 00:24:d4:c7:4c:98 ssid=‘freebox_MTZFTI’ wpa_ie_len=26 rsn_ie_len=0 caps=0x411 level=-94
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 7: 00:18:84:d0:90:51 ssid=‘OpenWrt’ wpa_ie_len=0 rsn_ie_len=0 caps=0x431 level=-63
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - no WPA/RSN proto match
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 8: 00:24:d4:98:61:a9 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-80
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 9: c2:a1:d7:24:56:49 ssid=‘SFR WiFi FON’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-83
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: 10: 00:24:d4:c7:4c:99 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-89
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: No suitable network found
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Use normal scan instead of sched_scan for initial scans (normal_scans=2)
Apr 29 16:34:45 volumio wpa_supplicant[6414]: wlan0: Setting scan request: 5.000000 sec
Apr 29 16:34:45 volumio wpa_supplicant[6414]: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 29 16:34:46 volumio wireless.js[6333]: trying…
Apr 29 16:34:46 volumio sudo[6497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:46 volumio sudo[6497]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:46 volumio sudo[6497]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: leased 192.168.0.27 for 43200 seconds
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: adding host route to 192.168.0.27 via 127.0.0.1
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: adding route to 192.168.0.0/24
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: adding default route via 192.168.0.254
Apr 29 16:34:47 volumio dhcpcd[6471]: eth0: removing route to 192.168.0.0/24
Apr 29 16:34:47 volumio dhcpcd[6471]: eth0: removing default route via 192.168.0.254
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: removing route to 192.168.0.0/24
Apr 29 16:34:47 volumio dhcpcd[683]: eth0: removing default route via 192.168.0.254
Apr 29 16:34:47 volumio volumio[1359]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Apr 29 16:34:47 volumio sudo[6525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 29 16:34:47 volumio sudo[6525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:47 volumio volumio[5553]: :2:src/ohmetacache.cxx:122::dmcacheSaveWorker: can’t get task from queue
Apr 29 16:34:47 volumio volumio[5553]: :3:/usr/include/libupnpp/workqueue.h:193::SaveQueue: tasks 0 nowakes 0 wsleeps 1 csleeps 0
Apr 29 16:34:47 volumio sudo[6525]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:47 volumio mpd[572]: client: [11] closed
Apr 29 16:34:47 volumio sudo[6538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 16:34:47 volumio sudo[6538]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:47 volumio systemd[1]: Starting UPnP Renderer front-end to MPD…
Apr 29 16:34:47 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 16:34:47 volumio sudo[6538]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:47 volumio volumio[1359]: info: Upmpdcli Daemon Started
Apr 29 16:34:47 volumio mpd[572]: client: [12] opened from ::ffff:127.0.0.1:57290
Apr 29 16:34:47 volumio wireless.js[6333]: trying…
Apr 29 16:34:47 volumio sudo[6557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:47 volumio sudo[6557]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:48 volumio sudo[6557]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:49 volumio wireless.js[6333]: trying…
Apr 29 16:34:49 volumio sudo[6566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:49 volumio sudo[6566]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:49 volumio sudo[6566]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:50 volumio wireless.js[6333]: trying…
Apr 29 16:34:50 volumio sudo[6575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:50 volumio sudo[6575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:50 volumio sudo[6575]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: Starting AP scan for wildcard SSID
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: Building WPS IE for Probe Request
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Version (hardcoded 0x10)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Request Type
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Config Methods (2148)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * UUID-E
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Primary Device Type
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * RF Bands (1)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Association State
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Configuration Error (0)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Device Password ID (0)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Manufacturer
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Model Name
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Model Number
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Device Name
Apr 29 16:34:50 volumio wpa_supplicant[6414]: WPS: * Version2 (0x20)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: P2P: * P2P IE header
Apr 29 16:34:50 volumio wpa_supplicant[6414]: P2P: * Capability dev=25 group=00
Apr 29 16:34:50 volumio wpa_supplicant[6414]: P2P: * Listen Channel: Regulatory Class 81 Channel 1
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: Determining shared radio frequencies (max len 2)
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: Shared frequencies (len=0): completed iteration
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: Add radio work ‘scan’@0x5640ac20
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: First radio work item in the queue - schedule start immediately
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: Starting radio work ‘scan’@0x5640ac20 after 0.001938 second wait
Apr 29 16:34:50 volumio wpa_supplicant[6414]: wlan0: nl80211: scan request
Apr 29 16:34:51 volumio wpa_supplicant[6414]: Scan requested (ret=0) - scan timeout 30 seconds
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlan0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: nl80211: Scan trigger
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Event SCAN_STARTED (49) received
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Own scan request started a scan in 0.000182 seconds
Apr 29 16:34:51 volumio wireless.js[6333]: trying…
Apr 29 16:34:51 volumio sudo[6584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:51 volumio sudo[6584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:51 volumio sudo[6584]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlan0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: nl80211: New scan results available
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘OpenWrt’
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Scan probed for SSID ‘’
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Event SCAN_RESULTS (3) received
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Scan completed in 0.485044 seconds
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Received scan results (11 BSSes)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: BSS: Start scan result update 3
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 7 BSSID f0:b4:29:8e:68:bd SSID ‘monwifi’ due to no match in scan
Apr 29 16:34:51 volumio wpa_supplicant[6414]: BSS: last_scan_res_used=11/32
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: New scan results available (own=1 ext=0)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: AP[0] e0:a1:d7:24:56:48 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: AP[1] 24:7f:20:be:de:30 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: AP[2] f0:b4:29:8e:68:bd type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Radio work ‘scan’@0x5640ac20 done in 0.532677 seconds
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Selecting BSS from priority group 1
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 0: 00:24:d4:98:61:aa ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-78
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 1: 00:24:d4:98:61:a8 ssid=‘monwifi’ wpa_ie_len=22 rsn_ie_len=0 caps=0x411 level=-80
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 2: c2:a1:d7:24:56:4b ssid=‘SFR WiFi Mobile’ wpa_ie_len=0 rsn_ie_len=20 caps=0x411 level=-83
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 3: e0:a1:d7:24:56:48 ssid=‘NEUF_5644’ wpa_ie_len=28 rsn_ie_len=0 caps=0x411 level=-84 wps
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 4: 24:7f:20:be:de:30 ssid=‘Livebox-DE30’ wpa_ie_len=26 rsn_ie_len=24 caps=0x431 level=-86 wps
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 5: 00:24:d4:c7:4c:9a ssid=‘FreeWifi_secure’ wpa_ie_len=0 rsn_ie_len=24 caps=0x411 level=-91
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 6: 00:24:d4:c7:4c:98 ssid=‘freebox_MTZFTI’ wpa_ie_len=26 rsn_ie_len=0 caps=0x411 level=-94
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 7: 00:18:84:d0:90:51 ssid=‘OpenWrt’ wpa_ie_len=0 rsn_ie_len=0 caps=0x431 level=-65
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - no WPA/RSN proto match
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 8: 00:24:d4:98:61:a9 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-79
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 9: c2:a1:d7:24:56:49 ssid=‘SFR WiFi FON’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-83
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: 10: 00:24:d4:c7:4c:99 ssid=‘FreeWifi’ wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-89
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - SSID mismatch
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: skip - disabled
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: No suitable network found
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Beginning of SSID list
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: add to filter ssid: OpenWrt
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: add to active scan ssid: OpenWrt
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: Building WPS IE for Probe Request
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Version (hardcoded 0x10)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Request Type
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Config Methods (2148)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * UUID-E
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Primary Device Type
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * RF Bands (1)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Association State
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Configuration Error (0)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Device Password ID (0)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Manufacturer
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Model Name
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Model Number
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Device Name
Apr 29 16:34:51 volumio wpa_supplicant[6414]: WPS: * Version2 (0x20)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: P2P: * P2P IE header
Apr 29 16:34:51 volumio wpa_supplicant[6414]: P2P: * Capability dev=25 group=00
Apr 29 16:34:51 volumio wpa_supplicant[6414]: P2P: * Listen Channel: Regulatory Class 81 Channel 1
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: Starting sched scan: interval 10 (no timeout)
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: nl80211: sched_scan request
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Sched scan requested (ret=0) - scan interval 10000 msec
Apr 29 16:34:51 volumio wpa_supplicant[6414]: RTM_NEWLINK: ifi_index=3 ifname=wlan0 wext ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 29 16:34:51 volumio wpa_supplicant[6414]: nl80211: Drv Event 75 (NL80211_CMD_START_SCHED_SCAN) received for wlan0
Apr 29 16:34:51 volumio wpa_supplicant[6414]: wlan0: nl80211: Sched scan started
Apr 29 16:34:52 volumio wireless.js[6333]: trying…
Apr 29 16:34:52 volumio sudo[6594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:52 volumio sudo[6594]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:52 volumio sudo[6594]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:53 volumio wireless.js[6333]: trying…
Apr 29 16:34:53 volumio sudo[6603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:53 volumio sudo[6603]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:53 volumio sudo[6603]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:54 volumio wireless.js[6333]: trying…
Apr 29 16:34:54 volumio sudo[6612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:54 volumio sudo[6612]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:54 volumio sudo[6612]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:55 volumio wireless.js[6333]: trying…
Apr 29 16:34:55 volumio sudo[6621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:55 volumio sudo[6621]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:55 volumio sudo[6621]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:56 volumio wireless.js[6333]: trying…
Apr 29 16:34:56 volumio sudo[6630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:56 volumio sudo[6630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:56 volumio sudo[6630]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:57 volumio wireless.js[6333]: trying…
Apr 29 16:34:57 volumio sudo[6639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:57 volumio sudo[6639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:57 volumio sudo[6639]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:58 volumio wireless.js[6333]: trying…
Apr 29 16:34:58 volumio sudo[6648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:58 volumio sudo[6648]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:58 volumio sudo[6648]: pam_unix(sudo:session): session closed for user root
Apr 29 16:34:59 volumio wireless.js[6333]: trying…
Apr 29 16:34:59 volumio sudo[6657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:34:59 volumio sudo[6657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:34:59 volumio sudo[6657]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:00 volumio wireless.js[6333]: trying…
Apr 29 16:35:00 volumio sudo[6666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 29 16:35:00 volumio sudo[6666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:00 volumio sudo[6666]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:01 volumio wireless.js[6333]: Overtime, starting plan B
Apr 29 16:35:01 volumio wireless.js[6333]: killing: kill pgrep -f "^/usr/bin/sudo" || true
Apr 29 16:35:01 volumio wireless.js[6333]: killing: kill pgrep -f "^wpa_supplicant" || true
Apr 29 16:35:01 volumio wpa_supplicant[6414]: wlan0: Removing interface wlan0
Apr 29 16:35:01 volumio wpa_supplicant[6414]: wlan0: Request to deauthenticate - bssid=00:00:00:00:00:00 pending_bssid=00:00:00:00:00:00 reason=3 state=SCANNING
Apr 29 16:35:01 volumio wpa_supplicant[6414]: TDLS: Tear down peers
Apr 29 16:35:01 volumio wpa_supplicant[6414]: wlan0: State: SCANNING -> DISCONNECTED
Apr 29 16:35:01 volumio wpa_supplicant[6414]: nl80211: Set wlan0 operstate 0->0 (DORMANT)
Apr 29 16:35:01 volumio wpa_supplicant[6414]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
Apr 29 16:35:01 volumio wpa_supplicant[6414]: EAPOL: External notification - portEnabled=0
Apr 29 16:35:01 volumio wpa_supplicant[6414]: EAPOL: External notification - portValid=0
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 0 BSSID 00:24:d4:98:61:aa SSID ‘FreeWifi_secure’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 1 BSSID 00:24:d4:98:61:a8 SSID ‘monwifi’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 3 BSSID c2:a1:d7:24:56:4b SSID ‘SFR WiFi Mobile’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 2 BSSID e0:a1:d7:24:56:48 SSID ‘NEUF_5644’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 4 BSSID 24:7f:20:be:de:30 SSID ‘Livebox-DE30’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 5 BSSID 00:24:d4:c7:4c:9a SSID ‘FreeWifi_secure’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 6 BSSID 00:24:d4:c7:4c:98 SSID ‘freebox_MTZFTI’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 8 BSSID 00:18:84:d0:90:51 SSID ‘OpenWrt’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 9 BSSID 00:24:d4:98:61:a9 SSID ‘FreeWifi’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 10 BSSID c2:a1:d7:24:56:49 SSID ‘SFR WiFi FON’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: BSS: Remove id 11 BSSID 00:24:d4:c7:4c:99 SSID ‘FreeWifi’ due to wpa_bss_flush
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: Cancelling delayed sched scan
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: Cancelling scan request
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: Cancelling authentication timeout
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: Cancelling sched scan
Apr 29 16:35:02 volumio wpa_supplicant[6414]: nl80211: Sched scan stop sent (ret=0)
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: P2P: Disable P2P since removing the management interface is being removed
Apr 29 16:35:02 volumio wpa_supplicant[6414]: P2P: Stopping find
Apr 29 16:35:02 volumio wpa_supplicant[6414]: P2P: Clear timeout (state=IDLE)
Apr 29 16:35:02 volumio wpa_supplicant[6414]: P2P: State IDLE -> IDLE
Apr 29 16:35:02 volumio wpa_supplicant[6414]: Remove interface wlan0 from radio phy0
Apr 29 16:35:02 volumio wpa_supplicant[6414]: Remove radio phy0
Apr 29 16:35:02 volumio wpa_supplicant[6414]: nl80211: Remove monitor interface: refcount=0
Apr 29 16:35:02 volumio wpa_supplicant[6414]: netlink: Operstate: ifindex=3 linkmode=0 (kernel-control), operstate=6 (IF_OPER_UP)
Apr 29 16:35:02 volumio wpa_supplicant[6414]: nl80211: Set mode ifindex 3 iftype 2 (STATION)
Apr 29 16:35:02 volumio wpa_supplicant[6414]: nl80211: Unsubscribe mgmt frames handle 0xdeb734c1 (mode change)
Apr 29 16:35:02 volumio wpa_supplicant[6414]: wlan0: CTRL-EVENT-TERMINATING
Apr 29 16:35:04 volumio systemd[1]: Stopped hotspot.service.
Apr 29 16:35:05 volumio wireless.js[6333]: stophotspotchild process exited with code 0
Apr 29 16:35:05 volumio sudo[6681]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 29 16:35:05 volumio sudo[6681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:05 volumio sudo[6681]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:05 volumio sudo[6689]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 29 16:35:05 volumio sudo[6689]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:05 volumio netplugd[1117]: wlan0: state INACTIVE flags 0x00001003 UP,BROADCAST,MULTICAST -> 0x00001002 BROADCAST,MULTICAST
Apr 29 16:35:05 volumio netplugd[6694]: /etc/netplug/netplug wlan0 probe -> pid 6694
Apr 29 16:35:05 volumio sudo[6689]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:05 volumio netplugd[1117]: wlan0: state PROBING pid 6694 exited status 0
Apr 29 16:35:05 volumio wireless.js[6333]: Hotspot is disabled, not starting it
Apr 29 16:35:05 volumio wireless.js[6333]: ifdeconfigchild process exited with code 0
Apr 29 16:35:05 volumio netplugd[1117]: wlan0: state DOWN flags 0x00001002 BROADCAST,MULTICAST -> 0x00001003 UP,BROADCAST,MULTICAST
Apr 29 16:35:05 volumio kernel: brcmfmac: power management disabled
Apr 29 16:35:05 volumio wireless.js[6333]: ifconfig null
Apr 29 16:35:05 volumio wireless.js[6333]: configwlanupchild process exited with code 0
Apr 29 16:35:05 volumio systemd[1]: Started Wireless Services.
Apr 29 16:35:05 volumio sudo[5925]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:05 volumio sudo[5689]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:05 volumio sudo[6271]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:05 volumio netplugd[1117]: eth0: state PROBING_UP pid 5722 exited status 0
Apr 29 16:35:05 volumio netplugd[6703]: /etc/netplug/netplug eth0 in -> pid 6703
Apr 29 16:35:05 volumio netplugd[1117]: eth0: state INNING pid 6703 exited status 0
Apr 29 16:35:15 volumio volumio[1359]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Apr 29 16:35:15 volumio volumio[1359]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Apr 29 16:35:15 volumio volumio[1359]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Apr 29 16:35:15 volumio sudo[6713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 29 16:35:15 volumio sudo[6713]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:15 volumio sudo[6715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 29 16:35:15 volumio sudo[6715]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:15 volumio sudo[6720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 29 16:35:15 volumio volumio[6543]: :2:src/ohmetacache.cxx:122::dmcacheSaveWorker: can’t get task from queue
Apr 29 16:35:15 volumio sudo[6713]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:15 volumio volumio[6543]: :3:/usr/include/libupnpp/workqueue.h:193::SaveQueue: tasks 0 nowakes 0 wsleeps 1 csleeps 0
Apr 29 16:35:15 volumio mpd[572]: client: [12] closed
Apr 29 16:35:15 volumio sudo[6720]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:15 volumio sudo[6715]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:15 volumio sudo[6720]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:15 volumio volumio[1359]: error: Cannot kill upmpdcli Error: Command failed: /usr/bin/sudo /usr/bin/killall upmpdcli
Apr 29 16:35:15 volumio volumio[1359]: upmpdcli: no process found
Apr 29 16:35:15 volumio volumio[1359]: error: Cannot kill upmpdcli Error: Command failed: /usr/bin/sudo /usr/bin/killall upmpdcli
Apr 29 16:35:15 volumio volumio[1359]: upmpdcli: no process found
Apr 29 16:35:15 volumio sudo[6749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 16:35:15 volumio sudo[6749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:16 volumio sudo[6754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 16:35:16 volumio sudo[6756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 29 16:35:16 volumio systemd[1]: Starting UPnP Renderer front-end to MPD…
Apr 29 16:35:16 volumio sudo[6756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:16 volumio sudo[6754]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 29 16:35:16 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 16:35:16 volumio sudo[6749]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:16 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 29 16:35:16 volumio sudo[6754]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:16 volumio sudo[6756]: pam_unix(sudo:session): session closed for user root
Apr 29 16:35:16 volumio volumio[1359]: info: Upmpdcli Daemon Started
Apr 29 16:35:16 volumio mpd[572]: client: [13] opened from ::ffff:127.0.0.1:57292
Apr 29 16:35:16 volumio volumio[1359]: info: Upmpdcli Daemon Started
Apr 29 16:35:16 volumio volumio[1359]: info: Upmpdcli Daemon Started

thanks for your help

chsims1 · April 29, 2017, 5:29pm

Your log is showing that wpa_supplicant is giving an “SSID mismatch” error for your network.

Did you add “8292001473” as a password to the UI during configuration or is it a hex key? Can you try with a simple text password?

champ · April 30, 2017, 4:39pm

Hello chsims1,
Yes, I added 8292001473 as a password to the GUI and I verified that it was the right code. But, how did you get to know it, it is not stored in clear in the log yet?
Unfortunately, I can not replace it with a simple text password…
Thanks again for your help.

chsims1 · May 1, 2017, 6:21am

You displayed it in the original post … not much of a security risk.

I can’t see anything else in the log other than the ssid mismatch, but difficult to fault find that if you can’t change it. Have you edited the wpa_supplicant.conf file or is the one posted generated by Volumio?

champ · May 1, 2017, 8:34pm

Ah! Okay, I like that better …

No, I can not change the key of the wifi server but eventually I can try another one?
I think the pb can come from / bin / systemctl… When I put Wirelress Networking ON it always returns to OFF

Thanks chsims1

Arpath · May 2, 2017, 7:31am

Hi,
i have the same issue with my rpi Zero w and i´m working on it , but you wrote that Rune Audio Works fine on the Zero can you please post which Version of Rune you used and where i can fibnd it.
Sorry you didn´t mentioned a Zero so that question for Rune is obsolet.

Kind Regards
Thomas

Arpath · May 2, 2017, 7:52am

Hello

I have the same issue on my Raspberry Pi Zero W . I Installed Volumio , configured the Wlan access for my Home Net .
First i could see the Pi on my Router also on my Mobile on which i was able to configure the DAC HAT . After rebooting i didn´t get a Connection to the Router and so i couldn´t reach it with my mobile .
But i reallised that the DAC HAT works fine in that configuration ( Raspbian makes a Jingle after a while and i had it on the Output of my DAC ) .

So the only Problem is to get a stable Wifi Connection.

I forgot that issue thast i used an USB Wifi Adapter , with that i had that Situation like mentioned above. with the Onboard Adapter i had just a very short Connection to the Network , only like this , that it appeared in the Wlan Connections of the Router, the Fault message in Raspbian is in both cases the same.

Anyone who has an Idea .
sorry for bad english

Kind Regards
Thomas