server log | how did i do ?

This forum is for all inquiries relating to the installation of OpenVPN from source and with binaries.

Moderators: TinCanTech, TinCanTech, TinCanTech, TinCanTech, TinCanTech, TinCanTech

Forum rules
Please visit (and READ) the OpenVPN HowTo http://openvpn.net/howto prior to asking any questions in here!
Post Reply
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

server log | how did i do ?

Post by blah09 » Thu May 21, 2015 9:34 pm

below is my log off my server that i started and stopped (verb 6) can any tell me how i did and any input would be much appreciated
cat openvpn.log
Thu May 21 17:29:06 2015 us=72008 Current Parameter Settings:
Thu May 21 17:29:06 2015 us=72069 config = 'server.conf'
Thu May 21 17:29:06 2015 us=72088 mode = 1
Thu May 21 17:29:06 2015 us=72099 persist_config = DISABLED
Thu May 21 17:29:06 2015 us=72109 persist_mode = 1
Thu May 21 17:29:06 2015 us=72119 show_ciphers = DISABLED
Thu May 21 17:29:06 2015 us=72129 show_digests = DISABLED
Thu May 21 17:29:06 2015 us=72139 show_engines = DISABLED
Thu May 21 17:29:06 2015 us=72148 genkey = DISABLED
Thu May 21 17:29:06 2015 us=72158 key_pass_file = '[UNDEF]'
Thu May 21 17:29:06 2015 us=72167 show_tls_ciphers = DISABLED
Thu May 21 17:29:06 2015 us=72178 Connection profiles [default]:
Thu May 21 17:29:06 2015 us=72188 proto = udp
Thu May 21 17:29:06 2015 us=72198 local = '255.***.***.***'
Thu May 21 17:29:06 2015 us=72207 local_port = 443
Thu May 21 17:29:06 2015 us=72217 remote = '[UNDEF]'
Thu May 21 17:29:06 2015 us=72227 remote_port = 443
Thu May 21 17:29:06 2015 us=72236 remote_float = DISABLED
Thu May 21 17:29:06 2015 us=72246 bind_defined = DISABLED
Thu May 21 17:29:06 2015 us=72255 bind_local = ENABLED
Thu May 21 17:29:06 2015 us=72265 NOTE: --mute triggered...
Thu May 21 17:29:06 2015 us=72284 264 variation(s) on previous 20 message(s) suppressed by --mute
Thu May 21 17:29:06 2015 us=72296 OpenVPN 2.3.6 i686-redhat-linux-gnu [SSL (OpenSSL)] [LZO] [EPOLL] [PKCS11] [MH] [IPv6] built on Dec 2 2014
Thu May 21 17:29:06 2015 us=72311 library versions: OpenSSL 1.0.1e-fips 11 Feb 2013, LZO 2.03
Thu May 21 17:29:06 2015 us=290083 Diffie-Hellman initialized with 4096 bit key
Thu May 21 17:29:06 2015 us=290806 Control Channel Authentication: using 'ta.key' as a OpenVPN static key file
Thu May 21 17:29:06 2015 us=290836 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 21 17:29:06 2015 us=290850 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 21 17:29:06 2015 us=290874 TLS-Auth MTU parms [ L:1602 D:178 EF:78 EB:0 ET:0 EL:0 ]
Thu May 21 17:29:06 2015 us=290898 Socket Buffers: R=[133120->131072] S=[133120->131072]
Thu May 21 17:29:06 2015 us=291066 ROUTE_GATEWAY ON_LINK IFACE=venet0 HWADDR=00:00:00:00:00:00
Thu May 21 17:29:06 2015 us=291586 TUN/TAP device tun0 opened
Thu May 21 17:29:06 2015 us=291608 TUN/TAP TX queue length set to 100
Thu May 21 17:29:06 2015 us=291625 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0
Thu May 21 17:29:06 2015 us=291653 /sbin/ip link set dev tun0 up mtu 1500
Thu May 21 17:29:06 2015 us=303722 /sbin/ip addr add dev tun0 local 10.8.0.1 peer 10.8.0.2
Thu May 21 17:29:06 2015 us=304636 /sbin/ip route add 10.8.0.0/24 via 10.8.0.2
Thu May 21 17:29:06 2015 us=310272 Data Channel MTU parms [ L:1602 D:1450 EF:70 EB:135 ET:32 EL:0 AF:3/1 ]
Thu May 21 17:29:06 2015 us=311049 GID set to nobody
Thu May 21 17:29:06 2015 us=311101 UID set to nobody
Thu May 21 17:29:06 2015 us=311132 UDPv4 link local (bound): [AF_INET]255.***.***.***:443
Thu May 21 17:29:06 2015 us=311145 UDPv4 link remote: [undef]
Thu May 21 17:29:06 2015 us=311162 MULTI: multi_init called, r=256 v=256
Thu May 21 17:29:06 2015 us=311229 IFCONFIG POOL: base=10.8.0.4 size=62, ipv6=0
Thu May 21 17:29:06 2015 us=311263 Initialization Sequence Completed
Thu May 21 17:29:21 2015 us=996258 event_wait : Interrupted system call (code=4)
Thu May 21 17:29:21 2015 us=996447 TCP/UDP: Closing socket
Thu May 21 17:29:21 2015 us=996513 /sbin/ip route del 10.8.0.0/24
RTNETLINK answers: Operation not permitted
Thu May 21 17:29:21 2015 us=997362 ERROR: Linux route delete command failed: external program exited with error status: 2
Thu May 21 17:29:21 2015 us=997388 Closing TUN/TAP interface
Thu May 21 17:29:21 2015 us=997415 /sbin/ip addr del dev tun0 local 10.8.0.1 peer 10.8.0.2
RTNETLINK answers: Operation not permitted
Thu May 21 17:29:21 2015 us=998423 Linux ip addr del failed: external program exited with error status: 2
Thu May 21 17:29:22 2015 us=34893 SIGTERM[hard,] received, process exiting

