Re: NM 1.4.4 and hotspot problem

From: Dan Williams <dcbw redhat com>
To: Belisko Marek <marek belisko gmail com>
Cc: networkmanager-list gnome org
Subject: Re: NM 1.4.4 and hotspot problem
Date: Wed, 21 Feb 2018 16:45:02 -0600

On Wed, 2018-02-21 at 22:46 +0100, Belisko Marek wrote:

Hi Dan,

On Tue, Feb 20, 2018 at 11:53 PM, Dan Williams <dcbw redhat com>
wrote:

On Tue, 2018-02-20 at 22:47 +0100, Belisko Marek wrote:

Hi Dan,

On Tue, Feb 20, 2018 at 10:11 PM, Dan Williams <dcbw redhat com>
wrote:

On Tue, 2018-02-20 at 21:00 +0100, Belisko Marek wrote:

Hi,

I'm trying to configure hotspot by using this command:
nmcli dev wifi hotspot ifname wlan0 ssid test password
"test1234"

on orangepi which is using realtek wifi (out of tree driver).
When
want to setup simple hotspot it looks like there are soe
mtroubles
with iptbles + dnsmasq. Any ideas what can cause this issue?
Thanks


Your analysis looks correct.  What happens when you run the
iptables
command manually?

/usr/sbin/iptables --table nat \
   --insert POSTROUTING --source 10.42.0.0/255.255.255.0 \
   ! --destination 10.42.0.0/255.255.255.0 --jump MASQUERADE

does /usr/sbin/iptables exist?

does your kernel have the ipt_MASQUERADE, iptable_nat,
nf_conntrack,
iptable_mangle, and other modules like that available?


I've nmcli c up Hotspot


What does your 'iptables-save' output look like on this machine?


It looks like this:

 iptables-save
# Generated by iptables-save v1.6.1 on Wed Feb 21 21:42:54 2018
*filter
:INPUT ACCEPT [61:11807]
:FORWARD ACCEPT [0:0]
:OUTPUT ACCEPT [42:7785]
COMMIT
# Completed on Wed Feb 21 21:42:54 2018
# Generated by iptables-save v1.6.1 on Wed Feb 21 21:42:54 2018
*nat
:PREROUTING ACCEPT [0:0]
:INPUT ACCEPT [0:0]
:OUTPUT ACCEPT [0:0]
:POSTROUTING ACCEPT [0:0]
COMMIT
# Completed on Wed Feb 21 21:42:54 2018
root@orange-pi-pc-plus:~# lsmod
Module                  Size  Used by
ipt_REJECT             16384  -2
ipt_MASQUERADE         16384  -2
xt_tcpudp              16384  -2
iptable_filter         16384  -2
iptable_nat            16384  -2
ip_tables              20480  -2
x_tables               20480  -2
mali                  208896  -2
8189fs               1224704  -2


I've added more kernel modules (according :
https://wiki.gentoo.org/wiki/Iptables#Kernel) and output look much
better (unfortunately there are still some problems):


Ok, so the issue with iptables is solved (at least I think?), but now
it's dnsmasq.  There was a problem in Debian a while back, where just
installing dnsmasq set up a configuration that did this, which meant
that NM could not run its own interface-specific dnsmasq.

This line:

Feb 21 21:39:28 orange-pi-pc-plus daemon.info NetworkManager[765]:
 dnsmasq: failed to create listening socket for 10.42.0.1: Address
 already in use
 Feb 21 21:39:28 orange-pi-pc-plus user.warn NetworkManager[765]:
 <warn>  [1519249168.4498] dnsmasq-manager: dnsmasq exited with error:
 Network access problem (address in use, permissions) (2)

is likely the current problem.  Do you have an existing dnsmasq process
running and what is the contents of /etc/dnsmasq.conf?  If it has the
"bind-interfaces" option enabled, that could be causing this issue.

