You are not logged in.

#1 2019-02-20 23:49:27

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

[SOLVED] Hamachi not starting

Hi
I was trying to set up hamachi on my router box, but I ran into strange problem:
I started logmein-hamachi service (as usual, I've done it on many other PCs without any problems) and ran hamachi in terminal, then logmein-hamachi service crashed. Then I noticed that systemd-udevd and NetworkManager were using 100% of CPU. I looked at journalctl -u systemd-udevd and noticed this loop repeating all the time:

Feb 21 00:14:54 router systemd-udevd[250]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Feb 21 00:14:54 router systemd-udevd[250]: link_config: could not get ethtool features for ham0
Feb 21 00:14:54 router systemd-udevd[250]: Could not set offload features of ham0: No such device
Feb 21 00:14:54 router systemd-udevd[250]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Feb 21 00:14:54 router systemd-udevd[250]: link_config: could not get ethtool features for ham0
Feb 21 00:14:54 router systemd-udevd[250]: Could not set offload features of ham0: No such device

In journalctl -u NetworkManager I can see another (propably related) loop:

Feb 21 00:26:56 router NetworkManager[323]: <info>  [1550705216.6618] manager: (ham0): new Tun device (/org/freedesktop/NetworkManager/Devices/272)
Feb 21 00:26:56 router NetworkManager[323]: <info>  [1550705216.7701] manager: (ham0): new Tun device (/org/freedesktop/NetworkManager/Devices/273)
Feb 21 00:26:56 router NetworkManager[323]: <info>  [1550705216.9089] manager: (ham0): new Tun device (/org/freedesktop/NetworkManager/Devices/274)
Feb 21 00:26:56 router NetworkManager[323]: <info>  [1550705216.9989] manager: (ham0): new Tun device (/org/freedesktop/NetworkManager/Devices/275)

In nmcli I couldn't see any ham0 interface.

I noticed that these loops start as soon as I launch logmein-hamachi service. The difference between them is that loop in NetworkManager stops when I crash logmein-hamachi service (to be clear, I can't stop it usual ways), but systemd-udevd doesn't stop at all, I need to reboot. Hamachi don't output anything at all to journal (this is normal, confirmed on healthy systems).

"Healthy" systems are running NetworkManager too, so I don't think this is NM specific bug. System was updated right before I installed hamachi on it.

Thanks for any help.

Last edited by Lumpiasty (2019-02-22 20:04:53)

Offline

#2 2019-02-21 09:14:16

seth
Member
Registered: 2012-09-03
Posts: 50,012

Re: [SOLVED] Hamachi not starting

Check "udevadm monitor" - it would seem the ham0 interface is constantly created and lost (also see whether "ip l" has the interface steadyly)
Watch out for remaining hamachi related processes and try to kill them.

Check the hamachi service for the cause of the crash, see the last comments on the AUR package. Are the "healthy" systems running up-to-date versions if archlinux as well?

Offline

#3 2019-02-21 20:06:18

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

Re: [SOLVED] Hamachi not starting

I just updated one working, very similar hardware-wise system and I have no problems so far. And yes, I'm talking about Arch.
When I start hamachi service, udevadm monitor start spamming messages similar to this:

KERNEL[72411.352479] remove   /devices/virtual/net/ham0 (net)
KERNEL[72411.363527] add      /devices/virtual/net/ham0 (net)
KERNEL[72411.364008] add      /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.365576] add      /devices/virtual/net/ham0/queues/tx-0 (queues)
KERNEL[72411.376923] remove   /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.377392] remove   /devices/virtual/net/ham0/queues/tx-0 (queues)
KERNEL[72411.378031] remove   /devices/virtual/net/ham0 (net)
KERNEL[72411.386761] add      /devices/virtual/net/ham0 (net)
KERNEL[72411.392157] add      /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.392253] add      /devices/virtual/net/ham0/queues/tx-0 (queues)
UDEV  [72411.402649] add      /devices/virtual/net/ham0 (net)
KERNEL[72411.406028] remove   /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.406520] remove   /devices/virtual/net/ham0/queues/tx-0 (queues)
KERNEL[72411.407116] remove   /devices/virtual/net/ham0 (net)
KERNEL[72411.420146] add      /devices/virtual/net/ham0 (net)
KERNEL[72411.420590] add      /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.420952] add      /devices/virtual/net/ham0/queues/tx-0 (queues)
UDEV  [72411.428413] add      /devices/virtual/net/ham0/queues/rx-0 (queues)
UDEV  [72411.441746] add      /devices/virtual/net/ham0/queues/tx-0 (queues)
KERNEL[72411.449377] remove   /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.450816] remove   /devices/virtual/net/ham0/queues/tx-0 (queues)
KERNEL[72411.451429] remove   /devices/virtual/net/ham0 (net)
KERNEL[72411.460139] add      /devices/virtual/net/ham0 (net)
KERNEL[72411.460588] add      /devices/virtual/net/ham0/queues/rx-0 (queues)
KERNEL[72411.460941] add      /devices/virtual/net/ham0/queues/tx-0 (queues)
UDEV  [72411.470981] remove   /devices/virtual/net/ham0/queues/rx-0 (queues)
UDEV  [72411.474621] remove   /devices/virtual/net/ham0/queues/tx-0 (queues

In "ip l" I can't see hamachi interface. After service fail there are no hamachi related processes left.
This is systemctl status logmein-hamachi output:

● logmein-hamachi.service - LogMeIn Hamachi daemon
   Loaded: loaded (/usr/lib/systemd/system/logmein-hamachi.service; disabled; vendor preset: disabled)
   Active: failed (Result: core-dump) since Thu 2019-02-21 20:42:04 CET; 4min 52s ago
  Process: 1589 ExecStart=/opt/logmein-hamachi/bin/hamachid (code=exited, status=0/SUCCESS)
 Main PID: 1590 (code=dumped, signal=SEGV)

Feb 21 20:40:16 router systemd[1]: Starting LogMeIn Hamachi daemon...
Feb 21 20:40:16 router systemd[1]: Started LogMeIn Hamachi daemon.
Feb 21 20:42:04 router systemd[1]: logmein-hamachi.service: Main process exited, code=dumped, status=11/SEGV
Feb 21 20:42:04 router systemd[1]: logmein-hamachi.service: Failed with result 'core-dump'.

Last comment on AUR package is from 2018-03-13 and the package itself was last updated 2018-08-18. I have installed it many times since then with no such problems.

Last edited by Lumpiasty (2019-02-21 20:14:45)

Offline

#4 2019-02-21 20:38:05

seth
Member
Registered: 2012-09-03
Posts: 50,012

Re: [SOLVED] Hamachi not starting

And still, hamachi segfaults (check coredumpctl, it has probably left behind a truckload of coredumps) - which will likely be the cause for the recreation of the ham0 device (and udev and networkmanager havoc in turn)

Offline

#5 2019-02-21 20:50:01

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

Re: [SOLVED] Hamachi not starting

So what can I do about these coredumps?

Thu 2019-02-21 20:42:05 CET    1590     0     0  11 present   /opt/logmein-hamachi/bin/hamachid

Offline

#6 2019-02-21 21:08:32

seth
Member
Registered: 2012-09-03
Posts: 50,012

Re: [SOLVED] Hamachi not starting

First of all: inspect them. See why hamachi crashes.

Offline

#7 2019-02-21 22:38:11

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

Re: [SOLVED] Hamachi not starting

Sorry for noob question, but where to begin? When I run coredumpctl gdb 1590 I get

GNU gdb (GDB) 8.2.1
Copyright (C) 2018 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
Type "show copying" and "show warranty" for details.
This GDB was configured as "x86_64-pc-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
    <http://www.gnu.org/software/gdb/documentation/>.

For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /opt/logmein-hamachi/bin/hamachid...(no debugging symbols found)...done.
[New LWP 1590]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/usr/lib/libthread_db.so.1".
Core was generated by `/opt/logmein-hamachi/bin/hamachid'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  0x00007f0cd12c4ca8 in _IO_default_xsputn () from /usr/lib/libc.so.6
(gdb) where
#0  0x00007f0cd12c4ca8 in _IO_default_xsputn () from /usr/lib/libc.so.6
#1  0x00007f0cd1296876 in vfprintf () from /usr/lib/libc.so.6
#2  0x00007f0cd1350c5f in __vsnprintf_chk () from /usr/lib/libc.so.6
#3  0x0000000000447291 in ?? ()
#4  0x00000000004bdb9f in ?? ()
#5  0x00000000005279e8 in ?? ()
#6  0x00000000004bdb42 in ?? ()
#7  0x0000000000527c07 in ?? ()
#8  0x0000000000527dc2 in ?? ()
#9  0x0000000000497b20 in ?? ()
#10 0x0000000000432e84 in ?? ()
#11 0x000000000050f362 in ?? ()
#12 0x000000000043255e in ?? ()
#13 0x000000000043435a in ?? ()
#14 0x0000000000503a17 in ?? ()
#15 0x000000000043175c in ?? ()
#16 0x0000000000497dde in ?? ()
#17 0x0000000000498e06 in ?? ()
#18 0x000000000043317a in ?? ()
#19 0x000000000050f362 in ?? ()
#20 0x000000000043390e in ?? ()
#21 0x0000000000498061 in ?? ()
#22 0x0000000000432e84 in ?? ()
...
#42173 0x0000000000498e06 in ?? ()
#42174 0x000000000043317a in ?? ()
#42175 0x000000000050f362 in ?? ()
#42176 0x000000000043390e in ?? ()
#42177 0x0000000000498061 in ?? ()
#42178 0x000000000049864f in ?? ()
#42179 0x00000000004987e7 in ?? ()
#42180 0x000000000044cc5f in ?? ()
#42181 0x00000000004be10c in ?? ()
#42182 0x000000000040709e in ?? ()
#42183 0x00007f0cd126a223 in __libc_start_main () from /usr/lib/libc.so.6
#42184 0x000000000040763f in ?? ()
(gdb)

I don't think this is useful, but I don't know where to start.

Last edited by Lumpiasty (2019-02-21 22:56:56)

Offline

#8 2019-02-21 23:13:38

seth
Member
Registered: 2012-09-03
Posts: 50,012

Re: [SOLVED] Hamachi not starting

Buffer overflow in string operation.
Most lines are empty, because the hamachi binary has been completely stripped of symbol names.

Try to run /opt/logmein-hamachi/bin/hamachid from an interactive shell and see whether it prints anything.

Offline

#9 2019-02-21 23:52:56

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

Re: [SOLVED] Hamachi not starting

It instantly forks to background and behave exactly like started as service.

Last edited by Lumpiasty (2019-02-21 23:58:10)

Offline

#10 2019-02-22 07:47:58

seth
Member
Registered: 2012-09-03
Posts: 50,012

Re: [SOLVED] Hamachi not starting

Move away /var/lib/logmein-hamachi/h2-engine-override.cfg, try to strace hamachi to see what happens before the segfault.

Offline

#11 2019-02-22 20:03:57

Lumpiasty
Member
Registered: 2018-07-27
Posts: 14

Re: [SOLVED] Hamachi not starting

I don't have this file as I haven't done any special configuration so far (for now I'm just trying to start it)
Here are some last lines of strace:

write(8, "02.22 20:19:42.784 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219144
fstat(8, {st_mode=S_IFREG|0644, st_size=1219144, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219144, ...}) = 0
write(8, "vpn: domain [Hamachi] -> 'VPN_se"..., 42) = 42
close(8)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219186
fstat(8, {st_mode=S_IFREG|0644, st_size=1219186, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219186, ...}) = 0
write(8, "02.22 20:19:42.790 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219205
fstat(8, {st_mode=S_IFREG|0644, st_size=1219205, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219205, ...}) = 0
write(8, "tap: config(ham0, <hamachi ip4>, "..., 50) = 50
close(8)                                = 0
socket(AF_INET, SOCK_DGRAM, IPPROTO_IP) = 8
ioctl(8, SIOCGIFFLAGS, {ifr_name="ham0", ifr_flags=IFF_UP|IFF_BROADCAST|IFF_RUNNING|IFF_MULTICAST}) = 0
ioctl(8, SIOCSIFADDR, {ifr_name="ham0", ifr_addr={sa_family=AF_INET, sin_port=htons(0), sin_addr=inet_addr("<hamachi ip4>")}}) = 0
ioctl(8, SIOCSIFNETMASK, {ifr_name="ham0", ifr_netmask={sa_family=AF_INET, sin_port=htons(0), sin_addr=inet_addr("255.0.0.0")}}) = 0
ioctl(8, SIOCSIFBRDADDR, {ifr_name="ham0", ifr_broadaddr={sa_family=AF_INET, sin_port=htons(0), sin_addr=inet_addr("25.255.255.255")}}) = 0
socket(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 9
ioctl(9, SIOCGIFINDEX, {ifr_name="ham0", }) = 0
close(9)                                = 0
socket(AF_INET6, SOCK_DGRAM, IPPROTO_IP) = 9
ioctl(9, SIOCSIFADDR, {ifr_name="& ", ifr_addr={sa_family=0x60 /* AF_??? */, sa_data="\0\0\3506\0\0\0002($kpC\264"}}) = -1 EACCES (Permission denied)
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 10
lseek(10, 0, SEEK_END)                  = 1219255
fstat(10, {st_mode=S_IFREG|0644, st_size=1219255, ...}) = 0
fstat(10, {st_mode=S_IFREG|0644, st_size=1219255, ...}) = 0
write(10, "02.22 20:19:42.802 ", 19)    = 19
close(10)                               = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 10
lseek(10, 0, SEEK_END)                  = 1219274
fstat(10, {st_mode=S_IFREG|0644, st_size=1219274, ...}) = 0
fstat(10, {st_mode=S_IFREG|0644, st_size=1219274, ...}) = 0
write(10, "tap: ioctl(SIOCSIFADDR) IPv6 err"..., 56) = 56
close(10)                               = 0
close(9)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 9
lseek(9, 0, SEEK_END)                   = 1219330
fstat(9, {st_mode=S_IFREG|0644, st_size=1219330, ...}) = 0
fstat(9, {st_mode=S_IFREG|0644, st_size=1219330, ...}) = 0
write(9, "02.22 20:19:42.809 ", 19)     = 19
close(9)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 9
lseek(9, 0, SEEK_END)                   = 1219349
fstat(9, {st_mode=S_IFREG|0644, st_size=1219349, ...}) = 0
fstat(9, {st_mode=S_IFREG|0644, st_size=1219349, ...}) = 0
write(9, "tap: if_config() -> 0\n", 22) = 22
close(9)                                = 0
close(8)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219371
fstat(8, {st_mode=S_IFREG|0644, st_size=1219371, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219371, ...}) = 0
write(8, "02.22 20:19:42.814 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219390
fstat(8, {st_mode=S_IFREG|0644, st_size=1219390, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219390, ...}) = 0
write(8, "vpn: tap config done, [failed]\n", 31) = 31
close(8)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219421
fstat(8, {st_mode=S_IFREG|0644, st_size=1219421, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219421, ...}) = 0
write(8, "02.22 20:19:42.821 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219440
fstat(8, {st_mode=S_IFREG|0644, st_size=1219440, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219440, ...}) = 0
write(8, "vpn: tap config failed, retry. ["..., 35) = 35
close(8)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219475
fstat(8, {st_mode=S_IFREG|0644, st_size=1219475, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219475, ...}) = 0
write(8, "02.22 20:19:42.828 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219494
fstat(8, {st_mode=S_IFREG|0644, st_size=1219494, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219494, ...}) = 0
write(8, "dbg: disable(Hamachi), locked: 0"..., 33) = 33
close(8)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219527
fstat(8, {st_mode=S_IFREG|0644, st_size=1219527, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219527, ...}) = 0
write(8, "02.22 20:19:42.835 ", 19)     = 19
close(8)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 8
lseek(8, 0, SEEK_END)                   = 1219546
fstat(8, {st_mode=S_IFREG|0644, st_size=1219546, ...}) = 0
fstat(8, {st_mode=S_IFREG|0644, st_size=1219546, ...}) = 0
write(8, "vpn: disabling [Hamachi] domain "..., 35) = 35
close(8)                                = 0
epoll_ctl(4, EPOLL_CTL_DEL, 7, 0x7ffe11f265f0) = 0
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219581
fstat(7, {st_mode=S_IFREG|0644, st_size=1219581, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219581, ...}) = 0
write(7, "02.22 20:19:42.857 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219600
fstat(7, {st_mode=S_IFREG|0644, st_size=1219600, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219600, ...}) = 0
write(7, "vpn: domain [Hamachi] -> 'VPN_di"..., 41) = 41
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219641
fstat(7, {st_mode=S_IFREG|0644, st_size=1219641, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219641, ...}) = 0
write(7, "02.22 20:19:42.862 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219660
fstat(7, {st_mode=S_IFREG|0644, st_size=1219660, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219660, ...}) = 0
write(7, "vpn: on_set_tapdev(, 0) -> ok\n", 30) = 30
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219690
fstat(7, {st_mode=S_IFREG|0644, st_size=1219690, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219690, ...}) = 0
write(7, "02.22 20:19:42.866 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219709
fstat(7, {st_mode=S_IFREG|0644, st_size=1219709, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219709, ...}) = 0
write(7, "vpn: domain [Hamachi] -> 'VPN_di"..., 40) = 40
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219749
fstat(7, {st_mode=S_IFREG|0644, st_size=1219749, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219749, ...}) = 0
write(7, "02.22 20:19:42.873 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219768
fstat(7, {st_mode=S_IFREG|0644, st_size=1219768, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219768, ...}) = 0
write(7, "dbg: setup_vpn_domain [Hamachi]\n", 32) = 32
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219800
fstat(7, {st_mode=S_IFREG|0644, st_size=1219800, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219800, ...}) = 0
write(7, "02.22 20:19:42.880 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219819
fstat(7, {st_mode=S_IFREG|0644, st_size=1219819, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219819, ...}) = 0
write(7, "dbg: vpn_domain::config - [Hamac"..., 36) = 36
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219855
fstat(7, {st_mode=S_IFREG|0644, st_size=1219855, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219855, ...}) = 0
write(7, "02.22 20:19:42.890 ", 19)     = 19
close(7)                                = 0
openat(AT_FDCWD, "/var/lib/logmein-hamachi/h2-engine.log", O_WRONLY|O_CREAT|O_APPEND, 0666) = 7
lseek(7, 0, SEEK_END)                   = 1219874
fstat(7, {st_mode=S_IFREG|0644, st_size=1219874, ...}) = 0
fstat(7, {st_mode=S_IFREG|0644, st_size=1219874, ...}) = 0
write(7, "dbg: enable(Hamachi), locked: 0\n", 32) = 32
close(7)                                = 0
stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2696, ...}) = 0
--- SIGSEGV {si_signo=SIGSEGV, si_code=SEGV_MAPERR, si_addr=0x7ffe11f22ff8} ---
--- SIGSEGV {si_signo=SIGSEGV, si_code=SI_KERNEL, si_addr=NULL} ---
+++ killed by SIGSEGV (core dumped) +++

I notices file: /var/lob/logmein-hamachi/h2-engine.log
I can see there (again) loop:

02.22 19:52:41.026 tap: device ham0 opened
02.22 19:52:41.046 vpn: domain [Hamachi] -> 'VPN_up'
02.22 19:52:41.067 dbg: setup_vpn_domain [Hamachi]
02.22 19:52:41.080 dbg: vpn_domain::config - [Hamachi]
02.22 19:52:41.093 vpn: domain [Hamachi] -> 'VPN_setting_up'
02.22 19:52:41.101 tap: config(ham0, <hamachi ip4>, 255.0.0.0, [/96])
02.22 19:52:41.113 tap: ioctl(SIOCSIFADDR) IPv6 err, 13, Permission denied
02.22 19:52:41.119 tap: if_config() -> 0
02.22 19:52:41.126 vpn: tap config done, [failed]
02.22 19:52:41.134 vpn: tap config failed, retry. [1]
02.22 19:52:41.139 dbg: disable(Hamachi), locked: 0
02.22 19:52:41.145 vpn: disabling [Hamachi] domain ..
02.22 19:52:41.164 vpn: domain [Hamachi] -> 'VPN_disabling'
02.22 19:52:41.174 vpn: on_set_tapdev(, 0) -> ok
02.22 19:52:41.186 vpn: domain [Hamachi] -> 'VPN_disabled'
02.22 19:52:41.193 dbg: setup_vpn_domain [Hamachi]
02.22 19:52:41.198 dbg: vpn_domain::config - [Hamachi]
02.22 19:52:41.205 dbg: enable(Hamachi), locked: 0
02.22 19:52:41.212 vpn: domain [Hamachi] -> 'VPN_opening'
02.22 19:52:41.216 vpn: enabling [Hamachi] domain ..
02.22 19:52:41.236 vpn: on_set_tapdev(, 1) -> ok
02.22 19:52:41.247 tap: device ham0 opened
02.22 19:52:41.262 vpn: domain [Hamachi] -> 'VPN_up'
02.22 19:52:41.277 dbg: setup_vpn_domain [Hamachi]
02.22 19:52:41.293 dbg: vpn_domain::config - [Hamachi]
02.22 19:52:41.306 vpn: domain [Hamachi] -> 'VPN_setting_up'
02.22 19:52:41.312 tap: config(ham0, <hamachi ip4>, 255.0.0.0, [/96])
02.22 19:52:41.336 tap: ioctl(SIOCSIFADDR) IPv6 err, 13, Permission denied
02.22 19:52:41.341 tap: if_config() -> 0
02.22 19:52:41.347 vpn: tap config done, [failed]
02.22 19:52:41.355 vpn: tap config failed, retry. [1]
02.22 19:52:41.360 dbg: disable(Hamachi), locked: 0
02.22 19:52:41.367 vpn: disabling [Hamachi] domain ..
02.22 19:52:41.395 vpn: domain [Hamachi] -> 'VPN_disabling'
02.22 19:52:41.402 vpn: on_set_tapdev(, 0) -> ok
02.22 19:52:41.415 vpn: domain [Hamachi] -> 'VPN_disabled'
02.22 19:52:41.430 dbg: setup_vpn_domain [Hamachi]
02.22 19:52:41.438 dbg: vpn_domain::config - [Hamachi]
02.22 19:52:41.443 dbg: enable(Hamachi), locked: 0
02.22 19:52:41.449 vpn: domain [Hamachi] -> 'VPN_opening'
02.22 19:52:41.456 vpn: enabling [Hamachi] domain ..
02.22 19:52:41.460 vpn: on_set_tapdev(, 1) -> ok

An interesting line:

02.22 19:52:41.336 tap: ioctl(SIOCSIFADDR) IPv6 err, 13, Permission denied

I just realised that long time ago when I was setting this thing up I had to disable IPv6 due to buggy driver for onboard network adapter. That is not case for quite a long time but I didn't turn it on because my ISP don't give IPv6 anyways.
I enabled it again and it works! Huge thanks for help.

Offline

#12 2019-05-22 16:08:18

hablutzel1
Member
Registered: 2017-09-01
Posts: 3

Re: [SOLVED] Hamachi not starting

I had the same problem. I disabled IPv6 some time ago because I am not really familiar with that protocol yet and when I tried to start Hamachi I got a lot of the following in /var/log/syslog:

May 22 09:51:33 jaime-Qosmio-X70-A systemd-udevd[27017]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 22 09:51:33 jaime-Qosmio-X70-A systemd-udevd[27017]: link_config: could not get ethtool features for ham0
May 22 09:51:33 jaime-Qosmio-X70-A systemd-udevd[27017]: Could not set offload features of ham0: No such device
May 22 09:51:33 jaime-Qosmio-X70-A gnome-shell[1730]: Removing a network device that was not added
May 22 09:51:33 jaime-Qosmio-X70-A NetworkManager[1278]: <info>  [1558536693.3576] devices added (path: /sys/devices/virtual/net/ham0, iface: ham0)
May 22 09:51:33 jaime-Qosmio-X70-A NetworkManager[1278]: <info>  [1558536693.3576] device added (path: /sys/devices/virtual/net/ham0, iface: ham0): no ifupdown configuration found.
May 22 09:51:33 jaime-Qosmio-X70-A NetworkManager[1278]: <info>  [1558536693.3613] devices removed (path: /sys/devices/virtual/net/ham0, iface: ham0)
May 22 09:51:33 jaime-Qosmio-X70-A gnome-shell[8433]: Removing a network device that was not added
May 22 09:51:33 jaime-Qosmio-X70-A charon: 16[KNL] interface ham0 activated
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: Joining mDNS multicast group on interface ham0.IPv4 with address 25.90.173.33.
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: New relevant interface ham0.IPv4 for mDNS.
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: Registering new address record for 25.90.173.33 on ham0.IPv4.
May 22 09:51:33 jaime-Qosmio-X70-A charon: 07[KNL] 25.90.173.33 appeared on ham0
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: Interface ham0.IPv4 no longer relevant for mDNS.
May 22 09:51:33 jaime-Qosmio-X70-A charon: 05[KNL] interface ham0 deactivated
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: Leaving mDNS multicast group on interface ham0.IPv4 with address 25.90.173.33.
May 22 09:51:33 jaime-Qosmio-X70-A charon: 12[KNL] 25.90.173.33 disappeared from ham0
May 22 09:51:33 jaime-Qosmio-X70-A charon: 09[KNL] interface ham0 deleted
May 22 09:51:33 jaime-Qosmio-X70-A avahi-daemon[1174]: Withdrawing address record for 25.90.173.33 on ham0.
May 22 09:51:33 jaime-Qosmio-X70-A NetworkManager[1278]: <info>  [1558536693.3701] manager: (ham0): new Tun device (/org/freedesktop/NetworkManager/Devices/4479)

So I reenabled IPv6 at the host level.

Then started Logmein Hamachi and turned off its IPv6 capability with the following:

$ sudo hamachi set-ip-mode ipv4

Then I disabled IPv6 in the host again and everything is working as expected now.

Offline

Board footer

Powered by FluxBB