____________________________________
server.conf

cat server.conf
local 255.***.***.***
port 443
proto udp
dev tun
tun-mtu 1500
tun-mtu-extra 32
mssfix 1450
reneg-sec 0
ca /etc/openvpn/easy-rsa/keys/ca.crt
cert /etc/openvpn/easy-rsa/keys/server.crt
key /etc/openvpn/easy-rsa/keys/server.key
dh /etc/openvpn/easy-rsa/keys/dh4096.pem
;plugin /usr/share/openvpn/plugin/lib/openvpn-auth-pam.so /etc/pam.d/login
#plugin /etc/openvpn/radiusplugin.so /etc/openvpn/radiusplugin.cnf
user nobody
group nobody
tls-auth ta.key 0
cipher AES-256-CBC
auth sha256
server 10.8.0.0 255.255.255.0
push "redirect-gateway def1"
push "redirect-gateway"
push "dhcp-option DNS 8.8.8.8"
push "dhcp-option DNS 8.8.4.4"
keepalive 5 180
comp-lzo
persist-key
persist-tun
status openvpn-status.log
log /etc/openvpn/openvpn.log
verb 6
mute 20
Top
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

Re: server log | how did i do ?

Post by blah09 » Fri May 22, 2015 4:07 pm

not long after this was posted, i dunno what i did lol but i get this invalid argument spitting out to the log and ive been googling for hours and have come up with nothing sept its from my client conf "i think" because it happens when i connect to my server.

Failed to truncate status file: Invalid argument

Code: Select all

client
dev tun
proto udp
remote 255.***.***.*** 443
resolv-retry infinite
nobind
persist-key
persist-tun
ca ca.crt
cert Narcho.crt
key Narcho.key
remote-cert-tls server
tls-auth ta.key 1
cipher AES-256-CBC
comp-lzo
verb 3
mute 20
auth sha256
i updated the port to 443 on the server as well
Top
User avatar
Traffic
OpenVPN Protagonist
Posts: 4066
Joined: Sat Aug 09, 2014 11:24 am

Re: server log | how did i do ?

Post by Traffic » Mon May 25, 2015 8:57 am

blah09 wrote:its from my client conf "i think" because it happens when i connect to my server.

