[Support] binhex - DelugeVPN


Recommended Posts

I am having issues with my webui showing when the vpn is enabled. I haven't changed anything recently. Saw Unraid had an update so I went ahead and ran that last night. Still didnt work after update. Turned the vpn option off and was able to see the webui so I'm assuming the issue is with my VPN. Any help would be greatly appreciated!

2018-04-03 11:11:04.564050 [info] Host is running unRAID
2018-04-03 11:11:04.582340 [info] System information Linux 4a88acb1da9a 4.14.26-unRAID #1 SMP PREEMPT Mon Mar 12 16:21:20 PDT 2018 x86_64 GNU/Linux
2018-04-03 11:11:04.602878 [info] PUID defined as '99'
2018-04-03 11:11:04.624285 [info] PGID defined as '100'
2018-04-03 11:11:04.779663 [info] UMASK defined as '000'
2018-04-03 11:11:04.799161 [info] Permissions already set for volume mappings
2018-04-03 11:11:04.821876 [info] VPN_ENABLED defined as 'yes'
2018-04-03 11:11:04.845359 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/Netherlands.ovpn
dos2unix: converting file /config/openvpn/Netherlands.ovpn to Unix format...
2018-04-03 11:11:04.873593 [info] VPN remote line defined as 'remote nl.privateinternetaccess.com 1198'
2018-04-03 11:11:04.893382 [info] VPN_REMOTE defined as 'nl.privateinternetaccess.com'
2018-04-03 11:11:04.913192 [info] VPN_PORT defined as '1198'
2018-04-03 11:11:04.934984 [info] VPN_PROTOCOL defined as 'udp'
2018-04-03 11:11:04.955152 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-04-03 11:11:04.974685 [info] VPN_PROV defined as 'pia'
2018-04-03 11:11:04.994498 [info] LAN_NETWORK defined as '192.168.1.0/24'
2018-04-03 11:11:05.014138 [info] NAME_SERVERS defined as '209.222.18.222,37.235.1.174,8.8.8.8,209.222.18.218,37.235.1.177,8.8.4.4'
2018-04-03 11:11:05.034093 [info] VPN_USER defined as 'XXXXXXXXXXX'
2018-04-03 11:11:05.054899 [info] VPN_PASS defined as 'XXXXXXXXXXX'
2018-04-03 11:11:05.074880 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-04-03 11:11:05.094683 [info] STRICT_PORT_FORWARD defined as 'yes'
2018-04-03 11:11:05.116100 [info] ENABLE_PRIVOXY defined as 'no'
2018-04-03 11:11:05.136544 [info] Starting Supervisor...
2018-04-03 11:11:05,254 CRIT Set uid to user 0
2018-04-03 11:11:05,254 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing
2018-04-03 11:11:05,256 INFO supervisord started with pid 7
2018-04-03 11:11:06,258 INFO spawned: 'start-script' with pid 137
2018-04-03 11:11:06,259 INFO spawned: 'deluge-script' with pid 138
2018-04-03 11:11:06,259 INFO spawned: 'deluge-web-script' with pid 139
2018-04-03 11:11:06,260 INFO spawned: 'privoxy-script' with pid 140
2018-04-03 11:11:06,260 INFO reaped unknown pid 8
2018-04-03 11:11:06,263 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN

2018-04-03 11:11:06,263 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 11:11:06,263 INFO success: deluge-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 11:11:06,263 INFO success: deluge-web-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 11:11:06,263 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 11:11:06,263 DEBG 'deluge-script' stdout output:
[info] Deluge config file already exists, skipping copy

2018-04-03 11:11:06,264 DEBG 'deluge-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid

2018-04-03 11:11:06,265 DEBG 'privoxy-script' stdout output:
[info] Privoxy set to disabled

2018-04-03 11:11:06,265 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 23232860817960 for <Subprocess at 23232860815872 with name privoxy-script in state RUNNING> (stdout)>
2018-04-03 11:11:06,265 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 23232860818392 for <Subprocess at 23232860815872 with name privoxy-script in state RUNNING> (stderr)>
2018-04-03 11:11:06,265 INFO exited: privoxy-script (exit status 0; expected)
2018-04-03 11:11:06,265 DEBG received SIGCLD indicating a child quit
2018-04-03 11:11:06,270 DEBG 'start-script' stdout output:
[warn] Password contains characters which could cause authentication issues, please consider changing this if possible

2018-04-03 11:11:06,291 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1

2018-04-03 11:11:06,294 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.222 to /etc/resolv.conf

2018-04-03 11:11:06,296 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf

2018-04-03 11:11:06,298 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf

2018-04-03 11:11:06,300 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf

2018-04-03 11:11:06,303 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf

2018-04-03 11:11:06,305 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf

2018-04-03 11:11:07,464 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2018-04-03 11:11:07,465 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.14.26-unRAID

2018-04-03 11:11:07,465 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2018-04-03 11:11:07,465 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory


2018-04-03 11:11:07,466 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'

2018-04-03 11:11:07,468 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0

2018-04-03 11:11:07,469 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-04-03 11:11:07,469 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-04-03 11:11:07,469 DEBG 'start-script' stdout output:
--------------------

2018-04-03 11:11:07,483 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16

2018-04-03 11:11:07,547 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-04-03 11:11:07,548 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 1198 -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 -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 1198 -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 -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT

2018-04-03 11:11:07,548 DEBG 'start-script' stdout output:
--------------------

