[Support] binhex - rTorrentVPN

Spies · January 25, 2019

23 hours ago, Spies said:

I've added an 2TB drive dedicated to torrents using unassigned devices, will see how it goes!

Run into the same issue again, rtorrent is still running but I'm getting no throughput at all and it fails to resolve any of the trackers.

Yet privoxy via the browser is still working.

Caught the crash whilst trying to stop a large number of torrents:

1548423482 C Caught internal_error: 'TrackerController cannot set timeout when inactive.'.
---DUMP---
/usr/lib/libtorrent.so.20(_ZN7torrent14internal_error10initializeERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0x24f) [0x153c1bc5051f]
/usr/bin/rtorrent(_ZN7torrent14internal_errorC1EPKc+0x8f) [0x55d9fe6147ff]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController14update_timeoutEj+0x345) [0x153c1bc6ebe5]
/usr/bin/rtorrent(+0x10031a) [0x55d9fe69031a]
/usr/bin/rtorrent(+0x1076df) [0x55d9fe6976df]
/usr/lib/libtorrent.so.20(+0xc9d81) [0x153c1bcdbd81]
/usr/lib/libtorrent.so.20(+0x3a9de) [0x153c1bc4c9de]
/usr/lib/libtorrent.so.20(_ZN7torrent11thread_base10event_loopEPS0_+0x164) [0x153c1bca3424]
/usr/bin/rtorrent(+0x36a15) [0x55d9fe5c6a15]
/usr/lib/libc.so.6(__libc_start_main+0xf3) [0x153c1b87c223]
/usr/bin/rtorrent(+0x372fe) [0x55d9fe5c72fe]

---END---

Seems to change slightly in subsequent crashes.

---DUMP---
/usr/lib/libtorrent.so.20(_ZN7torrent14internal_error10initializeERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0x24f) [0x14c0586fc51f]
/usr/bin/rtorrent(_ZN7torrent14internal_errorC1EPKc+0x8f) [0x560102ca47ff]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController14update_timeoutEj+0x345) [0x14c05871abe5]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController10do_timeoutEv+0x236) [0x14c05871b326]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController15receive_failureEPNS_7TrackerERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0x29) [0x14c05871b539]
/usr/lib/libtorrent.so.20(_ZN7torrent11TrackerList14receive_failedEPNS_7TrackerERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0xe0) [0x14c05871c250]
/usr/lib/libtorrent.so.20(+0xfed98) [0x14c0587bcd98]
/usr/lib/libtorrent.so.20(+0x3b6ef) [0x14c0586f96ef]
/usr/lib/libtorrent.so.20(+0x3be09) [0x14c0586f9e09]
/usr/lib/libtorrent.so.20(+0xfcc96) [0x14c0587bac96]
/usr/lib/libtorrent.so.20(+0xfdc5b) [0x14c0587bbc5b]
/usr/lib/libtorrent.so.20(_ZN7torrent11TrackerList10send_stateEPNS_7TrackerEi+0x50) [0x14c05871bcb0]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController10do_timeoutEv+0x213) [0x14c05871b303]
/usr/lib/libtorrent.so.20(_ZN7torrent17TrackerController15receive_failureEPNS_7TrackerERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0x29) [0x14c05871b539]
/usr/lib/libtorrent.so.20(_ZN7torrent11TrackerList14receive_failedEPNS_7TrackerERKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEE+0xe0) [0x14c05871c250]
/usr/lib/libtorrent.so.20(+0xfed98) [0x14c0587bcd98]
/usr/lib/libtorrent.so.20(+0x3b6ef) [0x14c0586f96ef]
/usr/lib/libtorrent.so.20(+0x3be09) [0x14c0586f9e09]
/usr/lib/libtorrent.so.20(+0xfcc96) [0x14c0587bac96]
/usr/lib/libtorrent.so.20(+0xfdc5b) [0x14c0587bbc5b]

---END---

Edited January 25, 2019 by Spies

DavidAUK · January 25, 2019

Quote

1. do you use vlan's on your home network? - if so then check that the vlan assigned to the host allows inbound and outbound external access and the routing is correct.

Not as far as I know. I have it working fine on a Synology which shares the same network.

Quote

2. is a firewall running on your host? - check to see if anything is blocking outbound on the host, if you are running all the containers on the same host and you have external access to them, then this wont be the issue.

I'm running non-VPN containers and remotely connecting to them without problems on the same device.

Quote

3. does 192.168.86.0/24 cover all networks on your lan? - if it doesn't then you will need to add in any additional networks you have defined, what is your router's ip address?

The IP addresses are 192.168.86.* The router's IP address is 192.168.86.1.

Quote

4. port forwarding - can you post a screenshot showing how you have defined the port forward for this container?, it should be port forward to internal ip 192.168.86.xxx where xxx is your hosts ip, and port <host port you have chosen for flood, normally 3000>

I've attached a screenshot showing the port forwarding I'm using and a log file with debug enabled. After your post I noticed that I was setting debug to true but then false later in the YML - sorry about that.

To recap, neither DelugeVPN or rTorrentVPN can be accessed remotely. Both can be accessed locally. I previously had these containers running on a Synology on the same network, so I'm inclined to say it's not my network. Ports are correctly forwarded, as far as I can see. This is the first time I'm running on Ubuntu Server, so perhaps I've set something incorrectly there.

I assume that the IP I should be connecting to is the same as my WAN IP? That's what I did successfully on the Synology.

supervisord.log

Edited January 26, 2019 by DavidAUK
Re=uploaded log file.

DavidAUK · January 25, 2019

And I don't know if it provides a clue or not, but when I'm on the home LAN and use the WAN IP on the VPN containers then everything works fine. That would suggest that I have the right IP and ports at least.

Also, online port forward testers think that my the ports on my VPN containers are closed.

Edited January 25, 2019 by DavidAUK

DavidAUK · January 26, 2019

Re-uploaded the log file. iptable_mangle seems to be working but still no success accessing rtorrentvpn on delugevpn remotely.

Edited January 26, 2019 by DavidAUK

binhex · January 27, 2019

Re-uploaded the log file. iptable_mangle seems to be working but still no success accessing rtorrentvpn on delugevpn remotely.

Ok so I suspect it's probably a firewall on the host then I think you mentioned that your running Ubuntu so do some googling around that as I think it may be blocking external incoming connections.

Sent from my EML-L29 using Tapatalk

John Jensen · January 28, 2019