Failed to truncate status file: Invalid argument
where does the error occur ?

You only have "status file" defined in server conf ..
Top
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

Re: server log | how did i do ?

Post by blah09 » Tue May 26, 2015 1:04 am

where does the error occur ?

You only have "status file" defined in server conf ..
status openvpn-status.log
log /etc/openvpn/openvpn.log
both are enabled
Top
User avatar
Traffic
OpenVPN Protagonist
Posts: 4066
Joined: Sat Aug 09, 2014 11:24 am

Re: server log | how did i do ?

Post by Traffic » Tue May 26, 2015 9:18 am

blah09 wrote:both are enabled
not in your client conf ..

and your server log shows no errors ..

Please post your complete client log.
Top
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

Re: server log | how did i do ?

Post by blah09 » Tue May 26, 2015 6:38 pm

Traffic wrote:
blah09 wrote:both are enabled
not in your client conf ..

and your server log shows no errors ..

Please post your complete client log.
client config has already been posted
this is the openvpn.log from the server

Code: Select all

cat openvpn.log 
Tue May 26 14:25:58 2015 Failed to truncate status file: Invalid argument
Tue May 26 14:26:58 2015 Failed to truncate status file: Invalid argument
Tue May 26 14:27:58 2015 Failed to truncate status file: Invalid argument
Tue May 26 14:28:58 2015 Failed to truncate status file: Invalid argument
And here is the client log from the openvpn GUI

Code: Select all

