mullvad / mullvadvpn-app

The Mullvad VPN client app for desktop and mobile
https://mullvad.net/
GNU General Public License v3.0
4.99k stars 337 forks source link

Applications (unable to reproduce which ones in particular) hang when Lockdown Mode is enabled and VPN is running #6523

Closed AyazJenkins closed 2 months ago

AyazJenkins commented 2 months ago

Is it a bug?

I have checked if others have reported this already

Current Behavior

Applications hang when attempting to open them with Mullvad connected. Attempting to execute them makes them hang with no sign of life for about 10–15 minutes, then they open. This is happening to many Java applications and Firefox.

Expected Behavior

I expect my apps to open normally, with no problem.

Steps to Reproduce

1.Launch Mullvad VPN, connect to any server 2.Enable lockdown mode

Failure Logs

System information:
id: 71ab22ac-eac2-4c47-812e-565a7740fcb8
kernel: 6.9.10-200.fc40.x86_64
mullvad-product-version: 2024.4
nm: 1.46.2
os: Linux Fedora Linux 40 (Workstation Edition)
systemd: systemd 255 (255.8-1.fc40)
wireguard: 1.0.0

====================
Log: /var/log/mullvad-vpn/early-boot-fw.log
====================
[2024-07-28 09:16:27.897][mullvad_daemon::version][INFO] Starting mullvad-daemon - 2024.4 2024-07-23
[2024-07-28 09:16:27.897][mullvad_daemon::settings][INFO] Loading settings from /etc/mullvad-vpn/settings.json
[2024-07-28 09:16:27.897][mullvad_daemon::early_boot_firewall][INFO] Applying firewall policy Blocked. Blocking LAN. Allowing endpoint: none
[2024-07-28 09:16:27.897][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: none

====================
Log: /var/log/mullvad-vpn/daemon.old.log
====================
[2024-07-27 15:49:13.474][mullvad_daemon::version][INFO] Starting mullvad-daemon - 2024.4 2024-07-23
[2024-07-27 15:49:13.474][mullvad_daemon][INFO] Logging to /var/log/mullvad-vpn
[2024-07-27 15:49:13.474][mullvad_daemon][INFO] Management interface listening on /var/run/mullvad-vpn
[2024-07-27 15:49:13.474][mullvad_api::address_cache][DEBUG] Loading API addresses from /var/cache/mullvad-vpn/api-ip-address.txt
[2024-07-27 15:49:13.474][mullvad_api::address_cache][DEBUG] Using API address: [REDACTED]:443
[2024-07-27 15:49:13.474][mullvad_api::availability][DEBUG] Suspending API requests
[2024-07-27 15:49:13.474][mullvad_daemon::settings][INFO] Loading settings from /etc/mullvad-vpn/settings.json
[2024-07-27 15:49:13.474][mullvad_daemon::settings][INFO] No settings were found. Using defaults.
[2024-07-27 15:49:13.474][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-27 15:49:13.477][mullvad_relay_selector::relay_selector::parsed_relays][DEBUG] Reading relays from /var/cache/mullvad-vpn/relays.json
[2024-07-27 15:49:13.477][mullvad_relay_selector::relay_selector::parsed_relays][DEBUG] Reading relays from /opt/Mullvad VPN/resources/relays.json
[2024-07-27 15:49:13.479][mullvad_relay_selector::relay_selector][INFO] Initialized with 688 cached relays from 2024-07-23 17:52:45.000
[2024-07-27 15:49:13.482][mullvad_api::availability][DEBUG] Pausing background API requests
[2024-07-27 15:49:13.482][mullvad_daemon::account_history][INFO] Opening account history file in /etc/mullvad-vpn/account-history.json
[2024-07-27 15:49:13.484][mullvad_daemon::target_state][DEBUG] No cached target state to load
[2024-07-27 15:49:13.485][talpid_core::firewall][INFO] Resetting firewall policy
[2024-07-27 15:49:13.485][talpid_core::firewall::imp][DEBUG] Removing table and chain from netfilter
[2024-07-27 15:49:13.494][mullvad_daemon::api][INFO] Initial offline state - online
[2024-07-27 15:49:13.495][mullvad_daemon::version_check][DEBUG] Loading version check cache from /var/cache/mullvad-vpn/version-info.json
[2024-07-27 15:49:13.495][mullvad_daemon::version_check][WARN] Error: Unable to load cached version info
Caused by: Failed to open app version cache file for reading
Caused by: No such file or directory (os error 2)
[2024-07-27 15:49:13.495][mullvad_api::availability][DEBUG] Unsuspending API requests
[2024-07-27 15:49:13.495][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-27 15:49:13.649][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-27 15:49:14.658][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-27 15:49:15.200][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-27 15:49:18.071][mullvad_daemon::management_interface][DEBUG] is_performing_post_upgrade
[2024-07-27 15:49:18.079][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-27 15:49:18.081][mullvad_daemon::management_interface][DEBUG] get_tunnel_state
[2024-07-27 15:49:18.116][mullvad_daemon::management_interface][DEBUG] get_device
[2024-07-27 15:49:18.118][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-27 15:49:18.118][mullvad_daemon::management_interface][DEBUG] get_settings
[2024-07-27 15:49:18.124][mullvad_daemon::management_interface][DEBUG] get_current_api_access_method
[2024-07-27 15:49:18.126][mullvad_daemon::management_interface][DEBUG] get_relay_locations
[2024-07-27 15:49:18.158][mullvad_daemon::management_interface][DEBUG] get_current_version
[2024-07-27 15:49:18.160][mullvad_daemon::management_interface][DEBUG] get_version_info
[2024-07-27 15:49:18.239][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-27 15:49:18.239][mullvad_relay_selector::relay_selector::detailer][INFO] Selected Shadowsocks bridge se-got-br-001 at [REDACTED]:1234/UDP
[2024-07-27 15:49:18.239][mullvad_daemon::api][INFO] A new API access method has been selected: Mullvad Bridges
[2024-07-27 15:49:18.240][mullvad_daemon::management_interface][DEBUG] Broadcasting access method event
[2024-07-27 15:49:18.632][mullvad_daemon::version_check][DEBUG] Writing version check cache to /var/cache/mullvad-vpn/version-info.json
[2024-07-27 15:49:18.632][mullvad_daemon::management_interface][DEBUG] Broadcasting new app version info
[2024-07-27 15:49:21.199][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-27 15:49:38.853][mullvad_daemon::management_interface][DEBUG] login_account
[2024-07-27 15:49:38.853][mullvad_api::access][DEBUG] Fetching access token for an account
[2024-07-27 15:49:39.947][mullvad_api::availability][DEBUG] Resuming background API requests
[2024-07-27 15:49:39.964][mullvad_daemon::management_interface][DEBUG] Broadcasting device event
[2024-07-27 15:49:40.005][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 15:49:40.005][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-27 15:49:40.254][mullvad_daemon::relay_list][DEBUG] Writing relays cache to /var/cache/mullvad-vpn/relays.json
[2024-07-27 15:49:40.257][mullvad_relay_selector::relay_selector::parsed_relays][INFO] Updated relay inventory has 689 relays
[2024-07-27 15:49:40.257][mullvad_daemon::management_interface][DEBUG] Broadcasting new relay list
[2024-07-27 15:49:46.861][mullvad_daemon::management_interface][DEBUG] set_auto_connect(true)
[2024-07-27 15:49:46.861][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-27 15:49:46.867][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-27 15:49:50.264][mullvad_daemon::management_interface][DEBUG] set_block_when_disconnected(true)
[2024-07-27 15:49:50.265][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-27 15:49:50.268][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-27 15:49:50.268][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: [REDACTED]:1234/TCP
[2024-07-27 15:49:50.277][mullvad_daemon][DEBUG] New tunnel state: Disconnected { location: None, locked_down: true }
[2024-07-27 15:49:50.277][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-27 15:49:50.277][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: Connection refused (os error 111)
Caused by: Connection refused (os error 111)
[2024-07-27 15:49:50.901][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: Connection refused (os error 111)
Caused by: Connection refused (os error 111)
[2024-07-27 15:49:50.933][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: Connection refused (os error 111)
Caused by: Connection refused (os error 111)
[2024-07-27 15:49:50.985][mullvad_daemon::management_interface][DEBUG] set_relay_settings
[2024-07-27 15:49:50.986][mullvad_types::settings][DEBUG] Changing relay settings:
    from: Tunnel protocol: any
OpenVPN constraints: any port
Wireguard constraints: any port
Location: country se
Provider(s): any
Ownership: any
    to: Tunnel protocol: WireGuard
OpenVPN constraints: any port
Wireguard constraints: any port
Location: country se
Provider(s): any
Ownership: any
[2024-07-27 15:49:50.986][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-27 15:49:50.991][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-27 15:49:50.992][mullvad_daemon][INFO] Initiating tunnel restart because the relay settings changed
[2024-07-27 15:49:51.624][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: Connection refused (os error 111)
Caused by: Connection refused (os error 111)
[2024-07-27 15:50:01.106][mullvad_daemon::management_interface][DEBUG] connect_tunnel
[2024-07-27 15:50:01.106][mullvad_daemon][DEBUG] Target state Unsecured => Secured
[2024-07-27 15:50:01.107][mullvad_daemon::tunnel][DEBUG] Same IP is NOT being used
[2024-07-27 15:50:01.107][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:19152/UDP, Blocking LAN, interface: none. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:01.118][mullvad_daemon][DEBUG] New tunnel state: Connecting { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:19152, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: None }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Sweden", city: Some("Stockholm"), latitude: 59.3289, longitude: 18.0649, mullvad_exit_ip: true, hostname: Some("se-sto-wg-005"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-27 15:50:01.118][mullvad_daemon][DEBUG] Settings: openvpn mssfix: unset, wg mtu: unset, wg ip version: any, multihop: off, ipv6 (tun): off, lan: off, pq: auto, obfs: auto, dns: default
[2024-07-27 15:50:01.119][talpid_wireguard][DEBUG] Tunnel MTU: 1380
[2024-07-27 15:50:01.137][talpid_wireguard][DEBUG] Using kernel WireGuard implementation
[2024-07-27 15:50:01.138][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:19152/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:01.149][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 32 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: true, mtu: None }}
[2024-07-27 15:50:01.149][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:19152/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:01.162][talpid_wireguard][DEBUG] Requesting ephemeral peer
[2024-07-27 15:50:01.162][talpid_tunnel_config_client][DEBUG] Config client socket MSS: 496
[2024-07-27 15:50:08.371][talpid_wireguard][DEBUG] Retrieved ephemeral peer
[2024-07-27 15:50:08.390][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:19152/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: All), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:08.396][talpid_wireguard::mtu_detection][DEBUG] Starting MTU detection
[2024-07-27 15:50:08.497][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 0 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: false, mtu: None }}
[2024-07-27 15:50:08.497][talpid_core::firewall][INFO] Applying firewall policy: Connected to [REDACTED]:19152/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None), Blocking LAN
[2024-07-27 15:50:08.506][talpid_core::dns][INFO] Setting DNS servers to [REDACTED]
[2024-07-27 15:50:08.507][talpid_core::dns::imp][DEBUG] Managing DNS via systemd-resolved
[2024-07-27 15:50:08.509][mullvad_daemon][DEBUG] New tunnel state: Connected { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:19152, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: Some("wg0-mullvad") }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Sweden", city: Some("Stockholm"), latitude: 59.3289, longitude: 18.0649, mullvad_exit_ip: true, hostname: Some("se-sto-wg-005"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-27 15:50:08.509][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-27 15:50:08.592][talpid_wireguard::mtu_detection][DEBUG] MTU 1380 verified to not drop packets
[2024-07-27 15:50:17.166][mullvad_daemon::management_interface][DEBUG] set_relay_settings
[2024-07-27 15:50:17.166][mullvad_types::settings][DEBUG] Changing relay settings:
    from: Tunnel protocol: WireGuard
OpenVPN constraints: any port
Wireguard constraints: any port
Location: country se
Provider(s): any
Ownership: any
    to: Tunnel protocol: WireGuard
OpenVPN constraints: any port
Wireguard constraints: any port
Location: country tr
Provider(s): any
Ownership: any
[2024-07-27 15:50:17.166][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-27 15:50:17.171][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-27 15:50:17.172][mullvad_daemon][INFO] Initiating tunnel restart because the relay settings changed
[2024-07-27 15:50:17.172][talpid_core::dns][INFO] Resetting DNS
[2024-07-27 15:50:17.175][talpid_routing::imp::imp][DEBUG] Clearing routes
[2024-07-27 15:50:17.175][mullvad_daemon][DEBUG] New tunnel state: Disconnecting(Reconnect)
[2024-07-27 15:50:17.254][talpid_core::tunnel_state_machine::connecting_state][DEBUG] Tunnel monitor exited with block reason: None
[2024-07-27 15:50:17.254][mullvad_daemon::tunnel][DEBUG] Same IP is NOT being used
[2024-07-27 15:50:17.254][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:26242/UDP, Blocking LAN, interface: none. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:17.267][mullvad_daemon][DEBUG] New tunnel state: Connecting { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:26242, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: None }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-27 15:50:17.267][mullvad_daemon][DEBUG] Settings: openvpn mssfix: unset, wg mtu: unset, wg ip version: any, multihop: off, ipv6 (tun): off, lan: off, pq: auto, obfs: auto, dns: default
[2024-07-27 15:50:17.267][talpid_wireguard][DEBUG] Tunnel MTU: 1380
[2024-07-27 15:50:17.293][talpid_wireguard][DEBUG] Using kernel WireGuard implementation
[2024-07-27 15:50:17.294][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:26242/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:17.304][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 32 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: true, mtu: None }}
[2024-07-27 15:50:17.304][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:26242/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:17.314][talpid_wireguard][DEBUG] Requesting ephemeral peer
[2024-07-27 15:50:17.314][talpid_tunnel_config_client][DEBUG] Config client socket MSS: 496
[2024-07-27 15:50:17.706][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: failed to lookup address information: Temporary failure in name resolution
Caused by: failed to lookup address information: Temporary failure in name resolution
[2024-07-27 15:50:18.446][talpid_wireguard][DEBUG] Retrieved ephemeral peer
[2024-07-27 15:50:18.460][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:26242/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: All), Blocking LAN. Allowing endpoint [REDACTED]:1234/TCP
[2024-07-27 15:50:18.465][talpid_wireguard::mtu_detection][DEBUG] Starting MTU detection
[2024-07-27 15:50:18.516][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 0 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: false, mtu: None }}
[2024-07-27 15:50:18.516][talpid_core::firewall][INFO] Applying firewall policy: Connected to [REDACTED]:26242/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None), Blocking LAN
[2024-07-27 15:50:18.527][talpid_core::dns][INFO] Setting DNS servers to [REDACTED]
[2024-07-27 15:50:18.528][talpid_core::dns::imp][DEBUG] Managing DNS via systemd-resolved
[2024-07-27 15:50:18.529][mullvad_daemon][DEBUG] New tunnel state: Connected { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:26242, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: Some("wg0-mullvad") }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-27 15:50:18.530][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-27 15:50:18.549][talpid_wireguard::mtu_detection][DEBUG] MTU 1380 verified to not drop packets
[2024-07-27 15:50:23.141][mullvad_daemon][DEBUG] Location from am.i.mullvad.net belongs to an outdated tunnel state
[2024-07-27 15:50:34.128][mullvad_daemon][DEBUG] Location from am.i.mullvad.net belongs to an outdated tunnel state
[2024-07-27 15:51:01.180][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 15:51:49.682][mullvad_daemon::management_interface][DEBUG] test_api_access_method_by_id
[2024-07-27 15:51:49.999][mullvad_daemon][DEBUG] API access method Direct could successfully connect to the Mullvad API
[2024-07-27 15:51:51.906][mullvad_daemon::management_interface][DEBUG] test_api_access_method_by_id
[2024-07-27 15:51:51.906][mullvad_relay_selector::relay_selector::detailer][INFO] Selected Shadowsocks bridge cz-prg-br-101 at [REDACTED]:1236/UDP
[2024-07-27 15:51:52.362][mullvad_daemon][DEBUG] API access method Mullvad Bridges could successfully connect to the Mullvad API
[2024-07-27 15:51:52.364][mullvad_daemon::management_interface][DEBUG] set_api_access_method
[2024-07-27 15:51:52.365][mullvad_relay_selector::relay_selector::detailer][INFO] Selected Shadowsocks bridge ch-zrh-br-001 at [REDACTED]:1234/UDP
[2024-07-27 15:51:52.365][mullvad_daemon::api][INFO] A new API access method has been selected: Mullvad Bridges
[2024-07-27 15:51:52.365][mullvad_daemon::management_interface][DEBUG] Broadcasting access method event
[2024-07-27 15:52:01.169][mullvad_daemon::management_interface][DEBUG] test_api_access_method_by_id
[2024-07-27 15:52:01.447][mullvad_daemon][DEBUG] API access method Direct could successfully connect to the Mullvad API
[2024-07-27 15:52:01.449][mullvad_daemon::management_interface][DEBUG] set_api_access_method
[2024-07-27 15:52:01.449][mullvad_daemon::api][INFO] A new API access method has been selected: Direct
[2024-07-27 15:52:01.449][mullvad_daemon::management_interface][DEBUG] Broadcasting access method event
[2024-07-27 16:04:13.786][mullvad_daemon::api_address_updater][DEBUG] Fetched new API address [REDACTED]:443. Fetching again in 24 hours
[2024-07-27 16:44:22.277][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 16:49:40.830][mullvad_daemon::relay_list][DEBUG] Writing relays cache to /var/cache/mullvad-vpn/relays.json
[2024-07-27 16:49:40.838][mullvad_relay_selector::relay_selector::parsed_relays][INFO] Updated relay inventory has 689 relays
[2024-07-27 16:49:40.838][mullvad_daemon::management_interface][DEBUG] Broadcasting new relay list
[2024-07-27 16:50:25.613][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 16:55:02.233][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 16:56:45.816][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 16:58:15.862][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 17:01:21.872][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 17:49:41.244][mullvad_daemon::relay_list][DEBUG] Relay list is up-to-date
[2024-07-27 18:05:18.241][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 18:49:41.711][mullvad_daemon::relay_list][DEBUG] Relay list is up-to-date
[2024-07-27 19:49:42.095][mullvad_daemon::relay_list][DEBUG] Relay list is up-to-date
[2024-07-27 20:20:40.174][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 20:33:17.634][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-27 20:33:25.804][mullvad_daemon::shutdown::platform][DEBUG] Process received signal: [Term]
[2024-07-27 20:33:25.923][mullvad_daemon][DEBUG] Blocking firewall during shutdown since system is going down
[2024-07-27 20:33:25.924][talpid_core::dns][INFO] Resetting DNS
[2024-07-27 20:33:25.928][talpid_routing::imp::imp][DEBUG] Clearing routes
[2024-07-27 20:33:25.929][mullvad_daemon][DEBUG] New tunnel state: Disconnecting(Nothing)
[2024-07-27 20:33:26.001][talpid_core::tunnel_state_machine::connecting_state][DEBUG] Tunnel monitor exited with block reason: None
[2024-07-27 20:33:26.002][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: [REDACTED]:443/TCP
[2024-07-27 20:33:26.011][mullvad_daemon][DEBUG] New tunnel state: Disconnected { location: None, locked_down: true }
[2024-07-27 20:33:26.012][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-27 20:33:26.012][mullvad_daemon::device][DEBUG] Account manager has stopped
[2024-07-27 20:33:26.012][talpid_core::dns][INFO] Resetting DNS
[2024-07-27 20:33:26.012][talpid_core::tunnel_state_machine][DEBUG] Tunnel state machine exited
[2024-07-27 20:33:26.013][talpid_core::tunnel_state_machine][INFO] Tunnel state machine shut down
[2024-07-27 20:33:26.013][mullvad_daemon][INFO] Mullvad daemon is quitting
[2024-07-27 20:33:26.017][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: failed to lookup address information: Temporary failure in name resolution
Caused by: failed to lookup address information: Temporary failure in name resolution
[2024-07-27 20:33:26.028][mullvad_daemon::management_interface][INFO] Management interface shut down
[2024-07-27 20:33:26.513][mullvad_daemon][DEBUG] Process exiting with code 0

====================
Log: /var/log/mullvad-vpn/daemon.log
====================
[2024-07-28 09:16:33.407][mullvad_daemon::version][INFO] Starting mullvad-daemon - 2024.4 2024-07-23
[2024-07-28 09:16:33.407][mullvad_daemon][INFO] Logging to /var/log/mullvad-vpn
[2024-07-28 09:16:33.407][mullvad_daemon][INFO] Management interface listening on /var/run/mullvad-vpn
[2024-07-28 09:16:33.407][mullvad_api::address_cache][DEBUG] Loading API addresses from /var/cache/mullvad-vpn/api-ip-address.txt
[2024-07-28 09:16:33.407][mullvad_api::address_cache][DEBUG] Using API address: [REDACTED]:443
[2024-07-28 09:16:33.407][mullvad_api::availability][DEBUG] Suspending API requests
[2024-07-28 09:16:33.408][mullvad_daemon::settings][INFO] Loading settings from /etc/mullvad-vpn/settings.json
[2024-07-28 09:16:33.408][mullvad_relay_selector::relay_selector::parsed_relays][DEBUG] Reading relays from /var/cache/mullvad-vpn/relays.json
[2024-07-28 09:16:33.422][mullvad_relay_selector::relay_selector::parsed_relays][DEBUG] Reading relays from /opt/Mullvad VPN/resources/relays.json
[2024-07-28 09:16:33.438][mullvad_relay_selector::relay_selector][INFO] Initialized with 689 cached relays from 2024-07-27 16:49:40.834
[2024-07-28 09:16:33.439][mullvad_api::availability][DEBUG] Pausing background API requests
[2024-07-28 09:16:33.439][mullvad_daemon::account_history][INFO] Opening account history file in /etc/mullvad-vpn/account-history.json
[2024-07-28 09:16:33.439][mullvad_daemon][INFO] Automatically connecting since auto-connect is turned on
[2024-07-28 09:16:33.439][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: [REDACTED]:443/TCP
[2024-07-28 09:16:33.457][mullvad_daemon::api][INFO] Initial offline state - offline
[2024-07-28 09:16:33.457][mullvad_api::availability][DEBUG] Pausing API requests due to being offline
[2024-07-28 09:16:33.457][mullvad_daemon::version_check][DEBUG] Loading version check cache from /var/cache/mullvad-vpn/version-info.json
[2024-07-28 09:16:33.458][mullvad_api::availability][DEBUG] Unsuspending API requests
[2024-07-28 09:16:33.458][mullvad_api::access][DEBUG] Fetching access token for an account
[2024-07-28 09:16:33.458][mullvad_api::availability][DEBUG] Resuming background API requests
[2024-07-28 09:16:33.458][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: [REDACTED]:443/TCP
[2024-07-28 09:16:33.469][mullvad_daemon][DEBUG] New tunnel state: Error(ErrorState { cause: IsOffline, block_failure: None })
[2024-07-28 09:16:33.469][mullvad_daemon][INFO] Blocking all network connections, reason: This device is offline, no tunnels can be established
[2024-07-28 09:16:39.738][talpid_core::dns][INFO] Resetting DNS
[2024-07-28 09:16:39.738][mullvad_daemon::api][INFO] Detecting changes to offline state - Status { ipv4: true, ipv6: false }
[2024-07-28 09:16:39.738][mullvad_api::availability][DEBUG] Resuming API requests due to coming online
[2024-07-28 09:16:39.738][mullvad_api::access][DEBUG] Fetching access token for an account
[2024-07-28 09:16:39.738][mullvad_daemon::tunnel][DEBUG] Same IP is NOT being used
[2024-07-28 09:16:39.738][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:43791/UDP, Blocking LAN, interface: none. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:16:39.749][mullvad_daemon][DEBUG] New tunnel state: Connecting { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:43791, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: None }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:16:39.749][mullvad_daemon][DEBUG] Settings: openvpn mssfix: unset, wg mtu: unset, wg ip version: any, multihop: off, ipv6 (tun): off, lan: off, pq: auto, obfs: auto, dns: default
[2024-07-28 09:16:39.749][talpid_wireguard][DEBUG] Tunnel MTU: 1380
[2024-07-28 09:16:39.796][talpid_wireguard][DEBUG] Using kernel WireGuard implementation
[2024-07-28 09:16:39.797][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:43791/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:16:39.804][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 32 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: true, mtu: None }}
[2024-07-28 09:16:39.804][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:43791/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:16:39.814][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:16:39.814][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:16:39.814][mullvad_relay_selector::relay_selector::detailer][INFO] Selected Shadowsocks bridge cz-prg-br-101 at [REDACTED]:443/TCP
[2024-07-28 09:16:39.815][mullvad_daemon::api][INFO] A new API access method has been selected: Mullvad Bridges
[2024-07-28 09:16:39.816][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:43791/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:16:39.816][talpid_wireguard][DEBUG] Requesting ephemeral peer
[2024-07-28 09:16:39.816][talpid_tunnel_config_client][DEBUG] Config client socket MSS: 496
[2024-07-28 09:16:39.829][mullvad_daemon::management_interface][DEBUG] Broadcasting access method event
[2024-07-28 09:16:40.932][talpid_wireguard][DEBUG] Retrieved ephemeral peer
[2024-07-28 09:16:40.955][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:43791/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: All), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:16:40.969][talpid_wireguard::mtu_detection][DEBUG] Starting MTU detection
[2024-07-28 09:16:41.019][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 0 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: false, mtu: None }}
[2024-07-28 09:16:41.019][talpid_core::firewall][INFO] Applying firewall policy: Connected to [REDACTED]:43791/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None), Blocking LAN
[2024-07-28 09:16:41.030][talpid_core::dns][INFO] Setting DNS servers to [REDACTED]
[2024-07-28 09:16:41.030][talpid_core::dns::imp][DEBUG] Managing DNS via systemd-resolved
[2024-07-28 09:16:41.032][mullvad_daemon][DEBUG] New tunnel state: Connected { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:43791, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: Some("wg0-mullvad") }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:16:41.032][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-28 09:16:41.052][talpid_wireguard::mtu_detection][DEBUG] MTU 1380 verified to not drop packets
[2024-07-28 09:16:47.943][mullvad_api::access][DEBUG] Fetching access token for an account
[2024-07-28 09:16:56.434][mullvad_daemon::management_interface][DEBUG] is_performing_post_upgrade
[2024-07-28 09:16:56.440][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:16:56.442][mullvad_daemon::management_interface][DEBUG] get_tunnel_state
[2024-07-28 09:16:56.475][mullvad_daemon::management_interface][DEBUG] get_device
[2024-07-28 09:16:56.479][mullvad_daemon::management_interface][DEBUG] get_settings
[2024-07-28 09:16:56.479][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-28 09:16:56.479][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:16:56.479][mullvad_daemon::management_interface][DEBUG] update_device
[2024-07-28 09:16:56.484][mullvad_daemon::management_interface][DEBUG] get_current_api_access_method
[2024-07-28 09:16:56.486][mullvad_daemon::management_interface][DEBUG] get_relay_locations
[2024-07-28 09:16:56.520][mullvad_daemon::management_interface][DEBUG] get_current_version
[2024-07-28 09:16:56.524][mullvad_daemon::management_interface][DEBUG] get_version_info
[2024-07-28 09:16:56.525][mullvad_daemon::management_interface][DEBUG] connect_tunnel
[2024-07-28 09:16:56.696][mullvad_daemon::device][DEBUG] The current device is still valid
[2024-07-28 09:16:57.031][mullvad_daemon::relay_list][DEBUG] Relay list is up-to-date
[2024-07-28 09:17:30.894][mullvad_daemon::management_interface][DEBUG] disconnect_tunnel
[2024-07-28 09:17:30.894][mullvad_daemon][DEBUG] Target state Secured => Unsecured
[2024-07-28 09:17:30.895][talpid_core::dns][INFO] Resetting DNS
[2024-07-28 09:17:30.897][talpid_routing::imp::imp][DEBUG] Clearing routes
[2024-07-28 09:17:30.897][mullvad_daemon][DEBUG] New tunnel state: Disconnecting(Nothing)
[2024-07-28 09:17:30.978][talpid_core::tunnel_state_machine::connecting_state][DEBUG] Tunnel monitor exited with block reason: None
[2024-07-28 09:17:30.978][talpid_core::firewall][INFO] Applying firewall policy: Blocked. Blocking LAN. Allowing endpoint: [REDACTED]:443/TCP
[2024-07-28 09:17:30.989][mullvad_daemon][DEBUG] New tunnel state: Disconnected { location: None, locked_down: true }
[2024-07-28 09:17:30.989][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-28 09:17:30.993][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: failed to lookup address information: Temporary failure in name resolution
Caused by: failed to lookup address information: Temporary failure in name resolution
[2024-07-28 09:17:31.176][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: failed to lookup address information: Temporary failure in name resolution
Caused by: failed to lookup address information: Temporary failure in name resolution
[2024-07-28 09:17:34.235][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: failed to lookup address information: Temporary failure in name resolution
Caused by: failed to lookup address information: Temporary failure in name resolution
[2024-07-28 09:17:37.456][mullvad_daemon::management_interface][DEBUG] disconnect_tunnel
[2024-07-28 09:17:45.547][mullvad_daemon::management_interface][DEBUG] is_performing_post_upgrade
[2024-07-28 09:17:45.552][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:17:45.555][mullvad_daemon::management_interface][DEBUG] get_tunnel_state
[2024-07-28 09:17:45.576][mullvad_daemon::management_interface][DEBUG] get_device
[2024-07-28 09:17:45.582][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:17:45.582][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-28 09:17:45.582][mullvad_daemon::management_interface][DEBUG] update_device
[2024-07-28 09:17:45.582][mullvad_daemon::management_interface][DEBUG] get_settings
[2024-07-28 09:17:45.588][mullvad_daemon::management_interface][DEBUG] get_current_api_access_method
[2024-07-28 09:17:45.589][mullvad_daemon::management_interface][DEBUG] get_relay_locations
[2024-07-28 09:17:45.628][mullvad_daemon::management_interface][DEBUG] get_current_version
[2024-07-28 09:17:45.630][mullvad_daemon::management_interface][DEBUG] connect_tunnel
[2024-07-28 09:17:45.630][mullvad_daemon::management_interface][DEBUG] get_version_info
[2024-07-28 09:17:45.630][mullvad_daemon][DEBUG] Target state Unsecured => Secured
[2024-07-28 09:17:45.631][mullvad_daemon::tunnel][DEBUG] Same IP is NOT being used
[2024-07-28 09:17:45.632][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:9676/UDP, Blocking LAN, interface: none. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:17:45.640][mullvad_daemon][DEBUG] New tunnel state: Connecting { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:9676, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: None }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:17:45.640][mullvad_daemon][DEBUG] Settings: openvpn mssfix: unset, wg mtu: unset, wg ip version: any, multihop: off, ipv6 (tun): off, lan: off, pq: auto, obfs: auto, dns: default
[2024-07-28 09:17:45.640][talpid_wireguard][DEBUG] Tunnel MTU: 1380
[2024-07-28 09:17:45.669][talpid_wireguard][DEBUG] Using kernel WireGuard implementation
[2024-07-28 09:17:45.671][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:9676/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:17:45.680][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 32 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: true, mtu: None }}
[2024-07-28 09:17:45.680][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:9676/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:17:45.687][talpid_wireguard][DEBUG] Requesting ephemeral peer
[2024-07-28 09:17:45.687][talpid_tunnel_config_client][DEBUG] Config client socket MSS: 496
[2024-07-28 09:17:46.011][mullvad_daemon::device][DEBUG] The current device is still valid
[2024-07-28 09:17:46.829][talpid_wireguard][DEBUG] Retrieved ephemeral peer
[2024-07-28 09:17:46.852][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:9676/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: All), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:17:46.867][talpid_wireguard::mtu_detection][DEBUG] Starting MTU detection
[2024-07-28 09:17:46.918][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 0 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: false, mtu: None }}
[2024-07-28 09:17:46.918][talpid_core::firewall][INFO] Applying firewall policy: Connected to [REDACTED]:9676/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None), Blocking LAN
[2024-07-28 09:17:46.937][talpid_core::dns][INFO] Setting DNS servers to [REDACTED]
[2024-07-28 09:17:46.937][talpid_core::dns::imp][DEBUG] Managing DNS via systemd-resolved
[2024-07-28 09:17:46.939][mullvad_daemon][DEBUG] New tunnel state: Connected { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:9676, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: Some("wg0-mullvad") }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:17:46.939][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-28 09:17:46.947][talpid_wireguard::mtu_detection][DEBUG] MTU 1380 verified to not drop packets
[2024-07-28 09:17:49.871][mullvad_daemon][DEBUG] Location from am.i.mullvad.net belongs to an outdated tunnel state
[2024-07-28 09:17:50.137][mullvad_daemon::management_interface][DEBUG] is_performing_post_upgrade
[2024-07-28 09:17:50.141][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:17:50.144][mullvad_daemon::management_interface][DEBUG] get_tunnel_state
[2024-07-28 09:17:50.160][mullvad_daemon::management_interface][DEBUG] get_device
[2024-07-28 09:17:50.164][mullvad_daemon::management_interface][DEBUG] get_settings
[2024-07-28 09:17:50.164][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-28 09:17:50.164][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:17:50.164][mullvad_daemon::management_interface][DEBUG] update_device
[2024-07-28 09:17:50.171][mullvad_daemon::management_interface][DEBUG] get_current_api_access_method
[2024-07-28 09:17:50.173][mullvad_daemon::management_interface][DEBUG] get_relay_locations
[2024-07-28 09:17:50.205][mullvad_daemon::management_interface][DEBUG] get_current_version
[2024-07-28 09:17:50.206][mullvad_daemon::management_interface][DEBUG] connect_tunnel
[2024-07-28 09:17:50.206][mullvad_daemon::management_interface][DEBUG] get_version_info
[2024-07-28 09:17:58.517][mullvad_daemon::management_interface][DEBUG] set_block_when_disconnected(false)
[2024-07-28 09:17:58.517][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-28 09:17:58.525][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-28 09:18:05.827][mullvad_daemon::management_interface][DEBUG] disconnect_tunnel
[2024-07-28 09:18:05.827][mullvad_daemon][DEBUG] Target state Secured => Unsecured
[2024-07-28 09:18:05.827][talpid_core::dns][INFO] Resetting DNS
[2024-07-28 09:18:05.829][talpid_routing::imp::imp][DEBUG] Clearing routes
[2024-07-28 09:18:05.830][mullvad_daemon][DEBUG] New tunnel state: Disconnecting(Nothing)
[2024-07-28 09:18:05.945][talpid_core::tunnel_state_machine::connecting_state][DEBUG] Tunnel monitor exited with block reason: None
[2024-07-28 09:18:05.945][talpid_core::firewall][INFO] Resetting firewall policy
[2024-07-28 09:18:05.945][talpid_core::firewall::imp][DEBUG] Removing table and chain from netfilter
[2024-07-28 09:18:05.951][mullvad_daemon][DEBUG] New tunnel state: Disconnected { location: None, locked_down: false }
[2024-07-28 09:18:05.951][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-28 09:18:06.294][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:18:06.804][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:18:10.761][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:18:12.250][mullvad_api::rest][ERROR] Error: HTTP request failed
Caused by: Hyper error
Caused by: error trying to connect: received corrupt message of type InvalidContentType
Caused by: received corrupt message of type InvalidContentType
[2024-07-28 09:18:19.780][mullvad_daemon::management_interface][DEBUG] is_performing_post_upgrade
[2024-07-28 09:18:19.784][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:18:19.787][mullvad_daemon::management_interface][DEBUG] get_tunnel_state
[2024-07-28 09:18:19.807][mullvad_daemon::management_interface][DEBUG] get_device
[2024-07-28 09:18:19.812][mullvad_daemon::management_interface][DEBUG] get_settings
[2024-07-28 09:18:19.812][mullvad_daemon::management_interface][DEBUG] get_account_data
[2024-07-28 09:18:19.812][mullvad_daemon::management_interface][DEBUG] update_device
[2024-07-28 09:18:19.812][mullvad_daemon::management_interface][DEBUG] get_account_history
[2024-07-28 09:18:19.822][mullvad_daemon::management_interface][DEBUG] get_current_api_access_method
[2024-07-28 09:18:19.825][mullvad_daemon::management_interface][DEBUG] get_relay_locations
[2024-07-28 09:18:19.870][mullvad_daemon::management_interface][DEBUG] get_current_version
[2024-07-28 09:18:19.874][mullvad_daemon::management_interface][DEBUG] get_version_info
[2024-07-28 09:18:19.874][mullvad_daemon::management_interface][DEBUG] connect_tunnel
[2024-07-28 09:18:19.874][mullvad_daemon][DEBUG] Target state Unsecured => Secured
[2024-07-28 09:18:19.875][mullvad_daemon::tunnel][DEBUG] Same IP is NOT being used
[2024-07-28 09:18:19.876][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:55609/UDP, Blocking LAN, interface: none. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:18:19.887][mullvad_daemon][DEBUG] New tunnel state: Connecting { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:55609, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: None }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:18:19.887][mullvad_daemon][DEBUG] Settings: openvpn mssfix: unset, wg mtu: unset, wg ip version: any, multihop: off, ipv6 (tun): off, lan: off, pq: auto, obfs: auto, dns: default
[2024-07-28 09:18:19.888][talpid_wireguard][DEBUG] Tunnel MTU: 1380
[2024-07-28 09:18:19.911][talpid_wireguard][DEBUG] Using kernel WireGuard implementation
[2024-07-28 09:18:19.912][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:55609/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:18:19.920][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 32 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: true, mtu: None }}
[2024-07-28 09:18:19.921][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:55609/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: [REDACTED]:1337/TCP), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:18:19.928][talpid_wireguard][DEBUG] Requesting ephemeral peer
[2024-07-28 09:18:19.929][talpid_tunnel_config_client][DEBUG] Config client socket MSS: 496
[2024-07-28 09:18:20.257][mullvad_daemon::device][DEBUG] The current device is still valid
[2024-07-28 09:18:21.047][talpid_wireguard][DEBUG] Retrieved ephemeral peer
[2024-07-28 09:18:21.065][talpid_core::firewall][INFO] Applying firewall policy: Connecting to [REDACTED]:55609/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None, allowed in-tunnel traffic: All), Blocking LAN. Allowing endpoint [REDACTED]:443/TCP
[2024-07-28 09:18:21.079][talpid_wireguard::mtu_detection][DEBUG] Starting MTU detection
[2024-07-28 09:18:21.130][talpid_routing::imp::imp][DEBUG] Adding routes: {RequiredRoute { prefix: V4(Ipv4Network { addr: [REDACTED], prefix: 0 }), node: RealNode(Node { ip: None, device: Some("wg0-mullvad") }), main_table: false, mtu: None }}
[2024-07-28 09:18:21.130][talpid_core::firewall][INFO] Applying firewall policy: Connected to [REDACTED]:55609/UDP over "wg0-mullvad" (ip: [REDACTED], v4 gw: [REDACTED], v6 gw: None), Blocking LAN
[2024-07-28 09:18:21.141][talpid_core::dns][INFO] Setting DNS servers to [REDACTED]
[2024-07-28 09:18:21.141][talpid_core::dns::imp][DEBUG] Managing DNS via systemd-resolved
[2024-07-28 09:18:21.143][mullvad_daemon][DEBUG] New tunnel state: Connected { endpoint: TunnelEndpoint { endpoint: Endpoint { address: [REDACTED]:55609, protocol: Udp }, tunnel_type: Wireguard, quantum_resistant: true, proxy: None, obfuscation: None, entry_endpoint: None, tunnel_interface: Some("wg0-mullvad") }, location: Some(GeoIpLocation { ipv4: None, ipv6: None, country: "Turkey", city: Some("Istanbul"), latitude: 41.00824, longitude: 28.978359, mullvad_exit_ip: true, hostname: Some("tr-ist-wg-001"), bridge_hostname: None, entry_hostname: None, obfuscator_hostname: None }) }
[2024-07-28 09:18:21.143][mullvad_daemon::geoip][DEBUG] Fetching GeoIpLocation
[2024-07-28 09:18:21.164][talpid_wireguard::mtu_detection][DEBUG] MTU 1380 verified to not drop packets
[2024-07-28 09:18:25.536][mullvad_daemon::management_interface][DEBUG] set_block_when_disconnected(true)
[2024-07-28 09:18:25.536][mullvad_daemon::settings][DEBUG] Writing settings to /etc/mullvad-vpn/settings.json
[2024-07-28 09:18:25.542][mullvad_daemon::management_interface][DEBUG] Broadcasting new settings
[2024-07-28 09:18:53.067][mullvad_daemon][DEBUG] Location from am.i.mullvad.net belongs to an outdated tunnel state
[2024-07-28 09:20:54.209][mullvad_daemon::management_interface][DEBUG] get_account_data