Hi binhex.. first, i am a happy user of your rutorrent-vpn.. i have used it very much - and very stable..
Buuut, the last few days, i am getting "Port status unknown" inside the GUI right down corner - i havent changed anything and using PIA swiss.. what could have happened ?

Thanks, John

Edited January 28, 2019 by John Jensen
forgot something

DavidAUK · January 28, 2019

On 1/27/2019 at 9:55 AM, binhex said:

Ok so I suspect it's probably a firewall on the host

I don't think it's a firewall as UFW is disabled and non-VPN containers work fine. But I agree that it's likely something on the host. Yes, it's Ubuntu Server 18.04.1 LTS with a default install and very little installed that would clash with these containers. I've spent many hours trying to diagnose this, so while it's certainly something that's caused by the combination of my operating system and this container, any pointers would be appreciated.

Here's what I've worked out.

Ports are open and forwarded on the router, which is google wifi.
Remote access to non-VPN containers (e.g. Portainer) works fine.
Remote access to VPN container's WebUIs (e.g. Flood, Rutorrent, Deluge) all fail. ERR_CONNECTION_TIMED_OUT in Chrome.
Rutorrent shows the listening port status as unknown - likely blocked.
Haugene/docker-transmission-openvpn also has a blocked listening port - problem not unique to binhex builds?
Remote access to VPN container's WebUIs works fine if I use traefik reverse proxy. Doesn't help the listening port though. Currently disabled.
RtorrentVPN and DelugeVPN work without problem on my Synology NAS on the same network.
Changing from the default ports makes no difference.

Since non-VPN containers work fine and the issue is present in Haugene and your containers, I wonder if the issue might be related to OpenVPN?

Is there anything I can do that would give more diagnostic information? Some kind of netstat? Would a 100% fresh install of Ubuntu help?

Ritt · January 28, 2019

10 hours ago, John Jensen said:

Hi binhex.. first, i am a happy user of your rutorrent-vpn.. i have used it very much - and very stable..
Buuut, the last few days, i am getting "Port status unknown" inside the GUI right down corner - i havent changed anything and using PIA swiss.. what could have happened ?

Thanks, John

Hi! I have the same problem but I am using AirVPN. The port is forwared in AirVPN. On most (but not all of them!) trackers I get the message:

Failed to add torrent. Can't retrieve URL.

I have googled the problem and it seems to be a problem with curl & https?

Niklas · January 28, 2019

12 hours ago, John Jensen said:

Hi binhex.. first, i am a happy user of your rutorrent-vpn.. i have used it very much - and very stable..
Buuut, the last few days, i am getting "Port status unknown" inside the GUI right down corner - i havent changed anything and using PIA swiss.. what could have happened ?

Thanks, John

Same here. Using another server with port forwarding.

Running 6.7 RC2.

Edited January 28, 2019 by Niklas

Ritt · January 29, 2019

8 hours ago, Niklas said:

Same here. Using another server with port forwarding.

Running 6.7 RC2.

Do you have same problem as me? See above

binhex · January 29, 2019

10 hours ago, Niklas said:

i am getting "Port status unknown" inside the GUI right down corner - i havent changed anything and using PIA swiss.. what could have happened ?

ive seen the port forward rutorrent plugin sometimes just stop working over time, a restart of the container normally fixes this, but it is cosmetic, the port forward is most probably working just fine, if a reboot doesnt fix it then chances are the website the port forward rutorrent plugin references is either down or blocking connection, again its only a cosmetic problem this does NOT affect the port forwarding function built into the image.

Niklas · January 29, 2019

3 hours ago, binhex said:

ive seen the port forward rutorrent plugin sometimes just stop working over time, a restart of the container normally fixes this, but it is cosmetic, the port forward is most probably working just fine, if a reboot doesnt fix it then chances are the website the port forward rutorrent plugin references is either down or blocking connection, again its only a cosmetic problem this does NOT affect the port forwarding function built into the image.

Ah, yeah. Sounds about right. Thanks.

Niklas · January 29, 2019

5 hours ago, Ritt said:

Do you have same problem as me? See above

I use PIA so I don't think so but the same may apply to you.

nekromantik · January 29, 2019

People who used both this and DelugeVPN, which torrent client do you prefer?

RTorrent or Deluge?

plantsandbinary · January 30, 2019

After the last update I keep getting 'Port status unknown' from ruTorrent UI.

Here's a log: [EDIT. I saw someone else asked about it, NVM.]

Edited January 30, 2019 by plantsandbinary

DavidAUK · January 30, 2019

On 1/29/2019 at 9:50 PM, nekromantik said:

People who used both this and DelugeVPN, which torrent client do you prefer?

RTorrent or Deluge?

I’m not an expert but my understanding is that rtorrent let’s you seed more files at once than Deluge. I’ve heard people seeding 1000 torrents in rtorrent.

The plugin system of Deluge is great although a little more geared for desktop users as a lot of them don’t have a webui and need to be operated through thin client, which is a bit painful.

The binhex container of rtorrent comes with two interfaces: rutorrent and Flood. The latter looks modern and clean compared with rutorrent and Deluge. You might also want to take a look at the material design of the combustion interface for Transmission.

Deluge works well with Sonarr, offering some functionality that isn’t present in other clients.

blacksad · February 6, 2019

Hello,

I try to make rtorrentvpn running.

My VPN is connected with an open port, but rtorrent doesn't look listening port 5000.

Here is my log with debug enabled:

blacksad@CHRONOS:~$ sudo docker run \
    -v /root/docker/data:/data \
    -v /root/docker/config:/config \
>     --cap-add=NET_ADMIN \
>     -p 9080:9080 \
>     -p 9443:9443 \
>     -p 8118:8118 \
>     -p 3000:3000 \
>     --name=rtorrentvpn \
    -e LAN_NETWORK=192.168.2.0/24 \
>     -v /root/docker/data:/data \
>     -v /root/docker/config:/config \
>     -v /etc/localtime:/etc/localtime:ro \
>     -e VPN_ENABLED=yes \
>     -e VPN_USER=pwd \
>     -e VPN_PASS=user \
>     -e VPN_PROV=pia \
>     -e STRICT_PORT_FORWARD=yes \
>     -e ENABLE_PRIVOXY=no \
>     -e ENABLE_FLOOD=no \
>     -e ENABLE_AUTODL_IRSSI=no \
>     -e LAN_NETWORK=192.168.2.0/24 \
>     -e NAME_SERVERS=209.222.18.222,37.235.1.174,1.1.1.1,8.8.8.8,209.222.18.218,37.235.1.177,1.0.0.1,8.8.4.4 \
>     -e DEBUG=true \
>     -e PHP_TZ=UTC \
>     -e UMASK=0022 \
>     -e PUID=1000 \
>     -e PGID=1000 \
>     binhex/arch-rtorrentvpn
Created by...
___.   .__       .__
\_ |__ |__| ____ |  |__   ____ ___  ___
 | __ \|  |/    \|  |  \_/ __ \\  \/  /
 | \_\ \  |   |  \   Y  \  ___/ >    <
 |___  /__|___|  /___|  /\___  >__/\_ \
     \/        \/     \/     \/      \/
   https://hub.docker.com/u/binhex/

