<est-symmetric-id-tcp.sh TEST_GEN_PROGS="" run_tests
make: Entering directory '/srv/vmksft/testing/wt-6/tools/testing/selftests'
make[1]: Entering directory '/srv/vmksft/testing/wt-6/tools/testing/selftests/net/ovpn'
make[1]: Nothing to be done for 'all'.
make[1]: Leaving directory '/srv/vmksft/testing/wt-6/tools/testing/selftests/net/ovpn'
make[1]: Entering directory '/srv/vmksft/testing/wt-6/tools/testing/selftests/net/ovpn'
TAP version 13
1..1
# overriding timeout to 240
# selftests: net/ovpn: test-symmetric-id-tcp.sh
# Deleting interface tun1 ifindex 4
# Deleting interface tun2 ifindex 4
# Deleting interface tun3 ifindex 4
# Creating interface tun0 with mode 1
# Creating interface tun1 with mode 0
# Creating interface tun2 with mode 0
# Creating interface tun3 with mode 0
# Creating interface tun4 with mode 0
# Creating interface tun5 with mode 0
# Creating interface tun6 with mode 0
# connected
# Connection received!
# Sent 1002 bytes over TCP socket
# connected
# Connection received!
# Sent 1002 bytes over TCP socket
# connected
# Connection received!
# Sent 1002 bytes over TCP socket
# connected
# Connection received!
# Sent 1002 bytes over TCP socket
# connected
# Connection received!
# Sent 1002 bytes over TCP socket
# connected
# Connection received!
# >>>> Received 1002 bytes over TCP socket, header: 1000
# >>>> Received 1002 bytes over TCP socket, header: 1000
# >>>> Received 1002 bytes over TCP socket, header: 1000
# >>>> Received 1002 bytes over TCP socket, header: 1000
# >>>> Received 1002 bytes over TCP socket, header: 1000
# >>>> Received 1002 bytes over TCP socket, header: 1000
# Sent 1002 bytes over TCP socket
# PING 5.5.5.2 (5.5.5.2) 56(84) bytes of data.
# 
# --- 5.5.5.2 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 521ms
# rtt min/avg/max/mdev = 0.487/0.963/13.410/1.512 ms, pipe 2, ipg/ewma 1.044/1.562 ms
# PING 5.5.5.2 (5.5.5.2) 3000(3028) bytes of data.
# 
# --- 5.5.5.2 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 1667ms
# rtt min/avg/max/mdev = 1.682/3.162/23.712/2.707 ms, pipe 2, ipg/ewma 3.341/2.560 ms
# PING 5.5.5.3 (5.5.5.3) 56(84) bytes of data.
# 
# --- 5.5.5.3 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 349ms
# rtt min/avg/max/mdev = 0.484/0.618/4.797/0.664 ms, ipg/ewma 0.698/0.595 ms
# PING 5.5.5.3 (5.5.5.3) 3000(3028) bytes of data.
# 
# --- 5.5.5.3 ping statistics ---
# 501 packets transmitted, 501 received, 0% packet loss, time 1335ms
# rtt min/avg/max/mdev = 1.677/2.467/15.382/1.911 ms, pipe 3, ipg/ewma 2.669/3.224 ms
# PING 5.5.5.4 (5.5.5.4) 56(84) bytes of data.
# 
# --- 5.5.5.4 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 529ms
# rtt min/avg/max/mdev = 0.487/0.968/11.398/1.148 ms, pipe 2, ipg/ewma 1.060/0.936 ms
# PING 5.5.5.4 (5.5.5.4) 3000(3028) bytes of data.
# 
# --- 5.5.5.4 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 1521ms
# rtt min/avg/max/mdev = 1.687/2.827/13.993/2.011 ms, pipe 2, ipg/ewma 3.048/2.075 ms
# PING 5.5.5.5 (5.5.5.5) 56(84) bytes of data.
# 
# --- 5.5.5.5 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 421ms
# rtt min/avg/max/mdev = 0.487/0.765/12.615/0.984 ms, pipe 2, ipg/ewma 0.844/0.987 ms
# PING 5.5.5.5 (5.5.5.5) 3000(3028) bytes of data.
# 
# --- 5.5.5.5 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 1777ms
# rtt min/avg/max/mdev = 1.699/3.349/18.337/2.677 ms, pipe 2, ipg/ewma 3.561/2.515 ms
# PING 5.5.5.6 (5.5.5.6) 56(84) bytes of data.
# 
# --- 5.5.5.6 ping statistics ---
# 501 packets transmitted, 500 received, 0.199601% packet loss, time 1903ms
# rtt min/avg/max/mdev = 0.494/3.996/19.574/5.538 ms, pipe 2, ipg/ewma 3.805/13.050 ms
# PING 5.5.5.6 (5.5.5.6) 3000(3028) bytes of data.
# 
# --- 5.5.5.6 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 1441ms
# rtt min/avg/max/mdev = 1.692/2.659/13.877/1.775 ms, pipe 2, ipg/ewma 2.887/4.022 ms
# PING 5.5.5.7 (5.5.5.7) 56(84) bytes of data.
# 
# --- 5.5.5.7 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 443ms
# rtt min/avg/max/mdev = 0.488/0.804/15.243/1.044 ms, pipe 2, ipg/ewma 0.887/1.022 ms
# PING 5.5.5.7 (5.5.5.7) 3000(3028) bytes of data.
# 
# --- 5.5.5.7 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 1531ms
# rtt min/avg/max/mdev = 1.688/2.826/12.038/1.965 ms, pipe 2, ipg/ewma 3.068/2.339 ms
# PING 11.11.11.11 (11.11.11.11) 56(84) bytes of data.
# 
# --- 11.11.11.11 ping statistics ---
# 500 packets transmitted, 500 received, 0% packet loss, time 426ms
# rtt min/avg/max/mdev = 0.490/0.774/9.649/0.837 ms, ipg/ewma 0.853/0.995 ms
# -----------------------------------------------------------
# Server listening on 5201 (test #1)
# -----------------------------------------------------------
# Connecting to host 5.5.5.1, port 5201
# Accepted connection from 5.5.5.2, port 33968
# [  7] local 5.5.5.2 port 33976 connected to 5.5.5.1 port 5201
# [  7] local 5.5.5.1 port 5201 connected to 5.5.5.2 port 33976
# [ ID] Interval           Transfer     Bitrate
# [  7]   0.00-1.00   sec  2.50 MBytes  21.0 Mbits/sec                  
# [ ID] Interval           Transfer     Bitrate         Retr  Cwnd
# [  7]   0.00-1.00   sec  2.62 MBytes  22.0 Mbits/sec    8    167 KBytes       
# [  7]   1.00-2.00   sec  2.75 MBytes  23.1 Mbits/sec                  
# [  7]   1.00-2.00   sec  2.62 MBytes  21.9 Mbits/sec    0    167 KBytes       
# [  7]   2.00-3.00   sec  2.38 MBytes  19.9 Mbits/sec                  
# [  7]   3.00-3.09   sec   256 KBytes  22.8 Mbits/sec                  
# - - - - - - - - - - - - - - - - - - - - - - - - -
# [ ID] Interval           Transfer     Bitrate
# [  7]   0.00-3.09   sec  7.88 MBytes  21.4 Mbits/sec                  receiver
# [  7]   2.00-3.01   sec  1.88 MBytes  15.7 Mbits/sec    0    167 KBytes       
# - - - - - - - - - - - - - - - - - - - - - - - - -
# [ ID] Interval           Transfer     Bitrate         Retr
# [  7]   0.00-3.01   sec  7.88 MBytes  22.0 Mbits/sec    8            sender
# [  7]   0.00-3.09   sec  7.88 MBytes  21.4 Mbits/sec                  receiver
# 
# iperf Done.
# Adding secondary key and then swap:
# Querying all peers:
# List of peers connected to: tun0
# * Peer 4
# TX peer ID 4
# VPN IPv4: 5.5.5.5
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1576000
# VPN TX bytes: 1576000
# VPN RX packets: 2000
# VPN TX packets: 2000
# LINK RX bytes: 1624216
# LINK TX bytes: 1624000
# LINK RX packets: 2003
# LINK TX packets: 2000
# * Peer 3
# TX peer ID 3
# VPN IPv4: 5.5.5.4
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1576000
# VPN TX bytes: 1576000
# VPN RX packets: 2000
# VPN TX packets: 2000
# LINK RX bytes: 1624144
# LINK TX bytes: 1624000
# LINK RX packets: 2002
# LINK TX packets: 2000
# * Peer 5
# TX peer ID 5
# VPN IPv4: 5.5.5.6
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1576084
# VPN TX bytes: 1576084
# VPN RX packets: 2001
# VPN TX packets: 2001
# LINK RX bytes: 1624252
# LINK TX bytes: 1624108
# LINK RX packets: 2003
# LINK TX packets: 2001
# * Peer 1
# TX peer ID 1
# VPN IPv4: 5.5.5.2
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 10278454
# VPN TX bytes: 1638595
# VPN RX packets: 8758
# VPN TX packets: 2888
# LINK RX bytes: 10488862
# LINK TX bytes: 1707907
# LINK RX packets: 8761
# LINK TX packets: 2888
# * Peer 6
# TX peer ID 6
# VPN IPv4: 5.5.5.7
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1576000
# VPN TX bytes: 1576000
# VPN RX packets: 2000
# VPN TX packets: 2000
# LINK RX bytes: 1624144
# LINK TX bytes: 1624000
# LINK RX packets: 2002
# LINK TX packets: 2000
# * Peer 2
# TX peer ID 2
# VPN IPv4: 5.5.5.3
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1579068
# VPN TX bytes: 1579068
# VPN RX packets: 2003
# VPN TX packets: 2003
# LINK RX bytes: 1627284
# LINK TX bytes: 1627140
# LINK RX packets: 2005
# LINK TX packets: 2003
# List of peers connected to: tun1
# * Peer 1
# TX peer ID 1
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 1638595
# VPN TX bytes: 10278598
# VPN RX packets: 2888
# VPN TX packets: 8761
# LINK RX bytes: 1707907
# LINK TX bytes: 10488862
# LINK RX packets: 2888
# LINK TX packets: 8761
# Querying peer 1:
# * Peer 1
# TX peer ID 1
# VPN IPv4: 5.5.5.2
# Keepalive interval: 60 sec
# Keepalive timeout: 120 sec
# VPN RX bytes: 10278454
# VPN TX bytes: 1638595
# VPN RX packets: 8758
# VPN TX packets: 2888
# LINK RX bytes: 10488862
# LINK TX bytes: 1707907
# LINK RX packets: 8761
# LINK TX packets: 2888
# Querying non-existent peer 20:
# kernel error: ovpn: cannot find peer with id 20
# netlink reports error (-12): Object not found
# failed to send netlink message: No such file or directory (-2)
# Cannot execute command: No such file or directory (-2)
# Deleting peer 1:
# Querying keys:
# * Peer 2
# - Slot: primary
# - Key ID: 1
# - Cipher: aes-gcm
# * Peer 2
# - Slot: secondary
# - Key ID: 0
# - Cipher: aes-gcm
# * Peer 3
# - Slot: primary
# - Key ID: 1
# - Cipher: aes-gcm
# * Peer 3
# - Slot: secondary
# - Key ID: 0
# - Cipher: aes-gcm
# * Peer 4
# - Slot: primary
# - Key ID: 1
# - Cipher: aes-gcm
# * Peer 4
# - Slot: secondary
# - Key ID: 0
# - Cipher: aes-gcm
# * Peer 5
# - Slot: primary
# - Key ID: 1
# - Cipher: aes-gcm
# * Peer 5
# - Slot: secondary
# - Key ID: 0
# - Cipher: aes-gcm
# * Peer 6
# - Slot: primary
# - Key ID: 1
# - Cipher: aes-gcm
# * Peer 6
# - Slot: secondary
# - Key ID: 0
# - Cipher: aes-gcm
# Deleting peer while sending traffic:
# PING 5.5.5.1 (5.5.5.1) 56(84) bytes of data.
# Deleting keys:
# Setting timeout to 3s MP:
# 
# --- 5.5.5.1 ping statistics ---
# 2128 packets transmitted, 1956 received, 8.08271% packet loss, time 3996ms
# rtt min/avg/max/mdev = 0.484/0.951/16.532/1.361 ms, pipe 2, ipg/ewma 1.878/0.751 ms
# Setting timeout to 3s P2P:
# ./common.sh: line 150: kill: (2767) - No such process
# Checking notifications for peer 0... 19,54d18
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 3
# <     }
# <   }
# < }
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 4
# <     }
# <   }
# < }
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 5
# <     }
# <   }
# < }
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 6
# <     }
# <   }
# < }
# ./common.sh: line 150: kill: (2769) - No such process
# Checking notifications for peer 1... OK
# ./common.sh: line 150: kill: (2771) - No such process
# Checking notifications for peer 2... OK
# ./common.sh: line 150: kill: (2773) - No such process
# Checking notifications for peer 3... 1,9d0
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 3
# <     }
# <   }
# < }
# ./common.sh: line 150: kill: (2775) - No such process
# Checking notifications for peer 4... 1,9d0
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 4
# <     }
# <   }
# < }
# ./common.sh: line 150: kill: (2777) - No such process
# Checking notifications for peer 5... 1,9d0
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 5
# <     }
# <   }
# < }
# ./common.sh: line 150: kill: (2779) - No such process
# Checking notifications for peer 6... 1,9d0
# < {
# <   "name": "peer-del-ntf",
# <   "msg": {
# <     "peer": {
# <       "del-reason": "expired",
# <       "id": 6
# <     }
# <   }
# < }
# Deleting interface tun1 ifindex 4
# Deleting interface tun2 ifindex 4
# Deleting interface tun3 ifindex 4
# Deleting interface tun4 ifindex 4
# Deleting interface tun5 ifindex 4
# Deleting interface tun6 ifindex 4
ok 1 selftests: net/ovpn: test-symmetric-id-tcp.sh
make[1]: Leaving directory '/srv/vmksft/testing/wt-6/tools/testing/selftests/net/ovpn'
make: Leaving directory '/srv/vmksft/testing/wt-6/tools/testing/selftests'
xx__-> echo $?
0
xx__-> echo scan > /sys/kernel/debug/kmemleak
xx__-> <el/debug/kmemleak && cat /sys/kernel/debug/kmemleak
xx__->