Jump to content
binhex

[Support] binhex - rTorrentVPN

2501 posts in this topic Last Reply

Recommended Posts

20 minutes ago, deusxanime said:

 

Yeah I've been meaning to switch over to Medusa or Sonarr eventually. This might be the final nail in the coffin for SickRage.

 

medusa also has working jackett support which is awesome, i believe its still broken in sickrage, once you get jackett working correctly it really is very nice.

Share this post


Link to post
Quote
  On 3/6/2018 at 10:20 PM, c0nfuzed said:

I just found a bug, it only appears to have started recently so I suspect something changed at my VPN provider.

 

The script that detects my public IP fails about 90% of the time because ... 


# from /root/getvpnextip.sh
$(dig -b ${vpn_ip} TXT +short o-o.myaddr.l.google.com @${pri_ns} 2> /dev/null | tr -d '"')

returns a IPv6 address rather than IPv4 as expected by the script.

 

Additionally, and I'm not sure why, but when it does return an IPV4 address it is always different than what I get from 


curl ipinfo.io/ip

by exactly 1... so if google's dns is reporting my IP is 1.1.1.1 then ipinfo.io/ip is reporting that it's 1.1.1.2... I don't fully understand why they would be different, but I fear that googles dns is wrong... might explain why I am not seeding as well as I would like.

 

So after a bit of screwing around, I fixed my issue by creating a replacement getvpenextip.sh and mounting it into the container as follows.  This new file uses the old DNS lookup method first, but if that fails it falls back to using curl to get the ip from http://checkip.amazonaws.com followed by http://whatismyip.akamai.com (both stable web presences).

 

To test this:

 

1. create a file called getvpenextip.sh on the host OS containing:

#!/bin/bash

# define name servers to connect to in order to get external ip address
pri_ns="ns1.google.com"
sec_ns="resolver1.opendns.com"
pri_url="http://checkip.amazonaws.com"
sec_url="http://whatismyip.akamai.com"
retry_count=30

# remove previous run output file
rm -f /home/nobody/vpn_external_ip.txt

# wait for vpn tunnel to come up before proceeding
source /home/nobody/getvpnip.sh

# function to check ip address is in correct format
check_valid_ip() {

        check_ip="$1"

        # check if the format looks right
        echo "${check_ip}" | egrep -qE '[0-9]{1,3}\.[0-9]{1,3}\.[0-9]{1,3}\.[0-9]{1,3}' || return 1

        # check that each octect is less than or equal to 255
        echo "${check_ip}" | awk -F'.' '$1 <=255 && $2 <= 255 && $3 <=255 && $4 <= 255 {print "Y" } ' | grep -q Y || return 1

        return 0
}

while true; do

        if [[ "${DEBUG}" == "true" ]]; then
                echo "[debug] Attempting to get external IP using Name Server '${pri_ns}'..."
        fi

        external_ip="$(dig -b ${vpn_ip} -4 TXT +short o-o.myaddr.l.google.com @${pri_ns} 2> /dev/null | tr -d '"')"
        check_valid_ip "${external_ip}"
        return_code="$?"

        # if empty value returned, or ip not in correct format then try secondary ns
        if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then

                if [[ "${DEBUG}" == "true" ]]; then
                        echo "[debug] Failed to get external IP using Name Server '${pri_ns}', trying '${sec_ns}'..."
                fi

                external_ip="$(dig -b ${vpn_ip} -4 +short myip.opendns.com @${sec_ns} 2> /dev/null)"
                check_valid_ip "${external_ip}"
                return_code="$?"

        fi

        # if empty value returned, or ip not in correct format then try first URL
        if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then

                if [[ "${DEBUG}" == "true" ]]; then
                        echo "[debug] Failed to get external IP using Name Servers, trying '${pri_url}'..."
                fi

                external_ip="$(curl --interface ${vpn_ip} ${pri_url} 2> /dev/null)"
                check_valid_ip "${external_ip}"
                return_code="$?"

        fi

        # if empty value returned, or ip not in correct format then try secondary URL
        if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then

                if [[ "${DEBUG}" == "true" ]]; then
                        echo "[debug] Failed to get external IP using Name Servers and primary URL, trying '${sec_url}'..."
                fi

                external_ip="$(curl --interface ${vpn_ip} ${sec_url} 2> /dev/null)"
                check_valid_ip "${external_ip}"
                return_code="$?"

        fi

        # if empty value returned, or ip not in correct format then retry
        if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then

                if [ "${retry_count}" -eq "0" ]; then

                        external_ip="${vpn_ip}"

                        echo "[warn] Cannot determine external IP address, exausted retries setting to tunnel IP ${external_ip}"
                        break

                else

                        retry_count=$((retry_count-1))

                        if [[ "${DEBUG}" == "true" ]]; then
                                echo "[debug] Cannot determine external IP address, retrying..."
                        fi

                        sleep 1s
                        continue

                fi

        fi

        echo "[info] Successfully retrieved external IP address ${external_ip}"
        break


done

# write external ip address to text file, this is then read by the downloader script
echo "${external_ip}" > /home/nobody/vpn_external_ip.txt

# chmod file to prevent restrictive umask causing read issues for user nobody (owner is user root)
chmod +r /home/nobody/vpn_external_ip.txt

2. mount it over the container's version using the mount option: 

-v <host path>/getvpnextip.sh:/root/getvpnextip.sh:ro

 

Hopefully BinHex will see this and consider updating his script.  In the meantime this seems to be working for me.

 

Share this post


Link to post

hi @c0nfuzed thanks for the post above, so i obviously cant really dig into the details of this as i dont use the provider you have a problem with, so a few questions so im clear on the issue:-

 

 - So are you seeing an ipv6 address returned from ns lookup method?, this shouldnt now happen as i enhanced the script to return only ipv4.

 - Im assuming you are still seeing the odd behaviour that the ip address returned is your external ip + 1?, if you are seeing a valid ip address returned then how does your modification identify that the returned ip isn't correct?, surely it would only do this on failure to get an ip address using the ns lookup method?, so i can only assume you are seeing no ip address returned (either ipv4 or ipv6) correct?.

 

 

Share this post


Link to post
8 hours ago, binhex said:

hi @c0nfuzed thanks for the post above, so i obviously cant really dig into the details of this as i dont use the provider you have a problem with, so a few questions so im clear on the issue:-

 

 - So are you seeing an ipv6 address returned from ns lookup method?, this shouldnt now happen as i enhanced the script to return only ipv4.

 - Im assuming you are still seeing the odd behaviour that the ip address returned is your external ip + 1?, if you are seeing a valid ip address returned then how does your modification identify that the returned ip isn't correct?, surely it would only do this on failure to get an ip address using the ns lookup method?, so i can only assume you are seeing no ip address returned (either ipv4 or ipv6) correct?.

 

 

 

Yes, still getting an IPv6 address.  The dig "-4" you added doesn't seem to make a difference... not sure why.

 

I wasn't able to confirm the +1 issue, as I couldn't get the script to return an IPv4 address after an hour of testing.  I was able to confirm that rTorrent is gettting the correct IP by doing a port test with NMAP (both my incoming port and DHT port were open, others closed).  Perhaps, when the DNS method was returning an IPv4 address, it was wrong, not the web url.

 

regardless, I think having alternative methods is a good thing.  While the DNS method is considered best under most circumstances, it doesn't hurt to have fallback methods.

Share this post


Link to post

Hello,

 

I've noticed random crashes over the last couple of months.

 

It's hard to find a trend, the closest I got is if I add a torrent it will timeout on rutorrent (not all torrents do this). 

 

2018-06-21 09:04:22,988 DEBG 'rutorrent-script' stderr output:
2018/06/21 09:04:22 [error] 3103#3103: *7386 FastCGI sent in stderr: "PHP message: PHP Notice: Undefined offset: 3 in /usr/share/webapps/rutorrent/plugins/extratio/rules.php on line 198" while reading response header from upstream, client: 192.168.1.122, server: localhost, request: "POST /plugins/extratio/action.php HTTP/1.1", upstream: "fastcgi://127.0.0.1:7777", host: "192.168.1.110:9080", referrer: "http://192.168.1.110:9080/"


