benjarobbi / get-a-robot-vpnc

Automatically exported from code.google.com/p/get-a-robot-vpnc
1 stars 0 forks source link

Hangs on 'trying to connect' on froyo on HTC Hero #101

Open GoogleCodeExporter opened 9 years ago

GoogleCodeExporter commented 9 years ago
What steps will reproduce the problem?
1. Install a froyo based ROM with tun compilied in on an HTC hero 
(froydvillain, CM6 daily, etc)
2. Attempt to connect to VPN
3. Please wait trying to connect stays on screen and VPN connections has to be 
killed.

What is the expected output? What do you see instead?
Connected to VPN

What version of the product are you using? On what operating system?
0.99 on FroydVillain (have tested on CM6 alpha and had similar issue on 
VillainROM 12. Note taht I believe all these have tun compilied into kernel 
rather than a module. At least /dev/tun exists but there is no tun.ko available 
on the system.

Please provide any additional information below.

Anonymised Logcat Output:

I/ActivityManager(  428): Starting activity: Intent { 
act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] 
flg=0x10200000 cmp=org.codeandroid.vpnc_frontend/.VPNC }
I/ActivityManager(  428): Start proc org.codeandroid.vpnc_frontend for activity 
org.codeandroid.vpnc_frontend/.VPNC: pid=997 uid=10076 gids={1015}
W/ResourceType(  428): Skipping entry 0x7f040007 in package table 0 because it 
is not complex!
W/ResourceType(  428): Skipping entry 0x7f040008 in package table 0 because it 
is not complex!
D/VPN_Connections(  997): Read PS header line as USER     PID   PPID  VSIZE  
RSS     WCHAN    PC         NAME
D/VPN_Connections(  997): PID is in column #1
D/VPN_Connections(  997): VpncProcessHandler instantiated
D/VPN_Connections(  997): Read vpnc process line as null
D/VPN_Connections(  997): Attempt to read vpnc process id did not return 
anything
I/ActivityManager(  428): Starting activity: Intent { 
cmp=org.codeandroid.vpnc_frontend/.BackendFileManager }
D/VPN_Connections(  997): NetworkDatabase:allNetworks - Start
D/VPN_Connections(  997): Preference Window: Creating new NetworkPreference
D/VPN_Connections(  997): Adding NetworkPreference with ID:1
D/VPN_Connections(  997): Monitoring will not start
D/VPN_Connections(  997): filemanager: File: 
/data/data/org.codeandroid.vpnc_frontend/files/vpncexists, not copying
D/VPN_Connections(  997): filemanager: File: 
/data/data/org.codeandroid.vpnc_frontend/files/vpnc-scriptexists, not copying
E/linker  (  997): bionic/linker/linker.c:693| WARNING: 
`/system/lib/hw/gralloc.msm7k.so` is not a prelinked library
E/linker  (  997):    58 mapping library 'gralloc.msm7k.so' at 80900000 (index 
00000009) through buddy allocator.
E/linker  ( 1013): bionic/linker/linker.c:693| WARNING: `libicudata.so` is not 
a prelinked library
E/linker  ( 1013):  1013 mapping library 'libicudata.so' at 80000000 (index 
00000000) through buddy allocator.
I/ActivityManager(  428): Displayed activity 
org.codeandroid.vpnc_frontend/.BackendFileManager: 447 ms (total 499451 ms)
E/linker  ( 1013): bionic/linker/linker.c:693| WARNING: `libjpeg.so` is not a 
prelinked library
E/linker  ( 1013):  1013 mapping library 'libjpeg.so' at 80800000 (index 
00000008) through buddy allocator.
W/Parcel  (  428): Attempt to read object from Parcel 0x48c8bdd8 at offset 636 
that is not in the object list
I/ActivityManager(  428): Starting activity: Intent { 
act=android.intent.action.MAIN flg=0x58000000 pkg=com.noshufou.android.su 
cmp=com.noshufou.android.su/.SuRequest (has extras) }
D/dalvikvm(  754): GC_FOR_MALLOC freed 6169 objects / 361448 bytes in 198ms
D/SuRequest(  754): Sending result: ALLOW
D/su      ( 1013): 10076 org.codeandroid.vpnc_frontend executing 0 sh using 
shell /system/bin/sh : sh
D/VPN_Connections(  997): filemanager: Done creating directory /dev/net with 
return code 0
D/VPN_Connections(  997): filemanager: ln -s /dev/tun /dev/net/tun
E/linker  ( 1016): bionic/linker/linker.c:693| WARNING: `libicudata.so` is not 
a prelinked library
E/linker  ( 1016):  1016 mapping library 'libicudata.so' at 80000000 (index 
00000000) through buddy allocator.
E/linker  ( 1016): bionic/linker/linker.c:693| WARNING: `libjpeg.so` is not a 
prelinked library
E/linker  ( 1016):  1016 mapping library 'libjpeg.so' at 80800000 (index 
00000008) through buddy allocator.
W/Parcel  (  428): Attempt to read object from Parcel 0x48437dd8 at offset 636 
that is not in the object list
I/ActivityManager(  428): Starting activity: Intent { 
act=android.intent.action.MAIN flg=0x58000000 pkg=com.noshufou.android.su 
cmp=com.noshufou.android.su/.SuRequest (has extras) }
D/SuRequest(  754): Sending result: ALLOW
D/su      ( 1016): 10076 org.codeandroid.vpnc_frontend executing 0 sh using 
shell /system/bin/sh : sh
D/VPN_Connections(  997): filemanager: Done creating sym link /dev/net/tun with 
return code 0
E/linker  ( 1019): bionic/linker/linker.c:693| WARNING: `libicudata.so` is not 
a prelinked library
E/linker  ( 1019):  1019 mapping library 'libicudata.so' at 80000000 (index 
00000000) through buddy allocator.
E/linker  ( 1019): bionic/linker/linker.c:693| WARNING: `libjpeg.so` is not a 
prelinked library
E/linker  ( 1019):  1019 mapping library 'libjpeg.so' at 80800000 (index 
00000008) through buddy allocator.
D/NetworkLocationProvider(  428): onDataConnectionStateChanged 3
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for hipri
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for supl
D/MobileDataStateTracker(  428): default Received state= CONNECTED, old= 
CONNECTED, reason= (unspecified), apnTypeList= default,supl
W/Parcel  (  428): Attempt to read object from Parcel 0x44e8ddd8 at offset 636 
that is not in the object list
I/ActivityManager(  428): Starting activity: Intent { 
act=android.intent.action.MAIN flg=0x58000000 pkg=com.noshufou.android.su 
cmp=com.noshufou.android.su/.SuRequest (has extras) }
D/SuRequest(  754): Sending result: ALLOW
D/su      ( 1019): 10076 org.codeandroid.vpnc_frontend executing 0 sh using 
shell /system/bin/sh : sh
D/VPN_Connections(  997): filemanager: Done setting permission with return code 
0
D/VPN_Connections(  997): On Activity Result: resultcode 0
D/VPN_Connections(  997): NetworkDatabase:allNetworks - Start
D/VPN_Connections(  997): Preference Window: Creating new NetworkPreference
D/VPN_Connections(  997): Adding NetworkPreference with ID:1
I/ActivityManager(  428): Displayed activity 
org.codeandroid.vpnc_frontend/.VPNC: 5055 ms (total 2768 ms)
D/VPN_Connections(  997): long press handler, handling the choice
D/VPN_Connections(  997): NetworkDatabase:singleNetwork - Start
E/linker  ( 1024): bionic/linker/linker.c:693| WARNING: `libicudata.so` is not 
a prelinked library
E/linker  ( 1024):  1024 mapping library 'libicudata.so' at 80000000 (index 
00000000) through buddy allocator.
D/dalvikvm(  997): GC_FOR_MALLOC freed 4088 objects / 261872 bytes in 211ms
E/linker  ( 1024): bionic/linker/linker.c:693| WARNING: `libjpeg.so` is not a 
prelinked library
E/linker  ( 1024):  1024 mapping library 'libjpeg.so' at 80800000 (index 
00000008) through buddy allocator.
W/Parcel  (  428): Attempt to read object from Parcel 0x4a081dd8 at offset 636 
that is not in the object list
I/ActivityManager(  428): Starting activity: Intent { 
act=android.intent.action.MAIN flg=0x58000000 pkg=com.noshufou.android.su 
cmp=com.noshufou.android.su/.SuRequest (has extras) }
D/VPN_Connections(  997): Monitoring will not start
D/SuRequest(  754): Sending result: ALLOW
D/su      ( 1024): 10076 org.codeandroid.vpnc_frontend executing 0 sh using 
shell /system/bin/sh : sh
D/VPN_Connections(  997): Enter IPSec gateway address: 
D/VPN_Connections(  997): IP vpnendpoint.example.com
D/VPN_Connections(  997): Enter IPSec ID for vpnendpoint.example.com: 
D/VPN_Connections(  997): group id: groupid
D/VPN_Connections(  997): Enter IPSec secret for 
groupid@vpnendpoint.example.com: 
D/VPN_Connections(  997): group pwd grouppassword
D/VPN_Connections(  997): 
D/VPN_Connections(  997): Enter username for vpnendpoint.example.com: Enter 
password for @vpnendpoint.example.com: 
D/VPN_Connections(  997): user username
D/NetworkLocationProvider(  428): onDataConnectionStateChanged 3
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for hipri
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for supl
D/MobileDataStateTracker(  428): default Received state= CONNECTED, old= 
CONNECTED, reason= (unspecified), apnTypeList= default,supl
D/Tethering(  428): tun0 is not a tetherable iface, ignoring
D/dalvikvm(  506): GC_EXPLICIT freed 1499 objects / 80576 bytes in 129ms
D/NetworkLocationProvider(  428): onDataConnectionStateChanged 3
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for hipri
D/MobileDataStateTracker(  428): replacing old mInterfaceName (rmnet0) with 
rmnet0 for supl
D/MobileDataStateTracker(  428): default Received state= CONNECTED, old= 
CONNECTED, reason= (unspecified), apnTypeList= default,supl
D/dalvikvm(  754): GC_EXPLICIT freed 3057 objects / 189792 bytes in 111ms
D/dalvikvm(  567): GC_EXPLICIT freed 2432 objects / 116424 bytes in 141ms
D/dalvikvm(  868): GC_EXPLICIT freed 2967 objects / 133672 bytes in 117ms
I/dalvikvm(  997): Jit: resizing JitTable from 512 to 1024
I/power   (  428): *** set_screen_state 0
D/SurfaceFlinger(  428): About to give-up screen, flinger = 0x116bb8
D/VPN_Connections(  997): Monitoring will not start
D/AK8973  (   63): Compass CLOSE 
E/Tethering(  428): attempting to remove unknown iface (tun0), ignoring
D/StatusBar(  428): DISABLE_EXPAND: yes
D/GoogleLoginService(  567): onBind: Intent { 
act=android.accounts.AccountAuthenticator 
cmp=com.google.android.gsf/.loginservice.GoogleLoginService }
D/KeyguardViewMediator(  428): wakeWhenReadyLocked(6)
D/KeyguardViewMediator(  428): handleWakeWhenReady(6)
D/KeyguardViewMediator(  428): pokeWakelock(5000)
I/power   (  428): *** set_screen_state 1
D/AK8973  (   63): Compass Start
D/SurfaceFlinger(  428): Screen about to return, flinger = 0x116bb8
I/dalvikvm(  868): Jit: resizing JitTable from 512 to 1024
D/KeyguardViewMediator(  428): pokeWakelock(5000)
D/KeyguardViewMediator(  428): pokeWakelock(5000)
D/dalvikvm(  836): GC_EXPLICIT freed 151 objects / 7256 bytes in 121ms
D/dalvikvm(  868): GC_EXPLICIT freed 3029 objects / 137256 bytes in 127ms
D/dalvikvm(  428): GC_FOR_MALLOC freed 20298 objects / 994088 bytes in 266ms
I/power   (  428): *** set_screen_state 0
D/SurfaceFlinger(  428): About to give-up screen, flinger = 0x116bb8
D/VPN_Connections(  997): Monitoring will not start
D/AK8973  (   63): Compass CLOSE 
D/StatusBar(  428): DISABLE_EXPAND: yes
D/GoogleLoginService(  567): onBind: Intent { 
act=android.accounts.AccountAuthenticator 
cmp=com.google.android.gsf/.loginservice.GoogleLoginService }
D/dalvikvm(  567): GC_EXPLICIT freed 847 objects / 48488 bytes in 116ms
D/dalvikvm(  836): GC_EXPLICIT freed 33 objects / 1816 bytes in 102ms

Original issue reported on code.google.com by james.ho...@gmail.com on 22 Jul 2010 at 11:23

GoogleCodeExporter commented 9 years ago
Further to the above manually connecting to the vpn endpoint (with adb shell 
and ./vpnc --script ./vpnc-script --gateway vpnendpoint.example.com --id 
groupid --username username) works.... 

Looking at the logcat again looks like the password request screen doesn't 
appear when it should and hangs there...

Original comment by james.ho...@gmail.com on 22 Jul 2010 at 12:12

GoogleCodeExporter commented 9 years ago
Hmm... set up an eclipse environment with the ADT plugin and the SDKs to try 
and debug this with a checkout of the current source code...

First time I run the android application on the phone (no changes) and it 
behaves as expected with and without the rsa token option checked....

So I'm fine with my locally built version and have no idea why the .99 apk 
provided didn't work on my phone... unless the current source code in a current 
ADT environment with a current SDK (still targeted as API 3) differs somehow 
from the apk provided in the downloads...

Yay for a user being able to debug an app/phone without an expensive developer 
license?!

Original comment by james.ho...@gmail.com on 22 Jul 2010 at 2:20