Probleme beim Aufbau einer VPN Verbindung mit Openvpn

[Nils0815]

Hallo zusammen,
ich würde gerne eine VPN Verbindung mit Zertifikaten aufbauen. Dazu habe ich Freetz mit OpenVPN auf meine Fritzbox 7141 gespielt und dieses Howto http://trac.freetz.org/wiki/packages/openvpn befolgt. Leider kenne ich mich mit OPEN VPN nicht aus. Mein Problem ist jetzt folgendes:
Ich habe alle Zertifikate generiert und auf den Server und den Cleinet gespielt. Die Server-Config sieht wie folgt aus:

#  OpenVPN 2.1 Config
proto udp
dev tap0
ca /tmp/flash/ca.crt
cert /tmp/flash/box.crt
key /tmp/flash/box.key
dh /tmp/flash/dh.pem
crl-verify /tmp/flash/crl.pem
tls-server
tls-auth /tmp/flash/static.key 0
port 1194
mode server
ifconfig-pool 192.168.200.100 192.168.200.150
push "route 192.168.200.1 "
ifconfig 192.168.200.1 255.255.255.0
push "route-gateway 192.168.200.1"
push "route 192.168.178.0 255.255.255.0"
max-clients 5
tun-mtu 1500
mssfix
verb 3
daemon
cipher AES-128-CBC
keepalive 10 120

Dies ist die Client-Config:

  remote xyz.dyndns.org
  port 1194
  proto udp
  dev tap
  tls-client
  ns-cert-type server
  ca "C:\\Programme\\OpenVPN\\config\\ca.crt"
  cert "C:\\Programme\\OpenVPN\\config\\clientn01.crt"
  key "C:\\Programme\\OpenVPN\\config\\clientn01.key"
  tls-auth "C:\\Programme\\OpenVPN\\config\\static.key" 1
  tun-mtu 1500
  mssfix
  nobind
  pull
  verb 3

Leider wird des Icon von der OpenVPN GUI nur gelb und nicht grün. Ich habe jetzt schon mehrere Stunden damit verbracht den Fehler zu finden aber nichts was ich gelesen habe hat geholfen. Auf dem Client Rechner habe ich die Firewall deaktiviert.
Vielleicht kann mir ja jemand von euch helfen?

 

[µRaCoLi]

Was gibt dein Client denn so an Meldungen aus?

 

[Nils0815]

Dies steht in der Logdatei:

(…)
Wed Sep 08 23:04:41 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Wed Sep 08 23:04:41 2010 TLS Error: TLS handshake failed
Wed Sep 08 23:04:41 2010 TCP/UDP: Closing socket
(…)

 

[MaxMuster]

Die beiden Verschlüsselungsoptionen ("Cipher") stimmen nicht überein, der Standard ist BF-CBC ("Blowfish") und in der GUI ist gewählt AES-128-CBC.

Der "Fehler" ist leider auch in der Beispielconfig des Clients im Wiki (besser: war ;-)).
Ergänze im Client bitte "cipher AES-128-CBC" und lasse die GUI-Einstellung oder wähle in der GUI "Blowfish" und lasse den Client so...

Jörg

 

[Nils0815]