Dan

Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7576] device (wlan0): Activation: (wifi)
connection 'Hotspot' has security, and secrets exist.  No new secrets
needed.
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7579] Config: added 'ssid' value 'test'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7580] Config: added 'mode' value '2'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7581] Config: added 'frequency' value '2412'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7583] Config: added 'key_mgmt' value 'WPA-PSK'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7584] Config: added 'psk' value '<omitted>'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7585] Config: added 'proto' value 'RSN'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7586] Config: added 'pairwise' value 'CCMP'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7587] Config: added 'group' value 'CCMP'
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.7688] sup-iface[0x25a1f8,wlan0]: config: set
interface ap_scan to 2
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.9895] device (wlan0): supplicant interface state:
disconnected -> completed
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.9897] device (wlan0): Activation: (wifi) Stage 2
of 5 (Device Configure) successful.  Started Wi-Fi Hotspot 'test'.
Feb 21 21:39:27 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249167.9902] device (wlan0): state change: config ->
ip-config (reason 'none') [50 70 0]
Error: Connection activation failed.
IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
root@orange-pi-pc-plus:~# Feb 21 21:39:28 orange-pi-pc-plus user.info
NetworkManager[765]: <info>  [1519249168.0696] Executing:
/usr/sbin/iptables --table filter --insert INPUT --in-interface wlan0
--protocol tcp --destination-port 53 --ju
mp ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.0801] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol udp --destination-port
53 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.0912] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol tcp --destination-port
67 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1018] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol udp --destination-port
67 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1130] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --in-interface wlan0 --jump REJECT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1269] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --out-interface wlan0 --jump REJECT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1370] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --in-interface wlan0 --out-interface wlan0 --jump
ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1461] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --source 10.42.0.0/255.255.255.0 --in-interface
wlan0
--jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1555] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --destination 10.42.0.0/255.255.255.0 --out-
interface
wlan0 --match state --state ESTA
BLISHED,RELATED --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.warn NetworkManager[765]:
<warn>  [1519249168.1786] ** Command returned exit status 1.
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.1789] Executing: /usr/sbin/iptables --table nat
--insert POSTROUTING --source 10.42.0.0/255.255.255.0 ! --destination
10.42.0.0/255.255.255.0 --jump MASQU
ERADE
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.4371] dnsmasq-manager: starting dnsmasq...
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.4425] device (wlan0): state change: ip-config ->
ip-check (reason 'none') [70 80 0]
Feb 21 21:39:28 orange-pi-pc-plus daemon.info NetworkManager[765]:
dnsmasq: failed to create listening socket for 10.42.0.1: Address
already in use
Feb 21 21:39:28 orange-pi-pc-plus user.warn NetworkManager[765]:
<warn>  [1519249168.4498] dnsmasq-manager: dnsmasq exited with error:
Network access problem (address in use, permissions) (2)
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.4500] device (wlan0): state change: ip-check ->
failed (reason 'ip-config-unavailable') [80 120 5]
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.4556] manager: NetworkManager state is now
DISCONNECTED
Feb 21 21:39:28 orange-pi-pc-plus user.warn NetworkManager[765]:
<warn>  [1519249168.4613] device (wlan0): Activation: failed for
connection 'Hotspot'
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.4773] device (wlan0): state change: failed ->
disconnected (reason 'none') [120 30 0]
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.5316] device (wlan0): set-hw-addr: set MAC
address
to E6:89:83:FD:B0:35 (scanning)
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.5536] Executing: /usr/sbin/iptables --table nat
--delete POSTROUTING --source 10.42.0.0/255.255.255.0 ! --destination
10.42.0.0/255.255.255.0 --jump MASQU
ERADE
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6018] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --destination 10.42.0.0/255.255.255.0 --out-
interface
wlan0 --match state --state ESTA
BLISHED,RELATED --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.warn NetworkManager[765]:
<warn>  [1519249168.6230] ** Command returned exit status 1.
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6234] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --source 10.42.0.0/255.255.255.0 --in-interface
wlan0
--jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6340] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --in-interface wlan0 --out-interface wlan0 --jump
ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6447] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --out-interface wlan0 --jump REJECT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6554] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --in-interface wlan0 --jump REJECT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6665] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol udp --destination-port
67 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6797] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --destination-port
67 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.6922] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol udp --destination-port
53 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.7049] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --destination-port
53 --jump ACCEPT
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.7206] device (wlan0): supplicant interface state:
completed -> disabled
Feb 21 21:39:28 orange-pi-pc-plus user.info NetworkManager[765]:
<info>  [1519249168.7221] device (wlan0): supplicant interface state:
disabled -> inactive