2018-06-21 09:04:25,731 DEBG 'rutorrent-script' stderr output:
2018/06/21 09:04:25 [error] 3103#3103: *7387 FastCGI sent in stderr: "PHP message: PHP Notice: Undefined offset: 3 in /usr/share/webapps/rutorrent/plugins/extratio/rules.php on line 198" while reading response header from upstream, client: 192.168.1.122, server: localhost, request: "POST /plugins/extratio/action.php HTTP/1.1", upstream: "fastcgi://127.0.0.1:7777", host: "192.168.1.110:9080", referrer: "http://192.168.1.110:9080/"

I try to restart the container. although there are no errors that it still times out

 

2018-06-21 14:54:38,350 INFO stopped: privoxy-script (terminated by SIGTERM)
2018-06-21 14:54:38,350 WARN received SIGINT indicating exit request
2018-06-21 14:54:38,351 DEBG killing rtorrent-script (pid 144) with signal SIGTERM
2018-06-21 14:54:38,351 DEBG received SIGCLD indicating a child quit
2018-06-21 14:54:39,352 DEBG fd 27 closed, stopped monitoring <POutputDispatcher at 22686585154736 for <Subprocess at 22686585209848 with name rtorrent-script in state STOPPING> (stdout)>
2018-06-21 14:54:39,352 DEBG fd 31 closed, stopped monitoring <POutputDispatcher at 22686585619952 for <Subprocess at 22686585209848 with name rtorrent-script in state STOPPING> (stderr)>
2018-06-21 14:54:39,352 INFO stopped: rtorrent-script (terminated by SIGTERM)
2018-06-21 14:54:39,352 DEBG received SIGCLD indicating a child quit
2018-06-21 14:54:40,354 DEBG killing rutorrent-script (pid 141) with signal SIGTERM
2018-06-21 14:54:40,354 DEBG fd 16 closed, stopped monitoring <POutputDispatcher at 22686585191672 for <Subprocess at 22686585209632 with name rutorrent-script in state STOPPING> (stderr)>
2018-06-21 14:54:40,355 DEBG fd 11 closed, stopped monitoring <POutputDispatcher at 22686585192320 for <Subprocess at 22686585209632 with name rutorrent-script in state STOPPING> (stdout)>
2018-06-21 14:54:40,355 INFO stopped: rutorrent-script (terminated by SIGTERM)
2018-06-21 14:54:40,355 DEBG received SIGCLD indicating a child quit
2018-06-21 14:54:40,355 DEBG killing start-script (pid 140) with signal SIGTERM
2018-06-21 14:54:40,355 DEBG fd 8 closed, stopped monitoring <POutputDispatcher at 22686585209272 for <Subprocess at 22686585210424 with name start-script in state STOPPING> (stdout)>
2018-06-21 14:54:40,355 DEBG fd 10 closed, stopped monitoring <POutputDispatcher at 22686594710560 for <Subprocess at 22686585210424 with name start-script in state STOPPING> (stderr)>
2018-06-21 14:54:40,355 INFO stopped: start-script (terminated by SIGTERM)
2018-06-21 14:54:40,356 DEBG received SIGCLD indicating a child quit
Created by...
___. .__ .__
\_ |__ |__| ____ | |__ ____ ___ ___
| __ \| |/ \| | \_/ __ \\ \/ /
| \_\ \ | | \ Y \ ___/ > <
|___ /__|___| /___| /\___ >__/\_ \
\/ \/ \/ \/ \/
https://hub.docker.com/u/binhex/

2018-06-21 14:55:05.723117 [info] Host is running unRAID
2018-06-21 14:55:05.799402 [info] System information Linux 455b520e1c04 4.14.35-unRAID #1 SMP PREEMPT Thu Apr 19 14:06:21 PDT 2018 x86_64 GNU/Linux
2018-06-21 14:55:05.876052 [info] PUID defined as '99'
2018-06-21 14:55:06.041990 [info] PGID defined as '100'
2018-06-21 14:55:06.479292 [warn] UMASK not defined (via -e UMASK), defaulting to '000'
2018-06-21 14:55:06.520975 [info] Permissions already set for volume mappings
2018-06-21 14:55:06.599555 [info] VPN_ENABLED defined as 'yes'
2018-06-21 14:55:06.788848 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/client.ovpn
dos2unix: converting file /config/openvpn/client.ovpn to Unix format...
2018-06-21 14:55:06.875961 [info] VPN remote line defined as 'remote europe.vpn.airdns.org 443'
2018-06-21 14:55:06.910646 [info] VPN_REMOTE defined as 'europe.vpn.airdns.org'
2018-06-21 14:55:06.949900 [info] VPN_PORT defined as '443'
2018-06-21 14:55:06.995931 [info] VPN_PROTOCOL defined as 'udp'
2018-06-21 14:55:07.034746 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-06-21 14:55:07.068015 [info] VPN_PROV defined as 'custom'
2018-06-21 14:55:07.106252 [info] LAN_NETWORK defined as '192.168.1.0/24'
2018-06-21 14:55:07.158179 [warn] NAME_SERVERS not defined (via -e NAME_SERVERS), defaulting to Google and FreeDNS name servers
2018-06-21 14:55:07.202016 [info] VPN_USER defined as 'lorden'
2018-06-21 14:55:07.238430 [info] VPN_PASS defined as 'flashflash'
2018-06-21 14:55:07.277232 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-06-21 14:55:07.315603 [info] ENABLE_PRIVOXY defined as 'yes'
2018-06-21 14:55:07.358199 [warn] ENABLE_FLOOD not defined (via -e ENABLE_FLOOD), defaulting to 'no'
2018-06-21 14:55:07.400839 [warn] ENABLE_AUTODL_IRSSI not defined (via -e ENABLE_AUTODL_IRSSI), defaulting to 'no'
2018-06-21 14:55:08.414028 [info] Starting Supervisor...
2018-06-21 14:55:09,847 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2018-06-21 14:55:09,847 INFO Set uid to user 0 succeeded
2018-06-21 14:55:09,852 INFO supervisord started with pid 7
2018-06-21 14:55:10,854 INFO spawned: 'start-script' with pid 141
2018-06-21 14:55:10,856 INFO spawned: 'rutorrent-script' with pid 142
2018-06-21 14:55:10,858 INFO spawned: 'flood-script' with pid 143
2018-06-21 14:55:10,860 INFO spawned: 'irssi-script' with pid 144
2018-06-21 14:55:10,862 INFO spawned: 'rtorrent-script' with pid 145
2018-06-21 14:55:10,864 INFO spawned: 'privoxy-script' with pid 146
2018-06-21 14:55:10,864 INFO reaped unknown pid 8
2018-06-21 14:55:10,880 DEBG 'irssi-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-06-21 14:55:10,880 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,880 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,880 INFO success: flood-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,880 INFO success: irssi-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,880 INFO success: rtorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,880 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-06-21 14:55:10,881 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 22872383977016 for <Subprocess at 22872369382752 with name irssi-script in state RUNNING> (stderr)>
2018-06-21 14:55:10,881 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 22872369362560 for <Subprocess at 22872369382752 with name irssi-script in state RUNNING> (stdout)>
2018-06-21 14:55:10,882 INFO exited: irssi-script (exit status 0; expected)
2018-06-21 14:55:10,882 DEBG received SIGCLD indicating a child quit
2018-06-21 14:55:10,882 DEBG 'flood-script' stdout output:
[info] Flood not enabled, skipping starting Flood Web UI

2018-06-21 14:55:10,882 DEBG fd 17 closed, stopped monitoring <POutputDispatcher at 22872369363928 for <Subprocess at 22872369383184 with name flood-script in state RUNNING> (stdout)>
2018-06-21 14:55:10,882 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 22872369363280 for <Subprocess at 22872369383184 with name flood-script in state RUNNING> (stderr)>
2018-06-21 14:55:10,883 INFO exited: flood-script (exit status 0; expected)
2018-06-21 14:55:10,883 DEBG received SIGCLD indicating a child quit
2018-06-21 14:55:10,917 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN

2018-06-21 14:55:10,988 DEBG 'rtorrent-script' stdout output:
[info] rTorrent config file already exists, skipping copy

2018-06-21 14:55:11,105 DEBG 'rtorrent-script' stderr output:
dos2unix: converting file /config/rtorrent/config/rtorrent.rc to Unix format...

2018-06-21 14:55:11,218 DEBG 'rtorrent-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid

2018-06-21 14:55:11,317 DEBG 'start-script' stdout output:
[info] Default route for container is 172.17.0.1

2018-06-21 14:55:11,321 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf

2018-06-21 14:55:11,325 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.174 to /etc/resolv.conf

2018-06-21 14:55:11,329 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf

2018-06-21 14:55:11,334 DEBG 'start-script' stdout output:
[info] Adding 37.235.1.177 to /etc/resolv.conf

2018-06-21 14:55:12,048 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0

2018-06-21 14:55:12,049 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-06-21 14:55:12,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.2
192.168.1.0/24 via 172.17.0.1 dev eth0

2018-06-21 14:55:12,050 DEBG 'start-script' stdout output:
--------------------

2018-06-21 14:55:12,055 DEBG 'start-script' stdout output:
iptable_mangle 16384 2
ip_tables 24576 3 iptable_mangle,iptable_filter,iptable_nat

2018-06-21 14:55:12,055 DEBG 'start-script' stdout output:
[info] iptable_mangle support detected, adding fwmark for tables

2018-06-21 14:55:12,107 DEBG 'start-script' stdout output:
[info] Docker network defined as 172.17.0.0/16

2018-06-21 14:55:12,732 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-06-21 14:55:12,735 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD ACCEPT
-P OUTPUT DROP
-A INPUT -i tun0 -j ACCEPT
-A INPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --sport 443 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --dport 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 -s 192.168.1.0/24 -d 172.17.0.0/16 -i eth0 -p tcp -j ACCEPT
-A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT
-A INPUT -i lo -j ACCEPT
-A OUTPUT -o tun0 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --dport 443 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --dport 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 -s 172.17.0.0/16 -d 192.168.1.0/24 -o eth0 -p tcp -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT

2018-06-21 14:55:12,736 DEBG 'start-script' stdout output:
--------------------

2018-06-21 14:55:12,737 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2018-06-21 14:55:13,025 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 WARNING: file 'credentials.conf' is group or others accessible

Thu Jun 21 14:55:13 2018 OpenVPN 2.4.5 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Mar 1 2018
Thu Jun 21 14:55:13 2018 library versions: OpenSSL 1.1.0g 2 Nov 2017, LZO 2.10

2018-06-21 14:55:13,027 DEBG 'start-script' stdout output:
[info] OpenVPN started

2018-06-21 14:55:13,028 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2018-06-21 14:55:13,029 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication

2018-06-21 14:55:13,029 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication

2018-06-21 14:55:13,030 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]62.102.148.141:443
Thu Jun 21 14:55:13 2018 Socket Buffers: R=[212992->524288] S=[212992->524288]
Thu Jun 21 14:55:13 2018 UDP link local: (not bound)
Thu Jun 21 14:55:13 2018 UDP link remote: [AF_INET]62.102.148.141:443

2018-06-21 14:55:13,161 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 TLS: Initial packet from [AF_INET]62.102.148.141:443, sid=4ea807fb d7905a26

2018-06-21 14:55:13,301 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 VERIFY OK: depth=1, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=airvpn.org CA, emailAddress=info@airvpn.org

2018-06-21 14:55:13,301 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 VERIFY KU OK
Thu Jun 21 14:55:13 2018 Validating certificate extended key usage
Thu Jun 21 14:55:13 2018 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Thu Jun 21 14:55:13 2018 VERIFY EKU OK
Thu Jun 21 14:55:13 2018 VERIFY OK: depth=0, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=server, emailAddress=info@airvpn.org

2018-06-21 14:55:13,643 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:13 2018 Control Channel: TLSv1.2, cipher TLSv1.2 ECDHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
Thu Jun 21 14:55:13 2018 [server] Peer Connection Initiated with [AF_INET]62.102.148.141:443

2018-06-21 14:55:14,769 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 SENT CONTROL [server]: 'PUSH_REQUEST' (status=1)

2018-06-21 14:55:14,900 DEBG 'start-script' stdout output:

21 14:55:14 2018 PUSH: Received control message: 'PUSH_REPLY,comp-lzo no,redirect-gateway def1 bypass-dhcp,dhcp-option DNS 10.4.0.1,route-gateway 10.4.0.1,topology subnet,ping 10,ping-restart 60,ifconfig 10.4.36.53 255.255.0.0,peer-id 61,cipher AES-256-GCM'

2018-06-21 14:55:14,900 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: timers and/or timeouts modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: compression parms modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: --ifconfig/up options modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: route options modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: route-related options modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: peer-id set
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: adjusting link_mtu to 1625
Thu Jun 21 14:55:14 2018 OPTIONS IMPORT: data channel crypto options modified
Thu Jun 21 14:55:14 2018 Data Channel: using negotiated cipher 'AES-256-GCM'
Thu Jun 21 14:55:14 2018 Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Thu Jun 21 14:55:14 2018 Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Thu Jun 21 14:55:14 2018 ROUTE_GATEWAY 172.17.0.1/255.255.0.0 IFACE=eth0 HWADDR=02:42:ac:11:00:02

2018-06-21 14:55:14,901 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 TUN/TAP device tun0 opened
Thu Jun 21 14:55:14 2018 TUN/TAP TX queue length set to 100

2018-06-21 14:55:14,901 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Thu Jun 21 14:55:14 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-06-21 14:55:14,903 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 /usr/bin/ip addr add dev tun0 10.4.36.53/16 broadcast 10.4.255.255

2018-06-21 14:55:14,905 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 /root/openvpnup.sh tun0 1500 1553 10 .4.36.53 255.255.0.0 init

2018-06-21 14:55:14,908 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 /usr/bin/ip route add 62.102.148.141/32 via 172.17.0.1

2018-06-21 14:55:14,910 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 /usr/bin/ip route add 0.0.0.0/1 via 10.4.0.1

2018-06-21 14:55:14,912 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 /usr/bin/ip route add 128.0.0.0/1 via 10.4.0.1

2018-06-21 14:55:14,913 DEBG 'start-script' stdout output:
Thu Jun 21 14:55:14 2018 Initialization Sequence Completed

2018-06-21 14:55:14,953 DEBG 'privoxy-script' stdout output:
[info] Configuring Privoxy...

2018-06-21 14:55:14,987 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running
[info] rTorrent listening interface IP 0.0.0.0 and VPN provider IP 10.4.36.53 different, marking for reconfigure

2018-06-21 14:55:15,050 DEBG 'privoxy-script' stdout output:
[info] All checks complete, starting Privoxy...

2018-06-21 14:55:15,146 DEBG 'privoxy-script' stderr output:
2018-06-21 14:55:15.145 14fae1c490c0 Info: Privoxy version 3.0.26

2018-06-21 14:55:15.146 14fae1c490c0 Info: Program name: /usr/bin/privoxy

2018-06-21 14:55:15,847 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 62.102.148.154

2018-06-21 14:55:15,900 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-06-21 14:55:15,901 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-06-21 14:55:15,937 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-06-21 14:55:16,127 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-06-21 14:55:16,127 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-06-21 14:55:16,487 DEBG 'rutorrent-script' stdout output:
[info] rtorrent started, setting up rutorrent...
[info] Setting PHP timezone to UTC...

2018-06-21 14:55:16,568 DEBG 'rutorrent-script' stdout output:
[info] nginx cert files already exists, skipping copy
[info] nginx security file already exists, skipping copy

2018-06-21 14:55:16,568 DEBG 'rutorrent-script' stdout output:
[info] nginx config file already exists, skipping copy

2018-06-21 14:55:16,569 DEBG 'rutorrent-script' stdout output:
[info] rutorrent conf folder already exists, skipping copy

2018-06-21 14:55:16,643 DEBG 'rutorrent-script' stdout output:
[info] running rsync to copy rutorrent user plugins to the plugins folder inside the container...

2018-06-21 14:55:17,139 DEBG 'rtorrent-script' stdout output:
[info] rTorrent started

2018-06-21 14:55:17,139 DEBG 'rtorrent-script' stdout output:
[info] Initialising ruTorrent plugins (checking rTorrent is running)...

2018-06-21 14:55:17,147 DEBG 'rtorrent-script' stdout output:
[info] rTorrent running
[info] Initialising ruTorrent plugins (checking nginx is running)...

2018-06-21 14:55:17,336 DEBG 'rutorrent-script' stdout output:
sending incremental file list