2018-04-03 11:11:07,549 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2018-04-03 11:11:07,560 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:07 2018 WARNING: file 'credentials.conf' is group or others accessible

Tue Apr 3 11:11:07 2018 OpenVPN 2.4.4 x86_64-unknown-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Sep 26 2017
Tue Apr 3 11:11:07 2018 library versions: OpenSSL 1.1.0f 25 May 2017, LZO 2.10

2018-04-03 11:11:07,561 DEBG 'start-script' stdout output:
[info] OpenVPN started
Tue Apr 3 11:11:07 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2018-04-03 11:11:07,561 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:07 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]46.166.190.130:1198
Tue Apr 3 11:11:07 2018 UDP link local: (not bound)
Tue Apr 3 11:11:07 2018 UDP link remote: [AF_INET]46.166.190.130:1198

2018-04-03 11:11:07,992 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:07 2018 [ad15b11d033d980d338dc57300133aaf] Peer Connection Initiated with [AF_INET]46.166.190.130:1198

2018-04-03 11:11:09,159 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 auth-token received, disabling auth-nocache for the authentication token

2018-04-03 11:11:09,159 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 TUN/TAP device tun0 opened
Tue Apr 3 11:11:09 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0

2018-04-03 11:11:09,159 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-04-03 11:11:09,160 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 /usr/bin/ip addr add dev tun0 local 10.6.10.6 peer 10.6.10.5

2018-04-03 11:11:09,161 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 /root/openvpnup.sh tun0 1500 1558 10.6.10.6 10.6.10.5 init

2018-04-03 11:11:09,165 DEBG 'start-script' stdout output:
Tue Apr 3 11:11:09 2018 Initialization Sequence Completed

2018-04-03 11:11:09,265 DEBG 'deluge-script' stdout output:
[info] Deluge not running
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.6.10.6 different, marking for reconfigure

2018-04-03 11:11:09,275 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=1720bee85fe892b2828fb4f1e572b73d516b9fd3226ec1c9bef9b535f671d75c...

2018-04-03 11:11:09,383 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 12 retries left
[info] Retrying in 10 secs...

2018-04-03 11:11:09,491 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 212.92.112.31

2018-04-03 11:11:19,490 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 11 retries left
[info] Retrying in 10 secs...

2018-04-03 11:11:29,596 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 10 retries left
[info] Retrying in 10 secs...

2018-04-03 11:11:39,703 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 9 retries left
[info] Retrying in 10 secs...

2018-04-03 11:11:49,809 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 8 retries left
[info] Retrying in 10 secs...

2018-04-03 11:11:59,915 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 7 retries left
[info] Retrying in 10 secs...

2018-04-03 11:12:10,022 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 6 retries left
[info] Retrying in 10 secs...

2018-04-03 11:12:20,129 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 5 retries left
[info] Retrying in 10 secs...

2018-04-03 11:12:30,235 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 4 retries left
[info] Retrying in 10 secs...

2018-04-03 11:12:40,343 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 3 retries left
[info] Retrying in 10 secs...

2018-04-03 11:12:50,448 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 2 retries left
[info] Retrying in 10 secs...

2018-04-03 11:13:00,556 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 1 retries left
[info] Retrying in 10 secs...

2018-04-03 11:13:10,661 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx, exausted retries exiting script...

2018-04-03 11:13:10,662 DEBG 'start-script' stdout output:
[warn] PIA API currently down, terminating OpenVPN process to force retry for incoming port...

2018-04-03 11:13:10,662 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:10 2018 event_wait : Interrupted system call (code=4)

2018-04-03 11:13:10,665 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:10 2018 /usr/bin/ip addr del dev tun0 local 10.6.10.6 peer 10.6.10.5

2018-04-03 11:13:10,679 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:10 2018 SIGINT[hard,] received, process exiting

2018-04-03 11:13:39,191 DEBG 'start-script' stdout output:
[warn] OpenVPN process terminated, restarting OpenVPN...

2018-04-03 11:13:39,196 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:39 2018 WARNING: file 'credentials.conf' is group or others accessible

Tue Apr 3 11:13:39 2018 OpenVPN 2.4.4 x86_64-unknown-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Sep 26 2017
Tue Apr 3 11:13:39 2018 library versions: OpenSSL 1.1.0f 25 May 2017, LZO 2.10

2018-04-03 11:13:39,196 DEBG 'start-script' stdout output:
[info] OpenVPN restarted

2018-04-03 11:13:39,196 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:39 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2018-04-03 11:13:39,196 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:39 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]46.166.190.130:1198
Tue Apr 3 11:13:39 2018 UDP link local: (not bound)
Tue Apr 3 11:13:39 2018 UDP link remote: [AF_INET]46.166.190.130:1198

2018-04-03 11:13:39,625 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:39 2018 [ad15b11d033d980d338dc57300133aaf] Peer Connection Initiated with [AF_INET]46.166.190.130:1198

2018-04-03 11:13:40,776 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 auth-token received, disabling auth-nocache for the authentication token

2018-04-03 11:13:40,777 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 TUN/TAP device tun0 opened

2018-04-03 11:13:40,777 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Tue Apr 3 11:13:40 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-04-03 11:13:40,778 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 /usr/bin/ip addr add dev tun0 local 10.39.10.6 peer 10.39.10.5

2018-04-03 11:13:40,778 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 /root/openvpnup.sh tun0 1500 1558 10.39.10.6 10.39.10.5 init