Wed May 27 04:26:08 2015 OpenVPN 2.3.6 x86_64-w64-mingw32 [SSL (OpenSSL)] [LZO] [PKCS11] [IPv6] built on Mar 19 2015
Wed May 27 04:26:08 2015 library versions: OpenSSL 1.0.1m 19 Mar 2015, LZO 2.08
Wed May 27 04:26:08 2015 MANAGEMENT: TCP Socket listening on [AF_INET]127.0.0.1:25340
Wed May 27 04:26:08 2015 Need hold release from management interface, waiting...
Wed May 27 04:26:09 2015 MANAGEMENT: Client connected from [AF_INET]127.0.0.1:25340
Wed May 27 04:26:09 2015 MANAGEMENT: CMD 'state on'
Wed May 27 04:26:09 2015 MANAGEMENT: CMD 'log all on'
Wed May 27 04:26:09 2015 MANAGEMENT: CMD 'hold off'
Wed May 27 04:26:09 2015 MANAGEMENT: CMD 'hold release'
Wed May 27 04:26:09 2015 Control Channel Authentication: using 'ta.key' as a OpenVPN static key file
Wed May 27 04:26:09 2015 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 04:26:09 2015 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 04:26:09 2015 Socket Buffers: R=[8192->8192] S=[8192->8192]
Wed May 27 04:26:09 2015 UDPv4 link local: [undef]
Wed May 27 04:26:09 2015 UDPv4 link remote: [AF_INET]255.***.***.***:443
Wed May 27 04:26:09 2015 MANAGEMENT: >STATE:1432664769,WAIT,,,
Wed May 27 04:26:09 2015 MANAGEMENT: >STATE:1432664769,AUTH,,,
Wed May 27 04:26:09 2015 TLS: Initial packet from [AF_INET]255.***.***.***:443, sid=34ae79f8 875f5475
Wed May 27 04:26:19 2015 VERIFY OK: depth=1, C=US, ST=CA, L=brooklyn, O=random, OU=********, CN=random CA, name=EasyRSA, emailAddress=spidey@*********
Wed May 27 04:26:19 2015 Validating certificate key usage
Wed May 27 04:26:19 2015 ++ Certificate has key usage  00a0, expects 00a0
Wed May 27 04:26:19 2015 VERIFY KU OK
Wed May 27 04:26:19 2015 Validating certificate extended key usage
Wed May 27 04:26:19 2015 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Wed May 27 04:26:19 2015 VERIFY EKU OK
Wed May 27 04:26:19 2015 VERIFY OK: depth=0, C=US, ST=CA, L=brooklyn, O=random, OU=********, CN=server, name=EasyRSA, emailAddress=spidey@*********
Wed May 27 04:26:36 2015 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
Wed May 27 04:26:36 2015 Data Channel Encrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 04:26:36 2015 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
Wed May 27 04:26:36 2015 Data Channel Decrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 04:26:36 2015 Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA, 4096 bit RSA
Wed May 27 04:26:36 2015 [server] Peer Connection Initiated with [AF_INET]255.***.***.***:443
Wed May 27 04:26:37 2015 MANAGEMENT: >STATE:1432664797,GET_CONFIG,,,
Wed May 27 04:26:38 2015 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1)
Wed May 27 04:26:43 2015 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1)
Wed May 27 04:26:43 2015 PUSH: Received control message: 'PUSH_REPLY,redirect-gateway def1,redirect-gateway,dhcp-option DNS 8.8.8.8,dhcp-option DNS 8.8.4.4,route 10.8.0.1,topology net30,ping 5,ping-restart 180,ifconfig 10.8.0.6 10.8.0.5'
Wed May 27 04:26:43 2015 OPTIONS IMPORT: timers and/or timeouts modified
Wed May 27 04:26:43 2015 OPTIONS IMPORT: --ifconfig/up options modified
Wed May 27 04:26:43 2015 OPTIONS IMPORT: route options modified
Wed May 27 04:26:43 2015 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
Wed May 27 04:26:43 2015 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0
Wed May 27 04:26:43 2015 MANAGEMENT: >STATE:1432664803,ASSIGN_IP,,10.8.0.6,
Wed May 27 04:26:43 2015 open_tun, tt->ipv6=0
Wed May 27 04:26:43 2015 TAP-WIN32 device [Local Area Connection 2] opened: \\.\Global\{31B85720-5B66-4301-8735-379DEE81D6BF}.tap
Wed May 27 04:26:43 2015 TAP-Windows Driver Version 9.21 
Wed May 27 04:26:43 2015 Notified TAP-Windows driver to set a DHCP IP/netmask of 10.8.0.6/255.255.255.252 on interface {31B85720-5B66-4301-8735-379DEE81D6BF} [DHCP-serv: 10.8.0.5, lease-time: 31536000]
Wed May 27 04:26:43 2015 Successful ARP Flush on interface [18] {31B85720-5B66-4301-8735-379DEE81D6BF}
Wed May 27 04:26:48 2015 TEST ROUTES: 2/2 succeeded len=1 ret=1 a=0 u/d=up
Wed May 27 04:26:48 2015 C:\Windows\system32\route.exe ADD 255.***.***.*** MASK 255.255.255.255 192.168.1.1
Wed May 27 04:26:48 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Wed May 27 04:26:48 2015 Route addition via IPAPI succeeded [adaptive]
Wed May 27 04:26:48 2015 C:\Windows\system32\route.exe ADD 0.0.0.0 MASK 128.0.0.0 10.8.0.5
Wed May 27 04:26:48 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Wed May 27 04:26:48 2015 Route addition via IPAPI succeeded [adaptive]
Wed May 27 04:26:48 2015 C:\Windows\system32\route.exe ADD 128.0.0.0 MASK 128.0.0.0 10.8.0.5
Wed May 27 04:26:48 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Wed May 27 04:26:48 2015 Route addition via IPAPI succeeded [adaptive]
Wed May 27 04:26:48 2015 MANAGEMENT: >STATE:1432664808,ADD_ROUTES,,,
Wed May 27 04:26:48 2015 C:\Windows\system32\route.exe ADD 10.8.0.1 MASK 255.255.255.255 10.8.0.5
Wed May 27 04:26:48 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Wed May 27 04:26:48 2015 Route addition via IPAPI succeeded [adaptive]
Wed May 27 04:26:48 2015 Initialization Sequence Completed
Wed May 27 04:26:48 2015 MANAGEMENT: >STATE:1432664808,CONNECTED,SUCCESS,10.8.0.6,255.***.***.***
Top
User avatar
Traffic
OpenVPN Protagonist
Posts: 4066
Joined: Sat Aug 09, 2014 11:24 am

Re: server log | how did i do ?

Post by Traffic » Tue May 26, 2015 7:10 pm