====================
Log: ~/.config/Mullvad VPN/logs/frontend-main.old.log
====================
[2024-07-28 09:17:49.807][verbose] Chromium sandbox is enabled
[2024-07-28 09:17:49.808][info] Running version 2024.4
[2024-07-28 09:17:49.901][info] Detected locale: en-US
[2024-07-28 09:17:50.129][info] Connected to the daemon
[2024-07-28 09:17:50.206][info] Autoconnect the tunnel
[2024-07-28 09:18:05.828][info] Disconnected the tunnel
[2024-07-28 09:18:05.828][info] before-quit received
[2024-07-28 09:18:05.828][info] Quit initiated
[2024-07-28 09:18:05.828][info] Unsubscribed from the daemon events
[2024-07-28 09:18:05.829][verbose] GRPC Channel connectivity state changed to 4

====================
Log: ~/.config/Mullvad VPN/logs/frontend-renderer.old.log
====================
[2024-07-28 09:17:50.437][verbose] Tunnel state: connected
[2024-07-28 09:17:50.438][verbose] Initial: Wrong content height: 597, expected 568
[2024-07-28 09:17:50.442][verbose] Resize: Wrong content height: 597, expected 568
[2024-07-28 09:17:50.507][verbose] Map canvas scale factor: 1, using: 1
[2024-07-28 09:18:03.070][verbose] Map canvas scale factor: 1, using: 1

