I have setup arch-delugevpn in Open Media Vault. Everything happens without any errors; but I cannot seem to resolve any hostnames. Turning off the VPN allows the following commands to produce the expected results; however no combination of VPN and/or Proxy will connect the web-ui.
Example behavior:
~$ sudo docker exec -it arch-delugevpn curl ipinfo.io
curl: (6) Could not resolve host: ipinfo.io
~$ sudo docker exec -it arch-delugevpn ping google.com
ping: google.com: Temporary failure in name resolution
~$ sudo docker exec -it arch-delugevpn cat /etc/resolv.conf
nameserver 8.8.8.8
nameserver 37.235.1.174
nameserver 8.8.4.4
nameserver 37.235.1.177
~$ sudo docker exec -it arch-delugevpn ping 37.235.1.174
PING 37.235.1.174 (37.235.1.174) 56(84) bytes of data.
64 bytes from 37.235.1.174: icmp_seq=1 ttl=48 time=130 ms
64 bytes from 37.235.1.174: icmp_seq=2 ttl=48 time=127 ms
This is my supervisord.log
Created by...
___. .__ .__
\_ |__ |__| ____ | |__ ____ ___ ___
| __ \| |/ \| | \_/ __ \\ \/ /
| \_\ \ | | \ Y \ ___/ > <
|___ /__|___| /___| /\___ >__/\_ \
\/ \/ \/ \/ \/
https://hub.docker.com/u/binhex/
2018-09-18 12:00:51.481400 [info] System information Linux 5bc7a01b56e1 4.17.0-0.bpo.3-amd64 #1 SMP Debian 4.17.17-1~bpo9+1 (2018-08-27) x86_64 GNU/Linux
2018-09-18 12:00:51.514020 [info] PUID defined as '1000'
2018-09-18 12:00:51.711941 [info] PGID defined as '1000'
2018-09-18 12:00:51.927771 [info] UMASK defined as '2'
2018-09-18 12:00:51.959458 [info] Permissions already set for volume mappings
2018-09-18 12:00:51.992618 [info] VPN_ENABLED defined as 'yes'
2018-09-18 12:00:52.032886 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/default.ovpn
dos2unix: converting file /config/openvpn/default.ovpn to Unix format...
2018-09-18 12:00:52.080983 [info] VPN remote line defined as 'remote us-mn2-smart.serverlocation.co 443'
2018-09-18 12:00:52.112522 [info] VPN_REMOTE defined as 'us-mn2-smart.serverlocation.co'
2018-09-18 12:00:52.146599 [info] VPN_PORT defined as '443'
2018-09-18 12:00:52.182366 [info] VPN_PROTOCOL defined as 'udp'
2018-09-18 12:00:52.213756 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-09-18 12:00:52.248577 [info] VPN_PROV defined as 'custom'
2018-09-18 12:00:52.283728 [info] LAN_NETWORK defined as '192.168.1.0/24'
2018-09-18 12:00:52.320286 [warn] NAME_SERVERS not defined (via -e NAME_SERVERS), defaulting to Google and FreeDNS name servers
2018-09-18 12:00:52.352810 [info] VPN_USER defined as '*******'
2018-09-18 12:00:52.387728 [info] VPN_PASS defined as '*******'
2018-09-18 12:00:52.423548 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-09-18 12:00:52.456163 [info] ENABLE_PRIVOXY defined as 'yes'
2018-09-18 12:00:54.484348 [info] Starting Supervisor...
2018-09-18 12:00:54,839 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing
2018-09-18 12:00:54,839 INFO Set uid to user 0 succeeded
2018-09-18 12:00:54,842 INFO supervisord started with pid 8
2018-09-18 12:00:55,844 INFO spawned: 'start-script' with pid 138
2018-09-18 12:00:55,846 INFO spawned: 'deluge-script' with pid 139
2018-09-18 12:00:55,848 INFO spawned: 'deluge-web-script' with pid 140
2018-09-18 12:00:55,850 INFO spawned: 'privoxy-script' with pid 141
2018-09-18 12:00:55,851 INFO reaped unknown pid 9
2018-09-18 12:00:55,856 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN
2018-09-18 12:00:55,857 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-09-18 12:00:55,857 INFO success: deluge-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-09-18 12:00:55,857 INFO success: deluge-web-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-09-18 12:00:55,857 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-09-18 12:00:55,857 DEBG 'start-script' stdout output:
[debug] Environment variables defined as follows
2018-09-18 12:00:55,857 DEBG 'start-script' stdout output:
BASH=/bin/bash
2018-09-18 12:00:55,857 DEBG 'deluge-script' stdout output:
[info] Deluge config file already exists, skipping copy
2018-09-18 12:00:55,857 DEBG 'start-script' stdout output:
BASHOPTS=cmdhist:complete_fullquote:extquote:force_fignore:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath
2018-09-18 12:00:55,857 DEBG 'start-script' stdout output:
BASH_ALIASES=()
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_ARGC=()
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_ARGV=()
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_CMDS=()
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_LINENO=([0]="0")
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_SOURCE=([0]="/root/start.sh")
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_VERSINFO=([0]="4" [1]="4" [2]="23" [3]="1" [4]="release" [5]="x86_64-unknown-linux-gnu")
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
BASH_VERSION='4.4.23(1)-release'
2018-09-18 12:00:55,858 DEBG 'deluge-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid
2018-09-18 12:00:55,858 DEBG 'start-script' stdout output:
DEBUG=true
2018-09-18 12:00:55,859 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:00:55,859 DEBG 'start-script' stdout output:
DIRSTACK=()
2018-09-18 12:00:55,859 DEBG 'start-script' stdout output:
ENABLE_PRIVOXY=yes
2018-09-18 12:00:55,859 DEBG 'start-script' stdout output:
EUID=0
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
GROUPS=()
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
HOME=/home/nobody
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
HOSTNAME=5bc7a01b56e1
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
HOSTTYPE=x86_64
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
IFS=$' \t\n'
2018-09-18 12:00:55,860 DEBG 'start-script' stdout output:
LANG=en_GB.UTF-8
2018-09-18 12:00:55,861 DEBG 'start-script' stdout output:
LAN_NETWORK=192.168.1.0/24
2018-09-18 12:00:55,861 DEBG 'start-script' stdout output:
MACHTYPE=x86_64-unknown-linux-gnu
2018-09-18 12:00:55,861 DEBG 'start-script' stdout output:
NAME_SERVERS=8.8.8.8,37.235.1.174,8.8.4.4,37.235.1.177
2018-09-18 12:00:55,861 DEBG 'start-script' stdout output:
OPTERR=1
2018-09-18 12:00:55,861 DEBG 'start-script' stdout output:
OPTIND=1
2018-09-18 12:00:55,862 DEBG 'start-script' stdout output:
OSTYPE=linux-gnu
2018-09-18 12:00:55,862 DEBG 'start-script' stdout output:
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2018-09-18 12:00:55,862 DEBG 'start-script' stdout output:
PGID=1000
2018-09-18 12:00:55,862 DEBG 'start-script' stdout output:
PIPESTATUS=([0]="0")
2018-09-18 12:00:55,862 DEBG 'privoxy-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
PPID=8
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
PS4='+ '
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
PUID=1000
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
PWD=/
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
SHELL=/bin/bash
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
SHELLOPTS=braceexpand:hashall:interactive-comments
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
SHLVL=1
2018-09-18 12:00:55,863 DEBG 'start-script' stdout output:
STRICT_PORT_FORWARD=no
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
SUPERVISOR_ENABLED=1
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
SUPERVISOR_GROUP_NAME=start-script
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
SUPERVISOR_PROCESS_NAME=start-script
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
TERM=xterm
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
UID=0
UMASK=2
VPN_CONFIG=/config/openvpn/default.ovpn
VPN_DEVICE_TYPE=tun0
VPN_ENABLED=yes
VPN_OPTIONS=
VPN_PASS=*******
VPN_PORT=443
VPN_PROTOCOL=udp
VPN_PROV=custom
VPN_REMOTE=us-mn2-smart.serverlocation.co
VPN_USER=*******
_='[debug] Environment variables defined as follows'
2018-09-18 12:00:55,864 DEBG 'start-script' stdout output:
[debug] Directory listing of files in /config/openvpn as follows
2018-09-18 12:00:55,867 DEBG 'start-script' stdout output:
total 24
drwxrwsr-x 2 nobody users 4096 Sep 18 12:00 .
drwxrwsr-x 8 nobody users 4096 Sep 18 12:00 ..
-rwxrwxr-x 1 nobody users 20 Sep 18 11:40 credentials.conf
-rwxrwxr-x 1 nobody users 280 Sep 18 12:00 default.ovpn
-rwxrwxr-x 1 nobody users 20 Sep 18 09:45 login.txt
-rwxrwxr-x 1 nobody users 1870 Sep 18 09:46 serverlocation.crt
2018-09-18 12:00:55,872 DEBG 'start-script' stdout output:
[warn] Username contains characters which could cause authentication issues, please consider changing this if possible
2018-09-18 12:00:55,899 DEBG 'start-script' stdout output:
[debug] Contents of ovpn file /config/openvpn/default.ovpn as follows...
2018-09-18 12:00:55,900 DEBG 'start-script' stdout output:
remote us-mn2-smart.serverlocation.co 443
client
dev tun
proto udp
resolv-retry infinite
nobind
persist-key
auth sha1
tls-client
remote-cert-tls server
auth-user-pass credentials.conf
auth-nocache
comp-lzo
verb 1
ca ./serverlocation.crt
disable-occ
script-security 2
route-noexec
2018-09-18 12:00:55,914 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1
2018-09-18 12:00:55,918 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf
2018-09-18 12:00:55,922 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf
2018-09-18 12:00:55,926 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf
2018-09-18 12:00:55,931 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf
2018-09-18 12:00:55,997 DEBG 'start-script' stdout output:
[info] Remote VPN endpoint resolves to the following A record(s)...
46.36.201.41
2018-09-18 12:00:56,017 DEBG 'start-script' stdout output:
[debug] Show name servers defined for container
2018-09-18 12:00:56,018 DEBG 'start-script' stdout output:
nameserver 8.8.8.8
nameserver 37.235.1.174
nameserver 8.8.4.4
nameserver 37.235.1.177
2018-09-18 12:00:56,018 DEBG 'start-script' stdout output:
[debug] Show name resolution for VPN endpoint us-mn2-smart.serverlocation.co
2018-09-18 12:00:56,067 DEBG 'start-script' stdout output:
;; ->>HEADER<<- opcode: QUERY, rcode: NOERROR, id: 14068
;; flags: qr rd ra ; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 0
;; QUESTION SECTION:
;; us-mn2-smart.serverlocation.co. IN A
;; ANSWER SECTION:
us-mn2-smart.serverlocation.co. 59 IN A 46.36.201.41
;; AUTHORITY SECTION:
;; ADDITIONAL SECTION:
;; Query time: 47 msec
;; SERVER: 8.8.8.8
;; WHEN: Tue Sep 18 12:00:56 2018
;; MSG SIZE rcvd: 64
2018-09-18 12:00:56,068 DEBG 'start-script' stdout output:
[debug] Show contents of hosts file
2018-09-18 12:00:56,068 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
172.17.0.2 5bc7a01b56e1
46.36.201.41 us-mn2-smart.serverlocation.co
2018-09-18 12:00:56,074 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0
2018-09-18 12:00:56,076 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------
2018-09-18 12:00:56,078 DEBG 'start-script' stdout output:
default via 172.17.0.1 dev eth0
172.17.0.0/16 dev eth0 proto kernel scope link src 172.17.0.2
192.168.1.0/24 via 172.17.0.1 dev eth0
2018-09-18 12:00:56,078 DEBG 'start-script' stdout output:
--------------------
2018-09-18 12:00:56,078 DEBG 'start-script' stdout output:
[debug] Modules currently loaded for kernel
2018-09-18 12:00:56,082 DEBG 'start-script' stdout output:
Module Size Used by
xt_mark 16384 0
iptable_mangle 16384 0
tun 49152 0
xt_nat 16384 0
veth 16384 0
softdog 16384 0
nf_conntrack_netlink 49152 0
nfnetlink 16384 2 nf_conntrack_netlink
xfrm_user 45056 1
xfrm_algo 16384 1 xfrm_user
xt_conntrack 16384 1
br_netfilter 24576 0
bridge 184320 1 br_netfilter
stp 16384 1 bridge
llc 16384 2 bridge,stp
overlay 110592 1
xt_tcpudp 16384 4
ip6table_filter 16384 0
ip6_tables 32768 1 ip6table_filter
xt_owner 16384 0
iptable_filter 16384 1
ipt_MASQUERADE 16384 1
nf_nat_masquerade_ipv4 16384 1 ipt_MASQUERADE
xt_addrtype 16384 1
iptable_nat 16384 1
nf_conntrack_ipv4 16384 3
nf_defrag_ipv4 16384 1 nf_conntrack_ipv4
nf_nat_ipv4 16384 1 iptable_nat
cpufreq_powersave 16384 0
cpufreq_conservative 16384 0
nf_nat 36864 3 nf_nat_masquerade_ipv4,nf_nat_ipv4,xt_nat
cpufreq_userspace 16384 0
nf_conntrack 155648 8 xt_conntrack,nf_nat_masquerade_ipv4,nf_conntrack_ipv4,nf_nat,ipt_MASQUERADE,nf_nat_ipv4,xt_nat,nf_conntrack_netlink
intel_rapl 24576 0
x86_pkg_temp_thermal 16384 0
intel_powerclamp 16384 0
coretemp 16384 0
kvm 729088 0
irqbypass 16384 1 kvm
iTCO_wdt 16384 1
iTCO_vendor_support 16384 1 iTCO_wdt
crct10dif_pclmul 16384 0
crc32_pclmul 16384 0
ghash_clmulni_intel 16384 0
intel_cstate 16384 0
intel_uncore 131072 0
intel_rapl_perf 16384 0
joydev 24576 0
serio_raw 16384 0
evdev 28672 9
pcspkr 16384 0
snd_hda_codec_hdmi 57344 1
lpc_ich 28672 0
snd_hda_intel 45056 0
i915 1703936 2
snd_hda_codec 151552 2 snd_hda_codec_hdmi,snd_hda_intel
sg 36864 0
snd_hda_core 94208 3 snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec
snd_hwdep 20480 1 snd_hda_codec
video 45056 1 i915
snd_pcm 118784 4 snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec,snd_hda_core
snd_timer 36864 1 snd_pcm
drm_kms_helper 196608 1 i915
mei_me 45056 0
snd 94208 6 snd_hda_codec_hdmi,snd_hwdep,snd_hda_intel,snd_hda_codec,snd_timer,snd_pcm
mei 110592 1 mei_me
drm 462848 3 drm_kms_helper,i915
shpchp 40960 0
pcc_cpufreq 16384 0
button 16384 1 i915
soundcore 16384 1 snd
ie31200_edac 16384 0
fuse 118784 3
sunrpc 421888 1
ip_tables 28672 3 iptable_filter,iptable_nat,iptable_mangle
x_tables 49152 12 ip6table_filter,xt_conntrack,iptable_filter,xt_tcpudp,ipt_MASQUERADE,xt_addrtype,xt_nat,xt_owner,ip6_tables,ip_tables,iptable_mangle,xt_mark
autofs4 49152 2
ext4 741376 12
crc16 16384 1 ext4
mbcache 16384 1 ext4
jbd2 118784 1 ext4
fscrypto 32768 1 ext4
ecb 16384 0
btrfs 1372160 0
zstd_decompress 90112 1 btrfs
zstd_compress 180224 1 btrfs
xxhash 16384 2 zstd_compress,zstd_decompress
raid10 57344 0
raid456 172032 0
async_raid6_recov 20480 1 raid456
async_memcpy 16384 2 raid456,async_raid6_recov
async_pq 16384 2 raid456,async_raid6_recov
async_xor 16384 3 async_pq,raid456,async_raid6_recov
async_tx 16384 5 async_pq,async_memcpy,async_xor,raid456,async_raid6_recov
xor 24576 2 async_xor,btrfs
raid6_pq
2018-09-18 12:00:56,083 DEBG 'start-script' stdout output:
122880 4 async_pq,btrfs,raid456,async_raid6_recov
libcrc32c 16384 4 nf_conntrack,nf_nat,btrfs,raid456
crc32c_generic 16384 0
raid1 45056 0
raid0 20480 0
multipath 16384 0
linear 16384 0
md_mod 159744 6 raid1,raid10,raid0,linear,raid456,multipath
hid_generic 16384 0
usbhid 57344 0
hid 135168 2 usbhid,hid_generic
uas 28672 0
usb_storage 69632 1 uas
sd_mod 53248 25
crc32c_intel 24576 25
aesni_intel 200704 0
xhci_pci 16384 0
ehci_pci 16384 0
xhci_hcd 262144 1 xhci_pci
ehci_hcd 94208 1 ehci_pci
ahci 40960 13
libahci 40960 1 ahci
aes_x86_64 20480 1 aesni_intel
crypto_simd 16384 1 aesni_intel
cryptd 28672 3 crypto_simd,ghash_clmulni_intel,aesni_intel
glue_helper 16384 1 aesni_intel
psmouse 172032 0
usbcore 290816 7 xhci_hcd,ehci_pci,usbhid,usb_storage,ehci_hcd,xhci_pci,uas
libata 278528 2 libahci,ahci
i2c_i801 28672 0
scsi_mod 253952 5 sd_mod,usb_storage,uas,libata,sg
usb_common 16384 1 usbcore
igb 249856 0
e1000e 282624 0
i2c_algo_bit 16384 2 igb,i915
dca 16384 1 igb
2018-09-18 12:00:56,087 DEBG 'start-script' stdout output:
iptable_mangle 16384 0
ip_tables 28672 3 iptable_filter,iptable_nat,iptable_mangle
x_tables 49152 12 ip6table_filter,xt_conntrack,iptable_filter,xt_tcpudp,ipt_MASQUERADE,xt_addrtype,xt_nat,xt_owner,ip6_tables,ip_tables,iptable_mangle,xt_mark
2018-09-18 12:00:56,087 DEBG 'start-script' stdout output:
[info] iptable_mangle support detected, adding fwmark for tables
2018-09-18 12:00:56,170 DEBG 'start-script' stdout output:
[debug] Docker interface defined as eth0
2018-09-18 12:00:56,175 DEBG 'start-script' stdout output:
[debug] Docker IP defined as 172.17.0.2
2018-09-18 12:00:56,180 DEBG 'start-script' stdout output:
[debug] Docker netmask defined as 255.255.0.0
2018-09-18 12:00:56,189 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16
2018-09-18 12:00:56,251 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------
2018-09-18 12:00:56,253 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD ACCEPT
-P OUTPUT DROP
-A INPUT -i tun0 -j ACCEPT
-A INPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -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 192.168.1.0/24 -i eth0 -p tcp -m tcp --dport 58846 -j ACCEPT
-A INPUT -s 192.168.1.0/24 -d 172.17.0.0/16 -i eth0 -p tcp -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 172.17.0.0/16 -d 172.17.0.0/16 -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 192.168.1.0/24 -o eth0 -p tcp -m tcp --sport 58846 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 192.168.1.0/24 -o eth0 -p tcp -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT
2018-09-18 12:00:56,254 DEBG 'start-script' stdout output:
--------------------
2018-09-18 12:00:56,255 DEBG 'start-script' stdout output:
[debug] OpenVPN command line:- /usr/bin/openvpn --daemon --reneg-sec 0 --mute-replay-warnings --auth-nocache --setenv VPN_PROV 'custom' --setenv DEBUG 'true' --setenv VPN_DEVICE_TYPE 'tun0' --setenv VPN_REMOTE 'us-mn2-smart.serverlocation.co' --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' --remote 46.36.201.41 443 udp --remote-random --keepalive 10 60 --auth-user-pass credentials.conf --cd /config/openvpn --config '/config/openvpn/default.ovpn'
[info] Starting OpenVPN...
2018-09-18 12:00:56,264 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:56 2018 WARNING: file 'credentials.conf' is group or others accessible
Tue Sep 18 12:00:56 2018 OpenVPN 2.4.6 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Apr 24 2018
Tue Sep 18 12:00:56 2018 library versions: OpenSSL 1.1.0h 27 Mar 2018, LZO 2.10
2018-09-18 12:00:56,265 DEBG 'start-script' stdout output:
[info] OpenVPN started
2018-09-18 12:00:56,265 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
Tue Sep 18 12:00:56 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
2018-09-18 12:00:56,266 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:56 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]46.36.201.41:443
Tue Sep 18 12:00:56 2018 UDP link local: (not bound)
2018-09-18 12:00:56,266 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:56 2018 UDP link remote: [AF_INET]46.36.201.41:443
2018-09-18 12:00:57,776 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:57 2018 [*.serverlocation.co] Peer Connection Initiated with [AF_INET]46.36.201.41:443
2018-09-18 12:00:59,036 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 WARNING: INSECURE cipher with block size less than 128 bit (64 bit). This allows attacks like SWEET32. Mitigate by using a --cipher with a larger block size (e.g. AES-256-CBC).
Tue Sep 18 12:00:59 2018 WARNING: INSECURE cipher with block size less than 128 bit (64 bit). This allows attacks like SWEET32. Mitigate by using a --cipher with a larger block size (e.g. AES-256-CBC).
Tue Sep 18 12:00:59 2018 WARNING: cipher with small block size in use, reducing reneg-bytes to 64MB to mitigate SWEET32 attacks.
2018-09-18 12:00:59,036 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 TUN/TAP device tun0 opened
2018-09-18 12:00:59,036 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Tue Sep 18 12:00:59 2018 /usr/bin/ip link set dev tun0 up mtu 1500
2018-09-18 12:00:59,038 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 /usr/bin/ip addr add dev tun0 10.4.0.5/24 broadcast 10.4.0.255
2018-09-18 12:00:59,039 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 /root/openvpnup.sh tun0 1500 1542 10.4.0.5 255.255.255.0 init
2018-09-18 12:00:59,042 DEBG 'start-script' stdout output:
Tue Sep 18 12:00:59 2018 Initialization Sequence Completed
2018-09-18 12:00:59,044 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:00:59,044 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:00:59,143 DEBG 'privoxy-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
[info] Configuring Privoxy...
2018-09-18 12:00:59,145 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:00:59,146 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:00:59,149 DEBG 'deluge-script' stdout output:
[info] Deluge not running
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.4.0.5 different, marking for reconfigure
[info] Attempting to start Deluge...
2018-09-18 12:00:59,159 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
[debug] VPN provider custom is != pia, skipping incoming port detection
2018-09-18 12:00:59,161 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:00:59,161 DEBG 'start-script' stdout output:
[debug] Attempting to get external IP using Name Server 'ns1.google.com'...
2018-09-18 12:00:59,167 DEBG 'privoxy-script' stdout output:
[info] All checks complete, starting Privoxy...
2018-09-18 12:00:59,167 DEBG 'privoxy-script' stderr output:
2018-09-18 12:00:59.167 7f16092f70c0 Info: Privoxy version 3.0.26
2018-09-18 12:00:59.167 7f16092f70c0 Info: Program name: /usr/bin/privoxy
2018-09-18 12:00:59,173 DEBG 'start-script' stdout output:
[debug] Failed to get external IP using Name Server 'ns1.google.com', trying 'resolver1.opendns.com'...
2018-09-18 12:00:59,184 DEBG 'start-script' stdout output:
[debug] Failed to get external IP using Name Server 'resolver1.opendns.com', trying 'http://checkip.amazonaws.com'...
2018-09-18 12:00:59,192 DEBG 'start-script' stdout output:
[debug] Failed to get external IP using Web Server 'http://checkip.amazonaws.com', trying 'http://whatismyip.akamai.com'...
2018-09-18 12:00:59,199 DEBG 'start-script' stdout output:
[debug] Failed to get external IP using Web Server 'http://whatismyip.akamai.com', trying 'https://showextip.azurewebsites.net'...
2018-09-18 12:00:59,207 DEBG 'start-script' stdout output:
[debug] Failed to get external IP using Web Server 'https://showextip.azurewebsites.net'
[warn] Cannot determine external IP address, exhausted retries setting to tunnel IP '10.4.0.5'
2018-09-18 12:00:59,321 DEBG 'deluge-script' stdout output:
[info] Deluge listening interface currently defined as 10.4.0.5
[info] Deluge listening interface will be changed to 10.4.0.5
[info] Saving changes to Deluge config file /config/core.conf...
2018-09-18 12:00:59,516 DEBG 'deluge-script' stdout output:
[info] Deluge started
2018-09-18 12:00:59,907 DEBG 'deluge-web-script' stdout output:
[info] Starting Deluge webui...
2018-09-18 12:00:59,976 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:01:29,977 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:01:30,108 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:01:30,112 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:02:00,113 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:02:00,245 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:02:00,248 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:02:30,250 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:02:30,382 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:02:30,385 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:03:00,387 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:03:00,519 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:03:00,524 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:03:30,526 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:03:30,657 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:03:30,663 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:04:00,664 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:04:00,796 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:04:00,801 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:04:30,803 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:04:30,935 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:04:30,938 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:05:00,939 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:05:01,071 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:05:01,075 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:05:31,076 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:05:31,208 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:05:31,214 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:06:01,215 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:06:01,343 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:06:01,349 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:06:31,351 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...
2018-09-18 12:06:31,481 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.4.0.5'
2018-09-18 12:06:31,484 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is
[debug] VPN IP is 10.4.0.5
[debug] Deluge incoming port is
[debug] Deluge IP is 10.4.0.5
2018-09-18 12:06:45,631 WARN received SIGTERM indicating exit request
2018-09-18 12:06:45,631 DEBG killing privoxy-script (pid 141) with signal SIGTERM
2018-09-18 12:06:45,631 INFO waiting for start-script, deluge-script, deluge-web-script, privoxy-script to die
2018-09-18 12:06:45,631 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 140512519524504 for <Subprocess at 140512519512008 with name privoxy-script in state STOPPING> (stderr)>
2018-09-18 12:06:45,632 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 140512519525872 for <Subprocess at 140512519512008 with name privoxy-script in state STOPPING> (stdout)>
2018-09-18 12:06:45,632 INFO stopped: privoxy-script (terminated by SIGTERM)
2018-09-18 12:06:45,632 DEBG received SIGCLD indicating a child quit
2018-09-18 12:06:45,632 DEBG killing deluge-web-script (pid 140) with signal SIGTERM
2018-09-18 12:06:45,632 DEBG fd 17 closed, stopped monitoring <POutputDispatcher at 140512519526376 for <Subprocess at 140512519140776 with name deluge-web-script in state STOPPING> (stdout)>
2018-09-18 12:06:45,632 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 140512519526088 for <Subprocess at 140512519140776 with name deluge-web-script in state STOPPING> (stderr)>
2018-09-18 12:06:45,632 INFO stopped: deluge-web-script (terminated by SIGTERM)
2018-09-18 12:06:45,632 DEBG received SIGCLD indicating a child quit
2018-09-18 12:06:45,633 DEBG killing deluge-script (pid 139) with signal SIGTERM
2018-09-18 12:06:45,633 DEBG fd 16 closed, stopped monitoring <POutputDispatcher at 140512519527024 for <Subprocess at 140512519140272 with name deluge-script in state STOPPING> (stderr)>
2018-09-18 12:06:45,633 DEBG fd 11 closed, stopped monitoring <POutputDispatcher at 140512519526880 for <Subprocess at 140512519140272 with name deluge-script in state STOPPING> (stdout)>
2018-09-18 12:06:45,633 INFO stopped: deluge-script (terminated by SIGTERM)
2018-09-18 12:06:45,633 DEBG received SIGCLD indicating a child quit
2018-09-18 12:06:45,633 DEBG killing start-script (pid 138) with signal SIGTERM
2018-09-18 12:06:45,634 DEBG fd 8 closed, stopped monitoring <POutputDispatcher at 140512519508696 for <Subprocess at 140512519508768 with name start-script in state STOPPING> (stdout)>
2018-09-18 12:06:45,634 DEBG fd 10 closed, stopped monitoring <POutputDispatcher at 140512519508120 for <Subprocess at 140512519508768 with name start-script in state STOPPING> (stderr)>
2018-09-18 12:06:45,634 INFO stopped: start-script (terminated by SIGTERM)
2018-09-18 12:06:45,634 DEBG received SIGCLD indicating a child quit