2019-02-05 20:16:26.221588 [info] System information Linux ec09e4a50cc4 4.15.0-45-generic #48-Ubuntu SMP Tue Jan 29 16:28:13                                                                                                                                 UTC 2019 x86_64 GNU/Linux
2019-02-05 20:16:26.241275 [info] PUID defined as '1000'
2019-02-05 20:16:26.363886 [info] PGID defined as '1000'
2019-02-05 20:16:26.418681 [info] UMASK defined as '0022'
2019-02-05 20:16:26.437622 [info] Permissions already set for volume mappings
2019-02-05 20:16:26.459599 [info] VPN_ENABLED defined as 'yes'
2019-02-05 20:16:26.481506 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/CA Montreal.ovpn
dos2unix: converting file /config/openvpn/CA Montreal.ovpn to Unix format...
2019-02-05 20:16:26.509750 [info] VPN remote line defined as 'remote ca-montreal.privateinternetaccess.com 1198'
2019-02-05 20:16:26.528986 [info] VPN_REMOTE defined as 'ca-montreal.privateinternetaccess.com'
2019-02-05 20:16:26.548609 [info] VPN_PORT defined as '1198'
2019-02-05 20:16:26.570129 [info] VPN_PROTOCOL defined as 'udp'
2019-02-05 20:16:26.589802 [info] VPN_DEVICE_TYPE defined as 'tun0'
2019-02-05 20:16:26.608919 [info] VPN_PROV defined as 'pia'
2019-02-05 20:16:26.628019 [info] LAN_NETWORK defined as '192.168.2.0/24'
2019-02-05 20:16:26.647444 [info] NAME_SERVERS defined as '209.222.18.222,37.235.1.174,1.1.1.1,8.8.8.8,209.222.18.218,37.235.                                                                                                                                1.177,1.0.0.1,8.8.4.4'
2019-02-05 20:16:26.668127 [info] VPN_USER defined as 'pwd'
2019-02-05 20:16:26.687321 [info] VPN_PASS defined as 'user'
2019-02-05 20:16:26.706802 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2019-02-05 20:16:26.726158 [info] STRICT_PORT_FORWARD defined as 'yes'
2019-02-05 20:16:26.745838 [info] ENABLE_PRIVOXY defined as 'no'
2019-02-05 20:16:26.765190 [info] ENABLE_FLOOD defined as 'no'
2019-02-05 20:16:26.784347 [info] ENABLE_AUTODL_IRSSI defined as 'no'
2019-02-05 20:21:28.088216 [info] Starting Supervisor...
2019-02-05 20:21:28,263 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2019-02-05 20:21:28,263 INFO Set uid to user 0 succeeded
2019-02-05 20:21:28,264 INFO supervisord started with pid 8
2019-02-05 20:21:29,267 INFO spawned: 'start-script' with pid 153
2019-02-05 20:21:29,267 INFO spawned: 'rutorrent-script' with pid 154
2019-02-05 20:21:29,268 INFO spawned: 'flood-script' with pid 155
2019-02-05 20:21:29,268 INFO spawned: 'irssi-script' with pid 156
2019-02-05 20:21:29,269 INFO spawned: 'watchdog-script' with pid 157
2019-02-05 20:21:29,270 INFO spawned: 'privoxy-script' with pid 158
2019-02-05 20:21:29,270 INFO reaped unknown pid 9
2019-02-05 20:21:29,271 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN
[debug] Environment variables defined as follows
BASH=/bin/bash
BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:pro                                                                                                                                gcomp:promptvars:sourcepath
BASH_ALIASES=()
BASH_ARGC=()
BASH_ARGV=()
BASH_CMDS=()
BASH_LINENO=([0]="0")
BASH_SOURCE=([0]="/root/start.sh")
BASH_VERSINFO=([0]="5" [1]="0" [2]="0" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu")
BASH_VERSION='5.0.0(1)-release'
DEBUG=true
DIRSTACK=()
ENABLE_AUTODL_IRSSI=no
ENABLE_FLOOD=no
ENABLE_PRIVOXY=no
EUID=0
GROUPS=()
HOME=/home/nobody
HOSTNAME=ec09e4a50cc4
HOSTTYPE=x86_64
IFS=$' \t\n'
LANG=en_GB.UTF-8
LAN_NETWORK=192.168.2.0/24
MACHTYPE=x86_64-pc-linux-gnu
NAME_SERVERS=209.222.18.222,37.235.1.174,1.1.1.1,8.8.8.8,209.222.18.218,37.235.1.177,1.0.0.1,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
PHP_TZ=UTC
PIPESTATUS=([0]="0")
PPID=8
PS4='+ '
PUID=1000
PWD=/
SHELL=/bin/bash
SHELLOPTS=braceexpand:hashall:interactive-comments
SHLVL=1
STRICT_PORT_FORWARD=yes
SUPERVISOR_ENABLED=1
SUPERVISOR_GROUP_NAME=start-script
SUPERVISOR_PROCESS_NAME=start-script
TERM=xterm
UID=0
UMASK=0022
VPN_CONFIG='/config/openvpn/CA Montreal.ovpn'
VPN_DEVICE_TYPE=tun0
VPN_ENABLED=yes
VPN_OPTIONS=
VPN_PASS=user
VPN_PORT=1198
VPN_PROTOCOL=udp
VPN_PROV=pia
VPN_REMOTE=ca-montreal.privateinternetaccess.com
VPN_USER=pwd
_='[debug] Environment variables defined as follows'

2019-02-05 20:21:29,271 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startse                                                                                                                                cs)
2019-02-05 20:21:29,271 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (sta                                                                                                                                rtsecs)
2019-02-05 20:21:29,272 INFO success: flood-script entered RUNNING state, process has stayed up for > than 0 seconds (startse                                                                                                                                cs)
2019-02-05 20:21:29,272 INFO success: irssi-script entered RUNNING state, process has stayed up for > than 0 seconds (startse                                                                                                                                cs)
2019-02-05 20:21:29,272 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (star                                                                                                                                tsecs)
2019-02-05 20:21:29,272 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (start                                                                                                                                secs)
2019-02-05 20:21:29,272 DEBG 'start-script' stdout output:
[debug] Directory listing of files in /config/openvpn as follows

