OpenVPN funktioniert nicht mehr

H8Ball · Beitrag von **H8Ball** » 07.08.2015 14:46:18

Hallo zusammen.

An meinem Server kommt es mir vor als wäre er faul wegen der Hitze.

Es läuft ein Openvpn-Server der auch die ganze Zeit tadelos seinen Dienst gemacht hat. Aber seit neuestem nimmt er keine Verbindungen mehr an.

Nach dem ich durch die Rettungskonsole mein SSH wieder für die Außenwelt offen hatte, konnte ich das Problem auch mal genauer betrachten.

Also:

mit

Code: Alles auswählen

openvpn server.conf

startet der Server ohne Fehlermeldungen.
Er zeigt aber auch keine Verbindungsversuche oder Fehlermeldungen beim Verbinden.
Ich habe noch einen Client eingrichtet, der funktioniert ohne Probleme.

Auch das erstellen einer neuen Konfiguration hat nichts geholfen.

Dann hatte ich die Firewall vom Hoster oder die meines Servers im Auge. Ich habe mit tcpdump am Server gelauscht, und die Pakete von meinem Client kommen am Server an, tcpdump meldet mir auch dass keines der Pakete vom Kernel gedropt wurde.

Aber es kommt einfach keine Verbindung mehr zu Stande.

netstat zeigt auch das der Port vom VPN-Dienst genutzt wird.

Als letztes habe ich per apt-get remove, apt-get clean und apt-get install openvpn neu installiert, aber auch das bringt keinen Erfolg.

Hat jemand schon mal so ein ähnliches Problem gehabt und kann mir helfen?

Schönen Tag wünsche ich euch.

Daniel

gbotti · Beitrag von **gbotti** » 07.08.2015 15:03:15

Hi.

Naja... Ähnliche Probleme ja, aber da war eine der beiden Konfigurationen für Client und Server schuld. Hast du auch schon mal die Gegenstelle neu gestartet?

Wurde irgendwo ein Update eingespielt?

Ohne Logfiles ist das echt eigentlich garnicht zu debuggen. Wie sieht denn die Config aus?

orcape · Beitrag von **orcape** » 07.08.2015 16:15:37

Hi,
wie ist denn Dein Netz aufgebaut ?
Was für Software/Hardware verwendest Du für Server und Client ?
Wie sehen die Configs aus ?
Was gibt die Konsole aus, wenn Du den Tunnel am Client händisch startest ?
Hast Du eine feste IP vom Provider oder läuft das per DynDNS ?

Dann hatte ich die Firewall vom Hoster oder die meines Servers im Auge.

Was hat die Firewall Deines Hosters denn mit Deinem VPN-Tunnel zu tun ?
Du siehst also, Fragen über Fragen. Du hast zwar viel geschrieben, uns aber nicht wirklich etwas erzählt, womit wir Dir weiterhelfen könnten.
Gruß orcape

eggy · Beitrag von **eggy** » 07.08.2015 17:25:43

Inkompatible Client/Serverversionen? Scriptsecuritylevel falsch? Routen kaputt? Berechtigungen auf den Configs/Keys falsch? Tun/Tap nicht geladen Firewall auf Clientseite? Firewall blockt ausgehende Pakete. Glaskugel nicht geputzt?
Sowohl Client als auch Server von der Console starten.
Logging auf beiden Seiten schrittweise hochdrehen.
Tcpdump auf beiden Seiten mitlaufen lassen.

H8Ball · Beitrag von **H8Ball** » 08.08.2015 17:13:32

Die Verbindung klappt weder unter Linux, noch unter MacOS.
Hier das Log von Tunnelblick

2015-08-08 16:50:58 *Tunnelblick: openvpnstart starting OpenVPN
2015-08-08 16:50:59 MANAGEMENT: Client connected from [AF_INET]127.0.0.1:1337
2015-08-08 16:50:59 *Tunnelblick: Established communication with OpenVPN
2015-08-08 16:50:59 MANAGEMENT: CMD 'pid'
2015-08-08 16:50:59 MANAGEMENT: CMD 'state on'
2015-08-08 16:50:59 MANAGEMENT: CMD 'state'
2015-08-08 16:50:59 MANAGEMENT: CMD 'bytecount 1'
2015-08-08 16:50:59 MANAGEMENT: CMD 'hold release'
2015-08-08 16:50:59 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
2015-08-08 16:50:59 Socket Buffers: R=[196724->65536] S=[9216->65536]
2015-08-08 16:50:59 UDPv4 link local: [undef]
2015-08-08 16:50:59 UDPv4 link remote: [AF_INET]XXX.XXX.XXX.XXX:11941
2015-08-08 16:50:59 MANAGEMENT: >STATE:1439045459,WAIT,,,
2015-08-08 16:53:32 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
2015-08-08 16:53:32 TLS Error: TLS handshake failed
2015-08-08 16:53:32 SIGUSR1[soft,tls-error] received, process restarting
2015-08-08 16:53:32 MANAGEMENT: >STATE:1439045612,RECONNECTING,tls-error,,
2015-08-08 16:53:32 MANAGEMENT: CMD 'hold release'
2015-08-08 16:53:32 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
2015-08-08 16:53:32 Socket Buffers: R=[196724->65536] S=[9216->65536]
2015-08-08 16:53:32 UDPv4 link local: [undef]
2015-08-08 16:53:32 UDPv4 link remote: [AF_INET]XXX.XXX.XXX.XXX:11941
2015-08-08 16:53:32 MANAGEMENT: >STATE:1439045612,WAIT,,,

Zu anderen VPN Netzen kann ich mich problemlos verbinden.

Hier das Log aus Linux