Now I understand the problem:
blah09 wrote:this is the openvpn.log from the server
Code:
cat openvpn.log
Tue May 26 14:25:58 2015 Failed to truncate status file: Invalid argument
Tue May 26 14:26:58 2015 Failed to truncate status file: Invalid argument
From the source:

status.c:
  • code:
    • #if defined(HAVE_FTRUNCATE)
      {
      const off_t off = lseek (so->fd, (off_t)0, SEEK_CUR);
      if (ftruncate (so->fd, off) != 0) {
      msg (M_WARN, "Failed to truncate status file: %s", strerror(errno));
      }
      }
I will ask Michael to have a look.
Top
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

Re: server log | how did i do ?

Post by blah09 » Tue May 26, 2015 8:19 pm

Thank you in advance :D
Top
User avatar
maikcat
Forum Team
Posts: 4200
Joined: Wed Jan 12, 2011 9:23 am
Location: Athens,Greece
Contact:
Contact maikcat

Re: server log | how did i do ?

Post by maikcat » Wed May 27, 2015 6:53 am

some things to check,

can you use absolute path name for the status file?
in which filesystem the status file is located?
can you try to stop openvpn and remove/rename the file then start openvpn again?

Michael.
Top
blah09
OpenVpn Newbie
Posts: 8
Joined: Sat Apr 11, 2015 2:37 pm

Re: server log | how did i do ?

Post by blah09 » Wed May 27, 2015 5:05 pm

maikcat wrote:some things to check,

can you use absolute path name for the status file?
in which filesystem the status file is located?
can you try to stop openvpn and remove/rename the file then start openvpn again?

Michael.
im not 100% clear on what you mean, below you can see what i changed to best fit your instruction
  • status /etc/openvpn/logs/openvpn-status.log
    log /etc/openvpn//logs/openvpn.log
Image
cat openvpn-status.log

Code: Select all

OpenVPN CLIENT LIST
Updated,Wed May 27 12:16:55 2015
Common Name,Real Address,Bytes Received,Bytes Sent,Connected Since
ROUTING TABLE
Virtual Address,Common Name,Real Address,Last Ref
GLOBAL STATS
Max bcast/mcast queue length,0
END
cat openvpn.log

Code: Select all

