search

schwabe / ics-openvpn

OpenVPN for Android
3.36k stars 1.2k forks source link

"Reboot required issue" -> information from logcat #437

Closed AlmogBaku closed 8 years ago

AlmogBaku commented 8 years ago

Hey, I collected the logs from the "reboot required"/"broken configuration/rom" issue:

Logcat:

01-14 19:52:12.078 852-1289/? I/ActivityManager: START u0 {act=android.intent.action.MAIN flg=0x34000000 cmp=net.rimoto.android/net.rimoto.vpnlib.ConnectVPN (has extras)} from uid 10119 on display 0
01-14 19:52:12.083 1557-5013/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1455 android.content.ContextWrapper.sendBroadcast:376 com.motorola.motocare.util.TriggerHelper$TriggerBuilder.send:76 com.motorola.motocare.internal.frameworkevents.PauseResumeTrigger.handleFrameworkEvent:53 com.motorola.motocare.internal.frameworkevents.FwEventMonitor$FrameworkListener.processFrameworkEvent:114 
01-14 19:52:12.084 282-717/? I/SFPerfTracer:      triggers: (rate: 0:11) (12026 sw vsyncs) (0 skipped) (64:95558 vsyncs) (66:157369)
01-14 19:52:12.095 1557-5013/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1455 android.content.ContextWrapper.sendBroadcast:376 com.motorola.motocare.util.TriggerHelper$TriggerBuilder.send:76 com.motorola.motocare.internal.frameworkevents.PauseResumeTrigger.handleFrameworkEvent:53 com.motorola.motocare.internal.frameworkevents.FwEventMonitor$FrameworkListener.processFrameworkEvent:114 
01-14 19:52:12.142 852-1689/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:12.163 1557-5013/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1455 android.content.ContextWrapper.sendBroadcast:376 com.motorola.motocare.util.TriggerHelper$TriggerBuilder.send:76 com.motorola.motocare.internal.frameworkevents.PauseResumeTrigger.handleFrameworkEvent:53 com.motorola.motocare.internal.frameworkevents.FwEventMonitor$FrameworkListener.processFrameworkEvent:114 
01-14 19:52:12.221 12889-14092/net.rimoto.android I/OpenVPN: Starting openvpn
01-14 19:52:12.251 1557-5013/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1455 android.content.ContextWrapper.sendBroadcast:376 com.motorola.motocare.util.TriggerHelper$TriggerBuilder.send:76 com.motorola.motocare.internal.frameworkevents.PauseResumeTrigger.handleFrameworkEvent:53 com.motorola.motocare.internal.frameworkevents.FwEventMonitor$FrameworkListener.processFrameworkEvent:114 
01-14 19:52:12.262 852-1178/? I/LaunchCheckinHandler: Displayed net.rimoto.android/net.rimoto.vpnlib.ConnectVPN,wp,ca,172
01-14 19:52:12.273 2114-2114/? I/Keyboard.Facilitator: onFinishInput()
01-14 19:52:12.294 12889-12906/net.rimoto.android I/art: Background sticky concurrent mark sweep GC freed 13429(1053KB) AllocSpace objects, 49(3MB) LOS objects, 14% free, 24MB/29MB, paused 9.040ms total 148.211ms
01-14 19:52:12.373 852-2273/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:12.555 1347-1347/? I/SBar.MotoNetworkCtrlr: PhoneStateListener[0].onDataActivity: received on phoneId:0, direction=3