Hey vielen Dank erst mal für eure schnelle Antwort….
Ich habe gestern die Verschlüsselungsoptionen Blowfish in der GUI eingestellt. Leider hat sich dadurch nichts verändert. Das Symbol bleibt gelb ;-(
Die ist die Aktuelle Logdatei:

Fri Sep 10 08:36:27 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Fri Sep 10 08:36:27 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Fri Sep 10 08:36:27 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Fri Sep 10 08:36:27 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Fri Sep 10 08:36:27 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Fri Sep 10 08:36:27 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
(…)

Hab ihr vielleicht noch eine Idee woran es liegen könnte?

 

[MaxMuster]

Weitere Fragen:
Was sagt das Log des Servers? Startet der korrekt?
Hast du wirklich eine CRL (Liste mit zurückgezogenen Zertifikaten) eingetragen? Ansonsten wäre das ein weiterer Punkt, den du prüfen solltest. Im Zweifel lösche die Datei "/tmp/flash/crl.pem"

Jörg

 

[Nils0815]

Also die Logdatei sieht so aus:

 [1;1H [0J
Sat Sep 11 14:13:03 2010 OpenVPN 2.1.1 mipsel-linux [SSL] [LZO2] [EPOLL] [MH] bu

Sat Sep 11 14:13:03 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or hig

Sat Sep 11 14:13:04 2010 Diffie-Hellman initialized with 1024 bit key

Sat Sep 11 14:13:04 2010 WARNING: file '/tmp/flash/box.key' is group or others a

Sat Sep 11 14:13:04 2010 Control Channel Authentication: using '/tmp/flash/stati

Sat Sep 11 14:13:04 2010 Outgoing Control Channel Authentication: Using 160 bit

Sat Sep 11 14:13:04 2010 Incoming Control Channel Authentication: Using 160 bit

Sat Sep 11 14:13:04 2010 TLS-Auth MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0

Sat Sep 11 14:13:04 2010 TUN/TAP device tap0 opened

Sat Sep 11 14:13:04 2010 TUN/TAP TX queue length set to 100

Sat Sep 11 14:13:04 2010 /sbin/ifconfig tap0 192.168.200.1 netmask 255.255.255.0

Sat Sep 11 14:13:04 2010 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32

Sat Sep 11 14:13:04 2010 Socket Buffers: R=[110592->131072] S=[110592->131072]

Sat Sep 11 14:13:04 2010 UDPv4 link local (bound): [undef]

Sat Sep 11 14:13:04 2010 UDPv4 link remote: [undef]

Sat Sep 11 14:13:04 2010 MULTI: multi_init called, r=256 v=256

Sat Sep 11 14:13:04 2010 IFCONFIG POOL: base=192.168.200.100 size=51

Sat Sep 11 14:13:04 2010 Initialization Sequence Completed

Und der Dienst wird als running gemeldet. In der CRL habe ich auch nichts eingetragen.
Danke schon mal für deine Mühe….

 

[MaxMuster]

Poste doch mal ein Log während des Verbindungsaufbaus.
Testest du von "extern" (also durch das Internet)? Wenn ja: wie hast du die Portweiterleitung gemacht? Auf die IP 0.0.0.0?

Jörg

 

[Nils0815]

Ich habe es bisher sowohl intern als auch extern getestet. Das Ergebnis ist das gleiche. Die Prot Weiterleitung habe ich mit AVM Firewall durchgeführt. Dort habe ich das ganze sohl für tcp als auch für UDP für den Port 1194 eingerichtet. Ich weiß das eigentlich UDP recht aber naja….
Die ist die Log Datei vom Server:


Sat Jan  1 01:00:52 2000 us=557892 OpenVPN 2.1.1 mipsel-linux [SSL] [LZO2] [EPOL

Sat Jan  1 01:00:52 2000 us=563895 NOTE: OpenVPN 2.1 requires '--script-security

Sat Jan  1 01:00:53 2000 us=182811 Diffie-Hellman initialized with 1024 bit key

Sat Jan  1 01:00:53 2000 us=189881 WARNING: file '/tmp/flash/box.key' is group o

Sat Jan  1 01:00:53 2000 us=207248 Control Channel Authentication: using '/tmp/f

Sat Jan  1 01:00:53 2000 us=208072 Outgoing Control Channel Authentication: Usin

Sat Jan  1 01:00:53 2000 us=208740 Incoming Control Channel Authentication: Usin

Sat Jan  1 01:00:53 2000 us=209856 TLS-Auth MTU parms [ L:1573 D:166 EF:66 EB:0

Sat Jan  1 01:00:53 2000 us=262006 TUN/TAP device tap0 opened

Sat Jan  1 01:00:53 2000 us=262712 TUN/TAP TX queue length set to 100

Sat Jan  1 01:00:53 2000 us=263924 /sbin/ifconfig tap0 192.168.200.1 netmask 255

Sat Jan  1 01:00:53 2000 us=319433 Data Channel MTU parms [ L:1573 D:1450 EF:41

Sat Jan  1 01:00:53 2000 us=328336 Socket Buffers: R=[110592->131072] S=[110592-

Sat Jan  1 01:00:53 2000 us=329347 UDPv4 link local (bound): [undef]

Sat Jan  1 01:00:53 2000 us=332613 UDPv4 link remote: [undef]

Sat Jan  1 01:00:53 2000 us=333333 MULTI: multi_init called, r=256 v=256

Sat Jan  1 01:00:53 2000 us=335717 IFCONFIG POOL: base=192.168.200.100 size=51

Sat Jan  1 01:00:53 2000 us=337274 Initialization Sequence Completed

Sat Jan  1 01:00:53 2000 us=337932  event_wait returned 1

Sat Jan  1 01:00:53 2000 us=339448  read from TUN/TAP returned 50

Sat Jan  1 01:00:53 2000 us=342062  event_wait returned 1

Sat Jan  1 01:00:53 2000 us=342690  read from TUN/TAP returned 62

Sat Jan  1 01:00:58 2000 us=862504  event_wait returned 1- /var/vi.tmp 1/805 0%

Und dies die Logdatei vom Client:

Sat Sep 11 15:30:22 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Sat Sep 11 15:30:22 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Sat Sep 11 15:30:22 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Sat Sep 11 15:30:22 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:30:22 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:30:22 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Sat Sep 11 15:30:22 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Sat Sep 11 15:30:22 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Sat Sep 11 15:30:22 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Sat Sep 11 15:30:22 2010 Local Options hash (VER=V4): '715aaf04'
Sat Sep 11 15:30:22 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Sat Sep 11 15:30:22 2010 UDPv4 link local: [undef]
Sat Sep 11 15:30:22 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Sat Sep 11 15:31:22 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Sat Sep 11 15:31:22 2010 TLS Error: TLS handshake failed
Sat Sep 11 15:31:22 2010 TCP/UDP: Closing socket
Sat Sep 11 15:31:22 2010 SIGUSR1[soft,tls-error] received, process restarting
Sat Sep 11 15:31:22 2010 Restart pause, 2 second(s)
Sat Sep 11 15:31:24 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Sat Sep 11 15:31:24 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Sat Sep 11 15:31:24 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:31:24 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:31:24 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Sat Sep 11 15:31:24 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Sat Sep 11 15:31:24 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Sat Sep 11 15:31:24 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Sat Sep 11 15:31:24 2010 Local Options hash (VER=V4): '715aaf04'
Sat Sep 11 15:31:24 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Sat Sep 11 15:31:24 2010 UDPv4 link local: [undef]
Sat Sep 11 15:31:24 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Sat Sep 11 15:32:24 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Sat Sep 11 15:32:24 2010 TLS Error: TLS handshake failed
Sat Sep 11 15:32:24 2010 TCP/UDP: Closing socket
Sat Sep 11 15:32:24 2010 SIGUSR1[soft,tls-error] received, process restarting
Sat Sep 11 15:32:24 2010 Restart pause, 2 second(s)
Sat Sep 11 15:32:26 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Sat Sep 11 15:32:26 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Sat Sep 11 15:32:26 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:32:26 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:32:26 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Sat Sep 11 15:32:26 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Sat Sep 11 15:32:26 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Sat Sep 11 15:32:26 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Sat Sep 11 15:32:26 2010 Local Options hash (VER=V4): '715aaf04'
Sat Sep 11 15:32:26 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Sat Sep 11 15:32:26 2010 UDPv4 link local: [undef]
Sat Sep 11 15:32:26 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Sat Sep 11 15:33:26 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Sat Sep 11 15:33:26 2010 TLS Error: TLS handshake failed
Sat Sep 11 15:33:26 2010 TCP/UDP: Closing socket
Sat Sep 11 15:33:26 2010 SIGUSR1[soft,tls-error] received, process restarting
Sat Sep 11 15:33:26 2010 Restart pause, 2 second(s)
Sat Sep 11 15:33:28 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Sat Sep 11 15:33:28 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Sat Sep 11 15:33:28 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:33:28 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Sat Sep 11 15:33:28 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Sat Sep 11 15:33:28 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Sat Sep 11 15:33:28 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Sat Sep 11 15:33:28 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Sat Sep 11 15:33:28 2010 Local Options hash (VER=V4): '715aaf04'
Sat Sep 11 15:33:28 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Sat Sep 11 15:33:28 2010 UDPv4 link local: [undef]
Sat Sep 11 15:33:28 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194

 

[MaxMuster]

Da deine Box scheinbar keine korrekte Uhrzeit hat, sind auf jeden Fall die Zertifikate noch nicht gültig.
Dann sollte aber eine Fehlermeldung der Art: "error=certificate is not yet valid" dort auftauchen (vielleicht auch nur bei größerem "verb" Level). So setzt du Datum/Uhrzeit direkt

date -s '2010-09-11 15:00:00'

Hilft das? Sonst bitte mit größerem Wert bei "verb" nochmal versuchen ..

Jörg

 

[Nils0815]

[...]
Hi sorry aber ich hab echt keine Ahnung wo ich das jetzt eintragen muss? Hab es jetzt als Befehl in der Rudi-Shell ausgeführt. Dabei hat sich keine Änderung ergeben..

 

[MaxMuster]

Das war dort schon o.k., im Log sollte danach zumindest das Datum stimmen (und nicht mehr der 1.1.2000), die Uhrzeit nur, wenn du sie anpasst.
Mit "date" kannst du das überprüfen.

Ansonsten bitte ein Log des Servers vom Verbindungsaufbau mit verbose-level 6 anhängen.

Jörg

 

[Nils0815]

Hi Jörg,
erst mal danke für deine ganze Mühe. Das mit dem Datum hat leider nicht funktioniert. Ich kann dir aber leider nicht ganz folgen. Bisher habe ich den Log des Servers ausgelesen in dem ich in die Rudi-Shell dieses eingegeben habe:

cat /var/tmp/debug_openvpn.out > /var/tmp/flash/debug_openvpn.out
cd /var/tmp/flash/
nvi debug_openvpn.out

Das ist das folgendes Ergebnis:


Sat Jan  1 01:00:52 2000 us=557892 OpenVPN 2.1.1 mipsel-linux [SSL] [LZO2] [EPOL

Sat Jan  1 01:00:52 2000 us=563895 NOTE: OpenVPN 2.1 requires '--script-security

Sat Jan  1 01:00:53 2000 us=182811 Diffie-Hellman initialized with 1024 bit key

Sat Jan  1 01:00:53 2000 us=189881 WARNING: file '/tmp/flash/box.key' is group o

Sat Jan  1 01:00:53 2000 us=207248 Control Channel Authentication: using '/tmp/f

Sat Jan  1 01:00:53 2000 us=208072 Outgoing Control Channel Authentication: Usin

Sat Jan  1 01:00:53 2000 us=208740 Incoming Control Channel Authentication: Usin

Sat Jan  1 01:00:53 2000 us=209856 TLS-Auth MTU parms [ L:1573 D:166 EF:66 EB:0

Sat Jan  1 01:00:53 2000 us=262006 TUN/TAP device tap0 opened

Sat Jan  1 01:00:53 2000 us=262712 TUN/TAP TX queue length set to 100

Sat Jan  1 01:00:53 2000 us=263924 /sbin/ifconfig tap0 192.168.200.1 netmask 255

Sat Jan  1 01:00:53 2000 us=319433 Data Channel MTU parms [ L:1573 D:1450 EF:41

Sat Jan  1 01:00:53 2000 us=328336 Socket Buffers: R=[110592->131072] S=[110592-

Sat Jan  1 01:00:53 2000 us=329347 UDPv4 link local (bound): [undef]

Sat Jan  1 01:00:53 2000 us=332613 UDPv4 link remote: [undef]

Sat Jan  1 01:00:53 2000 us=333333 MULTI: multi_init called, r=256 v=256

Sat Jan  1 01:00:53 2000 us=335717 IFCONFIG POOL: base=192.168.200.100 size=51

Sat Jan  1 01:00:53 2000 us=337274 Initialization Sequence Completed

Sat Jan  1 01:00:53 2000 us=337932  event_wait returned 1

Sat Jan  1 01:00:53 2000 us=339448  read from TUN/TAP returned 50

Sat Jan  1 01:00:53 2000 us=342062  event_wait returned 1

Sat Jan  1 01:00:53 2000 us=342690  read from TUN/TAP returned 62

Sat Jan  1 01:00:58 2000 us=862504  event_wait returned 1- /var/vi.tmp 1/805 0%

Aber was meinst du mit „Ansonsten bitte ein Log des Servers vom Verbindungsaufbau mit verbose-level 6 anhängen“?
Gruß
Nils

 

[MaxMuster]

Das mit dem Datum hat leider nicht funktioniert.

Solange die Box ein so falsches Datum hat, wird die Verbindung nicht funktionieren (es sei denn, du hättest die Zertifikate vor dem 1.1.2000 erstellt).
Du musst also zwingend erstmal die Uhrzeit stellen, per Telnet-Verbindung oder in der RudiShell.
Nur zur Sicherheit: Bist du sicher, dass die Box auch richtig im Internet ist? Denn eigentlich sollte sie die Uhrzeit schon selbsttätig stellen. Wenn die Internetverbindung da ist, könntest du die Zeit auch "korrekt" stellen lassen mit dem Befehl "rdate" (in Telnet oder RudiShell) :

rdate -s time.fu-berlin.de

Zum Log: Den Debug-Output erzeugst du ja, indem du auf der GUI den Haken setzt. Dort gibt es dann ein Feld, it dem "verbose" Level (da steht standardmäßig "3" drin. Den bitte auf 6 stellen, dann wird das Log viel "gesprächiger".
"Schöner" bekommst du das übrigens, indem du es einfach anzeigen lässt:

cat /var/tmp/debug_openvpn.out

. Dann sollten diese blöden Leerzeilen nicht dasein...

Mit falschem Datum wird das aber ziemlich sicher nix werden...

 

[Nils0815]

Hallo Jörg,
also das mit dem Datum hat jetzt funktioniert. Der Log vom Server sieht nun folgendermaßen aus:

 Mon Sep 13 10:26:17 2010 us=153739 OpenVPN 2.1.1 mipsel-linux [SSL] [LZO2] [EPOLL] [MH] built on Sep  7 2010
Mon Sep 13 10:26:17 2010 us=160007 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:26:17 2010 us=468816 Diffie-Hellman initialized with 1024 bit key
Mon Sep 13 10:26:17 2010 us=475753 WARNING: file '/tmp/flash/box.key' is group or others accessible
Mon Sep 13 10:26:17 2010 us=494500 Control Channel Authentication: using '/tmp/flash/static.key' as a OpenVPN static key file
Mon Sep 13 10:26:17 2010 us=495337 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:26:17 2010 us=496022 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:26:17 2010 us=498329 TLS-Auth MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:26:17 2010 us=513597 TUN/TAP device tap0 opened
Mon Sep 13 10:26:17 2010 us=514305 TUN/TAP TX queue length set to 100
Mon Sep 13 10:26:17 2010 us=515512 /sbin/ifconfig tap0 192.168.200.1 netmask 255.255.255.0 mtu 1500 broadcast 192.168.200.255
Mon Sep 13 10:26:17 2010 us=558706 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:26:17 2010 us=753398 Socket Buffers: R=[110592->131072] S=[110592->131072]
Mon Sep 13 10:26:17 2010 us=754403 UDPv4 link local (bound): [undef]
Mon Sep 13 10:26:17 2010 us=754945 UDPv4 link remote: [undef]
Mon Sep 13 10:26:17 2010 us=755625 MULTI: multi_init called, r=256 v=256
Mon Sep 13 10:26:17 2010 us=759709 IFCONFIG POOL: base=192.168.200.100 size=51
Mon Sep 13 10:26:17 2010 us=761291 Initialization Sequence Completed
Mon Sep 13 10:27:56 2010 us=471382 MULTI: multi_create_instance called
Mon Sep 13 10:27:56 2010 us=473516 91.97.211.114:56845 Re-using SSL/TLS context
Mon Sep 13 10:27:56 2010 us=486109 91.97.211.114:56845 Control Channel MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:27:56 2010 us=489801 91.97.211.114:56845 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:27:56 2010 us=492781 91.97.211.114:56845 UDPv4 READ [42] from [AF_INET]91.97.211.114:56845: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 pid=[ #1 ] [ ] pid=0 DATA len=0
Mon Sep 13 10:27:56 2010 us=493932 91.97.211.114:56845 TLS: Initial packet from [AF_INET]91.97.211.114:56845, sid=f62a938a d6382376
Mon Sep 13 10:27:56 2010 us=499698 91.97.211.114:56845 UDPv4 WRITE [54] to [AF_INET]91.97.211.114:56845: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 pid=[ #1 ] [ 0 ] pid=0 DATA len=0
Mon Sep 13 10:27:56 2010 us=670984 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #2 ] [ 0 ]
Mon Sep 13 10:27:56 2010 us=675938 91.97.211.114:56845 UDPv4 READ [136] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=1 DATA len=94
Mon Sep 13 10:27:57 2010 us=253387 91.97.211.114:56845 UDPv4 WRITE [154] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #2 ] [ 1 ] pid=1 DATA len=100
Mon Sep 13 10:27:57 2010 us=260865 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=2 DATA len=100
Mon Sep 13 10:27:57 2010 us=264904 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #4 ] [ ] pid=3 DATA len=100
Mon Sep 13 10:27:57 2010 us=271281 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #5 ] [ ] pid=4 DATA len=100
Mon Sep 13 10:27:57 2010 us=466009 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #4 ] [ 1 ]
Mon Sep 13 10:27:57 2010 us=471821 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #6 ] [ ] pid=5 DATA len=100
Mon Sep 13 10:27:57 2010 us=479235 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #5 ] [ 2 ]
Mon Sep 13 10:27:57 2010 us=482249 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #7 ] [ ] pid=6 DATA len=100
Mon Sep 13 10:27:57 2010 us=488481 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #6 ] [ 3 ]
Mon Sep 13 10:27:57 2010 us=492425 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #8 ] [ ] pid=7 DATA len=100
Mon Sep 13 10:27:57 2010 us=496201 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #7 ] [ 4 ]
Mon Sep 13 10:27:57 2010 us=502097 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #9 ] [ ] pid=8 DATA len=100
Mon Sep 13 10:27:57 2010 us=650422 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #8 ] [ 5 ]
Mon Sep 13 10:27:57 2010 us=656181 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #10 ] [ ] pid=9 DATA len=100
Mon Sep 13 10:27:57 2010 us=661429 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #9 ] [ 6 ]
Mon Sep 13 10:27:57 2010 us=664409 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #11 ] [ ] pid=10 DATA len=100
Mon Sep 13 10:27:57 2010 us=671276 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #10 ] [ 7 ]
Mon Sep 13 10:27:57 2010 us=674246 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #12 ] [ ] pid=11 DATA len=100
Mon Sep 13 10:27:57 2010 us=680113 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #11 ] [ 8 ]
Mon Sep 13 10:27:57 2010 us=683942 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #13 ] [ ] pid=12 DATA len=100
Mon Sep 13 10:27:57 2010 us=757523 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #12 ] [ 9 ]
Mon Sep 13 10:27:57 2010 us=760491 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #14 ] [ ] pid=13 DATA len=100
Mon Sep 13 10:27:57 2010 us=772438 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #13 ] [ 10 ]
Mon Sep 13 10:27:57 2010 us=775400 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #15 ] [ ] pid=14 DATA len=100
Mon Sep 13 10:27:57 2010 us=790514 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #14 ] [ 11 ]
Mon Sep 13 10:27:57 2010 us=793467 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #16 ] [ ] pid=15 DATA len=100
Mon Sep 13 10:27:57 2010 us=799027 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #15 ] [ 12 ]
Mon Sep 13 10:27:57 2010 us=801961 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #17 ] [ ] pid=16 DATA len=100
Mon Sep 13 10:27:57 2010 us=922270 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #16 ] [ 13 ]
Mon Sep 13 10:27:57 2010 us=926121 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #18 ] [ ] pid=17 DATA len=100
Mon Sep 13 10:27:57 2010 us=935843 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #17 ] [ 14 ]
Mon Sep 13 10:27:57 2010 us=943075 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #19 ] [ ] pid=18 DATA len=100
Mon Sep 13 10:27:57 2010 us=949680 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #18 ] [ 15 ]
Mon Sep 13 10:27:57 2010 us=952608 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #20 ] [ ] pid=19 DATA len=100
Mon Sep 13 10:27:57 2010 us=959426 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #19 ] [ 16 ]
Mon Sep 13 10:27:57 2010 us=962345 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #21 ] [ ] pid=20 DATA len=100
Mon Sep 13 10:27:58 2010 us=85114 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #20 ] [ 17 ]
Mon Sep 13 10:27:58 2010 us=88751 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #22 ] [ ] pid=21 DATA len=100
Mon Sep 13 10:27:58 2010 us=173821 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #21 ] [ 18 ]
Mon Sep 13 10:27:58 2010 us=180049 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #23 ] [ ] pid=22 DATA len=100
Mon Sep 13 10:27:58 2010 us=183837 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #22 ] [ 19 ]
Mon Sep 13 10:27:58 2010 us=189536 91.97.211.114:56845 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #24 ] [ ] pid=23 DATA len=100
Mon Sep 13 10:27:58 2010 us=193308 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #23 ] [ 20 ]
Mon Sep 13 10:27:58 2010 us=200212 91.97.211.114:56845 UDPv4 WRITE [56] to [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #25 ] [ ] pid=24 DATA len=14
Mon Sep 13 10:27:58 2010 us=230553 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #24 ] [ 21 ]
Mon Sep 13 10:27:58 2010 us=291768 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #25 ] [ 22 ]
Mon Sep 13 10:27:58 2010 us=294686 91.97.211.114:56845 UDPv4 READ [50] from [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #26 ] [ 23 ]
Mon Sep 13 10:27:58 2010 us=404914 91.97.211.114:56845 UDPv4 READ [154] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #27 ] [ 24 ] pid=2 DATA len=100
Mon Sep 13 10:27:58 2010 us=409786 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #26 ] [ 2 ]
Mon Sep 13 10:27:58 2010 us=415117 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #28 ] [ ] pid=3 DATA len=100
Mon Sep 13 10:27:58 2010 us=421730 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #27 ] [ 3 ]
Mon Sep 13 10:27:58 2010 us=425549 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #29 ] [ ] pid=4 DATA len=100
Mon Sep 13 10:27:58 2010 us=430754 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #28 ] [ 4 ]
Mon Sep 13 10:27:58 2010 us=435092 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #30 ] [ ] pid=5 DATA len=100
Mon Sep 13 10:27:58 2010 us=439365 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #29 ] [ 5 ]
Mon Sep 13 10:27:58 2010 us=579799 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #31 ] [ ] pid=6 DATA len=100
Mon Sep 13 10:27:58 2010 us=581857 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #30 ] [ 6 ]
Mon Sep 13 10:27:58 2010 us=598456 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #32 ] [ ] pid=7 DATA len=100
Mon Sep 13 10:27:58 2010 us=600513 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #31 ] [ 7 ]
Mon Sep 13 10:27:58 2010 us=603862 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #33 ] [ ] pid=8 DATA len=100
Mon Sep 13 10:27:58 2010 us=606869 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #32 ] [ 8 ]
Mon Sep 13 10:27:58 2010 us=609173 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #34 ] [ ] pid=9 DATA len=100
Mon Sep 13 10:27:58 2010 us=611766 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #33 ] [ 9 ]
Mon Sep 13 10:27:58 2010 us=693658 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #35 ] [ ] pid=10 DATA len=100
Mon Sep 13 10:27:58 2010 us=695719 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #34 ] [ 10 ]
Mon Sep 13 10:27:58 2010 us=700347 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #36 ] [ ] pid=11 DATA len=100
Mon Sep 13 10:27:58 2010 us=702399 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #35 ] [ 11 ]
Mon Sep 13 10:27:58 2010 us=709455 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #37 ] [ ] pid=12 DATA len=100
Mon Sep 13 10:27:58 2010 us=711512 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #36 ] [ 12 ]
Mon Sep 13 10:27:58 2010 us=714237 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #38 ] [ ] pid=13 DATA len=100
Mon Sep 13 10:27:58 2010 us=717137 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #37 ] [ 13 ]
Mon Sep 13 10:27:58 2010 us=828937 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #39 ] [ ] pid=14 DATA len=100
Mon Sep 13 10:27:58 2010 us=830996 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #38 ] [ 14 ]
Mon Sep 13 10:27:58 2010 us=836002 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #40 ] [ ] pid=15 DATA len=100
Mon Sep 13 10:27:58 2010 us=838965 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #39 ] [ 15 ]
Mon Sep 13 10:27:58 2010 us=841257 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #41 ] [ ] pid=16 DATA len=100
Mon Sep 13 10:27:58 2010 us=843856 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #40 ] [ 16 ]
Mon Sep 13 10:27:58 2010 us=848258 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #42 ] [ ] pid=17 DATA len=100
Mon Sep 13 10:27:58 2010 us=850316 91.97.211.114:56845 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:56845: P_ACK_V1 kid=0 pid=[ #41 ] [ 17 ]
Mon Sep 13 10:27:58 2010 us=972012 91.97.211.114:56845 UDPv4 READ [142] from [AF_INET]91.97.211.114:56845: P_CONTROL_V1 kid=0 pid=[ #43 ] [ ] pid=18 DATA len=100
Mon Sep 13 10:27:58 2010 us=985722 91.97.211.114:56845 CRL: cannot read CRL from file /tmp/flash/crl.pem
Mon Sep 13 10:27:58 2010 us=988049 91.97.211.114:56845 Exiting

Dies ist der vom Client:

 Mon Sep 13 10:28:44 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Mon Sep 13 10:28:44 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:28:44 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:28:44 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:28:44 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:28:44 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:28:44 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:28:44 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:28:44 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:28:44 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:28:44 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:28:44 2010 UDPv4 link local: [undef]
Mon Sep 13 10:28:44 2010 UDPv4 link remote: xx.xx.xxx.xxx:1194
Mon Sep 13 10:29:02 2010 TCP/UDP: Closing socket
Mon Sep 13 10:29:02 2010 SIGTERM[hard,] received, process exiting
Mon Sep 13 10:29:02 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Mon Sep 13 10:29:02 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:29:02 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:29:02 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:29:02 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:29:02 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:29:02 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:29:02 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:29:03 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:29:03 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:29:03 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:29:03 2010 UDPv4 link local: [undef]
Mon Sep 13 10:29:03 2010 UDPv4 link remote: xxx.xxx.xxx.xxx:1194
Mon Sep 13 10:30:03 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:30:03 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:30:03 2010 TCP/UDP: Closing socket
Mon Sep 13 10:30:03 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:30:03 2010 Restart pause, 2 second(s)
Mon Sep 13 10:30:05 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:30:05 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:30:05 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:30:05 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:30:05 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:30:05 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:30:05 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:30:05 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:30:05 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:30:05 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:30:05 2010 UDPv4 link local: [undef]
Mon Sep 13 10:30:05 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:30:47 2010 TCP/UDP: Closing socket
Mon Sep 13 10:30:47 2010 SIGTERM[hard,] received, process exiting
Mon Sep 13 10:30:47 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Mon Sep 13 10:30:47 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:30:47 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:30:47 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:30:47 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:30:47 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:30:47 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:30:47 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:30:48 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:30:48 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:30:48 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:30:48 2010 UDPv4 link local: [undef]
Mon Sep 13 10:30:48 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:31:48 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:31:48 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:31:48 2010 TCP/UDP: Closing socket
Mon Sep 13 10:31:48 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:31:48 2010 Restart pause, 2 second(s)
Mon Sep 13 10:31:50 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:31:50 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:31:50 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:31:50 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:31:50 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:31:50 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:31:50 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:31:52 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:31:52 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:31:52 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:31:52 2010 UDPv4 link local: [undef]
Mon Sep 13 10:31:52 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:32:52 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:32:52 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:32:52 2010 TCP/UDP: Closing socket
Mon Sep 13 10:32:52 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:32:52 2010 Restart pause, 2 second(s)
Mon Sep 13 10:32:54 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:32:54 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:32:54 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:32:54 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:32:54 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:32:54 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:32:54 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:32:54 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:32:54 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:32:54 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:32:54 2010 UDPv4 link local: [undef]
Mon Sep 13 10:32:54 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:33:55 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:33:55 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:33:55 2010 TCP/UDP: Closing socket
Mon Sep 13 10:33:55 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:33:55 2010 Restart pause, 2 second(s)
Mon Sep 13 10:33:57 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:33:57 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:33:57 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:33:57 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:33:57 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:33:57 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:33:57 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:33:57 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:33:57 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:33:57 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:33:57 2010 UDPv4 link local: [undef]
Mon Sep 13 10:33:57 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194

Eine Verbindung kommt aber leider immer noch nicht zustande.

 

[MaxMuster]

CRL: cannot read CRL from file /tmp/flash/crl.pem

Hatte ich oben schonmal angemerkt (#6): Bitte nochmal prüfen, ob in der CRL nicht doch was steht (Leerzeichen oder so).
Im Zweifel bitte die Datei löschen ("rm tmp/flash/crl.pem")

Jörg

 

[Nils0815]

Also hab die Datei nochmal gelöscht. Mir ist jetzt aufgefallen der der Dienst Open VPN nach einem Verbindungsversuch nun immer wieder beendet wird.
Log vom Server:

 Mon Sep 13 11:00:05 2010 us=609081 OpenVPN 2.1.1 mipsel-linux [SSL] [LZO2] [EPOLL] [MH] built on Sep  7 2010
Mon Sep 13 11:00:05 2010 us=614256 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 11:00:05 2010 us=919723 Diffie-Hellman initialized with 1024 bit key
Mon Sep 13 11:00:05 2010 us=928967 WARNING: file '/tmp/flash/box.key' is group or others accessible
Mon Sep 13 11:00:05 2010 us=945052 Control Channel Authentication: using '/tmp/flash/static.key' as a OpenVPN static key file
Mon Sep 13 11:00:05 2010 us=945889 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:05 2010 us=948485 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:05 2010 us=949641 TLS-Auth MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 11:00:05 2010 us=964522 TUN/TAP device tap0 opened
Mon Sep 13 11:00:05 2010 us=965225 TUN/TAP TX queue length set to 100
Mon Sep 13 11:00:05 2010 us=968034 /sbin/ifconfig tap0 192.168.200.1 netmask 255.255.255.0 mtu 1500 broadcast 192.168.200.255
Mon Sep 13 11:00:06 2010 us=12528 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 11:00:06 2010 us=145437 Socket Buffers: R=[110592->131072] S=[110592->131072]
Mon Sep 13 11:00:06 2010 us=149071 UDPv4 link local (bound): [undef]
Mon Sep 13 11:00:06 2010 us=149643 UDPv4 link remote: [undef]
Mon Sep 13 11:00:06 2010 us=150325 MULTI: multi_init called, r=256 v=256
Mon Sep 13 11:00:06 2010 us=151975 IFCONFIG POOL: base=192.168.200.100 size=51
Mon Sep 13 11:00:06 2010 us=153538 Initialization Sequence Completed
Mon Sep 13 11:00:14 2010 us=892689 MULTI: multi_create_instance called
Mon Sep 13 11:00:14 2010 us=894054 91.97.211.114:49898 Re-using SSL/TLS context
Mon Sep 13 11:00:14 2010 us=901291 91.97.211.114:49898 Control Channel MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 11:00:14 2010 us=901914 91.97.211.114:49898 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 11:00:14 2010 us=903297 91.97.211.114:49898 UDPv4 READ [42] from [AF_INET]91.97.211.114:49898: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 pid=[ #1 ] [ ] pid=0 DATA len=0
Mon Sep 13 11:00:14 2010 us=904064 91.97.211.114:49898 TLS: Initial packet from [AF_INET]91.97.211.114:49898, sid=6e57c1a4 590913fb
Mon Sep 13 11:00:14 2010 us=905844 91.97.211.114:49898 UDPv4 WRITE [54] to [AF_INET]91.97.211.114:49898: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 pid=[ #1 ] [ 0 ] pid=0 DATA len=0
Mon Sep 13 11:00:15 2010 us=6633 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #2 ] [ 0 ]
Mon Sep 13 11:00:15 2010 us=10994 91.97.211.114:49898 UDPv4 READ [136] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=1 DATA len=94
Mon Sep 13 11:00:15 2010 us=453253 91.97.211.114:49898 UDPv4 WRITE [154] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #2 ] [ 1 ] pid=1 DATA len=100
Mon Sep 13 11:00:15 2010 us=455769 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=2 DATA len=100
Mon Sep 13 11:00:15 2010 us=460639 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #4 ] [ ] pid=3 DATA len=100
Mon Sep 13 11:00:15 2010 us=463141 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #5 ] [ ] pid=4 DATA len=100
Mon Sep 13 11:00:15 2010 us=549889 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #4 ] [ 1 ]
Mon Sep 13 11:00:15 2010 us=552340 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #6 ] [ ] pid=5 DATA len=100
Mon Sep 13 11:00:15 2010 us=555124 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #5 ] [ 2 ]
Mon Sep 13 11:00:15 2010 us=557455 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #7 ] [ ] pid=6 DATA len=100
Mon Sep 13 11:00:15 2010 us=565972 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #6 ] [ 3 ]
Mon Sep 13 11:00:15 2010 us=570021 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #8 ] [ ] pid=7 DATA len=100
Mon Sep 13 11:00:15 2010 us=572799 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #7 ] [ 4 ]
Mon Sep 13 11:00:15 2010 us=574733 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #9 ] [ ] pid=8 DATA len=100
Mon Sep 13 11:00:15 2010 us=638370 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #8 ] [ 5 ]
Mon Sep 13 11:00:15 2010 us=640297 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #10 ] [ ] pid=9 DATA len=100
Mon Sep 13 11:00:15 2010 us=643525 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #9 ] [ 6 ]
Mon Sep 13 11:00:15 2010 us=645444 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #11 ] [ ] pid=10 DATA len=100
Mon Sep 13 11:00:15 2010 us=656173 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #10 ] [ 7 ]
Mon Sep 13 11:00:15 2010 us=660384 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #12 ] [ ] pid=11 DATA len=100
Mon Sep 13 11:00:15 2010 us=662652 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #11 ] [ 8 ]
Mon Sep 13 11:00:15 2010 us=664558 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #13 ] [ ] pid=12 DATA len=100
Mon Sep 13 11:00:15 2010 us=698909 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #12 ] [ 9 ]
Mon Sep 13 11:00:15 2010 us=700811 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #14 ] [ ] pid=13 DATA len=100
Mon Sep 13 11:00:15 2010 us=703530 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #13 ] [ 10 ]
Mon Sep 13 11:00:15 2010 us=705426 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #15 ] [ ] pid=14 DATA len=100
Mon Sep 13 11:00:15 2010 us=734283 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #14 ] [ 11 ]
Mon Sep 13 11:00:15 2010 us=736176 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #16 ] [ ] pid=15 DATA len=100
Mon Sep 13 11:00:15 2010 us=739705 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #15 ] [ 12 ]
Mon Sep 13 11:00:15 2010 us=741584 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #17 ] [ ] pid=16 DATA len=100
Mon Sep 13 11:00:15 2010 us=780595 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #16 ] [ 13 ]
Mon Sep 13 11:00:15 2010 us=782480 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #18 ] [ ] pid=17 DATA len=100
Mon Sep 13 11:00:15 2010 us=785158 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #17 ] [ 14 ]
Mon Sep 13 11:00:15 2010 us=787730 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #19 ] [ ] pid=18 DATA len=100
Mon Sep 13 11:00:15 2010 us=794947 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #18 ] [ 15 ]
Mon Sep 13 11:00:15 2010 us=797962 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #20 ] [ ] pid=19 DATA len=100
Mon Sep 13 11:00:15 2010 us=800656 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #19 ] [ 16 ]
Mon Sep 13 11:00:15 2010 us=803029 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #21 ] [ ] pid=20 DATA len=100
Mon Sep 13 11:00:15 2010 us=872459 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #20 ] [ 17 ]
Mon Sep 13 11:00:15 2010 us=874884 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #22 ] [ ] pid=21 DATA len=100
Mon Sep 13 11:00:15 2010 us=908934 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #21 ] [ 18 ]
Mon Sep 13 11:00:15 2010 us=910785 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #23 ] [ ] pid=22 DATA len=100
Mon Sep 13 11:00:15 2010 us=913484 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #22 ] [ 19 ]
Mon Sep 13 11:00:15 2010 us=915879 91.97.211.114:49898 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #24 ] [ ] pid=23 DATA len=100
Mon Sep 13 11:00:15 2010 us=926198 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #23 ] [ 20 ]
Mon Sep 13 11:00:15 2010 us=929560 91.97.211.114:49898 UDPv4 WRITE [56] to [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #25 ] [ ] pid=24 DATA len=14
Mon Sep 13 11:00:16 2010 us=71892 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #24 ] [ 21 ]
Mon Sep 13 11:00:16 2010 us=121852 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #25 ] [ 22 ]
Mon Sep 13 11:00:16 2010 us=126011 91.97.211.114:49898 UDPv4 READ [50] from [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #26 ] [ 23 ]
Mon Sep 13 11:00:16 2010 us=186997 91.97.211.114:49898 UDPv4 READ [154] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #27 ] [ 24 ] pid=2 DATA len=100
Mon Sep 13 11:00:16 2010 us=189071 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #26 ] [ 2 ]
Mon Sep 13 11:00:16 2010 us=193122 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #28 ] [ ] pid=3 DATA len=100
Mon Sep 13 11:00:16 2010 us=197643 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #27 ] [ 3 ]
Mon Sep 13 11:00:16 2010 us=200420 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #29 ] [ ] pid=4 DATA len=100
Mon Sep 13 11:00:16 2010 us=203047 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #28 ] [ 4 ]
Mon Sep 13 11:00:16 2010 us=205343 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #30 ] [ ] pid=5 DATA len=100
Mon Sep 13 11:00:16 2010 us=208994 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #29 ] [ 5 ]
Mon Sep 13 11:00:16 2010 us=364254 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #32 ] [ ] pid=7 DATA len=100
Mon Sep 13 11:00:16 2010 us=366098 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #30 ] [ 7 ]
Mon Sep 13 11:00:16 2010 us=371046 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #33 ] [ ] pid=8 DATA len=100
Mon Sep 13 11:00:16 2010 us=372896 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #31 ] [ 8 ]
Mon Sep 13 11:00:16 2010 us=377795 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #34 ] [ ] pid=9 DATA len=100
Mon Sep 13 11:00:16 2010 us=380152 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #32 ] [ 9 ]
Mon Sep 13 11:00:17 2010 us=734384 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #35 ] [ ] pid=6 DATA len=100
Mon Sep 13 11:00:17 2010 us=737513 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #33 ] [ 6 ]
Mon Sep 13 11:00:17 2010 us=834944 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #36 ] [ ] pid=10 DATA len=100
Mon Sep 13 11:00:17 2010 us=837362 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #34 ] [ 10 ]
Mon Sep 13 11:00:17 2010 us=841074 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #37 ] [ ] pid=11 DATA len=100
Mon Sep 13 11:00:17 2010 us=844280 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #35 ] [ 11 ]
Mon Sep 13 11:00:17 2010 us=848134 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #38 ] [ ] pid=12 DATA len=100
Mon Sep 13 11:00:17 2010 us=851208 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #36 ] [ 12 ]
Mon Sep 13 11:00:17 2010 us=853503 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #39 ] [ ] pid=13 DATA len=100
Mon Sep 13 11:00:17 2010 us=855559 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #37 ] [ 13 ]
Mon Sep 13 11:00:17 2010 us=974337 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #40 ] [ ] pid=14 DATA len=100
Mon Sep 13 11:00:17 2010 us=976788 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #38 ] [ 14 ]
Mon Sep 13 11:00:17 2010 us=984166 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #41 ] [ ] pid=15 DATA len=100
Mon Sep 13 11:00:17 2010 us=988655 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #39 ] [ 15 ]
Mon Sep 13 11:00:17 2010 us=990958 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #42 ] [ ] pid=16 DATA len=100
Mon Sep 13 11:00:17 2010 us=993015 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #40 ] [ 16 ]
Mon Sep 13 11:00:18 2010 us=76938 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #44 ] [ ] pid=18 DATA len=100
Mon Sep 13 11:00:18 2010 us=78807 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #41 ] [ 18 ]
Mon Sep 13 11:00:18 2010 us=86186 91.97.211.114:49898 UDPv4 READ [142] from [AF_INET]91.97.211.114:49898: P_CONTROL_V1 kid=0 pid=[ #45 ] [ ] pid=19 DATA len=100
Mon Sep 13 11:00:18 2010 us=89614 91.97.211.114:49898 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49898: P_ACK_V1 kid=0 pid=[ #42 ] [ 19 ]
Mon Sep 13 11:00:19 2010 us=606802 MULTI: multi_create_instance called
Mon Sep 13 11:00:19 2010 us=607778 91.97.211.114:49899 Re-using SSL/TLS context
Mon Sep 13 11:00:19 2010 us=612754 91.97.211.114:49899 Control Channel MTU parms [ L:1573 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 11:00:19 2010 us=613373 91.97.211.114:49899 Data Channel MTU parms [ L:1573 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 11:00:19 2010 us=614827 91.97.211.114:49899 UDPv4 READ [42] from [AF_INET]91.97.211.114:49899: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 pid=[ #1 ] [ ] pid=0 DATA len=0
Mon Sep 13 11:00:19 2010 us=615599 91.97.211.114:49899 TLS: Initial packet from [AF_INET]91.97.211.114:49899, sid=c6cc0617 c7599a8d
Mon Sep 13 11:00:19 2010 us=619231 91.97.211.114:49899 UDPv4 WRITE [54] to [AF_INET]91.97.211.114:49899: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 pid=[ #1 ] [ 0 ] pid=0 DATA len=0
Mon Sep 13 11:00:19 2010 us=727136 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #2 ] [ 0 ]
Mon Sep 13 11:00:19 2010 us=732460 91.97.211.114:49899 UDPv4 READ [136] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=1 DATA len=94
Mon Sep 13 11:00:20 2010 us=131283 91.97.211.114:49899 UDPv4 WRITE [154] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #2 ] [ 1 ] pid=1 DATA len=100
Mon Sep 13 11:00:20 2010 us=133813 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #3 ] [ ] pid=2 DATA len=100
Mon Sep 13 11:00:20 2010 us=138890 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #4 ] [ ] pid=3 DATA len=100
Mon Sep 13 11:00:20 2010 us=141403 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #5 ] [ ] pid=4 DATA len=100
Mon Sep 13 11:00:20 2010 us=212901 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #4 ] [ 1 ]
Mon Sep 13 11:00:20 2010 us=214868 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #6 ] [ ] pid=5 DATA len=100
Mon Sep 13 11:00:20 2010 us=218486 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #5 ] [ 2 ]
Mon Sep 13 11:00:20 2010 us=220487 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #7 ] [ ] pid=6 DATA len=100
Mon Sep 13 11:00:20 2010 us=223196 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #6 ] [ 3 ]
Mon Sep 13 11:00:20 2010 us=225667 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #8 ] [ ] pid=7 DATA len=100
Mon Sep 13 11:00:20 2010 us=229720 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #7 ] [ 4 ]
Mon Sep 13 11:00:20 2010 us=231662 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #9 ] [ ] pid=8 DATA len=100
Mon Sep 13 11:00:20 2010 us=304077 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #8 ] [ 5 ]
Mon Sep 13 11:00:20 2010 us=306016 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #10 ] [ ] pid=9 DATA len=100
Mon Sep 13 11:00:20 2010 us=358344 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #9 ] [ 6 ]
Mon Sep 13 11:00:20 2010 us=360284 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #11 ] [ ] pid=10 DATA len=100
Mon Sep 13 11:00:20 2010 us=363944 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #10 ] [ 7 ]
Mon Sep 13 11:00:20 2010 us=365876 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #12 ] [ ] pid=11 DATA len=100
Mon Sep 13 11:00:20 2010 us=382424 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #11 ] [ 8 ]
Mon Sep 13 11:00:20 2010 us=384349 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #13 ] [ ] pid=12 DATA len=100
Mon Sep 13 11:00:20 2010 us=428914 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #12 ] [ 9 ]
Mon Sep 13 11:00:20 2010 us=430827 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #14 ] [ ] pid=13 DATA len=100
Mon Sep 13 11:00:20 2010 us=470161 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #13 ] [ 10 ]
Mon Sep 13 11:00:20 2010 us=472072 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #15 ] [ ] pid=14 DATA len=100
Mon Sep 13 11:00:20 2010 us=475282 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #14 ] [ 11 ]
Mon Sep 13 11:00:20 2010 us=477556 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #16 ] [ ] pid=15 DATA len=100
Mon Sep 13 11:00:20 2010 us=622818 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #15 ] [ 12 ]
Mon Sep 13 11:00:20 2010 us=624718 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #17 ] [ ] pid=16 DATA len=100
Mon Sep 13 11:00:20 2010 us=732285 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #16 ] [ 13 ]
Mon Sep 13 11:00:20 2010 us=734331 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #18 ] [ ] pid=17 DATA len=100
Mon Sep 13 11:00:20 2010 us=757200 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #17 ] [ 14 ]
Mon Sep 13 11:00:20 2010 us=759566 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #19 ] [ ] pid=18 DATA len=100
Mon Sep 13 11:00:20 2010 us=761841 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #18 ] [ 15 ]
Mon Sep 13 11:00:20 2010 us=765078 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #20 ] [ ] pid=19 DATA len=100
Mon Sep 13 11:00:20 2010 us=852262 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #19 ] [ 16 ]
Mon Sep 13 11:00:20 2010 us=854139 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #21 ] [ ] pid=20 DATA len=100
Mon Sep 13 11:00:20 2010 us=970855 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #20 ] [ 17 ]
Mon Sep 13 11:00:20 2010 us=972729 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #22 ] [ ] pid=21 DATA len=100
Mon Sep 13 11:00:20 2010 us=985058 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #21 ] [ 18 ]
Mon Sep 13 11:00:20 2010 us=988113 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #23 ] [ ] pid=22 DATA len=100
Mon Sep 13 11:00:20 2010 us=990391 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #22 ] [ 19 ]
Mon Sep 13 11:00:20 2010 us=992252 91.97.211.114:49899 UDPv4 WRITE [142] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #24 ] [ ] pid=23 DATA len=100
Mon Sep 13 11:00:21 2010 us=68834 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #23 ] [ 20 ]
Mon Sep 13 11:00:21 2010 us=70684 91.97.211.114:49899 UDPv4 WRITE [56] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #25 ] [ ] pid=24 DATA len=14
Mon Sep 13 11:00:21 2010 us=208759 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #25 ] [ 22 ]
Mon Sep 13 11:00:21 2010 us=211553 91.97.211.114:49899 UDPv4 READ [50] from [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #26 ] [ 23 ]
Mon Sep 13 11:00:21 2010 us=333000 91.97.211.114:49899 UDPv4 READ [154] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #27 ] [ 24 ] pid=2 DATA len=100
Mon Sep 13 11:00:21 2010 us=335072 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #26 ] [ 2 ]
Mon Sep 13 11:00:21 2010 us=339518 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #28 ] [ ] pid=3 DATA len=100
Mon Sep 13 11:00:21 2010 us=342134 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #27 ] [ 3 ]
Mon Sep 13 11:00:21 2010 us=344423 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #29 ] [ ] pid=4 DATA len=100
Mon Sep 13 11:00:21 2010 us=348955 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #28 ] [ 4 ]
Mon Sep 13 11:00:21 2010 us=351252 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #30 ] [ ] pid=5 DATA len=100
Mon Sep 13 11:00:21 2010 us=353304 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #29 ] [ 5 ]
Mon Sep 13 11:00:21 2010 us=622453 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #31 ] [ ] pid=6 DATA len=100
Mon Sep 13 11:00:21 2010 us=624505 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #30 ] [ 6 ]
Mon Sep 13 11:00:21 2010 us=629369 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #32 ] [ ] pid=7 DATA len=100
Mon Sep 13 11:00:21 2010 us=631979 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #31 ] [ 7 ]
Mon Sep 13 11:00:21 2010 us=634815 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #33 ] [ ] pid=8 DATA len=100
Mon Sep 13 11:00:21 2010 us=638481 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #32 ] [ 8 ]
Mon Sep 13 11:00:21 2010 us=640768 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #34 ] [ ] pid=9 DATA len=100
Mon Sep 13 11:00:21 2010 us=643419 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #33 ] [ 9 ]
Mon Sep 13 11:00:21 2010 us=892979 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #35 ] [ ] pid=10 DATA len=100
Mon Sep 13 11:00:21 2010 us=895035 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #34 ] [ 10 ]
Mon Sep 13 11:00:21 2010 us=899263 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #36 ] [ ] pid=11 DATA len=100
Mon Sep 13 11:00:21 2010 us=901319 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #35 ] [ 11 ]
Mon Sep 13 11:00:21 2010 us=908599 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #37 ] [ ] pid=12 DATA len=100
Mon Sep 13 11:00:21 2010 us=911142 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #36 ] [ 12 ]
Mon Sep 13 11:00:21 2010 us=913433 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #38 ] [ ] pid=13 DATA len=100
Mon Sep 13 11:00:21 2010 us=916018 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #37 ] [ 13 ]
Mon Sep 13 11:00:22 2010 us=94503 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #39 ] [ ] pid=14 DATA len=100
Mon Sep 13 11:00:22 2010 us=96173 91.97.211.114:49899 UDPv4 WRITE [154] to [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #38 ] [ 14 ] pid=21 DATA len=100
Mon Sep 13 11:00:22 2010 us=101080 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #40 ] [ ] pid=15 DATA len=100
Mon Sep 13 11:00:22 2010 us=103134 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #39 ] [ 15 ]
Mon Sep 13 11:00:22 2010 us=108834 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #41 ] [ ] pid=16 DATA len=100
Mon Sep 13 11:00:22 2010 us=110882 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #40 ] [ 16 ]
Mon Sep 13 11:00:22 2010 us=113590 91.97.211.114:49899 UDPv4 READ [142] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #42 ] [ ] pid=17 DATA len=100
Mon Sep 13 11:00:22 2010 us=116138 91.97.211.114:49899 UDPv4 WRITE [50] to [AF_INET]91.97.211.114:49899: P_ACK_V1 kid=0 pid=[ #41 ] [ 17 ]
Mon Sep 13 11:00:22 2010 us=220889 91.97.211.114:49899 UDPv4 READ [154] from [AF_INET]91.97.211.114:49899: P_CONTROL_V1 kid=0 pid=[ #43 ] [ 21 ] pid=18 DATA len=100
Mon Sep 13 11:00:22 2010 us=235777 91.97.211.114:49899 CRL: cannot read CRL from file /tmp/flash/crl.pem
Mon Sep 13 11:00:22 2010 us=237714 91.97.211.114:49899 Exiting

Log vom Client

 Mon Sep 13 10:57:09 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Mon Sep 13 10:57:09 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:57:09 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:57:09 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:57:09 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:57:09 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:57:09 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:57:09 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:57:09 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:57:09 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:57:09 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:57:09 2010 UDPv4 link local: [undef]
Mon Sep 13 10:57:09 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:57:10 2010 TLS: Initial packet from xx.xxx.xxx.xxx:1194, sid=3d541b06 9df84417
Mon Sep 13 10:57:11 2010 VERIFY OK: depth=1, /C=DE/ST=NR/L=Burgsteinfurt/O=OpenVPN/CN=ca/[email protected]
Mon Sep 13 10:57:11 2010 VERIFY OK: nsCertType=SERVER
Mon Sep 13 10:57:11 2010 VERIFY OK: depth=0, /C=DE/ST=NR/O=OpenVPN/CN=fritzbox/[email protected]
Mon Sep 13 10:58:09 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:58:09 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:58:09 2010 TCP/UDP: Closing socket
Mon Sep 13 10:58:09 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:58:09 2010 Restart pause, 2 second(s)
Mon Sep 13 10:58:11 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:58:11 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:58:11 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:58:11 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:58:11 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:58:11 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:58:11 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:58:11 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:58:11 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:58:11 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:58:11 2010 UDPv4 link local: [undef]
Mon Sep 13 10:58:11 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 10:59:11 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 10:59:11 2010 TLS Error: TLS handshake failed
Mon Sep 13 10:59:11 2010 TCP/UDP: Closing socket
Mon Sep 13 10:59:11 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 10:59:11 2010 Restart pause, 2 second(s)
Mon Sep 13 10:59:13 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 10:59:13 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 10:59:13 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:59:13 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 10:59:13 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 10:59:13 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 10:59:13 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 10:59:13 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 10:59:13 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 10:59:13 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 10:59:13 2010 UDPv4 link local: [undef]
Mon Sep 13 10:59:13 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 11:00:13 2010 TLS Error: TLS key negotiation failed to occur within 60 seconds (check your network connectivity)
Mon Sep 13 11:00:13 2010 TLS Error: TLS handshake failed
Mon Sep 13 11:00:13 2010 TCP/UDP: Closing socket
Mon Sep 13 11:00:13 2010 SIGUSR1[soft,tls-error] received, process restarting
Mon Sep 13 11:00:13 2010 Restart pause, 2 second(s)
Mon Sep 13 11:00:15 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 11:00:15 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 11:00:15 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:15 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:15 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 11:00:15 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 11:00:15 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 11:00:15 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 11:00:15 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 11:00:15 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 11:00:15 2010 UDPv4 link local: [undef]
Mon Sep 13 11:00:15 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 11:00:15 2010 TLS: Initial packet from xx.xxx.xxx.xxx:1194, sid=4fbc2412 a98864b9
Mon Sep 13 11:00:16 2010 VERIFY OK: depth=1, /C=DE/ST=NR/L=Burgsteinfurt/O=OpenVPN/CN=ca/[email protected]
Mon Sep 13 11:00:16 2010 VERIFY OK: nsCertType=SERVER
Mon Sep 13 11:00:16 2010 VERIFY OK: depth=0, /C=DE/ST=NR/O=OpenVPN/CN=fritzbox/[email protected]
Mon Sep 13 11:00:19 2010 TCP/UDP: Closing socket
Mon Sep 13 11:00:19 2010 SIGTERM[hard,] received, process exiting
Mon Sep 13 11:00:20 2010 OpenVPN 2.1.3 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Aug 20 2010
Mon Sep 13 11:00:20 2010 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables
Mon Sep 13 11:00:20 2010 Control Channel Authentication: using 'C:\Programme\OpenVPN\config\static.key' as a OpenVPN static key file
Mon Sep 13 11:00:20 2010 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:20 2010 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Sep 13 11:00:20 2010 WARNING: normally if you use --mssfix and/or --fragment, you should also set --tun-mtu 1500 (currently it is 1492)
Mon Sep 13 11:00:20 2010 Control Channel MTU parms [ L:1565 D:166 EF:66 EB:0 ET:0 EL:0 ]
Mon Sep 13 11:00:20 2010 Socket Buffers: R=[8192->8192] S=[8192->8192]
Mon Sep 13 11:00:20 2010 Data Channel MTU parms [ L:1565 D:1450 EF:41 EB:4 ET:32 EL:0 ]
Mon Sep 13 11:00:20 2010 Local Options hash (VER=V4): '715aaf04'
Mon Sep 13 11:00:20 2010 Expected Remote Options hash (VER=V4): '8d7b1722'
Mon Sep 13 11:00:20 2010 UDPv4 link local: [undef]
Mon Sep 13 11:00:20 2010 UDPv4 link remote: xx.xxx.xxx.xxx:1194
Mon Sep 13 11:00:20 2010 TLS: Initial packet from xx.xxx.xxx.xxx:1194 sid=ad6accd0 90084833
Mon Sep 13 11:00:21 2010 VERIFY OK: depth=1, /C=DE/ST=NR/L=Burgsteinfurt/O=OpenVPN/CN=ca/[email protected]
Mon Sep 13 11:00:21 2010 VERIFY OK: nsCertType=SERVER
Mon Sep 13 11:00:21 2010 VERIFY OK: depth=0, /C=DE/ST=NR/O=OpenVPN/CN=fritzbox/[email protected]

 

[MaxMuster]

Kann es sein, dass das Server-Log nicht das aktuelle ist, oder zum Verbindungsaufbau passt? Der Verbindungsversuch ist dort nicht zu sehen, und es steht noch der "CRL-Fehler" drin?!?

Jörg

 

[Nils0815]

Hi Jörg,
Also hab grade noch mal die Datei gelöscht und mir den log anzeigenlassen. Die Zeile steht da immer noch.

 Mon Sep 13 11:32:09 2010 us=77379 95.33.248.171:65156 CRL: cannot read CRL from file /tmp/flash/crl.pem

Ich denke mal dass kein Verbindungsversuch drin steht da der Open VPN Dienst gestoppt wurde.
Gruß
Nils

 

[MaxMuster]

O.k., das darf/sollte nicht sein. Du nutzt aber nur die von der GUI erzeugte Konfiguration, nicht irgendeine "eigene Abwandlung"? Dann poste bitte nochmal die aktuelle Server-Config....

Jörg