Attachment 5909 Details for Bug 13400 – NetworkManager service logs

NetworkManager service logs

vpnlog.txt (text/plain), 10.95 KB, created by d.zaslavsky@rosalinux.ru on 2023-06-06 14:53:45 MSK

(hide)

Description:

Filename:

MIME Type:

Creator: d.zaslavsky@rosalinux.ru

Created: 2023-06-06 14:53:45 MSK

Size: 10.95 KB

patch

obsolete

>-- Journal begins at Thu 2023-06-01 13:03:09 MSK. --
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt nm-sstp-service[1723170]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt nm-sstp-service[1723170]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[788]: <info>  [1686051793.5208] vpn-connection[0x24ec130,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",6:(ppp0)]: VPN plugin: state changed: stopping (5)
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[788]: <info>  [1686051793.5209] vpn-connection[0x24ec130,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",6:(ppp0)]: VPN plugin: state changed: stopped (6)
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[788]: <info>  [1686051793.5233] policy: set 'ens18' (ens18) as default for IPv4 routing and DNS
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[788]: <info>  [1686051793.5294] vpn-connection[0x24ec130,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: VPN service disappeared
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt pppd[1723173]: Terminating on signal 15
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[1723173]: Terminating on signal 15
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt pppd[1723173]: Exit.
>Ð¸ÑÐ½ 06 14:43:13 dc.test.alt NetworkManager[788]: <warn>  [1686051793.5890] dns-sd-resolved[8b388cdc33018dd5]: send-updates SetLinkDomains@6 failed: GDBus.Error:org.freedesktop.resolve1.NoSuchLink: Link 6 not known
>Ð¸ÑÐ½ 06 14:43:31 dc.test.alt NetworkManager[788]: <info>  [1686051811.7937] audit: op="statistics" interface="ens18" ifindex=2 args="2000" pid=51363 uid=500 result="success"
>Ð¸ÑÐ½ 06 14:43:32 dc.test.alt NetworkManager[788]: <info>  [1686051812.9615] audit: op="connection-activate" uuid="b98a097e-f9cd-4c69-9ea7-e72f864e3656" name="sstp" pid=51363 uid=500 result="success"
>Ð¸ÑÐ½ 06 14:43:32 dc.test.alt NetworkManager[788]: <info>  [1686051812.9720] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: Started the VPN service, PID 1723425
>Ð¸ÑÐ½ 06 14:43:32 dc.test.alt NetworkManager[788]: <info>  [1686051812.9899] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: Saw the service appear; activating connection
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[788]: <info>  [1686051813.0028] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: VPN connection: (ConnectInteractive) reply received
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[788]: <info>  [1686051813.0074] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: VPN plugin: state changed: starting (3)
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt pppd[1723428]: Plugin /usr/lib64/pppd/2.4.9/nm-sstp-pppd-plugin.so loaded.
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[1723428]: Plugin /usr/lib64/pppd/2.4.9/nm-sstp-pppd-plugin.so loaded.
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt pppd[1723428]: pppd 2.4.9 started by root, uid 0
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt pppd[1723428]: Using interface ppp0
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[1723428]: Using interface ppp0
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt pppd[1723428]: Connect: ppp0 <--> /dev/pts/3
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[1723428]: Connect: ppp0 <--> /dev/pts/3
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt NetworkManager[788]: <info>  [1686051813.0487] manager: (ppp0): new Ppp device (/org/freedesktop/NetworkManager/Devices/7)
>Ð¸ÑÐ½ 06 14:43:33 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:37 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:37 dc.test.alt pppd[1723428]: PAP authentication succeeded
>Ð¸ÑÐ½ 06 14:43:37 dc.test.alt NetworkManager[1723428]: PAP authentication succeeded
>Ð¸ÑÐ½ 06 14:43:37 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt pppd[1723428]: local  IP address 10.238.152.72
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[1723428]: local  IP address 10.238.152.72
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[1723428]: remote IP address 1.0.0.1
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[1723428]: primary   DNS address 10.238.254.254
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[1723428]: secondary DNS address 8.8.8.8
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt pppd[1723428]: remote IP address 1.0.0.1
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt nm-sstp-service[1723425]: handle_set_config
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt pppd[1723428]: primary   DNS address 10.238.254.254
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt nm-sstp-service[1723425]: handle_set_ip4_config
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt pppd[1723428]: secondary DNS address 8.8.8.8
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5408] device (ppp0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5434] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",0]: VPN connection: (IP Config Get) reply received.
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5440] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: VPN connection: (IP4 Config Get) reply received
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5448] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data: Tunnel Device: "ppp0"
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5462] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data: IPv4 configuration:
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5464] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Internal Address: 10.238.152.72
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5466] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Internal Prefix: 32
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5468] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Internal Point-to-Point Address: 1.0.0.1
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5471] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Static Route: 10.238.254.254/32   Next Hop: 1.0.0.1
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5488] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Static Route: 0.0.0.0/0   Next Hop: 0.0.0.0
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5490] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Static Route: 1.0.0.1/32   Next Hop: 0.0.0.0
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5493] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Internal DNS: 10.238.254.254
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5495] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   Internal DNS: 8.8.8.8
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5497] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data:   DNS Domain: '(none)'
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5500] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: Data: No IPv6 configuration
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5508] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: VPN plugin: state changed: started (4)
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5533] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: VPN connection: (IP Config Get) complete
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5541] device (ppp0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'external')
>Ð¸ÑÐ½ 06 14:43:42 dc.test.alt NetworkManager[788]: <info>  [1686051822.5823] policy: set 'sstp' (ppp0) as default for IPv4 routing and DNS
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt dhclient[850]: DHCPREQUEST for 10.128.10.204 on ens18 to 10.128.10.1 port 67
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt dhclient[850]: DHCPACK of 10.128.10.204 from 10.128.10.1
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3805] dhcp4 (ens18):   address 10.128.10.204
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3805] dhcp4 (ens18):   plen 24 (255.255.255.0)
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3805] dhcp4 (ens18):   gateway 10.128.10.1
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3806] dhcp4 (ens18):   lease time 600
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3806] dhcp4 (ens18):   nameserver '8.8.8.8'
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt NetworkManager[788]: <info>  [1686051973.3806] dhcp4 (ens18): state changed extended -> extended, address=10.128.10.204
>Ð¸ÑÐ½ 06 14:46:13 dc.test.alt dhclient[850]: bound to 10.128.10.204 -- renewal in 244 seconds.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt sstpc[1723431]: Unrecoverable socket error, 1
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt sstpc[1723431]: Connection was aborted, Reason was not known
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Modem hangup
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[1723428]: Modem hangup
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[1723428]: Connect time 3.1 minutes.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Connect time 3.1 minutes.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[1723428]: Sent 56477 bytes, received 0 bytes.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Sent 56477 bytes, received 0 bytes.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[788]: <info>  [1686052003.7252] device (ppp0): state change: disconnected -> unmanaged (reason 'connection-assumed', sys-iface-state: 'external')
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Connection terminated.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[1723428]: Connection terminated.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt nm-sstp-service[1723425]: handle_set_state
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[788]: <info>  [1686052003.7378] vpn-connection[0x24ec340,b98a097e-f9cd-4c69-9ea7-e72f864e3656,"sstp",7:(ppp0)]: VPN service disappeared
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[788]: <info>  [1686052003.7395] policy: set 'ens18' (ens18) as default for IPv4 routing and DNS
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Terminating on signal 15
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[1723428]: Terminating on signal 15
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt pppd[1723428]: Exit.
>Ð¸ÑÐ½ 06 14:46:43 dc.test.alt NetworkManager[788]: <warn>  [1686052003.8918] dns-sd-resolved[8b388cdc33018dd5]: send-updates SetLinkDomains@7 failed: GDBus.Error:org.freedesktop.resolve1.NoSuchLink: Link 7 not known

Actions: View

Attachments on bug 13400: 5909 | 5910 | 5911