Wed May 27 12:16:45 2015 us=422125 Current Parameter Settings:
Wed May 27 12:16:45 2015 us=422179   config = 'server.conf'
Wed May 27 12:16:45 2015 us=422191   mode = 1
Wed May 27 12:16:45 2015 us=422200   persist_config = DISABLED
Wed May 27 12:16:45 2015 us=422209   persist_mode = 1
Wed May 27 12:16:45 2015 us=422217   show_ciphers = DISABLED
Wed May 27 12:16:45 2015 us=422226   show_digests = DISABLED
Wed May 27 12:16:45 2015 us=422234   show_engines = DISABLED
Wed May 27 12:16:45 2015 us=422243   genkey = DISABLED
Wed May 27 12:16:45 2015 us=422251   key_pass_file = '[UNDEF]'
Wed May 27 12:16:45 2015 us=422260   show_tls_ciphers = DISABLED
Wed May 27 12:16:45 2015 us=422271 Connection profiles [default]:
Wed May 27 12:16:45 2015 us=422281   proto = udp
Wed May 27 12:16:45 2015 us=422290   local = '255.***.***.***'
Wed May 27 12:16:45 2015 us=422298   local_port = 443
Wed May 27 12:16:45 2015 us=422307   remote = '[UNDEF]'
Wed May 27 12:16:45 2015 us=422316   remote_port = 443
Wed May 27 12:16:45 2015 us=422325   remote_float = DISABLED
Wed May 27 12:16:45 2015 us=422333   bind_defined = DISABLED
Wed May 27 12:16:45 2015 us=422342   bind_local = ENABLED
Wed May 27 12:16:45 2015 us=422350 NOTE: --mute triggered...
Wed May 27 12:16:45 2015 us=422367 264 variation(s) on previous 20 message(s) suppressed by --mute
Wed May 27 12:16:45 2015 us=422378 OpenVPN 2.3.6 i686-redhat-linux-gnu [SSL (OpenSSL)] [LZO] [EPOLL] [PKCS11] [MH] [IPv6] built on Dec  2 2014
Wed May 27 12:16:45 2015 us=422390 library versions: OpenSSL 1.0.1e-fips 11 Feb 2013, LZO 2.03
Wed May 27 12:16:45 2015 us=661220 Diffie-Hellman initialized with 4096 bit key
Wed May 27 12:16:45 2015 us=661925 Control Channel Authentication: using 'ta.key' as a OpenVPN static key file
Wed May 27 12:16:45 2015 us=661955 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 12:16:45 2015 us=661969 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Wed May 27 12:16:45 2015 us=661992 TLS-Auth MTU parms [ L:1570 D:178 EF:78 EB:0 ET:0 EL:0 ]
Wed May 27 12:16:45 2015 us=662012 Socket Buffers: R=[133120->131072] S=[133120->131072]
Wed May 27 12:16:45 2015 us=662162 ROUTE_GATEWAY ON_LINK IFACE=venet0 HWADDR=00:00:00:00:00:00
Wed May 27 12:16:45 2015 us=662432 TUN/TAP device tun0 opened
Wed May 27 12:16:45 2015 us=662449 TUN/TAP TX queue length set to 100
Wed May 27 12:16:45 2015 us=662462 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0
Wed May 27 12:16:45 2015 us=662487 /sbin/ip link set dev tun0 up mtu 1500
Wed May 27 12:16:45 2015 us=677586 /sbin/ip addr add dev tun0 local 10.8.0.1 peer 10.8.0.2
Wed May 27 12:16:45 2015 us=682493 /sbin/ip route add 10.8.0.0/24 via 10.8.0.2
Wed May 27 12:16:45 2015 us=683154 Data Channel MTU parms [ L:1570 D:1450 EF:70 EB:135 ET:0 EL:0 AF:3/1 ]
Wed May 27 12:16:45 2015 us=683620 GID set to nobody
Wed May 27 12:16:45 2015 us=683666 UID set to nobody
Wed May 27 12:16:45 2015 us=683692 UDPv4 link local (bound): [AF_INET]255.***.***.***:443
Wed May 27 12:16:45 2015 us=683702 UDPv4 link remote: [undef]
Wed May 27 12:16:45 2015 us=683717 MULTI: multi_init called, r=256 v=256
Wed May 27 12:16:45 2015 us=683781 IFCONFIG POOL: base=10.8.0.4 size=62, ipv6=0
Wed May 27 12:16:45 2015 us=683810 Initialization Sequence Completed

now i connect and disconnect from the vpn via OPENVPN GUI
openvpn GUI log

Code: Select all