01-14 19:52:13.145 852-867/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:13.414 852-1542/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:13.562 1347-1347/? I/SBar.MotoNetworkCtrlr: PhoneStateListener[0].onDataActivity: received on phoneId:0, direction=0
01-14 19:52:14.064 852-1289/? I/ActivityManager: Killing 13424:com.google.android.setupwizard/u0a15 (adj 15): empty #7
01-14 19:52:14.099 852-2273/? W/libprocessgroup: failed to open /acct/uid_10015/pid_13424/cgroup.procs: No such file or directory
01-14 19:52:14.139 312-969/? D/hardware_info: hw_info_append_hw_type : device_name = speaker
01-14 19:52:14.146 312-969/? E/msm8974_platform: platform_update_tpa_poll: Could not get ctl for mixer cmd - TPA6165 POLL ACC DET
01-14 19:52:14.146 852-867/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:14.415 852-3161/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:14.565 1347-1347/? I/SBar.MotoNetworkCtrlr: PhoneStateListener[0].onDataActivity: received on phoneId:0, direction=2
01-14 19:52:14.631 322-410/? I/ThermalEngine: Sensor:xo_therm_pu2:49000 mC
01-14 19:52:14.650 13394-13394/? W/Settings: Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.
01-14 19:52:14.724 13394-13394/? W/Settings: Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.
01-14 19:52:14.751 13394-13394/? W/Settings: Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.Global, returning read-only value.
01-14 19:52:15.149 852-1542/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:15.415 852-2306/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:15.717 13066-13168/? E/MDM: AppOpsUtil - Caught an IllegalArgumentException when getting application operation states. e: Unknown operation string: android:read_phone_state
01-14 19:52:15.763 13066-13168/? W/MDM: InstalledPackageMonitor - <--> getAppVersionForUid(0) failed to find matching entity
01-14 19:52:15.764 13066-13168/? W/MDM: InstalledPackageMonitor - <--> getAppVersionForUid(0) failed to find matching entity
01-14 19:52:16.150 852-1689/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:16.416 852-2273/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output
01-14 19:52:16.591 12889-14091/net.rimoto.android I/openvpn: Got unrecognized command>FATAL:ERROR: Cannot open TUN
01-14 19:52:16.599 12889-14092/net.rimoto.android I/OpenVPN: Giving up
01-14 19:52:16.606 12889-14092/net.rimoto.android I/OpenVPN: Exiting
01-14 19:52:16.673 282-282/? I/SFPerfTracer:      triggers: (rate: 68:3944) (compose: 0:27) (post: 0:6) (render: 14:449) (255:65927 frames) (256:86292)
01-14 19:52:16.673 282-282/? D/SFPerfTracer:        layers: (5:11) (FocusedStackFrame (0xb88fcf98): 0:1061)* (DimLayer (0xb8905f28): 0:966) (DimLayer (0xb89087c0): 0:334)* (StatusBar (0xb88bf1a0): 4:17338) (com.android.systemui.ImageWallpaper (0xb88cc0b8): 0:1336)* (NavigationBar (0xb88ff9a0): 0:596) (net.rimoto.android/net.rimoto.android.activity.VpnConnectActivity_ (0xb88c0a98): 0:53) (net.rimoto.android/net.rimoto.android.activity.VpnConnectActivity_ (0xb885dea0): 255:326) (net.rimoto.android/net.rimoto.vpnlib.ConnectVPN (0xb88c9948): 0:7)- 
01-14 19:52:16.684 282-717/? I/SFPerfTracer:      triggers: (rate: 0:11) (12026 sw vsyncs) (0 skipped) (267:95827 vsyncs) (269:157642)
01-14 19:52:17.151 852-3157/? W/ActivityManager: getRunningAppProcesses: caller 10108 does not hold REAL_GET_TASKS; limiting output

VpnStatus:

[Jan 14, 19:52:16] [ERROR] Log (no context) resid 2131231100
[Jan 14, 19:52:16] [ERROR] Error: Android establish() method returned null (Really broken network configuration?)
[Jan 14, 19:52:16] [WARNING] MGMT: Got unrecognized command>FATAL:ERROR: Cannot open TUN
[Jan 14, 19:52:16] [INFO] MANAGEMENT: CMD 'needok 'OPENTUN' cancel'
[Jan 14, 19:52:16] [INFO] MANAGEMENT: Client disconnected
[Jan 14, 19:52:16] [INFO] ERROR: Cannot open TUN
[Jan 14, 19:52:16] [INFO] Exiting due to fatal error
[Jan 14, 19:52:16] [ERROR] Process exited with exit value 1

Maybe that's can help

AlmogBaku commented 8 years ago

Device: moto g 2 (it happened a lot with this device)

schwabe commented 8 years ago

I am not really seeing anything that could explain that error in the log. :(

AlmogBaku commented 8 years ago

So am I :|

But I ahve a guess.. i found that this happened when one VPN is established and there is another try to establish a vpn connection. It happened to me before with ovpb-for-android and onavo, and with ovpn-for-android and my fork..

I guess that for some reason, the vpn is trying twice to connect, and it cause this problem.

natsihitt commented 8 years ago

You're right second connection I think its for the tunnul program or because I set the TCP to adoptive mod and its connecting on and om

schwabe commented 8 years ago

@natsihitt ???

natsihitt commented 8 years ago

??

schwabe commented 8 years ago

@AlmogBaku comment points to an Android bug, so closing this