2018-06-21 14:55:17,339 DEBG 'rutorrent-script' stdout output:
README.txt

2018-06-21 14:55:17,339 DEBG 'rutorrent-script' stdout output:
theme/themes/README.txt

2018-06-21 14:55:17,340 DEBG 'rutorrent-script' stdout output:

sent 2.29K bytes received 79 bytes 4.75K bytes/sec
total size is 3.07M speedup is 1,295.13

2018-06-21 14:55:17,340 DEBG 'rutorrent-script' stdout output:
[info] rutorrent share folder already exists, skipping copy

2018-06-21 14:55:17,341 DEBG 'rutorrent-script' stdout output:
[info] starting php-fpm...

2018-06-21 14:55:22,778 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

2018-06-21 14:55:22,782 DEBG 'rutorrent-script' stdout output:
[info] starting nginx...

2018-06-21 14:55:23,422 DEBG 'rtorrent-script' stdout output:
[info] nginx running
[info] Initialising ruTorrent plugins...

2018-06-21 14:55:30,150 DEBG 'rtorrent-script' stdout output:
[info] ruTorrent plugins initialised

 

when this happens, I have no choice but to delete the  sessions folder restart the container.

 

I did try to attach in the docker but i have no idea how to move passed that to open rtorrent for example.

Share this post


Link to post

Is it possible to get the incoming port forwarded without the use of a vpn for this container? I've set the prov to custom, disabled the strict port forwarded and set a custom incoming port within the .rc and still cannot get it to forward it.

Share this post


Link to post

Hello, I require some support. Recently Rutorrent keeps timing out. Please let me know what information you require to help get the support started 

Share this post


Link to post

ive found in the last wk or so my rutorrent wont start properly. all was working fine up until recently so im not too sure if its just a recent update to the docker. here is the last few entries in the log after i try to start.

 

2018-07-01 01:51:58,498 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address **********

2018-07-01 01:51:58,533 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-07-01 01:51:58,549 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-07-01 01:51:58,552 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-07-01 01:51:58,580 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-07-01 01:51:58,580 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-07-01 01:52:27,727 DEBG 'rtorrent-script' stdout output:
[warn] Wait for rTorrent process to start aborted

2018-07-01 01:52:57,852 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running

2018-07-01 01:52:57,853 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-07-01 01:52:57,867 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-07-01 01:52:57,868 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-07-01 01:52:57,888 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-07-01 01:52:57,888 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-07-01 01:53:27,012 DEBG 'rtorrent-script' stdout output:
[warn] Wait for rTorrent process to start aborted
 

Share this post


Link to post
  On 3/6/2018 at 10:20 PM, c0nfuzed said: I just found a bug, it only appears to have started recently so I suspect something changed at my VPN provider.
 
The script that detects my public IP fails about 90% of the time because ... 
# from /root/getvpnextip.sh$(dig -b ${vpn_ip} TXT +short o-o.myaddr.l.google.com @${pri_ns} 2> /dev/null | tr -d '"')

returns a IPv6 address rather than IPv4 as expected by the script.
 
Additionally, and I'm not sure why, but when it does return an IPV4 address it is always different than what I get from 

curl ipinfo.io/ip

by exactly 1... so if google's dns is reporting my IP is 1.1.1.1 then ipinfo.io/ip is reporting that it's 1.1.1.2... I don't fully understand why they would be different, but I fear that googles dns is wrong... might explain why I am not seeding as well as I would like.

 
So after a bit of screwing around, I fixed my issue by creating a replacement getvpenextip.sh and mounting it into the container as follows.  This new file uses the old DNS lookup method first, but if that fails it falls back to using curl to get the ip from http://checkip.amazonaws.com followed by http://whatismyip.akamai.com (both stable web presences).
 
To test this:
 
1. create a file called getvpenextip.sh on the host OS containing:
#!/bin/bash# define name servers to connect to in order to get external ip addresspri_ns="ns1.google.com"sec_ns="resolver1.opendns.com"pri_url="http://checkip.amazonaws.com"sec_url="http://whatismyip.akamai.com"retry_count=30# remove previous run output filerm -f /home/nobody/vpn_external_ip.txt# wait for vpn tunnel to come up before proceedingsource /home/nobody/getvpnip.sh# function to check ip address is in correct formatcheck_valid_ip() {       check_ip="$1"       # check if the format looks right       echo "${check_ip}" | egrep -qE '[0-9]{1,3}\.[0-9]{1,3}\.[0-9]{1,3}\.[0-9]{1,3}' || return 1       # check that each octect is less than or equal to 255       echo "${check_ip}" | awk -F'.' '$1        return 0}while true; do       if [[ "${DEBUG}" == "true" ]]; then               echo "[debug] Attempting to get external IP using Name Server '${pri_ns}'..."       fi       external_ip="$(dig -b ${vpn_ip} -4 TXT +short o-o.myaddr.l.google.com @${pri_ns} 2> /dev/null | tr -d '"')"       check_valid_ip "${external_ip}"       return_code="$?"       # if empty value returned, or ip not in correct format then try secondary ns       if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then               if [[ "${DEBUG}" == "true" ]]; then                       echo "[debug] Failed to get external IP using Name Server '${pri_ns}', trying '${sec_ns}'..."               fi               external_ip="$(dig -b ${vpn_ip} -4 +short myip.opendns.com @${sec_ns} 2> /dev/null)"               check_valid_ip "${external_ip}"               return_code="$?"       fi       # if empty value returned, or ip not in correct format then try first URL       if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then               if [[ "${DEBUG}" == "true" ]]; then                       echo "[debug] Failed to get external IP using Name Servers, trying '${pri_url}'..."               fi               external_ip="$(curl --interface ${vpn_ip} ${pri_url} 2> /dev/null)"               check_valid_ip "${external_ip}"               return_code="$?"       fi       # if empty value returned, or ip not in correct format then try secondary URL       if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then               if [[ "${DEBUG}" == "true" ]]; then                       echo "[debug] Failed to get external IP using Name Servers and primary URL, trying '${sec_url}'..."               fi               external_ip="$(curl --interface ${vpn_ip} ${sec_url} 2> /dev/null)"               check_valid_ip "${external_ip}"               return_code="$?"       fi       # if empty value returned, or ip not in correct format then retry       if [[ -z "${external_ip}" || "${return_code}" != 0 ]]; then               if [ "${retry_count}" -eq "0" ]; then                       external_ip="${vpn_ip}"                       echo "[warn] Cannot determine external IP address, exausted retries setting to tunnel IP ${external_ip}"                       break               else                       retry_count=$((retry_count-1))                       if [[ "${DEBUG}" == "true" ]]; then                               echo "[debug] Cannot determine external IP address, retrying..."                       fi                       sleep 1s                       continue               fi       fi       echo "[info] Successfully retrieved external IP address ${external_ip}"       breakdone# write external ip address to text file, this is then read by the downloader scriptecho "${external_ip}" > /home/nobody/vpn_external_ip.txt# chmod file to prevent restrictive umask causing read issues for user nobody (owner is user root)chmod +r /home/nobody/vpn_external_ip.txt

2. mount it over the container's version using the mount option: 

-v /getvpnextip.sh:/root/getvpnextip.sh:ro

 
Hopefully BinHex will see this and consider updating his script.  In the meantime this seems to be working for me.
 
Fyi this did get done, not exactly as you implemented but similar.

Sent from my SM-G935F using Tapatalk

Share this post


Link to post

Thanks for the docker! I have a problem in flood, the speed is limited to each reboot at 1000mb/s even if I change rtorrent.rc

Share this post


Link to post

Having an issue with Flood seeming to become unresponsive after about a day. Sometimes restarting the container corrects it, but other times I need to blow away the container and recreate it. I have DEBUG set to true, but there is nothing in the container logs. Is this an already known issue? The port seems to still be responsive, but the webUI times out.

Share this post


Link to post
20 hours ago, tronyx said:

Having an issue with Flood seeming to become unresponsive after about a day. Sometimes restarting the container corrects it, but other times I need to blow away the container and recreate it. I have DEBUG set to true, but there is nothing in the container logs. Is this an already known issue? The port seems to still be responsive, but the webUI times out.

Ive been having that issue for a while, see my post here for some info I tried to come up with. I think its the scgi port just being slow for some reason. 

Share this post


Link to post

