Android系统DHCP问题

最新推荐文章于 2021-05-31 10:41:26 发布

雷古拉斯

最新推荐文章于 2021-05-31 10:41:26 发布

阅读量1.3w

点赞数

分类专栏：移动操作系统之Android

本文链接：https://blog.csdn.net/tankai19880619/article/details/42972551

版权

移动操作系统之Android 专栏收录该内容

107 篇文章 5 订阅

订阅专栏

一、现象

12小时压测wifi连接后，发现网络连接中断；相关log：

我们关心状态变化部分ConnectivityService: ConnectivityChange for WIFI

01-19-17:42;0501-01 08:00:38.552   954  1117 D ConnectivityService: --NetworkStateTracker.EVENT_STATE_CHANGED handle--
01-19-17:42;0501-01 08:00:38.552   954  1117 D ConnectivityService: ConnectivityChange for WIFI: CONNECTED/CONNECTED
01-19-17:42;0501-01 08:00:38.552   954  1117 D ConnectivityService: Setting TCP values: [524288,1048576,2097152,262144,524288,1048576] which comes from [net.tcp.buffersize.wifi]
/12hago
01-20-05:14;2201-01 19:33:18.943  1267  1386 V shizx   : @@@clienttype:@@@TCL-CN-MT55CD-F3700A-LG
01-20-05:14;22ERROR!!! MlmeEnqueueForRecv: un-recongnized mgmt->subtype=15
01-20-05:14;2301-01 19:33:19.572   954  1808 E Dhinit: 
01-20-05:14;23 waitpid returned pid 1835, status = 00000009
01-20-05:14;23cpStateMacinit: process 'dhcpcd_wlan0', pid 1835 exited
01-20-05:14;23hine: DHCP failed on wlan0: Timed out waiting for DHCP Renew to finish
01-20-05:14;2301-01 19:33:19.574   954  1808 D DHCP    : ifc_init, return = 0
01-20-05:14;2301-01 19:33:19.574   954  1808 D DHCP    : ifc_set_addr(wlan0, xx) = 0
01-20-05:14;2301-01 19:33:19.574   954  1808 D DHCP    : ifc_close
01-20-05:14;2301-01 19:33:19.779   954  1115 D WifiHW  : send cmd is DRIVER POWERMODE 0 
01-20-05:14;2301-01 19:33:19.779   954  1115 D WifiHW  : send cmd is DRIVER BTCOEXMODE 2 
01-20-05:14;2301-01 19:33:19.781   954  1115 E WifiStateMachine: IP configuration failed
01-20-05:14;2301-01 19:33:19.781   954  1115 D WifiHW  : send cmd is DISCONNECT 
01-20-05:14;2301-01 19:33:19.782  1558  1558 D wpa_supplicant: wpa_driver_wext_deauthenticate
01-20-05:14;2301-01 19:33:19.789  1558  1558 D wpa_supplicant: wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
01-20-05:14;2301-01 19:33:19.790  1558  1558 D wpa_supplicant: wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
01-20-05:14;2301-01 19:33:19.790   954  1110 D NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
01-20-05:14;2301-01 19:33:19.793  1558  1558 D wpa_supplicant: wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
01-20-05:14;2301-01 19:33:19.793  1558  1558 D wpa_supplicant: wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
01-20-05:14;2301-01 19:33:19.794  1558  1558 D wpa_supplicant: wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
01-20-05:14;2301-01 19:33:19.795  1558  1558 D wpa_supplicant: wpa_driver_wext_set_operstate: operstate 1->0 (DORMANT)
01-20-05:14;2301-01 19:33:19.795  1558  1558 D wpa_supplicant: netlinkinit: 
01-20-05:14;23 waitpid returned pid 1126, status = 00000009
01-20-05:14;23init: process 'dhcpcd_eth0', pid 1126 exited
01-20-05:14;23: Operstate: linkmode=-1, operstate=5

二、分析

关键部分：

DhcpStateMachine: DHCP failed on wlan0: Timed out waiting for DHCP Renew to finish
init: waitpid returned pid 1835, status = 00000009
init: process 'dhcpcd_wlan0', pid 1835 exited

1.frameworks/base/core/java/android/net/DhcpStateMachine.java

private boolean runDhcp(DhcpAction dhcpAction) {
  if (dhcpAction == DhcpAction.START) {
    if (DBG) Log.d(TAG, "DHCP request on " + mInterfaceName);
    success = NetworkUtils.runDhcp(mInterfaceName, dhcpInfoInternal);
    mDhcpInfo = dhcpInfoInternal;
  } else if (dhcpAction == DhcpAction.RENEW) {
     if (DBG) Log.d(TAG, "DHCP renewal on " + mInterfaceName);
     success = NetworkUtils.runDhcpRenew(mInterfaceName, dhcpInfoInternal); //f分析该函数
     dhcpInfoInternal.updateFromDhcpRequest(mDhcpInfo);
  }
  if (success) {
    ......
  } else {
     //这里就是打印：DhcpStateMachine: DHCP failed on wlan0: Timed out waiting for DHCP Renew to finish
     Log.e(TAG, "DHCP failed on " + mInterfaceName + ": " +
                    NetworkUtils.getDhcpError());
     NetworkUtils.stopDhcp(mInterfaceName);
     mController.obtainMessage(CMD_POST_DHCP_ACTION, DHCP_FAILURE, 0)
                .sendToTarget();
  }
  return success;
}