2019-02-05 20:21:29,272 DEBG 'flood-script' stdout output:
[info] Flood not enabled, skipping starting Flood Web UI

2019-02-05 20:21:29,272 DEBG fd 17 closed, stopped monitoring <POutputDispatcher at 140529256460160 for <Subprocess at 140529                                                                                                                                256458216 with name flood-script in state RUNNING> (stdout)>
2019-02-05 20:21:29,273 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 140529254973664 for <Subprocess at 140529                                                                                                                                256458216 with name flood-script in state RUNNING> (stderr)>
2019-02-05 20:21:29,273 INFO exited: flood-script (exit status 0; expected)
2019-02-05 20:21:29,273 DEBG received SIGCLD indicating a child quit
2019-02-05 20:21:29,273 DEBG 'irssi-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2019-02-05 20:21:29,273 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 140529254974240 for <Subprocess at 140529                                                                                                                                256458360 with name irssi-script in state RUNNING> (stderr)>
2019-02-05 20:21:29,273 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 140529254973952 for <Subprocess at 140529                                                                                                                                256458360 with name irssi-script in state RUNNING> (stdout)>
2019-02-05 20:21:29,273 INFO exited: irssi-script (exit status 0; expected)
2019-02-05 20:21:29,273 DEBG received SIGCLD indicating a child quit
2019-02-05 20:21:29,274 DEBG 'start-script' stdout output:
total 24
drwxrwxr-x 2 nobody users 4096 Feb  5 20:16 .
drwxrwxr-x 3 root   root  4096 Feb  4 22:29 ..
-rwxrwxr-x 1 nobody users 3174 Feb  5 20:16 CA Montreal.ovpn
-rwxrwxr-x 1 nobody users 2025 Feb  5 19:00 ca.rsa.2048.crt
-rwxrwxr-x 1 nobody users   20 Feb  5 19:42 credentials.conf
-rwxrwxr-x 1 nobody users  869 Feb  5 19:00 crl.rsa.2048.pem

2019-02-05 20:21:29,275 DEBG 'watchdog-script' stdout output:
[info] rTorrent config file doesnt exist, copying default to /config/rtorrent/config/...

2019-02-05 20:21:29,275 DEBG 'watchdog-script' stderr output:
mkdir: cannot create directory ‘/config/rtorrent’
2019-02-05 20:21:29,275 DEBG 'watchdog-script' stderr output:
: Permission denied

2019-02-05 20:21:29,277 DEBG 'watchdog-script' stderr output:
sed: can't read /config/rtorrent/config/rtorrent.rc: No such file or directory

2019-02-05 20:21:29,277 DEBG 'privoxy-script' stdout output:
[info] Privoxy set to disabled

2019-02-05 20:21:29,277 DEBG fd 32 closed, stopped monitoring <POutputDispatcher at 140529254975320 for <Subprocess at 140529                                                                                                                                256458504 with name privoxy-script in state RUNNING> (stdout)>
2019-02-05 20:21:29,278 DEBG fd 36 closed, stopped monitoring <POutputDispatcher at 140529254975752 for <Subprocess at 140529                                                                                                                                256458504 with name privoxy-script in state RUNNING> (stderr)>
2019-02-05 20:21:29,278 INFO exited: privoxy-script (exit status 0; expected)
2019-02-05 20:21:29,278 DEBG received SIGCLD indicating a child quit
2019-02-05 20:21:29,279 DEBG 'watchdog-script' stderr output:
sed: can't read /config/rtorrent/config/rtorrent.rc: No such file or directory

2019-02-05 20:21:29,281 DEBG 'watchdog-script' stderr output:
sed: can't read /config/rtorrent/config/rtorrent.rc: No such file or directory

2019-02-05 20:21:29,283 DEBG 'watchdog-script' stderr output:
sed: can't read /config/rtorrent/config/rtorrent.rc: No such file or directory

2019-02-05 20:21:29,285 DEBG 'watchdog-script' stderr output:
sed: can't read /config/rtorrent/config/rtorrent.rc: No such file or directory

2019-02-05 20:21:29,285 DEBG 'watchdog-script' stderr output:
dos2unix: /config/rtorrent/config/rtorrent.rc: No such file or directory
dos2unix:
2019-02-05 20:21:29,285 DEBG 'watchdog-script' stderr output:
Skipping /config/rtorrent/config/rtorrent.rc, not a regular file.

2019-02-05 20:21:29,286 DEBG 'watchdog-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2019-02-05 20:21:29,300 DEBG 'start-script' stdout output:
[debug] Contents of ovpn file /config/openvpn/CA Montreal.ovpn as follows...

2019-02-05 20:21:29,301 DEBG 'start-script' stdout output:
remote ca-montreal.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
compress
verb 1
<crl-verify>
-----BEGIN X509 CRL-----
MIICWDCCAUAwDQYJKoZIhvcNAQENBQAwgegxCzAJBgNVBAYTAlVTMQswCQYDVQQI
EwJDQTETMBEGA1UEBxMKTG9zQW5nZWxlczEgMB4GA1UEChMXUHJpdmF0ZSBJbnRl
cm5ldCBBY2Nlc3MxIDAeBgNVBAsTF1ByaXZhdGUgSW50ZXJuZXQgQWNjZXNzMSAw
HgYDVQQDExdQcml2YXRlIEludGVybmV0IEFjY2VzczEgMB4GA1UEKRMXUHJpdmF0
ZSBJbnRlcm5ldCBBY2Nlc3MxLzAtBgkqhkiG9w0BCQEWIHNlY3VyZUBwcml2YXRl
aW50ZXJuZXRhY2Nlc3MuY29tFw0xNjA3MDgxOTAwNDZaFw0zNjA3MDMxOTAwNDZa
MCYwEQIBARcMMTYwNzA4MTkwMDQ2MBECAQYXDDE2MDcwODE5MDA0NjANBgkqhkiG
jI+ffKN3laDvczsG6CxmY3jNyc79XVpEYUnq4rT3FfveW1+Ralf+Vf38HdpwB8EW
B4hZlQ205+21CALLvZvR8HcPxC9KEnev1mU46wkTiov0EKc+EdRxkj5yMgv0V2Re
ze7AP+NQ9ykvDScH4eYCsmufNpIjBLhpLE2cuZZXBLcPhuRzVoU3l7A9lvzG9mjA
5YijHJGHNjlWFqyrn1CfYS6koa4TGEPngBoAziWRbDGdhEgJABHrpoaFYaL61zqy
MR6jC0K2ps9qyZAN74LEBedEfK7tBOzWMwr58A==
-----END X509 CRL-----
</crl-verify>