hi all managed to get the container working but im unable to get external access im on openmediavault v4  struggling to figure it out any help would be greatly appreciated 

 

-07-08 22:43:49,717 DEBG 'start-script' stdout output:
[info] Attempting to load tun kernel module...

2018-07-08 22:43:49,825 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.16.0-0.bpo.2-amd64

2018-07-08 22:43:49,826 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...
[warn] Unable to load tun kernel module, assuming its dynamically loaded

2018-07-08 22:43:49,826 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2018-07-08 22:43:50,121 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2018-07-08 22:43:50,137 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.16.0-0.bpo.2-amd64

2018-07-08 22:43:50,153 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2018-07-08 22:43:50,177 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2018-07-08 22:43:50,179 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module, you will not be able to connect to the applications Web UI or Privoxy outside of your LAN
[info] unRAID/Ubuntu users: Please attempt to load the module by executing the following on your host: '/sbin/modprobe iptable_mangle'
[info] Synology users: Please attempt to load the module by executing the following on your host: 'insmod /lib/modules/iptable_mangle.ko'

2018-07-08 22:43:50,244 DEBG 'start-script' stdout output:
[info] Adding 192.168.1.0/24 as route via docker eth0

2018-07-08 22:43:50,249 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-07-08 22:43:50,251 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.7 
192.168.1.0/24 via 172.17.0.1 dev eth0 

2018-07-08 22:43:50,252 DEBG 'start-script' stdout output:
--------------------

2018-07-08 22:43:50,912 DEBG 'start-script' stdout output:
[info] Docker network defined as    172.17.0.0/16

2018-07-08 22:43:55,241 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-07-08 22:43:55,310 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 -i eth0 -p tcp -m tcp --dport 3000 -j ACCEPT
-A INPUT -i eth0 -p tcp -m tcp --sport 3000 -j ACCEPT
-A INPUT -s 192.168.1.0/24 -i eth0 -p tcp -m tcp --dport 5000 -j ACCEPT
-A INPUT -s 192.168.1.0/24 -d 172.17.0.0/16 -i eth0 -p tcp -j ACCEPT
-A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT
-A INPUT -i lo -j ACCEPT
-A OUTPUT -o tun0 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --dport 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 -o eth0 -p tcp -m tcp --dport 3000 -j ACCEPT
-A OUTPUT -o eth0 -p tcp -m tcp --sport 3000 -j ACCEPT
-A OUTPUT -d 192.168.1.0/24 -o eth0 -p tcp -m tcp --sport 5000 -j ACCEPT
-A OUTPUT -s 172.17.0.0/16 -d 192.168.1.0/24 -o eth0 -p tcp -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT

2018-07-08 22:43:55,311 DEBG 'start-script' stdout output:
--------------------

2018-07-08 22:43:55,355 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

thank you

Share this post


Link to post
12 hours ago, khile said:

[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'

 

taken from the log above ^.

 

in short you need to find out how you enable iptable_mangle on openmediavaultault.

Share this post


Link to post

It's based on Debian 8 I think now so guessing that would be a good place to start thank you 

Share this post


Link to post

i have found i can run  the below code in ssh and its enable until i restart server im struggling how to make changes permanent for now i have made a cron job at startup to load below code

 

modprobe ipt_MASQUERADE
modprobe ipt_helper
modprobe ipt_SAME
modprobe ipt_REDIRECT
modprobe ipt_state
modprobe ipt_TCPMSS
modprobe ipt_LOG
modprobe ipt_TOS
modprobe iptable_nat
modprobe ipt_length
modprobe ipt_tcpmss
modprobe iptable_mangle
modprobe ipt_limit
modprobe ipt_tos
modprobe iptable_filter
modprobe ipt_helper
modprobe ipt_tos
modprobe ipt_ttl
modprobe ipt_REJECT

 

Share this post


Link to post

I'm not able to access the web UI. I have LAN_NETWORK set correctly so I'm not sure what's going on. 

 

Log: 

 

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

2018-07-30 10:01:42.460022 [info] Host is running unRAID
2018-07-30 10:01:42.495531 [info] System information Linux afb5d455978d 4.14.26-unRAID #1 SMP PREEMPT Mon Mar 12 16:21:20 PDT 2018 x86_64 GNU/Linux
2018-07-30 10:01:42.537033 [info] PUID defined as '99'
2018-07-30 10:01:42.580325 [info] PGID defined as '100'
2018-07-30 10:01:42.633161 [info] UMASK defined as '000'
2018-07-30 10:01:42.674736 [info] Permissions already set for volume mappings
2018-07-30 10:01:42.720247 [info] VPN_ENABLED defined as 'yes'
2018-07-30 10:01:42.772027 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/AirVPN_Netherlands_UDP-443.ovpn
dos2unix: converting file /config/openvpn/AirVPN_Netherlands_UDP-443.ovpn to Unix format...
2018-07-30 10:01:42.848823 [info] VPN remote line defined as 'remote nl.vpn.airdns.org 443'
2018-07-30 10:01:42.889446 [info] VPN_REMOTE defined as 'nl.vpn.airdns.org'
2018-07-30 10:01:42.932913 [info] VPN_PORT defined as '443'
2018-07-30 10:01:43.015863 [info] VPN_PROTOCOL defined as 'udp'
2018-07-30 10:01:43.060916 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-07-30 10:01:43.114135 [info] VPN_PROV defined as 'airvpn'
2018-07-30 10:01:43.159860 [info] LAN_NETWORK defined as '192.168.2.0/24'
2018-07-30 10:01:43.203931 [info] NAME_SERVERS defined as '4.2.2.1'
2018-07-30 10:01:43.248488 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-07-30 10:01:43.293717 [info] ENABLE_PRIVOXY defined as 'no'
2018-07-30 10:01:43.334739 [info] ENABLE_FLOOD defined as 'no'
2018-07-30 10:01:43.376044 [info] ENABLE_AUTODL_IRSSI defined as 'no'
2018-07-30 10:01:43.415259 [info] Starting Supervisor...
2018-07-30 10:01:43,639 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2018-07-30 10:01:43,640 INFO Set uid to user 0 succeeded
2018-07-30 10:01:43,645 INFO supervisord started with pid 5
2018-07-30 10:01:44,647 INFO spawned: 'start-script' with pid 132
2018-07-30 10:01:44,650 INFO spawned: 'rutorrent-script' with pid 133
2018-07-30 10:01:44,652 INFO spawned: 'flood-script' with pid 134
2018-07-30 10:01:44,655 INFO spawned: 'irssi-script' with pid 135
2018-07-30 10:01:44,657 INFO spawned: 'rtorrent-script' with pid 136
2018-07-30 10:01:44,661 INFO spawned: 'privoxy-script' with pid 137
2018-07-30 10:01:44,664 INFO reaped unknown pid 6
2018-07-30 10:01:44,667 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN

2018-07-30 10:01:44,668 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,668 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,668 INFO success: flood-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,669 INFO success: irssi-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,669 INFO success: rtorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,669 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-07-30 10:01:44,672 DEBG 'flood-script' stdout output:
[info] Flood not enabled, skipping starting Flood Web UI

2018-07-30 10:01:44,673 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 22361660586176 for <Subprocess at 22361660605576 with name flood-script in state RUNNING> (stderr)>
2018-07-30 10:01:44,674 DEBG fd 17 closed, stopped monitoring <POutputDispatcher at 22361660586536 for <Subprocess at 22361660605576 with name flood-script in state RUNNING> (stdout)>
2018-07-30 10:01:44,674 INFO exited: flood-script (exit status 0; expected)
2018-07-30 10:01:44,675 DEBG received SIGCLD indicating a child quit
2018-07-30 10:01:44,686 DEBG 'irssi-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-07-30 10:01:44,687 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 22361660584880 for <Subprocess at 22361660605000 with name irssi-script in state RUNNING> (stderr)>
2018-07-30 10:01:44,687 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 22361660585240 for <Subprocess at 22361660605000 with name irssi-script in state RUNNING> (stdout)>
2018-07-30 10:01:44,688 INFO exited: irssi-script (exit status 0; expected)
2018-07-30 10:01:44,688 DEBG received SIGCLD indicating a child quit
2018-07-30 10:01:44,690 DEBG 'privoxy-script' stdout output:
[info] Privoxy set to disabled

2018-07-30 10:01:44,691 DEBG fd 32 closed, stopped monitoring <POutputDispatcher at 22361661011800 for <Subprocess at 22361660605288 with name privoxy-script in state RUNNING> (stdout)>
2018-07-30 10:01:44,691 DEBG fd 36 closed, stopped monitoring <POutputDispatcher at 22361660690944 for <Subprocess at 22361660605288 with name privoxy-script in state RUNNING> (stderr)>
2018-07-30 10:01:44,691 INFO exited: privoxy-script (exit status 0; expected)
2018-07-30 10:01:44,691 DEBG received SIGCLD indicating a child quit
2018-07-30 10:01:44,696 DEBG 'rtorrent-script' stdout output:
[info] rTorrent config file already exists, skipping copy

2018-07-30 10:01:44,709 DEBG 'start-script' stdout output:
[warn] Username contains characters which could cause authentication issues, please consider changing this if possible

2018-07-30 10:01:44,715 DEBG 'start-script' stdout output:
[warn] Password contains characters which could cause authentication issues, please consider changing this if possible

2018-07-30 10:01:44,759 DEBG 'rtorrent-script' stderr output:
dos2unix: converting file /config/rtorrent/config/rtorrent.rc to Unix format...

2018-07-30 10:01:44,762 DEBG 'rtorrent-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid

2018-07-30 10:01:44,829 DEBG 'start-script' stdout output:
[info] Default route for container is 192.168.2.1

2018-07-30 10:01:44,834 DEBG 'start-script' stdout output:
[info] Adding 4.2.2.1 to /etc/resolv.conf

2018-07-30 10:01:44,907 DEBG 'start-script' stdout output:
[info] Adding 192.168.2.0/24 as route via docker eth0

2018-07-30 10:01:44,908 DEBG 'start-script' stderr output:
RTNETLINK answers: File exists

2018-07-30 10:01:44,909 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-07-30 10:01:44,910 DEBG 'start-script' stdout output:
default via 192.168.2.1 dev eth0 
192.168.2.0/24 dev eth0 proto kernel scope link src 192.168.2.15 

2018-07-30 10:01:44,910 DEBG 'start-script' stdout output:
--------------------

2018-07-30 10:01:44,913 DEBG 'start-script' stdout output:
iptable_mangle         16384  1
ip_tables              24576  3 iptable_mangle,iptable_filter,iptable_nat

2018-07-30 10:01:44,914 DEBG 'start-script' stdout output:
[info] iptable_mangle support detected, adding fwmark for tables

2018-07-30 10:01:44,945 DEBG 'start-script' stdout output:
[info] Docker network defined as    192.168.2.0/24

2018-07-30 10:01:45,098 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-07-30 10:01:45,102 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD ACCEPT
-P OUTPUT DROP
-A INPUT -i tun0 -j ACCEPT
-A INPUT -s 192.168.2.0/24 -d 192.168.2.0/24 -j ACCEPT
-A INPUT -i eth0 -p udp -m udp --sport 443 -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 192.168.2.0/24 -d 192.168.2.0/24 -j ACCEPT
-A OUTPUT -o eth0 -p udp -m udp --dport 443 -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

2018-07-30 10:01:45,103 DEBG 'start-script' stdout output:
--------------------

2018-07-30 10:01:45,104 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2018-07-30 10:01:45,115 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 WARNING: file 'credentials.conf' is group or others accessible
Mon Jul 30 10:01:45 2018 OpenVPN 2.4.5 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Mar  1 2018
Mon Jul 30 10:01:45 2018 library versions: OpenSSL 1.1.0g  2 Nov 2017, LZO 2.10

2018-07-30 10:01:45,116 DEBG 'start-script' stdout output:
[info] OpenVPN started

2018-07-30 10:01:45,125 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts

2018-07-30 10:01:45,126 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
Mon Jul 30 10:01:45 2018 Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication

2018-07-30 10:01:45,126 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]213.152.162.14:443
Mon Jul 30 10:01:45 2018 Socket Buffers: R=[212992->212992] S=[212992->212992]
Mon Jul 30 10:01:45 2018 UDP link local: (not bound)
Mon Jul 30 10:01:45 2018 UDP link remote: [AF_INET]213.152.162.14:443

