Skip to main content
Topic solved
This topic has been marked as solved and requires no further attention.
Topic: Tailscale - New MachineID after Reboot - Reauth Needed and Logged out Repeatedly (Read 428 times) previous topic - next topic
0 Members and 1 Guest are viewing this topic.

Tailscale - New MachineID after Reboot - Reauth Needed and Logged out Repeatedly

Hi,

s6-init user here, but I don't think this is an s6-specific issue. I noticed that after every reboot I wasn't connected to my tailscale network - Tailscaled is set to launch on boot... A quick
Code: [Select]
tailscale status
shows that I'm logged out. Stopping and restarting the tailscaled service via s6 does not trigger the logout, it's a reboot that's needed for this. There are issues like this already reported, see [1]. Thing is I'm on Linux, and I don't think the issue is with tailscale itself since I have another Archlinux setup that has not issues like these.
Some error lines are telling me it's looking for some systemd/systemd-resolved/dbus implementation that Artix-s6 could be lacking out of the box:
Code: [Select]
2024-05-01 21:43:16.030537525  2024/05/01 21:43:16 monitor: RTM_DELROUTE: src=, dst=fe80::/64, gw=, outif=6, table=254
2024-05-01 21:43:16.030550662  2024/05/01 21:43:16 monitor: RTM_DELROUTE: src=, dst=fe80::fc54:ff:fecf:fd79/128, gw=, outif=6, table=255
2024-05-01 21:43:16.030554199  2024/05/01 21:43:16 monitor: RTM_DELROUTE: src=, dst=ff00::/8, gw=, outif=6, table=255
2024-05-01 21:43:16.043048127  2024/05/01 21:43:16 LinkChange: major, rebinding. New state: interfaces.State{defaultRoute=wlan0 ifs={tailscale0:[100.64.0.8/32 fd7a:115c:a1e0::8/128 llu6] virbr0:[192.168.122.1/24] wlan0:[192.168.1.5/24]} v4=true v6=false}
2024-05-01 21:43:16.043054363  2024/05/01 21:43:16 dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:4}
2024-05-01 21:43:16.043055588  2024/05/01 21:43:16 dns: Resolvercfg: {Routes:{} Hosts:4 LocalDomains:[]}
2024-05-01 21:43:16.043056629  2024/05/01 21:43:16 dns: OScfg: {}
2024-05-01 21:43:16.043057789  2024/05/01 21:43:16 wgengine: set DNS config again after major link change
2024-05-01 21:43:16.043122247  2024/05/01 21:43:16 onPortUpdate(port=59033, network=udp6)
2024-05-01 21:43:16.043182209  2024/05/01 21:43:16 onPortUpdate(port=39446, network=udp4)
2024-05-01 21:43:16.122588038  2024/05/01 21:43:16 Rebind; defIf="wlan0", ips=[192.168.1.5/24]
2024-05-01 21:43:16.122619734  2024/05/01 21:43:16 magicsock: 1 active derp conns: derp-18=cr16m0s,wr16m0s
2024-05-01 21:43:16.135891780  2024/05/01 21:43:16 portmapper: UPnP discovery response from non-UPnP port 60161
2024-05-01 21:43:16.176208824  2024/05/01 21:43:16 post-rebind ping of DERP region 18 okay
2024-05-01 21:43:16.374061415  2024/05/01 21:43:16 portmapper: UPnP meta changed: [{Location:http://192.168.1.1:49652/49652gatedesc.xml Server:Linux/4.4.240, UPnP/1.0, Portable SDK for UPnP devices/1.12.1 USN:uuid:00e0fc37-2525-2828-2500-C0E3FBA4EFCA::urn:schemas-upnp-org:device:InternetGatewayDevice:1}]
2024-05-01 21:43:16.374180606  2024/05/01 21:43:16 control: NetInfo: NetInfo{varies=false hairpin=false ipv6=false ipv6os=true udp=true icmpv4=false derp=#18 portmap=U link="" firewallmode="ipt-default"}
2024-05-01 21:43:16.379388568  2024/05/01 21:43:16 portmapper: saw UPnP type WANIPConnection1 at http://192.168.1.1:49652/49652gatedesc.xml; Huawei IGD (Huawei), method=single
2024-05-01 21:43:16.786617508  2024/05/01 21:43:16 control: NetInfo: NetInfo{varies=true hairpin=false ipv6=false ipv6os=true udp=true icmpv4=false derp=#18 portmap=active-U link="" firewallmode="ipt-default"}
2024-05-01 21:43:16.786663917  2024/05/01 21:43:16 magicsock: endpoints changed: <PUBLIC_IP_ADDRESS>:49756 (portmap), <PUBLIC_IP_ADDRESS>:39446 (stun), <PUBLIC_IP_ADDRESS>:54726 (portmap), 192.168.1.5:39446 (local), 192.168.122.1:39446 (local)
2024-05-01 21:43:42.488654749  2024/05/01 21:43:42 control: NetInfo: NetInfo{varies=false hairpin=false ipv6=false ipv6os=true udp=true icmpv4=false derp=#18 portmap=active-U link="" firewallmode="ipt-default"}
2024-05-01 21:43:56.622626990  2024/05/01 21:43:56 tailscaled got signal terminated; shutting down
2024-05-01 21:43:56.622635273  2024/05/01 21:43:56 control: client.Shutdown()
2024-05-01 21:43:56.622639271  2024/05/01 21:43:56 control: client.Shutdown
2024-05-01 21:43:56.622643038  2024/05/01 21:43:56 control: authRoutine: exiting
2024-05-01 21:43:56.622646839  2024/05/01 21:43:56 control: updateRoutine: exiting
2024-05-01 21:43:56.622650605  2024/05/01 21:43:56 control: mapRoutine: exiting
2024-05-01 21:43:56.622654207  2024/05/01 21:43:56 control: Client.Shutdown done.
2024-05-01 21:43:56.699790039  2024/05/01 21:43:56 magicsock: closing connection to derp-18 (conn-close), age 16m26s
2024-05-01 21:43:56.699801781  2024/05/01 21:43:56 magicsock: 0 active derp conns
2024-05-01 21:43:56.702467131  2024/05/01 21:43:56 monitor: RTM_DELROUTE: src=, dst=fe80::/64, gw=, outif=8, table=254
2024-05-01 21:43:56.704103647  2024/05/01 21:43:56 monitor: RTM_DELROUTE: src=, dst=fe80::a9bd:e0aa:6ac:53fb/128, gw=, outif=8, table=255
2024-05-01 21:43:56.704112741  2024/05/01 21:43:56 monitor: RTM_DELROUTE: src=, dst=ff00::/8, gw=, outif=8, table=255
2024-05-01 21:43:56.704121326  2024/05/01 21:43:56 monitor: ip rule deleted: {Family:2 DstLength:0 SrcLength:0 Tos:0 Table:254 Protocol:0 Scope:0 Type:1 Flags:0 Attributes:{Dst:<nil> Src:<nil> Gateway:<nil> OutIface:0 Priority:5210 Table:254 Mark:16711680 Pref:<nil> Expires:<nil> Metrics:<nil> Multipath:[]}}
2024-05-01 21:43:56.704128787  2024/05/01 21:43:56 monitor: ip rule deleted: {Family:2 DstLength:0 SrcLength:0 Tos:0 Table:253 Protocol:0 Scope:0 Type:1 Flags:0 Attributes:{Dst:<nil> Src:<nil> Gateway:<nil> OutIface:0 Priority:5230 Table:253 Mark:16711680 Pref:<nil> Expires:<nil> Metrics:<nil> Multipath:[]}}
2024-05-01 21:43:56.704133441  2024/05/01 21:43:56 monitor: ip rule deleted: {Family:2 DstLength:0 SrcLength:0 Tos:0 Table:0 Protocol:0 Scope:0 Type:7 Flags:0 Attributes:{Dst:<nil> Src:<nil> Gateway:<nil> OutIface:0 Priority:5250 Table:0 Mark:16711680 Pref:<nil> Expires:<nil> Metrics:<nil> Multipath:[]}}
2024-05-01 21:43:56.704137304  2024/05/01 21:43:56 monitor: ip rule deleted: {Family:2 DstLength:0 SrcLength:0 Tos:0 Table:52 Protocol:0 Scope:0 Type:1 Flags:0 Attributes:{Dst:<nil> Src:<nil> Gateway:<nil> OutIface:0 Priority:5270 Table:52 Mark:0 Pref:<nil> Expires:<nil> Metrics:<nil> Multipath:[]}}
2024-05-01 21:43:56.709743953  2024/05/01 21:43:56 monitor: RTM_DELROUTE: src=192.168.1.5/0, dst=192.168.1.255/32, gw=, outif=4, table=255
2024-05-01 21:43:56.709757496  2024/05/01 21:43:56 monitor: RTM_DELROUTE: src=192.168.1.5/0, dst=192.168.1.5/32, gw=, outif=4, table=255
2024-05-01 21:43:56.709762675  2024/05/01 21:43:56 [RATELIMIT] format("monitor: %s: src=%v, dst=%v, gw=%v, outif=%v, table=%v")
2024-05-01 21:43:56.844272340  2024/05/01 21:43:56 flushing log.
2024-05-01 21:43:56.844527082  2024/05/01 21:43:56 logger closing down
2024-05-01 21:44:26.119413814  2024/05/01 21:44:26 You have disabled logging. Tailscale will not be able to provide support.
2024-05-01 21:44:26.119543180  2024/05/01 21:44:26 logtail started
2024-05-01 21:44:26.119594849  2024/05/01 21:44:26 Program starting: v1.64.0, Go 1.22.2: []string{"tailscaled", "--state=/var/lib/tailscale/tailscaled.state", "--socket=/run/tailscale/tailscaled.sock", "--port", "0", "--no-logs-no-support"}
2024-05-01 21:44:26.120401118  2024/05/01 21:44:26 LogID: <very_long_random_log_identifier>
2024-05-01 21:44:26.120460334  2024/05/01 21:44:26 logpolicy: using system state directory "/var/lib/tailscale"
2024-05-01 21:44:26.120645321  2024/05/01 21:44:26 dns: ResolvConfMode error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.120706129  2024/05/01 21:44:26 dns: [rc=nm resolved=nss nm-resolved=yes nm=no resolv-conf-mode=error ret=systemd-resolved]
2024-05-01 21:44:26.120756271  2024/05/01 21:44:26 dns: using "systemd-resolved" mode
2024-05-01 21:44:26.120851474  2024/05/01 21:44:26 creating dns cleanup: route ip+net: no such network interface
2024-05-01 21:44:26.181429888  2024/05/01 21:44:26 deleting [-j ts-input] in filter/INPUT: running [/usr/bin/iptables -t filter -D INPUT -j ts-input --wait]: exit status 2: iptables v1.8.10 (legacy): Couldn't load target `ts-input':No such file or directory
2024-05-01 21:44:26.181441660 
2024-05-01 21:44:26.181454814  Try 'iptables -h' or 'iptables --help' for more information.
2024-05-01 21:44:26.182745818  2024/05/01 21:44:26 deleting [-j ts-forward] in filter/FORWARD: running [/usr/bin/iptables -t filter -D FORWARD -j ts-forward --wait]: exit status 2: iptables v1.8.10 (legacy): Couldn't load target `ts-forward':No such file or directory
2024-05-01 21:44:26.182752633 
2024-05-01 21:44:26.182757044  Try 'iptables -h' or 'iptables --help' for more information.
2024-05-01 21:44:26.292664366  2024/05/01 21:44:26 deleting [-j ts-postrouting] in nat/POSTROUTING: running [/usr/bin/iptables -t nat -D POSTROUTING -j ts-postrouting --wait]: exit status 2: iptables v1.8.10 (legacy): Couldn't load target `ts-postrouting':No such file or directory
2024-05-01 21:44:26.292672754 
2024-05-01 21:44:26.292677463  Try 'iptables -h' or 'iptables --help' for more information.
2024-05-01 21:44:26.330108670  2024/05/01 21:44:26 deleting [-j ts-input] in filter/INPUT: running [/usr/bin/ip6tables -t filter -D INPUT -j ts-input --wait]: exit status 2: ip6tables v1.8.10 (legacy): Couldn't load target `ts-input':No such file or directory
2024-05-01 21:44:26.330116261 
2024-05-01 21:44:26.330120103  Try `ip6tables -h' or 'ip6tables --help' for more information.
2024-05-01 21:44:26.331350079  2024/05/01 21:44:26 deleting [-j ts-forward] in filter/FORWARD: running [/usr/bin/ip6tables -t filter -D FORWARD -j ts-forward --wait]: exit status 2: ip6tables v1.8.10 (legacy): Couldn't load target `ts-forward':No such file or directory
2024-05-01 21:44:26.331356846 
2024-05-01 21:44:26.331361301  Try `ip6tables -h' or 'ip6tables --help' for more information.
2024-05-01 21:44:26.331376025  2024/05/01 21:44:26 [RATELIMIT] format("deleting %v in %s/%s: %v")
2024-05-01 21:44:26.381970451  2024/05/01 21:44:26 wgengine.NewUserspaceEngine(tun "tailscale0") ...
2024-05-01 21:44:26.398536726  2024/05/01 21:44:26 dns: ResolvConfMode error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.398553201  2024/05/01 21:44:26 dns: [rc=nm resolved=nss nm-resolved=yes nm=no resolv-conf-mode=error ret=systemd-resolved]
2024-05-01 21:44:26.398580247  2024/05/01 21:44:26 dns: using "systemd-resolved" mode
2024-05-01 21:44:26.399806101  2024/05/01 21:44:26 dns: dbus connection error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.401198712  2024/05/01 21:44:26 dns: using *dns.resolvedManager
2024-05-01 21:44:26.401228659  2024/05/01 21:44:26 link state: interfaces.State{defaultRoute= ifs={} v4=false v6=false}
2024-05-01 21:44:26.401519519  2024/05/01 21:44:26 onPortUpdate(port=40259, network=udp6)
2024-05-01 21:44:26.401543179  2024/05/01 21:44:26 router: using firewall mode pref
2024-05-01 21:44:26.401554635  2024/05/01 21:44:26 router: default choosing iptables
2024-05-01 21:44:26.406273840  2024/05/01 21:44:26 dns: dbus connection error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.415013755  2024/05/01 21:44:26 router: v6 = true, v6filter = true, v6nat = true
2024-05-01 21:44:26.415022068  2024/05/01 21:44:26 onPortUpdate(port=58887, network=udp4)
2024-05-01 21:44:26.415024938  2024/05/01 21:44:26 magicsock: disco key = d:7c91808a4a29c523
2024-05-01 21:44:26.415027380  2024/05/01 21:44:26 magicsock: SetNetworkUp(false)
2024-05-01 21:44:26.415029720  2024/05/01 21:44:26 Creating WireGuard device...
2024-05-01 21:44:26.415043383  2024/05/01 21:44:26 Bringing WireGuard device up...
2024-05-01 21:44:26.415783975  2024/05/01 21:44:26 Bringing router up...
2024-05-01 21:44:26.421370524  2024/05/01 21:44:26 external route: up
2024-05-01 21:44:26.421517658  2024/05/01 21:44:26 Clearing router settings...
2024-05-01 21:44:26.421562629  2024/05/01 21:44:26 Starting network monitor...
2024-05-01 21:44:26.421613723  2024/05/01 21:44:26 Engine created.
2024-05-01 21:44:26.423769569  2024/05/01 21:44:26 pm: migrating "_daemon" profile to new format
2024-05-01 21:44:26.426500151  2024/05/01 21:44:26 envknob: TS_NO_LOGS_NO_SUPPORT="true"
2024-05-01 21:44:26.426507745  2024/05/01 21:44:26 logpolicy: using system state directory "/var/lib/tailscale"
2024-05-01 21:44:26.426561041  2024/05/01 21:44:26 got LocalBackend in 45ms
2024-05-01 21:44:26.426605118  2024/05/01 21:44:26 Start
2024-05-01 21:44:26.450109370  2024/05/01 21:44:26 Backend: logs: be:<very_long_random_logs_identifier> fe:
2024-05-01 21:44:26.450373668  2024/05/01 21:44:26 control: setPaused(true)
2024-05-01 21:44:26.450494993  2024/05/01 21:44:26 control: mapRoutine: awaiting unpause
2024-05-01 21:44:26.450959616  2024/05/01 21:44:26 control: authRoutine: awaiting unpause
2024-05-01 21:44:26.451002731  2024/05/01 21:44:26 control: updateRoutine: awaiting unpause
2024-05-01 21:44:26.451038889  2024/05/01 21:44:26 Switching ipn state NoState -> NeedsLogin (WantRunning=false, nm=false)
2024-05-01 21:44:26.451105340  2024/05/01 21:44:26 blockEngineUpdates(true)
2024-05-01 21:44:26.451225433  2024/05/01 21:44:26 health("overall"): error: state=NeedsLogin, wantRunning=false
2024-05-01 21:44:26.451784770  2024/05/01 21:44:26 wgengine: Reconfig: configuring userspace WireGuard config (with 0/0 peers)
2024-05-01 21:44:26.451860301  2024/05/01 21:44:26 wgengine: Reconfig: configuring router
2024-05-01 21:44:26.451909579  2024/05/01 21:44:26 wgengine: Reconfig: configuring DNS
2024-05-01 21:44:26.451964725  2024/05/01 21:44:26 dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}
2024-05-01 21:44:26.452008804  2024/05/01 21:44:26 dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}
2024-05-01 21:44:26.452047243  2024/05/01 21:44:26 dns: OScfg: {}
2024-05-01 21:44:26.452105831  2024/05/01 21:44:26 dns: failed to configure resolved: resolved DBus does not have a connection
2024-05-01 21:44:26.452224623  2024/05/01 21:44:26 Reconfig(down): resolved DBus does not have a connection
2024-05-01 21:44:26.452360173  2024/05/01 21:44:26 health("dns-os"): error: resolved DBus does not have a connection
2024-05-01 21:44:26.452471736  2024/05/01 21:44:26 health("dns"): error: resolved DBus does not have a connection
2024-05-01 21:44:26.458509119  2024/05/01 21:44:26 dns: dbus connection error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.562690641  2024/05/01 21:44:26 dns: dbus connection error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.727739496  2024/05/01 21:44:26 dns: dbus connection error: dial unix /var/run/dbus/system_bus_socket: connect: no such file or directory
2024-05-01 21:44:26.727842321  2024/05/01 21:44:26 [RATELIMIT] format("dns: dbus connection error: %v")
2024-05-01 21:44:30.889412418  2024/05/01 21:44:30 health("dns-os"): ok
2024-05-01 21:44:32.630551092  2024/05/01 21:44:32 monitor: RTM_DELROUTE: src=, dst=ff00::/8, gw=, outif=4, table=255
2024-05-01 21:44:32.635023894  2024/05/01 21:44:32 monitor: RTM_NEWROUTE: src=, dst=192.168.1.1/32, gw=, outif=4, table=254
2024-05-01 21:44:32.635029949  2024/05/01 21:44:32 monitor: RTM_NEWROUTE: src=, dst=, gw=192.168.1.1, outif=4, table=254
2024-05-01 21:44:32.749614193  2024/05/01 21:44:32 monitor: RTM_NEWROUTE: src=192.168.1.5/0, dst=192.168.1.5/32, gw=, outif=4, table=255
2024-05-01 21:44:32.749622809  2024/05/01 21:44:32 monitor: RTM_NEWROUTE: src=192.168.1.5/0, dst=192.168.1.255/32, gw=, outif=4, table=255
2024-05-01 21:44:32.749624086  2024/05/01 21:44:32 [RATELIMIT] format("monitor: %s: src=%v, dst=%v, gw=%v, outif=%v, table=%v")
2024-05-01 21:44:32.882827882  2024/05/01 21:44:32 LinkChange: major, rebinding. New state: interfaces.State{defaultRoute=wlan0 ifs={wlan0:[192.168.1.5/24]} v4=true v6=false}
2024-05-01 21:44:32.882914362  2024/05/01 21:44:32 magicsock: SetNetworkUp(true)
2024-05-01 21:44:32.882970145  2024/05/01 21:44:32 dns: Set: {DefaultResolvers:[] Routes:{} SearchDomains:[] Hosts:0}
2024-05-01 21:44:32.883018891  2024/05/01 21:44:32 dns: Resolvercfg: {Routes:{} Hosts:0 LocalDomains:[]}
2024-05-01 21:44:32.883094331  2024/05/01 21:44:32 dns: OScfg: {}
2024-05-01 21:44:32.883195086  2024/05/01 21:44:32 control: setPaused(false)
2024-05-01 21:44:32.884397701  2024/05/01 21:44:32 dns: failed to configure resolved: setLinkDNS: The name org.freedesktop.resolve1 was not provided by any .service files
2024-05-01 21:44:32.884519407  2024/05/01 21:44:32 wgengine: error setting DNS config after major link change: setLinkDNS: The name org.freedesktop.resolve1 was not provided by any .service files
2024-05-01 21:44:32.884610666  2024/05/01 21:44:32 health("dns-os"): error: setLinkDNS: The name org.freedesktop.resolve1 was not provided by any .service files
2024-05-01 21:44:32.884859518  2024/05/01 21:44:32 onPortUpdate(port=40259, network=udp6)
2024-05-01 21:44:32.885164509  2024/05/01 21:44:32 onPortUpdate(port=58887, network=udp4)
2024-05-01 21:44:32.885319658  2024/05/01 21:44:32 Rebind; defIf="wlan0", ips=[192.168.1.5/24]
2024-05-01 21:44:32.885415433  2024/05/01 21:44:32 magicsock: 0 active derp conns
2024-05-01 21:44:32.886251269  2024/05/01 21:44:32 monitor: gateway and self IP changed: gw=192.168.1.1 self=192.168.1.5
To be more specific and if I'm not mistaken it tries to check the DNS, tells itself that NetworkManager is not used (it is), falls back to systemd-resolved for this, tries some iptables trickery and fails miserably. The DBUS connection fails as well (it's running as a service on boot), and there's no org.freedesktop.resolve1. I hope there is no hardcoded systemd dependency and a workaround can be provided.
Hope I provided everything needed for now.

Re: Tailscale - New MachineID after Reboot - Reauth Needed and Logged out Repeatedly

Reply #1
Is this issue so hard to solve? Still no answer, I can understand devs don't always have the time but I'm starting to think I'm the only Tailscale artix user here?

Re: Tailscale - New MachineID after Reboot - Reauth Needed and Logged out Repeatedly

Reply #2
Had to do this myself. Problem is related to this issue on GitHub, same behaviour here. What I did was simply inspecting the "run" file inside the tailscale-srv folder [ /etc/s6/sv/tailscaled-srv/run ]. Changed the file contents to this and everything worked (since the tailscale.state file is not under /var anymore):
Code: [Select]
#!/bin/execlineb -P
envfile /etc/s6/config/tailscale.conf
importas -uD "0" PORT PORT
importas -sCuD "" OPTS OPTS
fdmove -c 2 1
exec tailscaled --state=/home/user/.local/lib/tailscale/tailscaled.state --socket=/run/tailscale/tailscaled.sock --port $PORT $OPTS