Jump to content


Photo

Eddie standalone flips its sh*t on Gentoo


Best Answer overmorrow, 15 September 2018 - 07:19 AM

Is the path hardcoded to /sbin/ip ? My installation has the ip binary in /bin/ip. I'm going to try to see if a symlink fixes the problem.

And it did.

 

A couple of suggestions for the devs:

  • Rather than hard code the paths, would it be possible to use the $PATH variable like most programs do?
  • Infinite loops are bad. An error like "could not execute external program" is not likely to go away by retrying, and should therefore cause a single failure and then stop execution, rather than an infinite loop.
  • Could you please name the process "eddie", "airvpn" or something less generic than "Main" so that one will have any clue what to look for should things go south?

Anyway this issue is solved.

Go to the full post


  • Please log in to reply
5 replies to this topic

#1 overmorrow

overmorrow

    Newbie

  • Members
  • Pip
  • 6 posts

Posted 14 September 2018 - 05:47 PM

This didn't use to be a problem. Eddie up to 2.12-ish(?) worked just fine, but with the current version it always tries to connect to Alderamin, Austria, it almost instantly fails (seemingly without even trying) and goes into an infinite loop of "Connection terminated."-messages, which it spams at a rate of dozens per second.

 

It also refuses to die. Closing it by any normal means does a big fat nothing. In fact I haven't been able to kill it at all because I can't even figure out what the process name is. Because of this it's almost impossible to troubleshoot. What's going on? Is there some part of the "standalone" Eddie that isn't really standalone, and that my Gentoo setup might be missing? Pointers would be appreciated.



#2 giganerd

giganerd

    I shall have no title

  • Members
  • PipPipPip
  • 2510 posts
  • LocationGermany

Posted 14 September 2018 - 10:50 PM

The logfile could help us understand the issue better. Also, try deleting the AirVPN.xml.

 

Somewhere in 2.15 or so the binary was renamed from airvpn to eddie-ui. Look for this one next time.


Always remember:
There's a guide to AirVPN,

Amazon IPs are not dangerous here,
running TOR exits is discouraged,

using spoilers for your logs is the proper way to heaven.
Same issues are rare! Search for solutions and if not successful open your own threads.

~ Furthermore, I propose that your paranoia is to be destroyed. ~

 


#3 overmorrow

overmorrow

    Newbie

  • Members
  • Pip
  • 6 posts

Posted 15 September 2018 - 06:13 AM

The logfile could help us understand the issue better.

I'm sure it would help me as well, but since Eddie hangs/goes in to infinite loop instantly, there's no way to extract the logfile. :no: That is unless Eddie has some other methods of log extraction than the "save logs"-icon, that I'm unaware of...

 

Also, try deleting the AirVPN.xml.

Unfortunately that doesn't help.

 

Somewhere in 2.15 or so the binary was renamed from airvpn to eddie-ui. Look for this one next time.

I've looked for anything and everything that looks like eddie, air or vpn-anything. There just aren't any such processes running (even though the window is clearly visible on my desktop). The closest thing that I've found are some kdesu/kdesu_stub -processes which I assume Eddie uses to gain the privileges that it needs, but killing those makes no difference.



#4 overmorrow

overmorrow

    Newbie

  • Members
  • Pip
  • 6 posts

Posted 15 September 2018 - 07:08 AM

That is unless Eddie has some other methods of log extraction than the "save logs"-icon, that I'm unaware of...

And of course looking more closely at the settings there is. Furthermore by carefully looking at the process list before and after launching Eddie, I discovered that the process in named "Main", which is... shall we say ...less than intuitive. <_<

 

Anyway, here's the log:

