Hi Daniel,
Sorry, still no debug output log.
OK, I am running the connmand debug manually in command line, it is
the same debug messages and it is able to be reproduced, the connmand
works many loops for disconnecting antenna, then it finally stopped to
poll or to call DHCP, there is no IP address now but the connmand is
still running. Here is whole debug from the console screen:
# CONNMAN_DHCP_DEBUG=1 connmand -n -d src/dhpc.c:src/net
work.c:plugins/ofono.c
connmand[3135]: Connection Manager version 1.37
connmand[3135]: Adding configuration wifi
connmand[3135]: Ignore group named 'global' because prefix is not
'service_'
connmand[3135]: Adding service configuration wifi
connmand[3135]: Adding configuration cellular
connmand[3135]: Ignore group named 'global' because prefix is not
'service_'
connmand[3135]: Adding service configuration cellular
connmand[3135]: Checking loopback interface settings
connmand[3135]: System hostname is solar
connmand[3135]: lo {newlink} index 1 address 00:00:00:00:00:00 mtu 65536
connmand[3135]: lo {newlink} index 1 operstate 0 <UNKNOWN
connmand[3135]: sit0 {newlink} index 2 address 00:00:00:00:08:00 mtu 1480
connmand[3135]: sit0 {newlink} index 2 operstate 2 <DOWN
connmand[3135]: mlan0 {create} index 3 type 1 <ETHER
connmand[3135]: mlan0 {RX} 14 packets 2382 bytes
connmand[3135]: mlan0 {TX} 33 packets 4316 bytes
connmand[3135]: mlan0 {update} flags 36867 <UP
connmand[3135]: mlan0 {newlink} index 3 address D4:CA:6E:9A:7E:53 mtu 1500
connmand[3135]: mlan0 {newlink} index 3 operstate 2 <DOWN
connmand[3135]: Adding interface mlan0 [ wifi ]
connmand[3135]: wwan0 {create} index 4 type 65534 <NONE
connmand[3135]: wwan0 {RX} 30 packets 2572 bytes
connmand[3135]: wwan0 {TX} 36 packets 2699 bytes
connmand[3135]: wwan0 {update} flags 4240 <DOWN
connmand[3135]: wwan0 {newlink} index 4 address 00:00:00:00:00:00 mtu 1500
connmand[3135]: wwan0 {newlink} index 4 operstate 2 <DOWN
connmand[3135]: mlan0 {RX} 14 packets 2382 bytes
connmand[3135]: mlan0 {TX} 33 packets 4316 bytes
connmand[3135]: mlan0 {newlink} index 3 address D4:CA:6E:9A:7E:53 mtu 1500
connmand[3135]: mlan0 {newlink} index 3 operstate 2 <DOWN
[
275.244356] mwifiex_sdio mmc0:0001:1: info: trying to associate to 'JupiterIo
T' bssid 34:08:04:12:b1:a2
[ 275.300753] mwifiex_sdio mmc0:0001:1: info: associated to bssid 34:08:04:12:b
1:a2 successfully
connmand[3135]: mlan0 {RX} 15 packets 2495 bytes
connmand[3135]: mlan0 {TX} 33 packets 4316 bytes
connmand[3135]: mlan0 {update} flags 102403 <UP,LOWER_UP
connmand[3135]: mlan0 {newlink} index 3 address D4:CA:6E:9A:7E:53 mtu 1500
connmand[3135]: mlan0 {newlink} index 3 operstate 5 <DORMANT
[ 275.378601] IPv6: ADDRCONF(NETDEV_CHANGE): mlan0: link
becomes ready
connmand[3135]: mlan0 {add} route ff00:: gw :: scope 0 <UNIVERSE
connmand[3135]: mlan0 {add} route fe80:: gw :: scope 0
<UNIVERSE
connmand[3135]: mlan0 {RX} 16
packets 2712 bytes
connmand[3135]: mlan0 {TX} 35 packets 4564 bytes
connmand[3135]: mlan0 {update} flags 102467 <UP,RUNNING,LOWER_UP
connmand[3135]: mlan0 {newlink} index 3 address
D4:CA:6E:9A:7E:53 mtu 1500
co[ 275.447911] mwifiex_sdio mmc0:0001:1: CMD_RESP: cmd 0x23f error, result=0x2
nnmand[3135]: mlan0 {newlink} index 3 operstate 6 <UP
connmand[3135]: DHCP index 3: switch listening mode (0 ==> 1)
connmand[3135]: DHCP index 3: sending DHCP discover request
connmand[3135]: DHCP index 3: received DHCP packet xid 0xf5970486 (current state
0)
connmand[3135]: DHCP index 3: init ip 192.168.0.101 secs 0 -> broadcast flag off
connmand[3135]: DHCP index 3: start request (retries 0)
connmand[3135]: DHCP index 3: sending DHCP request (state 2)
connmand[3135]: DHCP index 3: received DHCP packet xid 0xf5970486 (current state
2)
connmand[3135]: DHCP index 3: switch listening mode (1 ==> 0)
connmand[3135]: DHCP index 3: start bound
connmand[3135]: DHCP index 3: processed DHCP packet (new state 3)
connmand[3135]: mlan0 {add} address 192.168.0.101/24 label mlan0 family 2
connmand[3135]: mlan0 {add} route 192.168.0.0 gw 0.0.0.0 scope 253 <LINK
connmand[3135]: mlan0 {add} route 192.168.0.1 gw 0.0.0.0 scope
253 <LINK
connmand[3135]: mlan0 {add} route
0.0.0.0 gw 192.168.0.1 scope 0 <UNIVERSE
connmand[3135]: mlan0 {add} route 212.227.81.55 gw 192.168.0.1 scope 0 <UNIVERSE
connmand[3135]: wwan0 {RX} 30 packets 2572 bytes
connmand[3135]: wwan0 {TX} 36 packets 2699 bytes
connmand[3135]: wwan0 {update} flags 69841 <UP,RUNNING,LOWER_UP
connmand[3135]: wwan0 {newlink} index 4 address
00:00:00:00:00:00 mtu 1500
connmand[3135]: wwan0 {newlink} index 4 operstate 0 <UNKNOWN
connmand[3135]: wwan0 {add} route ff00:: gw :: scope 0
<UNIVERSE
connmand[3135]: wwan0 {add} route
fe80:: gw :: scope 0 <UNIVERSE
connmand[3135]: rp_filter set to 2
(loose mode routing), old value was 2
connmand[3135]: ipconfig state 3 ipconfig method 1
connmand[3135]: wwan0 {add} address 10.114.11.88/28 label wwan0 family 2
connmand[3135]: wwan0 {add} route 10.114.11.80 gw 0.0.0.0 scope 253 <LINK
connmand[3135]: wwan0 {add} route 10.114.11.89 gw 0.0.0.0 scope
253 <LINK
connmand[3135]: wwan0 {add} route
10.4.130.164 gw 10.114.11.89 scope 0 <UNIVERSE
connmand[3135]: wwan0 {add} route 10.4.58.204 gw 10.114.11.89
scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route
fe80:: gw :: scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route
ff00:: gw :: scope 0 <UNIVERSE
connmand[3135]: wwan0 {add} route
212.227.81.55 gw 10.114.11.89 scope 0 <UNIVERS
E
connmand[3135]: mlan0 {del} route 212.227.81.55 gw 192.168.0.1
scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route 212.227.81.55 gw 10.114.11.89
scope 0 <UNIVERS
E
[ 371.772925] mwifiex_sdio mmc0:0001:1: CMD_RESP: cmd 0x23f error, result=0x2
Disconnect antenna
connmand[3135]: rp_filter restored to 2
connmand[3135]: wwan0 {del} route 10.4.130.164 gw 10.114.11.89 scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route 10.4.58.204 gw 10.114.11.89
scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route
10.114.11.89 gw 0.0.0.0 scope 253 <LINK
connmand[3135]: wwan0 {del} address 10.114.11.88/28 label wwan0
connmand[3135]: wwan0 {del} route 10.114.11.80 gw 0.0.0.0 scope 253 <LINK
Connect antenna
connmand[3135]: rp_filter set to 2 (loose mode routing), old value was 2
connmand[3135]: ipconfig state 3 ipconfig method 1
connmand[3135]: wwan0 {add} address 10.114.11.88/28 label wwan0 family 2
connmand[3135]: wwan0 {add} route 10.114.11.80 gw 0.0.0.0 scope 253 <LINK
connmand[3135]: wwan0 {add} route 10.114.11.89 gw 0.0.0.0 scope
253 <LINK
connmand[3135]: wwan0 {add} route
10.4.130.164 gw 10.114.11.89 scope 0 <UNIVERSE
connmand[3135]: wwan0 {add} route 10.4.58.204 gw 10.114.11.89
scope 0 <UNIVERSE
connmand[3135]: wwan0 {add} route
212.227.81.55 gw 10.114.11.89 scope 0 <UNIVERS
E
connmand[3135]: wwan0 {del} route 212.227.81.55 gw 10.114.11.89
scope 0 <UNIVERS
E
Disconnect antenna
connmand[3135]: rp_filter restored to 2
connmand[3135]: wwan0 {del} route 10.4.130.164 gw 10.114.11.89 scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route 10.4.58.204 gw 10.114.11.89
scope 0 <UNIVERSE
connmand[3135]: wwan0 {del} route
10.114.11.89 gw 0.0.0.0 scope 253 <LINK
connmand[3135]: wwan0 {del} address 10.114.11.88/28 label wwan0
connmand[3135]: wwan0 {del} route 10.114.11.80 gw 0.0.0.0 scope 253 <LINK
[ 612.404088] mwifiex_sdio mmc0:0001:1: CMD_RESP: cmd 0x23f
error, result=0x2
Repeat .......
Connect antenna
It stopped working, no IP address and no more messages coming, but the
connmand is still running, I think that is the main issue some DHCP
polling process stopped.
~# ps | grep connmand
3135 root 8552 S connmand -n -d
src/dhpc.c:src/network.c:plugins/ofono.c
Does it give some clues?
Thank you.
Kind regards,
Jupiter