I removed tun-mtu and tried with mssfix at various values as well as leaving it off and still no luck. It's almost always exactly 30 seconds for it to restart, but sometimes it lasts 1 minute or 1:30. Here is the first part of my log below:
Created by...
___. .__ .__
\_ |__ |__| ____ | |__ ____ ___ ___
| __ \| |/ \| | \_/ __ \\ \/ /
| \_\ \ | | \ Y \ ___/ > <
|___ /__|___| /___| /\___ >__/\_ \
\/ \/ \/ \/ \/
https://hub.docker.com/u/binhex/
2018-02-19 11:30:03.142687 [info] System information Linux 68e037700d87 4.2.8 #1 SMP Tue Feb 13 01:43:29 CST 2018 x86_64 GNU/Linux
2018-02-19 11:30:03.231792 [info] PUID defined as '911'
2018-02-19 11:30:03.350080 [info] PGID defined as '1000'
2018-02-19 11:30:03.437476 [info] UMASK defined as '000'
2018-02-19 11:30:03.505382 [info] Permissions already set for volume mappings
2018-02-19 11:30:03.588286 [info] VPN_ENABLED defined as 'yes'
2018-02-19 11:30:03.872091 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn
dos2unix: converting file /config/openvpn/AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn to Unix format...
2018-02-19 11:30:03.947324 [info] VPN remote line defined as '199.19.94.12 443'
2018-02-19 11:30:04.012750 [info] VPN_REMOTE defined as '199.19.94.12'
2018-02-19 11:30:04.078367 [info] VPN_PORT defined as '443'
2018-02-19 11:30:04.150602 [info] VPN_PROTOCOL defined as 'udp'
2018-02-19 11:30:04.220178 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-02-19 11:30:04.289099 [info] VPN_PROV defined as 'airvpn'
2018-02-19 11:30:04.358946 [info] LAN_NETWORK defined as '10.11.12.0/24'
2018-02-19 11:30:04.431508 [info] NAME_SERVERS defined as '8.8.8.8,37.235.1.174,37.235.1.177,209.244.0.3,64.6.64.6,4.2.2.2,8.8.4.4,208.67.222.222,209.222.18.218'
2018-02-19 11:30:04.498166 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-02-19 11:30:04.570766 [info] ENABLE_PRIVOXY defined as 'NO'
2018-02-19 11:30:04.639653 [info] Setting permissions on files/folders inside container...
2018-02-19 11:30:04.736066 [info] Starting Supervisor...
2018-02-19 11:30:05,323 CRIT Set uid to user 0
2018-02-19 11:30:05,323 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing
2018-02-19 11:30:05,333 INFO supervisord started with pid 6
2018-02-19 11:30:06,336 INFO spawned: 'start-script' with pid 117
2018-02-19 11:30:06,338 INFO spawned: 'deluge-script' with pid 118
2018-02-19 11:30:06,341 INFO spawned: 'deluge-web-script' with pid 119
2018-02-19 11:30:06,344 INFO spawned: 'privoxy-script' with pid 120
2018-02-19 11:30:06,345 INFO reaped unknown pid 7
2018-02-19 11:30:06,354 DEBG 'deluge-script' stdout output:
[info] Deluge config file already exists, skipping copy
2018-02-19 11:30:06,355 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-02-19 11:30:06,355 INFO success: deluge-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-02-19 11:30:06,355 INFO success: deluge-web-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-02-19 11:30:06,355 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-02-19 11:30:06,356 DEBG 'deluge-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid
2018-02-19 11:30:06,356 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-02-19 11:30:06,360 DEBG 'privoxy-script' stdout output:
[info] Privoxy set to disabled
2018-02-19 11:30:06,361 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 140379986381280 for <Subprocess at 140379995430712 with name privoxy-script in state RUNNING> (stdout)>
2018-02-19 11:30:06,361 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 140379986381712 for <Subprocess at 140379995430712 with name privoxy-script in state RUNNING> (stderr)>
2018-02-19 11:30:06,362 INFO exited: privoxy-script (exit status 0; expected)
2018-02-19 11:30:06,362 DEBG received SIGCLD indicating a child quit
2018-02-19 11:30:06,400 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN
[debug] Environment variables defined as follows
BASH=/bin/bash
BASHOPTS=cmdhist:complete_fullquote:extquote:force_fignore:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath
BASH_ALIASES=()
BASH_ARGC=()
BASH_ARGV=()
BASH_CMDS=()
2018-02-19 11:30:06,401 DEBG 'start-script' stdout output:
BASH_LINENO=([0]="0")
BASH_SOURCE=([0]="/root/start.sh")
BASH_VERSINFO=([0]="4" [1]="4" [2]="12" [3]="1" [4]="release" [5]="x86_64-unknown-linux-gnu")
BASH_VERSION='4.4.12(1)-release'
DEBUG=true
DIRSTACK=()
ENABLE_PRIVOXY=NO
EUID=0
GROUPS=()
HOME=/home/nobody
HOSTNAME=68e037700d87
HOSTTYPE=x86_64
IFS=$' \t\n'
LANG=en_GB.UTF-8
LAN_NETWORK=10.11.12.0/24
MACHTYPE=x86_64-unknown-linux-gnu
NAME_SERVERS=8.8.8.8,37.235.1.174,37.235.1.177,209.244.0.3,64.6.64.6,4.2.2.2,8.8.4.4,208.67.222.222,209.222.18.218
OPTERR=1
OPTIND=1
OSTYPE=linux-gnu
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
PGID=1000
PIPESTATUS=([0]="0")
PPID=6
PS4='+ '
PUID=911
PWD=/
SHELL=/bin/bash
SHELLOPTS=braceexpand:hashall:interactive-comments
SHLVL=1
SUPERVISOR_ENABLED=1
SUPERVISOR_GROUP_NAME=start-script
SUPERVISOR_PROCESS_NAME=start-script
TERM=xterm
UID=0
UMASK=000
VPN_CONFIG=/config/openvpn/AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn
VPN_DEVICE_TYPE=tun0
VPN_ENABLED=yes
VPN_OPTIONS=
VPN_PORT=443
VPN_PROTOCOL=udp
VPN_PROV=airvpn
VPN_REMOTE=199.19.94.12
_='[debug] Environment variables defined as follows'
vpn_remote_line='199.19.94.12 443'
[debug] Directory listing of files in /config/openvpn as follows
2018-02-19 11:30:06,420 DEBG 'start-script' stdout output:
total 7564
drwxrwxr-x+ 4 nobody users 4096 Feb 19 11:30 .
drwxrwxr-x+ 7 nobody users 4096 Feb 19 11:30 ..
drwxrwxr-x+ 2 nobody users 4096 Feb 16 14:02 airvpn
-rwxrwxr-x+ 1 nobody users 9155 Feb 19 11:30 AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn
drwxrwxr-x+ 2 nobody users 491520 Feb 16 12:24 configs
-rwxrwxr-x+ 1 nobody users 7212234 Feb 16 15:56 openvpn.log
2018-02-19 11:30:06,470 DEBG 'start-script' stdout output:
[debug] Contents of ovpn file /config/openvpn/AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn as follows...
2018-02-19 11:30:06,473 DEBG 'start-script' stdout output:
remote 199.19.94.12 443
# --------------------------------------------------------
# Air VPN | https://airvpn.org | Friday 16th of February 2018 07:43:22 PM
# OpenVPN Client Configuration
# AirVPN_US-Pennsylvania_Metallah_UDP-443
# --------------------------------------------------------
client
dev tun
proto udp
resolv-retry infinite
remote-random
nobind
#mssfix 1400
persist-key
ping 15
ping-restart 60
explicit-exit-notify 3
remote-cert-tls server
#mute 10000
comp-lzo no
verb 3
pull
fast-io
cipher AES-256-CBC
key-direction 1
<ca>
-----BEGIN CERTIFICATE-----
...
-----END CERTIFICATE-----
</ca>
<cert>
-----BEGIN CERTIFICATE-----
...
-----END CERTIFICATE-----
</cert>
<key>
-----BEGIN PRIVATE KEY-----
...
-----END PRIVATE KEY-----
</key>
<tls-auth>
#
# 2048 bit OpenVPN static key
#
-----BEGIN OpenVPN Static key V1-----
...
-----END OpenVPN Static key V1-----
</tls-auth>
2018-02-19 11:30:06,516 DEBG 'start-script' stdout output:
[info] Default route for container is 10.0.3.1
2018-02-19 11:30:06,522 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf
2018-02-19 11:30:06,529 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf
2018-02-19 11:30:06,535 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf
2018-02-19 11:30:06,542 DEBG 'start-script' stdout output:
[info] Adding 209.244.0.3 to /etc/resolv.conf
2018-02-19 11:30:06,548 DEBG 'start-script' stdout output:
[info] Adding 64.6.64.6 to /etc/resolv.conf
2018-02-19 11:30:06,555 DEBG 'start-script' stdout output:
[info] Adding 4.2.2.2 to /etc/resolv.conf
2018-02-19 11:30:06,561 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf
2018-02-19 11:30:06,567 DEBG 'start-script' stdout output:
[info] Adding 208.67.222.222 to /etc/resolv.conf
2018-02-19 11:30:06,574 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf
2018-02-19 11:30:06,579 DEBG 'start-script' stdout output:
199.19.94.12
2018-02-19 11:30:06,606 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...
2018-02-19 11:30:06,609 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.2.8
2018-02-19 11:30:06,610 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...
2018-02-19 11:30:06,616 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory
2018-02-19 11:30:06,617 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module, you will not be able to connect to the applications Web UI or Privoxy outside of your LAN
[info] unRAID/Ubuntu users: Please attempt to load the module by executing the following on your host: '/sbin/modprobe iptable_mangle'
[info] Synology users: Please attempt to load the module by executing the following on your host: 'insmod /lib/modules/iptable_mangle.ko'
[debug] Show name servers defined for container
2018-02-19 11:30:06,618 DEBG 'start-script' stdout output:
nameserver 8.8.8.8
nameserver 37.235.1.174
nameserver 37.235.1.177
nameserver 209.244.0.3
nameserver 64.6.64.6
nameserver 4.2.2.2
nameserver 8.8.4.4
nameserver 208.67.222.222
nameserver 209.222.18.218
2018-02-19 11:30:06,619 DEBG 'start-script' stdout output:
[debug] Show name resolution for VPN endpoint 199.19.94.12
2018-02-19 11:30:06,656 DEBG 'start-script' stdout output:
;; ->>HEADER<<- opcode: QUERY, rcode: NXDOMAIN, id: 43339
;; flags: qr rd ra ; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;; 199.19.94.12. IN A
;; ANSWER SECTION:
;; AUTHORITY SECTION:
. 86381 IN SOA a.root-servers.net. nstld.verisign-grs.com. 2018021900 1800 900 604800 86400
;; ADDITIONAL SECTION:
;; Query time: 29 msec
;; SERVER: 8.8.8.8
;; WHEN: Mon Feb 19 11:30:06 2018
;; MSG SIZE rcvd: 105
2018-02-19 11:30:06,657 DEBG 'start-script' stdout output:
[debug] Show contents of hosts file
2018-02-19 11:30:06,658 DEBG 'start-script' stdout output:
127.0.0.1 localhost
::1 localhost ip6-localhost ip6-loopback
fe00::0 ip6-localnet
ff00::0 ip6-mcastprefix
ff02::1 ip6-allnodes
ff02::2 ip6-allrouters
10.0.3.6 68e037700d87
2018-02-19 11:30:06,666 DEBG 'start-script' stdout output:
[info] Adding 10.11.12.0/24 as route via docker eth0
2018-02-19 11:30:06,668 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------
2018-02-19 11:30:06,670 DEBG 'start-script' stdout output:
default via 10.0.3.1 dev eth0
10.0.3.0/24 dev eth0 proto kernel scope link src 10.0.3.6
10.11.12.0/24 via 10.0.3.1 dev eth0
2018-02-19 11:30:06,670 DEBG 'start-script' stdout output:
--------------------
[debug] Modules currently loaded for kernel
2018-02-19 11:30:06,675 DEBG 'start-script' stdout output:
Module Size Used by
xfrm4_tunnel 1993 0
ipcomp 2203 0
esp4 6849 0
ah4 6547 0
xfrm4_mode_transport 1418 0
xfrm4_mode_tunnel 1936 0
xfrm4_mode_beet 1979 0
af_key 25926 0
xfrm_ipcomp 3868 1 ipcomp
nf_nat_redirect 1267 0
l2tp_ppp 15362 0
l2tp_eth 3984 0
l2tp_netlink 9274 2 l2tp_eth,l2tp_ppp
l2tp_debugfs 4346 0
l2tp_ip 6053 0
l2tp_core 18070 5 l2tp_eth,l2tp_ppp,l2tp_debugfs,l2tp_ip,l2tp_netlink
ppp_deflate 3874 0
ppp_async 6850 0
ppp_mppe 6187 0
bsd_comp 5226 0
pppoe 9430 0
pppox 1810 2 l2tp_ppp,pppoe
ppp_generic 18543 7 l2tp_ppp,pppoe,pppox,bsd_comp,ppp_mppe,ppp_async,ppp_deflate
slhc 5235 1 ppp_generic
tunnel4 2325 1 xfrm4_tunnel
vhost_scsi 21520 0
target_core_mod 392179 1 vhost_scsi
vhost_net 10228 0
vhost 19160 2 vhost_net,vhost_scsi
macvtap 10877 1 vhost_net
macvlan 13168 1 macvtap
tun 18961 1 vhost_net
vringh 8642 0
virtio_scsi 10385 0
virtio_pci 14007 0
virtio_net 21315 0
virtio_mmio 5142 0
virtio_console 17572 0
virtio_blk 8736 0
virtio_balloon 5479 0
virtio_rng 2527 0
virtio_ring 7299 8 virtio_blk,virtio_net,virtio_pci,virtio_rng,virtio_balloon,virtio_console,virtio_mmio,virtio_scsi
virtio 5273 8 virtio_blk,virtio_net,virtio_pci,virtio_rng,virtio_balloon,virtio_console,virtio_mmio,virtio_scsi
kvm_intel 145614 0
kvm 307775 1 kvm_intel
xt_nat 1977 0
rfcomm 50263 0
iscsi_tcp 8942 0
libiscsi_tcp 12474 1 iscsi_tcp
libiscsi 38257 2 libiscsi_tcp,iscsi_tcp
scsi_transport_iscsi 66567 3 iscsi_tcp,libiscsi
fbdisk 20441 0
ipt_MASQUERADE 1533 4
iptable_nat 1959 1
nf_nat_masquerade_ipv4 1865 1 ipt_MASQUERADE
nf_nat_ipv4 5147 1 iptable_nat
nf_nat 11914 4 nf_nat_redirect,nf_nat_ipv4,xt_nat,nf_nat_masquerade_ipv4
xt_policy 2522 0
xt_mark 1317 0
bonding 114377 0
br_netfilter 13236 0
bridge 80620 1 br_netfilter
stp 1693 1 bridge
8021q 17067 0
ipv6 311235 2 bridge,l2tp_core
uvcvideo 73142 0
videobuf2_vmalloc 5094 1 uvcvideo
videobuf2_memops 2215 1 videobuf2_vmalloc
videobuf2_core 33372 1 uvcvideo
snd_usb_caiaq 39170 0
snd_usb_audio 139029 0
snd_usbmidi_lib 20836 1 snd_usb_audio
snd_seq_midi 5478 0
snd_rawmidi 18725 3 snd_usb_caiaq,snd_usbmidi_lib,snd_seq_midi
fnotify 27085 2
isofs 31658 0
sp5100_tco 5952 0
iTCO_wdt 5700 1
vfio_pci 27672 0
vfio_virqfd 2165 1 vfio_pci
vfio_iommu_type1 8294 0
vfio 14991 2 vfio_iommu_type1,vfio_pci
udf 77803 1
x53B_pins 3884 0
ufsd 652732 0
jnl 27383 1 ufsd
pl2303 11696 0
usbserial 28885 1 pl2303
qm2_i2c 3281 6
intel_ips 11476 0
drbd 331130 4
flashcache 140446 1
dm_tier_hro_algo 14663 1
dm_thin_pool 157769 21 target_core_mod,dm_tier_hro_algo
dm_bio_prison 4372 1 dm_thin_pool
dm_persistent_data 48048 1 dm_thin_pool
hal_netlink 4853 0
k10temp 3253 0
coretemp 6044 0
tn40xx 1078570 0
r8152 52531 0
usb
2018-02-19 11:30:06,677 DEBG 'start-script' stdout output:
net 25199 0
mii 4035 2 r8152,usbnet
igb 162846 0
e1000e 198727 0
mpt3sas 275732 0
mpt2sas 169679 0
scsi_transport_sas 24764 2 mpt2sas,mpt3sas
raid_class 3572 2 mpt2sas,mpt3sas
usb_storage 49870 1
xhci_pci 4650 0
xhci_hcd 134237 1 xhci_pci
usblp 12346 0
uhci_hcd 32595 0
ehci_pci 4359 0
ehci_hcd 60621 1 ehci_pci
2018-02-19 11:30:06,693 DEBG 'start-script' stdout output:
[debug] Docker interface defined as eth0
2018-02-19 11:30:06,700 DEBG 'start-script' stdout output:
[debug] Docker IP defined as 10.0.3.6
2018-02-19 11:30:06,707 DEBG 'start-script' stdout output:
[debug] Docker netmask defined as 255.255.255.0
2018-02-19 11:30:06,727 DEBG 'start-script' stdout output:
[info] Docker network defined as 10.0.3.0/24
2018-02-19 11:30:06,832 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------
2018-02-19 11:30:06,836 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD ACCEPT
-P OUTPUT DROP
-A INPUT -i tun0 -j ACCEPT
-A INPUT -s 10.0.3.0/24 -d 10.0.3.0/24 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --sport 443 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 8112 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 8112 -j ACCEPT
-A INPUT -s 10.11.12.0/24 -i eth0 -p tcp -m tcp --dport 58846 -j ACCEPT
-A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT
-A INPUT -i lo -j ACCEPT
-A OUTPUT -o tun0 -j ACCEPT
-A OUTPUT -s 10.0.3.0/24 -d 10.0.3.0/24 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --dport 443 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 8112 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 8112 -j ACCEPT
-A OUTPUT -d 10.11.12.0/24 -o eth0 -p tcp -m tcp --sport 58846 -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT
2018-02-19 11:30:06,837 DEBG 'start-script' stdout output:
--------------------
2018-02-19 11:30:06,838 DEBG 'start-script' stdout output:
[debug] OpenVPN command line:- /usr/bin/openvpn --cd /config/openvpn --config '/config/openvpn/AirVPN_US-Pennsylvania_Metallah_UDP-443.ovpn' --daemon --reneg-sec 0 --mute-replay-warnings --auth-nocache --setenv VPN_PROV 'airvpn' --setenv DEBUG 'true' --setenv VPN_DEVICE_TYPE 'tun0' --setenv VPN_REMOTE '199.19.94.12' --script-security 2 --up /root/openvpnup.sh --up-delay --up-restart --writepid /root/openvpn.pid --remap-usr1 SIGHUP --log-append /dev/stdout --pull-filter ignore 'up' --pull-filter ignore 'down' --pull-filter ignore 'route-ipv6' --pull-filter ignore 'ifconfig-ipv6' --pull-filter ignore 'tun-ipv6' --pull-filter ignore 'persist-tun' --pull-filter ignore 'reneg-sec'
[info] Starting OpenVPN...
2018-02-19 11:30:06,852 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 OpenVPN 2.4.4 x86_64-unknown-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Sep 26 2017
Mon Feb 19 11:30:06 2018 library versions: OpenSSL 1.1.0f 25 May 2017, LZO 2.10
2018-02-19 11:30:06,854 DEBG 'start-script' stdout output:
[info] OpenVPN started
Mon Feb 19 11:30:06 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
[debug] Waiting for valid IP address from tunnel...
2018-02-19 11:30:06,854 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Feb 19 11:30:06 2018 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Feb 19 11:30:06 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]199.19.94.12:443
Mon Feb 19 11:30:06 2018 Socket Buffers: R=[1048576->1048576] S=[1048576->1048576]
Mon Feb 19 11:30:06 2018 UDP link local: (not bound)
Mon Feb 19 11:30:06 2018 UDP link remote: [AF_INET]199.19.94.12:443
2018-02-19 11:30:06,884 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 TLS: Initial packet from [AF_INET]199.19.94.12:443, sid=131d3c23 7399b3ec
2018-02-19 11:30:06,937 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 VERIFY OK: depth=1, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=airvpn.org CA,
[email protected]
2018-02-19 11:30:06,937 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 VERIFY KU OK
Mon Feb 19 11:30:06 2018 Validating certificate extended key usage
2018-02-19 11:30:06,937 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:06 2018 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Mon Feb 19 11:30:06 2018 VERIFY EKU OK
Mon Feb 19 11:30:06 2018 VERIFY OK: depth=0, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=Almach,
[email protected]
2018-02-19 11:30:07,084 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:07 2018 Control Channel: TLSv1.2, cipher TLSv1.2 ECDHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
Mon Feb 19 11:30:07 2018 [Almach] Peer Connection Initiated with [AF_INET]199.19.94.12:443
2018-02-19 11:30:08,160 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 SENT CONTROL [Almach]: 'PUSH_REQUEST' (status=1)
2018-02-19 11:30:08,190 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 PUSH: Received control message: 'PUSH_REPLY,comp-lzo no,redirect-gateway def1 bypass-dhcp,dhcp-option DNS 10.4.0.1,route-gateway 10.4.0.1,topology subnet,ping 10,ping-restart 60,ifconfig 10.4.19.176 255.255.0.0,peer-id 4,cipher AES-256-GCM'
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: timers and/or timeouts modified
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: compression parms modified
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: --ifconfig/up options modified
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: route options modified
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: route-related options modified
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
2018-02-19 11:30:08,191 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: peer-id set
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: adjusting link_mtu to 1625
Mon Feb 19 11:30:08 2018 OPTIONS IMPORT: data channel crypto options modified
Mon Feb 19 11:30:08 2018 Data Channel: using negotiated cipher 'AES-256-GCM'
Mon Feb 19 11:30:08 2018 Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Mon Feb 19 11:30:08 2018 Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Mon Feb 19 11:30:08 2018 ROUTE_GATEWAY 10.0.3.1/255.255.255.0 IFACE=eth0 HWADDR=02:42:0a:00:03:06
Mon Feb 19 11:30:08 2018 TUN/TAP device tun0 opened
Mon Feb 19 11:30:08 2018 TUN/TAP TX queue length set to 100
Mon Feb 19 11:30:08 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
2018-02-19 11:30:08,191 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /usr/bin/ip link set dev tun0 up mtu 1500
2018-02-19 11:30:08,194 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /usr/bin/ip addr add dev tun0 10.4.19.176/16 broadcast 10.4.255.255
2018-02-19 11:30:08,197 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /root/openvpnup.sh tun0 1500 1553 10.4.19.176 255.255.0.0 init
2018-02-19 11:30:08,202 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /usr/bin/ip route add 199.19.94.12/32 via 10.0.3.1
2018-02-19 11:30:08,208 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-02-19 11:30:08,210 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /usr/bin/ip route add 0.0.0.0/1 via 10.4.0.1
2018-02-19 11:30:08,213 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 /usr/bin/ip route add 128.0.0.0/1 via 10.4.0.1
2018-02-19 11:30:08,214 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-02-19 11:30:08,217 DEBG 'start-script' stdout output:
Mon Feb 19 11:30:08 2018 Initialization Sequence Completed
2018-02-19 11:30:08,236 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.19.176'
2018-02-19 11:30:08,334 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.19.176'
2018-02-19 11:30:08,343 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.19.176'
[debug] Attempting to get external IP using Name Server 'ns1.google.com'...
2018-02-19 11:30:08,344 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.19.176'
2018-02-19 11:30:08,345 DEBG 'start-script' stdout output:
[debug] VPN provider airvpn is != pia, skipping incoming port detection
2018-02-19 11:30:08,346 DEBG 'deluge-script' stdout output:
[info] Deluge not running
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.4.19.176 different, marking for reconfigure
[info] Attempting to start Deluge...
2018-02-19 11:30:08,489 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 199.19.94.16
2018-02-19 11:30:08,702 DEBG 'deluge-script' stdout output:
[info] Deluge listening interface currently defined as 10.4.19.176
[info] Deluge listening interface will be changed to 10.4.19.176
[info] Saving changes to Deluge config file /config/core.conf...
2018-02-19 11:30:09,080 DEBG 'deluge-script' stdout output:
[info] Deluge started
[debug] VPN incoming port is
[debug] VPN IP is 10.4.19.176
2018-02-19 11:30:09,080 DEBG 'deluge-script' stdout output:
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.19.176
2018-02-19 11:30:09,823 DEBG 'deluge-web-script' stdout output:
[info] Starting Deluge webui...
2018-02-19 11:30:38,251 DEBG 'start-script' stdout output:
[warn] OpenVPN process terminated, restarting OpenVPN...