<ca>
-----BEGIN CERTIFICATE-----
MIIFqzCCBJOgAwIBAgIJAKZ7D5Yv87qDMA0GCSqGSIb3DQEBDQUAMIHoMQswCQYD
VQQGEwJVUzELMAkGA1UECBMCQ0ExEzARBgNVBAcTCkxvc0FuZ2VsZXMxIDAeBgNV
BAoTF1ByaXZhdGUgSW50ZXJuZXQgQWNjZXNzMSAwHgYDVQQLExdQcml2YXRlIElu
dGVybmV0IEFjY2VzczEgMB4GA1UEAxMXUHJpdmF0ZSBJbnRlcm5ldCBBY2Nlc3Mx
IDAeBgNVBCkTF1ByaXZhdGUgSW50ZXJuZXQgQWNjZXNzMS8wLQYJKoZIhvcNAQkB
FiBzZWN1cmVAcHJpdmF0ZWludGVybmV0YWNjZXNzLmNvbTAeFw0xNDA0MTcxNzM1
MThaFw0zNDA0MTIxNzM1MThaMIHoMQswCQYDVQQGEwJVUzELMAkGA1UECBMCQ0Ex
EzARBgNVBAcTCkxvc0FuZ2VsZXMxIDAeBgNVBAoTF1ByaXZhdGUgSW50ZXJuZXQg
QWNjZXNzMSAwHgYDVQQLExdQcml2YXRlIEludGVybmV0IEFjY2VzczEgMB4GA1UE
AxMXUHJpdmF0ZSBJbnRlcm5ldCBBY2Nlc3MxIDAeBgNVBCkTF1ByaXZhdGUgSW50
ZXJuZXQgQWNjZXNzMS8wLQYJKoZIhvcNAQkBFiBzZWN1cmVAcHJpdmF0ZWludGVy
bmV0YWNjZXNzLmNvbTCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBAPXD
lH/P/CnFPdBWlLp5ze3HRBCc/Avgr5CdMRkEsySL5GHBZsx6w2cayQ2EcRhVTwWp
cdldeNO+pPr9rIgPrtXqT4SWViTQRBeGM8CDxAyTopTsobjSiYZCF9Ta1gunl0G/
8Vfp+SXfYCC+ZzWvP+L1pFhPRqzQQ8k+wMZIovObK1s+nlwPaLyayzw9a8sUnvWB
/5rGPdIYnQWPgoNlLN9HpSmsAcw2z8DXI9pIxbr74cb3/HSfuYGOLkRqrOk6h4RC
OfuWoTrZup1uEOn+fw8CAwEAAaOCAVQwggFQMB0GA1UdDgQWBBQv63nQ/pJAt5tL
y8VJcbHe22ZOsjCCAR8GA1UdIwSCARYwggESgBQv63nQ/pJAt5tLy8VJcbHe22ZO
sqGB7qSB6zCB6DELMAkGA1UEBhMCVVMxCzAJBgNVBAgTAkNBMRMwEQYDVQQHEwpM
b3NBbmdlbGVzMSAwHgYDVQQKExdQcml2YXRlIEludGVybmV0IEFjY2VzczEgMB4G
A1UECxMXUHJpdmF0ZSBJbnRlcm5ldCBBY2Nlc3MxIDAeBgNVBAMTF1ByaXZhdGUg
SW50ZXJuZXQgQWNjZXNzMSAwHgYDVQQpExdQcml2YXRlIEludGVybmV0IEFjY2Vz
czEvMC0GCSqGSIb3DQEJARYgc2VjdXJlQHByaXZhdGVpbnRlcm5ldGFjY2Vzcy5j
b22CCQCmew+WL/O6gzAMBgNVHRMEBTADAQH/MA0GCSqGSIb3DQEBDQUAA4IBAQAn
a5PgrtxfwTumD4+3/SYvwoD66cB8IcK//h1mCzAduU8KgUXocLx7QgJWo9lnZ8xU
ryXvWab2usg4fqk7FPi00bED4f4qVQFVfGfPZIH9QQ7/48bPM9RyfzImZWUCenK3
7pdw4Bvgoys2rHLHbGen7f28knT2j/cbMxd78tQc20TIObGjo8+ISTRclSTRBtyC
GohseKYpTS9himFERpUgNtefvYHbn70mIOzfOJFTVqfrptf9jXa9N8Mpy3ayfodz
1wiqdteqFXkTYoSDctgKMiZ6GdocK9nMroQipIQtpnwd4yBDWIyC6Bvlkrq5TQUt
YDQ8z9v+DMO6iwyIDRiU
-----END CERTIFICATE-----
</ca>

disable-occ

2019-02-05 20:21:29,308 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1

2019-02-05 20:21:29,310 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.222 to /etc/resolv.conf

2019-02-05 20:21:29,312 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf

2019-02-05 20:21:29,315 DEBG 'start-script' stdout output:
[info] Adding 1.1.1.1 to /etc/resolv.conf

2019-02-05 20:21:29,317 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf

2019-02-05 20:21:29,319 DEBG 'start-script' stdout output:
[info] Adding 209.222.18.218 to /etc/resolv.conf

2019-02-05 20:21:29,321 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf

2019-02-05 20:21:29,324 DEBG 'start-script' stdout output:
[info] Adding 1.0.0.1 to /etc/resolv.conf

2019-02-05 20:21:29,326 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf

2019-02-05 20:21:44,609 DEBG 'start-script' stdout output:
[info] Attempting to load tun kernel module...

2019-02-05 20:21:44,609 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.15.0-45-generic

2019-02-05 20:21:44,610 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...

2019-02-05 20:21:44,610 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2019-02-05 20:21:44,610 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded

2019-02-05 20:21:44,616 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2019-02-05 20:21:44,616 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.15.0-45-generic

2019-02-05 20:21:44,616 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2019-02-05 20:21:44,617 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2019-02-05 20:21:44,617 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module, you will not be able to connect to the applications Web UI or Privoxy outside of                                                                                                                                 your LAN
[info] unRAID/Ubuntu users: Please attempt to load the module by executing the following on your host: '/sbin/modprobe iptabl                                                                                                                                e_mangle'
[info] Synology users: Please attempt to load the module by executing the following on your host: 'insmod /lib/modules/iptabl                                                                                                                                e_mangle.ko'
[debug] Show name servers defined for container