2.frameworks/base/core/java/android/net/NetworkUtils.java

public native static boolean runDhcpRenew(String interfaceName, DhcpInfoInternal ipInfo);

3.frameworks/base/core/jni/android_net_NetUtils.cpp

static jboolean android_net_utils_runDhcpRenew(JNIEnv* env, jobject clazz, jstring ifname, jobject info)
{
  return android_net_utils_runDhcpCommon(env, clazz, ifname, info, true);
}

static jboolean android_net_utils_runDhcpCommon(JNIEnv* env, jobject clazz, jstring ifname,
        jobject info, bool renew)
{
  if (renew) {
    result = ::dhcp_do_request_renew(nameStr, ipaddr, gateway, &prefixLength,
                dns1, dns2, server, &lease, vendorInfo);
  }
}

4.system/core/libnetutils/dhcp_utils.c

int dhcp_do_request_renew(const char *interface,
                    char *ipaddr,
                    char *gateway,
                    uint32_t *prefixLength,
                    char *dns[],
                    char *server,
                    uint32_t *lease,
                    char *vendorInfo,
                    char *domain,
                    char *mtu)
{
  if (wait_for_property(result_prop_name, NULL, 30) < 0) {
    snprintf(errmsg, sizeof(errmsg), "%s", "Timed out waiting for DHCP Renew to finish"); //这是最关键的错误部分
    return -1;
  }
}

static int wait_for_property(const char *name, const char *desired_value, int maxwait)
{
    char value[PROPERTY_VALUE_MAX] = {'\0'};
    int maxnaps = (maxwait * 1000) / NAP_TIME;

    if (maxnaps < 1) {
        maxnaps = 1;
    }

//add by tank
//  add for MStar Android Patch Begin
    maxnaps = maxnaps + 1;
    usleep(50*1000);
//  add for MStar Android Patch End
//end tank
    while (maxnaps-- > 0) {
        usleep(NAP_TIME * 1000);
        if (property_get(name, value, NULL)) {
            if (desired_value == NULL ||
                    strcmp(value, desired_value) == 0) {
                return 0;
            }
        }
//add by tank@
//  add for MStar Android Patch Begin             
                usleep(NAP_TIME * 1000);
//  add for MStar Android Patch End
//end tank
    }
    return -1; /* failure */
}

三、解决

合入上处4中add by tank后问题解决。

其他问题，mac地址冲突导致重启后无法获取IP。

D/NetdConnector(  958): RCV <- {213 5c:36:b8:4d:ab:7a 0.0.0.0 0 [up broadcast multicast]}
D/NetdConnector(  958): RSP <- {213 5c:36:b8:4d:ab:7a 0.0.0.0 0 [up broadcast multicast]}
D/NetworkManagementService(  958): rsp <213 5c:36:b8:4d:ab:7a 0.0.0.0 0 [up broadcast multicast]>
D/NetworkManagementService(  958): flags <[up broadcast multicast]>
D/NetworkManagementService(  958): Registering observer
I/EthernetStateTracker(  958): reset device eth0
D/NetUtils(  958): android_net_utils_resetConnections in env=0x7d6950 clazz=0xad200001 iface=eth0 mask=0x3
D/DHCP    (  958): ifc_init, return = 0
D/DHCP    (  958): ifc_close
D/DHCP    (  958): ifc_init, return = 0
D/DHCP    (  958): ifc_up(eth0) = 0
D/DHCP    (  958): ifc_close
D/DHCP    (  958): ifc_init, return = 0
D/DHCP    (  958): ifc_close
D/DHCP    (  958): ifc_init, return = 0
D/DHCP    (  958): ifc_close
D/dhcp    ( 1124): enter dhcpcd service 
D/dhcp    ( 1124): enter dhcpcd service add options
D/dhcp    ( 1124): enter dhcpcd service leave option
D/dhcp    ( 1124): enter dhcpcd service chdir
D/dhcp    ( 1124): enter dhcpcd service dump
D/dhcp    ( 1124): enter dhcpcd service master
E/dhcp    ( 1124): version 5.2.10 starting
D/DHCP    ( 1124): ifc_init, return = 0
D/DHCP    ( 1124): ifc_close
F/dhcp    ( 1124): eth0: using hwaddr 5c:36:b8:4d:ab:7a
F/dhcp    ( 1124): eth0: executing `/system/etc/dhcpcd/dhcpcd-run-hooks', reason PREINIT
I/dhcp    ( 1124): host does not support a monotonic clock - timing can skew
F/dhcp    ( 1124): eth0: reading lease `/data/misc/dhcp/dhcpcd-eth0.lease'
E/dhcp    ( 1124): eth0: broadcasting for a lease
F/dhcp    ( 1124): eth0: sending DISCOVER (xid 0xd92bbde3), next in 3.54 seconds