skirven

Solved! Thank you very much for the assist. I ended up setting up the array as xfs after the xfs_repair, and the drives mounted. I did still have kernel panics on the preclear, but I'll watch the drives, and do have a stable array at the moment. Thank you! Stephen

Well! That was a little too easy. I think I did try that, but probably not *after* the xfs_repair. I'm running some preclears on some other disks, so the array is offline, but the disk I expected to be there, was. I'll come back and close this out in a day or so, in case something else comes up. Thanks! Stephen

I also just had a random kernel panic. Might it be wise to replace the USB drive? The build was done in 2015, so it does have some age on it. -Stephen

Hi folks, I re-arranged some drives from a SATA bus perspective, and also moved the Mobo and drives to another chasis, and now I can't get the drives to mount, which seems odd. - I know my Parity is probably borked at this time, and that's OK. The command xfs_repair -v /dev/md1 (and 2) runs fine, but a "blkid" doesn't list the devices, yet a "fdisk -l" clearly shows the drives and they are gpt xfs formatted. root@Tower:~# xfs_repair -v /dev/md1 Phase 1 - find and verify superblock... - block cache size set to 737056 entries Phase 2 - using internal log - zero log... zero_log: head block 0 tail block 0 - scan filesystem freespace and inode maps... - found root inode chunk Phase 3 - for each AG... - scan and clear agi unlinked lists... - process known inodes and perform inode discovery... - agno = 0 - agno = 1 - agno = 2 - agno = 3 - process newly discovered inodes... Phase 4 - check for duplicate blocks... - setting up duplicate extent list... - check for inodes claiming duplicate blocks... - agno = 2 - agno = 1 - agno = 0 - agno = 3 Phase 5 - rebuild AG headers and trees... - agno = 0 - agno = 1 - agno = 2 - agno = 3 - reset superblock... Phase 6 - check inode connectivity... - resetting contents of realtime bitmap and summary inodes - traversing filesystem ... - agno = 0 - agno = 1 - agno = 2 - agno = 3 - traversal finished ... - moving disconnected inodes to lost+found ... Phase 7 - verify and correct link counts... XFS_REPAIR Summary Sat Aug 28 17:18:08 2021 Phase Start End Duration Phase 1: 08/28 17:14:57 08/28 17:14:58 1 second Phase 2: 08/28 17:14:58 08/28 17:15:01 3 seconds Phase 3: 08/28 17:15:01 08/28 17:16:40 1 minute, 39 seconds Phase 4: 08/28 17:16:40 08/28 17:16:40 Phase 5: 08/28 17:16:40 08/28 17:16:44 4 seconds Phase 6: 08/28 17:16:44 08/28 17:18:06 1 minute, 22 seconds Phase 7: 08/28 17:18:06 08/28 17:18:06 Total run time: 3 minutes, 9 seconds done root@Tower:~# blkid /dev/loop0: TYPE="squashfs" /dev/loop1: TYPE="squashfs" /dev/sda1: LABEL_FATBOOT="UNRAID" LABEL="UNRAID" UUID="7A2A-1AD5" BLOCK_SIZE="512" TYPE="vfat" /dev/sdc1: PARTUUID="78528c66-769f-4615-bb80-16e54e790894" root@Tower:~# #### root@Tower:~# fdisk -l Disk /dev/loop0: 11.98 MiB, 12562432 bytes, 24536 sectors Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 512 bytes I/O size (minimum/optimal): 512 bytes / 512 bytes Disk /dev/loop1: 19.78 MiB, 20738048 bytes, 40504 sectors Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 512 bytes I/O size (minimum/optimal): 512 bytes / 512 bytes Disk /dev/sda: 14.91 GiB, 16008609792 bytes, 31266816 sectors Disk model: Cruzer Fit Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 512 bytes I/O size (minimum/optimal): 512 bytes / 512 bytes Disklabel type: dos Disk identifier: 0x00000000 Device Boot Start End Sectors Size Id Type /dev/sda1 * 2 31266815 31266814 14.9G b W95 FAT32 Disk /dev/sdb: 3.64 TiB, 4000787030016 bytes, 7814037168 sectors Disk model: ST4000VN008-2DR1 Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 4096 bytes I/O size (minimum/optimal): 4096 bytes / 4096 bytes Disk /dev/sde: 2.73 TiB, 3000592982016 bytes, 5860533168 sectors Disk model: WDC WD30EZRX-00S Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 4096 bytes I/O size (minimum/optimal): 4096 bytes / 4096 bytes Disklabel type: gpt Disk identifier: A86E76E5-F1A9-48B2-A90A-76DDD4A35F72 Device Start End Sectors Size Type /dev/sde1 64 5860533134 5860533071 2.7T Linux filesystem Disk /dev/sdd: 2.73 TiB, 3000592982016 bytes, 5860533168 sectors Disk model: WDC WD30EZRX-00D Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 4096 bytes I/O size (minimum/optimal): 4096 bytes / 4096 bytes Disklabel type: gpt Disk identifier: 4748A929-FA9E-4DC8-9168-D48D8611E052 Device Start End Sectors Size Type /dev/sdd1 64 5860533134 5860533071 2.7T Linux filesystem Disk /dev/sdc: 2.73 TiB, 3000592982016 bytes, 5860533168 sectors Disk model: WDC WD30EZRX-00S Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 4096 bytes I/O size (minimum/optimal): 4096 bytes / 4096 bytes Disklabel type: gpt Disk identifier: 8CA4D20E-5072-4555-BC00-89062C80AD84 Device Start End Sectors Size Type /dev/sdc1 64 5860533134 5860533071 2.7T Linux filesystem Disk /dev/md1: 2.73 TiB, 3000592928768 bytes, 5860533064 sectors Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 512 bytes I/O size (minimum/optimal): 512 bytes / 512 bytes Disk /dev/md2: 2.73 TiB, 3000592928768 bytes, 5860533064 sectors Units: sectors of 1 * 512 = 512 bytes Sector size (logical/physical): 512 bytes / 512 bytes I/O size (minimum/optimal): 512 bytes / 512 bytes root@Tower:~# I'm already in the process of replacing the drives, and I'm also not in a panic (yet), so I'd rather at this point, take my time and not impact this further. Any help would be appreciated! Stephen tower-diagnostics-20210828-1338.zip