2019-02-05 20:21:44,617 DEBG 'start-script' stdout output:
nameserver 209.222.18.222
nameserver 37.235.1.174
nameserver 1.1.1.1
nameserver 8.8.8.8
nameserver 209.222.18.218
nameserver 37.235.1.177
nameserver 1.0.0.1
nameserver 8.8.4.4

2019-02-05 20:21:44,617 DEBG 'start-script' stdout output:
[debug] Show name resolution for VPN endpoint ca-montreal.privateinternetaccess.com

2019-02-05 20:21:44,744 DEBG 'start-script' stdout output:
;; ->>HEADER<<- opcode: QUERY, rcode: NOERROR, id: 8487
;; flags: qr rd ra ; QUERY: 1, ANSWER: 13, AUTHORITY: 4, ADDITIONAL: 0
;; QUESTION SECTION:
;; ca-montreal.privateinternetaccess.com.       IN      A

;; ANSWER SECTION:
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.138
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.165
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.140
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.146
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.170
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.182
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.185
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.188
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.153
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.132
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.151
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.163
ca-montreal.privateinternetaccess.com.  300     IN      A       199.229.249.164

;; AUTHORITY SECTION:
privateinternetaccess.com.      86400   IN      NS      ns2.p28.dynect.net.
privateinternetaccess.com.      86400   IN      NS      ns4.p28.dynect.net.
privateinternetaccess.com.      86400   IN      NS      ns3.p28.dynect.net.
privateinternetaccess.com.      86400   IN      NS      ns1.p28.dynect.net.

;; ADDITIONAL SECTION:

;; Query time: 125 msec
;; SERVER: 209.222.18.218
;; WHEN: Tue Feb  5 20:21:44 2019
;; MSG SIZE  rcvd: 349

2019-02-05 20:21:44,744 DEBG 'start-script' stdout output:
[debug] Show contents of hosts file

2019-02-05 20:21:44,745 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.4      ec09e4a50cc4
199.229.249.138 ca-montreal.privateinternetaccess.com

2019-02-05 20:21:44,747 DEBG 'start-script' stdout output:
[debug] Docker interface defined as eth0

2019-02-05 20:21:44,750 DEBG 'start-script' stdout output:
[debug] Docker IP defined as 172.17.0.4

2019-02-05 20:21:44,752 DEBG 'start-script' stdout output:
[debug] Docker netmask defined as 255.255.0.0

2019-02-05 20:21:44,757 DEBG 'start-script' stdout output:
[info] Docker network defined as    172.17.0.0/16

2019-02-05 20:21:44,760 DEBG 'start-script' stdout output:
[info] Adding 192.168.2.0/24 as route via docker eth0

2019-02-05 20:21:44,761 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2019-02-05 20:21:44,761 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

2019-02-05 20:21:44,762 DEBG 'start-script' stdout output:
--------------------
[debug] Modules currently loaded for kernel

2019-02-05 20:21:44,763 DEBG 'start-script' stdout output:
Module                  Size  Used by
xt_nat                 16384  28
xt_tcpudp              16384  60
veth                   16384  0
ipt_MASQUERADE         16384  20
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  4
nf_conntrack_ipv4      16384  51
nf_defrag_ipv4         16384  1 nf_conntrack_ipv4
nf_nat_ipv4            16384  1 iptable_nat
xt_addrtype            16384  4
iptable_filter         16384  1
xt_conntrack           16384  2
nf_nat                 32768  3 nf_nat_masquerade_ipv4,nf_nat_ipv4,xt_nat
nf_conntrack          131072  8 xt_conntrack,nf_nat_masquerade_ipv4,nf_conntrack_ipv4,nf_nat,ipt_MASQUERADE,nf_nat_ipv4,xt_na                                                                                                                                t,nf_conntrack_netlink
libcrc32c              16384  2 nf_conntrack,nf_nat
br_netfilter           24576  0
bridge                151552  1 br_netfilter
stp                    16384  1 bridge
llc                    16384  2 bridge,stp
overlay                77824  4
aufs                  241664  0
snd_hda_codec_realtek   106496  1
snd_hda_codec_generic    73728  1 snd_hda_codec_realtek
edac_mce_amd           28672  0
snd_hda_codec_hdmi     49152  1
snd_hda_intel          40960  0
snd_hda_codec         126976  4 snd_hda_codec_generic,snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec_realtek
kvm                   598016  0
snd_hda_core           81920  5 snd_hda_codec_generic,snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec,snd_hda_codec_realtek
snd_hwdep              20480  1 snd_hda_codec
snd_pcm                98304  4 snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec,snd_hda_core
irqbypass              16384  1 kvm
snd_timer              32768  1 snd_pcm
crct10dif_pclmul       16384  0
snd                    81920  8 snd_hda_codec_generic,snd_hda_codec_hdmi,snd_hwdep,snd_hda_intel,snd_hda_codec,snd_hda_codec_                                                                                                                                realtek,snd_timer,snd_pcm
crc32_pclmul           16384  0
soundcore              16384  1 snd
joydev                 24576  0
input_leds             16384  0
ccp                    73728  0
ghash_clmulni_intel    16384  0
pcbc                   16384  0
aesni_intel           188416  0
eeepc_wmi              16384  0
aes_x86_64             20480  1 aesni_intel
asus_wmi               28672  1 eeepc_wmi
crypto_simd            16384  1 aesni_intel
shpchp                 36864  0
sparse_keymap          16384  1 asus_wmi
glue_helper            16384  1 aesni_intel
k10temp                16384  0
video                  45056  1 asus_wmi
cryptd                 24576  3 crypto_simd,ghash_clmulni_intel,aesni_intel
wmi_bmof               16384  0
mac_hid                16384  0
sch_fq_codel           20480  3
ip_tables              28672  2 iptable_filter,iptable_nat
x_tables               40960  7 xt_conntrack,iptable_filter,xt_tcpudp,ipt_MASQUERADE,xt_addrtype,xt_nat,ip_tables
autofs4                40960  2
hid_generic            16384  0
usbhid                 49152  0
hid                   118784  2 usbhid,hid_generic
amdkfd                180224  1
amd_iommu_v2           20480  1 amdkfd
amdgpu               2703360  1
chash                  16384  1 amdgpu
ttm                   106496  1 amdgpu
drm_kms_helper        172032  1 amdgpu
syscopyarea            16384  1 drm_kms_helper
sysfillrect            16384  1 drm_kms_helper
sysimgblt              16384  1 drm_kms_helper
fb_sys_fops            16384  1 drm_kms_helper
igb                   217088  0
drm                   401408  4 drm_kms_helper,amdgpu,ttm
dca                    16384  1 igb
i2c_piix4              24576  0
ahci                   40960  1
i2c_algo_bit           16384  2 igb,amdgpu
ptp                    20480  1 igb
libahci                32768  1 ahci
pps_core               20480  1 ptp
wmi                    24576  2 asus_wmi,wmi_bmof
gpio_amdpt             16384  0
gpio_generic           20480  1 gpio_amdpt

