schwabe / ics-openvpn

OpenVPN for Android
3.34k stars 1.2k forks source link

Error: Android establish() method returned null #368

Closed yoni1234 closed 9 years ago

yoni1234 commented 9 years ago

2015-06-30 10:20:35 Running on SM-G900F (MSM8974) samsung, Android API 21, version 0.6.30, official build 2015-06-30 10:20:35 Building configuration… 2015-06-30 10:20:37 started Socket Thread 2015-06-30 10:20:37 Network Status: CONNECTED to WIFI "_" 2015-06-30 10:20:37 Current Parameter Settings: 2015-06-30 10:20:37 config = '/data/data/de.blinkt.openvpn/cache/android.conf' 2015-06-30 10:20:37 mode = 0 2015-06-30 10:20:37 show_ciphers = DISABLED 2015-06-30 10:20:37 show_digests = DISABLED 2015-06-30 10:20:37 show_engines = DISABLED 2015-06-30 10:20:37 genkey = DISABLED 2015-06-30 10:20:37 key_pass_file = '[UNDEF]' 2015-06-30 10:20:37 show_tls_ciphers = DISABLED 2015-06-30 10:20:37 connect_retry_max = 5 2015-06-30 10:20:37 Connection profiles [0]: 2015-06-30 10:20:37 proto = udp 2015-06-30 10:20:37 local = '[UNDEF]' 2015-06-30 10:20:37 local_port = '1194' 2015-06-30 10:20:37 remote = '**' 2015-06-30 10:20:37 remote_port = '1194' 2015-06-30 10:20:37 remote_float = DISABLED 2015-06-30 10:20:37 bind_defined = DISABLED 2015-06-30 10:20:37 bind_local = ENABLED 2015-06-30 10:20:37 bind_ipv6_only = DISABLED 2015-06-30 10:20:37 connect_retry_seconds = 5 2015-06-30 10:20:37 connect_timeout = 10 2015-06-30 10:20:37 socks_proxy_server = '[UNDEF]' 2015-06-30 10:20:37 socks_proxy_port = '[UNDEF]' 2015-06-30 10:20:37 socks_proxy_retry = DISABLED 2015-06-30 10:20:37 tun_mtu = 1500 2015-06-30 10:20:37 tun_mtu_defined = ENABLED 2015-06-30 10:20:37 link_mtu = 1500 2015-06-30 10:20:37 link_mtu_defined = DISABLED 2015-06-30 10:20:37 tun_mtu_extra = 0 2015-06-30 10:20:37 tun_mtu_extra_defined = DISABLED 2015-06-30 10:20:37 mtu_discover_type = -1 2015-06-30 10:20:37 fragment = 0 2015-06-30 10:20:37 mssfix = 1450 2015-06-30 10:20:37 explicit_exit_notification = 0 2015-06-30 10:20:37 Connection profiles END 2015-06-30 10:20:37 remote_random = DISABLED 2015-06-30 10:20:37 ipchange = '[UNDEF]' 2015-06-30 10:20:37 dev = 'tun' 2015-06-30 10:20:37 dev_type = '[UNDEF]' 2015-06-30 10:20:37 dev_node = '[UNDEF]' 2015-06-30 10:20:37 lladdr = '[UNDEF]' 2015-06-30 10:20:37 topology = 1 2015-06-30 10:20:37 tun_ipv6 = DISABLED 2015-06-30 10:20:37 ifconfig_local = '[UNDEF]' 2015-06-30 10:20:37 ifconfig_remote_netmask = '[UNDEF]' 2015-06-30 10:20:37 ifconfig_noexec = DISABLED 2015-06-30 10:20:37 ifconfig_nowarn = ENABLED 2015-06-30 10:20:37 ifconfig_ipv6_local = '[UNDEF]' 2015-06-30 10:20:37 ifconfig_ipv6_netbits = 0 2015-06-30 10:20:37 ifconfig_ipv6_remote = '[UNDEF]' 2015-06-30 10:20:37 shaper = 0 2015-06-30 10:20:37 mtu_test = 0 2015-06-30 10:20:37 mlock = DISABLED 2015-06-30 10:20:37 keepalive_ping = 0 2015-06-30 10:20:37 keepalive_timeout = 0 2015-06-30 10:20:37 inactivity_timeout = 0 2015-06-30 10:20:37 ping_send_timeout = 0 2015-06-30 10:20:37 ping_rec_timeout = 0 2015-06-30 10:20:37 ping_rec_timeout_action = 0 2015-06-30 10:20:37 ping_timer_remote = DISABLED 2015-06-30 10:20:37 remap_sigusr1 = 0 2015-06-30 10:20:37 persist_tun = DISABLED 2015-06-30 10:20:37 persist_local_ip = DISABLED 2015-06-30 10:20:37 persist_remote_ip = DISABLED 2015-06-30 10:20:37 persist_key = DISABLED 2015-06-30 10:20:37 passtos = DISABLED 2015-06-30 10:20:37 resolve_retry_seconds = 60 2015-06-30 10:20:37 resolve_in_advance = DISABLED 2015-06-30 10:20:37 username = '[UNDEF]' 2015-06-30 10:20:37 groupname = '[UNDEF]' 2015-06-30 10:20:37 chroot_dir = '[UNDEF]' 2015-06-30 10:20:37 cd_dir = '[UNDEF]' 2015-06-30 10:20:37 writepid = '[UNDEF]' 2015-06-30 10:20:37 up_script = '[UNDEF]' 2015-06-30 10:20:37 down_script = '[UNDEF]' 2015-06-30 10:20:37 down_pre = DISABLED 2015-06-30 10:20:37 up_restart = DISABLED 2015-06-30 10:20:37 up_delay = DISABLED 2015-06-30 10:20:37 daemon = DISABLED 2015-06-30 10:20:37 inetd = 0 2015-06-30 10:20:37 log = DISABLED 2015-06-30 10:20:37 suppress_timestamps = DISABLED 2015-06-30 10:20:37 machine_readable_output = ENABLED 2015-06-30 10:20:37 nice = 0 2015-06-30 10:20:37 verbosity = 4 2015-06-30 10:20:37 mute = 0 2015-06-30 10:20:37 gremlin = 0 2015-06-30 10:20:37 status_file = '[UNDEF]' 2015-06-30 10:20:37 status_file_version = 1 2015-06-30 10:20:37 status_file_update_freq = 60 2015-06-30 10:20:37 occ = ENABLED 2015-06-30 10:20:37 rcvbuf = 65536 2015-06-30 10:20:37 sndbuf = 65536 2015-06-30 10:20:37 sockflags = 0 2015-06-30 10:20:37 fast_io = DISABLED 2015-06-30 10:20:37 comp.alg = 2 2015-06-30 10:20:37 comp.flags = 1 2015-06-30 10:20:37 route_script = '[UNDEF]' 2015-06-30 10:20:37 route_default_gateway = '[UNDEF]' 2015-06-30 10:20:37 route_default_metric = 0 2015-06-30 10:20:37 route_noexec = DISABLED 2015-06-30 10:20:37 route_delay = 0 2015-06-30 10:20:37 route_delay_window = 30 2015-06-30 10:20:37 route_delay_defined = DISABLED 2015-06-30 10:20:37 route_nopull = DISABLED 2015-06-30 10:20:37 route_gateway_via_dhcp = DISABLED 2015-06-30 10:20:37 allow_pull_fqdn = DISABLED 2015-06-30 10:20:37 route 0.0.0.0/0.0.0.0/vpn_gateway/nil 2015-06-30 10:20:37 management_addr = '/data/data/de.blinkt.openvpn/cache/mgmtsocket' 2015-06-30 10:20:37 management_port = 'unix' 2015-06-30 10:20:37 management_user_pass = '[UNDEF]' 2015-06-30 10:20:37 management_log_history_cache = 250 2015-06-30 10:20:37 management_echo_buffer_size = 100 2015-06-30 10:20:37 management_write_peer_info_file = '[UNDEF]' 2015-06-30 10:20:37 management_client_user = '[UNDEF]' 2015-06-30 10:20:37 management_client_group = '[UNDEF]' 2015-06-30 10:20:37 management_flags = 4390 2015-06-30 10:20:37 shared_secret_file = '[UNDEF]' 2015-06-30 10:20:37 key_direction = 0 2015-06-30 10:20:37 ciphername_defined = ENABLED 2015-06-30 10:20:37 ciphername = 'BF-CBC' 2015-06-30 10:20:37 authname_defined = ENABLED 2015-06-30 10:20:37 authname = 'SHA1' 2015-06-30 10:20:37 prng_hash = 'SHA1' 2015-06-30 10:20:37 prng_nonce_secret_len = 16 2015-06-30 10:20:37 keysize = 0 2015-06-30 10:20:37 engine = DISABLED 2015-06-30 10:20:37 replay = ENABLED 2015-06-30 10:20:37 mute_replay_warnings = DISABLED 2015-06-30 10:20:37 replay_window = 64 2015-06-30 10:20:37 replay_time = 15 2015-06-30 10:20:37 packet_id_file = '[UNDEF]' 2015-06-30 10:20:37 use_iv = ENABLED 2015-06-30 10:20:37 test_crypto = DISABLED 2015-06-30 10:20:37 tls_server = DISABLED 2015-06-30 10:20:37 tls_client = ENABLED 2015-06-30 10:20:37 key_method = 2 2015-06-30 10:20:37 ca_file = '[[INLINE]]' 2015-06-30 10:20:37 ca_path = '[UNDEF]' 2015-06-30 10:20:37 dh_file = '[UNDEF]' 2015-06-30 10:20:37 cert_file = '[[INLINE]]' 2015-06-30 10:20:37 priv_key_file = '[[INLINE]]' 2015-06-30 10:20:37 pkcs12_file = '[UNDEF]' 2015-06-30 10:20:37 cipher_list = '[UNDEF]' 2015-06-30 10:20:37 tls_verify = '[UNDEF]' 2015-06-30 10:20:37 tls_export_cert = '[UNDEF]' 2015-06-30 10:20:37 verify_x509_type = 0 2015-06-30 10:20:37 verify_x509_name = '[UNDEF]' 2015-06-30 10:20:37 crl_file = '[UNDEF]' 2015-06-30 10:20:37 ns_cert_type = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_ku[i] = 0 2015-06-30 10:20:37 remote_cert_eku = '[UNDEF]' 2015-06-30 10:20:37 ssl_flags = 0 2015-06-30 10:20:37 tls_timeout = 2 2015-06-30 10:20:37 renegotiate_bytes = 0 2015-06-30 10:20:37 renegotiate_packets = 0 2015-06-30 10:20:37 renegotiate_seconds = 3600 2015-06-30 10:20:37 handshake_window = 60 2015-06-30 10:20:37 transition_window = 3600 2015-06-30 10:20:37 single_session = DISABLED 2015-06-30 10:20:37 push_peer_info = DISABLED 2015-06-30 10:20:37 tls_exit = DISABLED 2015-06-30 10:20:37 tls_auth_file = '[UNDEF]' 2015-06-30 10:20:37 client = ENABLED 2015-06-30 10:20:37 pull = ENABLED 2015-06-30 10:20:37 auth_user_pass_file = '[UNDEF]' 2015-06-30 10:20:37 OpenVPN 2.4-icsopenvpn [git:icsopenvpn_630-c9b2b7dc10e7781d] android-14-armeabi-v7a [SSL (OpenSSL)] [LZO] [SNAPPY] [LZ4] [EPOLL] [MH] [IPv6] built on Jun 7 2015 2015-06-30 10:20:37 library versions: OpenSSL 1.0.1l 15 Jan 2015, LZO 2.07 2015-06-30 10:20:37 MANAGEMENT: Connected to management server at /data/data/de.blinkt.openvpn/cache/mgmtsocket 2015-06-30 10:20:37 MANAGEMENT: CMD 'hold release' 2015-06-30 10:20:37 MANAGEMENT: CMD 'bytecount 2' 2015-06-30 10:20:37 MANAGEMENT: CMD 'state on' 2015-06-30 10:20:37 MANAGEMENT: CMD 'proxy NONE' 2015-06-30 10:20:38 WARNING: No server certificate verification method has been enabled. See http://openvpn.net/howto.html#mitm for more info. 2015-06-30 10:20:38 LZO compression initializing 2015-06-30 10:20:38 Control Channel MTU parms [ L:1542 D:138 EF:38 EB:0 ET:0 EL:3 ] 2015-06-30 10:20:38 MANAGEMENT: >STATE:1435648838,RESOLVE,,, 2015-06-30 10:20:38 Data Channel MTU parms [ L:1542 D:1450 EF:42 EB:393 ET:0 EL:3 ] 2015-06-30 10:20:38 Local Options String (VER=V4): 'V4,dev-type tun,link-mtu 1542,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA1,keysize 128,key-method 2,tls-client' 2015-06-30 10:20:38 Expected Remote Options String (VER=V4): 'V4,dev-type tun,link-mtu 1542,tun-mtu 1500,proto UDPv4,comp-lzo,cipher BF-CBC,auth SHA1,keysize 128,key-method 2,tls-server' 2015-06-30 10:20:38 TCP/UDP: Preserving recently used remote address: [AFINET]**_:1194 2015-06-30 10:20:38 Socket Buffers: R=[163840->131072] S=[163840->131072] 2015-06-30 10:20:38 Protecting socket fd 4 2015-06-30 10:20:38 Could not protect VPN socket 2015-06-30 10:20:38 MANAGEMENT: CMD 'needok 'PROTECTFD' ok' 2015-06-30 10:20:38 UDP link local (bound): [AF_INET][undef]:1194 2015-06-30 10:20:38 UDP link remote: [AF_INET]**:1194 2015-06-30 10:20:38 MANAGEMENT: >STATE:1435648838,WAIT,,, 2015-06-30 10:20:38 MANAGEMENT: >STATE:1435648838,AUTH,,, 2015-06-30 10:20:38 TLS: Initial packet from [AFINET]**_:1194, sid=c25f469c 3563133d 2015-06-30 10:20:39 VERIFY OK: depth=1, C=US, ST=CA, L=SanFrancisco, O=Fort-Funston, OU=changeme1, CN=changeme1, name=changeme1, emailAddress=mail@host.domain1 2015-06-30 10:20:39 VERIFY OK: depth=0, C=US, ST=CA, L=SanFrancisco, O=Fort-Funston, OU=changeme1, CN=server, name=changeme1, emailAddress=mail@host.domain1 2015-06-30 10:20:40 Data Channel Encrypt: Cipher 'BF-CBC' initialized with 128 bit key 2015-06-30 10:20:40 Data Channel Encrypt: Using 160 bit message hash 'SHA1' for HMAC authentication 2015-06-30 10:20:40 Data Channel Decrypt: Cipher 'BF-CBC' initialized with 128 bit key 2015-06-30 10:20:40 Data Channel Decrypt: Using 160 bit message hash 'SHA1' for HMAC authentication 2015-06-30 10:20:40 Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA, 1024 bit RSA 2015-06-30 10:20:40 [server] Peer Connection Initiated with [AF_INET]_:1194 2015-06-30 10:20:41 MANAGEMENT: >STATE:1435648841,GET_CONFIG,,, 2015-06-30 10:20:42 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1) 2015-06-30 10:20:42 PUSH: Received control message: 'PUSH_REPLY,redirect-gateway def1 bypass-dhcp,dhcp-option DNS 8.8.8.8,dhcp-option DNS 8.8.4.4,route 10.8.0.1,topology net30,ping 10,ping-restart 120,ifconfig 10.8.0.42 10.8.0.41' 2015-06-30 10:20:42 OPTIONS IMPORT: timers and/or timeouts modified 2015-06-30 10:20:42 OPTIONS IMPORT: --ifconfig/up options modified 2015-06-30 10:20:42 OPTIONS IMPORT: route options modified 2015-06-30 10:20:42 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified 2015-06-30 10:20:42 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo HWADDR=00:00:00:00:00:00 2015-06-30 10:20:42 ROUTE6: default_gateway=UNDEF 2015-06-30 10:20:42 OpenVPN ROUTE6: OpenVPN needs a gateway parameter for a --route-ipv6 option and no default was specified by either --route-ipv6-gateway or --ifconfig-ipv6 options 2015-06-30 10:20:42 OpenVPN ROUTE: failed to parse/resolve route for host/network: ::/0 2015-06-30 10:20:42 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0 2015-06-30 10:20:42 MANAGEMENT: >STATE:1435648842,ASSIGN_IP,,10.8.0.42, 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'IFCONFIG' ok' 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'ROUTE' ok' 2015-06-30 10:20:42 MANAGEMENT: >STATE:1435648842,ADD_ROUTES,,, 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'ROUTE' ok' 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'ROUTE' ok' 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'DNSSERVER' ok' 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'DNSSERVER' ok' 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'PERSIST_TUN_ACTION' OPEN_BEFORE_CLOSE' 2015-06-30 10:20:42 Opening tun interface: 2015-06-30 10:20:42 Local IPv4: 10.8.0.42/30 IPv6: null MTU: 1500 2015-06-30 10:20:42 DNS Server: 8.8.8.8, 8.8.4.4, Domain: null 2015-06-30 10:20:42 Routes: 0.0.0.0/0, 10.8.0.1/32, 10.8.0.40/30 2015-06-30 10:20:42 Routes excluded:
2015-06-30 10:20:42 VpnService routes installed: 0.0.0.0/0 2015-06-30 10:20:42 Disallowed VPN apps: 2015-06-30 10:20:42 Failed to open the tun interface 2015-06-30 10:20:42 Error: Android establish() method returned null (Really broken network configuration?) 2015-06-30 10:20:42 MANAGEMENT: CMD 'needok 'OPENTUN' cancel' 2015-06-30 10:20:42 MGMT: Got unrecognized command>FATAL:ERROR: Cannot open TUN 2015-06-30 10:20:43 MANAGEMENT: Client disconnected 2015-06-30 10:20:43 ERROR: Cannot open TUN 2015-06-30 10:20:43 Exiting due to fatal error 2015-06-30 10:20:43 Process exited with exit value 1

what could i done to resolve that? Thanks!

schwabe commented 9 years ago

first try to reboot your phone. If that does not help try looking through adb logcat if there are any warnings/errors in there.

yoni1234 commented 9 years ago

Can i fix this issue without reboot?

Again, thank you very much.

schwabe commented 9 years ago

If a reboot fixes that issue, then there is probably something broken in your ROM. See logcat. OpenVPN for Android can probably do not do anything about it. But the messages in adb logcat may give a hint what is really going on.