2018-04-03 11:13:40,783 DEBG 'start-script' stdout output:
Tue Apr 3 11:13:40 2018 Initialization Sequence Completed

2018-04-03 11:13:40,893 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=642ceaa87a83370d6fa0e6f16a8d184dd36246e1173868c58c15685eb2e75ded...

2018-04-03 11:13:40,998 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 12 retries left
[info] Retrying in 10 secs...

2018-04-03 11:13:41,110 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 212.92.112.31

2018-04-03 11:13:51,106 DEBG 'start-script' stdout output:
[warn] Response code 000 from curl != 2xx
[warn] Exit code 7 from curl != 0
[info] 11 retries left
[info] Retrying in 10 secs...

 

Link to comment

I've tried changing enpoints and corresponding config file to Toronto, German, and France and am still not able to open deluge. Radarr/Sonarr are able to access deluge now and torrents download but I just can't open webui with vpn enabled. I was getting this before debug:

[warn] Response code 000 from curl != 2xx
[warn] Exit code 56 from curl != 0
[info] 12 retries left
[info] Retrying in 10 secs...

Debug log:

2018-04-03 16:09:03.861614 [info] System information Linux 82f9b9b19f12 4.13.0-37-generic #42~16.04.1-Ubuntu SMP Wed Mar 7 16:03:28 UTC 2018 x86_64 GNU/Linux
2018-04-03 16:09:03.897392 [info] PUID defined as '1000'
2018-04-03 16:09:03.962075 [info] PGID defined as '1000'
2018-04-03 16:09:04.032581 [warn] UMASK not defined (via -e UMASK), defaulting to '000'
2018-04-03 16:09:04.068553 [info] Permissions already set for volume mappings
2018-04-03 16:09:04.107788 [info] VPN_ENABLED defined as 'yes'
2018-04-03 16:09:04.141660 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/CA Toronto.ovpn
dos2unix: converting file /config/openvpn/CA Toronto.ovpn to Unix format...
2018-04-03 16:09:04.177436 [info] VPN remote line defined as 'remote ca-toronto.privateinternetaccess.com 1198'
2018-04-03 16:09:04.204720 [info] VPN_REMOTE defined as 'ca-toronto.privateinternetaccess.com'
2018-04-03 16:09:04.229366 [info] VPN_PORT defined as '1198'
2018-04-03 16:09:04.265196 [info] VPN_PROTOCOL defined as 'udp'
2018-04-03 16:09:04.293301 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-04-03 16:09:04.316554 [info] VPN_PROV defined as 'pia'
2018-04-03 16:09:04.339791 [info] LAN_NETWORK defined as '192.168.86.100/24'
2018-04-03 16:09:04.364100 [info] NAME_SERVERS defined as '209.222.18.222,37.235.1.174,8.8.8.8,209.222.18.218,37.235.1.177,8.8.4.4'
2018-04-03 16:09:04.387075 [info] VPN_USER defined as '***'
2018-04-03 16:09:04.408779 [info] VPN_PASS defined as '***'
2018-04-03 16:09:04.433940 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-04-03 16:09:04.457877 [info] STRICT_PORT_FORWARD defined as 'yes'
2018-04-03 16:09:04.483368 [info] ENABLE_PRIVOXY defined as 'yes'
2018-04-03 16:09:04.829547 [info] Starting Supervisor...
2018-04-03 16:09:04,953 CRIT Set uid to user 0
2018-04-03 16:09:04,953 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing
2018-04-03 16:09:04,955 INFO supervisord started with pid 9
2018-04-03 16:09:05,957 INFO spawned: 'start-script' with pid 141
2018-04-03 16:09:05,959 INFO spawned: 'deluge-script' with pid 142
2018-04-03 16:09:05,960 INFO spawned: 'deluge-web-script' with pid 143
2018-04-03 16:09:05,962 INFO spawned: 'privoxy-script' with pid 144
2018-04-03 16:09:05,972 INFO reaped unknown pid 10
2018-04-03 16:09:05,972 DEBG 'deluge-script' stdout output:
[info] Deluge config file already exists, skipping copy

2018-04-03 16:09:05,972 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 16:09:05,973 INFO success: deluge-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 16:09:05,973 INFO success: deluge-web-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 16:09:05,973 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-04-03 16:09:05,973 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=()
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=yes
EUID=0
GROUPS=()
HOME=/home/nobody
HOSTNAME=82f9b9b19f12
HOSTTYPE=x86_64
IFS=$' \t\n'
LANG=en_GB.UTF-8
LAN_NETWORK=192.168.86.100/24
MACHTYPE=x86_64-unknown-linux-gnu
NAME_SERVERS=209.222.18.222,37.235.1.174,8.8.8.8,209.222.18.218,37.235.1.177,8.8.4.4
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=9
PS4='+ '
PUID=1000
PWD=/
SHELL=/bin/bash
SHELLOPTS=braceexpand:hashall:interactive-comments
SHLVL=1
STRICT_PORT_FORWARD=yes
STRONG_CERTS=no
SUPERVISOR_ENABLED=1
SUPERVISOR_GROUP_NAME=start-script
SUPERVISOR_PROCESS_NAME=start-script
TERM=xterm
UID=0
VPN_CONFIG='/config/openvpn/CA Toronto.ovpn'
VPN_DEVICE_TYPE=tun0
VPN_ENABLED=yes
VPN_OPTIONS=
VPN_PASS=***
VPN_PORT=1198
VPN_PROTOCOL=udp
VPN_PROV=pia
VPN_REMOTE=ca-toronto.privateinternetaccess.com
VPN_USER=***
_='[debug] Environment variables defined as follows'
[debug] Directory listing of files in /config/openvpn as follows