Also I'm unsure about dnsmasq problem as service seems to have
problem
with startup:

Feb 20 21:40:11 orange-pi-pc-plus systemd[1]: Starting DNS forwarder
and DHCP server...
Feb 20 21:40:11 orange-pi-pc-plus dnsmasq[290]: dnsmasq: syntax check
OK.
Feb 20 21:40:11 orange-pi-pc-plus dnsmasq[293]: dnsmasq: directory
/etc/resolv.conf for resolv-file is missing, cannot poll
Feb 20 21:40:11 orange-pi-pc-plus systemd[1]:
[[0;1;39mdnsmasq.service: Control process exited, code=exited
status=5[[0m
Feb 20 21:40:11 orange-pi-pc-plus systemd[1]: [[0;1;31mFailed to
start
DNS forwarder and DHCP server.[[0m

Thanks.

Marek

Dan

IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9165] device (wlan0): Activation: starting
connection 'Hotspot' (13e514a4-5c21-43ec-9658-d2d80738bac7)
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9187] audit: op="connection-activate"
uuid="13e514a4-5c21-43ec-9658-d2d80738bac7" name="Hotspot"
pid=985
uid=0 result="success"
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9207] device (wlan0): state change:
disconnected
-> prepare (reason 'none') [30 40 0]
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9230] manager: NetworkManager state is now
CONNECTING
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9439] device (wlan0): set-hw-addr: set-cloned 
MAC
address to 12:81:76:EA:FC:D0 (permanent)
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9810] device (wlan0): state change: prepare
->
config (reason 'none') [40 50 0]
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9840] device (wlan0): Activation: (wifi)
access
point 'Hotspot' has security, but secrets are required.
Feb 20 21:41:02 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162862.9856] device (wlan0): state change: config ->
need-auth (reason 'none') [50 60 0]
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0233] device (wlan0): state change: need-auth 
->
prepare (reason 'none') [60 40 0]
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0343] device (wlan0): state change: prepare
->
config (reason 'none') [40 50 0]
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0372] device (wlan0): Activation: (wifi)
connection 'Hotspot' has security, and secrets exist.  No new
secrets
needed.
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0376] Config: added 'ssid' value 'test'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0377] Config: added 'mode' value '2'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0378] Config: added 'frequency' value '2412'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0379] Config: added 'key_mgmt' value 'WPA-
PSK'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0379] Config: added 'psk' value '<omitted>'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0380] Config: added 'proto' value 'RSN'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0381] Config: added 'pairwise' value 'CCMP'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0382] Config: added 'group' value 'CCMP'
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.0543] sup-iface[0x25ecd0,wlan0]: config: set
interface ap_scan to 2
IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.8770] device (wlan0): supplicant interface
state:
disconnected -> completed
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.8772] device (wlan0): Activation: (wifi)
Stage 2
of 5 (Device Configure) successful.  Started Wi-Fi Hotspot
'test'.
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.8777] device (wlan0): state change: config ->
ip-config (reason 'none') [50 70 0]
Feb 20 21:41:03 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162863.9579] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol tcp --destination-
port
53 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.1881] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol udp --destination-
port
53 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2000] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol tcp --destination-
port
67 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2107] Executing: /usr/sbin/iptables --table
filter
--insert INPUT --in-interface wlan0 --protocol udp --destination-
port
67 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2220] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --in-interface wlan0 --jump REJECT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.2347] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2350] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --out-interface wlan0 --jump REJECT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.2479] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2483] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --in-interface wlan0 --out-interface wlan0 --
jump
ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2577] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --source 10.42.0.0/255.255.255.0 --in-interface
wlan0
--jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2676] Executing: /usr/sbin/iptables --table
filter
--insert FORWARD --destination 10.42.0.0/255.255.255.0 --out-
interface
wlan0 --match state --state ESTA
BLISHED,RELATED --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.2911] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.2914] Executing: /usr/sbin/iptables --table
nat
--insert POSTROUTING --source 10.42.0.0/255.255.255.0 ! --
destination
10.42.0.0/255.255.255.0 --jump MASQU
ERADE
Error: Connection activation failed.
IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
root@orange-pi-pc-plus:~# Feb 20 21:41:04 orange-pi-pc-plus
user.info
NetworkManager[264]: <info>  [1519162864.5330] dnsmasq-manager:
starting dnsmasq...
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.5387] device (wlan0): state change: ip-config 
->
ip-check (reason 'none') [70 80 0]
Feb 20 21:41:04 orange-pi-pc-plus daemon.info
NetworkManager[264]:
dnsmasq: failed to create listening socket for 10.42.0.1: Address
already in use
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.5459] dnsmasq-manager: dnsmasq exited with
error:
Network access problem (address in use, permissions) (2)
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.5461] device (wlan0): state change: ip-check
->
failed (reason 'ip-config-unavailable') [80 120 5]
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.5475] manager: NetworkManager state is now
DISCONNECTED
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.5514] device (wlan0): Activation: failed for
connection 'Hotspot'
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.5581] device (wlan0): state change: failed ->
disconnected (reason 'none') [120 30 0]
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.5936] device (wlan0): set-hw-addr: set MAC
address
to 62:5C:B4:CF:D2:69 (scanning)
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.6194] Executing: /usr/sbin/iptables --table
nat
--delete POSTROUTING --source 10.42.0.0/255.255.255.0 ! --
destination
10.42.0.0/255.255.255.0 --jump MASQU
ERADE
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.6726] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --destination 10.42.0.0/255.255.255.0 --out-
interface
wlan0 --match state --state ESTA
BLISHED,RELATED --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.6940] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.6943] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --source 10.42.0.0/255.255.255.0 --in-interface
wlan0
--jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7056] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --in-interface wlan0 --out-interface wlan0 --
jump
ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7167] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --out-interface wlan0 --jump REJECT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.7276] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7279] Executing: /usr/sbin/iptables --table
filter
--delete FORWARD --in-interface wlan0 --jump REJECT
Feb 20 21:41:04 orange-pi-pc-plus user.warn NetworkManager[264]:
<warn>  [1519162864.7388] ** Command returned exit status 1.
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7391] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol udp --destination-
port
67 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7520] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --destination-
port
67 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7644] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol udp --destination-
port
53 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.7773] Executing: /usr/sbin/iptables --table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --destination-
port
53 --jump ACCEPT
Feb 20 21:41:04 orange-pi-pc-plus user.info NetworkManager[264]:
<info>  [1519162864.8013] device (wlan0): supplicant interface
state:
completed -> disconnected
added mentioned modules but I'm not sure which one can be still
missing because issue is still there:

Does somewhere exist some list of necessary modules? Looks like
my
kernel is configured as one big binary instead of modules.
I have running modules:
lsmod
Module                  Size  Used by
ipt_MASQUERADE         16384  -2
xt_tcpudp              16384  -2
iptable_filter         16384  -2
iptable_nat            16384  -2
ip_tables              20480  -2
x_tables               20480  -2

Still looks like some iptables calls are failing. What about
dnsmasq
error: dnsmasq: failed to create listening socket for 10.42.0.1:
Address already in use

Thanks  a lot.

BR,

marek

Dan

Log:
IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3228] keyfile: add connection in-memory
(13e514a4-5c21-43ec-9658-d2d80738bac7,"Hotspot")
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3308] device (wlan0): Activation:
starting
connection 'Hotspot' (13e514a4-5c21-43ec-9658-d2d80738bac7)
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3343] keyfile: update
/etc/NetworkManager/system-connections/Hotspot
(13e514a4-5c21-43ec-9658-d2d80738bac7,"Hotspot") and persist
connection
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3351] audit: op="connection-add-activate"
uuid="13e514a4-5c21-43ec-9658-d2d80738bac7" name="Hotspot"
pid=1384
uid=0 result="success"
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3416] device (wlan0): state change:
disconnected
-> prepare (reason 'none') [30 40 0]
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3426] manager: NetworkManager state is
now
CONNECTING
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.3726] device (wlan0): set-hw-addr: set-
cloned
MAC
address to 12:81:76:EA:FC:D0 (permanent)
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4096] device (wlan0): state change:
prepare
->
config (reason 'none') [40 50 0]
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4111] device (wlan0): Activation: (wifi)
access
point 'Hotspot' has security, but secrets are required.
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4113] device (wlan0): state change:
config ->
need-auth (reason 'none') [50 60 0]
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4386] device (wlan0): supplicant
interface
state:
inactive -> disconnected
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4392] device (wlan0): supplicant
interface
state:
disconnected -> inactive
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4666] device (wlan0): state change: need-
auth
->
prepare (reason 'none') [60 40 0]
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4746] device (wlan0): state change:
prepare
->
config (reason 'none') [40 50 0]
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4759] device (wlan0): Activation: (wifi)
connection 'Hotspot' has security, and secrets exist.  No new
secrets
needed.
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4763] Config: added 'ssid' value 'test'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4765] Config: added 'mode' value '2'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4766] Config: added 'frequency' value
'2412'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4767] Config: added 'key_mgmt' value
'WPA-
PSK'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4768] Config: added 'psk' value
'<omitted>'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4769] Config: added 'proto' value 'RSN'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4770] Config: added 'pairwise' value
'CCMP'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4771] Config: added 'group' value 'CCMP'
Feb 20 19:55:47 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156547.4983] sup-iface[0x259368,wlan0]: config:
set
interface ap_scan to 2
IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.3471] device (wlan0): supplicant
interface
state:
inactive -> completed
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.3473] device (wlan0): Activation: (wifi)
Stage 2
of 5 (Device Configure) successful.  Started Wi-Fi Hotspot
'test'.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.3483] device (wlan0): state change:
config ->
ip-config (reason 'none') [50 70 0]
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.4330] Executing: /usr/sbin/iptables --
table
filter
--insert INPUT --in-interface wlan0 --protocol tcp --
destination-
port
53 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.4502] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.4506] Executing: /usr/sbin/iptables --
table
filter
--insert INPUT --in-interface wlan0 --protocol udp --
destination-
port
53 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.4682] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.infoIPv6:
ADDRCONF(NETDEV_UP):
wlan0: link is not ready
 NetworkManager[1375]: <info>  [1519156548.4686] Executing:
/usr/sbin/iptables --table filter --insert INPUT --in-
interface
wlan0
--protocol tcp --destination-port 67 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.4858] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.4861] Executing: /usr/sbin/iptables --
table
filter
--insert INPUT --in-interface wlan0 --protocol udp --
destination-
port
67 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5040] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.5043] Executing: /usr/sbin/iptables --
table
filter
--insert FORWARD --in-interface wlan0 --jump REJECT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5202] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.5205] Executing: /usr/sbin/iptables --
table
filter
--insert FORWARD --out-interface wlan0 --jump REJECT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5366] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.5369] Executing: /usr/sbin/iptables --
table
filter
--insert FORWARD --in-interface wlan0 --out-interface wlan0
--
jump
ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5529] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.5532] Executing: /usr/sbin/iptables --
table
filter
--insert FORWARD --source 10.42.0.0/255.255.255.0 --in-
interface
wlan0
--jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5693] ** Command returned exit status 3.
Error: Connection activation failed: (5) IP configuration
could
not
be
reserved (no available address, timeout, etc.).
root@orange-pi-pc-plus:~# Feb 20 19:55:48 orange-pi-pc-plus
user.info
NetworkManager[1375]: <info>  [1519156548.5697] Executing:
/usr/sbin/iptables --table filter --insert FORWARD --
destination
10.42.0.0/255.255.255.0 --out-interface wlan0
 --match state --state ESTABLISHED,RELATED --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.5965] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.5968] Executing: /usr/sbin/iptables --