====================
Log: ~/.config/Mullvad VPN/logs/frontend-main.log
====================
[2024-07-28 09:18:19.436][verbose] Chromium sandbox is enabled
[2024-07-28 09:18:19.437][info] Running version 2024.4
[2024-07-28 09:18:19.541][info] Detected locale: en-US
[2024-07-28 09:18:19.772][info] Connected to the daemon
[2024-07-28 09:18:19.873][info] Autoconnect the tunnel

====================
Log: ~/.config/Mullvad VPN/logs/frontend-renderer.log
====================
[2024-07-28 09:18:20.141][verbose] Tunnel state: connecting
[2024-07-28 09:18:20.142][verbose] Initial: Wrong content height: 597, expected 568
[2024-07-28 09:18:20.145][verbose] Resize: Wrong content height: 597, expected 568
[2024-07-28 09:18:20.216][verbose] Map canvas scale factor: 1, using: 1
[2024-07-28 09:18:21.145][verbose] Tunnel state: connected
[2024-07-28 09:18:21.486][verbose] Tunnel state: connected
[2024-07-28 09:18:27.047][verbose] Map canvas scale factor: 1, using: 1
[2024-07-28 09:20:41.986][verbose] Map canvas scale factor: 1, using: 1

Operating system version

Fedora Linux 40

Mullvad VPN app version

2024.4

Additional Information

No response

nit27 commented 2 months ago

Same issue with MegaSync app when Mullvad turned on. It cannot login untill I disconnect the VPN.

AyazJenkins commented 2 months ago

I have been able to fix this issue via manual troubleshooting. If anybody experiences the same problems, try this: https://discussion.fedoraproject.org/t/dnf-and-firefox-take-extreemly-long-to-start-when-vpn-active-on-f40/114604/4