2018-04-03 16:09:05,973 DEBG 'deluge-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:09:05,981 DEBG 'start-script' stdout output:
total 24
drwxrwxr-x 2 nobody users 4096 Apr  3 16:09 .
drwxrwxr-x 8 nobody users 4096 Apr  3 16:09 ..
-rwxrwxr-x 1 nobody users 2025 Apr  3 10:43 ca.rsa.2048.crt
-rwxrwxr-x 1 nobody users  285 Apr  3 16:09 CA Toronto.ovpn
-rwxrwxr-x 1 nobody users   20 Apr  3 15:31 credentials.conf
-rwxrwxr-x 1 nobody users  869 Apr  3 10:43 crl.rsa.2048.pem

2018-04-03 16:09:05,985 DEBG 'privoxy-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:09:06,010 DEBG 'start-script' stdout output:
[debug] Contents of ovpn file /config/openvpn/CA Toronto.ovpn as follows...

2018-04-03 16:09:06,011 DEBG 'start-script' stdout output:
remote ca-toronto.privateinternetaccess.com 1198
client
dev tun
proto udp
resolv-retry infinite
nobind
persist-key
cipher aes-128-cbc
auth sha1
tls-client
remote-cert-tls server
auth-user-pass credentials.conf
comp-lzo
verb 1
crl-verify crl.rsa.2048.pem
ca ca.rsa.2048.crt
disable-occ

2018-04-03 16:09:06,020 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1

2018-04-03 16:09:06,023 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.222 to /etc/resolv.conf

2018-04-03 16:09:06,026 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf

2018-04-03 16:09:06,029 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf

2018-04-03 16:09:06,032 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf

2018-04-03 16:09:06,036 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf

2018-04-03 16:09:06,038 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf

2018-04-03 16:09:06,089 DEBG 'start-script' stdout output:
[info] Remote VPN endpoint resolves to the following A record(s)...
172.98.67.92 172.98.67.85 172.98.67.116 172.98.67.34 172.98.67.74 172.98.67.3 172.98.67.98 172.98.67.6 172.98.67.46 172.98.67.5 172.98.67.113 172.98.67.108 172.98.67.60

2018-04-03 16:09:06,096 DEBG 'start-script' stdout output:
[info] Attempting to load tun kernel module...

2018-04-03 16:09:06,097 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.13.0-37-generic

2018-04-03 16:09:06,098 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...

2018-04-03 16:09:06,099 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2018-04-03 16:09:06,099 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded

2018-04-03 16:09:06,106 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2018-04-03 16:09:06,107 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.13.0-37-generic

2018-04-03 16:09:06,107 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2018-04-03 16:09:06,107 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2018-04-03 16:09:06,107 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'

2018-04-03 16:09:06,108 DEBG 'start-script' stdout output:
[debug] Show name servers defined for container

2018-04-03 16:09:06,108 DEBG 'start-script' stdout output:
nameserver 209.222.18.222
nameserver 37.235.1.174
nameserver 8.8.8.8
nameserver 209.222.18.218
nameserver 37.235.1.177
nameserver 8.8.4.4

2018-04-03 16:09:06,108 DEBG 'start-script' stdout output:
[debug] Show name resolution for VPN endpoint ca-toronto.privateinternetaccess.com

2018-04-03 16:09:06,154 DEBG 'start-script' stdout output:
;; ->>HEADER<<- opcode: QUERY, rcode: NOERROR, id: 61737
;; flags: qr rd ra ; QUERY: 1, ANSWER: 13, AUTHORITY: 0, ADDITIONAL: 0 
;; QUESTION SECTION:
;; ca-toronto.privateinternetaccess.com.	IN	A

;; ANSWER SECTION:
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.67
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.94
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.128
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.8
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.107
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.88
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.13
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.116
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.53
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.10
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.69
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.62
ca-toronto.privateinternetaccess.com.	258	IN	A	172.98.67.129

;; AUTHORITY SECTION:

;; ADDITIONAL SECTION:

;; Query time: 40 msec
;; SERVER: 8.8.8.8
;; WHEN: Tue Apr  3 16:09:06 2018
;; MSG SIZE  rcvd: 262

2018-04-03 16:09:06,154 DEBG 'start-script' stdout output:
[debug] Show contents of hosts file

2018-04-03 16:09:06,155 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.11	82f9b9b19f12

2018-04-03 16:09:06,161 DEBG 'start-script' stdout output:
[info] Adding 192.168.86.100/24 as route via docker eth0

2018-04-03 16:09:06,163 DEBG 'start-script' stderr output:
Error: Invalid prefix for given prefix length.

2018-04-03 16:09:06,163 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-04-03 16:09:06,164 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.11 

2018-04-03 16:09:06,164 DEBG 'start-script' stdout output:
--------------------
[debug] Modules currently loaded for kernel