table
nat
--insert POSTROUTING --source 10.42.0.0/255.255.255.0 ! --
destination
10.42.0.0/255.255.255.0 --jump MASQ
UERADE
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.6098] ** Command returned exit status 1.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6105] dnsmasq-manager: starting
dnsmasq...
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6158] device (wlan0): state change: ip-
config
->
ip-check (reason 'none') [70 80 0]
Feb 20 19:55:48 orange-pi-pc-plus daemon.info
NetworkManager[1375]:
dnsmasq: failed to create listening socket for 10.42.0.1:
Address
already in use
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.6228] dnsmasq-manager: dnsmasq exited
with
error:
Network access problem (address in use, permissions) (2)
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6230] device (wlan0): state change: ip-
check
->
failed (reason 'ip-config-unavailable') [80 120 5]
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6243] manager: NetworkManager state is
now
DISCONNECTED
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.6283] device (wlan0): Activation: failed
for
connection 'Hotspot'
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6534] device (wlan0): state change:
failed ->
disconnected (reason 'none') [120 30 0]
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6771] device (wlan0): set-hw-addr: set
MAC
address
to C6:38:4F:E7:AC:F6 (scanning)
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.6940] Executing: /usr/sbin/iptables --
table
nat
--delete POSTROUTING --source 10.42.0.0/255.255.255.0 ! --
destination
10.42.0.0/255.255.255.0 --jump MASQ
UERADE
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.7060] ** Command returned exit status 1.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.7063] Executing: /usr/sbin/iptables --
table
filter
--delete FORWARD --destination 10.42.0.0/255.255.255.0 --out-
interface
wlan0 --match state --state EST
ABLISHED,RELATED --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.7426] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.7428] Executing: /usr/sbin/iptables --
table
filter
--delete FORWARD --source 10.42.0.0/255.255.255.0 --in-
interface
wlan0
--jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.7610] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.7613] Executing: /usr/sbin/iptables --
table
filter
--delete FORWARD --in-interface wlan0 --out-interface wlan0
--
jump
ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.7786] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.7788] Executing: /usr/sbin/iptables --
table
filter
--delete FORWARD --out-interface wlan0 --jump REJECT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.7959] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.7962] Executing: /usr/sbin/iptables --
table
filter
--delete FORWARD --in-interface wlan0 --jump REJECT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.8133] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.8137] Executing: /usr/sbin/iptables --
table
filter
--delete INPUT --in-interface wlan0 --protocol udp --
destination-
port
67 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.8324] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.8327] Executing: /usr/sbin/iptables --
table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --
destination-
port
67 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.8518] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.8522] Executing: /usr/sbin/iptables --
table
filter
--delete INPUT --in-interface wlan0 --protocol udp --
destination-
port
53 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.8709] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.8712] Executing: /usr/sbin/iptables --
table
filter
--delete INPUT --in-interface wlan0 --protocol tcp --
destination-
port
53 --jump ACCEPT
Feb 20 19:55:48 orange-pi-pc-plus user.warn
NetworkManager[1375]:
<warn>  [1519156548.8896] ** Command returned exit status 3.
Feb 20 19:55:48 orange-pi-pc-plus user.info
NetworkManager[1375]:
<info>  [1519156548.8929] device (wlan0): supplicant
interface
state:
completed -> disconnected

BR,

marek

Follow-Ups:
- Re: NM 1.4.4 and hotspot problem
  - From: Belisko Marek

References:
- NM 1.4.4 and hotspot problem
  - From: Belisko Marek
- Re: NM 1.4.4 and hotspot problem
  - From: Dan Williams
- Re: NM 1.4.4 and hotspot problem
  - From: Belisko Marek
- Re: NM 1.4.4 and hotspot problem
  - From: Dan Williams
- Re: NM 1.4.4 and hotspot problem
  - From: Belisko Marek

[Date Prev][Date Next] [Thread Prev][Thread Next] [Thread Index] [Date Index] [Author Index]