Connecting to Wi-Fi hotspots hangs at Obtaining IP address...
When opening a Wi-Fi hotspot on an API 30 device, I am sometimes unable to connect with other devices, here using an API 16 device.
Log on API 30:
2021-04-14 09:43:55.080 I/ActivityTaskManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=org.briarproject.hotspot/.MainActivity bnds=[48,126][317,538]} from uid 10177
2021-04-14 09:43:55.139 D/android.hardware.power@1.3-service.pixel-libperfmgr: LAUNCH: 0
2021-04-14 09:43:56.941 V/GrantPermissionsActivity: Logged buttons presented and clicked permissionGroupName=android.permission-group.LOCATION uid=10301 package=org.briarproject.hotspot presentedButtons=44 clickedButton=32 sessionId=3369372125551090659
2021-04-14 09:43:56.955 I/OneTimePermissionUserManager: Start tracking org.briarproject.hotspot. uid=10301 timeout=60000 importanceToResetTimer=100 importanceToKeepSessionAlive=125
2021-04-14 09:43:56.955 V/OneTimePermissionUserManager: Importance changed for org.briarproject.hotspot (10301). importance=100
2021-04-14 09:43:56.957 V/GrantPermissionsActivity: Permission grant result requestId=3369372125551090659 callingUid=10301 callingPackage=org.briarproject.hotspot permission=android.permission.ACCESS_FINE_LOCATION isImplicit=false result=10
2021-04-14 09:43:56.959 V/GrantPermissionsActivity: Permission grant result requestId=3369372125551090659 callingUid=10301 callingPackage=org.briarproject.hotspot permission=android.permission.ACCESS_COARSE_LOCATION isImplicit=true result=10
2021-04-14 09:43:58.364 D/WifiP2pNative: Setup P2P interface
2021-04-14 09:43:58.366 I/WifiService: acquireWifiLock uid=10301 lockMode=3
2021-04-14 09:43:58.370 E/TEST: networkName: DIRECT-c4-R8Sasf7DT5
2021-04-14 09:43:58.370 E/TEST: passphrase: 8l833d3Q
2021-04-14 09:43:58.386 I/wpa_supplicant: rfkill: Cannot open RFKILL control device
2021-04-14 09:43:58.392 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: false
2021-04-14 09:43:58.409 I/chatty: uid=1000(system) android.fg identical 3 lines
2021-04-14 09:43:58.414 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: false
2021-04-14 09:43:58.418 I/WifiP2pNative: P2P interface setup completed
2021-04-14 09:43:58.418 I/WifiP2pService: Supported feature: P2P MAC randomization
2021-04-14 09:43:58.423 W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcastMultiplePermissions:1143 android.content.Context.sendBroadcastWithMultiplePermissions:2150 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendBroadcastMultiplePermissions:3106 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendP2pConnectionChangedBroadcast:3133 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.access$4900:756
2021-04-14 09:43:58.423 W/BroadcastQueue: Permission Denial: receiving Intent { act=android.net.wifi.p2p.CONNECTION_STATE_CHANGE flg=0x24000010 (has extras) } to ProcessRecord{dae2ff0 2101:com.android.networkstack.process/1073} (pid=2101, uid=1073) requires android.permission.NETWORK_SETTINGS due to sender android (uid 1000)
2021-04-14 09:43:58.423 W/BroadcastQueue: Permission Denial: receiving Intent { act=android.net.wifi.p2p.CONNECTION_STATE_CHANGE flg=0x24000010 (has extras) } to com.genonbeta.TrebleShot/.receiver.NetworkStatusReceiver requires android.permission.NETWORK_SETTINGS due to sender android (uid 1000)
2021-04-14 09:43:58.425 W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcastMultiplePermissions:1143 android.content.Context.sendBroadcastWithMultiplePermissions:2150 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendBroadcastMultiplePermissions:3106 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendThisDeviceChangedBroadcast:3115 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.updateThisDevice:3835
2021-04-14 09:43:58.432 D/WifiP2pNative: P2P InterfaceAvailableListener false
2021-04-14 09:43:58.432 I/WifiP2pNative: Masking interface non-availability callback because we created a P2P iface
2021-04-14 09:43:58.437 E/TEST: requestGroupInfo attempt: 1
2021-04-14 09:43:58.446 W/wpa_supplicant: Device is trying to offload WPS Probe Response while not supporting this
2021-04-14 09:43:58.446 W/wpa_supplicant: Device is trying to offload P2P Probe Response while not supporting this
2021-04-14 09:43:58.451 E/TEST: received networkName: DIRECT-Kl-G2om8OFtTB
2021-04-14 09:43:58.451 E/TEST: received passphrase: 8Edq9437
2021-04-14 09:43:58.461 I/WifiHAL: event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0xa5
2021-04-14 09:43:58.462 I/WifiNative: Device is in MCC mode now
2021-04-14 09:43:58.462 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: interface state UNINITIALIZED->ENABLED
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: AP-ENABLED
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: CTRL-EVENT-CONNECTED - Connection to 9e:43:88:e0:f9:53 completed [id=1 id_str=]
2021-04-14 09:43:58.465 I/wpa_supplicant: P2P-GROUP-STARTED p2p0 GO ssid="DIRECT-c4-R8Sasf7DT5" freq=2412 go_dev_addr=9e:43:88:e0:f9:53
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: CTRL-EVENT-CHANNEL-SWITCH freq=2412 ht_enabled=1 ch_offset=0 ch_width=20 MHz cf1=2412 cf2=0
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: CTRL-EVENT-CHANNEL-SWITCH freq=2412 ht_enabled=1 ch_offset=0 ch_width=20 MHz cf1=2412 cf2=0 dfs=0
2021-04-14 09:43:58.465 I/wpa_supplicant: p2p0: AP-CSA-FINISHED freq=2412 dfs=0
2021-04-14 09:43:58.466 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:43:58.466 D/WifiP2pService: Tethering service package: com.google.android.networkstack.tethering
2021-04-14 09:43:58.467 W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcastMultiplePermissions:1143 android.content.Context.sendBroadcastWithMultiplePermissions:2150 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendBroadcastMultiplePermissions:3106 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.sendP2pTetherRequestBroadcast:3182 com.android.server.wifi.p2p.WifiP2pServiceImpl$P2pStateMachine.access$9400:756
2021-04-14 09:43:58.467 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:43:58.468 W/BroadcastQueue: Permission Denial: receiving Intent { act=android.net.wifi.p2p.CONNECTION_STATE_CHANGE flg=0x24000010 pkg=com.google.android.networkstack.tethering (has extras) } to ProcessRecord{dae2ff0 2101:com.android.networkstack.process/1073} (pid=2101, uid=1073) requires android.permission.NETWORK_SETTINGS due to sender android (uid 1000)
2021-04-14 09:43:59.453 E/TEST: requestGroupInfo attempt: 2
2021-04-14 09:44:05.690 I/WorkerManager: dispose()
2021-04-14 09:44:05.694 W/A: Queue length for executor EventBus is now 11. Perhaps some tasks are too long, or the pool is too small.
2021-04-14 09:44:06.189 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:44:06.209 W/wpa_supplicant: Device is trying to offload WPS Probe Response while not supporting this
2021-04-14 09:44:06.210 W/wpa_supplicant: Device is trying to offload P2P Probe Response while not supporting this
2021-04-14 09:44:06.214 I/wpa_supplicant: p2p0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
2021-04-14 09:44:06.246 I/wpa_supplicant: p2p0: AP-STA-CONNECTED 58:a2:b5:9f:d3:70
2021-04-14 09:44:06.247 I/WifiHAL: event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0x65
2021-04-14 09:44:24.930 W/ActivityManager: Background start not allowed: service Intent { cmp=com.google.android.apps.messaging/.shared.datamodel.action.execution.ActionExecutorImpl$EmptyService } to com.google.android.apps.messaging/.shared.datamodel.action.execution.ActionExecutorImpl$EmptyService from pid=3916 uid=10171 pkg=com.google.android.apps.messaging startFg?=false
2021-04-14 09:44:25.017 W/Bugle: SubscriptionMetadataUtils get: invalid subId = -1
2021-04-14 09:44:25.021 I/Bugle: CountryCodeDetector: updateMainDeviceCountry from default subscription network country. detected country: br
2021-04-14 09:44:25.029 I/BugleDataModel: ParticipantRefresh: ContactContentObserver created
2021-04-14 09:44:25.030 I/BugleDataModel: ParticipantRefresh: Start participant refresh. refreshMode: SELF_ONLY
2021-04-14 09:44:25.057 W/Bugle: SubscriptionMetadataUtils get: invalid subId = -1
2021-04-14 09:44:25.057 W/Bugle: SubscriptionMetadataUtils get: invalid subId = -1
2021-04-14 09:44:25.058 W/Bugle: SubscriptionUtilsAsOfLMR1: getSelfRawNumber: subInfo is null for subscription{id:-1}
2021-04-14 09:44:24.976 W/ActivityManager: Background start not allowed: service Intent { cmp=com.google.android.apps.messaging/.shared.datamodel.action.execution.ActionExecutorImpl$EmptyService } to com.google.android.apps.messaging/.shared.datamodel.action.execution.ActionExecutorImpl$EmptyService from pid=3916 uid=10171 pkg=com.google.android.apps.messaging startFg?=false
2021-04-14 09:44:25.061 D/CompatibilityChangeReporter: Compat change id reported: 135634846; UID 10055; state: DISABLED
2021-04-14 09:44:25.062 D/CompatibilityChangeReporter: Compat change id reported: 143937733; UID 10055; state: ENABLED
2021-04-14 09:44:36.892 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:44:36.897 I/wpa_supplicant: p2p0: AP-STA-DISCONNECTED 58:a2:b5:9f:d3:70
2021-04-14 09:44:36.905 W/wpa_supplicant: Device is trying to offload WPS Probe Response while not supporting this
2021-04-14 09:44:36.905 W/wpa_supplicant: Device is trying to offload P2P Probe Response while not supporting this
2021-04-14 09:44:39.179 W/wpa_supplicant: Device is trying to offload WPS Probe Response while not supporting this
2021-04-14 09:44:39.179 W/wpa_supplicant: Device is trying to offload P2P Probe Response while not supporting this
2021-04-14 09:44:39.190 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
2021-04-14 09:44:39.196 I/wpa_supplicant: p2p0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
2021-04-14 09:44:39.238 I/wpa_supplicant: p2p0: AP-STA-CONNECTED 58:a2:b5:9f:d3:70
2021-04-14 09:44:39.239 I/WifiHAL: event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0x65
2021-04-14 09:45:07.716 I/wpa_supplicant: p2p0: AP-STA-DISCONNECTED 58:a2:b5:9f:d3:70
2021-04-14 09:45:07.722 W/wpa_supplicant: Device is trying to offload WPS Probe Response while not supporting this
2021-04-14 09:45:07.722 W/wpa_supplicant: Device is trying to offload P2P Probe Response while not supporting this
2021-04-14 09:45:07.741 I/EthernetTracker: interfaceLinkStateChanged, iface: p2p0, up: true
Log from API 16:
04-14 09:43:58.266 D/PowerManagerService: userActivity mLastEventTime=60000687 time=60023616 mUserActivityAllowed=true mUserState=0x3 mWakeLockState=0x0 mProximitySensorActive=false timeoutOverride=-1 force=false
04-14 09:43:58.266 D/PowerManagerService: setPowerState: mPowerState=0x3 newState=0x3 noChangeLights=false reason=2
04-14 09:43:58.266 D/PowerManagerService: setTimeoutLocked now=60023616 timeoutOverride=-1 nextState=3 when=60025116
04-14 09:43:58.316 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:43:58.316 D/PowerManagerService: Perflock acquired: 2, 1
04-14 09:43:58.326 I/ActivityManager: START {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000
04-14 09:44:02.231 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:02.231 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:platform, action:3
04-14 09:44:02.231 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:02.231 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:02.241 D/NetdConnector: SND -> {151 interface clearaddrs wlan0}
04-14 09:44:02.241 D/NetdConnector: RCV <- {200 151 Interface IP addresses cleared}
04-14 09:44:02.241 D/NetdConnector: RMV <- {200 151 Interface IP addresses cleared}
04-14 09:44:02.251 D/NetdConnector: SND -> {152 interface ipv6 wlan0 disable}
04-14 09:44:02.251 D/NetdConnector: RCV <- {200 152 IPv6 state changed}
04-14 09:44:02.251 D/NetdConnector: RMV <- {200 152 IPv6 state changed}
04-14 09:44:02.251 D/ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
04-14 09:44:02.251 D/ConnectivityService: [LGE_DATA] handleDisconnect() : mJustIsWifiConnected = false
04-14 09:44:02.261 D/ConnectivityService: Attempting to switch to mobile
04-14 09:44:02.261 D/ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
04-14 09:44:02.261 D/ConnectivityService: handleConnectivityChange: changed linkProperty[1]: doReset=true resetMask=3
curLp=InterfaceName: wlan0 LinkAddresses: [192.168.49.11/24,] Routes: [0.0.0.0/0 -> 192.168.49.1,] DnsAddresses: [192.168.49.1,] HttpProxy: [ProxyProperties.mHost == null]
newLp= null
04-14 09:44:02.261 D/ConnectivityService: not removing 192.168.49.1/32 -> 0.0.0.0 as it's still in use
04-14 09:44:02.261 D/ConnectivityService: Removing 0.0.0.0/0 -> 192.168.49.1 for interface wlan0
04-14 09:44:02.261 D/NetdConnector: SND -> {153 interface route remove wlan0 default 0.0.0.0 0 192.168.49.1}
04-14 09:44:02.261 D/NetdConnector: RCV <- {400 153 Failed to remove route from default table (No such process)}
04-14 09:44:02.261 D/NetdConnector: RMV <- {400 153 Failed to remove route from default table (No such process)}
04-14 09:44:02.261 D/ConnectivityService: Removing src route for:192.168.49.11
04-14 09:44:02.261 D/NetdConnector: SND -> {154 route del src v4 2}
04-14 09:44:02.311 D/NetdConnector: RCV <- {200 154 source route delete succeeded for rid:2}
04-14 09:44:02.311 D/NetdConnector: RMV <- {200 154 source route delete succeeded for rid:2}
04-14 09:44:02.311 D/ConnectivityService: Removing 192.168.49.1/32 -> 0.0.0.0 for interface wlan0
04-14 09:44:02.311 D/NetdConnector: SND -> {155 interface route remove wlan0 default 192.168.49.1 32 0.0.0.0}
04-14 09:44:02.311 D/NetdConnector: RCV <- {400 155 Failed to remove route from default table (No such process)}
04-14 09:44:02.311 D/NetdConnector: RMV <- {400 155 Failed to remove route from default table (No such process)}
04-14 09:44:02.311 D/ConnectivityService: resetConnections(wlan0, 3)
04-14 09:44:02.401 D/ConnectivityService: reportNetworkCondition(1, 0)
04-14 09:44:02.421 D/ConnectivityService: resetting DNS cache for wlan0
04-14 09:44:02.421 D/NetdConnector: SND -> {156 resolver flushif wlan0}
04-14 09:44:02.421 D/NetdConnector: RCV <- {200 156 Resolver command succeeded}
04-14 09:44:02.421 D/NetdConnector: RMV <- {200 156 Resolver command succeeded}
04-14 09:44:02.421 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE_IMMEDIATE
04-14 09:44:02.421 D/ConnectivityService: sendStickyBroadcastDelayed: delayMs=3000, action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:44:02.421 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:44:02.521 D/NetdConnector: SND -> {157 bandwidth setglobalalert 2097152}
04-14 09:44:02.521 D/NetdConnector: RCV <- {200 157 Bandwidth command succeeeded}
04-14 09:44:02.521 D/NetdConnector: RMV <- {200 157 Bandwidth command succeeeded}
04-14 09:44:03.612 I/ActivityManager: START {act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.lge.launcher2/.Launcher u=0} from pid 670
04-14 09:44:03.692 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:44:04.603 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:04.603 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:04.603 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:04.613 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:44:04.663 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:44:04.683 D/ConnectivityService: ConnectivityChange for WIFI: CONNECTING/OBTAINING_IPADDR
04-14 09:44:05.424 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:44:05.454 D/StatusBar.NetworkController: updateConnectivity: intent=Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x8000010 (has extras) }
04-14 09:44:05.454 D/StatusBar.NetworkController: updateConnectivity: networkInfo=NetworkInfo: type: WIFI[], state: DISCONNECTED/DISCONNECTED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
04-14 09:44:05.454 D/StatusBar.NetworkController: updateConnectivity: connectionStatus=0
04-14 09:44:05.464 D/StatusBar.NetworkController: updateTelephonySignalStrength: !hasService()
04-14 09:44:05.464 D/StatusBar.NetworkController: sendRssi()=0
04-14 09:44:05.464 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:44:05.474 D/ConnectivityService: reportNetworkCondition(1, 0)
04-14 09:44:05.474 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:44:05.834 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:05.925 D/PowerManagerService: userActivity mLastEventTime=60030329 time=60031279 mUserActivityAllowed=true mUserState=0x7 mWakeLockState=0x0 mProximitySensorActive=false timeoutOverride=-1 force=false
04-14 09:44:05.925 D/PowerManagerService: setPowerState: mPowerState=0x7 newState=0x7 noChangeLights=false reason=2
04-14 09:44:05.925 D/PowerManagerService: setTimeoutLocked now=60031279 timeoutOverride=-1 nextState=3 when=60032779
04-14 09:44:06.375 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:06.435 I/ActivityManager: START {act=android.settings.WIFI_SETTINGS flg=0x14000000 cmp=com.android.settings/.Settings$WifiSettingsActivity u=0} from pid 843
04-14 09:44:07.276 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:
04-14 09:44:09.658 W/SocketClient: write error (Broken pipe)
04-14 09:44:09.679 D/ConnectivityService: reportNetworkCondition(-1, 0)
04-14 09:44:09.679 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:44:23.703 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:44:24.154 D/ConnectivityService: reportNetworkCondition(-1, 0)
04-14 09:44:24.154 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:44:24.154 W/SocketClient: write error (Broken pipe)
04-14 09:44:35.326 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:platform, action:3
04-14 09:44:35.346 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:35.386 D/NetdConnector: SND -> {158 interface clearaddrs wlan0}
04-14 09:44:35.386 D/NetdConnector: RCV <- {200 158 Interface IP addresses cleared}
04-14 09:44:35.386 D/NetdConnector: RMV <- {200 158 Interface IP addresses cleared}
04-14 09:44:35.386 D/NetdConnector: SND -> {159 interface ipv6 wlan0 disable}
04-14 09:44:35.386 D/NetdConnector: RCV <- {200 159 IPv6 state changed}
04-14 09:44:35.396 D/NetdConnector: RMV <- {200 159 IPv6 state changed}
04-14 09:44:35.406 D/ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
04-14 09:44:35.406 D/ConnectivityService: [LGE_DATA] handleDisconnect() : mJustIsWifiConnected = false
04-14 09:44:35.406 D/ConnectivityService: Attempting to switch to mobile
04-14 09:44:35.406 D/ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
04-14 09:44:35.406 D/ConnectivityService: handleConnectivityChange: changed linkProperty[1]: doReset=true resetMask=3
curLp=null
newLp= null
04-14 09:44:35.406 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE_IMMEDIATE
04-14 09:44:35.406 D/ConnectivityService: sendStickyBroadcastDelayed: delayMs=3000, action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:44:35.436 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:35.446 D/NetdConnector: SND -> {160 bandwidth setglobalalert 2097152}
04-14 09:44:35.446 D/NetdConnector: RCV <- {200 160 Bandwidth command succeeeded}
04-14 09:44:35.456 D/NetdConnector: RMV <- {200 160 Bandwidth command succeeeded}
04-14 09:44:35.456 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:35.456 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:35.937 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:36.727 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:44:37.628 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:37.638 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:37.638 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:37.638 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:44:37.638 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:44:37.648 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:44:37.678 D/ConnectivityService: ConnectivityChange for WIFI: CONNECTING/OBTAINING_IPADDR
04-14 09:44:37.678 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:44:38.129 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:38.409 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:44:38.469 D/ConnectivityService: reportNetworkCondition(1, 0)
04-14 09:44:38.469 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:44:38.519 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:38.820 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:44:43.695 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:44:48.740 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:44:53.045 D/ConnectivityService: reportNetworkCondition(-1, 0)
04-14 09:44:53.045 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:45:00.132 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:00.333 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:02.265 D/ConnectivityService: NetTransition Wakelock for WifiStateMachine released by timeout
04-14 09:45:03.706 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:03.866 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:platform, action:3
04-14 09:45:03.876 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:03.876 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:03.876 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:03.876 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:03.896 D/NetdConnector: SND -> {161 interface clearaddrs wlan0}
04-14 09:45:03.896 D/NetdConnector: RCV <- {200 161 Interface IP addresses cleared}
04-14 09:45:03.896 D/NetdConnector: RMV <- {200 161 Interface IP addresses cleared}
04-14 09:45:03.896 D/NetdConnector: SND -> {162 interface ipv6 wlan0 disable}
04-14 09:45:03.896 D/NetdConnector: RCV <- {200 162 IPv6 state changed}
04-14 09:45:03.896 D/NetdConnector: RMV <- {200 162 IPv6 state changed}
04-14 09:45:03.906 D/ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
04-14 09:45:03.906 D/ConnectivityService: [LGE_DATA] handleDisconnect() : mJustIsWifiConnected = false
04-14 09:45:03.906 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:45:03.916 D/ConnectivityService: Attempting to switch to mobile
04-14 09:45:03.916 D/ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
04-14 09:45:03.916 D/ConnectivityService: handleConnectivityChange: changed linkProperty[1]: doReset=true resetMask=3
curLp=null
newLp= null
04-14 09:45:03.916 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE_IMMEDIATE
04-14 09:45:03.916 D/ConnectivityService: sendStickyBroadcastDelayed: delayMs=3000, action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:45:03.926 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:03.936 D/NetdConnector: SND -> {163 bandwidth setglobalalert 2097152}
04-14 09:45:03.936 D/NetdConnector: RCV <- {200 163 Bandwidth command succeeeded}
04-14 09:45:03.946 D/NetdConnector: RMV <- {200 163 Bandwidth command succeeeded}
04-14 09:45:04.437 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:06.219 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:06.569 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:06.920 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:45:06.930 D/StatusBar.NetworkController: updateConnectivity: intent=Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x8000010 (has extras) }
04-14 09:45:06.930 D/StatusBar.NetworkController: updateConnectivity: networkInfo=NetworkInfo: type: WIFI[], state: DISCONNECTED/DISCONNECTED, reason: (unspecified), extra: (none), roaming: false, failover: false, isAvailable: true
04-14 09:45:06.930 D/StatusBar.NetworkController: updateConnectivity: connectionStatus=0
04-14 09:45:06.940 D/StatusBar.NetworkController: updateTelephonySignalStrength: !hasService()
04-14 09:45:06.940 D/StatusBar.NetworkController: sendRssi()=0
04-14 09:45:06.950 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:45:07.000 D/ConnectivityService: reportNetworkCondition(1, 0)
04-14 09:45:07.000 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:45:07.080 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:07.530 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:08.481 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:08.722 I/ActivityManager: Config changed: {1.0 0mcc0mnc en_US sw360dp w640dp h334dp nrml long land finger -keyb/v/h -nav/h s.130fontTypeIndex}
04-14 09:45:08.862 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:45:09.002 D/PhoneStatusBar: handleMessage() msg.what = MSG_CONFIGURATION_CHANGED
04-14 09:45:09.783 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:11.324 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:11.625 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:11.825 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:12.025 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:14.127 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:15.058 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:15.058 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:15.058 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:15.058 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:45:15.108 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:45:15.128 D/StatusBar.NetworkController: refreshViews connected={ } level=5 combinedSignalIconId=0x7f0203ed/com.android.systemui:drawable/stat_sys_signal_null_vzw combinedActivityIconId=0x0 mobileLabel=No service wifiLabel= emergencyOnly=true combinedLabel=No Internet connection mAirplaneMode=false mDataActivity=0 mPhoneSignalIconId=0x7f0203ed mDataDirectionIconId=0x7f020391 mDataSignalIconId=0x7f0203ed mDataTypeIconId=0x0 mNoSimIconId=0x7f020391 mThirdTypeIconId=0x0 mWifiIconId=0x7f020419 mBluetoothTetherIconId=0x1080552
04-14 09:45:15.138 D/ConnectivityService: ConnectivityChange for WIFI: CONNECTING/OBTAINING_IPADDR
04-14 09:45:15.519 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:23.697 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:36.721 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:36.731 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:43.689 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:45.781 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:platform, action:3
04-14 09:45:45.801 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:45.801 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:45.801 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:45.841 D/NetdConnector: SND -> {164 interface clearaddrs wlan0}
04-14 09:45:45.841 D/NetdConnector: RCV <- {200 164 Interface IP addresses cleared}
04-14 09:45:45.841 D/NetdConnector: RMV <- {200 164 Interface IP addresses cleared}
04-14 09:45:45.841 D/NetdConnector: SND -> {165 interface ipv6 wlan0 disable}
04-14 09:45:45.841 D/NetdConnector: RCV <- {200 165 IPv6 state changed}
04-14 09:45:45.851 D/NetdConnector: RMV <- {200 165 IPv6 state changed}
04-14 09:45:45.861 D/ConnectivityService: ConnectivityChange for WIFI: DISCONNECTED/DISCONNECTED
04-14 09:45:45.861 D/ConnectivityService: [LGE_DATA] handleDisconnect() : mJustIsWifiConnected = false
04-14 09:45:45.861 D/ConnectivityService: Attempting to switch to mobile
04-14 09:45:45.861 D/ConnectivityService: Attempting to switch to BLUETOOTH_TETHER
04-14 09:45:45.861 D/ConnectivityService: handleConnectivityChange: changed linkProperty[1]: doReset=true resetMask=3
curLp=null
newLp= null
04-14 09:45:45.861 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE_IMMEDIATE
04-14 09:45:45.861 D/ConnectivityService: sendStickyBroadcastDelayed: delayMs=3000, action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:45:45.891 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:45.901 D/NetdConnector: SND -> {166 bandwidth setglobalalert 2097152}
04-14 09:45:45.911 D/NetdConnector: RCV <- {200 166 Bandwidth command succeeeded}
04-14 09:45:45.911 D/NetdConnector: RMV <- {200 166 Bandwidth command succeeeded}
04-14 09:45:48.033 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:48.033 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:48.033 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 down}
04-14 09:45:48.033 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:45:48.084 D/NetdConnector: RCV <- {600 Iface linkstate wlan0 up}
04-14 09:45:48.104 D/ConnectivityService: ConnectivityChange for WIFI: CONNECTING/OBTAINING_IPADDR
04-14 09:45:48.644 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:48.744 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:power_supply, action:3
04-14 09:45:48.864 D/ConnectivityService: sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
04-14 09:45:48.894 D/ConnectivityService: reportNetworkCondition(1, 0)
04-14 09:45:48.894 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:45:48.944 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:49.245 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:50.806 D/ConnectivityService: reportNetworkCondition(-1, 0)
04-14 09:45:50.806 D/ConnectivityService: handleInetConditionChange: no active default network - ignore
04-14 09:45:50.806 W/SocketClient: write error (Broken pipe)
04-14 09:45:56.923 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
04-14 09:45:57.123 I/Vold: [LGE][VOLD][NetlinkHandler.cpp][onEvent()] subsys:cpu, action:0
Related to #1992 (closed)