I 2018.09.15 09:33:21 - Session starting.
. 2018.09.15 09:33:21 - Shell(19) of '/bin/ps', 2 args: '-eo';'pid,command';
. 2018.09.15 09:33:21 - Shell(19) done in 12 ms, exit: 0, out: 'PID COMMAND
. 2018.09.15 09:33:21 -     1 init [3]
. 2018.09.15 09:33:21 -     2 [kthreadd]
. 2018.09.15 09:33:21 -     3 [kworker/0:0]
. 2018.09.15 09:33:21 -     4 [kworker/0:0H]
. 2018.09.15 09:33:21 -     6 [mm_percpu_wq]
. 2018.09.15 09:33:21 -     7 [ksoftirqd/0]
. 2018.09.15 09:33:21 -     8 [rcu_preempt]
. 2018.09.15 09:33:21 -     9 [rcu_sched]
. 2018.09.15 09:33:21 -     10 [rcu_bh]
. 2018.09.15 09:33:21 -     11 [migration/0]
. 2018.09.15 09:33:21 -     12 [cpuhp/0]
. 2018.09.15 09:33:21 -     13 [cpuhp/1]
. 2018.09.15 09:33:21 -     14 [migration/1]
. 2018.09.15 09:33:21 -     15 [ksoftirqd/1]
. 2018.09.15 09:33:21 -     17 [kworker/1:0H]
. 2018.09.15 09:33:21 -     18 [cpuhp/2]
. 2018.09.15 09:33:21 -     19 [migration/2]
. 2018.09.15 09:33:21 -     20 [ksoftirqd/2]
. 2018.09.15 09:33:21 -     22 [kworker/2:0H]
. 2018.09.15 09:33:21 -     23 [cpuhp/3]
. 2018.09.15 09:33:21 -     24 [migration/3]
. 2018.09.15 09:33:21 -     25 [ksoftirqd/3]
. 2018.09.15 09:33:21 -     28 [kdevtmpfs]
. 2018.09.15 09:33:21 -     29 [netns]
. 2018.09.15 09:33:21 -     30 [kworker/u8:1]
. 2018.09.15 09:33:21 -     41 [kworker/1:1]
. 2018.09.15 09:33:21 -     43 [kworker/3:1]
. 2018.09.15 09:33:21 -     303 [kworker/2:1]
. 2018.09.15 09:33:21 -     304 [oom_reaper]
. 2018.09.15 09:33:21 -     305 [writeback]
. 2018.09.15 09:33:21 -     307 [kcompactd0]
. 2018.09.15 09:33:21 -     308 [khugepaged]
. 2018.09.15 09:33:21 -     309 [crypto]
. 2018.09.15 09:33:21 -     310 [kintegrityd]
. 2018.09.15 09:33:21 -     312 [kblockd]
. 2018.09.15 09:33:21 -     434 [ata_sff]
. 2018.09.15 09:33:21 -     669 [kswapd0]
. 2018.09.15 09:33:21 -     990 [scsi_eh_0]
. 2018.09.15 09:33:21 -     991 [scsi_tmf_0]
. 2018.09.15 09:33:21 -     1005 [scsi_eh_1]
. 2018.09.15 09:33:21 -     1006 [scsi_tmf_1]
. 2018.09.15 09:33:21 -     1009 [scsi_eh_2]
. 2018.09.15 09:33:21 -     1010 [scsi_tmf_2]
. 2018.09.15 09:33:21 -     1056 [kworker/2:2]
. 2018.09.15 09:33:21 -     1076 [kworker/0:2]
. 2018.09.15 09:33:21 -     1089 [dm_bufio_cache]
. 2018.09.15 09:33:21 -     1090 [kmpathd]
. 2018.09.15 09:33:21 -     1091 [kmpath_handlerd]
. 2018.09.15 09:33:21 -     1117 [kworker/3:2]
. 2018.09.15 09:33:21 -     3377 [rpciod]
. 2018.09.15 09:33:21 -     3378 [xprtiod]
. 2018.09.15 09:33:21 -     3383 [nfsiod]
. 2018.09.15 09:33:21 -     3635 [kworker/1:1H]
. 2018.09.15 09:33:21 -     3642 [kdmflush]
. 2018.09.15 09:33:21 -     3643 [bioset]
. 2018.09.15 09:33:21 -     3644 [kcryptd_io]
. 2018.09.15 09:33:21 -     3646 [kcryptd]
. 2018.09.15 09:33:21 -     3647 [dmcrypt_write]
. 2018.09.15 09:33:21 -     3648 [bioset]
. 2018.09.15 09:33:21 -     3658 [kdmflush]
. 2018.09.15 09:33:21 -     3659 [bioset]
. 2018.09.15 09:33:21 -     3663 [kdmflush]
. 2018.09.15 09:33:21 -     3664 [bioset]
. 2018.09.15 09:33:21 -     3668 [kdmflush]
. 2018.09.15 09:33:21 -     3669 [bioset]
. 2018.09.15 09:33:21 -     3685 [kworker/u9:2]
. 2018.09.15 09:33:21 -     3686 [kworker/u9:3]
. 2018.09.15 09:33:21 -     3687 [kworker/u9:4]
. 2018.09.15 09:33:21 -     3688 [jbd2/dm-1-8]
. 2018.09.15 09:33:21 -     3689 [ext4-rsv-conver]
. 2018.09.15 09:33:21 -     3691 [kworker/3:1H]
. 2018.09.15 09:33:21 -     4044 /sbin/udevd --daemon
. 2018.09.15 09:33:21 -     4104 [kworker/2:1H]
. 2018.09.15 09:33:21 -     4151 [ttm_swap]
. 2018.09.15 09:33:21 -     4277 [kworker/0:1H]
. 2018.09.15 09:33:21 -     4430 [jbd2/dm-3-8]
. 2018.09.15 09:33:21 -     4431 [ext4-rsv-conver]
. 2018.09.15 09:33:21 -     4432 [jbd2/sda1-8]
. 2018.09.15 09:33:21 -     4433 [ext4-rsv-conver]
. 2018.09.15 09:33:21 -     4646 /usr/bin/dbus-daemon --system
. 2018.09.15 09:33:21 -     4680 /usr/sbin/console-kit-daemon
. 2018.09.15 09:33:21 -     4697 /usr/lib/polkit-1/polkitd --no-debug
. 2018.09.15 09:33:21 -     4932 metalog [MASTER]
. 2018.09.15 09:33:21 -     4933 metalog [KERNEL]
. 2018.09.15 09:33:21 -     5147 dhcpcd -m 3 eth0
. 2018.09.15 09:33:21 -     5262 /usr/sbin/sshd -o PidFile=/run/sshd.pid -f /etc/ssh/sshd_config
. 2018.09.15 09:33:21 -     5296 /usr/sbin/cron
. 2018.09.15 09:33:21 -     5379 /usr/bin/sddm
. 2018.09.15 09:33:21 -     5420 /sbin/agetty 38400 tty1 linux
. 2018.09.15 09:33:21 -     5421 /sbin/agetty 38400 tty2 linux
. 2018.09.15 09:33:21 -     5422 /sbin/agetty 38400 tty3 linux
. 2018.09.15 09:33:21 -     5423 /sbin/agetty 38400 tty4 linux
. 2018.09.15 09:33:21 -     5424 /sbin/agetty 38400 tty5 linux
. 2018.09.15 09:33:21 -     5425 /sbin/agetty 38400 tty6 linux
. 2018.09.15 09:33:21 -     5432 [kworker/u8:6]
. 2018.09.15 09:33:21 -     5435 /usr/bin/X -nolisten tcp -auth /var/run/sddm/{3cdbb8ed-079a-4c14-9713-9eadb546417b} -background none -noreset -displayfd 18 -seat seat0 vt7
. 2018.09.15 09:33:21 -     5450 dbus-launch --autolaunch 95b38b9b2efb068a09800d285b980cd6 --binary-syntax --close-stderr
. 2018.09.15 09:33:21 -     5451 /usr/bin/dbus-daemon --fork --print-pid 5 --print-address 7 --session
. 2018.09.15 09:33:21 -     5462 [kworker/3:2H]
. 2018.09.15 09:33:21 -     5466 [kworker/2:2H]
. 2018.09.15 09:33:21 -     5468 /usr/libexec/sddm-helper --socket /tmp/sddm-auth4818d687-5b99-4dad-85d8-8ba4b5a21305 --id 1 --start /usr/bin/startkde --user redacted
. 2018.09.15 09:33:21 -     5469 /usr/bin/ck-launch-session /usr/bin/dbus-launch --exit-with-session /usr/bin/startkde
. 2018.09.15 09:33:21 -     5489 /bin/sh /usr/bin/startkde
. 2018.09.15 09:33:21 -     5492 /usr/bin/dbus-launch --exit-with-session /usr/bin/startkde
. 2018.09.15 09:33:21 -     5493 /usr/bin/dbus-daemon --fork --print-pid 5 --print-address 7 --session
. 2018.09.15 09:33:21 -     5521 /usr/lib64/libexec/kf5/start_kdeinit --kded +kcminit_startup
. 2018.09.15 09:33:21 -     5522 kdeinit5: Running...
. 2018.09.15 09:33:21 -     5523 /usr/lib64/libexec/kf5/klauncher --fd=9
. 2018.09.15 09:33:21 -     5526 kded5 [kdeinit5]
. 2018.09.15 09:33:21 -     5538 /usr/libexec/udisks2/udisksd
. 2018.09.15 09:33:21 -     5544 /usr/bin/kaccess
. 2018.09.15 09:33:21 -     5546 kwrapper5 /usr/bin/ksmserver
. 2018.09.15 09:33:21 -     5548 /usr/bin/ksmserver
. 2018.09.15 09:33:21 -     5552 /usr/lib/upower/upowerd
. 2018.09.15 09:33:21 -     5577 /usr/bin/kglobalaccel5
. 2018.09.15 09:33:21 -     5583 /usr/libexec/dconf-service
. 2018.09.15 09:33:21 -     5588 kwin_x11 -session 10c86c6172000153698732400000055480004_1536992242_108162
. 2018.09.15 09:33:21 -     5590 /usr/bin/krunner
. 2018.09.15 09:33:21 -     5592 /usr/bin/plasmashell
. 2018.09.15 09:33:21 -     5594 /usr/lib64/libexec/polkit-kde-authentication-agent-1
. 2018.09.15 09:33:21 -     5596 /usr/bin/xembedsniproxy
. 2018.09.15 09:33:21 -     5603 /usr/bin/kmix -session 10c86c6172000153698732400000055480005_1536992227_710673
. 2018.09.15 09:33:21 -     5623 /usr/bin/kactivitymanagerd start-daemon
. 2018.09.15 09:33:21 -     5666 /usr/bin/kuiserver5
. 2018.09.15 09:33:21 -     5671 /usr/bin/konsole
. 2018.09.15 09:33:21 -     5676 /bin/bash
. 2018.09.15 09:33:21 -     5714 /usr/lib64/libexec/kf5/kdesud
. 2018.09.15 09:33:21 -     5807 /usr/bin/kdesu konsole
. 2018.09.15 09:33:21 -     5834 /bin/su root -c /usr/lib64/libexec/kf5/kdesu_stub -
. 2018.09.15 09:33:21 -     5837 /usr/lib64/libexec/kf5/kdesu_stub
. 2018.09.15 09:33:21 -     5840 konsole
. 2018.09.15 09:33:21 -     5846 dbus-launch --autolaunch 95b38b9b2efb068a09800d285b980cd6 --binary-syntax --close-stderr
. 2018.09.15 09:33:21 -     5847 /usr/bin/dbus-daemon --fork --print-pid 5 --print-address 7 --session
. 2018.09.15 09:33:21 -     5851 /bin/bash
. 2018.09.15 09:33:21 -     5897 /usr/bin/kdesu -u root -d -c /home/redacted/download/eddie-ui_2.16.3_linux_x64_portable/eddie-ui  console.mode=none linux.dbus=unix:abstract=/tmp/dbus-YL1J1ZlPu0,guid=617d037fedf60b23fc8706365b9ca45c
. 2018.09.15 09:33:21 -     5910 /bin/su root -c /usr/lib64/libexec/kf5/kdesu_stub -
. 2018.09.15 09:33:21 -     5913 /usr/lib64/libexec/kf5/kdesu_stub
. 2018.09.15 09:33:21 -     5916 /home/redacted/download/eddie-ui_2.16.3_linux_x64_portable/eddie-ui console.mode=none linux.dbus=unix:abstract=/tmp/dbus-YL1J1ZlPu0,guid=617d037fedf60b23fc8706365b9ca45c
. 2018.09.15 09:33:21 -     6028 [kworker/1:0]
. 2018.09.15 09:33:21 -     6058 [kworker/1:3H]
. 2018.09.15 09:33:21 -     6069 [kworker/3:3H]
. 2018.09.15 09:33:21 -     6078 [kworker/0:3H]
. 2018.09.15 09:33:21 -     6180 [kworker/u9:1]
. 2018.09.15 09:33:21 -     6181 [kworker/1:2]
. 2018.09.15 09:33:21 -     6196 [kworker/2:3H]
. 2018.09.15 09:33:21 -     6197 [kworker/3:0H]
. 2018.09.15 09:33:21 -     6214 [kworker/0:2H]
. 2018.09.15 09:33:21 -     6222 [kworker/1:2H]
. 2018.09.15 09:33:21 -     6281 /bin/ps -eo pid,command'
I 2018.09.15 09:33:21 - Checking authorization ...
! 2018.09.15 09:33:22 - Connecting to Baten (Lithuania, Siauliai)
. 2018.09.15 09:33:22 - OpenVPN > OpenVPN 2.4.6 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Apr 27 2018
. 2018.09.15 09:33:22 - OpenVPN > library versions: OpenSSL 1.1.0h  27 Mar 2018, LZO 2.10
. 2018.09.15 09:33:22 - Connection to OpenVPN Management Interface
. 2018.09.15 09:33:22 - OpenVPN > MANAGEMENT: TCP Socket listening on [AF_INET]127.0.0.1:3100
. 2018.09.15 09:33:22 - OpenVPN > Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
. 2018.09.15 09:33:22 - OpenVPN > Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
. 2018.09.15 09:33:22 - OpenVPN > TCP/UDP: Preserving recently used remote address: [AF_INET]46.166.165.124:443
. 2018.09.15 09:33:22 - OpenVPN > Socket Buffers: R=[212992->212992] S=[212992->212992]
. 2018.09.15 09:33:22 - OpenVPN > UDP link local: (not bound)
. 2018.09.15 09:33:22 - OpenVPN > UDP link remote: [AF_INET]46.166.165.124:443
. 2018.09.15 09:33:22 - OpenVPN > TLS: Initial packet from [AF_INET]46.166.165.124:443, sid=08306119 7ec92f84
. 2018.09.15 09:33:22 - OpenVPN > MANAGEMENT: Client connected from [AF_INET]127.0.0.1:3100
. 2018.09.15 09:33:22 - OpenVPN > VERIFY OK: depth=1, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=airvpn.org CA, emailAddress=info@airvpn.org
. 2018.09.15 09:33:22 - OpenVPN > VERIFY KU OK
. 2018.09.15 09:33:22 - OpenVPN > Validating certificate extended key usage
. 2018.09.15 09:33:22 - OpenVPN > ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
. 2018.09.15 09:33:22 - OpenVPN > VERIFY EKU OK
. 2018.09.15 09:33:22 - OpenVPN > VERIFY OK: depth=0, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=Baten, emailAddress=info@airvpn.org
. 2018.09.15 09:33:22 - OpenVPN > Control Channel: TLSv1.2, cipher TLSv1.2 ECDHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
. 2018.09.15 09:33:22 - OpenVPN > [Baten] Peer Connection Initiated with [AF_INET]46.166.165.124:443
. 2018.09.15 09:33:23 - OpenVPN > SENT CONTROL [Baten]: 'PUSH_REQUEST' (status=1)
. 2018.09.15 09:33:23 - OpenVPN > 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.6.99 255.255.0.0,peer-id 20,cipher AES-256-GCM'
. 2018.09.15 09:33:23 - OpenVPN > Pushed option removed by filter: 'redirect-gateway def1 bypass-dhcp'
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: timers and/or timeouts modified
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: compression parms modified
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: --ifconfig/up options modified
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: route-related options modified
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: peer-id set
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: adjusting link_mtu to 1625
. 2018.09.15 09:33:23 - OpenVPN > OPTIONS IMPORT: data channel crypto options modified
. 2018.09.15 09:33:23 - OpenVPN > Data Channel: using negotiated cipher 'AES-256-GCM'
. 2018.09.15 09:33:23 - OpenVPN > Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
. 2018.09.15 09:33:23 - OpenVPN > Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
. 2018.09.15 09:33:23 - OpenVPN > ROUTE_GATEWAY 192.168.1.1/255.255.255.0 IFACE=eth0 HWADDR=bc:5f:f4:ec:cd:d4
. 2018.09.15 09:33:23 - OpenVPN > TUN/TAP device tun0 opened
. 2018.09.15 09:33:23 - OpenVPN > TUN/TAP TX queue length set to 100
. 2018.09.15 09:33:23 - OpenVPN > do_ifconfig, tt->did_ifconfig_ipv6_setup=0
. 2018.09.15 09:33:23 - OpenVPN > /sbin/ip link set dev tun0 up mtu 1500
. 2018.09.15 09:33:23 - OpenVPN > Linux ip link set failed: could not execute external program
. 2018.09.15 09:33:23 - OpenVPN > Exiting due to fatal error
! 2018.09.15 09:33:23 - Disconnecting
. 2018.09.15 09:33:23 - Connection terminated.
I 2018.09.15 09:33:26 - Checking authorization ...
! 2018.09.15 09:33:27 - Connecting to Alderamin (Austria, Vienna)
. 2018.09.15 09:33:27 - OpenVPN > OpenVPN 2.4.6 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] built on Apr 27 2018
. 2018.09.15 09:33:27 - OpenVPN > library versions: OpenSSL 1.1.0h  27 Mar 2018, LZO 2.10
. 2018.09.15 09:33:27 - Connection to OpenVPN Management Interface
. 2018.09.15 09:33:27 - OpenVPN > MANAGEMENT: TCP Socket listening on [AF_INET]127.0.0.1:3100
. 2018.09.15 09:33:27 - OpenVPN > Outgoing Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
. 2018.09.15 09:33:27 - OpenVPN > Incoming Control Channel Authentication: Using 160 bit message hash 'SHA1' for HMAC authentication
. 2018.09.15 09:33:27 - OpenVPN > TCP/UDP: Preserving recently used remote address: [AF_INET]185.9.19.106:443
. 2018.09.15 09:33:27 - OpenVPN > Socket Buffers: R=[212992->212992] S=[212992->212992]
. 2018.09.15 09:33:27 - OpenVPN > UDP link local: (not bound)
. 2018.09.15 09:33:27 - OpenVPN > UDP link remote: [AF_INET]185.9.19.106:443
. 2018.09.15 09:33:27 - OpenVPN > TLS: Initial packet from [AF_INET]185.9.19.106:443, sid=99fa0b52 74f0aa36
. 2018.09.15 09:33:27 - OpenVPN > MANAGEMENT: Client connected from [AF_INET]127.0.0.1:3100
. 2018.09.15 09:33:27 - OpenVPN > VERIFY OK: depth=1, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=airvpn.org CA, emailAddress=info@airvpn.org
. 2018.09.15 09:33:27 - OpenVPN > VERIFY KU OK
. 2018.09.15 09:33:27 - OpenVPN > Validating certificate extended key usage
. 2018.09.15 09:33:27 - OpenVPN > ++ Certificate has EKU (str) TLS Web Server Authentication, expects TLS Web Server Authentication
. 2018.09.15 09:33:27 - OpenVPN > VERIFY EKU OK
. 2018.09.15 09:33:27 - OpenVPN > VERIFY OK: depth=0, C=IT, ST=IT, L=Perugia, O=airvpn.org, CN=Alderamin, emailAddress=info@airvpn.org
. 2018.09.15 09:33:27 - OpenVPN > Control Channel: TLSv1.2, cipher TLSv1.2 DHE-RSA-AES256-GCM-SHA384, 4096 bit RSA
. 2018.09.15 09:33:27 - OpenVPN > [Alderamin] Peer Connection Initiated with [AF_INET]185.9.19.106:443
. 2018.09.15 09:33:28 - OpenVPN > SENT CONTROL [Alderamin]: 'PUSH_REQUEST' (status=1)
. 2018.09.15 09:33:29 - OpenVPN > PUSH: Received control message: 'PUSH_REPLY,comp-lzo no,redirect-gateway ipv6 def1 bypass-dhcp,dhcp-option DNS 10.5.236.1,dhcp-option DNS6 fde6:7a:7d20:1ec::1,tun-ipv6,route-gateway 10.5.236.1,topology subnet,ping 10,ping-restart 60,ifconfig-ipv6 fde6:7a:7d20:1ec::1097/64 fde6:7a:7d20:1ec::1,ifconfig 10.5.236.153 255.255.255.0,peer-id 6,cipher AES-256-GCM'
. 2018.09.15 09:33:29 - OpenVPN > Pushed option removed by filter: 'redirect-gateway ipv6 def1 bypass-dhcp'
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: timers and/or timeouts modified
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: compression parms modified
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: --ifconfig/up options modified
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: route-related options modified
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: --ip-win32 and/or --dhcp-option options modified
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: peer-id set
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: adjusting link_mtu to 1625
. 2018.09.15 09:33:29 - OpenVPN > OPTIONS IMPORT: data channel crypto options modified
. 2018.09.15 09:33:29 - OpenVPN > Data Channel: using negotiated cipher 'AES-256-GCM'
. 2018.09.15 09:33:29 - OpenVPN > Outgoing Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
. 2018.09.15 09:33:29 - OpenVPN > Incoming Data Channel: Cipher 'AES-256-GCM' initialized with 256 bit key
. 2018.09.15 09:33:29 - OpenVPN > ROUTE_GATEWAY 192.168.1.1/255.255.255.0 IFACE=eth0 HWADDR=bc:5f:f4:ec:cd:d4
. 2018.09.15 09:33:29 - OpenVPN > GDG6: remote_host_ipv6=n/a
. 2018.09.15 09:33:29 - OpenVPN > GDG6: NLMSG_ERROR: error Operation not supported
. 2018.09.15 09:33:29 - OpenVPN > ROUTE6: default_gateway=UNDEF
. 2018.09.15 09:33:29 - OpenVPN > TUN/TAP device tun0 opened
. 2018.09.15 09:33:29 - OpenVPN > TUN/TAP TX queue length set to 100
. 2018.09.15 09:33:29 - OpenVPN > do_ifconfig, tt->did_ifconfig_ipv6_setup=1
. 2018.09.15 09:33:29 - OpenVPN > /sbin/ip link set dev tun0 up mtu 1500
. 2018.09.15 09:33:29 - OpenVPN > Linux ip link set failed: could not execute external program
. 2018.09.15 09:33:29 - OpenVPN > Exiting due to fatal error
! 2018.09.15 09:33:29 - Disconnecting
. 2018.09.15 09:33:29 - Connection terminated.
I 2018.09.15 09:33:32 - Checking authorization ...
! 2018.09.15 09:33:32 - Connecting to Alderamin (Austria, Vienna)