2019-02-05 20:21:44,861 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2019-02-05 20:21:44,862 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 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 -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 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 -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT

2019-02-05 20:21:44,862 DEBG 'start-script' stdout output:
--------------------

2019-02-05 20:21:44,862 DEBG 'start-script' stdout output:
[debug] OpenVPN command line:- /usr/bin/openvpn --daemon --reneg-sec 0 --mute-replay-warnings --auth-nocache --setenv VPN_PRO                                                                                                                                V 'pia' --setenv DEBUG 'true' --setenv VPN_DEVICE_TYPE 'tun0' --setenv VPN_REMOTE 'ca-montreal.privateinternetaccess.com' --s                                                                                                                                cript-security 2 --up /root/openvpnup.sh --up-delay --up-restart --writepid /root/openvpn.pid --remap-usr1 SIGHUP --log-appen                                                                                                                                d /dev/stdout --pull-filter ignore 'up' --pull-filter ignore 'down' --pull-filter ignore 'route-ipv6' --pull-filter ignore 'i                                                                                                                                fconfig-ipv6' --pull-filter ignore 'tun-ipv6' --pull-filter ignore 'persist-tun' --pull-filter ignore 'reneg-sec' --remote 19                                                                                                                                9.229.249.138 1198 udp --remote 199.229.249.164 1198 udp --remote 199.229.249.163 1198 udp --remote 199.229.249.146 1198 udp                                                                                                                                 --remote 199.229.249.187 1198 udp --remote 199.229.249.143 1198 udp --remote 199.229.249.173 1198 udp --remote 199.229.249.18                                                                                                                                5 1198 udp --remote 199.229.249.177 1198 udp --remote 199.229.249.132 1198 udp --remote 199.229.249.142 1198 udp --remote 199                                                                                                                                .229.249.165 1198 udp --remote 199.229.249.181 1198 udp --remote-random --keepalive 10 60 --setenv STRICT_PORT_FORWARD 'yes'                                                                                                                                 --disable-occ --auth-user-pass credentials.conf --cd /config/openvpn --config '/config/openvpn/CA Montreal.ovpn'

2019-02-05 20:21:44,863 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2019-02-05 20:21:44,867 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:44 2019 WARNING: file 'credentials.conf' is group or others accessible

2019-02-05 20:21:44,868 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:44 2019 OpenVPN 2.4.6 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] b                                                                                                                                uilt on Apr 24 2018
Tue Feb  5 20:21:44 2019 library versions: OpenSSL 1.1.1a  20 Nov 2018, LZO 2.10

2019-02-05 20:21:44,868 DEBG 'start-script' stdout output:
[info] OpenVPN started

2019-02-05 20:21:44,868 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2019-02-05 20:21:44,868 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:44 2019 NOTE: the current --script-security setting may allow this configuration to call user-defined script                                                                                                                                s

2019-02-05 20:21:44,868 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:44 2019 TCP/UDP: Preserving recently used remote address: [AF_INET]199.229.249.181:1198
Tue Feb  5 20:21:44 2019 UDP link local: (not bound)
Tue Feb  5 20:21:44 2019 UDP link remote: [AF_INET]199.229.249.181:1198

2019-02-05 20:21:45,099 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:45 2019 [559bec350bd6509591e00595c47663b8] Peer Connection Initiated with [AF_INET]199.229.249.181:1198

2019-02-05 20:21:46,231 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 auth-token received, disabling auth-nocache for the authentication token

2019-02-05 20:21:46,232 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 TUN/TAP device tun0 opened

2019-02-05 20:21:46,232 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Tue Feb  5 20:21:46 2019 /usr/bin/ip link set dev tun0 up mtu 1500

2019-02-05 20:21:46,233 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 /usr/bin/ip addr add dev tun0 local 10.12.10.10 peer 10.12.10.9

2019-02-05 20:21:46,233 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 /root/openvpnup.sh tun0 1500 1558 10.12.10.10 10.12.10.9 init

2019-02-05 20:21:46,236 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2019-02-05 20:21:46,236 DEBG 'start-script' stdout output:
[debug] Waiting for valid IP address from tunnel...

2019-02-05 20:21:46,238 DEBG 'start-script' stdout output:
Tue Feb  5 20:21:46 2019 Initialization Sequence Completed

2019-02-05 20:21:46,272 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.12.10.10'

2019-02-05 20:21:46,315 DEBG 'watchdog-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.12.10.10'
[info] rTorrent listening interface IP 0.0.0.0 and VPN provider IP 10.12.10.10 different, marking for reconfigure

2019-02-05 20:21:46,318 DEBG 'watchdog-script' stdout output:
[info] rTorrent not running

2019-02-05 20:21:46,342 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.12.10.10'

2019-02-05 20:21:46,343 DEBG 'start-script' stdout output:
[debug] Valid IP address from tunnel acquired '10.12.10.10'

2019-02-05 20:21:46,343 DEBG 'start-script' stdout output:
[debug] Port forwarding is enabled
[debug] Checking endpoint 'ca-montreal.privateinternetaccess.com' is port forward enabled...

2019-02-05 20:21:46,343 DEBG 'start-script' stdout output:
[debug] Attempting to get external IP using Name Server 'ns1.google.com'...

2019-02-05 20:21:46,345 DEBG 'start-script' stdout output:
[info] Attempting to curl https://www.privateinternetaccess.com/vpninfo/servers?version=82...

2019-02-05 20:21:46,562 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 199.229.249.181

2019-02-05 20:21:46,574 DEBG 'start-script' stdout output:
[info] Curl successful for https://www.privateinternetaccess.com/vpninfo/servers?version=82, response code 200

2019-02-05 20:21:46,619 DEBG 'start-script' stdout output:
[debug] PIA endpoint 'ca-montreal.privateinternetaccess.com' is in the list of endpoints that support port forwarding