2018-07-30 10:01:45,239 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 TLS: Initial packet from [AF_INET]213.152.162.14:443, sid=c6c08c4b 8e92df63

2018-07-30 10:01:45,377 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 VERIFY OK: depth=1, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=airvpn.org CA, emailAddress=info@airvpn.org

2018-07-30 10:01:45,378 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 VERIFY KU OK
Mon Jul 30 10:01:45 2018 Validating certificate extended key usage
Mon Jul 30 10:01:45 2018 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
Mon Jul 30 10:01:45 2018 VERIFY EKU OK
Mon Jul 30 10:01:45 2018 VERIFY OK: depth=0, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=Crater, emailAddress=info@airvpn.org

2018-07-30 10:01:45,698 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:45 2018 Control Channel: TLSv1.2, cipher TLSv1.2 ECDHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
Mon Jul 30 10:01:45 2018 [Crater] Peer Connection Initiated with [AF_INET]213.152.162.14:443

2018-07-30 10:01:46,933 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:46 2018 SENT CONTROL [Crater]: 'PUSH_REQUEST' (status=1)

2018-07-30 10:01:47,047 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:47 2018 PUSH: Received control message: 'PUSH_REPLY,comp-lzo no,redirect-gateway def1 bypass-dhcp,dhcp-option DNS 10.4.0.1,route-gateway 10.4.0.1,topology subnet,ping 10,ping-restart 60,ifconfig 10.4.51.75 255.255.0.0,peer-id 41,cipher AES-256-GCM'

2018-07-30 10:01:47,048 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: timers and/or timeouts modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: compression parms modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: --ifconfig/up options modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: route options modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: route-related options modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: peer-id set
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: adjusting link_mtu to 1625
Mon Jul 30 10:01:47 2018 OPTIONS IMPORT: data channel crypto options modified
Mon Jul 30 10:01:47 2018 Data Channel: using negotiated cipher 'AES-256-GCM'
Mon Jul 30 10:01:47 2018 Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Mon Jul 30 10:01:47 2018 Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
Mon Jul 30 10:01:47 2018 ROUTE_GATEWAY 192.168.2.1/255.255.255.0 IFACE=eth0 HWADDR=02:42:c0:a8:02:0f
Mon Jul 30 10:01:47 2018 TUN/TAP device tun0 opened
Mon Jul 30 10:01:47 2018 TUN/TAP TX queue length set to 100
Mon Jul 30 10:01:47 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Mon Jul 30 10:01:47 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-07-30 10:01:47,049 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:47 2018 /usr/bin/ip addr add dev tun0 10.4.51.75/16 broadcast 10.4.255.255

2018-07-30 10:01:47,052 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:47 2018 /root/openvpnup.sh tun0 1500 1553 10.4.51.75 255.255.0.0 init

2018-07-30 10:01:47,163 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running
[info] rTorrent listening interface IP 0.0.0.0 and VPN provider IP 10.4.51.75 different, marking for reconfigure

2018-07-30 10:01:47,256 DEBG 'start-script' stdout output:
[warn] Cannot determine external IP address, exhausted retries setting to tunnel IP '10.4.51.75'

2018-07-30 10:01:47,266 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-07-30 10:01:47,268 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-07-30 10:01:47,270 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-07-30 10:01:47,300 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-07-30 10:01:47,301 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-07-30 10:01:52,292 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:52 2018 /usr/bin/ip route add 213.152.162.14/32 via 192.168.2.1

2018-07-30 10:01:52,294 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:52 2018 /usr/bin/ip route add 0.0.0.0/1 via 10.4.0.1

2018-07-30 10:01:52,296 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:52 2018 /usr/bin/ip route add 128.0.0.0/1 via 10.4.0.1

2018-07-30 10:01:52,299 DEBG 'start-script' stdout output:
Mon Jul 30 10:01:52 2018 Initialization Sequence Completed

2018-07-30 10:02:16,519 DEBG 'rtorrent-script' stdout output:
[warn] Wait for rTorrent process to start aborted

2018-07-30 10:02:46,656 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running

2018-07-30 10:02:46,657 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-07-30 10:02:46,659 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-07-30 10:02:46,660 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-07-30 10:02:46,687 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-07-30 10:02:46,687 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

