[Support] binhex - rTorrentVPN


Recommended Posts

Hey all, I recently moved my "data" folder, and it deleted/modified all of my active torrents  where I have to re-download gigabytes of data. Why is this and how can I avoid this happening in the future? I switched from Deluge to rtorrent and I had to re-download all of my previously fully downloaded torrents as well.

Link to comment

Another new issue I am having, is I recently enabled VPN, and it looks like it's connecting fine, but the web UI is now broken. I can't load any torrent views, and on launch i get the following errors in the rTorrent log:

[25.03.2020 15:27:02] WebUI started.

[25.03.2020 15:27:23] Bad response from server: (0 [error,getplugins])

 

then if I try and click any torrent view tab, it returns the following error:

[25.03.2020 15:30:16] JS error: [http://[ipaddress]/js/stable.js : 1770] TypeError: this.dBody is undefined

Link to comment
On 3/24/2020 at 7:08 PM, cyriouslydylan said:

Hey all, I recently moved my "data" folder,

when you say moved do you mean changed the container volume name, i.e. 'data' to something else, or do you mean you changed the host path for the /data volume mapping?. 

Link to comment
3 hours ago, binhex said:

when you say moved do you mean changed the container volume name, i.e. 'data' to something else, or do you mean you changed the host path for the /data volume mapping?. 

I moved the "data" mapping in the docker settings.

I changed it from "/mnt/user/Media/Downloads" to "/mnt/user/Media/". Which obviously broke all of my file mappings for the torrents. So i then clicked on them, hit "save to" and set the original folder the files got saved to. Then hit "force recheck", but it didn't recognize any of the files. I can still see them in my file system, but once I moved the data, it corrupted those files and I can no longer play them, until I redownload the entire thing.

A similar thing happened when I first switched from Deluge to r-torrent and tried to import all of my old torrents from that program.

Link to comment

Hi, I am getting php permission denied errors constantly in the supervisor.

Example:

2020/03/27 18:26:22 [error] 1153#1153: *1647 FastCGI sent in stderr: "PHP message: PHP Warning:  fopen(/usr/share/webapps/rutorrent/share/settings/cpu.dat.tmp): failed to open stream: Permission denied in /usr/share/webapps/rutorrent/php/cache.php on line 40" while reading response header from upstream, client: 192.168.1.100, server: localhost, request: "GET /plugins/cpuload/action.php?_=1585332174170 HTTP/1.1", upstream: "fastcgi://127.0.0.1:7777", host: "192.168.2.10:9443", referrer: "https://192.168.2.10:9443/"

Any ideas?

Troubleshooting so far:
Clean install of my VM (Ubuntu server 18.04.4)
Only installed Docker+Portainer and Apache on host VM.

 

Platform: FreeNAS w/ bhyve VM. 

supervisord.log

Link to comment

For some reason I can't figure out how to port forward this container in pfSense.  I had it working in the past, but I can't seem to get it to open now for whatever reason.  My ports in rtorrent are 7100-7119.  This is my NAT rule.  Anyone got any ideas what I've got wrong?

 

 

Untitled.png

Link to comment
11 minutes ago, EC28 said:

For some reason I can't figure out how to port forward this container in pfSense.  I had it working in the past, but I can't seem to get it to open now for whatever reason.  My ports in rtorrent are 7100-7119.  This is my NAT rule.  Anyone got any ideas what I've got wrong?

 

 

Untitled.png

not sure exactly what you are trying to port forward here, but if its the incoming port then you shouldn't be doing this, see Q14:-

https://github.com/binhex/documentation/blob/master/docker/faq/vpn.md

  • Like 1
Link to comment
3 minutes ago, binhex said:

not sure exactly what you are trying to port forward here, but if its the incoming port then you shouldn't be doing this, see Q14:-

I have VPN turned off though.  So I'm just trying to get the incoming rTorrent ports open to the WAN I think.

Link to comment
2 minutes ago, EC28 said:

I have VPN turned off though.  So I'm just trying to get the incoming rTorrent ports open to the WAN I think.

i wouldnt use a range of ports a single port should be sufficient, also make sure pfsense is also creating the Firewall/Rules/WAN, as you need both for the port to be open.

  • Like 1
Link to comment
6 minutes ago, binhex said:

i wouldnt use a range of ports a single port should be sufficient, also make sure pfsense is also creating the Firewall/Rules/WAN, as you need both for the port to be open.

I changed...

network.port_range.set = 7100-7119

...to simply 7100 and ruTorrent wouldn't load with that set.  Changed it back and it loads fine.  Still no luck with opening ports though.

 

My UnRAID IP is 192.168.1.3

This is the NAT port forward rule.  rTorrent alias is port 7100.

 

And the other is the WAN rule.  Still nothing seems to open.  I know it's something silly on my end.

Untitled.png

Untitled2.png

Link to comment
2 minutes ago, EC28 said:

...to simply 7100 and ruTorrent wouldn't load with that set.

you need to set it to the following for a single port:-

7100-7100

your wan rule does not look the same as the port forward nat rule, the wan rule has a alias name of 'rTorrent' for the port, is this alias the same as your port forward nat rule value of '7100-7119' ?

  • Like 1
Link to comment
10 minutes ago, binhex said:

you need to set it to the following for a single port:-

Got that working now, thanks.

 

10 minutes ago, binhex said:

your wan rule does not look the same as the port forward nat rule, the wan rule has a alias name of 'rTorrent' for the port, is this alias the same as your port forward nat rule value of '7100-7119' ?

Must have somehow uploaded an older picture.  It's set to the same now.  Emby pings as open.  So does HTTP/HTTPS.  So weird.  I've tried turning NAT reflection completely off (disabled), tried PureNat, tried NAT + Proxy; doesn't seem to make a difference.

I am curious as to what each port does in the docker settings.  I know 9080 is the webUI, but what do the other ones do?  Is it something with them and pfSense maybe?

 

Untitled.png

Edited by EC28
Link to comment
6 minutes ago, EC28 said:

I am curious as to what each port does in the docker settings.

    -p 9080:9080 = web ui http
    -p 9443:9443 = web ui https
    -p 8118:8118 = privoxy

have you added a port mapping for the container for the incoming port?, you will need to add in the port 7100 for the container, otherwise it cannot get out to the lan.

  • Like 1
Link to comment
4 minutes ago, binhex said:

have you added a port mapping for the container for the incoming port?, you will need to add in the port 7100 for the container, otherwise it cannot get out to the lan.

That did it, thank you so much!  Why I couldn't remember to do that is beyond me.  Just out of curiosity, what is port 5000 for?

Link to comment

Hello i just recently started using this docker but im stuck on this error that wont let me load up the webui i have tried several different servers with the same results heres a copy of my log. 

Quote

ErrorWarningSystemArrayLogin

 

\/ \/ \/ \/ \/

https://hub.docker.com/u/binhex/

 

2020-03-30 21:02:31.652897 [info] System information Linux bef3fe1f8651 4.19.107-Unraid #1 SMP Thu Mar 5 13:55:57 PST 2020 x86_64 GNU/Linux

2020-03-30 21:02:31.688453 [info] PUID defined as '99'

2020-03-30 21:02:31.724955 [info] PGID defined as '100'

2020-03-30 21:02:32.435361 [info] UMASK defined as '000'

2020-03-30 21:02:32.466690 [info] Permissions already set for volume mappings

2020-03-30 21:02:32.501568 [info] VPN_ENABLED defined as 'yes'

2020-03-30 21:02:32.545151 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/Switzerland.ovpn

2020-03-30 21:02:32.603694 [info] VPN remote line defined as 'remote swiss.privateinternetaccess.com 1198'

2020-03-30 21:02:32.635829 [info] VPN_REMOTE defined as 'swiss.privateinternetaccess.com'

2020-03-30 21:02:32.671222 [info] VPN_PORT defined as '1198'

2020-03-30 21:02:32.708889 [info] VPN_PROTOCOL defined as 'udp'

2020-03-30 21:02:32.741055 [info] VPN_DEVICE_TYPE defined as 'tun0'

2020-03-30 21:02:32.772810 [info] VPN_PROV defined as 'pia'

2020-03-30 21:02:32.806709 [info] LAN_NETWORK defined as '192.168.2.0/24'

2020-03-30 21:02:32.842080 [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'

2020-03-30 21:02:32.876989 [info] VPN_USER defined as ‘XXXXXX’

2020-03-30 21:02:32.911684 [info] VPN_PASS defined as ‘XXXXXX’

2020-03-30 21:02:32.946614 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)

2020-03-30 21:02:32.978452 [info] STRICT_PORT_FORWARD defined as 'yes'

2020-03-30 21:02:33.013731 [info] ENABLE_PRIVOXY defined as 'yes'

2020-03-30 21:02:33.045266 [info] ENABLE_AUTODL_IRSSI defined as 'no'

2020-03-30 21:02:33.081364 [info] ENABLE_RPC2 defined as 'yes'

2020-03-30 21:02:33.115225 [info] ENABLE_RPC2_AUTH defined as 'yes'

2020-03-30 21:02:33.150831 [info] RPC2_USER defined as ‘XXXXXX’

2020-03-30 21:02:33.182690 [info] RPC2_PASS defined as ‘XXXXX’

2020-03-30 21:02:33.214718 [info] ENABLE_WEBUI_AUTH defined as 'yes'

2020-03-30 21:02:33.249663 [info] WEBUI_USER defined as ‘XXXXXX’

2020-03-30 21:02:33.281484 [info] WEBUI_PASS defined as ‘XXXXX’

2020-03-30 21:02:33.317021 [info] Deleting files in /tmp (non recursive)...

2020-03-30 21:02:33.348873 [info] Starting Supervisor...

2020-03-30 21:02:33,532 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing

2020-03-30 21:02:33,532 INFO Set uid to user 0 succeeded

2020-03-30 21:02:33,535 INFO supervisord started with pid 6

2020-03-30 21:02:34,538 INFO spawned: 'logrotate-script' with pid 191

2020-03-30 21:02:34,541 INFO spawned: 'pyrocore-script' with pid 192

2020-03-30 21:02:34,543 INFO spawned: 'rutorrent-script' with pid 193

2020-03-30 21:02:34,545 INFO spawned: 'start-script' with pid 194

2020-03-30 21:02:34,547 INFO spawned: 'watchdog-script' with pid 196

2020-03-30 21:02:34,547 INFO reaped unknown pid 7

2020-03-30 21:02:34,554 DEBG 'start-script' stdout output:

[info] VPN is enabled, beginning configuration of VPN

 

2020-03-30 21:02:34,554 INFO success: logrotate-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:02:34,554 INFO success: pyrocore-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:02:34,554 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:02:34,554 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:02:34,555 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:02:34,555 DEBG 'watchdog-script' stdout output:

[info] rTorrent config file already exists, skipping copy

 

2020-03-30 21:02:34,621 DEBG 'start-script' stdout output:

[info] Default route for container is 172.17.0.1

 

2020-03-30 21:02:34,624 DEBG 'start-script' stdout output:

[info] Adding 209.222.18.222 to /etc/resolv.conf

 

2020-03-30 21:02:34,629 DEBG 'start-script' stdout output:

[info] Adding 84.200.69.80 to /etc/resolv.conf

 

2020-03-30 21:02:34,633 DEBG 'start-script' stdout output:

[info] Adding 37.235.1.174 to /etc/resolv.conf

 

2020-03-30 21:02:34,638 DEBG 'start-script' stdout output:

[info] Adding 1.1.1.1 to /etc/resolv.conf

 

2020-03-30 21:02:34,641 DEBG 'start-script' stdout output:

[info] Adding 209.222.18.218 to /etc/resolv.conf

 

2020-03-30 21:02:34,644 DEBG 'start-script' stdout output:

[info] Adding 37.235.1.177 to /etc/resolv.conf

 

2020-03-30 21:02:34,648 DEBG 'start-script' stdout output:

[info] Adding 84.200.70.40 to /etc/resolv.conf

 

2020-03-30 21:02:34,651 DEBG 'start-script' stdout output:

[info] Adding 1.0.0.1 to /etc/resolv.conf

 

2020-03-30 21:02:34,744 DEBG fd 11 closed, stopped monitoring <POutputDispatcher at 22707576895568 for <Subprocess at 22707576894896 with name pyrocore-script in state RUNNING> (stdout)>

2020-03-30 21:02:34,744 DEBG fd 15 closed, stopped monitoring <POutputDispatcher at 22707576340976 for <Subprocess at 22707576894896 with name pyrocore-script in state RUNNING> (stderr)>

2020-03-30 21:02:34,745 INFO exited: pyrocore-script (exit status 0; expected)

2020-03-30 21:02:34,745 DEBG received SIGCHLD indicating a child quit

2020-03-30 21:02:34,865 DEBG 'start-script' stdout output:

[info] Docker network defined as 172.17.0.0/16

 

2020-03-30 21:02:34,870 DEBG 'start-script' stdout output:

[info] Adding 192.168.2.0/24 as route via docker eth0

 

2020-03-30 21:02:34,872 DEBG 'start-script' stdout output:

[info] ip route defined as follows...

--------------------

 

2020-03-30 21:02:34,873 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.4

192.168.2.0/24 via 172.17.0.1 dev eth0

 

2020-03-30 21:02:34,873 DEBG 'start-script' stdout output:

--------------------

 

2020-03-30 21:02:34,877 DEBG 'start-script' stdout output:

iptable_mangle 16384 1

ip_tables 24576 3 iptable_filter,iptable_nat,iptable_mangle

 

2020-03-30 21:02:34,877 DEBG 'start-script' stdout output:

[info] iptable_mangle support detected, adding fwmark for tables

 

2020-03-30 21:02:34,939 DEBG 'start-script' stdout output:

[info] iptables defined as follows...

--------------------

 

2020-03-30 21:02:34,941 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 -i eth0 -p udp -m udp --sport 1198 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --dport 9080 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --sport 9080 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --dport 9443 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --sport 9443 -j ACCEPT

-A INPUT -s 192.168.2.0/24 -i eth0 -p tcp -m tcp --dport 5000 -j ACCEPT

-A INPUT -s 192.168.2.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 INPUT -i 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 9080 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --sport 9080 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --dport 9443 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --sport 9443 -j ACCEPT

-A OUTPUT -d 192.168.2.0/24 -o eth0 -p tcp -m tcp --sport 5000 -j ACCEPT

-A OUTPUT -s 172.17.0.0/16 -d 192.168.2.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

-A OUTPUT -o tun0 -j ACCEPT

 

2020-03-30 21:02:34,942 DEBG 'start-script' stdout output:

--------------------

 

2020-03-30 21:02:34,943 DEBG 'start-script' stdout output:

[info] Starting OpenVPN...

 

2020-03-30 21:02:34,952 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:34 2020 WARNING: file 'credentials.conf' is group or others accessible

 

Mon Mar 30 21:02:34 2020 OpenVPN 2.4.8 [git:makepkg/3976acda9bf10b5e+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Jan 3 2020

Mon Mar 30 21:02:34 2020 library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10

 

2020-03-30 21:02:34,953 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:34 2020 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

 

2020-03-30 21:02:34,954 DEBG 'start-script' stdout output:

[info] OpenVPN started

 

2020-03-30 21:02:34,955 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:34 2020 TCP/UDP: Preserving recently used remote address: [AF_INET]185.230.125.83:1198

 

2020-03-30 21:02:34,955 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:34 2020 UDP link local: (not bound)

Mon Mar 30 21:02:34 2020 UDP link remote: [AF_INET]185.230.125.83:1198

 

2020-03-30 21:02:35,656 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:35 2020 [d512b0050ac2879d17607db22e07fe08] Peer Connection Initiated with [AF_INET]185.230.125.83:1198

 

2020-03-30 21:02:37,049 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:37 2020 TUN/TAP device tun0 opened

Mon Mar 30 21:02:37 2020 /usr/bin/ip link set dev tun0 up mtu 1500

 

2020-03-30 21:02:37,051 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:37 2020 /usr/bin/ip addr add dev tun0 local 10.32.10.6 peer 10.32.10.5

 

2020-03-30 21:02:37,052 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:37 2020 /root/openvpnup.sh tun0 1500 1558 10.32.10.6 10.32.10.5 init

 

2020-03-30 21:02:37,058 DEBG 'start-script' stdout output:

Mon Mar 30 21:02:37 2020 Initialization Sequence Completed

 

2020-03-30 21:02:37,171 DEBG 'start-script' stdout output:

[info] Port forwarding is enabled

[info] Checking endpoint 'swiss.privateinternetaccess.com' is port forward enabled...

 

2020-03-30 21:02:37,174 DEBG 'start-script' stdout output:

[info] Attempting to curl https://www.privateinternetaccess.com/vpninfo/servers?version=82...

 

 

2020-03-30 21:02:38,430 DEBG 'start-script' stdout output:

[info] Curl successful for https://www.privateinternetaccess.com/vpninfo/servers?version=82, response code 200

 

 

2020-03-30 21:02:38,509 DEBG 'start-script' stdout output:

[info] PIA endpoint 'swiss.privateinternetaccess.com' is in the list of endpoints that support port forwarding

 

2020-03-30 21:02:38,509 DEBG 'start-script' stdout output:

[info] List of PIA endpoints that support port forwarding:-

[info] ca-toronto.privateinternetaccess.com

[info] ca-montreal.privateinternetaccess.com

[info] ca-vancouver.privateinternetaccess.com

 

2020-03-30 21:02:38,509 DEBG 'start-script' stdout output:

[info] de-berlin.privateinternetaccess.com

[info] de-frankfurt.privateinternetaccess.com

[info] sweden.privateinternetaccess.com

[info] swiss.privateinternetaccess.com

[info] france.privateinternetaccess.com

[info] czech.privateinternetaccess.com

[info] spain.privateinternetaccess.com

[info] ro.privateinternetaccess.com

[info] israel.privateinternetaccess.com

[info] Attempting to get dynamically assigned port...

 

2020-03-30 21:02:38,515 DEBG 'start-script' stdout output:

[info] Attempting to curl http://209.222.18.222:2000/?client_id=3dcd0bb5d16df927fe37d37a79de4baf523ab7d27b961cb2fa495f02a6e0d977...

 

2020-03-30 21:02:38,694 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...

 

2020-03-30 21:02:48,873 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...

 

2020-03-30 21:02:59,052 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...

 

2020-03-30 21:03:09,228 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...

 

2020-03-30 21:03:17,237 WARN received SIGTERM indicating exit request

2020-03-30 21:03:17,237 DEBG killing watchdog-script (pid 196) with signal SIGTERM

2020-03-30 21:03:17,237 INFO waiting for logrotate-script, rutorrent-script, start-script, watchdog-script to die

2020-03-30 21:03:17,246 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 22707576274752 for <Subprocess at 22707576274704 with name watchdog-script in state STOPPING> (stdout)>

2020-03-30 21:03:17,246 DEBG fd 30 closed, stopped monitoring <POutputDispatcher at 22707576342272 for <Subprocess at 22707576274704 with name watchdog-script in state STOPPING> (stderr)>

2020-03-30 21:03:17,247 INFO stopped: watchdog-script (terminated by SIGTERM)

2020-03-30 21:03:17,247 DEBG received SIGCHLD indicating a child quit

2020-03-30 21:03:17,247 DEBG killing start-script (pid 194) with signal SIGTERM

2020-03-30 21:03:18,248 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 22707576274560 for <Subprocess at 22707576274512 with name start-script in state STOPPING> (stdout)>

2020-03-30 21:03:18,248 DEBG fd 25 closed, stopped monitoring <POutputDispatcher at 22707576341696 for <Subprocess at 22707576274512 with name start-script in state STOPPING> (stderr)>

2020-03-30 21:03:18,248 INFO stopped: start-script (terminated by SIGTERM)

2020-03-30 21:03:18,249 DEBG received SIGCHLD indicating a child quit

2020-03-30 21:03:18,249 DEBG killing rutorrent-script (pid 193) with signal SIGTERM

2020-03-30 21:03:18,339 DEBG fd 16 closed, stopped monitoring <POutputDispatcher at 22707576274368 for <Subprocess at 22707576274320 with name rutorrent-script in state STOPPING> (stdout)>

2020-03-30 21:03:18,339 DEBG fd 20 closed, stopped monitoring <POutputDispatcher at 22707576341408 for <Subprocess at 22707576274320 with name rutorrent-script in state STOPPING> (stderr)>

2020-03-30 21:03:18,339 INFO stopped: rutorrent-script (terminated by SIGTERM)

2020-03-30 21:03:18,339 DEBG received SIGCHLD indicating a child quit

2020-03-30 21:03:19,340 DEBG killing logrotate-script (pid 191) with signal SIGTERM

2020-03-30 21:03:19,425 DEBG fd 8 closed, stopped monitoring <POutputDispatcher at 22707576274896 for <Subprocess at 22707576732592 with name logrotate-script in state STOPPING> (stdout)>

2020-03-30 21:03:19,425 DEBG fd 10 closed, stopped monitoring <POutputDispatcher at 22707576274848 for <Subprocess at 22707576732592 with name logrotate-script in state STOPPING> (stderr)>

2020-03-30 21:03:19,425 INFO stopped: logrotate-script (terminated by SIGTERM)

2020-03-30 21:03:19,425 DEBG received SIGCHLD indicating a child quit

Created by...

___. .__ .__

\_ |__ |__| ____ | |__ ____ ___ ___

| __ \| |/ \| | \_/ __ \\ \/ /

| \_\ \ | | \ Y \ ___/ > <

|___ /__|___| /___| /\___ >__/\_ \

\/ \/ \/ \/ \/

https://hub.docker.com/u/binhex/

 

2020-03-30 21:03:42.490770 [info] System information Linux bef3fe1f8651 4.19.107-Unraid #1 SMP Thu Mar 5 13:55:57 PST 2020 x86_64 GNU/Linux

2020-03-30 21:03:42.538025 [info] PUID defined as '99'

2020-03-30 21:03:42.587041 [info] PGID defined as '100'

2020-03-30 21:03:43.145560 [info] UMASK defined as '000'

2020-03-30 21:03:43.185020 [info] Permissions already set for volume mappings

2020-03-30 21:03:43.222237 [info] VPN_ENABLED defined as 'yes'

2020-03-30 21:03:43.265537 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/Switzerland.ovpn

2020-03-30 21:03:43.332336 [info] VPN remote line defined as 'remote swiss.privateinternetaccess.com 1198'

2020-03-30 21:03:43.370888 [info] VPN_REMOTE defined as 'swiss.privateinternetaccess.com'

2020-03-30 21:03:43.406477 [info] VPN_PORT defined as '1198'

2020-03-30 21:03:43.463884 [info] VPN_PROTOCOL defined as 'udp'

2020-03-30 21:03:43.502765 [info] VPN_DEVICE_TYPE defined as 'tun0'

2020-03-30 21:03:43.539387 [info] VPN_PROV defined as 'pia'

2020-03-30 21:03:43.575486 [info] LAN_NETWORK defined as '192.168.2.0/24'

2020-03-30 21:03:43.632276 [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'

2020-03-30 21:03:43.678428 [info] VPN_USER defined as ‘XXXXXX’

2020-03-30 21:03:43.715264 [info] VPN_PASS defined as ‘XXXXXX’

2020-03-30 21:03:43.762131 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)

2020-03-30 21:03:43.809448 [info] STRICT_PORT_FORWARD defined as 'yes'

2020-03-30 21:03:43.862920 [info] ENABLE_PRIVOXY defined as 'yes'

2020-03-30 21:03:43.913120 [info] ENABLE_AUTODL_IRSSI defined as 'no'

2020-03-30 21:03:43.964928 [info] ENABLE_RPC2 defined as 'yes'

2020-03-30 21:03:44.010446 [info] ENABLE_RPC2_AUTH defined as 'yes'

2020-03-30 21:03:44.063856 [info] RPC2_USER defined as ‘XXXX’

2020-03-30 21:03:44.113907 [info] RPC2_PASS defined as ‘XXXXX’

2020-03-30 21:03:44.150103 [info] ENABLE_WEBUI_AUTH defined as 'yes'

2020-03-30 21:03:44.186391 [info] WEBUI_USER defined as ‘XXXXX’

2020-03-30 21:03:44.222431 [info] WEBUI_PASS defined as ‘XXXXXX’

2020-03-30 21:03:44.266426 [info] Deleting files in /tmp (non recursive)...

2020-03-30 21:03:44.300210 [info] Starting Supervisor...

2020-03-30 21:03:44,495 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing

2020-03-30 21:03:44,495 INFO Set uid to user 0 succeeded

2020-03-30 21:03:44,498 INFO supervisord started with pid 6

2020-03-30 21:03:45,500 INFO spawned: 'logrotate-script' with pid 191

2020-03-30 21:03:45,502 INFO spawned: 'pyrocore-script' with pid 192

2020-03-30 21:03:45,504 INFO spawned: 'rutorrent-script' with pid 193

2020-03-30 21:03:45,506 INFO spawned: 'start-script' with pid 194

2020-03-30 21:03:45,508 INFO spawned: 'watchdog-script' with pid 195

2020-03-30 21:03:45,509 INFO reaped unknown pid 7

2020-03-30 21:03:45,514 DEBG 'start-script' stdout output:

[info] VPN is enabled, beginning configuration of VPN

 

2020-03-30 21:03:45,514 INFO success: logrotate-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:03:45,514 INFO success: pyrocore-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:03:45,514 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:03:45,514 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:03:45,514 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)

2020-03-30 21:03:45,515 DEBG 'watchdog-script' stdout output:

[info] rTorrent config file already exists, skipping copy

 

2020-03-30 21:03:45,582 DEBG 'start-script' stdout output:

[info] Default route for container is 172.17.0.1

 

2020-03-30 21:03:45,586 DEBG 'start-script' stdout output:

[info] Adding 209.222.18.222 to /etc/resolv.conf

 

2020-03-30 21:03:45,589 DEBG 'start-script' stdout output:

[info] Adding 84.200.69.80 to /etc/resolv.conf

 

2020-03-30 21:03:45,593 DEBG 'start-script' stdout output:

[info] Adding 37.235.1.174 to /etc/resolv.conf

 

2020-03-30 21:03:45,596 DEBG 'start-script' stdout output:

[info] Adding 1.1.1.1 to /etc/resolv.conf

 

2020-03-30 21:03:45,600 DEBG 'start-script' stdout output:

[info] Adding 209.222.18.218 to /etc/resolv.conf

 

2020-03-30 21:03:45,604 DEBG 'start-script' stdout output:

[info] Adding 37.235.1.177 to /etc/resolv.conf

 

2020-03-30 21:03:45,607 DEBG 'start-script' stdout output:

[info] Adding 84.200.70.40 to /etc/resolv.conf

 

2020-03-30 21:03:45,610 DEBG 'start-script' stdout output:

[info] Adding 1.0.0.1 to /etc/resolv.conf

 

2020-03-30 21:03:45,723 DEBG fd 11 closed, stopped monitoring <POutputDispatcher at 22455444875344 for <Subprocess at 22455444874672 with name pyrocore-script in state RUNNING> (stdout)>

2020-03-30 21:03:45,723 DEBG fd 15 closed, stopped monitoring <POutputDispatcher at 22455444320752 for <Subprocess at 22455444874672 with name pyrocore-script in state RUNNING> (stderr)>

2020-03-30 21:03:45,723 INFO exited: pyrocore-script (exit status 0; expected)

2020-03-30 21:03:45,723 DEBG received SIGCHLD indicating a child quit

2020-03-30 21:03:50,889 DEBG 'start-script' stdout output:

[info] Docker network defined as 172.17.0.0/16

 

2020-03-30 21:03:50,893 DEBG 'start-script' stdout output:

[info] Adding 192.168.2.0/24 as route via docker eth0

 

2020-03-30 21:03:50,894 DEBG 'start-script' stdout output:

[info] ip route defined as follows...

--------------------

 

2020-03-30 21:03:50,895 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.4

192.168.2.0/24 via 172.17.0.1 dev eth0

 

2020-03-30 21:03:50,895 DEBG 'start-script' stdout output:

--------------------

 

2020-03-30 21:03:50,898 DEBG 'start-script' stdout output:

iptable_mangle 16384 1

ip_tables 24576 3 iptable_filter,iptable_nat,iptable_mangle

 

2020-03-30 21:03:50,898 DEBG 'start-script' stdout output:

[info] iptable_mangle support detected, adding fwmark for tables

 

2020-03-30 21:03:50,953 DEBG 'start-script' stdout output:

[info] iptables defined as follows...

--------------------

 

2020-03-30 21:03:50,954 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 -i eth0 -p udp -m udp --sport 1198 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --dport 9080 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --sport 9080 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --dport 9443 -j ACCEPT

-A INPUT -i eth0 -p tcp -m tcp --sport 9443 -j ACCEPT

-A INPUT -s 192.168.2.0/24 -i eth0 -p tcp -m tcp --dport 5000 -j ACCEPT

-A INPUT -s 192.168.2.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 INPUT -i 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 9080 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --sport 9080 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --dport 9443 -j ACCEPT

-A OUTPUT -o eth0 -p tcp -m tcp --sport 9443 -j ACCEPT

-A OUTPUT -d 192.168.2.0/24 -o eth0 -p tcp -m tcp --sport 5000 -j ACCEPT

-A OUTPUT -s 172.17.0.0/16 -d 192.168.2.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

-A OUTPUT -o tun0 -j ACCEPT

 

2020-03-30 21:03:50,955 DEBG 'start-script' stdout output:

--------------------

 

2020-03-30 21:03:50,956 DEBG 'start-script' stdout output:

[info] Starting OpenVPN...

 

2020-03-30 21:03:50,962 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:50 2020 WARNING: file 'credentials.conf' is group or others accessible

 

Mon Mar 30 21:03:50 2020 OpenVPN 2.4.8 [git:makepkg/3976acda9bf10b5e+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Jan 3 2020

 

2020-03-30 21:03:50,962 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:50 2020 library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10

 

2020-03-30 21:03:50,963 DEBG 'start-script' stdout output:

[info] OpenVPN started

 

2020-03-30 21:03:50,963 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:50 2020 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

 

2020-03-30 21:03:50,964 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:50 2020 TCP/UDP: Preserving recently used remote address: [AF_INET]185.156.175.86:1198

 

2020-03-30 21:03:50,965 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:50 2020 UDP link local: (not bound)

Mon Mar 30 21:03:50 2020 UDP link remote: [AF_INET]185.156.175.86:1198

 

2020-03-30 21:03:51,664 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:51 2020 [511c0a1051df4ad971c965609fb7fec1] Peer Connection Initiated with [AF_INET]185.156.175.86:1198

 

2020-03-30 21:03:51,664 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:51 2020 [511c0a1051df4ad971c965609fb7fec1] Peer Connection Initiated with [AF_INET]185.156.175.86:1198

 

2020-03-30 21:03:53,070 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:53 2020 TUN/TAP device tun0 opened

Mon Mar 30 21:03:53 2020 /usr/bin/ip link set dev tun0 up mtu 1500

 

2020-03-30 21:03:53,071 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:53 2020 /usr/bin/ip addr add dev tun0 local 10.52.10.6 peer 10.52.10.5

 

2020-03-30 21:03:53,073 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:53 2020 /root/openvpnup.sh tun0 1500 1558 10.52.10.6 10.52.10.5 init

 

2020-03-30 21:03:53,081 DEBG 'start-script' stdout output:

Mon Mar 30 21:03:53 2020 Initialization Sequence Completed

 

2020-03-30 21:03:53,195 DEBG 'start-script' stdout output:

[info] Port forwarding is enabled

[info] Checking endpoint 'swiss.privateinternetaccess.com' is port forward enabled...

 

2020-03-30 21:03:53,199 DEBG 'start-script' stdout output:

[info] Attempting to curl https://www.privateinternetaccess.com/vpninfo/servers?version=82...

 

 

2020-03-30 21:03:54,702 DEBG 'start-script' stdout output:

[info] Curl successful for https://www.privateinternetaccess.com/vpninfo/servers?version=82, response code 200

 

 

2020-03-30 21:03:54,793 DEBG 'start-script' stdout output:

[info] PIA endpoint 'swiss.privateinternetaccess.com' is in the list of endpoints that support port forwarding

 

2020-03-30 21:03:54,794 DEBG 'start-script' stdout output:

[info] List of PIA endpoints that support port forwarding:-

[info] ca-toronto.privateinternetaccess.com

[info] ca-montreal.privateinternetaccess.com

[info] ca-vancouver.privateinternetaccess.com

[info] de-berlin.privateinternetaccess.com

[info] de-frankfurt.privateinternetaccess.com

[info] sweden.privateinternetaccess.com

[info] swiss.privateinternetaccess.com

[info] france.privateinternetaccess.com

[info] czech.privateinternetaccess.com

[info] spain.privateinternetaccess.com

[info] ro.privateinternetaccess.com

[info] israel.privateinternetaccess.com

[info] Attempting to get dynamically assigned port...

 

2020-03-30 21:03:54,800 DEBG 'start-script' stdout output:

[info] Attempting to curl http://209.222.18.222:2000/?client_id=708be8b18b915ffd4b3c1296e63a38f8d9eb61c2e987d38b24ebc95b5953e131...

 

2020-03-30 21:03:54,980 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...

 

2020-03-30 21:04:05,156 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 could use some help. I noticed i wasn't able to get into the GUI so I restarted the docker and I'm getting this error: 

 

2020-03-31 02:04:11,055 DEBG 'start-script' stdout output:
[info] List of PIA endpoints that support port forwarding:-
[info] ca-toronto.privateinternetaccess.com
[info] ca-montreal.privateinternetaccess.com
[info] ca-vancouver.privateinternetaccess.com
[info] de-berlin.privateinternetaccess.com
[info] de-frankfurt.privateinternetaccess.com
[info] sweden.privateinternetaccess.com
[info] swiss.privateinternetaccess.com
[info] france.privateinternetaccess.com
[info] czech.privateinternetaccess.com
[info] spain.privateinternetaccess.com
[info] ro.privateinternetaccess.com
[info] israel.privateinternetaccess.com
[info] Attempting to get dynamically assigned port...

2020-03-31 02:04:11,064 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=87c76d3ffe4c6a085d99371d3728a37dc6c81754967ccaf20473e4d376c50715...

2020-03-31 02:04:11,084 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...

2020-03-31 02:04:21,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...

2020-03-31 02:04:31,127 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...

 

Link to comment
4 hours ago, cherritaker said:

2020-03-30 21:03:09,228 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...

if you use pia and you are seeing the above in your log then the issue is that the pia api is down, looks like they are having technical difficulties right now, see here:-

]https://www.reddit.com/r/PrivateInternetAccess/comments/fs7ja0/cant_get_forwarded_port/

 

For now your only option is to set STRICT_PORT_FORWARD to 'no', this will allow you to connect but you will NOT have a working incoming port, so speeds will be slow at best.

 

Just to be clear, there is nothing i can do about this guys, its a vpn provider issue.

 

Edited by binhex
Link to comment

Having issues loading the web UI with VPN enabled - but I think a different issue than the other guys. I did change STRICT_PORT_FORWARD to 'no' as well:
 

Created by...
___. .__ .__
\_ |__ |__| ____ | |__ ____ ___ ___
| __ \| |/ \| | \_/ __ \\ \/ /
| \_\ \ | | \ Y \ ___/ > <
|___ /__|___| /___| /\___ >__/\_ \
\/ \/ \/ \/ \/
https://hub.docker.com/u/binhex/

2020-03-31 09:50:19.766167 [info] System information Linux ff866783be01 4.19.107-Unraid #1 SMP Thu Mar 5 13:55:57 PST 2020 x86_64 GNU/Linux
2020-03-31 09:50:19.790080 [info] PUID defined as '99'
2020-03-31 09:50:19.816530 [info] PGID defined as '100'
2020-03-31 09:50:19.903413 [info] UMASK defined as '000'
2020-03-31 09:50:19.926257 [info] Permissions already set for volume mappings
2020-03-31 09:50:19.952197 [info] VPN_ENABLED defined as 'yes'
2020-03-31 09:50:19.980783 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/CA Montreal.ovpn
2020-03-31 09:50:20.022962 [info] VPN remote line defined as 'remote ca-montreal.privateinternetaccess.com 1198'
2020-03-31 09:50:20.046463 [info] VPN_REMOTE defined as 'ca-montreal.privateinternetaccess.com'
2020-03-31 09:50:20.070006 [info] VPN_PORT defined as '1198'
2020-03-31 09:50:20.097143 [info] VPN_PROTOCOL defined as 'udp'
2020-03-31 09:50:20.125351 [info] VPN_DEVICE_TYPE defined as 'tun0'
2020-03-31 09:50:20.022962 [info] VPN remote line defined as 'remote ca-montreal.privateinternetaccess.com 1198'
2020-03-31 09:50:20.046463 [info] VPN_REMOTE defined as 'ca-montreal.privateinternetaccess.com'
2020-03-31 09:50:20.070006 [info] VPN_PORT defined as '1198'
2020-03-31 09:50:20.097143 [info] VPN_PROTOCOL defined as 'udp'
2020-03-31 09:50:20.125351 [info] VPN_DEVICE_TYPE defined as 'tun0'
2020-03-31 09:50:20.149778 [info] VPN_PROV defined as 'pia'
2020-03-31 09:50:20.173654 [info] LAN_NETWORK defined as '192.168.1.0/24'
2020-03-31 09:50:20.196838 [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'
2020-03-31 09:50:20.219951 [info] VPN_USER defined as 'p2097454'
2020-03-31 09:50:20.244060 [info] VPN_PASS defined as 'Bangarang#860'
2020-03-31 09:50:20.267787 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2020-03-31 09:50:20.292156 [info] STRICT_PORT_FORWARD defined as 'no'
2020-03-31 09:50:20.316153 [info] ENABLE_PRIVOXY defined as 'no'
2020-03-31 09:50:20.341533 [info] ENABLE_AUTODL_IRSSI defined as 'no'
2020-03-31 09:50:20.368737 [info] ENABLE_RPC2 defined as 'yes'
2020-03-31 09:50:20.393193 [info] ENABLE_RPC2_AUTH defined as 'yes'
2020-03-31 09:50:20.417318 [info] RPC2_USER defined as 'admin'
2020-03-31 09:50:20.441489 [info] RPC2_PASS defined as 'bangarang'
2020-03-31 09:50:20.465158 [info] ENABLE_WEBUI_AUTH defined as 'yes'
2020-03-31 09:50:20.489215 [info] WEBUI_USER defined as 'admin'
2020-03-31 09:50:20.513545 [info] WEBUI_PASS defined as 'bangarang'
2020-03-31 09:50:20.541256 [info] Deleting files in /tmp (non recursive)...
2020-03-31 09:50:20.568077 [info] Starting Supervisor...
2020-03-31 09:50:20,706 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2020-03-31 09:50:20,707 INFO Set uid to user 0 succeeded
2020-03-31 09:50:20,709 INFO supervisord started with pid 6
2020-03-31 09:50:21,711 INFO spawned: 'logrotate-script' with pid 191
2020-03-31 09:50:21,712 INFO spawned: 'pyrocore-script' with pid 192
2020-03-31 09:50:21,714 INFO spawned: 'rutorrent-script' with pid 193
2020-03-31 09:50:21,716 INFO spawned: 'start-script' with pid 194
2020-03-31 09:50:21,718 INFO spawned: 'watchdog-script' with pid 195
2020-03-31 09:50:21,718 INFO reaped unknown pid 7
2020-03-31 09:50:21,726 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN

2020-03-31 09:50:21,726 INFO success: logrotate-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2020-03-31 09:50:21,726 INFO success: pyrocore-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2020-03-31 09:50:21,727 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2020-03-31 09:50:21,727 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2020-03-31 09:50:21,727 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2020-03-31 09:50:21,736 DEBG 'watchdog-script' stdout output:
[info] rTorrent config file already exists, skipping copy

2020-03-31 09:50:21,762 DEBG 'start-script' stdout output:
[warn] Password contains characters which could cause authentication issues, please consider changing this if possible

2020-03-31 09:50:21,831 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1

2020-03-31 09:50:21,839 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.222 to /etc/resolv.conf

2020-03-31 09:50:21,849 DEBG 'start-script' stdout output:
[info] Adding 84.200.69.80 to /etc/resolv.conf

2020-03-31 09:50:21,859 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf

2020-03-31 09:50:21,863 DEBG 'start-script' stdout output:
[info] Adding 1.1.1.1 to /etc/resolv.conf

2020-03-31 09:50:21,869 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf

2020-03-31 09:50:21,872 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf

2020-03-31 09:50:21,876 DEBG 'start-script' stdout output:
[info] Adding 84.200.70.40 to /etc/resolv.conf

2020-03-31 09:50:21,879 DEBG 'start-script' stdout output:
[info] Adding 1.0.0.1 to /etc/resolv.conf

2020-03-31 09:50:21,943 DEBG fd 11 closed, stopped monitoring <POutputDispatcher at 23367280801824 for <Subprocess at 23367280801152 with name pyrocore-script in state RUNNING> (stdout)>
2020-03-31 09:50:21,943 DEBG fd 15 closed, stopped monitoring <POutputDispatcher at 23367280247232 for <Subprocess at 23367280801152 with name pyrocore-script in state RUNNING> (stderr)>
2020-03-31 09:50:21,944 INFO exited: pyrocore-script (exit status 0; expected)
2020-03-31 09:50:21,944 DEBG received SIGCHLD indicating a child quit
2020-03-31 09:50:22,029 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2020-03-31 09:50:22,030 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.19.107-Unraid

2020-03-31 09:50:22,030 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2020-03-31 09:50:22,031 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2020-03-31 09:50:22,031 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'

2020-03-31 09:50:22,046 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16

2020-03-31 09:50:22,049 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0

2020-03-31 09:50:22,050 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2020-03-31 09:50:22,050 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.3
192.168.1.0/24 via 172.17.0.1 dev eth0

2020-03-31 09:50:22,051 DEBG 'start-script' stdout output:
--------------------

2020-03-31 09:50:22,087 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2020-03-31 09:50:22,088 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 -i eth0 -p udp -m udp --sport 1198 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 9080 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 9080 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 9443 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 9443 -j ACCEPT
-A INPUT -s 192.168.1.0/24 -i eth0 -p tcp -m tcp --dport 5000 -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 -o eth0 -p udp -m udp --dport 1198 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 9080 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 9080 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 9443 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 9443 -j ACCEPT
-A OUTPUT -d 192.168.1.0/24 -o eth0 -p tcp -m tcp --sport 5000 -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

2020-03-31 09:50:22,089 DEBG 'start-script' stdout output:
--------------------

2020-03-31 09:50:22,089 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2020-03-31 09:50:22,095 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 WARNING: file 'credentials.conf' is group or others accessible
Tue Mar 31 09:50:22 2020 OpenVPN 2.4.8 [git:makepkg/3976acda9bf10b5e+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Jan 3 2020
Tue Mar 31 09:50:22 2020 library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10

2020-03-31 09:50:22,096 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2020-03-31 09:50:22,096 DEBG 'start-script' stdout output:
[info] OpenVPN started

2020-03-31 09:50:22,097 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 TCP/UDP: Preserving recently used remote address: [AF_INET]199.229.249.133:1198
Tue Mar 31 09:50:22 2020 UDP link local: (not bound)
Tue Mar 31 09:50:22 2020 UDP link remote: [AF_INET]199.229.249.133:1198

2020-03-31 09:50:22,174 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 [1efa38b575bce4902f9b13da368c8624] Peer Connection Initiated with [AF_INET]199.229.249.133:1198

2020-03-31 09:50:22,029 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2020-03-31 09:50:22,030 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.19.107-Unraid

2020-03-31 09:50:22,030 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2020-03-31 09:50:22,031 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2020-03-31 09:50:22,031 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'

2020-03-31 09:50:22,046 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16

2020-03-31 09:50:22,049 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0

2020-03-31 09:50:22,050 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2020-03-31 09:50:22,050 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.3
192.168.1.0/24 via 172.17.0.1 dev eth0

2020-03-31 09:50:22,051 DEBG 'start-script' stdout output:
--------------------

2020-03-31 09:50:22,087 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2020-03-31 09:50:22,088 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 -i eth0 -p udp -m udp --sport 1198 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 9080 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 9080 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 9443 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 9443 -j ACCEPT
-A INPUT -s 192.168.1.0/24 -i eth0 -p tcp -m tcp --dport 5000 -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 -o eth0 -p udp -m udp --dport 1198 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 9080 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 9080 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 9443 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 9443 -j ACCEPT
-A OUTPUT -d 192.168.1.0/24 -o eth0 -p tcp -m tcp --sport 5000 -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

2020-03-31 09:50:22,089 DEBG 'start-script' stdout output:
--------------------

2020-03-31 09:50:22,089 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2020-03-31 09:50:22,095 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 WARNING: file 'credentials.conf' is group or others accessible
Tue Mar 31 09:50:22 2020 OpenVPN 2.4.8 [git:makepkg/3976acda9bf10b5e+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Jan 3 2020
Tue Mar 31 09:50:22 2020 library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10

2020-03-31 09:50:22,096 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2020-03-31 09:50:22,096 DEBG 'start-script' stdout output:
[info] OpenVPN started

2020-03-31 09:50:22,097 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 TCP/UDP: Preserving recently used remote address: [AF_INET]199.229.249.133:1198
Tue Mar 31 09:50:22 2020 UDP link local: (not bound)
Tue Mar 31 09:50:22 2020 UDP link remote: [AF_INET]199.229.249.133:1198

2020-03-31 09:50:22,174 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:22 2020 [1efa38b575bce4902f9b13da368c8624] Peer Connection Initiated with [AF_INET]199.229.249.133:1198

2020-03-31 09:50:28,456 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:28 2020 TUN/TAP device tun0 opened
Tue Mar 31 09:50:28 2020 /usr/bin/ip link set dev tun0 up mtu 1500

2020-03-31 09:50:28,458 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:28 2020 /usr/bin/ip addr add dev tun0 local 10.13.11.10 peer 10.13.11.9

2020-03-31 09:50:28,459 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:28 2020 /root/openvpnup.sh tun0 1500 1558 10.13.11.10 10.13.11.9 init

2020-03-31 09:50:28,466 DEBG 'start-script' stdout output:
Tue Mar 31 09:50:28 2020 Initialization Sequence Completed

2020-03-31 09:50:28,579 DEBG 'start-script' stdout output:
[info] Port forwarding is not enabled

2020-03-31 09:50:28,579 DEBG 'start-script' stdout output:
[info] Checking we can resolve name 'www.google.com' to address...

2020-03-31 09:50:28,693 DEBG 'start-script' stdout output:
[info] DNS operational, we can resolve name 'www.google.com' to address '172.217.22.36'

2020-03-31 09:50:28,695 DEBG 'start-script' stdout output:
[info] Attempting to get external IP using Name Server 'ns1.google.com'...

2020-03-31 09:50:28,872 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 199.229.249.133

2020-03-31 09:50:28,958 DEBG 'watchdog-script' stdout output:
[info] rTorrent listening interface IP 0.0.0.0 and VPN provider IP 10.13.11.10 different, marking for reconfigure

2020-03-31 09:50:28,961 DEBG 'watchdog-script' stdout output:
[info] rTorrent not running

2020-03-31 09:50:28,962 DEBG 'watchdog-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2020-03-31 09:50:28,963 DEBG 'watchdog-script' stdout output:
[info] Attempting to start rTorrent...

2020-03-31 09:50:28,964 DEBG 'watchdog-script' stdout output:
Script started, output log file is '/home/nobody/typescript'.

2020-03-31 09:50:28,985 DEBG 'watchdog-script' stdout output:
Script done.

2020-03-31 09:50:29,098 DEBG 'rutorrent-script' stdout output:
[info] rtorrent started, setting up rutorrent...

2020-03-31 09:50:29,099 DEBG 'rutorrent-script' stdout output:
[info] Setting PHP timezone to UTC...

2020-03-31 09:50:29,102 DEBG 'rutorrent-script' stdout output:
[info] nginx cert files already exists, skipping copy

2020-03-31 09:50:29,103 DEBG 'rutorrent-script' stdout output:
[info] nginx config file already exists, skipping copy

2020-03-31 09:50:29,104 DEBG 'rutorrent-script' stdout output:
[info] rutorrent conf folder already exists, skipping copy

2020-03-31 09:50:29,106 DEBG 'rutorrent-script' stdout output:
"python" => '/usr/bin/python', // Something like /usr/bin/python. If empty, will be found in PATH.

2020-03-31 09:50:29,113 DEBG 'rutorrent-script' stdout output:
[info] running rsync to copy rutorrent user plugins to the plugins folder inside the container...

2020-03-31 09:50:29,114 DEBG 'rutorrent-script' stderr output:
This rsync lacks old-style --compress due to its external zlib. Try -zz.
Continuing without compression.


2020-03-31 09:50:29,116 DEBG 'rutorrent-script' stdout output:
sending incremental file list

2020-03-31 09:50:29,117 DEBG 'rutorrent-script' stdout output:
README.txt

2020-03-31 09:50:29,117 DEBG 'rutorrent-script' stdout output:
theme/themes/README.txt

2020-03-31 09:50:29,118 DEBG 'rutorrent-script' stdout output:

sent 494 bytes received 64 bytes 1.12K bytes/sec
total size is 237 speedup is 0.42

2020-03-31 09:50:29,119 DEBG 'rutorrent-script' stdout output:
[info] rutorrent share folder already exists, skipping copy

2020-03-31 09:50:29,120 DEBG 'rutorrent-script' stdout output:
[info] nginx /rpc2 location enabled

2020-03-31 09:50:29,127 DEBG 'rutorrent-script' stdout output:
[info] Updating password for rpc2 account 'admin'...

2020-03-31 09:50:29,128 DEBG 'rutorrent-script' stderr output:


2020-03-31 09:50:29,128 DEBG 'rutorrent-script' stderr output:
password for user admin

2020-03-31 09:50:29,135 DEBG 'rutorrent-script' stdout output:
[info] Updating password for web ui account 'admin'...

2020-03-31 09:50:29,137 DEBG 'rutorrent-script' stderr output:


2020-03-31 09:50:29,137 DEBG 'rutorrent-script' stderr output:
password for user admin

2020-03-31 09:50:29,137 DEBG 'rutorrent-script' stdout output:
[info] starting php-fpm...

2020-03-31 09:50:29,169 DEBG 'rutorrent-script' stderr output:
[NOTICE] [pool www] 'user' directive is ignored when FPM is not running as root
[NOTICE] [pool www] 'group' directive is ignored when FPM is not running as root

2020-03-31 09:50:29,173 DEBG 'rutorrent-script' stdout output:
[info] starting nginx...

2020-03-31 09:50:29,995 DEBG 'watchdog-script' stdout output:
[info] rTorrent process started
[info] Waiting for rTorrent process to start listening on port 5000...

2020-03-31 09:50:30,002 DEBG 'watchdog-script' stdout output:
[info] rTorrent process listening on port 5000
[info] Initialising ruTorrent plugins (checking rTorrent is running)...

2020-03-31 09:50:30,007 DEBG 'watchdog-script' stdout output:
[info] rTorrent running
[info] Initialising ruTorrent plugins (checking nginx is running)...

2020-03-31 09:50:30,013 DEBG 'watchdog-script' stdout output:
[info] nginx running
[info] Initialising ruTorrent plugins...

2020-03-31 09:50:30,103 DEBG 'watchdog-script' stdout output:


2020-03-31 09:50:30,135 DEBG 'watchdog-script' stdout output:
[info] ruTorrent plugins initialised

2020-03-31 09:50:30,002 DEBG 'watchdog-script' stdout output:
[info] rTorrent process listening on port 5000
[info] Initialising ruTorrent plugins (checking rTorrent is running)...

2020-03-31 09:50:30,007 DEBG 'watchdog-script' stdout output:
[info] rTorrent running
[info] Initialising ruTorrent plugins (checking nginx is running)...

2020-03-31 09:50:30,013 DEBG 'watchdog-script' stdout output:
[info] nginx running
[info] Initialising ruTorrent plugins...

2020-03-31 09:50:30,103 DEBG 'watchdog-script' stdout output:


2020-03-31 09:50:30,135 DEBG 'watchdog-script' stdout output:
[info] ruTorrent plugins initialised

 

Link to comment

Nvm i see above its a PIA issue. I guess we just have to wait then?

 

Ive been running this docker for the past few months with no issues. today is decided to change the webui and RPC2 and WEBUI username and passwords. As soon as I restarted the docker, i was unable to log into the webUI. removed the docker and reinstalled and restarted the server a couple times. after doing so i enabled debug and have attached the supervisor.log here.

 

i keep getting this error:

 

2020-03-31 16:43:14,046 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...

 

Please help me get this running again. thank you.

 

supervisord.log

 

Edited by slyk
Link to comment
  • binhex locked this topic
Guest
This topic is now closed to further replies.