2019-02-05 20:21:46,619 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
[debug] Attempting to get dynamically assigned port...

2019-02-05 20:21:46,620 DEBG 'watchdog-script' stdout output:
[debug] External IP address from tunnel is '199.229.249.181'

2019-02-05 20:21:46,620 DEBG 'watchdog-script' stdout output:
[debug] Waiting for file '/home/nobody/vpn_incoming_port.txt' to be generated (contains PIA API generated incoming port numbe                                                                                                                                r)...

2019-02-05 20:21:46,622 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=f5aa2d5739129722f06cf56be6adeeda24fa2138f82244abd47f3...

2019-02-05 20:21:47,149 DEBG 'start-script' stdout output:
[info] Curl successful for http://209.222.18.222:2000/?client_id=f5aa2d5739129722f06cf56be6adeeda24fa2138f82244abd405ba37f3, response code 200

2019-02-05 20:21:47,171 DEBG 'start-script' stdout output:
[debug] Successfully assigned incoming port 56945

2019-02-05 20:21:47,621 DEBG 'watchdog-script' stdout output:
[debug] Incoming port for tunnel is '56945'

2019-02-05 20:21:47,621 DEBG 'watchdog-script' stdout output:
[info] rTorrent incoming port 49160 and VPN incoming port 56945 different, marking for reconfigure
[info] Removing any rTorrent session lock files left over from the previous run...

2019-02-05 20:21:47,622 DEBG 'watchdog-script' stdout output:
[info] Attempting to start rTorrent...

2019-02-05 20:21:47,623 DEBG 'watchdog-script' stdout output:
Script started, file is /home/nobody/typescript

2019-02-05 20:21:47,643 DEBG 'watchdog-script' stdout output:
Script done, file is /home/nobody/typescript

2019-02-05 20:21:47,646 DEBG 'watchdog-script' stdout output:
[debug] Waiting for rTorrent process to start...

2019-02-05 20:21:48,650 DEBG 'watchdog-script' stdout output:
[info] rTorrent process started

2019-02-05 20:21:48,652 DEBG 'watchdog-script' stdout output:
[info] Waiting for rTorrent process to start listening on port 5000...

I'm unable to indentify the issue.

If somebody can help, I'll be grateful.

Thanks for your help.

Edited February 6, 2019 by blacksad
display

Spies · February 6, 2019

Is your downloads path set correctly?

DavidAUK · February 6, 2019

Listening for what? Port 5000 in your setup is rtorrent listening for a connection to a WebUI. It's not the port that your browser uses to connect to the WebUI nor the port that rtorrent uses as a listening port for incoming connections.

Spies · February 6, 2019

2 minutes ago, DavidAUK said:

Listening for what? Port 5000 in your setup is rtorrent listening for a connection to a WebUI. It's not the port that your browser uses to connect to the WebUI nor the port that rtorrent uses as a listening port for incoming connections.

He has an issue, it should show the following lines in the log:

2019-02-05 15:56:23,635 DEBG 'watchdog-script' stdout output:
[info] rTorrent process started
[info] Waiting for rTorrent process to start listening on port 5000...

2019-02-05 15:56:23,643 DEBG 'watchdog-script' stdout output:
[info] rTorrent process listening

2019-02-05 15:56:23,650 DEBG 'watchdog-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2019-02-05 15:56:23,650 DEBG 'watchdog-script' stdout output:
[info] Initialising ruTorrent plugins (checking rTorrent is running)...

binhex · February 6, 2019

9 hours ago, blacksad said:

mkdir: cannot create directory ‘/config/rtorrent’ 2019-02-05 20:21:29,275 DEBG 'watchdog-script' stderr output: : Permission denied

permissions issues, probably due to incorrect umask, 0022 is not valid, set it back to 000, or if you want to be a little tighter set it to 002

Fiala06 · February 7, 2019

Any idea how to solve the issues below. Seen this in my log file.

[02/06/2019 19:35:32] FILE MANAGER: rar archive manipulation disabled (application not found)

[02/06/2019 19:35:32] FILE MANAGER: zip archive manipulation disabled (application not found)

[02/06/2019 19:35:32] FILE MANAGER: gzip archive manipulation disabled (application not found)

[02/06/2019 19:35:32] FILE MANAGER: bzip2 archive manipulation disabled (application not found)

blacksad · February 7, 2019

Hello,

Thank you all for your answers.

permissions issues, probably due to incorrect umask, 0022 is not valid, set it back to 000, or if you want to be a little tighter set it to 002

Thanks binhex. It did the trick. With 000 as UMASK and rights relaxed an config and data folders it works.

I will rationalized that later.

I still have a little issue. There is a 5 minutes delay during the initialization, just after ENABLE_AUTODL_IRSSI step (which is disabled).

There is no specific output.

Do you have any idea of what is blocking ?

2019-02-06 22:38:29.978641 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2019-02-06 22:38:29.998500 [info] STRICT_PORT_FORWARD defined as 'yes'
2019-02-06 22:38:30.017873 [info] ENABLE_PRIVOXY defined as 'no'
2019-02-06 22:38:30.037296 [info] ENABLE_FLOOD defined as 'no'
2019-02-06 22:38:30.056538 [info] ENABLE_AUTODL_IRSSI defined as 'no'
2019-02-06 22:43:31.103989 [info] Starting Supervisor...
2019-02-06 22:43:31,285 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2019-02-06 22:43:31,285 INFO Set uid to user 0 succeeded

I attached the full log if it helps.

Thanks for your support.

20190206_rtorrentvpn_log.txt

Edited February 7, 2019 by blacksad

Katherine · February 7, 2019

Is there a way to supress this message somehow?

2019-02-06 04:55:27,868 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:55:58,003 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:56:28,136 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:56:58,270 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:57:28,404 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

binhex · February 7, 2019

2 hours ago, Katherine said:

Is there a way to supress this message somehow?


2019-02-06 04:55:27,868 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:55:58,003 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:56:28,136 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:56:58,270 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

2019-02-06 04:57:28,404 DEBG 'watchdog-script' stdout output:
[info] Nginx log file does not exist, skipping log rotation

this situation shouldnt happen with the latest image (was a bug in an earlier release), im assuming you are running the latest image right?, if so please can you follow the procedure below:-

[Support] binhex - rTorrentVPN

Recommended Posts

Link to comment

Top Posters In This Topic

Popular Days

Top Posters In This Topic

Popular Days

Popular Posts

binhex

Beta

binhex

Posted Images

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment

Link to comment