2018-07-30 10:03:15,938 DEBG 'rtorrent-script' stdout output:
[warn] Wait for rTorrent process to start aborted

2018-07-30 10:03:46,077 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running

2018-07-30 10:03:46,078 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-07-30 10:03:46,079 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-07-30 10:03:46,081 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-07-30 10:03:46,108 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-07-30 10:03:46,109 DEBG 'rtorrent-script' stdout output:
[info] Autodl-irssi not enabled, skipping startup

 

Share this post


Link to post
1 hour ago, AaronJAnderson said:

I'm not able to access the web UI. I have LAN_NETWORK set correctly so I'm not sure what's going on. 

 

Log: 

 

you are probably seeing issues relating to the change in rtorrent.rc, do the following:-

 

1. stop the container

2. delete the file /config/rtorrent/rtorrent.rc

3. start the container.

Share this post


Link to post
14 minutes ago, binhex said:

you are probably seeing issues relating to the change in rtorrent.rc, do the following:-

 

1. stop the container

2. delete the file /config/rtorrent/rtorrent.rc

3. start the container.

 

That did it. Thanks mate. (deleted my other thread) 

Share this post


Link to post

Hello,

 

I just restarted the container for the first time in about 5 weeks and now I can't get it back up. Any ideas?

 

```

2018-08-04 17:00:14,387 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.4.0-119-generic

2018-08-04 17:00:14,387 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...

2018-08-04 17:00:14,389 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2018-08-04 17:00:14,390 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded

```

Share this post


Link to post
Hello,
 
I just restarted the container for the first time in about 5 weeks and now I can't get it back up. Any ideas?
 
```
2018-08-04 17:00:14,387 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.4.0-119-generic
2018-08-04 17:00:14,387 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...
2018-08-04 17:00:14,389 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory
2018-08-04 17:00:14,390 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded
```
Try this first:-

you are probably seeing issues relating to the change in rtorrent.rc, do the following:-

1. stop the container
2. delete the file /config/rtorrent/rtorrent.rc
3. start the container.


Sent from my SM-G935F using Tapatalk

Share this post


Link to post

I don't think that worked. I tried removing that file, stopping and removing the container and recreating it. I still get this

 

2018-08-04 18:43:22,084 DEBG 'start-script' stdout output:
[info] Attempting to load tun kernel module...

2018-08-04 18:43:22,086 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.4.0-131-generic

2018-08-04 18:43:22,086 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...

2018-08-04 18:43:22,087 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2018-08-04 18:43:22,088 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded

2018-08-04 18:43:22,095 DEBG 'start-script' stdout output:
[info] Attempting to load iptable_mangle module...

2018-08-04 18:43:22,096 DEBG 'start-script' stderr output:
modprobe: FATAL: Module iptable_mangle not found in directory /lib/modules/4.4.0-131-generic

2018-08-04 18:43:22,096 DEBG 'start-script' stdout output:
[warn] Unable to load iptable_mangle module using modprobe, trying insmod...

2018-08-04 18:43:22,097 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/iptable_mangle.ko: No such file or directory

2018-08-04 18:43:22,098 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'
 

 

 

Share this post


Link to post

So I removed the rtorrent.rc file, the container and started the container again, and it still doesn't come back up. Here is the full logs. 

 

 

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

2018-08-04 18:56:11.319555 [info] System information Linux 8dd3c06831be 4.4.0-131-generic #157-Ubuntu SMP Thu Jul 12 15:51:36 UTC 2018 x86_64 GNU/Linux
2018-08-04 18:56:11.361603 [info] PUID defined as '1000'
2018-08-04 18:56:11.451168 [info] PGID defined as '1000'
2018-08-04 18:56:11.502370 [info] UMASK defined as '000'
2018-08-04 18:56:11.542956 [info] Permissions already set for volume mappings
2018-08-04 18:56:11.588439 [info] VPN_ENABLED defined as 'yes'
2018-08-04 18:56:11.635162 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/CA Toronto.ovpn
dos2unix: converting file /config/openvpn/CA Toronto.ovpn to Unix format...
2018-08-04 18:56:11.694563 [info] VPN remote line defined as 'remote ca-toronto.privateinternetaccess.com 1198'
2018-08-04 18:56:11.735606 [info] VPN_REMOTE defined as 'ca-toronto.privateinternetaccess.com'
2018-08-04 18:56:11.777282 [info] VPN_PORT defined as '1198'
2018-08-04 18:56:11.822301 [info] VPN_PROTOCOL defined as 'udp'
2018-08-04 18:56:11.863818 [info] VPN_DEVICE_TYPE defined as 'tun0'
2018-08-04 18:56:11.905185 [info] VPN_PROV defined as 'pia'
2018-08-04 18:56:11.946579 [info] LAN_NETWORK defined as '10.10.10.0/24'
2018-08-04 18:56:11.987852 [info] NAME_SERVERS defined as '8.8.8.8,8.8.4.4'
2018-08-04 18:56:12.111140 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS)
2018-08-04 18:56:12.151911 [info] STRICT_PORT_FORWARD defined as 'yes'
2018-08-04 18:56:12.192809 [info] ENABLE_PRIVOXY defined as 'yes'
2018-08-04 18:56:12.233986 [info] ENABLE_FLOOD defined as 'no'
2018-08-04 18:56:12.275712 [info] ENABLE_AUTODL_IRSSI defined as 'yes'
2018-08-04 18:56:29.726221 [info] Starting Supervisor...
2018-08-04 18:56:29,929 INFO Included extra file "/etc/supervisor/conf.d/rtorrent.conf" during parsing
2018-08-04 18:56:29,929 INFO Set uid to user 0 succeeded
2018-08-04 18:56:29,933 INFO supervisord started with pid 8
2018-08-04 18:56:30,935 INFO spawned: 'start-script' with pid 153
2018-08-04 18:56:30,937 INFO spawned: 'rutorrent-script' with pid 154
2018-08-04 18:56:30,939 INFO spawned: 'flood-script' with pid 155
2018-08-04 18:56:30,941 INFO spawned: 'irssi-script' with pid 156
2018-08-04 18:56:30,943 INFO spawned: 'rtorrent-script' with pid 157
2018-08-04 18:56:30,945 INFO spawned: 'privoxy-script' with pid 159
2018-08-04 18:56:30,946 INFO reaped unknown pid 9
2018-08-04 18:56:30,947 DEBG 'start-script' stdout output:
[info] VPN is enabled, beginning configuration of VPN

2018-08-04 18:56:30,947 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,947 INFO success: rutorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,947 INFO success: flood-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,947 INFO success: irssi-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,947 INFO success: rtorrent-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,947 INFO success: privoxy-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2018-08-04 18:56:30,957 DEBG 'flood-script' stdout output:
[info] Flood not enabled, skipping starting Flood Web UI

2018-08-04 18:56:30,958 DEBG fd 17 closed, stopped monitoring <POutputDispatcher at 139685100496800 for <Subprocess at 139685100516776 with name flood-script in state RUNNING> (stdout)>
2018-08-04 18:56:30,958 DEBG fd 21 closed, stopped monitoring <POutputDispatcher at 139685100497016 for <Subprocess at 139685100516776 with name flood-script in state RUNNING> (stderr)>
2018-08-04 18:56:30,958 INFO exited: flood-script (exit status 0; expected)
2018-08-04 18:56:30,958 DEBG received SIGCLD indicating a child quit
2018-08-04 18:56:30,970 DEBG 'rtorrent-script' stdout output:
[info] rTorrent config file doesnt exist, copying default to /config/rtorrent/config/...

2018-08-04 18:56:30,999 DEBG 'rtorrent-script' stderr output:
dos2unix: converting file /config/rtorrent/config/rtorrent.rc to Unix format...

2018-08-04 18:56:31,001 DEBG 'rtorrent-script' stdout output:
[info] VPN is enabled, checking VPN tunnel local ip is valid

2018-08-04 18:56:31,036 DEBG 'start-script' stdout output:
[info] Default route for container is 172.19.0.1

2018-08-04 18:56:31,041 DEBG 'start-script' stdout output:
[info] Adding 8.8.8.8 to /etc/resolv.conf

2018-08-04 18:56:31,046 DEBG 'start-script' stdout output:
[info] Adding 8.8.4.4 to /etc/resolv.conf