***
Repeat ad infinitum
***

. 2018.09.15 09:33:57 - Received signal SIGTERM
. 2018.09.15 09:33:57 - Shutdown in progress
I 2018.09.15 09:33:58 - Cancel requested.
! 2018.09.15 09:33:58 - Session terminated.
. 2018.09.15 09:33:59 - Shutdown complete

The crucial point where things go wrong, seems to be:

. 2018.09.15 09:33:29 - OpenVPN > /sbin/ip link set dev tun0 up mtu 1500
. 2018.09.15 09:33:29 - OpenVPN > Linux ip link set failed: could not execute external program

Is the path hardcoded to /sbin/ip ? My installation has the ip binary in /bin/ip. I'm going to try to see if a symlink fixes the problem.



#5 overmorrow

overmorrow

    Newbie

  • Members
  • Pip
  • 6 posts

Posted 15 September 2018 - 07:19 AM   Best Answer

Is the path hardcoded to /sbin/ip ? My installation has the ip binary in /bin/ip. I'm going to try to see if a symlink fixes the problem.

And it did.

 

A couple of suggestions for the devs:

  • Rather than hard code the paths, would it be possible to use the $PATH variable like most programs do?
  • Infinite loops are bad. An error like "could not execute external program" is not likely to go away by retrying, and should therefore cause a single failure and then stop execution, rather than an infinite loop.
  • Could you please name the process "eddie", "airvpn" or something less generic than "Main" so that one will have any clue what to look for should things go south?