2018-04-03 16:09:06,168 DEBG 'start-script' stdout output:
Module                  Size  Used by
xt_nat                 16384  12
xt_tcpudp              16384  36
veth                   16384  0
ipt_MASQUERADE         16384  13
nf_nat_masquerade_ipv4    16384  1 ipt_MASQUERADE
nf_conntrack_netlink    40960  0
nfnetlink              16384  2 nf_conntrack_netlink
xfrm_user              32768  1
xfrm_algo              16384  1 xfrm_user
iptable_nat            16384  1
nf_conntrack_ipv4      16384  27
nf_defrag_ipv4         16384  1 nf_conntrack_ipv4
nf_nat_ipv4            16384  1 iptable_nat
xt_addrtype            16384  2
iptable_filter         16384  1
ip_tables              24576  2 iptable_filter,iptable_nat
xt_conntrack           16384  1
x_tables               40960  7 xt_nat,ip_tables,iptable_filter,xt_tcpudp,ipt_MASQUERADE,xt_addrtype,xt_conntrack
nf_nat                 28672  3 xt_nat,nf_nat_masquerade_ipv4,nf_nat_ipv4
nf_conntrack          131072  8 xt_nat,nf_conntrack_ipv4,ipt_MASQUERADE,nf_conntrack_netlink,nf_nat_masquerade_ipv4,xt_conntrack,nf_nat_ipv4,nf_nat
libcrc32c              16384  2 nf_conntrack,nf_nat
br_netfilter           24576  0
bridge                143360  1 br_netfilter
stp                    16384  1 bridge
llc                    16384  2 bridge,stp
overlay                69632  12
rfcomm                 77824  2
bnep                   20480  2
arc4                   16384  2
intel_rapl             20480  0
x86_pkg_temp_thermal    16384  0
intel_powerclamp       16384  0
coretemp               16384  0
kvm_intel             204800  0
kvm                   589824  1 kvm_intel
snd_hda_codec_hdmi     49152  1
irqbypass              16384  1 kvm
crct10dif_pclmul       16384  0
crc32_pclmul           16384  0
iwlmvm                385024  0
ghash_clmulni_intel    16384  0
pcbc                   16384  0
mac80211              782336  1 iwlmvm
aesni_intel           188416  0
snd_hda_codec_realtek    94208  1
snd_hda_codec_generic    73728  1 snd_hda_codec_realtek
aes_x86_64             20480  1 aesni_intel
crypto_simd            16384  1 aesni_intel
glue_helper            16384  1 aesni_intel
cryptd                 24576  3 crypto_simd,ghash_clmulni_intel,aesni_intel
intel_cstate           20480  0
intel_rapl_perf        16384  0
snd_hda_intel          40960  5
snd_hda_codec         126976  4 snd_hda_intel,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_hda_codec_realtek
snd_hda_core           81920  5 snd_hda_intel,snd_hda_codec,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_hda_codec_realtek
snd_hwdep              20480  1 snd_hda_codec
iwlwifi               249856  1 iwlmvm
snd_pcm                98304  4 snd_hda_intel,snd_hda_codec,snd_hda_core,snd_hda_codec_hdmi
joydev                 20480  0
input_leds             16384  0
btusb                  45056  0
cfg80211              614400  3 iwlmvm,iwlwifi,mac80211
snd_seq_midi           16384  0
snd_seq_midi_event     16384  1 snd_seq_midi
snd_rawmidi            32768  1 snd_seq_midi
btrtl                  16384  1 btusb
btbcm                  16384  1 btusb
btintel                16384  1 btusb
snd_seq                65536  2 snd_seq_midi_event,snd_seq_midi
bluetooth             548864  31 btrtl,btintel,bnep,btbcm,rfcomm,btusb
snd_seq_device         16384  3 snd_seq,snd_rawmidi,snd_seq_midi
snd_timer              32768  2 snd_seq,snd_pcm
snd                    81920  21 snd_hda_intel,snd_hwdep,snd_seq,snd_hda_codec,snd_timer,snd_rawmidi,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_seq_device,snd_hda_codec_realtek,snd_pcm
lpc_ich                24576  0
ecdh_generic           24576  1 bluetooth
mei_me                 40960  0
mei                   102400  1 mei_me
shpchp                 36864  0
soundcore              16384  1 snd
mac_hid                16384  0
tpm_infineon           20480  0
soc_button_array       16384  0
parport_pc             32768  0
ppdev                  20480  0
lp                     20480  0
parport                49152  3 lp,parport_pc,ppdev
autofs4                40960  2
hid_generic            16384  0
hid_logitech_hidpp     32768  0
hid_logitech_dj        20480  0
usbhid        
2018-04-03 16:09:06,169 DEBG 'start-script' stdout output:
         49152  0
hid                   118784  5 hid_generic,usbhid,hid_logitech_dj,hid_logitech_hidpp
i915                 1830912  80
i2c_algo_bit           16384  1 i915
drm_kms_helper        167936  1 i915
syscopyarea            16384  1 drm_kms_helper
ahci                   36864  4
sysfillrect            16384  1 drm_kms_helper
sysimgblt              16384  1 drm_kms_helper
libahci                32768  1 ahci
fb_sys_fops            16384  1 drm_kms_helper
e1000e                249856  0
alx                    45056  0
mdio                   16384  1 alx
drm                   360448  8 i915,drm_kms_helper
ptp                    20480  1 e1000e
pps_core               20480  1 ptp
video                  40960  1 i915

2018-04-03 16:09:06,178 DEBG 'start-script' stdout output:
[debug] Docker interface defined as eth0

2018-04-03 16:09:06,182 DEBG 'start-script' stdout output:
[debug] Docker IP defined as 172.17.0.11

2018-04-03 16:09:06,184 DEBG 'start-script' stdout output:
[debug] Docker netmask defined as 255.255.0.0

