schwabe / ics-openvpn

OpenVPN for Android
3.35k stars 1.2k forks source link

USR1 signal unknown to MGMT, no reconnect on network change #312

Closed GoogleCodeExporter closed 9 years ago

GoogleCodeExporter commented 9 years ago
What steps will reproduce the problem?
1.Change network (wifi to cellular and vice versa)
2.Failed USR1 signal, no reconnect
3.No data anymore

What is the expected output? What do you see instead?
Expect USR1 to trigger a reconnect over new network

What mobile phone are you using?
Samsung i9300
Which Android Version and stock ROM or aftermarket like cyanogenmod?
CM11-M11

See log below, thanks in advance!

Please provide any additional information below.
2014-12-21 09:25:44 Running on GT-I9300 (smdk4x12) samsung, Android API 19, 
version 0.6.26, official build
2014-12-21 09:26:34 Building configuration…
2014-12-21 09:26:36 started Socket Thread
2014-12-21 09:26:36 Network Status: CONNECTED  to WIFI "steadydecline"
2014-12-21 09:26:36 Current Parameter Settings:
2014-12-21 09:26:36   config = 
'/data/data/de.blinkt.openvpn/cache/android.conf'
2014-12-21 09:26:36   mode = 0
2014-12-21 09:26:36   show_ciphers = DISABLED
2014-12-21 09:26:36   show_digests = DISABLED
2014-12-21 09:26:36   show_engines = DISABLED
2014-12-21 09:26:36   genkey = DISABLED
2014-12-21 09:26:36   key_pass_file = '[UNDEF]'
2014-12-21 09:26:36   show_tls_ciphers = DISABLED
2014-12-21 09:26:36   connect_retry_max = 0
2014-12-21 09:26:36 Connection profiles [0]:
2014-12-21 09:26:36   proto = udp
2014-12-21 09:26:36   local = '[UNDEF]'
2014-12-21 09:26:36   local_port = '1194'
2014-12-21 09:26:36   remote = 'steadydecline.net'
2014-12-21 09:26:36   remote_port = '1194'
2014-12-21 09:26:36   remote_float = ENABLED
2014-12-21 09:26:36   bind_defined = DISABLED
2014-12-21 09:26:36   bind_local = ENABLED
2014-12-21 09:26:36   bind_ipv6_only = DISABLED
2014-12-21 09:26:36   connect_retry_seconds = 1
2014-12-21 09:26:36   connect_timeout = 10
2014-12-21 09:26:36   socks_proxy_server = '[UNDEF]'
2014-12-21 09:26:36   socks_proxy_port = '[UNDEF]'
2014-12-21 09:26:36   socks_proxy_retry = DISABLED
2014-12-21 09:26:36   tun_mtu = 1500
2014-12-21 09:26:36   tun_mtu_defined = ENABLED
2014-12-21 09:26:36   link_mtu = 1500
2014-12-21 09:26:36   link_mtu_defined = DISABLED
2014-12-21 09:26:36   tun_mtu_extra = 0
2014-12-21 09:26:36   tun_mtu_extra_defined = DISABLED
2014-12-21 09:26:36   mtu_discover_type = -1
2014-12-21 09:26:36   fragment = 0
2014-12-21 09:26:36   mssfix = 1450
2014-12-21 09:26:36   explicit_exit_notification = 0
2014-12-21 09:26:36 Connection profiles END
2014-12-21 09:26:36   remote_random = DISABLED
2014-12-21 09:26:36   ipchange = '[UNDEF]'
2014-12-21 09:26:36   dev = 'tun'
2014-12-21 09:26:36   dev_type = '[UNDEF]'
2014-12-21 09:26:36   dev_node = '[UNDEF]'
2014-12-21 09:26:36   lladdr = '[UNDEF]'
2014-12-21 09:26:36   topology = 1
2014-12-21 09:26:36   tun_ipv6 = DISABLED
2014-12-21 09:26:36   ifconfig_local = '[UNDEF]'
2014-12-21 09:26:36   ifconfig_remote_netmask = '[UNDEF]'
2014-12-21 09:26:36   ifconfig_noexec = DISABLED
2014-12-21 09:26:36   ifconfig_nowarn = ENABLED
2014-12-21 09:26:36   ifconfig_ipv6_local = '[UNDEF]'
2014-12-21 09:26:36   ifconfig_ipv6_netbits = 0
2014-12-21 09:26:36   ifconfig_ipv6_remote = '[UNDEF]'
2014-12-21 09:26:36   shaper = 0
2014-12-21 09:26:36   mtu_test = 0
2014-12-21 09:26:36   mlock = DISABLED
2014-12-21 09:26:36   keepalive_ping = 0
2014-12-21 09:26:36   keepalive_timeout = 0
2014-12-21 09:26:36   inactivity_timeout = 0
2014-12-21 09:26:36   ping_send_timeout = 0
2014-12-21 09:26:36   ping_rec_timeout = 0
2014-12-21 09:26:36   ping_rec_timeout_action = 0
2014-12-21 09:26:36   ping_timer_remote = DISABLED
2014-12-21 09:26:36   remap_sigusr1 = 0
2014-12-21 09:26:36   persist_tun = ENABLED
2014-12-21 09:26:36   persist_local_ip = DISABLED
2014-12-21 09:26:36   persist_remote_ip = DISABLED
2014-12-21 09:26:36   persist_key = DISABLED
2014-12-21 09:26:36   passtos = DISABLED
2014-12-21 09:26:36   resolve_retry_seconds = 60
2014-12-21 09:26:36   resolve_in_advance = ENABLED
2014-12-21 09:26:36   username = '[UNDEF]'
2014-12-21 09:26:36   groupname = '[UNDEF]'
2014-12-21 09:26:36   chroot_dir = '[UNDEF]'
2014-12-21 09:26:36   cd_dir = '[UNDEF]'
2014-12-21 09:26:36   writepid = '[UNDEF]'
2014-12-21 09:26:36   up_script = '[UNDEF]'
2014-12-21 09:26:36   down_script = '[UNDEF]'
2014-12-21 09:26:36   down_pre = DISABLED
2014-12-21 09:26:36   up_restart = DISABLED
2014-12-21 09:26:36   up_delay = DISABLED
2014-12-21 09:26:36   daemon = DISABLED
2014-12-21 09:26:36   inetd = 0
2014-12-21 09:26:36   log = DISABLED
2014-12-21 09:26:36   suppress_timestamps = DISABLED
2014-12-21 09:26:36   machine_readable_output = ENABLED
2014-12-21 09:26:36   nice = 0
2014-12-21 09:26:36   verbosity = 4
2014-12-21 09:26:36   mute = 0
2014-12-21 09:26:36   gremlin = 0
2014-12-21 09:26:36   status_file = '[UNDEF]'
2014-12-21 09:26:36   status_file_version = 1
2014-12-21 09:26:36   status_file_update_freq = 60
2014-12-21 09:26:36   occ = ENABLED
2014-12-21 09:26:36   rcvbuf = 65536
2014-12-21 09:26:36   sndbuf = 65536
2014-12-21 09:26:36   sockflags = 0
2014-12-21 09:26:36   fast_io = DISABLED
2014-12-21 09:26:36   comp.alg = 2
2014-12-21 09:26:36   comp.flags = 1
2014-12-21 09:26:36   route_script = '[UNDEF]'
2014-12-21 09:26:36   route_default_gateway = '[UNDEF]'
2014-12-21 09:26:36   route_default_metric = 0
2014-12-21 09:26:36   route_noexec = DISABLED
2014-12-21 09:26:36   route_delay = 0
2014-12-21 09:26:36   route_delay_window = 30
2014-12-21 09:26:36   route_delay_defined = DISABLED
2014-12-21 09:26:36   route_nopull = DISABLED
2014-12-21 09:26:36   route_gateway_via_dhcp = DISABLED
2014-12-21 09:26:36   allow_pull_fqdn = DISABLED
2014-12-21 09:26:36   route 0.0.0.0/0.0.0.0/vpn_gateway/nil
2014-12-21 09:26:36   management_addr = 
'/data/data/de.blinkt.openvpn/cache/mgmtsocket'
2014-12-21 09:26:36   management_port = 'unix'
2014-12-21 09:26:36   management_user_pass = '[UNDEF]'
2014-12-21 09:26:36   management_log_history_cache = 250
2014-12-21 09:26:36   management_echo_buffer_size = 100
2014-12-21 09:26:36   management_write_peer_info_file = '[UNDEF]'
2014-12-21 09:26:36   management_client_user = '[UNDEF]'
2014-12-21 09:26:36   management_client_group = '[UNDEF]'
2014-12-21 09:26:36   management_flags = 294
2014-12-21 09:26:36   shared_secret_file = '[UNDEF]'
2014-12-21 09:26:36   key_direction = 0
2014-12-21 09:26:36   ciphername_defined = ENABLED
2014-12-21 09:26:36   ciphername = 'BF-CBC'
2014-12-21 09:26:36   authname_defined = ENABLED
2014-12-21 09:26:36   authname = 'SHA1'
2014-12-21 09:26:36   prng_hash = 'SHA1'
2014-12-21 09:26:36   prng_nonce_secret_len = 16
2014-12-21 09:26:36   keysize = 0
2014-12-21 09:26:36   engine = DISABLED
2014-12-21 09:26:36   replay = ENABLED
2014-12-21 09:26:36   mute_replay_warnings = DISABLED
2014-12-21 09:26:36   replay_window = 64
2014-12-21 09:26:36   replay_time = 15
2014-12-21 09:26:36   packet_id_file = '[UNDEF]'
2014-12-21 09:26:36   use_iv = ENABLED
2014-12-21 09:26:36   test_crypto = DISABLED
2014-12-21 09:26:36   tls_server = DISABLED
2014-12-21 09:26:36   tls_client = ENABLED
2014-12-21 09:26:36   key_method = 2
2014-12-21 09:26:36   ca_file = '[[INLINE]]'
2014-12-21 09:26:36   ca_path = '[UNDEF]'
2014-12-21 09:26:36   dh_file = '[UNDEF]'
2014-12-21 09:26:36   cert_file = '[[INLINE]]'
2014-12-21 09:26:36   priv_key_file = '[[INLINE]]'
2014-12-21 09:26:36   pkcs12_file = '[UNDEF]'
2014-12-21 09:26:36   cipher_list = '[UNDEF]'
2014-12-21 09:26:36   tls_verify = '[UNDEF]'
2014-12-21 09:26:36   tls_export_cert = '[UNDEF]'
2014-12-21 09:26:36   verify_x509_type = 0
2014-12-21 09:26:36   verify_x509_name = '[UNDEF]'
2014-12-21 09:26:36   crl_file = '[UNDEF]'
2014-12-21 09:26:36   ns_cert_type = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 160
2014-12-21 09:26:36   remote_cert_ku[i] = 136
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_ku[i] = 0
2014-12-21 09:26:36   remote_cert_eku = 'TLS Web Server Authentication'
2014-12-21 09:26:36   ssl_flags = 0
2014-12-21 09:26:36   tls_timeout = 2
2014-12-21 09:26:36   renegotiate_bytes = 0
2014-12-21 09:26:36   renegotiate_packets = 0
2014-12-21 09:26:36   renegotiate_seconds = 3600
2014-12-21 09:26:36   handshake_window = 60
2014-12-21 09:26:36   transition_window = 3600
2014-12-21 09:26:36   single_session = DISABLED
2014-12-21 09:26:36   push_peer_info = DISABLED
2014-12-21 09:26:36   tls_exit = DISABLED
2014-12-21 09:26:36   tls_auth_file = '[UNDEF]'
2014-12-21 09:26:36   client = ENABLED
2014-12-21 09:26:36   pull = ENABLED
2014-12-21 09:26:36   auth_user_pass_file = '[UNDEF]'
2014-12-21 09:26:36 OpenVPN 2.4-icsopenvpn 
[git:icsopenvpn_625-af9eb9424047f9f5] android-14-armeabi-v7a [SSL (OpenSSL)] 
[LZO] [SNAPPY] [LZ4] [EPOLL] [MH] [IPv6] built on Dec 15 2014
2014-12-21 09:26:36 library versions: OpenSSL 1.0.1j 15 Oct 2014, LZO 2.07
2014-12-21 09:26:36 MANAGEMENT: Connected to management server at 
/data/data/de.blinkt.openvpn/cache/mgmtsocket
2014-12-21 09:26:36 MANAGEMENT: CMD 'hold release'
2014-12-21 09:26:36 LZO compression initializing
2014-12-21 09:26:36 Control Channel MTU parms [ L:1542 D:138 EF:38 EB:0 ET:0 
EL:0 ]
2014-12-21 09:26:36 Data Channel MTU parms [ L:1542 D:1450 EF:42 EB:393 ET:0 
EL:0 ]
2014-12-21 09:26:36 Local Options String: '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'
2014-12-21 09:26:36 Expected Remote Options String: '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'
2014-12-21 09:26:36 Local Options hash (VER=V4): '41690919'
2014-12-21 09:26:36 Expected Remote Options hash (VER=V4): '530fdded'
2014-12-21 09:26:36 TCP/UDP: Preserving recently used remote address: 
[AF_INET]192.168.2.1:1194
2014-12-21 09:26:36 Socket Buffers: R=[112640->131072] S=[112640->131072]
2014-12-21 09:26:36 Protecting socket fd 4
2014-12-21 09:26:36 MANAGEMENT: CMD 'bytecount 2'
2014-12-21 09:26:36 MANAGEMENT: CMD 'state on'
2014-12-21 09:26:36 MANAGEMENT: CMD 'needok 'PROTECTFD' ok'
2014-12-21 09:26:36 UDP link local (bound): [AF_INET][undef]:1194
2014-12-21 09:26:36 UDP link remote: [AF_INET]192.168.2.1:1194
2014-12-21 09:26:36 MANAGEMENT: >STATE:1419150396,WAIT,,,
2014-12-21 09:26:36 MANAGEMENT: >STATE:1419150396,AUTH,,,
2014-12-21 09:26:36 TLS: Initial packet from [AF_INET]192.168.3.1:1194, 
sid=d1e3b371 ddfd7edd
2014-12-21 09:26:36 VERIFY OK: ***
2014-12-21 09:26:36 Validating certificate key usage
2014-12-21 09:26:36 ++ Certificate has key usage  00a0, expects 00a0
2014-12-21 09:26:36 VERIFY KU OK
2014-12-21 09:26:36 Validating certificate extended key usage
2014-12-21 09:26:36 ++ Certificate has EKU (str) TLS Web Server Authentication, 
expects TLS Web Server Authentication
2014-12-21 09:26:36 VERIFY EKU OK
2014-12-21 09:26:36 VERIFY OK: ***
2014-12-21 09:26:36 Data Channel Encrypt: Cipher 'BF-CBC' initialized with 128 
bit key
2014-12-21 09:26:36 Data Channel Encrypt: Using 160 bit message hash 'SHA1' for 
HMAC authentication
2014-12-21 09:26:36 Data Channel Decrypt: Cipher 'BF-CBC' initialized with 128 
bit key
2014-12-21 09:26:36 Data Channel Decrypt: Using 160 bit message hash 'SHA1' for 
HMAC authentication
2014-12-21 09:26:36 Control Channel: TLSv1, cipher TLSv1/SSLv3 
DHE-RSA-AES256-SHA, 1024 bit RSA
2014-12-21 09:26:36 [steady] Peer Connection Initiated with 
[AF_INET]192.168.3.1:1194
2014-12-21 09:26:37 MANAGEMENT: >STATE:1419150397,GET_CONFIG,,,
2014-12-21 09:26:39 SENT CONTROL [steady]: 'PUSH_REQUEST' (status=1)
2014-12-21 09:26:39 PUSH: Received control message: 'PUSH_REPLY,route 
192.168.4.1 255.255.255.255,route 192.168.2.0 255.255.255.0,route 192.168.3.0 
255.255.255.0,redirect-gateway def1 bypass-dhcp,dhcp-option DOMAIN 
***,dhcp-option DNS 192.168.2.1,dhcp-option WINS 192.168.2.1,comp-lzo yes,ping 
1800,ping-restart 3600,ifconfig 192.168.4.6 192.168.4.5'
2014-12-21 09:26:39 OPTIONS IMPORT: timers and/or timeouts modified
2014-12-21 09:26:39 OPTIONS IMPORT: compression parms modified
2014-12-21 09:26:39 LZO compression initializing
2014-12-21 09:26:39 OPTIONS IMPORT: --ifconfig/up options modified
2014-12-21 09:26:39 OPTIONS IMPORT: route options modified
2014-12-21 09:26:39 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options 
modified
2014-12-21 09:26:39 ROUTE_GATEWAY 127.100.103.119/255.0.0.0 IFACE=lo 
HWADDR=00:00:00:00:00:00
2014-12-21 09:26:39 ROUTE6: default_gateway=UNDEF
2014-12-21 09:26:39 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
2014-12-21 09:26:39 OpenVPN ROUTE: failed to parse/resolve route for 
host/network: ::/0
2014-12-21 09:26:39 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0
2014-12-21 09:26:39 MANAGEMENT: >STATE:1419150399,ASSIGN_IP,,192.168.4.6,
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'IFCONFIG' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2014-12-21 09:26:39 MANAGEMENT: >STATE:1419150399,ADD_ROUTES,,,
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'ROUTE' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'DNSSERVER' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'DNSDOMAIN' ok'
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'PERSIST_TUN_ACTION' 
OPEN_BEFORE_CLOSE'
2014-12-21 09:26:39 Opening tun interface:
2014-12-21 09:26:39 Local IPv4: 192.168.4.6/30 IPv6: null MTU: 1500
2014-12-21 09:26:39 DNS Server: 192.168.2.1, Domain: ***
2014-12-21 09:26:39 Routes: 0.0.0.0/0, 192.168.2.0/24, 192.168.3.0/24, 
192.168.4.1/32 
2014-12-21 09:26:39 Routes excluded:  
2014-12-21 09:26:39 VpnService routes installed: 0.0.0.0/0 
2014-12-21 09:26:39 MANAGEMENT: CMD 'needok 'OPENTUN' ok'
2014-12-21 09:26:39 Initialization Sequence Completed
2014-12-21 09:26:39 MANAGEMENT: 
>STATE:1419150399,CONNECTED,SUCCESS,192.168.4.6,192.168.3.1
2014-12-21 09:34:32 Network Status: CONNECTED HSPA+ to mobile internet
2014-12-21 09:34:32 MANAGEMENT: CMD 'network-change'
2014-12-21 09:34:32 MGMT: Got unrecognized line from management:ERROR: signal 
'USR1' is not a known signal type

Original issue reported on code.google.com by bas.huls...@gmail.com on 21 Dec 2014 at 10:21

GoogleCodeExporter commented 9 years ago
I see the same on CM11, OnePlusOne. Latest version from f-droid. No gapps.

Original comment by lar...@gmail.com on 21 Jan 2015 at 9:41

GoogleCodeExporter commented 9 years ago
This issue was closed by revision f6ba4eefa427.

Original comment by arne@rfc2549.org on 27 Jan 2015 at 2:25