2018-08-04 18:56:31,085 DEBG 'start-script' stdout output:
[info] Attempting to load tun kernel module...

2018-08-04 18:56:31,089 DEBG 'start-script' stderr output:
modprobe: FATAL: Module tun not found in directory /lib/modules/4.4.0-131-generic

2018-08-04 18:56:31,090 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module using modprobe, trying insmod...

2018-08-04 18:56:31,091 DEBG 'start-script' stdout output:
[warn] Unable to load tun kernel module, assuming its dynamically loaded

2018-08-04 18:56:31,091 DEBG 'start-script' stderr output:
insmod: ERROR: could not load module /lib/modules/tun.ko: No such file or directory

2018-08-04 18:56:31,106 DEBG 'start-script' stdout output:
[info] Adding 10.10.10.0/24 as route via docker eth0

2018-08-04 18:56:31,108 DEBG 'start-script' stdout output:
[info] ip route defined as follows...
--------------------

2018-08-04 18:56:31,110 DEBG 'start-script' stdout output:
default via 172.19.0.1 dev eth0
10.10.10.0/24 via 172.19.0.1 dev eth0
172.19.0.0/16 dev eth0 proto kernel scope link src 172.19.0.2
--------------------

2018-08-04 18:56:31,120 DEBG 'start-script' stdout output:
iptable_mangle         16384  0
ip_tables              24576  3 iptable_filter,iptable_mangle,iptable_nat
x_tables               36864  21 xt_DSCP,xt_dscp,xt_mark,xt_hl,xt_helper,xt_length,ip_tables,xt_tcpmss,xt_tcpudp,ipt_MASQUERADE,xt_limit,xt_state,xt_conntrack,xt_LOG,xt_nat,iptable_filter,xt_TCPMSS,ipt_REJECT,xt_REDIRECT,iptable_mangle,xt_addrtype

2018-08-04 18:56:31,121 DEBG 'start-script' stdout output:
[info] iptable_mangle support detected, adding fwmark for tables

2018-08-04 18:56:31,157 DEBG 'start-script' stdout output:
[info] Docker network defined as    172.19.0.0/16

2018-08-04 18:56:31,255 DEBG 'start-script' stdout output:
[info] iptables defined as follows...
--------------------

2018-08-04 18:56:31,258 DEBG 'start-script' stdout output:
-P INPUT DROP
-P FORWARD ACCEPT
-P OUTPUT DROP
-A INPUT -i tun0 -j ACCEPT
-A INPUT -s 172.19.0.0/16 -d 172.19.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 10.10.10.0/24 -i eth0 -p tcp -m tcp --dport 5000 -j ACCEPT
-A INPUT -s 10.10.10.0/24 -d 172.19.0.0/16 -i eth0 -p tcp -j ACCEPT
-A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT
-A INPUT -i lo -j ACCEPT
-A OUTPUT -o tun0 -j ACCEPT
-A OUTPUT -s 172.19.0.0/16 -d 172.19.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 10.10.10.0/24 -o eth0 -p tcp -m tcp --sport 5000 -j ACCEPT
-A OUTPUT -s 172.19.0.0/16 -d 10.10.10.0/24 -o eth0 -p tcp -j ACCEPT
-A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT
-A OUTPUT -o lo -j ACCEPT

2018-08-04 18:56:31,258 DEBG 'start-script' stdout output:
--------------------

2018-08-04 18:56:31,259 DEBG 'start-script' stdout output:
[info] Starting OpenVPN...

2018-08-04 18:56:31,268 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:31 2018 WARNING: file 'credentials.conf' is group or others accessible
Sat Aug  4 18:56:31 2018 OpenVPN 2.4.5 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Mar  1 2018
Sat Aug  4 18:56:31 2018 library versions: OpenSSL 1.1.0g  2 Nov 2017, LZO 2.10

2018-08-04 18:56:31,271 DEBG 'start-script' stdout output:
[info] OpenVPN started
Sat Aug  4 18:56:31 2018 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
Sat Aug  4 18:56:31 2018 TCP/UDP: Preserving recently used remote address: [AF_INET]172.98.67.82:1198
Sat Aug  4 18:56:31 2018 UDP link local: (not bound)
Sat Aug  4 18:56:31 2018 UDP link remote: [AF_INET]172.98.67.82:1198

2018-08-04 18:56:31,384 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:31 2018 [74e9e038cc1ee5f11e97abf6aba60f3a] Peer Connection Initiated with [AF_INET]zzz

2018-08-04 18:56:32,590 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:32 2018 auth-token received, disabling auth-nocache for the authentication token

2018-08-04 18:56:32,590 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:32 2018 TUN/TAP device tun0 opened
Sat Aug  4 18:56:32 2018 do_ifconfig, tt->did_ifconfig_ipv6_setup=0
Sat Aug  4 18:56:32 2018 /usr/bin/ip link set dev tun0 up mtu 1500

2018-08-04 18:56:32,593 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:32 2018 /usr/bin/ip addr add dev tun0 local 10.66.10.6 peer 10.66.10.5

2018-08-04 18:56:32,594 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:32 2018 /root/openvpnup.sh tun0 1500 1558 10.66.10.6 10.66.10.5 init

2018-08-04 18:56:32,609 DEBG 'start-script' stdout output:
Sat Aug  4 18:56:32 2018 Initialization Sequence Completed

2018-08-04 18:56:32,633 DEBG 'privoxy-script' stdout output:
[info] Configuring Privoxy...

2018-08-04 18:56:32,642 DEBG 'rtorrent-script' stdout output:
[info] rTorrent not running
[info] rTorrent listening interface IP 0.0.0.0 and VPN provider IP 10.66.10.6 different, marking for reconfigure

2018-08-04 18:56:32,658 DEBG 'privoxy-script' stdout output:
[info] All checks complete, starting Privoxy...

2018-08-04 18:56:32,659 DEBG 'privoxy-script' stderr output:
2018-08-04 18:56:32.659 7f7bd9f8d0c0 Info: Privoxy version 3.0.26
2018-08-04 18:56:32.659 7f7bd9f8d0c0 Info: Program name: /usr/bin/privoxy

2018-08-04 18:56:32,729 DEBG 'irssi-script' stdout output:
Script started, file is /home/nobody/typescript

2018-08-04 18:56:32,738 DEBG 'start-script' stdout output:
[info] Attempting to curl http://209.222.18.222:2000/?client_id=UUID...

2018-08-04 18:56:32,756 DEBG 'irssi-script' stdout output:
Script done, file is /home/nobody/typescript

2018-08-04 18:56:32,763 DEBG fd 22 closed, stopped monitoring <POutputDispatcher at 139685100496008 for <Subprocess at 139685100516632 with name irssi-script in state RUNNING> (stdout)>
2018-08-04 18:56:32,763 DEBG fd 26 closed, stopped monitoring <POutputDispatcher at 139685100461520 for <Subprocess at 139685100516632 with name irssi-script in state RUNNING> (stderr)>
2018-08-04 18:56:32,763 INFO exited: irssi-script (exit status 0; expected)
2018-08-04 18:56:32,763 DEBG received SIGCLD indicating a child quit
2018-08-04 18:56:32,843 DEBG 'start-script' stdout output:
[info] Successfully retrieved external IP address 

2018-08-04 18:56:33,997 DEBG 'start-script' stdout output:
[info] Curl successful for http://209.222.18.222:2000/?client_id=UUID, response code 200

2018-08-04 18:56:34,852 DEBG 'rtorrent-script' stdout output:
[info] Removing any rTorrent session lock files left over from the previous run...

2018-08-04 18:56:34,855 DEBG 'rtorrent-script' stdout output:
[info] Attempting to start rTorrent...

2018-08-04 18:56:34,856 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-08-04 18:56:34,879 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

2018-08-04 18:56:35,010 DEBG 'rtorrent-script' stdout output:
Script started, file is /home/nobody/typescript

2018-08-04 18:56:35,022 DEBG 'rtorrent-script' stdout output:
duplicate session: irssi_session

2018-08-04 18:56:35,032 DEBG 'rtorrent-script' stdout output:
Script done, file is /home/nobody/typescript

 

Share this post


Link to post

Join the conversation

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

Guest
Reply to this topic...

×   Pasted as rich text.   Restore formatting

  Only 75 emoji are allowed.

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

×   Your previous content has been restored.   Clear editor

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