2018-04-03 16:09:06,189 DEBG 'start-script' stdout output:
[info] Docker network defined as    172.17.0.0/16

2018-04-03 16:09:06,258 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-04-03 16:09:06,268 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 1198 -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.86.0/24 -i eth0 -p tcp -m tcp --dport 58846 -j ACCEPT
-A INPUT -s 192.168.86.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 1198 -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.86.0/24 -o eth0 -p tcp -m tcp --sport 58846 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 192.168.86.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-04-03 16:09:06,271 DEBG 'start-script' stdout output:
--------------------
[debug] OpenVPN command line:- /usr/bin/openvpn --daemon --reneg-sec 0 --mute-replay-warnings --auth-nocache --setenv VPN_PROV 'pia' --setenv DEBUG 'true' --setenv VPN_DEVICE_TYPE 'tun0' --setenv VPN_REMOTE 'ca-toronto.privateinternetaccess.com' --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 172.98.67.92 1198 udp --remote 172.98.67.85 1198 udp --remote 172.98.67.116 1198 udp --remote 172.98.67.34 1198 udp --remote 172.98.67.74 1198 udp --remote 172.98.67.3 1198 udp --remote 172.98.67.98 1198 udp --remote 172.98.67.6 1198 udp --remote 172.98.67.46 1198 udp --remote 172.98.67.5 1198 udp --remote 172.98.67.113 1198 udp --remote 172.98.67.108 1198 udp --remote 172.98.67.60 1198 udp --keepalive 10 60 --setenv STRICT_PORT_FORWARD 'yes' --disable-occ --auth-user-pass credentials.conf --cd /config/openvpn --config '/config/openvpn/CA Toronto.ovpn'
[info] Starting OpenVPN...

2018-04-03 16:09:06,279 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:06 2018 WARNING: file 'credentials.conf' is group or others accessible

2018-04-03 16:09:06,279 DEBG 'start-script' stdout output:
Tue Apr  3 16:09: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

2018-04-03 16:09:06,279 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:06 2018 library versions: OpenSSL 1.1.0f  25 May 2017, LZO 2.10

2018-04-03 16:09:06,281 DEBG 'start-script' stdout output:
[info] OpenVPN started
Tue Apr  3 16:09: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-04-03 16:09:06,281 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:06 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]172.98.67.92:1198
Tue Apr  3 16:09:06 2018 UDP link local: (not bound)
Tue Apr  3 16:09:06 2018 UDP link remote: [AF_INET]172.98.67.92:1198

2018-04-03 16:09:06,519 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:06 2018 [2f816dbe0a3349f590989433430f15e1] Peer Connection Initiated with [AF_INET]172.98.67.92:1198

2018-04-03 16:09:07,701 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 auth-token received, disabling auth-nocache for the authentication token

2018-04-03 16:09:07,701 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 TUN/TAP device tun0 opened

2018-04-03 16:09:07,701 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Tue Apr  3 16:09:07 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-04-03 16:09:07,703 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 /usr/bin/ip addr add dev tun0 local 10.3.10.10 peer 10.3.10.9

2018-04-03 16:09:07,705 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 /root/openvpnup.sh tun0 1500 1558 10.3.10.10 10.3.10.9 init

2018-04-03 16:09:07,713 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:09:07,713 DEBG 'start-script' stdout output:
Tue Apr  3 16:09:07 2018 Initialization Sequence Completed

2018-04-03 16:09:07,714 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:09:07,730 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:09:07,771 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:09:07,776 DEBG 'deluge-script' stdout output:
[info] Deluge not running
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.3.10.10 different, marking for reconfigure
[debug] Waiting for file '/home/nobody/vpn_incoming_port.txt' to be generated (contains PIA API generated incoming port number)...

2018-04-03 16:09:07,779 DEBG 'privoxy-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'
[info] Configuring Privoxy...

2018-04-03 16:09:07,797 DEBG 'privoxy-script' stdout output:
[info] All checks complete, starting Privoxy...

2018-04-03 16:09:07,798 DEBG 'privoxy-script' stderr output:
2018-04-03 16:09:07.798 7ff45a9fc0c0 Info: Privoxy version 3.0.26
2018-04-03 16:09:07.798 7ff45a9fc0c0 Info: Program name: /usr/bin/privoxy

2018-04-03 16:09:07,828 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:09:07,829 DEBG 'start-script' stdout output:
[debug] Attempting to get external IP using Name Server 'ns1.google.com'...

2018-04-03 16:09:07,830 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:09:07,830 DEBG 'start-script' stdout output:
[info] Strict port forwarding enabled, attempting to assign an incoming port...

2018-04-03 16:09:07,835 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=8677209ad9be3328cfa585a5350928c0e229518e6402597d5956e9f8b2607d58...

2018-04-03 16:09:07,978 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 173.239.230.88

2018-04-03 16:09:08,595 DEBG 'start-script' stdout output:
[info] Curl successful for http://209.222.18.222:2000/?client_id=8677209ad9be3328cfa585a5350928c0e229518e6402597d5956e9f8b2607d58, response code 200

2018-04-03 16:09:08,605 DEBG 'start-script' stdout output:
[debug] Successfully assigned incoming port 38015

2018-04-03 16:09:08,778 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:09:08,779 DEBG 'deluge-script' stdout output:
[info] Attempting to start Deluge...

2018-04-03 16:09:09,014 DEBG 'deluge-script' stdout output:
[info] Deluge listening interface currently defined as 10.22.10.6
[info] Deluge listening interface will be changed to 10.3.10.10
[info] Saving changes to Deluge config file /config/core.conf...