Anyway this issue is solved.



#6 Staff

Staff

    Advanced Member

  • Staff
  • PipPipPip
  • 7508 posts

Posted 15 September 2018 - 08:20 PM

Is the path hardcoded to /sbin/ip ? My installation has the ip binary in /bin/ip. I'm going to try to see if a symlink fixes the problem.

And it did.

 

A couple of suggestions for the devs:

  • Rather than hard code the paths, would it be possible to use the $PATH variable like most programs do?

 

Hello!

 

Please note that /sbin/ip is required by OpenVPN. It's OpenVPN that throws the error, not Eddie, so you could send your suggestion to OpenVPN developers. You will face the very same problem without Eddie, by running OpenVPN directly.

 

Remember that Eddie is an OpenVPN frontend and wrapper which adds several functions in your system (for example correct DNS push handling, which OpenVPN does not do by its own in Linux, iptables rules to prevent leaks and many more), but can't overcome certain OpenVPN hard coded limitations.

 

Of course we could re-compile OpenVPN with some patch about this issue but that would not solve the problem if you kept using the OpenVPN version you find in the official repositories. Additionally, spreading different branches poses various, complex issues, including security issues (especially when dealing with the execution of external binaries), which must be considered. We prefer, at the moment, to stick to OpenVPN official versions unless some critical bug fix is absolutely necessary and the fix is delayed by OpenVPN developers, a case which should never occur, or at least it should occur only under exceptional circumstances.

 