Aha! OK - I ended up replacing the ovpn file with another server (which I'd already tried). But I also removed the other config files, with the intent of the restart to rebuild them, and that did start it back working again. Thanks! Stephen

Hi! I've encountered similar issues now as other users. What I'm seeing is where my VPN will ramp up when started, but drop off to nothing. I think this started when I restarted the container, but made no other changes. It seems to be refreshing the iptables? I ran the commands from the VPN doc around iptables and the kill switch, with no help The setup: Unraid Server: 6.8.0 DelugeVPN Build: binhex/arch-delugevpn:latest VPN Provider: NordVPN My log: Created by... ___. .__ .__ \_ |__ |__| ____ | |__ ____ ___ ___ | __ \| |/ \| | \_/ __ \\ \/ / | \_\ \ | | \ Y \ ___/ > < |___ /__|___| /___| /\___ >__/\_ \ \/ \/ \/ \/ \/ https://hub.docker.com/u/binhex/ 2020-01-19 19:44:41.138319 [info] System information Linux 05efa151a05d 4.19.88-Unraid #1 SMP Mon Dec 9 11:16:40 PST 2019 x86_64 GNU/Linux 2020-01-19 19:44:41.167481 [info] PUID defined as '99' 2020-01-19 19:44:41.199017 [info] PGID defined as '100' 2020-01-19 19:44:41.916397 [info] UMASK defined as '000' 2020-01-19 19:44:41.945043 [info] Permissions already set for volume mappings 2020-01-19 19:44:41.976941 [info] DELUGE_DAEMON_LOG_LEVEL not defined,(via -e DELUGE_DAEMON_LOG_LEVEL), defaulting to 'info' 2020-01-19 19:44:42.005902 [info] DELUGE_WEB_LOG_LEVEL not defined,(via -e DELUGE_WEB_LOG_LEVEL), defaulting to 'info' 2020-01-19 19:44:42.035031 [info] VPN_ENABLED defined as 'yes' 2020-01-19 19:44:42.067262 [info] OpenVPN config file (ovpn extension) is located at /config/openvpn/us3141.nordvpn.com.udp.ovpn 2020-01-19 19:44:42.115418 [info] VPN remote line defined as 'remote 196.247.50.35 1194' 2020-01-19 19:44:42.144350 [info] VPN_REMOTE defined as '196.247.50.35' 2020-01-19 19:44:42.173703 [info] VPN_PORT defined as '1194' 2020-01-19 19:44:42.205619 [info] VPN_PROTOCOL defined as 'udp' 2020-01-19 19:44:42.236283 [info] VPN_DEVICE_TYPE defined as 'tun0' 2020-01-19 19:44:42.265470 [info] VPN_PROV defined as 'custom' 2020-01-19 19:44:42.294607 [info] LAN_NETWORK defined as '192.168.1.0/24' 2020-01-19 19:44:42.323645 [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' 2020-01-19 19:44:42.352796 [info] VPN_USER defined as '*****' 2020-01-19 19:44:42.381885 [info] VPN_PASS defined as '****' 2020-01-19 19:44:42.411762 [info] VPN_OPTIONS not defined (via -e VPN_OPTIONS) 2020-01-19 19:44:42.443510 [info] ENABLE_PRIVOXY defined as 'no' 2020-01-19 19:44:42.475901 [info] Deleting files in /tmp (non recursive)... 2020-01-19 19:44:42.504609 [info] Starting Supervisor... 2020-01-19 19:44:42,687 INFO Included extra file "/etc/supervisor/conf.d/delugevpn.conf" during parsing 2020-01-19 19:44:42,687 INFO Set uid to user 0 succeeded 2020-01-19 19:44:42,690 INFO supervisord started with pid 6 2020-01-19 19:44:43,692 INFO spawned: 'start-script' with pid 156 2020-01-19 19:44:43,693 INFO spawned: 'watchdog-script' with pid 157 2020-01-19 19:44:43,693 INFO reaped unknown pid 7 2020-01-19 19:44:43,698 DEBG 'start-script' stdout output: [info] VPN is enabled, beginning configuration of VPN [debug] Environment variables defined as follows APPLICATION=deluge BASH=/bin/bash BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath BASH_ALIASES=() BASH_ARGC=() BASH_ARGV=() BASH_CMDS=() BASH_LINENO=([0]="0") BASH_SOURCE=([0]="/root/start.sh") BASH_VERSINFO=([0]="5" [1]="0" [2]="11" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") BASH_VERSION='5.0.11(1)-release' DEBUG=true DELUGE_DAEMON_LOG_LEVEL=info DELUGE_WEB_LOG_LEVEL=info DIRSTACK=() ENABLE_PRIVOXY=no EUID=0 GROUPS=() HOME=/home/nobody HOSTNAME=05efa151a05d HOSTTYPE=x86_64 HOST_OS=Unraid IFS=$' \t\n' LANG=en_GB.UTF-8 LAN_NETWORK=192.168.1.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=100 PIPESTATUS=([0]="0") PPID=6 PS4='+ ' PUID=99 PWD=/ SHELL=/bin/bash SHELLOPTS=braceexpand:hashall:interactive-comments SHLVL=1 STRICT_PORT_FORWARD=no SUPERVISOR_ENABLED=1 SUPERVISOR_GROUP_NAME=start-script SUPERVISOR_PROCESS_NAME=start-script TERM=xterm TZ=America/New_York UID=0 2020-01-19 19:44:43,698 INFO success: start-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs) 2020-01-19 19:44:43,699 INFO success: watchdog-script entered RUNNING state, process has stayed up for > than 0 seconds (startsecs) 2020-01-19 19:44:43,699 DEBG 'start-script' stdout output: UMASK=000 VPN_CONFIG=/config/openvpn/us3141.nordvpn.com.udp.ovpn VPN_DEVICE_TYPE=tun0 VPN_ENABLED=yes VPN_OPTIONS= VPN_PASS=Ly3Pi2#0zQ68 VPN_PORT=1194 VPN_PROTOCOL=udp VPN_PROV=custom VPN_REMOTE=196.247.50.35 VPN_USER=**** _='[debug] Environment variables defined as follows' [debug] Directory listing of files in /config/openvpn as follows 2020-01-19 19:44:43,701 DEBG 'start-script' stdout output: total 12 drwxrwxr-x 2 nobody users 65 Jan 19 19:44 . drwxrwxr-x 8 nobody users 4096 Jan 19 19:44 .. -rwxrwxr-x 1 nobody users 31 Jan 19 19:37 credentials.conf -rwxrwxr-x 1 nobody users 2802 Jan 19 19:44 us3141.nordvpn.com.udp.ovpn 2020-01-19 19:44:43,707 DEBG 'start-script' stdout output: [warn] Username contains characters which could cause authentication issues, please consider changing this if possible 2020-01-19 19:44:43,710 DEBG 'start-script' stdout output: [warn] Password contains characters which could cause authentication issues, please consider changing this if possible 2020-01-19 19:44:43,732 DEBG 'start-script' stdout output: [debug] Contents of ovpn file /config/openvpn/us3141.nordvpn.com.udp.ovpn as follows... 2020-01-19 19:44:43,732 DEBG 'start-script' stdout output: remote 196.247.50.35 1194 client dev tun proto udp resolv-retry infinite remote-random nobind tun-mtu 1500 tun-mtu-extra 32 mssfix 1450 persist-key ping 15 ping-restart 0 ping-timer-rem comp-lzo no remote-cert-tls server auth-user-pass credentials.conf verb 3 pull fast-io cipher AES-256-CBC auth SHA512 <ca> 2020-01-19 19:44:43,741 DEBG 'start-script' stdout output: [info] Default route for container is 172.17.0.1 2020-01-19 19:44:43,744 DEBG 'start-script' stdout output: [info] Adding 209.222.18.222 to /etc/resolv.conf 2020-01-19 19:44:43,747 DEBG 'start-script' stdout output: [info] Adding 37.235.1.174 to /etc/resolv.conf 2020-01-19 19:44:43,749 DEBG 'start-script' stdout output: [info] Adding 1.1.1.1 to /etc/resolv.conf 2020-01-19 19:44:43,752 DEBG 'start-script' stdout output: [info] Adding 8.8.8.8 to /etc/resolv.conf 2020-01-19 19:44:43,755 DEBG 'start-script' stdout output: [info] Adding 209.222.18.218 to /etc/resolv.conf 2020-01-19 19:44:43,758 DEBG 'start-script' stdout output: [info] Adding 37.235.1.177 to /etc/resolv.conf 2020-01-19 19:44:43,761 DEBG 'start-script' stdout output: [info] Adding 1.0.0.1 to /etc/resolv.conf 2020-01-19 19:44:43,764 DEBG 'start-script' stdout output: [info] Adding 8.8.4.4 to /etc/resolv.conf 2020-01-19 19:44:43,766 DEBG 'start-script' stdout output: 196.247.50.35 2020-01-19 19:44:43,776 DEBG 'start-script' stdout output: [debug] Show name servers defined for container 2020-01-19 19:44:43,777 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 2020-01-19 19:44:43,777 DEBG 'start-script' stdout output: [debug] Show name resolution for VPN endpoint 196.247.50.35 2020-01-19 19:44:43,785 DEBG 'start-script' stdout output: ;; ->>HEADER<<- opcode: QUERY, rcode: NXDOMAIN, id: 5733 ;; flags: qr rd ra ; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0 ;; QUESTION SECTION: ;; 196.247.50.35. IN A ;; ANSWER SECTION: ;; AUTHORITY SECTION: . 86354 IN SOA a.root-servers.net. nstld.verisign-grs.com. 2020011901 1800 900 604800 86400 ;; ADDITIONAL SECTION: ;; Query time: 5 msec ;; SERVER: 8.8.8.8 ;; WHEN: Sun Jan 19 19:44:43 2020 ;; MSG SIZE rcvd: 106 2020-01-19 19:44:43,785 DEBG 'start-script' stdout output: [debug] Show contents of hosts file 2020-01-19 19:44:43,785 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.2 05efa151a05d 2020-01-19 19:44:43,791 DEBG 'start-script' stdout output: [debug] Docker interface defined as eth0 2020-01-19 19:44:43,795 DEBG 'start-script' stdout output: [debug] Docker IP defined as 172.17.0.2 2020-01-19 19:44:43,798 DEBG 'start-script' stdout output: [debug] Docker netmask defined as 255.255.0.0 2020-01-19 19:44:43,805 DEBG 'start-script' stdout output: [info] Docker network defined as 172.17.0.0/16 2020-01-19 19:44:43,808 DEBG 'start-script' stdout output: [info] Adding 192.168.1.0/24 as route via docker eth0 2020-01-19 19:44:43,809 DEBG 'start-script' stdout output: [info] ip route defined as follows... -------------------- 2020-01-19 19:44:43,810 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 2020-01-19 19:44:43,810 DEBG 'start-script' stdout output: -------------------- [debug] Modules currently loaded for kernel 2020-01-19 19:44:43,812 DEBG 'start-script' stdout output: Module Size Used by xt_nat 16384 5 xt_CHECKSUM 16384 1 ipt_REJECT 16384 2 ip6table_mangle 16384 1 ip6table_nat 16384 1 nf_nat_ipv6 16384 1 ip6table_nat ip6table_filter 16384 1 ip6_tables 24576 3 ip6table_filter,ip6table_nat,ip6table_mangle vhost_net 24576 1 tun 36864 4 vhost_net vhost 32768 1 vhost_net tap 20480 1 vhost_net veth 20480 0 ipt_MASQUERADE 16384 9 iptable_filter 16384 2 iptable_nat 16384 1 nf_nat_ipv4 16384 2 ipt_MASQUERADE,iptable_nat nf_nat 24576 3 nf_nat_ipv6,nf_nat_ipv4,xt_nat xfs 663552 2 md_mod 49152 2 iptable_mangle 16384 2 ip_tables 24576 5 iptable_filter,iptable_nat,iptable_mangle x86_pkg_temp_thermal 16384 0 intel_powerclamp 16384 0 coretemp 16384 0 kvm_intel 196608 3 kvm 380928 1 kvm_intel crct10dif_pclmul 16384 0 crc32_pclmul 16384 0 crc32c_intel 24576 0 ghash_clmulni_intel 16384 0 pcbc 16384 0 aesni_intel 200704 0 aes_x86_64 20480 1 aesni_intel crypto_simd 16384 1 aesni_intel cryptd 20480 3 crypto_simd,ghash_clmulni_intel,aesni_intel r8169 69632 0 glue_helper 16384 1 aesni_intel i2c_i801 24576 0 i2c_core 40960 1 i2c_i801 intel_cstate 16384 0 intel_uncore 102400 0 wmi_bmof 16384 0 intel_rapl_perf 16384 0 realtek 20480 1 ahci 40960 3 libahci 28672 1 ahci thermal 20480 0 video 40960 0 fan 16384 0 pcc_cpufreq 16384 0 button 16384 0 wmi 20480 1 wmi_bmof backlight 16384 1 video 2020-01-19 19:44:43,816 DEBG 'start-script' stdout output: iptable_mangle 16384 2 ip_tables 24576 5 iptable_filter,iptable_nat,iptable_mangle 2020-01-19 19:44:43,816 DEBG 'start-script' stdout output: [info] iptable_mangle support detected, adding fwmark for tables 2020-01-19 19:44:43,845 DEBG 'start-script' stdout output: [info] iptables defined as follows... -------------------- 2020-01-19 19:44:43,846 DEBG 'start-script' stdout output: -P INPUT DROP -P FORWARD DROP -P OUTPUT DROP -A INPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT -A INPUT -i eth0 -p udp -m udp --sport 1194 -j ACCEPT -A INPUT -i eth0 -p tcp -m tcp --dport 8112 -j ACCEPT -A INPUT -i eth0 -p tcp -m tcp --sport 8112 -j ACCEPT -A INPUT -s 192.168.1.0/24 -i eth0 -p tcp -m tcp --dport 58846 -j ACCEPT -A INPUT -p icmp -m icmp --icmp-type 0 -j ACCEPT -A INPUT -i lo -j ACCEPT -A INPUT -i tun0 -j ACCEPT -A OUTPUT -s 172.17.0.0/16 -d 172.17.0.0/16 -j ACCEPT -A OUTPUT -o eth0 -p udp -m udp --dport 1194 -j ACCEPT -A OUTPUT -o eth0 -p tcp -m tcp --dport 8112 -j ACCEPT -A OUTPUT -o eth0 -p tcp -m tcp --sport 8112 -j ACCEPT -A OUTPUT -d 192.168.1.0/24 -o eth0 -p tcp -m tcp --sport 58846 -j ACCEPT -A OUTPUT -p icmp -m icmp --icmp-type 8 -j ACCEPT -A OUTPUT -o lo -j ACCEPT -A OUTPUT -o tun0 -j ACCEPT 2020-01-19 19:44:43,847 DEBG 'start-script' stdout output: -------------------- 2020-01-19 19:44:43,848 DEBG 'start-script' stdout output: [debug] OpenVPN command line:- /usr/bin/openvpn --daemon --reneg-sec 0 --mute-replay-warnings --auth-nocache --setenv VPN_PROV 'custom' --setenv DEBUG 'true' --setenv VPN_DEVICE_TYPE 'tun0' --setenv VPN_ENABLED 'yes' --setenv VPN_REMOTE '196.247.50.35' --setenv APPLICATION 'deluge' --script-security 2 --writepid /root/openvpn.pid --remap-usr1 SIGHUP --log-append /dev/stdout --pull-filter ignore 'up' --pull-filter ignore 'down' --pull-filter ignore 'route-ipv6' --pull-filter ignore 'ifconfig-ipv6' --pull-filter ignore 'tun-ipv6' --pull-filter ignore 'persist-tun' --pull-filter ignore 'reneg-sec' --up /root/openvpnup.sh --up-delay --up-restart --auth-user-pass credentials.conf --cd /config/openvpn --config '/config/openvpn/us3141.nordvpn.com.udp.ovpn' [info] Starting OpenVPN... 2020-01-19 19:44:43,852 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 WARNING: file 'credentials.conf' is group or others accessible Sun Jan 19 19:44:43 2020 OpenVPN 2.4.8 [git:makepkg/3976acda9bf10b5e+] x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] built on Oct 30 2019 Sun Jan 19 19:44:43 2020 library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10 2020-01-19 19:44:43,853 DEBG 'start-script' stdout output: [info] OpenVPN started Sun Jan 19 19:44:43 2020 WARNING: --ping should normally be used with --ping-restart or --ping-exit Sun Jan 19 19:44:43 2020 NOTE: the current --script-security setting may allow this configuration to call user-defined scripts 2020-01-19 19:44:43,854 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 Outgoing Control Channel Authentication: Using 512 bit message hash 'SHA512' for HMAC authentication Sun Jan 19 19:44:43 2020 Incoming Control Channel Authentication: Using 512 bit message hash 'SHA512' for HMAC authentication 2020-01-19 19:44:43,854 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 TCP/UDP: Preserving recently used remote address: [AF_INET]196.247.50.35:1194 Sun Jan 19 19:44:43 2020 Socket Buffers: R=[212992->212992] S=[212992->212992] Sun Jan 19 19:44:43 2020 UDP link local: (not bound) Sun Jan 19 19:44:43 2020 UDP link remote: [AF_INET]196.247.50.35:1194 2020-01-19 19:44:43,860 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 TLS: Initial packet from [AF_INET]196.247.50.35:1194, sid=a08791cd ec919c53 2020-01-19 19:44:43,884 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 VERIFY OK: depth=2, C=PA, O=NordVPN, CN=NordVPN Root CA 2020-01-19 19:44:43,885 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 VERIFY OK: depth=1, C=PA, O=NordVPN, CN=NordVPN CA4 2020-01-19 19:44:43,885 DEBG 'start-script' stdout output: Sun Jan 19 19:44:43 2020 VERIFY KU OK Sun Jan 19 19:44:43 2020 Validating certificate extended key usage Sun Jan 19 19:44:43 2020 ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication Sun Jan 19 19:44:43 2020 VERIFY EKU OK Sun Jan 19 19:44:43 2020 VERIFY OK: depth=0, CN=us3141.nordvpn.com 2020-01-19 19:44:44,012 DEBG 'start-script' stdout output: Sun Jan 19 19:44:44 2020 Control Channel: TLSv1.2, cipher TLSv1.2 ECDHE-RSA-AES256-GCM-SHA384, 4096 bit RSA Sun Jan 19 19:44:44 2020 [us3141.nordvpn.com] Peer Connection Initiated with [AF_INET]196.247.50.35:1194 2020-01-19 19:44:45,245 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 SENT CONTROL [us3141.nordvpn.com]: 'PUSH_REQUEST' (status=1) 2020-01-19 19:44:45,252 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 PUSH: Received control message: 'PUSH_REPLY,redirect-gateway def1,dhcp-option DNS 103.86.96.100,dhcp-option DNS 103.86.99.100,sndbuf 524288,rcvbuf 524288,explicit-exit-notify,comp-lzo no,route-gateway 10.8.1.1,topology subnet,ping 60,ping-restart 180,ifconfig 10.8.1.30 255.255.255.0,peer-id 28,cipher AES-256-GCM' 2020-01-19 19:44:45,252 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: timers and/or timeouts modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: explicit notify parm(s) modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: compression parms modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: --sndbuf/--rcvbuf options modified Sun Jan 19 19:44:45 2020 Socket Buffers: R=[212992->1048576] S=[212992->1048576] Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: --ifconfig/up options modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: route options modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: route-related options modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: peer-id set Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: adjusting link_mtu to 1657 Sun Jan 19 19:44:45 2020 OPTIONS IMPORT: data channel crypto options modified Sun Jan 19 19:44:45 2020 Data Channel: using negotiated cipher 'AES-256-GCM' 2020-01-19 19:44:45,253 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key Sun Jan 19 19:44:45 2020 Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key Sun Jan 19 19:44:45 2020 ROUTE_GATEWAY 172.17.0.1/255.255.0.0 IFACE=eth0 HWADDR=02:42:ac:11:00:02 2020-01-19 19:44:45,253 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 TUN/TAP device tun0 opened Sun Jan 19 19:44:45 2020 TUN/TAP TX queue length set to 100 2020-01-19 19:44:45,253 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /usr/bin/ip link set dev tun0 up mtu 1500 2020-01-19 19:44:45,254 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /usr/bin/ip addr add dev tun0 10.8.1.30/24 broadcast 10.8.1.255 2020-01-19 19:44:45,255 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /root/openvpnup.sh tun0 1500 1585 10.8.1.30 255.255.255.0 init 2020-01-19 19:44:45,256 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /usr/bin/ip route add 196.247.50.35/32 via 172.17.0.1 2020-01-19 19:44:45,257 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /usr/bin/ip route add 0.0.0.0/1 via 10.8.1.1 2020-01-19 19:44:45,258 DEBG 'start-script' stdout output: [debug] Waiting for valid IP address from tunnel... 2020-01-19 19:44:45,258 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 /usr/bin/ip route add 128.0.0.0/1 via 10.8.1.1 2020-01-19 19:44:45,259 DEBG 'start-script' stdout output: Sun Jan 19 19:44:45 2020 Initialization Sequence Completed 2020-01-19 19:44:45,369 DEBG 'start-script' stdout output: [debug] Valid IP address from tunnel acquired '10.8.1.30' 2020-01-19 19:44:45,369 DEBG 'start-script' stdout output: [info] Application does not require port forwarding or VPN provider is != pia, skipping incoming port assignment 2020-01-19 19:44:45,369 DEBG 'start-script' stdout output: [info] Checking we can resolve name 'www.google.com' to address... 2020-01-19 19:44:45,378 DEBG 'start-script' stdout output: [info] DNS operational, we can resolve name 'www.google.com' to address '108.177.122.103 108.177.122.104 108.177.122.105 108.177.122.106 108.177.122.147 108.177.122.99' 2020-01-19 19:44:45,379 DEBG 'start-script' stdout output: [info] Attempting to get external IP using Name Server 'ns1.google.com'... 2020-01-19 19:44:45,440 DEBG 'start-script' stdout output: [info] Successfully retrieved external IP address 196.247.50.36 2020-01-19 19:44:45,527 DEBG 'watchdog-script' stdout output: [debug] Waiting for iptables chain policies to be in place... 2020-01-19 19:44:45,534 DEBG 'watchdog-script' stdout output: [debug] iptables chain policies are in place [info] Deluge listening interface IP 0.0.0.0 and VPN provider IP 10.8.1.30 different, marking for reconfigure 2020-01-19 19:44:45,537 DEBG 'watchdog-script' stdout output: [info] Deluge not running 2020-01-19 19:44:45,540 DEBG 'watchdog-script' stdout output: [info] Deluge Web UI not running 2020-01-19 19:44:45,540 DEBG 'watchdog-script' stdout output: [info] Attempting to start Deluge... [info] Removing deluge pid file (if it exists)... 2020-01-19 19:44:45,912 DEBG 'watchdog-script' stdout output: [info] Deluge key 'listen_interface' currently has a value of '10.8.1.17' [info] Deluge key 'listen_interface' will have a new value '10.8.1.30' [info] Writing changes to Deluge config file '/config/core.conf'... 2020-01-19 19:44:46,122 DEBG 'watchdog-script' stdout output: [info] Deluge key 'outgoing_interface' currently has a value of 'tun0' [info] Deluge key 'outgoing_interface' will have a new value 'tun0' [info] Writing changes to Deluge config file '/config/core.conf'... 2020-01-19 19:44:46,315 DEBG 'watchdog-script' stdout output: [info] Deluge key 'default_daemon' currently has a value of 'a51c36dae6ac95da1d50697a7e866896a7a15aa5' [info] Deluge key 'default_daemon' will have a new value 'a51c36dae6ac95da1d50697a7e866896a7a15aa5' [info] Writing changes to Deluge config file '/config/web.conf'... 2020-01-19 19:44:46,642 DEBG 'watchdog-script' stdout output: [info] Deluge process started [info] Waiting for Deluge process to start listening on port 58846... 2020-01-19 19:44:46,854 DEBG 'watchdog-script' stdout output: [info] Deluge process listening on port 58846 2020-01-19 19:44:47,153 DEBG 'watchdog-script' stderr output: Unable to initialize gettext/locale! 2020-01-19 19:44:47,154 DEBG 'watchdog-script' stderr output: 'ngettext' Traceback (most recent call last): File "/usr/lib/python3.8/site-packages/deluge/i18n/util.py", line 118, in setup_translation builtins.__dict__['_n'] = builtins.__dict__['ngettext'] KeyError: 'ngettext' 2020-01-19 19:44:49,588 DEBG 'watchdog-script' stdout output: [info] No torrents with state 'Error' found 2020-01-19 19:44:49,588 DEBG 'watchdog-script' stdout output: [info] Starting Deluge Web UI... 2020-01-19 19:44:49,588 DEBG 'watchdog-script' stdout output: [info] Deluge Web UI started 2020-01-19 19:44:49,588 DEBG 'watchdog-script' stdout output: [debug] VPN IP is 10.8.1.30 [debug] Deluge IP is 10.8.1.30 2020-01-19 19:44:49,887 DEBG 'watchdog-script' stderr output: Unable to initialize gettext/locale! 2020-01-19 19:44:49,888 DEBG 'watchdog-script' stderr output: 'ngettext' Traceback (most recent call last): File "/usr/lib/python3.8/site-packages/deluge/i18n/util.py", line 118, in setup_translation builtins.__dict__['_n'] = builtins.__dict__['ngettext'] KeyError: 'ngettext' 2020-01-19 19:45:19,593 DEBG 'watchdog-script' stdout output: -[debug] Waiting for iptables chain policies to be in place... 2020-01-19 19:45:19,600 DEBG 'watchdog-script' stdout output: [debug] iptables chain policies are in place 2020-01-19 19:45:19,606 DEBG 'watchdog-script' stdout output: [debug] VPN IP is 10.8.1.30 [debug] Deluge IP is 10.8.1.30