Sat Aug 8 17:05:31 2015 OpenVPN 2.3.2 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [EPOLL] [PKCS11] [eurephia] [MH] [IPv6] built on Dec 1 2014
Sat Aug 8 17:05:31 2015 Socket Buffers: R=[212992->131072] S=[212992->131072]
Sat Aug 8 17:05:31 2015 UDPv4 link local: [undef]
Sat Aug 8 17:05:31 2015 UDPv4 link remote: [AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 17:06:31 2015 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Sat Aug 8 17:06:31 2015 TLS Error: TLS handshake failed
Sat Aug 8 17:06:31 2015 SIGUSR1[soft,tls-error] received, process restarting
Sat Aug 8 17:06:31 2015 Restart pause, 2 second(s)
Sat Aug 8 17:06:33 2015 Socket Buffers: R=[212992->131072] S=[212992->131072]
Sat Aug 8 17:06:33 2015 UDPv4 link local: [undef]
Sat Aug 8 17:06:33 2015 UDPv4 link remote: [AF_INET]XXX.XXX.XXX.XXX:11940

Hier das Log vom Server (verbose 9)

Sat Aug 8 17:11:28 2015 us=945659 event_wait returned 0
Sat Aug 8 17:11:28 2015 us=945689 I/O WAIT status=0x0020
Sat Aug 8 17:11:28 2015 us=945704 MULTI: REAP range 0 -> 16
Sat Aug 8 17:11:28 2015 us=945738 SCHEDULE: schedule_find_least NULL
Sat Aug 8 17:11:28 2015 us=945756 PO_CTL rwflags=0x0001 ev=5 arg=0x7ff5373fb170
Sat Aug 8 17:11:28 2015 us=945762 PO_CTL rwflags=0x0001 ev=6 arg=0x7ff5373fb088
Sat Aug 8 17:11:28 2015 us=945768 I/O WAIT TR|Tw|SR|Sw [10/0]

TCPDUMP Server IP-Adressen und Hostnamen unkenntlich gemacht

17:23:01.991653 IP 37-247-88-166.natip.skydsl.de.50209 > ns3495131.ip-94-23-51.eu.11940: UDP, length 14
17:23:04.113554 IP 36.natip.skydsl.de.50209 > ns34.eu.11940: UDP, length 14
17:23:08.274251 IP 36.natip.skydsl.de.50209 > ns34.eu.11940: UDP, length 14
17:23:16.351715 IP 36.natip.skydsl.de.50209 > ns34.eu.11940: UDP, length 14
17:23:33.070498 IP 36.natip.skydsl.de.50209 > ns34.eu.11940: UDP, length 14
17:24:03.717629 IP 36.natip.skydsl.de.51541 > ns34.eu.11940: UDP, length 14
17:24:06.271522 IP 36.natip.skydsl.de.51541 > ns34.eu.11940: UDP, length 14
17:24:09.796877 IP 36.natip.skydsl.de.51541 > ns34.eu.11940: UDP, length 14
17:24:18.114579 IP 36.natip.skydsl.de.51541 > ns34.eu.11940: UDP, length 14
17:24:33.795172 IP 36.natip.skydsl.de.51541 > ns34.eu.11940: UDP, length 14

TCPDUMP Client IP-Adressen und Hostnamen unkenntlich gemacht

17:23:31.707408 IP Mint-Virt.lan.50209 > ns34.eu.11940: UDP, length 14
17:24:02.324435 IP Mint-Virt.lan.51541 > ns34.eu.11940: UDP, length 14
17:24:04.756109 IP Mint-Virt.lan.51541 > ns34.eu.11940: UDP, length 14
17:24:08.404287 IP Mint-Virt.lan.51541 > ns34.eu.11940: UDP, length 14
17:24:16.739572 IP Mint-Virt.lan.51541 > ns34.eu.11940: UDP, length 14

orcape · Beitrag von **orcape** » 08.08.2015 18:59:19

Ausser den Logs hast Du keine meiner Fragen beantwortet.
Aber sei es drum, das Log sagt alles.....

2015-08-08 16:53:32 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
2015-08-08 16:53:32 TLS Error: TLS handshake failed

Bei Dir stimmt etwas mit den Zertifikaten nicht..
Gruß orcape

H8Ball · Beitrag von **H8Ball** » 08.08.2015 19:07:59

Um Zertifikate überprüfen zu können, müssen sie auch übermittelt werden, und das findet ja schon nicht statt.
Sonst würde auch im Log des Clients stehen dass die Zertifikate abgelehnt wurden.

H8Ball · Beitrag von **H8Ball** » 08.08.2015 19:12:54

orcape hat geschrieben:Hi,
wie ist denn Dein Netz aufgebaut ?
Was für Software/Hardware verwendest Du für Server und Client ?
Wie sehen die Configs aus ?
Was gibt die Konsole aus, wenn Du den Tunnel am Client händisch startest ?
Hast Du eine feste IP vom Provider oder läuft das per DynDNS ?
Dann hatte ich die Firewall vom Hoster oder die meines Servers im Auge.
Was hat die Firewall Deines Hosters denn mit Deinem VPN-Tunnel zu tun ?
Du siehst also, Fragen über Fragen. Du hast zwar viel geschrieben, uns aber nicht wirklich etwas erzählt, womit wir Dir weiterhelfen könnten.
Gruß orcape

Der Server ist ein gehosteter Server bei OVH.
Client hat die Software Openvpn 2.3.2
Server OpenVPN 2.3.4

orcape · Beitrag von **orcape** » 08.08.2015 19:41:46

Hast Du mal versucht die Verbindung auf dem Client händisch zu initialisieren.
Unter Debian z.B. mit der Konsole und....
openvpn /etc/openvpn/client.conf
Was erfogt daraufhin für eine Ausgabe in der Konsole.

H8Ball · Beitrag von **H8Ball** » 08.08.2015 20:21:40

Dann erfolgt das was ich im Logging vom Client angegeben habe.

Hier nochmal mit Verbose 9.

Sat Aug 8 20:29:02 2015 us=106821 Current Parameter Settings:
Sat Aug 8 20:29:02 2015 us=106892 config = 'braeuer.conf'
Sat Aug 8 20:29:02 2015 us=106905 mode = 0
Sat Aug 8 20:29:02 2015 us=106915 persist_config = DISABLED
Sat Aug 8 20:29:02 2015 us=106924 persist_mode = 1
Sat Aug 8 20:29:02 2015 us=106933 show_ciphers = DISABLED
Sat Aug 8 20:29:02 2015 us=106941 show_digests = DISABLED
Sat Aug 8 20:29:02 2015 us=106950 show_engines = DISABLED
Sat Aug 8 20:29:02 2015 us=106959 genkey = DISABLED
Sat Aug 8 20:29:02 2015 us=106968 key_pass_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=106985 show_tls_ciphers = DISABLED
Sat Aug 8 20:29:02 2015 us=106994 Connection profiles [default]:
Sat Aug 8 20:29:02 2015 us=107002 proto = udp
Sat Aug 8 20:29:02 2015 us=107011 local = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107019 local_port = 0
Sat Aug 8 20:29:02 2015 us=107027 remote = 'XXX.net'
Sat Aug 8 20:29:02 2015 us=107035 remote_port = 11940
Sat Aug 8 20:29:02 2015 us=107043 remote_float = DISABLED
Sat Aug 8 20:29:02 2015 us=107051 bind_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=107059 bind_local = DISABLED
Sat Aug 8 20:29:02 2015 us=107068 connect_retry_seconds = 5
Sat Aug 8 20:29:02 2015 us=107076 connect_timeout = 10
Sat Aug 8 20:29:02 2015 us=107084 connect_retry_max = 0
Sat Aug 8 20:29:02 2015 us=107093 socks_proxy_server = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107101 socks_proxy_port = 0
Sat Aug 8 20:29:02 2015 us=107109 socks_proxy_retry = DISABLED
Sat Aug 8 20:29:02 2015 us=107117 tun_mtu = 1500
Sat Aug 8 20:29:02 2015 us=107125 tun_mtu_defined = ENABLED
Sat Aug 8 20:29:02 2015 us=107133 link_mtu = 1500
Sat Aug 8 20:29:02 2015 us=107141 link_mtu_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=107149 tun_mtu_extra = 0
Sat Aug 8 20:29:02 2015 us=107157 tun_mtu_extra_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=107165 mtu_discover_type = -1
Sat Aug 8 20:29:02 2015 us=107173 fragment = 0
Sat Aug 8 20:29:02 2015 us=107181 mssfix = 1450
Sat Aug 8 20:29:02 2015 us=107190 explicit_exit_notification = 0
Sat Aug 8 20:29:02 2015 us=107200 Connection profiles END
Sat Aug 8 20:29:02 2015 us=107209 remote_random = DISABLED
Sat Aug 8 20:29:02 2015 us=107217 ipchange = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107225 dev = 'tun'
Sat Aug 8 20:29:02 2015 us=107233 dev_type = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107241 dev_node = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107249 lladdr = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107257 topology = 1
Sat Aug 8 20:29:02 2015 us=107265 tun_ipv6 = DISABLED
Sat Aug 8 20:29:02 2015 us=107273 ifconfig_local = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107282 ifconfig_remote_netmask = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107290 ifconfig_noexec = DISABLED
Sat Aug 8 20:29:02 2015 us=107298 ifconfig_nowarn = DISABLED
Sat Aug 8 20:29:02 2015 us=107305 ifconfig_ipv6_local = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107314 ifconfig_ipv6_netbits = 0
Sat Aug 8 20:29:02 2015 us=107321 ifconfig_ipv6_remote = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107330 shaper = 0
Sat Aug 8 20:29:02 2015 us=107337 mtu_test = 0
Sat Aug 8 20:29:02 2015 us=107345 mlock = DISABLED
Sat Aug 8 20:29:02 2015 us=107355 keepalive_ping = 0
Sat Aug 8 20:29:02 2015 us=107364 keepalive_timeout = 0
Sat Aug 8 20:29:02 2015 us=107372 inactivity_timeout = 0
Sat Aug 8 20:29:02 2015 us=107380 ping_send_timeout = 0
Sat Aug 8 20:29:02 2015 us=107415 ping_rec_timeout = 0
Sat Aug 8 20:29:02 2015 us=107425 ping_rec_timeout_action = 0
Sat Aug 8 20:29:02 2015 us=107433 ping_timer_remote = DISABLED
Sat Aug 8 20:29:02 2015 us=107440 remap_sigusr1 = 0
Sat Aug 8 20:29:02 2015 us=107449 persist_tun = ENABLED
Sat Aug 8 20:29:02 2015 us=107457 persist_local_ip = DISABLED
Sat Aug 8 20:29:02 2015 us=107465 persist_remote_ip = DISABLED
Sat Aug 8 20:29:02 2015 us=107473 persist_key = ENABLED
Sat Aug 8 20:29:02 2015 us=107481 passtos = DISABLED
Sat Aug 8 20:29:02 2015 us=107489 resolve_retry_seconds = 1000000000
Sat Aug 8 20:29:02 2015 us=107503 username = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107512 groupname = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107520 chroot_dir = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107528 cd_dir = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107536 writepid = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107544 up_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107552 down_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107560 down_pre = DISABLED
Sat Aug 8 20:29:02 2015 us=107568 up_restart = DISABLED
Sat Aug 8 20:29:02 2015 us=107576 up_delay = DISABLED
Sat Aug 8 20:29:02 2015 us=107585 daemon = DISABLED
Sat Aug 8 20:29:02 2015 us=107593 inetd = 0
Sat Aug 8 20:29:02 2015 us=107601 log = DISABLED
Sat Aug 8 20:29:02 2015 us=107609 suppress_timestamps = DISABLED
Sat Aug 8 20:29:02 2015 us=107617 nice = 0
Sat Aug 8 20:29:02 2015 us=107625 verbosity = 9
Sat Aug 8 20:29:02 2015 us=107633 mute = 0
Sat Aug 8 20:29:02 2015 us=107641 gremlin = 0
Sat Aug 8 20:29:02 2015 us=107650 status_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107658 status_file_version = 1
Sat Aug 8 20:29:02 2015 us=107666 status_file_update_freq = 60
Sat Aug 8 20:29:02 2015 us=107674 occ = ENABLED
Sat Aug 8 20:29:02 2015 us=107682 rcvbuf = 65536
Sat Aug 8 20:29:02 2015 us=107690 sndbuf = 65536
Sat Aug 8 20:29:02 2015 us=107698 mark = 0
Sat Aug 8 20:29:02 2015 us=107706 sockflags = 0
Sat Aug 8 20:29:02 2015 us=107713 fast_io = DISABLED
Sat Aug 8 20:29:02 2015 us=107722 lzo = 7
Sat Aug 8 20:29:02 2015 us=107730 route_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107738 route_default_gateway = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107746 route_default_metric = 0
Sat Aug 8 20:29:02 2015 us=107754 route_noexec = DISABLED
Sat Aug 8 20:29:02 2015 us=107762 route_delay = 0
Sat Aug 8 20:29:02 2015 us=107770 route_delay_window = 30
Sat Aug 8 20:29:02 2015 us=107779 route_delay_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=107787 route_nopull = DISABLED
Sat Aug 8 20:29:02 2015 us=107795 route_gateway_via_dhcp = DISABLED
Sat Aug 8 20:29:02 2015 us=107803 max_routes = 100
Sat Aug 8 20:29:02 2015 us=107811 allow_pull_fqdn = DISABLED
Sat Aug 8 20:29:02 2015 us=107819 management_addr = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107828 management_port = 0
Sat Aug 8 20:29:02 2015 us=107836 management_user_pass = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107844 management_log_history_cache = 250
Sat Aug 8 20:29:02 2015 us=107852 management_echo_buffer_size = 100
Sat Aug 8 20:29:02 2015 us=107860 management_write_peer_info_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107869 management_client_user = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107879 management_client_group = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107889 management_flags = 0
Sat Aug 8 20:29:02 2015 us=107897 shared_secret_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=107906 key_direction = 0
Sat Aug 8 20:29:02 2015 us=107914 ciphername_defined = ENABLED
Sat Aug 8 20:29:02 2015 us=107922 ciphername = 'BF-CBC'
Sat Aug 8 20:29:02 2015 us=107930 authname_defined = ENABLED
Sat Aug 8 20:29:02 2015 us=107938 authname = 'SHA1'
Sat Aug 8 20:29:02 2015 us=107946 prng_hash = 'SHA1'
Sat Aug 8 20:29:02 2015 us=107955 prng_nonce_secret_len = 16
Sat Aug 8 20:29:02 2015 us=107963 keysize = 0
Sat Aug 8 20:29:02 2015 us=107971 engine = DISABLED
Sat Aug 8 20:29:02 2015 us=107979 replay = ENABLED
Sat Aug 8 20:29:02 2015 us=107988 mute_replay_warnings = DISABLED
Sat Aug 8 20:29:02 2015 us=107996 replay_window = 64
Sat Aug 8 20:29:02 2015 us=108004 replay_time = 15
Sat Aug 8 20:29:02 2015 us=108012 packet_id_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108020 use_iv = ENABLED
Sat Aug 8 20:29:02 2015 us=108028 test_crypto = DISABLED
Sat Aug 8 20:29:02 2015 us=108037 tls_server = DISABLED
Sat Aug 8 20:29:02 2015 us=108045 tls_client = ENABLED
Sat Aug 8 20:29:02 2015 us=108053 key_method = 2
Sat Aug 8 20:29:02 2015 us=108061 ca_file = 'braeuer/ca.crt'
Sat Aug 8 20:29:02 2015 us=108074 ca_path = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108082 dh_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108091 cert_file = 'braeuer/rodriguez.crt'
Sat Aug 8 20:29:02 2015 us=108099 priv_key_file = 'braeuer/rodriguez.key'
Sat Aug 8 20:29:02 2015 us=108107 pkcs12_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108115 cipher_list = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108123 tls_verify = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108131 tls_export_cert = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108139 verify_x509_type = 0
Sat Aug 8 20:29:02 2015 us=108147 verify_x509_name = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108156 crl_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108164 ns_cert_type = 1
Sat Aug 8 20:29:02 2015 us=108172 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108180 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108188 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108196 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108204 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108212 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108220 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108228 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108236 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108243 remote_cert_ku = 0
Sat Aug 8 20:29:02 2015 us=108251 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108259 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108267 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108275 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108283 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108291 remote_cert_ku[i] = 0
Sat Aug 8 20:29:02 2015 us=108299 remote_cert_eku = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108307 ssl_flags = 0
Sat Aug 8 20:29:02 2015 us=108315 tls_timeout = 2
Sat Aug 8 20:29:02 2015 us=108323 renegotiate_bytes = 0
Sat Aug 8 20:29:02 2015 us=108331 renegotiate_packets = 0
Sat Aug 8 20:29:02 2015 us=108339 renegotiate_seconds = 3600
Sat Aug 8 20:29:02 2015 us=108347 handshake_window = 60
Sat Aug 8 20:29:02 2015 us=108355 transition_window = 3600
Sat Aug 8 20:29:02 2015 us=108363 single_session = DISABLED
Sat Aug 8 20:29:02 2015 us=108371 push_peer_info = DISABLED
Sat Aug 8 20:29:02 2015 us=108379 tls_exit = DISABLED
Sat Aug 8 20:29:02 2015 us=108387 tls_auth_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108396 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108404 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108412 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108428 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108438 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108447 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108456 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108464 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108473 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108481 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108490 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108499 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108507 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108516 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108525 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108533 pkcs11_protected_authentication = DISABLED
Sat Aug 8 20:29:02 2015 us=108551 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108560 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108568 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108576 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108584 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108592 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108605 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108613 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108621 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108630 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108638 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108646 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108654 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108662 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108670 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108678 pkcs11_private_mode = 00000000
Sat Aug 8 20:29:02 2015 us=108686 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108694 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108702 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108710 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108718 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108726 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108734 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108742 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108750 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108758 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108766 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108774 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108782 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108790 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108798 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108806 pkcs11_cert_private = DISABLED
Sat Aug 8 20:29:02 2015 us=108814 pkcs11_pin_cache_period = -1
Sat Aug 8 20:29:02 2015 us=108822 pkcs11_id = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108830 pkcs11_id_management = DISABLED
Sat Aug 8 20:29:02 2015 us=108846 server_network = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108856 server_netmask = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108868 server_network_ipv6 = ::
Sat Aug 8 20:29:02 2015 us=108877 server_netbits_ipv6 = 0
Sat Aug 8 20:29:02 2015 us=108886 server_bridge_ip = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108895 server_bridge_netmask = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108903 server_bridge_pool_start = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108913 server_bridge_pool_end = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108921 ifconfig_pool_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=108930 ifconfig_pool_start = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108939 ifconfig_pool_end = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108948 ifconfig_pool_netmask = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=108956 ifconfig_pool_persist_filename = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=108964 ifconfig_pool_persist_refresh_freq = 600
Sat Aug 8 20:29:02 2015 us=108972 ifconfig_ipv6_pool_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=108981 ifconfig_ipv6_pool_base = ::
Sat Aug 8 20:29:02 2015 us=108989 ifconfig_ipv6_pool_netbits = 0
Sat Aug 8 20:29:02 2015 us=108998 n_bcast_buf = 256
Sat Aug 8 20:29:02 2015 us=109006 tcp_queue_limit = 64
Sat Aug 8 20:29:02 2015 us=109014 real_hash_size = 256
Sat Aug 8 20:29:02 2015 us=109022 virtual_hash_size = 256
Sat Aug 8 20:29:02 2015 us=109030 client_connect_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109039 learn_address_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109047 client_disconnect_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109055 client_config_dir = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109064 ccd_exclusive = DISABLED
Sat Aug 8 20:29:02 2015 us=109072 tmp_dir = '/tmp'
Sat Aug 8 20:29:02 2015 us=109080 push_ifconfig_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=109089 push_ifconfig_local = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=109098 push_ifconfig_remote_netmask = 0.0.0.0
Sat Aug 8 20:29:02 2015 us=109106 push_ifconfig_ipv6_defined = DISABLED
Sat Aug 8 20:29:02 2015 us=109115 push_ifconfig_ipv6_local = ::/0
Sat Aug 8 20:29:02 2015 us=109130 push_ifconfig_ipv6_remote = ::
Sat Aug 8 20:29:02 2015 us=109139 enable_c2c = DISABLED
Sat Aug 8 20:29:02 2015 us=109147 duplicate_cn = DISABLED
Sat Aug 8 20:29:02 2015 us=109156 cf_max = 0
Sat Aug 8 20:29:02 2015 us=109621 cf_per = 0
Sat Aug 8 20:29:02 2015 us=109636 max_clients = 1024
Sat Aug 8 20:29:02 2015 us=109645 max_routes_per_client = 256
Sat Aug 8 20:29:02 2015 us=109653 auth_user_pass_verify_script = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109662 auth_user_pass_verify_script_via_file = DISABLED
Sat Aug 8 20:29:02 2015 us=109670 port_share_host = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109678 port_share_port = 0
Sat Aug 8 20:29:02 2015 us=109686 client = ENABLED
Sat Aug 8 20:29:02 2015 us=109694 pull = ENABLED
Sat Aug 8 20:29:02 2015 us=109702 auth_user_pass_file = '[UNDEF]'
Sat Aug 8 20:29:02 2015 us=109712 OpenVPN 2.3.2 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [EPOLL] [PKCS11] [eurephia] [MH] [IPv6] built on Dec 1 2014
Sat Aug 8 20:29:02 2015 us=109750 PKCS#11: pkcs11_initialize - entered
Sat Aug 8 20:29:02 2015 us=109798 PKCS#11: pkcs11_initialize - return 0-'CKR_OK'
Sat Aug 8 20:29:02 2015 us=109818 PO_INIT maxevents=4 flags=0x00000002
Sat Aug 8 20:29:02 2015 us=110269 PRNG init md=SHA1 size=36
Sat Aug 8 20:29:02 2015 us=110301 LZO compression initialized
Sat Aug 8 20:29:02 2015 us=110317 MTU DYNAMIC mtu=0, flags=1, 0 -> 138
Sat Aug 8 20:29:02 2015 us=110328 TLS: tls_session_init: entry
Sat Aug 8 20:29:02 2015 us=110339 PID packet_id_init tcp_mode=0 seq_backtrack=64 time_backtrack=15
Sat Aug 8 20:29:02 2015 us=110371 PID packet_id_init tcp_mode=0 seq_backtrack=64 time_backtrack=15
Sat Aug 8 20:29:02 2015 us=110386 TLS: tls_session_init: new session object, sid=65413015 9b9d99bb
Sat Aug 8 20:29:02 2015 us=110395 TLS: tls_session_init: entry
Sat Aug 8 20:29:02 2015 us=110405 PID packet_id_init tcp_mode=0 seq_backtrack=64 time_backtrack=15
Sat Aug 8 20:29:02 2015 us=110430 PID packet_id_init tcp_mode=0 seq_backtrack=64 time_backtrack=15
Sat Aug 8 20:29:02 2015 us=110442 TLS: tls_session_init: new session object, sid=7a4b4337 ff9d2fbd
Sat Aug 8 20:29:02 2015 us=110452 Control Channel MTU parms [ L:1542 D:138 EF:38 EB:0 ET:0 EL:0 ]
Sat Aug 8 20:29:02 2015 us=110469 MTU DYNAMIC mtu=1450, flags=2, 1542 -> 1450
Sat Aug 8 20:29:02 2015 us=110505 Socket Buffers: R=[212992->131072] S=[212992->131072]
Sat Aug 8 20:29:02 2015 us=110524 GETADDRINFO flags=0x0101 ai_family=2 ai_socktype=1
Sat Aug 8 20:29:02 2015 us=114453 RESOLVE_REMOTE flags=0x0101 phase=1 rrs=0 sig=-1 status=0
Sat Aug 8 20:29:02 2015 us=114454 Data Channel MTU parms [ L:1542 D:1450 EF:42 EB:135 ET:0 EL:0 AF:3/1 ]
Sat Aug 8 20:29:02 2015 us=114470 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'
Sat Aug 8 20:29:02 2015 us=114483 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'
Sat Aug 8 20:29:02 2015 us=114504 Local Options hash (VER=V4): '41690919'
Sat Aug 8 20:29:02 2015 us=114517 Expected Remote Options hash (VER=V4): '530fdded'
Sat Aug 8 20:29:02 2015 us=114530 UDPv4 link local: [undef]
Sat Aug 8 20:29:02 2015 us=114541 UDPv4 link remote: [AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:02 2015 us=114559 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:02 2015 us=114577 TLS: tls_multi_process: i=0 state=S_INITIAL, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:02 2015 us=114589 TLS: tls_process: chg=0 ks=S_INITIAL lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:02 2015 us=114598 ACK mark active outgoing ID 0
Sat Aug 8 20:29:02 2015 us=114608 TLS: Initial Handshake, sid=65413015 9b9d99bb
Sat Aug 8 20:29:02 2015 us=114619 ACK reliable_can_send active=1 current=1 : [1] 0
Sat Aug 8 20:29:02 2015 us=114628 ACK reliable_send ID 0 (size=4 to=2)
Sat Aug 8 20:29:02 2015 us=114638 Reliable -> TCP/UDP
Sat Aug 8 20:29:02 2015 us=114656 ACK reliable_send_timeout 2 [1] 0
Sat Aug 8 20:29:02 2015 us=114664 TLS: tls_process: timeout set to 2
Sat Aug 8 20:29:02 2015 us=114675 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:02 2015 us=114686 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:02 2015 us=114700 RANDOM USEC=117176
Sat Aug 8 20:29:02 2015 us=114711 PO_CTL rwflags=0x0003 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:02 2015 us=114727 I/O WAIT T?|T?|SR|SW [1/117176]
Sat Aug 8 20:29:02 2015 us=114739 PO_WAIT[0,0] fd=3 rev=0x00000004 rwflags=0x0002 arg=0x7fe574db8150
Sat Aug 8 20:29:02 2015 us=114747 event_wait returned 1
Sat Aug 8 20:29:02 2015 us=114755 I/O WAIT status=0x0002
Sat Aug 8 20:29:02 2015 us=114770 UDPv4 WRITE [14] to [AF_INET]XXX.XXX.XXX.XXX:11940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=65413015 9b9d99bb [ ] pid=0 DATA
Sat Aug 8 20:29:02 2015 us=114858 UDPv4 write returned 14
Sat Aug 8 20:29:02 2015 us=114880 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:02 2015 us=114890 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:02 2015 us=114899 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:02 2015 us=114967 SSL state (connect): before/connect initialization
Sat Aug 8 20:29:02 2015 us=115005 SSL state (connect): SSLv3 write client hello A
Sat Aug 8 20:29:02 2015 us=115022 ACK reliable_send_timeout 2 [1] 0
Sat Aug 8 20:29:02 2015 us=115507 TLS: tls_process: timeout set to 2
Sat Aug 8 20:29:02 2015 us=115529 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:02 2015 us=115542 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:02 2015 us=115553 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:02 2015 us=115564 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:03 2015 us=233851 event_wait returned 0
Sat Aug 8 20:29:03 2015 us=234036 I/O WAIT status=0x0020
Sat Aug 8 20:29:03 2015 us=234062 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:03 2015 us=234142 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:03 2015 us=234162 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:03 2015 us=234176 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:03 2015 us=234208 ACK reliable_send_timeout 1 [1] 0
Sat Aug 8 20:29:03 2015 us=234221 TLS: tls_process: timeout set to 1
Sat Aug 8 20:29:03 2015 us=234237 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:03 2015 us=234254 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:03 2015 us=234270 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:03 2015 us=234286 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:04 2015 us=352502 event_wait returned 0
Sat Aug 8 20:29:04 2015 us=353849 I/O WAIT status=0x0020
Sat Aug 8 20:29:04 2015 us=353895 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:04 2015 us=353938 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:04 2015 us=353959 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:04 2015 us=353978 ACK reliable_can_send active=1 current=1 : [1] 0
Sat Aug 8 20:29:04 2015 us=353995 ACK reliable_send ID 0 (size=4 to=4)
Sat Aug 8 20:29:04 2015 us=354013 Reliable -> TCP/UDP
Sat Aug 8 20:29:04 2015 us=354044 ACK reliable_send_timeout 4 [1] 0
Sat Aug 8 20:29:04 2015 us=354061 TLS: tls_process: timeout set to 4
Sat Aug 8 20:29:04 2015 us=354084 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:04 2015 us=354107 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:04 2015 us=354128 PO_CTL rwflags=0x0003 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:04 2015 us=354151 I/O WAIT T?|T?|SR|SW [1/117176]
Sat Aug 8 20:29:04 2015 us=354172 PO_WAIT[0,0] fd=3 rev=0x00000004 rwflags=0x0002 arg=0x7fe574db8150
Sat Aug 8 20:29:04 2015 us=354189 event_wait returned 1
Sat Aug 8 20:29:04 2015 us=354204 I/O WAIT status=0x0002
Sat Aug 8 20:29:04 2015 us=354231 UDPv4 WRITE [14] to [AF_INET]XXX.XXX.XXX.XXX:11940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=65413015 9b9d99bb [ ] pid=0 DATA
Sat Aug 8 20:29:04 2015 us=354415 UDPv4 write returned 14
Sat Aug 8 20:29:04 2015 us=354456 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:04 2015 us=354474 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:04 2015 us=354491 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:04 2015 us=354530 ACK reliable_send_timeout 4 [1] 0
Sat Aug 8 20:29:04 2015 us=354547 TLS: tls_process: timeout set to 4
Sat Aug 8 20:29:04 2015 us=354569 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:04 2015 us=354591 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:04 2015 us=354610 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:04 2015 us=354629 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:05 2015 us=472692 event_wait returned 0
Sat Aug 8 20:29:05 2015 us=472870 I/O WAIT status=0x0020
Sat Aug 8 20:29:05 2015 us=472895 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:05 2015 us=472929 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:05 2015 us=472945 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:05 2015 us=472961 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:05 2015 us=472995 ACK reliable_send_timeout 3 [1] 0
Sat Aug 8 20:29:05 2015 us=473010 TLS: tls_process: timeout set to 3
Sat Aug 8 20:29:05 2015 us=473029 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:05 2015 us=473048 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:05 2015 us=473065 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:05 2015 us=473083 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:06 2015 us=591432 event_wait returned 0
Sat Aug 8 20:29:06 2015 us=591554 I/O WAIT status=0x0020
Sat Aug 8 20:29:06 2015 us=591587 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:06 2015 us=591613 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:06 2015 us=591642 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:07 2015 us=710946 event_wait returned 0
Sat Aug 8 20:29:07 2015 us=711067 I/O WAIT status=0x0020
Sat Aug 8 20:29:07 2015 us=711100 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:07 2015 us=711126 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:07 2015 us=711155 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:08 2015 us=829185 event_wait returned 0
Sat Aug 8 20:29:08 2015 us=829271 I/O WAIT status=0x0020
Sat Aug 8 20:29:08 2015 us=829292 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:08 2015 us=829327 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:08 2015 us=829366 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:08 2015 us=829383 ACK reliable_can_send active=1 current=1 : [1] 0
Sat Aug 8 20:29:08 2015 us=829396 ACK reliable_send ID 0 (size=4 to=8)
Sat Aug 8 20:29:08 2015 us=829410 Reliable -> TCP/UDP
Sat Aug 8 20:29:08 2015 us=829424 ACK reliable_send_timeout 8 [1] 0
Sat Aug 8 20:29:08 2015 us=829437 TLS: tls_process: timeout set to 8
Sat Aug 8 20:29:08 2015 us=829455 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:08 2015 us=829474 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:08 2015 us=829491 PO_CTL rwflags=0x0003 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:08 2015 us=829509 I/O WAIT T?|T?|SR|SW [1/117176]
Sat Aug 8 20:29:08 2015 us=829527 PO_WAIT[0,0] fd=3 rev=0x00000004 rwflags=0x0002 arg=0x7fe574db8150
Sat Aug 8 20:29:08 2015 us=829541 event_wait returned 1
Sat Aug 8 20:29:08 2015 us=829553 I/O WAIT status=0x0002
Sat Aug 8 20:29:08 2015 us=829576 UDPv4 WRITE [14] to [AF_INET]XXX.XXX.XXX.XXX:11940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=65413015 9b9d99bb [ ] pid=0 DATA
Sat Aug 8 20:29:08 2015 us=829748 UDPv4 write returned 14
Sat Aug 8 20:29:08 2015 us=829782 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:08 2015 us=829797 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:08 2015 us=829811 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:08 2015 us=829844 ACK reliable_send_timeout 8 [1] 0
Sat Aug 8 20:29:08 2015 us=829859 TLS: tls_process: timeout set to 8
Sat Aug 8 20:29:08 2015 us=829877 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:08 2015 us=829895 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:08 2015 us=829910 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:08 2015 us=829926 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:09 2015 us=947998 event_wait returned 0
Sat Aug 8 20:29:09 2015 us=948116 I/O WAIT status=0x0020
Sat Aug 8 20:29:09 2015 us=948136 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:09 2015 us=948169 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:09 2015 us=948185 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:09 2015 us=948200 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:09 2015 us=948233 ACK reliable_send_timeout 7 [1] 0
Sat Aug 8 20:29:09 2015 us=948248 TLS: tls_process: timeout set to 7
Sat Aug 8 20:29:09 2015 us=948267 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:09 2015 us=948286 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:09 2015 us=948303 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:09 2015 us=948321 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:11 2015 us=65599 event_wait returned 0
Sat Aug 8 20:29:11 2015 us=65694 I/O WAIT status=0x0020
Sat Aug 8 20:29:11 2015 us=65720 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:11 2015 us=65740 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:11 2015 us=65763 I/O WAIT T?|T?|SR|Sw [1/117176]
Sat Aug 8 20:29:12 2015 us=184060 event_wait returned 0
Sat Aug 8 20:29:12 2015 us=184180 I/O WAIT status=0x0020
Sat Aug 8 20:29:12 2015 us=184213 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:12 2015 us=184250 RANDOM USEC=33387
Sat Aug 8 20:29:12 2015 us=184304 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:12 2015 us=184335 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:13 2015 us=218643 event_wait returned 0
Sat Aug 8 20:29:13 2015 us=218766 I/O WAIT status=0x0020
Sat Aug 8 20:29:13 2015 us=218799 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:13 2015 us=218824 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:13 2015 us=218853 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:14 2015 us=253976 event_wait returned 0
Sat Aug 8 20:29:14 2015 us=254098 I/O WAIT status=0x0020
Sat Aug 8 20:29:14 2015 us=254131 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:14 2015 us=254156 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:14 2015 us=254185 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:15 2015 us=288330 event_wait returned 0
Sat Aug 8 20:29:15 2015 us=288455 I/O WAIT status=0x0020
Sat Aug 8 20:29:15 2015 us=288486 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:15 2015 us=288512 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:15 2015 us=288541 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:16 2015 us=322785 event_wait returned 0
Sat Aug 8 20:29:16 2015 us=322891 I/O WAIT status=0x0020
Sat Aug 8 20:29:16 2015 us=322917 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:16 2015 us=322957 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:16 2015 us=322977 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:16 2015 us=322996 ACK reliable_can_send active=1 current=1 : [1] 0
Sat Aug 8 20:29:16 2015 us=323012 ACK reliable_send ID 0 (size=4 to=16)
Sat Aug 8 20:29:16 2015 us=323028 Reliable -> TCP/UDP
Sat Aug 8 20:29:16 2015 us=323045 ACK reliable_send_timeout 16 [1] 0
Sat Aug 8 20:29:16 2015 us=323060 TLS: tls_process: timeout set to 16
Sat Aug 8 20:29:16 2015 us=323082 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:16 2015 us=323105 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:16 2015 us=323126 PO_CTL rwflags=0x0003 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:16 2015 us=323148 I/O WAIT T?|T?|SR|SW [1/33387]
Sat Aug 8 20:29:16 2015 us=323171 PO_WAIT[0,0] fd=3 rev=0x00000004 rwflags=0x0002 arg=0x7fe574db8150
Sat Aug 8 20:29:16 2015 us=323187 event_wait returned 1
Sat Aug 8 20:29:16 2015 us=323202 I/O WAIT status=0x0002
Sat Aug 8 20:29:16 2015 us=323229 UDPv4 WRITE [14] to [AF_INET]XXX.XXX.XXX.XXX:11940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=65413015 9b9d99bb [ ] pid=0 DATA
Sat Aug 8 20:29:16 2015 us=323436 UDPv4 write returned 14
Sat Aug 8 20:29:16 2015 us=323477 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:16 2015 us=323495 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:16 2015 us=323513 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:16 2015 us=323553 ACK reliable_send_timeout 16 [1] 0
Sat Aug 8 20:29:16 2015 us=323571 TLS: tls_process: timeout set to 16
Sat Aug 8 20:29:16 2015 us=323593 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:16 2015 us=323615 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:16 2015 us=323633 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:16 2015 us=323653 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:17 2015 us=358389 event_wait returned 0
Sat Aug 8 20:29:17 2015 us=358390 I/O WAIT status=0x0020
Sat Aug 8 20:29:17 2015 us=358390 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:17 2015 us=358991 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:17 2015 us=359075 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:17 2015 us=359101 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:17 2015 us=359153 ACK reliable_send_timeout 15 [1] 0
Sat Aug 8 20:29:17 2015 us=359177 TLS: tls_process: timeout set to 15
Sat Aug 8 20:29:17 2015 us=359206 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:17 2015 us=359235 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:17 2015 us=359261 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:17 2015 us=359290 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:18 2015 us=394305 event_wait returned 0
Sat Aug 8 20:29:18 2015 us=394426 I/O WAIT status=0x0020
Sat Aug 8 20:29:18 2015 us=394457 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:18 2015 us=394482 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:18 2015 us=394511 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:19 2015 us=429501 event_wait returned 0
Sat Aug 8 20:29:19 2015 us=429622 I/O WAIT status=0x0020
Sat Aug 8 20:29:19 2015 us=429654 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:19 2015 us=429743 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:19 2015 us=429773 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:20 2015 us=464850 event_wait returned 0
Sat Aug 8 20:29:20 2015 us=464962 I/O WAIT status=0x0020
Sat Aug 8 20:29:20 2015 us=464993 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:20 2015 us=465019 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:20 2015 us=465048 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:21 2015 us=499134 event_wait returned 0
Sat Aug 8 20:29:21 2015 us=499237 I/O WAIT status=0x0020
Sat Aug 8 20:29:21 2015 us=499262 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:21 2015 us=499282 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:21 2015 us=499305 I/O WAIT T?|T?|SR|Sw [1/33387]
Sat Aug 8 20:29:22 2015 us=533471 event_wait returned 0
Sat Aug 8 20:29:22 2015 us=533561 I/O WAIT status=0x0020
Sat Aug 8 20:29:22 2015 us=533584 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:22 2015 us=533610 RANDOM USEC=158864
Sat Aug 8 20:29:22 2015 us=533626 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:22 2015 us=533644 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:23 2015 us=693854 event_wait returned 0
Sat Aug 8 20:29:23 2015 us=693977 I/O WAIT status=0x0020
Sat Aug 8 20:29:23 2015 us=694009 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:23 2015 us=694036 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:23 2015 us=694065 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:24 2015 us=854455 event_wait returned 0
Sat Aug 8 20:29:24 2015 us=854577 I/O WAIT status=0x0020
Sat Aug 8 20:29:24 2015 us=854608 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:24 2015 us=854633 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:24 2015 us=854662 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:26 2015 us=15688 event_wait returned 0
Sat Aug 8 20:29:26 2015 us=15791 I/O WAIT status=0x0020
Sat Aug 8 20:29:26 2015 us=15816 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:26 2015 us=15836 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:26 2015 us=15858 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:27 2015 us=176097 event_wait returned 0
Sat Aug 8 20:29:27 2015 us=176158 I/O WAIT status=0x0020
Sat Aug 8 20:29:27 2015 us=176170 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:27 2015 us=176181 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:27 2015 us=176193 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:28 2015 us=337555 event_wait returned 0
Sat Aug 8 20:29:28 2015 us=337679 I/O WAIT status=0x0020
Sat Aug 8 20:29:28 2015 us=337742 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:28 2015 us=337768 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:28 2015 us=337797 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:29 2015 us=498077 event_wait returned 0
Sat Aug 8 20:29:29 2015 us=498178 I/O WAIT status=0x0020
Sat Aug 8 20:29:29 2015 us=498203 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:29 2015 us=498223 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:29 2015 us=498247 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:30 2015 us=658204 event_wait returned 0
Sat Aug 8 20:29:30 2015 us=658325 I/O WAIT status=0x0020
Sat Aug 8 20:29:30 2015 us=658357 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:30 2015 us=658383 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:30 2015 us=658411 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:31 2015 us=818656 event_wait returned 0
Sat Aug 8 20:29:31 2015 us=818711 I/O WAIT status=0x0020
Sat Aug 8 20:29:31 2015 us=818724 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:31 2015 us=818735 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:31 2015 us=818747 I/O WAIT T?|T?|SR|Sw [1/158864]
Sat Aug 8 20:29:32 2015 us=978562 event_wait returned 0
Sat Aug 8 20:29:32 2015 us=978684 I/O WAIT status=0x0020
Sat Aug 8 20:29:32 2015 us=978715 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:32 2015 us=978765 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:32 2015 us=978790 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:32 2015 us=978814 ACK reliable_can_send active=1 current=1 : [1] 0
Sat Aug 8 20:29:32 2015 us=978835 ACK reliable_send ID 0 (size=4 to=32)
Sat Aug 8 20:29:32 2015 us=978856 Reliable -> TCP/UDP
Sat Aug 8 20:29:32 2015 us=978878 ACK reliable_send_timeout 32 [1] 0
Sat Aug 8 20:29:32 2015 us=978897 TLS: tls_process: timeout set to 30
Sat Aug 8 20:29:32 2015 us=978926 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:32 2015 us=978955 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:32 2015 us=978991 RANDOM USEC=79609
Sat Aug 8 20:29:32 2015 us=978991 PO_CTL rwflags=0x0003 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:32 2015 us=978991 I/O WAIT T?|T?|SR|SW [1/79609]
Sat Aug 8 20:29:32 2015 us=978991 PO_WAIT[0,0] fd=3 rev=0x00000004 rwflags=0x0002 arg=0x7fe574db8150
Sat Aug 8 20:29:32 2015 us=978991 event_wait returned 1
Sat Aug 8 20:29:32 2015 us=978991 I/O WAIT status=0x0002
Sat Aug 8 20:29:32 2015 us=979013 UDPv4 WRITE [14] to [AF_INET]XXX.XXX.XXX.XXX:11940: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 sid=65413015 9b9d99bb [ ] pid=0 DATA
Sat Aug 8 20:29:32 2015 us=979255 UDPv4 write returned 14
Sat Aug 8 20:29:32 2015 us=979307 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:32 2015 us=979331 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:32 2015 us=979353 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:32 2015 us=979396 ACK reliable_send_timeout 32 [1] 0
Sat Aug 8 20:29:32 2015 us=979419 TLS: tls_process: timeout set to 30
Sat Aug 8 20:29:32 2015 us=979447 TLS: tls_multi_process: i=1 state=S_INITIAL, mysid=7a4b4337 ff9d2fbd, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:32 2015 us=979474 TLS: tls_multi_process: i=2 state=S_UNDEF, mysid=00000000 00000000, stored-sid=00000000 00000000, stored-ip=[undef]
Sat Aug 8 20:29:32 2015 us=979499 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:32 2015 us=979524 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:34 2015 us=61355 event_wait returned 0
Sat Aug 8 20:29:34 2015 us=61486 I/O WAIT status=0x0020
Sat Aug 8 20:29:34 2015 us=61552 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:34 2015 us=61580 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:34 2015 us=61610 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:35 2015 us=143754 event_wait returned 0
Sat Aug 8 20:29:35 2015 us=143878 I/O WAIT status=0x0020
Sat Aug 8 20:29:35 2015 us=143909 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:35 2015 us=143934 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:35 2015 us=143963 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:36 2015 us=225203 event_wait returned 0
Sat Aug 8 20:29:36 2015 us=225304 I/O WAIT status=0x0020
Sat Aug 8 20:29:36 2015 us=225329 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:36 2015 us=225349 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:36 2015 us=225371 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:37 2015 us=306759 event_wait returned 0
Sat Aug 8 20:29:37 2015 us=306881 I/O WAIT status=0x0020
Sat Aug 8 20:29:37 2015 us=306913 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:37 2015 us=306941 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:37 2015 us=306971 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:38 2015 us=388039 event_wait returned 0
Sat Aug 8 20:29:38 2015 us=388164 I/O WAIT status=0x0020
Sat Aug 8 20:29:38 2015 us=388195 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:38 2015 us=388221 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:38 2015 us=388250 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:39 2015 us=470293 event_wait returned 0
Sat Aug 8 20:29:39 2015 us=470418 I/O WAIT status=0x0020
Sat Aug 8 20:29:39 2015 us=470451 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:39 2015 us=470477 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:39 2015 us=470507 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:40 2015 us=551782 event_wait returned 0
Sat Aug 8 20:29:40 2015 us=551908 I/O WAIT status=0x0020
Sat Aug 8 20:29:40 2015 us=551942 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:40 2015 us=551968 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:40 2015 us=551998 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:41 2015 us=633263 event_wait returned 0
Sat Aug 8 20:29:41 2015 us=633383 I/O WAIT status=0x0020
Sat Aug 8 20:29:41 2015 us=633416 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:41 2015 us=633442 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:41 2015 us=633471 I/O WAIT T?|T?|SR|Sw [1/79609]
Sat Aug 8 20:29:42 2015 us=714738 event_wait returned 0
Sat Aug 8 20:29:42 2015 us=714841 I/O WAIT status=0x0020
Sat Aug 8 20:29:42 2015 us=714866 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:42 2015 us=714895 RANDOM USEC=216810
Sat Aug 8 20:29:42 2015 us=714915 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:42 2015 us=714937 I/O WAIT T?|T?|SR|Sw [1/216810]
Sat Aug 8 20:29:43 2015 us=933399 event_wait returned 0
Sat Aug 8 20:29:43 2015 us=933521 I/O WAIT status=0x0020
Sat Aug 8 20:29:43 2015 us=933554 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:43 2015 us=933580 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:43 2015 us=933608 I/O WAIT T?|T?|SR|Sw [1/216810]
Sat Aug 8 20:29:45 2015 us=152735 event_wait returned 0
Sat Aug 8 20:29:45 2015 us=152855 I/O WAIT status=0x0020
Sat Aug 8 20:29:45 2015 us=152886 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:45 2015 us=152911 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:45 2015 us=152940 I/O WAIT T?|T?|SR|Sw [1/216810]
Sat Aug 8 20:29:46 2015 us=372347 event_wait returned 0
Sat Aug 8 20:29:46 2015 us=372474 I/O WAIT status=0x0020
Sat Aug 8 20:29:46 2015 us=372505 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:46 2015 us=372531 PO_CTL rwflags=0x0001 ev=3 arg=0x7fe574db8150
Sat Aug 8 20:29:46 2015 us=372560 I/O WAIT T?|T?|SR|Sw [1/216810]
Sat Aug 8 20:29:47 2015 us=590977 event_wait returned 0
Sat Aug 8 20:29:47 2015 us=591080 I/O WAIT status=0x0020
Sat Aug 8 20:29:47 2015 us=591105 TIMER: coarse timer wakeup 1 seconds
Sat Aug 8 20:29:47 2015 us=591172 TLS: tls_multi_process: i=0 state=S_PRE_START, mysid=65413015 9b9d99bb, stored-sid=00000000 00000000, stored-ip=[AF_INET]XXX.XXX.XXX.XXX:11940
Sat Aug 8 20:29:47 2015 us=591193 TLS: tls_process: chg=0 ks=S_PRE_START lame=S_UNDEF to_link->len=0 wakeup=604800
Sat Aug 8 20:29:47 2015 us=591212 ACK reliable_can_send active=1 current=0 : [1] 0
Sat Aug 8 20:29:47 2015 us=591254 ACK reliable_send_timeout 17 [1] 0
Sat Aug 8 20:29:47 2015 us=591272 TLS: tls_process: timeout set to 15

orcape · Beitrag von **orcape** » 09.08.2015 12:48:29

So wie das aussieht hast Du eine MTU-Größe von 1500 gewählt.
Wie sieht den Deine Config aus und was sagen die Routing -Protokolle ?

H8Ball · Beitrag von **H8Ball** » 09.08.2015 13:09:39

Ich habe die Größe nicht gewählt, ist alles so wie vorher auch, und es hat ja ohne Probleme funktioniert, bis auf einmal nichts mehr ging.

Das ist die Konfiguration vom Server

port 11940
proto udp
dev tun
ca easy-rsa2/keys/ca.crt
cert easy-rsa2/keys/server.crt
key easy-rsa2/keys/server.key # This file should be kept secret
dh easy-rsa2/keys/dh1024.pem
server 10.8.0.0 255.255.255.0
ifconfig-pool-persist ipp.txt
client-config-dir ccd
client-config-dir ccd
client-to-client
keepalive 10 120
comp-lzo
user nobody
group nogroup
persist-key
persist-tun
status braeuer-status.log
log openvpn.log
;log-append openvpn.log
verb 9

orcape · Beitrag von **orcape** » 09.08.2015 14:22:40

.....ist alles so wie vorher auch,

Kann sein, muss nicht. Bei mir hat eine Änderung auf Providerseite anschließend Probleme mit der MTU gemacht.
Die MTU 1500-Größe macht der Tunnel automatisch, kann aber unter bestimmten Bedingungen dazu führen, das der Tunnel abbricht oder die Pakete einfach verworfen werden.

und es hat ja ohne Probleme funktioniert, bis auf einmal nichts mehr ging.

Bei mir liefen 3 Tunnel über 2 Jahre mit MTU 1500, dann kam eine Änderung des Providers auf der Client-Seite und das war es dann.
Das könnte (muss nicht) damit zusammenhängen.
In die Server.config einfach tun-mtu = 1432 einfügen.
Ich habe einen Tunnel der läuft oberhalb MTU 1400 nicht, da habe ich das sogar auf 1342 reduziert.
Gruß orcape

H8Ball · Beitrag von **H8Ball** » 09.08.2015 15:41:58

Leider keine Änderung.

TomL · Beitrag von **TomL** » 11.08.2015 18:50:00

H8Ball hat geschrieben:Es läuft ein Openvpn-Server der auch die ganze Zeit tadelos seinen Dienst gemacht hat. Aber seit neuestem nimmt er keine Verbindungen mehr an.

Haben deine Zertifikate einen Gültigkeitszeitraum eingetragen?

H8Ball · Beitrag von **H8Ball** » 12.08.2015 13:03:28

Nach langem Testen, habe ich den Server neu installiert.
Die alten Openvpn-Configs wieder eingespielt, und siehe da, es funktioniert.

Was jetzt das Problem war, kann ich leider nicht sagen.

Daher kann man den Thread auch löschen.

debianforum.de

OpenVPN funktioniert nicht mehr

OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr

Re: AW: OpenVPN funktioniert nicht mehr

Re: OpenVPN funktioniert nicht mehr