Project

General

Profile

Bug #15509 ยป ovpn_client.log

Evgeny Korostelev, 05/20/2024 05:19 AM

 
1
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.5844] audit: op="connection-activate" uuid="c54e1682-8f8a-4c69-b753-d2bdd3307a84" name="New-Home-oVPN" pid=16351 uid=1000 result="success"
2
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.5889] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",0]: Started the VPN service, PID 111205
3
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.5957] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",0]: Saw the service appear; activating connection
4
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.6077] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",0]: VPN plugin: state changed: starting (3)
5
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.6077] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",0]: VPN connection: (ConnectInteractive) reply received
6
May 20 10:12:53 saws nm-openvpn[111209]: OpenVPN 2.6.10 x86_64-pc-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS11] [MH/PKTINFO] [AEAD] [DCO]
7
May 20 10:12:53 saws nm-openvpn[111209]: library versions: OpenSSL 1.1.1n  15 Mar 2022, LZO 2.10
8
May 20 10:12:53 saws nm-openvpn[111209]: DCO version: N/A
9
May 20 10:12:53 saws nm-openvpn[111209]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
10
May 20 10:12:53 saws nm-openvpn[111209]: TCP/UDP: Preserving recently used remote address: [AF_INET]xx.xx.xx.xx:1194
11
May 20 10:12:53 saws nm-openvpn[111209]: UDPv4 link local: (not bound)
12
May 20 10:12:53 saws nm-openvpn[111209]: UDPv4 link remote: [AF_INET]xx.xx.xx.xx:1194
13
May 20 10:12:53 saws nm-openvpn[111209]: NOTE: chroot will be delayed because of --client, --pull, or --up-delay
14
May 20 10:12:53 saws nm-openvpn[111209]: NOTE: UID/GID downgrade will be delayed because of --client, --pull, or --up-delay
15
May 20 10:12:53 saws nm-openvpn[111209]: [ovpnsrv] Peer Connection Initiated with [AF_INET]xx.xx.xx.xx:1194
16
May 20 10:12:53 saws nm-openvpn[111209]: TUN/TAP device tun0 opened
17
May 20 10:12:53 saws nm-openvpn[111209]: /usr/lib/NetworkManager/nm-openvpn-service-openvpn-helper --debug 0 111205 --bus-name org.freedesktop.NetworkManager.openvpn.Connection_12 --tun -- tun0 1500 0 172.16.99.3 255.255.255.0 init
18
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8104] manager: (tun0): new Tun device (/org/freedesktop/NetworkManager/Devices/8)
19
May 20 10:12:53 saws systemd-udevd[111212]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
20
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8176] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",0]: VPN connection: (IP Config Get) reply received.
21
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8182] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: VPN connection: (IP4 Config Get) reply received
22
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8186] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data: VPN Gateway: xx.xx.xx.xx
23
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8186] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data: Tunnel Device: "tun0"
24
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8186] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data: IPv4 configuration:
25
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8186] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Internal Gateway: 172.16.99.1
26
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Internal Address: 172.16.99.3
27
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Internal Prefix: 24
28
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Internal Point-to-Point Address: 172.16.99.3
29
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Static Route: 192.168.0.0/16   Next Hop: 172.16.99.1
30
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Static Route: 172.16.0.0/12   Next Hop: 172.16.99.1
31
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Static Route: 10.0.0.0/8   Next Hop: 172.16.99.1
32
May 20 10:12:53 saws nm-openvpn[111209]: chroot to '/var/lib/openvpn/chroot' and cd to '/' succeeded
33
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Static Route: 172.16.99.0/24   Next Hop: 0.0.0.0
34
May 20 10:12:53 saws nm-openvpn[111209]: UID set to nm-openvpn
35
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   Internal DNS: xx.xx.xx.1
36
May 20 10:12:53 saws nm-openvpn[111209]: GID set to nm-openvpn
37
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data:   DNS Domain: '(none)'
38
May 20 10:12:53 saws nm-openvpn[111209]: Capabilities retained: CAP_NET_ADMIN
39
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8187] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: Data: No IPv6 configuration
40
May 20 10:12:53 saws nm-openvpn[111209]: Initialization Sequence Completed
41
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8188] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: VPN plugin: state changed: started (4)
42
May 20 10:12:53 saws charon: 08[KNL] interface tun0 activated
43
May 20 10:12:53 saws charon: 07[KNL] 172.16.99.3 appeared on tun0
44
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8220] vpn-connection[0x563779e0a580,c54e1682-8f8a-4c69-b753-d2bdd3307a84,"New-Home-oVPN",8:(tun0)]: VPN connection: (IP Config Get) complete
45
May 20 10:12:53 saws dbus-daemon[671]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.7' (uid=0 pid=672 comm="/usr/sbin/NetworkManager --no-daemon ")
46
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8231] device (tun0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
47
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8263] device (tun0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
48
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8270] device (tun0): Activation: starting connection 'tun0' (77aa56f7-b5a1-47a0-88af-9ca3c6baf3cf)
49
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8272] device (tun0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
50
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8275] device (tun0): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
51
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8278] device (tun0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
52
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8282] device (tun0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
53
May 20 10:12:53 saws systemd[1]: Starting Network Manager Script Dispatcher Service...
54
May 20 10:12:53 saws dbus-daemon[671]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
55
May 20 10:12:53 saws systemd[1]: Started Network Manager Script Dispatcher Service.
56
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.8938] dns-mgr: Writing DNS information to /sbin/resolvconf
57
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.9183] device (tun0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
58
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.9185] device (tun0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
59
May 20 10:12:53 saws NetworkManager[672]: <info>  [1716181973.9198] device (tun0): Activation: successful, device activated.
60
May 20 10:13:02 saws mount.davfs: open files exceed max cache size by 830 MiBytes
61
May 20 10:13:04 saws systemd[1]: systemd-hostnamed.service: Succeeded.
62
May 20 10:13:04 saws systemd[1]: NetworkManager-dispatcher.service: Succeeded.
63
May 20 10:13:53 saws nm-openvpn[111209]: [ovpnsrv] Inactivity timeout (--ping-restart), restarting
64
May 20 10:13:53 saws nm-openvpn[111209]: SIGUSR1[soft,ping-restart] received, process restarting
65
May 20 10:13:53 saws mount.davfs: open files exceed max cache size by 830 MiBytes
66
May 20 10:13:54 saws nm-openvpn[111209]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
67
May 20 10:13:54 saws nm-openvpn[111209]: TCP/UDP: Preserving recently used remote address: [AF_INET]xx.xx.xx.xx:1194
68
May 20 10:13:54 saws nm-openvpn[111209]: UDPv4 link local: (not bound)
69
May 20 10:13:54 saws nm-openvpn[111209]: UDPv4 link remote: [AF_INET]xx.xx.xx.xx:1194
70
May 20 10:13:54 saws nm-openvpn[111209]: [ovpnsrv] Peer Connection Initiated with [AF_INET]xx.xx.xx.xx:1194
71
May 20 10:13:54 saws nm-openvpn[111209]: Preserving previous TUN/TAP instance: tun0
72
May 20 10:13:54 saws nm-openvpn[111209]: /usr/lib/NetworkManager/nm-openvpn-service-openvpn-helper --debug 0 111205 --bus-name org.freedesktop.NetworkManager.openvpn.Connection_12 --tun -- tun0 1500 0 172.16.99.3 255.255.255.0 restart
73
May 20 10:13:54 saws nm-openvpn[111209]: WARNING: Failed running command (--up/--down): could not execute external program
74
May 20 10:13:54 saws nm-openvpn[111209]: Exiting due to fatal error
75
May 20 10:13:54 saws charon: 06[KNL] interface tun0 deactivated
76
May 20 10:13:54 saws charon: 08[KNL] 172.16.99.3 disappeared from tun0
77

    
78

    
    (1-1/1)