Tue Feb 23 13:19:42 2010 us=31000 Current Parameter Settings: Tue Feb 23 13:19:42 2010 us=31000 config = 'vpn_klient.ovpn' Tue Feb 23 13:19:42 2010 us=31000 mode = 0 Tue Feb 23 13:19:42 2010 us=31000 show_ciphers = DISABLED Tue Feb 23 13:19:42 2010 us=31000 show_digests = DISABLED Tue Feb 23 13:19:42 2010 us=31000 show_engines = DISABLED Tue Feb 23 13:19:42 2010 us=31000 genkey = DISABLED Tue Feb 23 13:19:42 2010 us=31000 key_pass_file = '[UNDEF]' Tue Feb 23 13:19:42 2010 us=31000 show_tls_ciphers = DISABLED Tue Feb 23 13:19:42 2010 us=31000 Connection profiles [default]: Tue Feb 23 13:19:42 2010 us=31000 NOTE: --mute triggered... Tue Feb 23 13:19:42 2010 us=31000 261 variation(s) on previous 10 message(s) suppressed by --mute Tue Feb 23 13:19:42 2010 us=31000 OpenVPN 2.1.1 i686-pc-mingw32 [SSL] [LZO2] [PKCS11] built on Dec 11 2009 Tue Feb 23 13:19:42 2010 us=31000 WARNING: No server certificate verification method has been enabled. See http://openvpn.net/howto.html#mitm for more info. Tue Feb 23 13:19:42 2010 us=31000 NOTE: OpenVPN 2.1 requires '--script-security 2' or higher to call user-defined scripts or executables Tue Feb 23 13:19:45 2010 us=156000 WARNING: this configuration may cache passwords in memory -- use the auth-nocache option to prevent this Tue Feb 23 13:19:45 2010 us=156000 LZO compression initialized Tue Feb 23 13:19:45 2010 us=156000 Control Channel MTU parms [ L:1576 D:140 EF:40 EB:0 ET:0 EL:0 ] Tue Feb 23 13:19:45 2010 us=171000 Data Channel MTU parms [ L:1576 D:1450 EF:44 EB:135 ET:32 EL:0 AF:3/1 ] Tue Feb 23 13:19:45 2010 us=171000 Local Options String: 'V4,dev-type tap,link-mtu 1576,tun-mtu 1532,proto TCPv4_CLIENT,comp-lzo,cipher BF-CBC,auth SHA1,keysize 128,key-method 2,tls-client' Tue Feb 23 13:19:45 2010 us=171000 Expected Remote Options String: 'V4,dev-type tap,link-mtu 1576,tun-mtu 1532,proto TCPv4_SERVER,comp-lzo,cipher BF-CBC,auth SHA1,keysize 128,key-method 2,tls-server' Tue Feb 23 13:19:45 2010 us=171000 Local Options hash (VER=V4): '31fdf004' Tue Feb 23 13:19:45 2010 us=171000 Expected Remote Options hash (VER=V4): '3e6d1056' Tue Feb 23 13:19:45 2010 us=171000 Attempting to establish TCP connection with 62.168.16.106:1194 Tue Feb 23 13:19:45 2010 us=187000 TCP connection established with 62.168.16.106:1194 Tue Feb 23 13:19:45 2010 us=187000 Socket Buffers: R=[8192->8192] S=[8192->8192] Tue Feb 23 13:19:45 2010 us=187000 TCPv4_CLIENT link local: [undef] Tue Feb 23 13:19:45 2010 us=187000 TCPv4_CLIENT link remote: 62.168.16.106:1194 Tue Feb 23 13:19:45 2010 us=203000 TCPv4_CLIENT WRITE [14] to 62.168.16.106:1194: P_CONTROL_HARD_RESET_CLIENT_V2 kid=0 [ ] pid=0 DATA len=0 Tue Feb 23 13:19:45 2010 us=218000 TCPv4_CLIENT READ [26] from 62.168.16.106:1194: P_CONTROL_HARD_RESET_SERVER_V2 kid=0 [ 0 ] pid=0 DATA len=0 Tue Feb 23 13:19:45 2010 us=218000 TLS: Initial packet from 62.168.16.106:1194, sid=1369e103 f2ce1f24 Tue Feb 23 13:19:45 2010 us=218000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 0 ] Tue Feb 23 13:19:45 2010 us=218000 TCPv4_CLIENT WRITE [106] to 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=1 DATA len=92 Tue Feb 23 13:19:45 2010 us=359000 TCPv4_CLIENT READ [126] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ 1 ] pid=1 DATA len=100 Tue Feb 23 13:19:45 2010 us=359000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 1 ] Tue Feb 23 13:19:45 2010 us=390000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=2 DATA len=100 Tue Feb 23 13:19:45 2010 us=390000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=3 DATA len=100 Tue Feb 23 13:19:45 2010 us=390000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=4 DATA len=100 Tue Feb 23 13:19:45 2010 us=390000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 2 ] Tue Feb 23 13:19:45 2010 us=390000 TCPv4_CLIENT WRITE [26] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 3 4 ] Tue Feb 23 13:19:45 2010 us=406000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=5 DATA len=100 Tue Feb 23 13:19:45 2010 us=406000 NOTE: --mute triggered... Tue Feb 23 13:19:45 2010 us=734000 44 variation(s) on previous 10 message(s) suppressed by --mute Tue Feb 23 13:19:45 2010 us=734000 VERIFY OK: depth=1, /C=CZ/ST=Czech_Republic/L=Prague/O=OpenVPN-Comstar/OU=IT/CN=OpenVPN-Comstar_CA/emailAddress=tech.alert@comstar.cz Tue Feb 23 13:19:45 2010 us=734000 VERIFY OK: depth=0, /C=CZ/ST=Czech_Republic/L=Prague/O=OpenVPN-Comstar/CN=server/emailAddress=tech.alert@comstar.cz Tue Feb 23 13:19:45 2010 us=734000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=28 DATA len=100 Tue Feb 23 13:19:45 2010 us=734000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 27 ] Tue Feb 23 13:19:45 2010 us=750000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 28 ] Tue Feb 23 13:19:45 2010 us=750000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=29 DATA len=100 Tue Feb 23 13:19:45 2010 us=750000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 29 ] Tue Feb 23 13:19:45 2010 us=765000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=30 DATA len=100 Tue Feb 23 13:19:45 2010 us=765000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 30 ] Tue Feb 23 13:19:45 2010 us=796000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=31 DATA len=100 Tue Feb 23 13:19:45 2010 us=796000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=32 DATA len=100 Tue Feb 23 13:19:45 2010 us=796000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 31 ] Tue Feb 23 13:19:45 2010 us=796000 NOTE: --mute triggered... Tue Feb 23 13:19:47 2010 us=437000 110 variation(s) on previous 10 message(s) suppressed by --mute Tue Feb 23 13:19:47 2010 us=437000 Data Channel Encrypt: Cipher 'BF-CBC' initialized with 128 bit key Tue Feb 23 13:19:47 2010 us=437000 Data Channel Encrypt: Using 160 bit message hash 'SHA1' for HMAC authentication Tue Feb 23 13:19:47 2010 us=437000 Data Channel Decrypt: Cipher 'BF-CBC' initialized with 128 bit key Tue Feb 23 13:19:47 2010 us=437000 Data Channel Decrypt: Using 160 bit message hash 'SHA1' for HMAC authentication Tue Feb 23 13:19:47 2010 us=453000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 53 ] Tue Feb 23 13:19:47 2010 us=453000 TCPv4_CLIENT WRITE [26] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 54 55 ] Tue Feb 23 13:19:47 2010 us=453000 Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA, 2048 bit RSA Tue Feb 23 13:19:47 2010 us=453000 [server] Peer Connection Initiated with 62.168.16.106:1194 Tue Feb 23 13:19:48 2010 us=531000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:49 2010 us=531000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:49 2010 us=531000 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1) Tue Feb 23 13:19:49 2010 us=531000 TCPv4_CLIENT WRITE [104] to 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=38 DATA len=90 Tue Feb 23 13:19:49 2010 us=546000 TCPv4_CLIENT READ [22] from 62.168.16.106:1194: P_ACK_V1 kid=0 [ 38 ] Tue Feb 23 13:19:49 2010 us=750000 TCPv4_CLIENT READ [114] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=56 DATA len=100 Tue Feb 23 13:19:49 2010 us=750000 TCPv4_CLIENT READ [52] from 62.168.16.106:1194: P_CONTROL_V1 kid=0 [ ] pid=57 DATA len=38 Tue Feb 23 13:19:49 2010 us=750000 PUSH: Received control message: 'PUSH_REPLY,ping 1,ping-restart 220,ifconfig 192.168.2.80 255.255.255.0' Tue Feb 23 13:19:49 2010 us=750000 OPTIONS IMPORT: timers and/or timeouts modified Tue Feb 23 13:19:49 2010 us=750000 OPTIONS IMPORT: --ifconfig/up options modified Tue Feb 23 13:19:49 2010 us=781000 TAP-WIN32 device [Připojení k místní síti 3] opened: \\.\Global\{58355529-6A70-44A6-9851-CC17E467129A}.tap Tue Feb 23 13:19:49 2010 us=781000 TAP-Win32 Driver Version 9.6 Tue Feb 23 13:19:49 2010 us=781000 TAP-Win32 MTU=1500 Tue Feb 23 13:19:49 2010 us=796000 Notified TAP-Win32 driver to set a DHCP IP/netmask of 192.168.2.80/255.255.255.0 on interface {58355529-6A70-44A6-9851-CC17E467129A} [DHCP-serv: 192.168.2.0, lease-time: 31536000] Tue Feb 23 13:19:49 2010 us=796000 Successful ARP Flush on interface [5] {58355529-6A70-44A6-9851-CC17E467129A} Tue Feb 23 13:19:49 2010 us=796000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 56 ] Tue Feb 23 13:19:49 2010 us=812000 TCPv4_CLIENT WRITE [22] to 62.168.16.106:1194: P_ACK_V1 kid=0 [ 57 ] Tue Feb 23 13:19:50 2010 us=875000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:50 2010 us=875000 TCPv4_CLIENT WRITE [53] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:51 2010 us=906000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:51 2010 us=906000 TCPv4_CLIENT WRITE [53] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:52 2010 us=781000 TUN READ [42] Tue Feb 23 13:19:52 2010 us=781000 TCPv4_CLIENT WRITE [77] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=76 Tue Feb 23 13:19:52 2010 us=812000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:52 2010 us=828000 TUN READ [42] Tue Feb 23 13:19:52 2010 us=828000 NOTE: --mute triggered... Tue Feb 23 13:19:54 2010 us=859000 5 variation(s) on previous 10 message(s) suppressed by --mute Tue Feb 23 13:19:54 2010 us=859000 TEST ROUTES: 0/0 succeeded len=-1 ret=1 a=0 u/d=up Tue Feb 23 13:19:54 2010 us=859000 Initialization Sequence Completed Tue Feb 23 13:19:54 2010 us=875000 TCPv4_CLIENT WRITE [93] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=92 Tue Feb 23 13:19:54 2010 us=875000 TCPv4_CLIENT READ [53] from 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=52 Tue Feb 23 13:19:54 2010 us=875000 TUN READ [54] Tue Feb 23 13:19:54 2010 us=875000 TCPv4_CLIENT WRITE [93] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=92 Tue Feb 23 13:19:54 2010 us=875000 TUN READ [66] Tue Feb 23 13:19:54 2010 us=875000 TCPv4_CLIENT WRITE [101] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=100 Tue Feb 23 13:19:54 2010 us=875000 TUN READ [66] Tue Feb 23 13:19:54 2010 us=875000 TCPv4_CLIENT WRITE [101] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=100 Tue Feb 23 13:19:54 2010 us=890000 TUN READ [110] Tue Feb 23 13:19:54 2010 us=890000 TCPv4_CLIENT WRITE [141] to 62.168.16.106:1194: P_DATA_V1 kid=0 DATA len=140 Tue Feb 23 13:19:54 2010 us=906000 NOTE: --mute triggered...