. 2018.09.15 09:33:23 - OpenVPN > /sbin/ip link set dev tun0 up mtu 1500
. 2018.09.15 09:33:23 - OpenVPN > Linux ip link set failed: could not execute external program

 

  • Infinite loops are bad. An error like "could not execute external program" is not likely to go away by retrying, and should therefore cause a single failure and then stop execution, rather than an infinite loop.

 

It's OpenVPN that exits when it can't find /sbin/ip . Of course your suggestion can be translated into an invitation to implement a better OpenVPN errors handling by Eddie, that's true.

 

 

  • Could you please name the process "eddie", "airvpn" or something less generic than "Main" so that one will have any clue what to look for should things go south?

Anyway this issue is solved.

 

 

The following command will let you see any process related to Eddie:

ps aux | grep -i eddie | grep -v grep

I'm sure it would help me as well, but since Eddie hangs/goes in to infinite loop instantly, there's no way to extract the logfile. :no: That is unless Eddie has some other methods of log extraction than the "save logs"-icon, that I'm unaware of...

 

Eddie can save the log to a file, and can even divide the log for you into multiple files according to day, month, day of week, etc., check "Preferences" > "Logging" please.

 

Kind regards







Similar Topics Collapse

0 user(s) are reading this topic

0 members, 0 guests, 0 anonymous users

Servers online. Online Sessions: 14600 - BW: 53185 Mbit/sYour IP: 54.162.159.33Guest Access.