2018-04-03 16:09:09,392 DEBG 'deluge-web-script' stdout output:
[info] Starting Deluge webui...

2018-04-03 16:09:09,620 DEBG 'deluge-script' stdout output:
Setting random_port to False..
Configuration value successfully updated.

2018-04-03 16:09:09,893 DEBG 'deluge-script' stdout output:
Setting listen_ports to (38015, 38015)..
Configuration value successfully updated.

2018-04-03 16:09:09,918 DEBG 'deluge-script' stdout output:
[info] Deluge started

2018-04-03 16:09:10,177 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:09:40,178 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:09:40,313 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:09:40,326 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:09:40,520 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:10:10,524 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:10:10,649 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:10:10,658 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:10:10,715 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:10:40,716 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:10:40,843 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:10:40,846 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:10:40,906 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:11:10,908 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:11:11,039 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:11:11,042 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:11:11,100 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015

2018-04-03 16:11:11,100 DEBG 'deluge-script' stdout output:
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:11:41,103 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:11:41,239 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:11:41,244 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:11:41,297 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:12:11,298 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:12:11,425 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:12:11,429 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:12:11,492 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:12:41,495 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:12:41,627 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:12:41,630 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:12:41,694 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:13:11,696 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:13:11,820 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:13:11,824 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:13:11,978 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:13:41,980 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:13:42,116 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:13:42,120 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:13:42,177 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:14:12,179 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:14:12,301 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:14:12,304 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:14:12,364 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:14:42,366 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:14:42,495 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:14:42,498 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:14:42,560 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:15:12,562 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:15:12,695 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:15:12,699 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:15:12,755 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:15:42,757 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:15:42,889 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:15:42,894 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:15:42,952 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015

2018-04-03 16:15:42,953 DEBG 'deluge-script' stdout output:
[debug] Deluge IP is 10.3.10.10

2018-04-03 16:16:12,955 DEBG 'deluge-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2018-04-03 16:16:13,086 DEBG 'deluge-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.3.10.10'

2018-04-03 16:16:13,089 DEBG 'deluge-script' stdout output:
[debug] Incoming port for tunnel is '38015'

2018-04-03 16:16:13,229 DEBG 'deluge-script' stdout output:
[debug] VPN incoming port is 38015
[debug] VPN IP is 10.3.10.10
[debug] Deluge incoming port is 38015
[debug] Deluge IP is 10.3.10.10
Edited by dp917
log file
Link to comment

@binhex changed it to 192.168.86.0/24 and got it working but only with debug. Did rebuild with vpn turned off and tested ok, then turned vpn on and debug false in same rebuild and got it working all around. I never touched LAN (0.0.0.0) when Netherlands endpoint worked, then with debug thing I was getting all confused! Thank you for your help and for this container. 

Link to comment

Afternoon folks!

 

A question regarding the WebUI.

 

The WebUI does not contain the 'added' column.

I found a forum post here that details how this column (and others) could be added back by editing the "deluge-all.js" file.

He located it here: /usr/lib/python2.7/dist-packages/deluge/ui/web/js/deluge-all.js

 

Thinking to do the same I went to the appdata location for the deluxe docker, but this section of the deluge files is not there.

