This is really starting to do my head in.
I have DelugeVPN setup and everything is working fine except for the torrents themselves.
All containers (SAB and Jacket) running through Deluge have the correct external IP and are accessible from the webui so I'm pretty sure I have done everything required from the Feb IP tightening; and pretty sure the torrents were working when this was done.
At first I suspected my VPN provider (PureVPN) and there outdated OPENVPN files, however, downloading from SAB I get the 4-5MB/s that I would expect from my ISP (I live in Australia), so the VPN is not causing a bottleneck.
Deluge torrents either don't download at all (no peers, just no activity at all) or it is extremely slow. Switch the vpn off and I can get the speeds I would expect.
Things I've tried:
Wiped Deluge, SAB and Jacket (including appdata files) and started again.
Installed Binhex qbittorrentvpn - same behaviour.
Tried running qbittorrent (without vpn) through deluge (mimicking SAB) - same behaviour.
PureVPN on windows or Kali work fine and I get expected speeds using speedtest.net
I'm at the point of setting up a Kali VM just for the torrent side of things, but that is presenting a whole different set of issues.
Any help is greatly appreciated.
Logs
\_ |__ |__| ____ | |__ ____ ___ ___
| __ \| |/ \| | \_/ __ \\ \/ /
| \_\ \ | | \ Y \ ___/ > <
|___ /__|___| /___| /\___ >__/\_ \
\/ \/ \/ \/ \/
https://hub.docker.com/u/binhex/
2021-05-19 23:01:41.006192 [info] Host is running unRAID
2021-05-19 23:01:41.028731 [info] System information Linux 7cb5697ec646 5.10.28-Unraid #1 SMP Wed Apr 7 08:23:18 PDT 2021 x86_64 GNU/Linux
2021-05-19 23:01:41.056890 [info] OS_ARCH defined as 'x86-64'
2021-05-19 23:01:41.083374 [info] PUID defined as '99'
2021-05-19 23:01:41.115182 [info] PGID defined as '100'
2021-05-19 23:01:41.152044 [info] UMASK defined as '000'
2021-05-19 23:01:41.177190 [info] Permissions already set for volume mappings
2021-05-19 23:01:41.204992 [info] Deleting files in /tmp (non recursive)...
2021-05-19 23:01:41.237807 [info] VPN_ENABLED defined as 'yes'
2021-05-19 23:01:41.266135 [info] VPN_CLIENT defined as 'openvpn'
2021-05-19 23:01:41.294095 [info] VPN_PROV defined as 'custom'
2021-05-19 23:01:41.337099 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/jp2-ovpn.ovpn
2021-05-19 23:01:41.399559 [info] VPN remote server(s) defined as 'jp2-ovpn.pointtoserver.com,'
2021-05-19 23:01:41.421527 [info] VPN remote port(s) defined as '80,'
2021-05-19 23:01:41.444061 [info] VPN remote protcol(s) defined as 'tcp-client,'
2021-05-19 23:01:41.471618 [info] VPN_DEVICE_TYPE defined as 'tun0'
2021-05-19 23:01:41.498277 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2021-05-19 23:01:41.525234 [info] LAN_NETWORK defined as '192.168.2.0/24'
2021-05-19 23:01:41.553266 [info] NAME_SERVERS defined as '209.222.18.222,84.200.69.80,37.235.1.174,1.1.1.1,209.222.18.218,37.235.1.177,84.200.70.40,1.0.0.1'
2021-05-19 23:01:41.581384 [info] VPN_USER defined as 'XXX'
2021-05-19 23:01:41.609447 [info] VPN_PASS defined as 'XXX'
2021-05-19 23:01:41.635789 [info] ENABLE_PRIVOXY defined as 'yes'
2021-05-19 23:01:41.668736 [warn] ADDITIONAL_PORTS DEPRECATED, please rename env var to 'VPN_INPUT_PORTS'
2021-05-19 23:01:41.692031 [info] ADDITIONAL_PORTS defined as '9117,8080'
2021-05-19 23:01:41.718169 [info] VPN_OUTPUT_PORTS not defined (via -e VPN_OUTPUT_PORTS), skipping allow for custom outgoing ports
2021-05-19 23:01:41.745219 [info] DELUGE_DAEMON_LOG_LEVEL defined as 'info'
2021-05-19 23:01:41.772022 [info] DELUGE_WEB_LOG_LEVEL defined as 'info'
2021-05-19 23:01:41.796412 [info] Starting Supervisor...
2021-05-19 23:01:41,930 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing
2021-05-19 23:01:41,930 INFO Set uid to user 0 succeeded
2021-05-19 23:01:41,931 INFO supervisord started with pid 7
2021-05-19 23:01:42,934 INFO spawned: 'shutdown-script' with pid 177
2021-05-19 23:01:42,936 INFO spawned: 'start-script' with pid 178
2021-05-19 23:01:42,939 INFO spawned: 'watchdog-script' with pid 179
2021-05-19 23:01:42,939 INFO reaped unknown pid 8 (exit status 0)
2021-05-19 23:01:42,943 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN
2021-05-19 23:01:42,943 INFO success: shutdown-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2021-05-19 23:01:42,943 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2021-05-19 23:01:42,943 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2021-05-19 23:01:43,018 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.222 to /etc/resolv.conf
2021-05-19 23:01:43,022 DEBG 'start-script' stdout output:
[info] Adding 84.200.69.80 to /etc/resolv.conf
2021-05-19 23:01:43,027 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf
2021-05-19 23:01:43,031 DEBG 'start-script' stdout output:
[info] Adding 1.1.1.1 to /etc/resolv.conf
2021-05-19 23:01:43,036 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf
2021-05-19 23:01:43,041 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf
2021-05-19 23:01:43,045 DEBG 'start-script' stdout output:
[info] Adding 84.200.70.40 to /etc/resolv.conf
2021-05-19 23:01:43,050 DEBG 'start-script' stdout output:
[info] Adding 1.0.0.1 to /etc/resolv.conf
2021-05-19 23:01:43,437 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1
2021-05-19 23:01:43,453 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16
2021-05-19 23:01:43,458 DEBG 'start-script' stdout output:
[info] Adding 192.168.2.0/24 as route via docker eth0
2021-05-19 23:01:43,459 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
2021-05-19 23:01:43,459 DEBG 'start-script' stdout output:
--------------------
2021-05-19 23:01:43,460 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.2.0/24 via 172.17.0.1 dev eth0
2021-05-19 23:01:43,461 DEBG 'start-script' stdout output:
broadcast 127.0.0.0 dev lo table local proto kernel scope link src 127.0.0.1
local 127.0.0.0/8 dev lo table local proto kernel scope host src 127.0.0.1
local 127.0.0.1 dev lo table local proto kernel scope host src 127.0.0.1
broadcast 127.255.255.255 dev lo table local proto kernel scope link src 127.0.0.1
broadcast 172.17.0.0 dev eth0 table local proto kernel scope link src 172.17.0.2
local 172.17.0.2 dev eth0 table local proto kernel scope host src 172.17.0.2
broadcast 172.17.255.255 dev eth0 table local proto kernel scope link src 172.17.0.2
--------------------
2021-05-19 23:01:43,464 DEBG 'start-script' stdout output:
iptable_mangle 16384 2
ip_tables 28672 5 iptable_filter,iptable_nat,iptable_mangle
x_tables 28672 14 ip6table_filter,xt_conntrack,iptable_filter,xt_tcpudp,xt_addrtype,xt_CHECKSUM,xt_nat,ip6_tables,ipt_REJECT,ip_tables,ip6table_mangle,xt_MASQUERADE,iptable_mangle,xt_mark
2021-05-19 23:01:43,465 DEBG 'start-script' stdout output:
[info] iptable_mangle support detected, adding fwmark for tables
2021-05-19 23:01:43,544 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------
2021-05-19 23:01:43,546 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD DROP
-P OUTPUT DROP
-A INPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT
-A INPUT -s 185.242.4.59/32 -i eth0 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 8112 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --dport 8112 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 9117 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --dport 9117 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 8080 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --dport 8080 -j ACCEPT
-A INPUT -s 192.168.2.0/24 -d 172.17.0.0/16 -i eth0 -p tcp -m tcp --dport 58846 -j ACCEPT
-A INPUT -s 192.168.2.0/24 -d 172.17.0.0/16 -i eth0 -p tcp -m tcp --dport 8118 -j ACCEPT
-A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT
-A INPUT -i lo -j ACCEPT
-A INPUT -i tun0 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT
-A OUTPUT -d 185.242.4.59/32 -o eth0 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 8112 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --sport 8112 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 9117 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --sport 9117 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 8080 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --sport 8080 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 192.168.2.0/24 -o eth0 -p tcp -m tcp --sport 58846 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 192.168.2.0/24 -o eth0 -p tcp -m tcp --sport 8118 -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT
-A OUTPUT -o tun0 -j ACCEPT
2021-05-19 23:01:43,547 DEBG 'start-script' stdout output:
--------------------
2021-05-19 23:01:43,547 DEBG 'start-script' stdout output:
[info] Starting OpenVPN (non daemonised)...
2021-05-19 23:01:43,555 DEBG 'start-script' stdout output:
2021-05-19 23:01:43 DEPRECATED OPTION: --cipher set to 'AES-256-CBC' but missing in --data-ciphers (AES-256-GCM:AES-128-GCM). Future OpenVPN version will ignore --cipher for cipher negotiations. Add 'AES-256-CBC' to --data-ciphers or change --cipher 'AES-256-CBC' to --data-ciphers-fallback 'AES-256-CBC' to silence this warning.
2021-05-19 23:01:43,555 DEBG 'start-script' stdout output:
2021-05-19 23:01:43 WARNING: file 'credentials.conf' is group or others accessible
2021-05-19 23:01:43 OpenVPN 2.5.1 [git:makepkg/f186691b32e68362+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Feb 24 2021
2021-05-19 23:01:43 library versions: OpenSSL 1.1.1k 25 Mar 2021, LZO 2.10
2021-05-19 23:01:43,555 DEBG 'start-script' stdout output:
2021-05-19 23:01:43 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
2021-05-19 23:01:43,556 DEBG 'start-script' stdout output:
2021-05-19 23:01:43 TCP/UDP: Preserving recently used remote address: [AF_INET]185.242.4.59:80
2021-05-19 23:01:43 Attempting to establish TCP connection with [AF_INET]185.242.4.59:80 [nonblock]
2021-05-19 23:01:43,711 DEBG 'start-script' stdout output:
2021-05-19 23:01:43 TCP connection established with [AF_INET]185.242.4.59:80
2021-05-19 23:01:43 TCP_CLIENT link local: (not bound)
2021-05-19 23:01:43 TCP_CLIENT link remote: [AF_INET]185.242.4.59:80
2021-05-19 23:01:44,970 DEBG 'start-script' stdout output:
2021-05-19 23:01:44 WARNING: 'link-mtu' is used inconsistently, local='link-mtu 1559', remote='link-mtu 1552'
2021-05-19 23:01:44 WARNING: 'auth' is used inconsistently, local='auth SHA1', remote='auth [null-digest]'
2021-05-19 23:01:44 WARNING: 'comp-lzo' is present in remote config but missing in local config, remote='comp-lzo'
2021-05-19 23:01:44,971 DEBG 'start-script' stdout output:
2021-05-19 23:01:44 [Secure-Server] Peer Connection Initiated with [AF_INET]185.242.4.59:80
2021-05-19 23:01:46,412 DEBG 'start-script' stdout output:
2021-05-19 23:01:46 TUN/TAP device tun0 opened
2021-05-19 23:01:46 net_iface_mtu_set: mtu 1500 for tun0
2021-05-19 23:01:46 net_iface_up: set tun0 up
2021-05-19 23:01:46,413 DEBG 'start-script' stdout output:
2021-05-19 23:01:46 net_addr_v4_add: 172.94.56.68/28 dev tun0
2021-05-19 23:01:46 /root/openvpnup.sh tun0 1500 1554 172.94.56.68 255.255.255.240 init
2021-05-19 23:01:46,416 DEBG 'start-script' stdout output:
2021-05-19 23:01:46 Initialization Sequence Completed
2021-05-19 23:01:47,596 DEBG 'start-script' stdout output:
[info] Attempting to get external IP using 'http://checkip.amazonaws.com'...
2021-05-19 23:01:49,276 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 172.94.56.68
2021-05-19 23:01:49,277 DEBG 'start-script' stdout output:
[info] Application does not require port forwarding or VPN provider is != pia, skipping incoming port assignment
2021-05-19 23:01:49,330 DEBG 'watchdog-script' stdout output:
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 172.94.56.68 different, marking for reconfigure
2021-05-19 23:01:49,334 DEBG 'watchdog-script' stdout output:
[info] Deluge not running
2021-05-19 23:01:49,338 DEBG 'watchdog-script' stdout output:
[info] Deluge Web UI not running
2021-05-19 23:01:49,342 DEBG 'watchdog-script' stdout output:
[info] Privoxy not running
2021-05-19 23:01:49,342 DEBG 'watchdog-script' stdout output:
[info] Attempting to start Deluge...
[info] Removing deluge pid file (if it exists)...
2021-05-19 23:01:49,581 DEBG 'watchdog-script' stdout output:
[info] Deluge key 'listen_interface' currently has a value of '172.94.56.70'
[info] Deluge key 'listen_interface' will have a new value '172.94.56.68'
[info] Writing changes to Deluge config file '/config/core.conf'...
2021-05-19 23:01:49,276 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 172.94.56.68
2021-05-19 23:01:49,277 DEBG 'start-script' stdout output:
[info] Application does not require port forwarding or VPN provider is != pia, skipping incoming port assignment
2021-05-19 23:01:49,330 DEBG 'watchdog-script' stdout output:
[info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 172.94.56.68 different, marking for reconfigure
2021-05-19 23:01:49,334 DEBG 'watchdog-script' stdout output:
[info] Deluge not running
2021-05-19 23:01:49,338 DEBG 'watchdog-script' stdout output:
[info] Deluge Web UI not running
2021-05-19 23:01:49,342 DEBG 'watchdog-script' stdout output:
[info] Privoxy not running
2021-05-19 23:01:49,342 DEBG 'watchdog-script' stdout output:
[info] Attempting to start Deluge...
[info] Removing deluge pid file (if it exists)...
2021-05-19 23:01:49,581 DEBG 'watchdog-script' stdout output:
[info] Deluge key 'listen_interface' currently has a value of '172.94.56.70'
[info] Deluge key 'listen_interface' will have a new value '172.94.56.68'
[info] Writing changes to Deluge config file '/config/core.conf'...
2021-05-19 23:01:49,748 DEBG 'watchdog-script' stdout output:
[info] Deluge key 'outgoing_interface' currently has a value of 'tun0'
[info] Deluge key 'outgoing_interface' will have a new value 'tun0'
[info] Writing changes to Deluge config file '/config/core.conf'...
2021-05-19 23:01:49,892 DEBG 'watchdog-script' stdout output:
[info] Deluge key 'default_daemon' currently has a value of 'e02ae3c7d0e949b1960dbce1e6a90c17'
[info] Deluge key 'default_daemon' will have a new value 'e02ae3c7d0e949b1960dbce1e6a90c17'
[info] Writing changes to Deluge config file '/config/web.conf'...
2021-05-19 23:01:50,166 DEBG 'watchdog-script' stdout output:
[info] Deluge process started
[info] Waiting for Deluge process to start listening on port 58846...
2021-05-19 23:01:50,395 DEBG 'watchdog-script' stdout output:
[info] Deluge process listening on port 58846
2021-05-19 23:01:52,738 DEBG 'watchdog-script' stdout output:
[info] No torrents with state 'Error' found
2021-05-19 23:01:52,739 DEBG 'watchdog-script' stdout output:
[info] Starting Deluge Web UI...
2021-05-19 23:01:52,739 DEBG 'watchdog-script' stdout output:
[info] Deluge Web UI started
2021-05-19 23:01:52,741 DEBG 'watchdog-script' stdout output:
[info] Attempting to start Privoxy...
2021-05-19 23:01:53,748 DEBG 'watchdog-script' stdout output:
[info] Privoxy process started
[info] Waiting for Privoxy process to start listening on port 8118...
2021-05-19 23:01:53,758 DEBG 'watchdog-script' stdout output:
[info] Privoxy process listening on port 8118