Thu May 28 02:23:36 2015 OpenVPN 2.3.6 x86_64-w64-mingw32 [SSL (OpenSSL)] [LZO] [PKCS11] [IPv6] built on Mar 19 2015
Thu May 28 02:23:36 2015 library versions: OpenSSL 1.0.1m 19 Mar 2015, LZO 2.08
Enter Management Password:
Thu May 28 02:23:36 2015 MANAGEMENT: TCP Socket listening on [AF_INET]127.0.0.1:25340
Thu May 28 02:23:36 2015 Need hold release from management interface, waiting...
Thu May 28 02:23:36 2015 MANAGEMENT: Client connected from [AF_INET]127.0.0.1:25340
Thu May 28 02:23:37 2015 MANAGEMENT: CMD 'state on'
Thu May 28 02:23:37 2015 MANAGEMENT: CMD 'log all on'
Thu May 28 02:23:37 2015 MANAGEMENT: CMD 'hold off'
Thu May 28 02:23:37 2015 MANAGEMENT: CMD 'hold release'
Thu May 28 02:23:37 2015 Control Channel Authentication: using 'ta.key' as a OpenVPN static key file
Thu May 28 02:23:37 2015 Outgoing Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 28 02:23:37 2015 Incoming Control Channel Authentication: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 28 02:23:37 2015 Socket Buffers: R=[8192->8192] S=[8192->8192]
Thu May 28 02:23:37 2015 UDPv4 link local: [undef]
Thu May 28 02:23:37 2015 UDPv4 link remote: [AF_INET]255.***.***.***:443
Thu May 28 02:23:37 2015 MANAGEMENT: >STATE:1432743817,WAIT,,,
Thu May 28 02:23:37 2015 MANAGEMENT: >STATE:1432743817,AUTH,,,
Thu May 28 02:23:37 2015 TLS: Initial packet from [AF_INET]255.***.***.***:443, sid=2b5f5879 0ef0d44b
Thu May 28 02:23:45 2015 VERIFY OK: depth=1, C=US, ST=CA, L=brooklyn, O=random, OU=asdfghjkl, CN=random CA, name=EasyRSA, emailAddress=***********
Thu May 28 02:23:45 2015 Validating certificate key usage
Thu May 28 02:23:45 2015 ++ Certificate has key usage  00a0, expects 00a0
Thu May 28 02:23:45 2015 VERIFY KU OK
Thu May 28 02:23:45 2015 Validating certificate extended key usage
Thu May 28 02:23:45 2015 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Thu May 28 02:23:45 2015 VERIFY EKU OK
Thu May 28 02:23:45 2015 VERIFY OK: depth=0, C=US, ST=CA, L=brooklyn, O=random, OU=asdfghjkl, CN=server, name=EasyRSA, emailAddress=********
Thu May 28 02:24:09 2015 Data Channel Encrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
Thu May 28 02:24:09 2015 Data Channel Encrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 28 02:24:09 2015 Data Channel Decrypt: Cipher 'AES-256-CBC' initialized with 256 bit key
Thu May 28 02:24:09 2015 Data Channel Decrypt: Using 256 bit message hash 'SHA256' for HMAC authentication
Thu May 28 02:24:09 2015 Control Channel: TLSv1, cipher TLSv1/SSLv3 DHE-RSA-AES256-SHA, 4096 bit RSA
Thu May 28 02:24:09 2015 [server] Peer Connection Initiated with [AF_INET]255.***.***.***:443
Thu May 28 02:24:10 2015 MANAGEMENT: >STATE:1432743850,GET_CONFIG,,,
Thu May 28 02:24:11 2015 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1)
Thu May 28 02:24:16 2015 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1)
Thu May 28 02:24:19 2015 PUSH: Received control message: 'PUSH_REPLY,redirect-gateway def1,redirect-gateway,dhcp-option DNS 8.8.8.8,dhcp-option DNS 8.8.4.4,route 10.8.0.1,topology net30,ping 5,ping-restart 180,ifconfig 10.8.0.6 10.8.0.5'
Thu May 28 02:24:19 2015 OPTIONS IMPORT: timers and/or timeouts modified
Thu May 28 02:24:19 2015 OPTIONS IMPORT: --ifconfig/up options modified
Thu May 28 02:24:19 2015 OPTIONS IMPORT: route options modified
Thu May 28 02:24:19 2015 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
Thu May 28 02:24:19 2015 do_ifconfig, tt->ipv6=0, tt->did_ifconfig_ipv6_setup=0
Thu May 28 02:24:19 2015 MANAGEMENT: >STATE:1432743859,ASSIGN_IP,,10.8.0.6,
Thu May 28 02:24:19 2015 open_tun, tt->ipv6=0
Thu May 28 02:24:19 2015 TAP-WIN32 device [Local Area Connection 2] opened: \\.\Global\{31B85720-5B66-4301-8735-379DEE81D6BF}.tap
Thu May 28 02:24:19 2015 TAP-Windows Driver Version 9.21 
Thu May 28 02:24:19 2015 Notified TAP-Windows driver to set a DHCP IP/netmask of 10.8.0.6/255.255.255.252 on interface {31B85720-5B66-4301-8735-379DEE81D6BF} [DHCP-serv: 10.8.0.5, lease-time: 31536000]
Thu May 28 02:24:19 2015 Successful ARP Flush on interface [18] {31B85720-5B66-4301-8735-379DEE81D6BF}
Thu May 28 02:24:24 2015 TEST ROUTES: 2/2 succeeded len=1 ret=1 a=0 u/d=up
Thu May 28 02:24:24 2015 C:\Windows\system32\route.exe ADD 192.210.145.63 MASK 255.255.255.255 192.168.1.1
Thu May 28 02:24:24 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Thu May 28 02:24:24 2015 Route addition via IPAPI succeeded [adaptive]
Thu May 28 02:24:24 2015 C:\Windows\system32\route.exe ADD 0.0.0.0 MASK 128.0.0.0 10.8.0.5
Thu May 28 02:24:24 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Thu May 28 02:24:24 2015 Route addition via IPAPI succeeded [adaptive]
Thu May 28 02:24:24 2015 C:\Windows\system32\route.exe ADD 128.0.0.0 MASK 128.0.0.0 10.8.0.5
Thu May 28 02:24:24 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Thu May 28 02:24:24 2015 Route addition via IPAPI succeeded [adaptive]
Thu May 28 02:24:24 2015 MANAGEMENT: >STATE:1432743864,ADD_ROUTES,,,
Thu May 28 02:24:24 2015 C:\Windows\system32\route.exe ADD 10.8.0.1 MASK 255.255.255.255 10.8.0.5
Thu May 28 02:24:24 2015 ROUTE: CreateIpForwardEntry succeeded with dwForwardMetric1=20 and dwForwardType=4
Thu May 28 02:24:24 2015 Route addition via IPAPI succeeded [adaptive]
Thu May 28 02:24:24 2015 Initialization Sequence Completed
Thu May 28 02:24:24 2015 MANAGEMENT: >STATE:1432743864,CONNECTED,SUCCESS,10.8.0.6,255.***.***.***
Thu May 28 02:24:33 2015 C:\Windows\system32\route.exe DELETE 10.8.0.1 MASK 255.255.255.255 10.8.0.5
Thu May 28 02:24:33 2015 Route deletion via IPAPI succeeded [adaptive]
Thu May 28 02:24:33 2015 C:\Windows\system32\route.exe DELETE 255.***.***.*** MASK 255.255.255.255 192.168.1.1
Thu May 28 02:24:33 2015 Route deletion via IPAPI succeeded [adaptive]
Thu May 28 02:24:33 2015 C:\Windows\system32\route.exe DELETE 0.0.0.0 MASK 128.0.0.0 10.8.0.5
Thu May 28 02:24:33 2015 Route deletion via IPAPI succeeded [adaptive]
Thu May 28 02:24:33 2015 C:\Windows\system32\route.exe DELETE 128.0.0.0 MASK 128.0.0.0 10.8.0.5
Thu May 28 02:24:33 2015 Route deletion via IPAPI succeeded [adaptive]
Thu May 28 02:24:33 2015 Closing TUN/TAP interface
Thu May 28 02:24:33 2015 SIGTERM[hard,] received, process exiting
Thu May 28 02:24:33 2015 MANAGEMENT: >STATE:1432743873,EXITING,SIGTERM,,
After i defined the openvpn-status.log to a proper path in verb 6 and verb 0 logging level i am no longer getting that message "Failed to truncate status file: Invalid argument" in my log file ,was that really it lol ?. If you have time can you please tell us what Failed to truncate status file: Invalid argument means
Top
User avatar
Traffic
OpenVPN Protagonist
Posts: 4066
Joined: Sat Aug 09, 2014 11:24 am

Re: server log | how did i do ?

Post by Traffic » Wed May 27, 2015 9:46 pm

1.
maikcat wrote:some things to check,

can you use absolute path name for the status file?
blah09 wrote:status /etc/openvpn/logs/openvpn-status.log
log /etc/openvpn//logs/openvpn.log
ok

2.
maikcat wrote:in which filesystem the status file is located?
check that ..


3.
maikcat wrote:can you try to stop openvpn and remove/rename the file then start openvpn again?

Michael.
probably implied by 1. (thanks Michael)
blah09 wrote:can you please tell us what Failed to truncate status file: Invalid argument means
meaning: Failed to truncate status file: [due to an] Invalid argument .. maybe some other process had the file locked ..
Top
Post Reply

Return to “Installation Help”