(I assume it's wrapped into the docker image.)

 

Is there a way to dig into that and make a modification to that js file?

 

(Alternately, is there another way to have the added column available in the webUI?)

Link to comment

Also got the curl error, but just had to change my endpoint, now it's working again!

 

But by the way, is this notification in my log normal "WARNING: file 'credentials.conf' is group or others accessible"? As far as I can tell, there's only my Pia login saved into, so I tried deleting it and restarting delugevpn. Of course the file got created again, but the notification still pops up...

Link to comment

So this container seems to just destroy my network when I have the container running I'm getting anywhere from 40 ms to 800 ms ping times to my router from my computer. The rutorrent container doesn't cause the same issue but I much prefer deluge has anyone else experienced this problem and if so what was the solution.

Link to comment

I got the container up and running after following the steps of downloading the three files:

 

CA Vancouver.ovpn

ca.rsa.2048.crt

crl.rsa.2048.pem

 

Placed them into my container /config folder as recommended, container starts up perfectly! I grabbed a quick test .torrent file, added it to the webui. Successful download! - Everything is working absolutely perfectly. Really nice job binhex!

I just have one question, and it might be dumb but, is there a way I can test that I'm connected to the VPN? Would looking at the logs be enough? Is there a way I can view the active connection?

 

Thanks!

Link to comment

All of a sudden my docker stopped working.  I tried restarting the server and restarting the plugin, but I keep getting the following error in chrome:


ERR_CONNECTION_REFUSED

 

Attached is the debug log, but the only error I see is: No such file or directory: '/config/dht.state'

 

I'm not sure why that would have randomly changed, but I've never had issues with this docker before.

deluged.log

Link to comment
1 hour ago, clowncracker said:

All of a sudden my docker stopped working.  I tried restarting the server and restarting the plugin, but I keep getting the following error in chrome:


ERR_CONNECTION_REFUSED

 

Attached is the debug log, but the only error I see is: No such file or directory: '/config/dht.state'

 

I'm not sure why that would have randomly changed, but I've never had issues with this docker before.

deluged.log

 

its not the deluge log we need, its the supervisord.log file, please follow the procedure below:-

 

 

Link to comment
Anyone have any idea whats going on here?
 
[info] Starting OpenVPN...2018-04-06 00:49:52,331 DEBG 'start-script' stdout output:Fri Apr  6 00:49:52 2018 WARNING: file 'credentials.conf' is group or others accessibleFri Apr  6 00:49:52 2018 OpenVPN 2.4.4 x86_64-unknown-linux-gnu [sSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Sep 26 2017Fri Apr  6 00:49:52 2018 library versions: OpenSSL 1.1.0f  25 May 2017, LZO 2.102018-04-06 00:49:52,332 DEBG 'start-script' stdout output:[info] OpenVPN startedFri Apr  6 00:49:52 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts2018-04-06 00:49:52,333 DEBG 'start-script' stdout output:Fri Apr  6 00:49:52 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]109.201.152.241:1194Fri Apr  6 00:49:52 2018 UDP link local: (not bound)2018-04-06 00:49:52,333 DEBG 'start-script' stdout output:Fri Apr  6 00:49:52 2018 UDP link remote: [AF_INET]109.201.152.241:11942018-04-06 00:49:53,681 DEBG 'start-script' stdout output:Fri Apr  6 00:49:53 2018 [3386382d2210d8f97bb14350a711d6] Peer Connection Initiated with [AF_INET]109.201.152.241:11942018-04-06 00:49:55,124 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 2018 auth-token received, disabling auth-nocache for the authentication token2018-04-06 00:49:55,124 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 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).Fri Apr  6 00:49:55 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).Fri Apr  6 00:49:55 2018 WARNING: cipher with small block size in use, reducing reneg-bytes to 64MB to mitigate SWEET32 attacks.2018-04-06 00:49:55,125 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 2018 TUN/TAP device tun0 openedFri Apr  6 00:49:55 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0Fri Apr  6 00:49:55 2018 /usr/bin/ip link set dev tun0 up mtu 15002018-04-06 00:49:55,126 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 2018 /usr/bin/ip addr add dev tun0 local 10.47.10.6 peer 10.47.10.52018-04-06 00:49:55,127 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 2018 /root/openvpnup.sh tun0 1500 1542 10.47.10.6 10.47.10.5 init2018-04-06 00:49:55,137 DEBG 'start-script' stdout output:Fri Apr  6 00:49:55 2018 Initialization Sequence Completed2018-04-06 00:49:55,205 DEBG 'deluge-script' stdout output:[info] Deluge not running[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.47.10.6 different, marking for reconfigure2018-04-06 00:49:55,254 DEBG 'start-script' stdout output:[info] Attempting to curl http://209.222.18.222:2000/?client_id=cbe4e184f2dd4c0e85830624e315ea5ff548c79c0bee69c0688de8180ac23931...2018-04-06 00:49:55,590 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 12 retries left2018-04-06 00:49:55,591 DEBG 'start-script' stdout output:[info] Retrying in 10 secs...2018-04-06 00:49:55,934 DEBG 'start-script' stdout output:[info] Successfully retrieved external IP address 212.92.105.2072018-04-06 00:50:05,932 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 11 retries left[info] Retrying in 10 secs...2018-04-06 00:50:16,272 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 10 retries left[info] Retrying in 10 secs...2018-04-06 00:50:26,608 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 9 retries left[info] Retrying in 10 secs...2018-04-06 00:50:36,963 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 8 retries left2018-04-06 00:50:36,963 DEBG 'start-script' stdout output:[info] Retrying in 10 secs...2018-04-06 00:50:47,915 DEBG 'start-script' stdout output:[warn] Response code 000 from curl != 2xx[warn] Exit code 7 from curl != 0[info] 7 retries left[info] Retrying in 10 secs...

 
My rtorrent is doing the exact same thing also. 
 
There was some errors about PIA API changing, maybe thats why?  

[warn] Response code 000 from curl != 2xx, exausted retries exiting script...2018-04-06 00:52:00,350 DEBG 'start-script' stdout output:[warn] PIA API currently down, terminating OpenVPN process to force retry for incoming port...

 
any idea's?
 
Addy
supervisord.log

See second post in this thread

Sent from my SM-G935F using Tapatalk

  • Like 1
Link to comment
23 hours ago, Chaos_Therum said:

So this container seems to just destroy my network when I have the container running I'm getting anywhere from 40 ms to 800 ms ping times to my router from my computer. The rutorrent container doesn't cause the same issue but I much prefer deluge has anyone else experienced this problem and if so what was the solution.

 

If you haven't done so already, limit your upload to about 80% of what your connection can handle. If you don't put a cap on your upload it will "overload" your network causing lower download speed and higher ping. This should be done regardless of the client you're using.

  • Like 1
Link to comment
On 4/6/2018 at 2:09 AM, docbrown said:

EDIT: Weird, Safari and Firefox delivered me a blank page but they downloaded fine in Chrome!

 

I just noticed the PIA change, but I can't seem get the OpenVPN files from https://www.privateinternetaccess.com/openvpn/openvpn.zip. Is the link working for anyone else?

Working for me.

 

Edit: Maybe this link will work for you-

***removed***

 

Please let me know if you get it so I can take it back down.

Edited by wgstarks
Link to comment

Join the conversation

You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.

Guest
Reply to this topic...

×   Pasted as rich text.   Restore formatting

  Only 75 emoji are allowed.

×   Your link has been automatically embedded.   Display as a link instead

×   Your previous content has been restored.   Clear editor

×   You cannot paste images directly. Upload or insert images from URL.