On Tue, Jan 24, 2023 at 02:01:19PM +0100, Eelco Chaudron wrote: > With some datapaths, read TC, it takes a bit longer to update the > OpenFlow statistics. Rather than adding an additional delay, try > to read the counters multiple times until we get the desired value. > > Signed-off-by: Eelco Chaudron <echau...@redhat.com> > Acked-by: Roi Dayan <r...@nvidia.com>
When, possibly unwisely, running this test on my laptop, with a somewhat old kernel the tests fail with absurd byte counts. I haven't had time to dig into why. $ uname -spv Linux #1 SMP Debian 5.10.158-2 (2022-12-13) unknown The first test appears to fail with n_bytes=18446744073709159596 And the second, with n_bytes=18446744073703563162 Log follows: make all-am make[1]: Map '/home/horms/projects/openvswitch/ovs' wordt binnengegaan make[1]: Map '/home/horms/projects/openvswitch/ovs' wordt verlaten set /bin/bash './tests/system-offloads-testsuite' -C tests AUTOTEST_PATH='utilities:vswitchd:ovsdb:vtep:tests:ipsec::'; \ "$@" -k "datapath - truncate and output" -v -j1 || (test X'' = Xyes && "$@" --recheck) Illegal "police" ## ------------------------------ ## ## openvswitch 3.1.90 test suite. ## ## ------------------------------ ## datapath-sanity 50. system-traffic.at:1639: testing datapath - truncate and output to gre tunnel by simulated packets ... ./system-traffic.at:1642: modprobe openvswitch Module vport_lisp not loaded. Module vport_stt not loaded. ./system-traffic.at:1642: ovsdb-tool create conf.db $abs_top_srcdir/vswitchd/vswitch.ovsschema ./system-traffic.at:1642: ovsdb-server --detach --no-chdir --pidfile --log-file --remote=punix:$OVS_RUNDIR/db.sock stderr: 2023-01-26T16:43:57Z|00001|vlog|INFO|opened log file /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/ovsdb-server.log ./system-traffic.at:1642: sed < stderr ' /vlog|INFO|opened log file/d /ovsdb_server|INFO|ovsdb-server (Open vSwitch)/d' ./system-traffic.at:1642: ovs-vsctl --no-wait init -- set Open_vSwitch . other_config:hw-offload=true ./system-traffic.at:1642: ovs-vswitchd --detach --no-chdir --pidfile --log-file -vvconn -vofproto_dpif -vunixctl stderr: 2023-01-26T16:43:57Z|00001|vlog|INFO|opened log file /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/ovs-vswitchd.log 2023-01-26T16:43:57Z|00002|ovs_numa|INFO|Discovered 8 CPU cores on NUMA node 0 2023-01-26T16:43:57Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 8 CPU cores 2023-01-26T16:43:57Z|00004|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/db.sock: connecting... 2023-01-26T16:43:57Z|00005|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/db.sock: connected 2023-01-26T16:43:57Z|00006|netdev_offload|INFO|netdev: Flow API Enabled 2023-01-26T16:43:57Z|00007|tc|INFO|tc: Using policy 'none' ./system-traffic.at:1642: sed < stderr ' /ovs_numa|INFO|Discovered /d /odp_execute_impl|INFO|Action implementation /d /vlog|INFO|opened log file/d /vswitchd|INFO|ovs-vswitchd (Open vSwitch)/d /reconnect|INFO|/d /dpif_netlink|INFO|Generic Netlink family .ovs_datapath. does not exist/d /ofproto|INFO|using datapath ID/d /netdev_linux|INFO|.*device has unknown hardware address family/d /ofproto|INFO|datapath ID changed to fedcba9876543210/d /dpdk|INFO|DPDK Disabled - Use other_config:dpdk-init to enable/d /netlink_socket|INFO|netlink: could not enable listening to all nsid/d /netdev_offload|INFO|netdev: Flow API Enabled/d /probe tc:/d /setting extended ack support failed/d /tc: Using policy/d' ./system-traffic.at:1642: ovs-vsctl -- add-br br0 -- set Bridge br0 protocols=OpenFlow10,OpenFlow11,OpenFlow12,OpenFlow13,OpenFlow14,OpenFlow15 fail-mode=secure -- Cannot remove namespace file "/run/netns/at_ns0": No such file or directory ./system-traffic.at:1645: ip netns add at_ns0 || return 77 net.netfilter.nf_conntrack_helper = 0 Cannot remove namespace file "/run/netns/at_ns1": No such file or directory ./system-traffic.at:1646: ip netns add at_ns1 || return 77 net.netfilter.nf_conntrack_helper = 0 ./system-traffic.at:1647: ovs-ofctl add-flow br0 "actions=normal" ./system-traffic.at:1648: ovs-ofctl add-flow br-underlay "actions=normal" ./system-traffic.at:1651: ip link add p0 type veth peer name ovs-p0 || return 77 ./system-traffic.at:1651: ip link set p0 netns at_ns0 ./system-traffic.at:1651: ip link set dev ovs-p0 up ./system-traffic.at:1651: ovs-vsctl add-port br-underlay ovs-p0 -- \ set interface ovs-p0 external-ids:iface-id="p0" ./system-traffic.at:1651: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip addr add "172.31.1.1/24" dev p0 NS_EXEC_HEREDOC ./system-traffic.at:1651: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip link set dev p0 up NS_EXEC_HEREDOC ./system-traffic.at:1651: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip link set dev p0 address fa:ad:fa:25:05:60 NS_EXEC_HEREDOC ./system-traffic.at:1652: ip addr add dev br-underlay "172.31.1.100/24" ./system-traffic.at:1653: ip link set dev br-underlay up ./system-traffic.at:1657: ovs-vsctl add-port br0 at_gre0 -- \ set int at_gre0 type=gre options:remote_ip=172.31.1.1 ./system-traffic.at:1657: ip addr add dev br0 10.1.1.100/24 ./system-traffic.at:1657: ip link set dev br0 up ./system-traffic.at:1657: ip link set dev br0 mtu 1450 ./system-traffic.at:1667: ip link add p1 type veth peer name ovs-p1 || return 77 ./system-traffic.at:1667: ip link set p1 netns at_ns1 ./system-traffic.at:1667: ip link set dev ovs-p1 up ./system-traffic.at:1667: ovs-vsctl add-port br0 ovs-p1 -- \ set interface ovs-p1 external-ids:iface-id="p1" ./system-traffic.at:1667: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip addr add '10.1.1.2/24' dev p1 NS_EXEC_HEREDOC ./system-traffic.at:1667: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip link set dev p1 up NS_EXEC_HEREDOC ./system-traffic.at:1668: ovs-vsctl -- set interface ovs-p1 ofport_request=2 ./system-traffic.at:1669: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip link set dev p1 address e6:66:c1:22:22:22 NS_EXEC_HEREDOC ./system-traffic.at:1670: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC arp -s 10.1.1.1 e6:66:c1:11:11:11 NS_EXEC_HEREDOC ./system-traffic.at:1673: ip link add p2 type veth peer name ovs-p2 ./system-traffic.at:1675: ip link set dev ovs-p2 up ./system-traffic.at:1676: ip link set dev p2 up ./system-traffic.at:1677: ovs-vsctl add-port br0 ovs-p2 -- set interface ovs-p2 ofport_request=3 ./system-traffic.at:1678: ovs-vsctl add-port br0 p2 -- set interface p2 ofport_request=4 ./system-traffic.at:1681: dd if=/dev/urandom of=payload200.bin bs=200 count=1 2> /dev/null ./system-traffic.at:1684: ovs-ofctl del-flows br0 ./system-traffic.at:1691: ovs-ofctl add-flows br0 flows.txt ./system-traffic.at:1693: ovs-ofctl del-flows br-underlay ./system-traffic.at:1700: ovs-ofctl add-flows br-underlay flows-underlay.txt ./system-traffic.at:1703: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC nc $NC_EOF_OPT -u 10.1.1.1 1234 < payload200.bin NS_EXEC_HEREDOC ./system-traffic.at:1704: sleep 2; ovs-appctl revalidator/purge ./system-traffic.at:1707: ovs-ofctl dump-flows br0 | grep "in_port=2" | sed -n 's/.*\(n\_bytes=[0-9]*\).*/\1/p' system-traffic.at:1711: waiting until ovs-ofctl dump-flows br-underlay | grep "in_port=LOCAL" | sed -n 's/.*\(n\_bytes=[0-9]*\).*/\1/p' | grep "n_bytes=138"... system-traffic.at:1711: wait failed after 30 seconds n_bytes=18446744073709159596 ./ovs-macros.at:247: hard failure 2023-01-26T16:44:33Z|00001|daemon_unix|WARN|/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/ovs-vswitchd.pid: open: No such file or directory ovs-appctl: cannot read pidfile "/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/050/ovs-vswitchd.pid" (No such file or directory) ovs-dpctl: opening datapath (No such device) 50. system-traffic.at:1639: FAILED (ovs-macros.at:247) 51. system-traffic.at:1768: testing datapath - truncate and output to gre tunnel ... ./system-traffic.at:1772: modprobe openvswitch Module vport_lisp not loaded. Module vport_stt not loaded. ./system-traffic.at:1772: ovsdb-tool create conf.db $abs_top_srcdir/vswitchd/vswitch.ovsschema ./system-traffic.at:1772: ovsdb-server --detach --no-chdir --pidfile --log-file --remote=punix:$OVS_RUNDIR/db.sock stderr: 2023-01-26T16:44:35Z|00001|vlog|INFO|opened log file /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovsdb-server.log ./system-traffic.at:1772: sed < stderr ' /vlog|INFO|opened log file/d /ovsdb_server|INFO|ovsdb-server (Open vSwitch)/d' ./system-traffic.at:1772: ovs-vsctl --no-wait init -- set Open_vSwitch . other_config:hw-offload=true ./system-traffic.at:1772: ovs-vswitchd --detach --no-chdir --pidfile --log-file -vvconn -vofproto_dpif -vunixctl stderr: 2023-01-26T16:44:35Z|00001|vlog|INFO|opened log file /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovs-vswitchd.log 2023-01-26T16:44:35Z|00002|ovs_numa|INFO|Discovered 8 CPU cores on NUMA node 0 2023-01-26T16:44:35Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 8 CPU cores 2023-01-26T16:44:35Z|00004|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/db.sock: connecting... 2023-01-26T16:44:35Z|00005|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/db.sock: connected 2023-01-26T16:44:35Z|00006|netdev_offload|INFO|netdev: Flow API Enabled 2023-01-26T16:44:35Z|00007|tc|INFO|tc: Using policy 'none' ./system-traffic.at:1772: sed < stderr ' /ovs_numa|INFO|Discovered /d /odp_execute_impl|INFO|Action implementation /d /vlog|INFO|opened log file/d /vswitchd|INFO|ovs-vswitchd (Open vSwitch)/d /reconnect|INFO|/d /dpif_netlink|INFO|Generic Netlink family .ovs_datapath. does not exist/d /ofproto|INFO|using datapath ID/d /netdev_linux|INFO|.*device has unknown hardware address family/d /ofproto|INFO|datapath ID changed to fedcba9876543210/d /dpdk|INFO|DPDK Disabled - Use other_config:dpdk-init to enable/d /netlink_socket|INFO|netlink: could not enable listening to all nsid/d /netdev_offload|INFO|netdev: Flow API Enabled/d /probe tc:/d /setting extended ack support failed/d /tc: Using policy/d' ./system-traffic.at:1772: ovs-vsctl -- add-br br0 -- set Bridge br0 protocols=OpenFlow10,OpenFlow11,OpenFlow12,OpenFlow13,OpenFlow14,OpenFlow15 fail-mode=secure -- Cannot remove namespace file "/run/netns/at_ns0": No such file or directory ./system-traffic.at:1775: ip netns add at_ns0 || return 77 net.netfilter.nf_conntrack_helper = 0 Cannot remove namespace file "/run/netns/at_ns1": No such file or directory ./system-traffic.at:1776: ip netns add at_ns1 || return 77 net.netfilter.nf_conntrack_helper = 0 ./system-traffic.at:1777: ovs-ofctl add-flow br0 "actions=normal" ./system-traffic.at:1778: ovs-ofctl add-flow br-underlay "actions=normal" ./system-traffic.at:1781: ip link add p0 type veth peer name ovs-p0 || return 77 ./system-traffic.at:1781: ip link set p0 netns at_ns0 ./system-traffic.at:1781: ip link set dev ovs-p0 up ./system-traffic.at:1781: ovs-vsctl add-port br-underlay ovs-p0 -- \ set interface ovs-p0 external-ids:iface-id="p0" ./system-traffic.at:1781: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip addr add "172.31.1.1/24" dev p0 NS_EXEC_HEREDOC ./system-traffic.at:1781: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip link set dev p0 up NS_EXEC_HEREDOC ./system-traffic.at:1782: ip addr add dev br-underlay "172.31.1.100/24" ./system-traffic.at:1783: ip link set dev br-underlay up ./system-traffic.at:1787: ovs-vsctl add-port br0 at_gre0 -- \ set int at_gre0 type=gre options:remote_ip=172.31.1.1 ./system-traffic.at:1787: ip addr add dev br0 10.1.1.100/24 ./system-traffic.at:1787: ip link set dev br0 up ./system-traffic.at:1787: ip link set dev br0 mtu 1450 ./system-traffic.at:1788: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip link add dev ns_gre0 type gretap remote 172.31.1.100 NS_EXEC_HEREDOC ./system-traffic.at:1788: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip addr add dev ns_gre0 10.1.1.1/24 NS_EXEC_HEREDOC ./system-traffic.at:1788: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC ip link set dev ns_gre0 mtu 1450 address e6:66:c1:11:11:11 up NS_EXEC_HEREDOC ./system-traffic.at:1790: ovs-vsctl -- set interface at_gre0 ofport_request=1 ./system-traffic.at:1791: ip netns exec at_ns0 sh << NS_EXEC_HEREDOC arp -s 10.1.1.2 e6:66:c1:22:22:22 NS_EXEC_HEREDOC ./system-traffic.at:1794: ip link add p1 type veth peer name ovs-p1 || return 77 ./system-traffic.at:1794: ip link set p1 netns at_ns1 ./system-traffic.at:1794: ip link set dev ovs-p1 up ./system-traffic.at:1794: ovs-vsctl add-port br0 ovs-p1 -- \ set interface ovs-p1 external-ids:iface-id="p1" ./system-traffic.at:1794: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip addr add '10.1.1.2/24' dev p1 NS_EXEC_HEREDOC ./system-traffic.at:1794: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip link set dev p1 up NS_EXEC_HEREDOC ./system-traffic.at:1795: ovs-vsctl -- set interface ovs-p1 ofport_request=2 ./system-traffic.at:1796: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC ip link set dev p1 address e6:66:c1:22:22:22 NS_EXEC_HEREDOC ./system-traffic.at:1797: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC arp -s 10.1.1.1 e6:66:c1:11:11:11 NS_EXEC_HEREDOC ./system-traffic.at:1800: ip link add p2 type veth peer name ovs-p2 ./system-traffic.at:1802: ip link set dev ovs-p2 up ./system-traffic.at:1803: ip link set dev p2 up ./system-traffic.at:1804: ovs-vsctl add-port br0 ovs-p2 -- set interface ovs-p2 ofport_request=3 ./system-traffic.at:1805: ovs-vsctl add-port br0 p2 -- set interface p2 ofport_request=4 ./system-traffic.at:1808: dd if=/dev/urandom of=payload200.bin bs=200 count=1 2> /dev/null ./system-traffic.at:1811: ovs-ofctl del-flows br0 ./system-traffic.at:1818: ovs-ofctl add-flows br0 flows.txt ./system-traffic.at:1820: ovs-ofctl del-flows br-underlay ./system-traffic.at:1827: ovs-ofctl add-flows br-underlay flows-underlay.txt ./system-traffic.at:1830: ip netns exec at_ns1 sh << NS_EXEC_HEREDOC nc $NC_EOF_OPT -u 10.1.1.1 1234 < payload200.bin NS_EXEC_HEREDOC ./system-traffic.at:1831: sleep 2; ovs-appctl revalidator/purge ./system-traffic.at:1834: ovs-ofctl dump-flows br0 | grep "in_port=2" | sed -n 's/.*\(n\_bytes=[0-9]*\).*/\1/p' ./system-traffic.at:1838: ovs-ofctl dump-flows br-underlay | grep "in_port=LOCAL" | sed -n 's/.*\(n\_bytes=[0-9]*\).*/\1/p' --- - 2023-01-26 17:44:41.102671600 +0100 +++ /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/at-groups/51/stdout 2023-01-26 17:44:41.098239330 +0100 @@ -1,2 +1,2 @@ -n_bytes=138 +n_bytes=18446744073703563162 ovsdb-server.log: > 2023-01-26T16:44:35.719Z|00001|vlog|INFO|opened log file > /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovsdb-server.log > 2023-01-26T16:44:35.748Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) > 3.1.90 ovs-vswitchd.log: > 2023-01-26T16:44:35.760Z|00001|vlog|INFO|opened log file > /home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovs-vswitchd.log > 2023-01-26T16:44:35.761Z|00002|ovs_numa|INFO|Discovered 8 CPU cores on NUMA > node 0 > 2023-01-26T16:44:35.761Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 8 > CPU cores > 2023-01-26T16:44:35.761Z|00004|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/db.sock: > connecting... > 2023-01-26T16:44:35.761Z|00005|reconnect|INFO|unix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/db.sock: > connected > 2023-01-26T16:44:35.763Z|00006|netdev_offload|INFO|netdev: Flow API Enabled > 2023-01-26T16:44:35.763Z|00007|tc|INFO|tc: Using policy 'none' > 2023-01-26T16:44:35.765Z|00008|bridge|INFO|ovs-vswitchd (Open vSwitch) 3.1.90 > 2023-01-26T16:44:35.775Z|00009|dpif_netlink|INFO|Datapath dispatch mode: > per-vport > 2023-01-26T16:44:35.851Z|00010|netdev_offload_tc|INFO|probe tc: block offload > is supported. > 2023-01-26T16:44:35.895Z|00011|netdev_offload_tc|INFO|probe tc: multiple > masks on single tc prio is supported. > 2023-01-26T16:44:36.055Z|00012|netdev_offload_tc|INFO|probe tc: supported ovs > ct_state bits: 0x27 > 2023-01-26T16:44:36.055Z|00013|netdev_offload_tc|INFO|added ingress qdisc to > ovs-system > 2023-01-26T16:44:36.055Z|00014|netdev_offload|INFO|ovs-system: Assigned flow > API 'linux_tc'. > 2023-01-26T16:44:36.056Z|00015|ofproto_dpif|INFO|system@ovs-system: Datapath > supports recirculation > 2023-01-26T16:44:36.056Z|00016|ofproto_dpif|INFO|system@ovs-system: VLAN > header stack length probed as 2 > 2023-01-26T16:44:36.056Z|00017|ofproto_dpif|INFO|system@ovs-system: MPLS > label stack length probed as 3 > 2023-01-26T16:44:36.056Z|00018|ofproto_dpif|INFO|system@ovs-system: Datapath > supports truncate action > 2023-01-26T16:44:36.056Z|00019|ofproto_dpif|INFO|system@ovs-system: Datapath > supports unique flow ids > 2023-01-26T16:44:36.056Z|00020|ofproto_dpif|INFO|system@ovs-system: Datapath > supports clone action > 2023-01-26T16:44:36.057Z|00021|ofproto_dpif|INFO|system@ovs-system: Max > sample nesting level probed as 10 > 2023-01-26T16:44:36.057Z|00022|ofproto_dpif|INFO|system@ovs-system: Datapath > supports eventmask in conntrack action > 2023-01-26T16:44:36.057Z|00023|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_clear action > 2023-01-26T16:44:36.057Z|00024|ofproto_dpif|INFO|system@ovs-system: Max > dp_hash algorithm probed to be 0 > 2023-01-26T16:44:36.057Z|00025|ofproto_dpif|INFO|system@ovs-system: Datapath > supports check_pkt_len action > 2023-01-26T16:44:36.057Z|00026|ofproto_dpif|INFO|system@ovs-system: Datapath > supports timeout policy in conntrack action > 2023-01-26T16:44:36.057Z|00027|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_zero_snat > 2023-01-26T16:44:36.057Z|00028|ofproto_dpif|INFO|system@ovs-system: Datapath > supports add_mpls action > 2023-01-26T16:44:36.057Z|00029|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_state > 2023-01-26T16:44:36.058Z|00030|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_zone > 2023-01-26T16:44:36.058Z|00031|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_mark > 2023-01-26T16:44:36.058Z|00032|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_label > 2023-01-26T16:44:36.058Z|00033|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_state_nat > 2023-01-26T16:44:36.058Z|00034|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_orig_tuple > 2023-01-26T16:44:36.058Z|00035|ofproto_dpif|INFO|system@ovs-system: Datapath > supports ct_orig_tuple6 > 2023-01-26T16:44:36.058Z|00036|ofproto_dpif|INFO|system@ovs-system: Datapath > does not support IPv6 ND Extensions > 2023-01-26T16:44:36.058Z|00037|ofproto_dpif_upcall|INFO|Setting > n-handler-threads to 5, setting n-revalidator-threads to 3 > 2023-01-26T16:44:36.058Z|00038|ofproto_dpif_upcall|INFO|Starting 8 threads > 2023-01-26T16:44:36.072Z|00039|netdev_offload_tc|INFO|added ingress qdisc to > br0 > 2023-01-26T16:44:36.072Z|00040|netdev_offload|INFO|br0: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.072Z|00041|bridge|INFO|bridge br0: added interface br0 on > port 65534 > 2023-01-26T16:44:36.073Z|00042|bridge|INFO|bridge br0: using datapath ID > 000016215abb444a > 2023-01-26T16:44:36.073Z|00043|connmgr|INFO|br0: added service controller > "punix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/br0.mgmt" > 2023-01-26T16:44:36.106Z|00044|netdev_offload_tc|INFO|added ingress qdisc to > br-underlay > 2023-01-26T16:44:36.106Z|00045|netdev_offload|INFO|br-underlay: Assigned flow > API 'linux_tc'. > 2023-01-26T16:44:36.106Z|00046|bridge|INFO|bridge br-underlay: added > interface br-underlay on port 65534 > 2023-01-26T16:44:36.107Z|00047|bridge|INFO|bridge br-underlay: using datapath > ID 00002a96e384084e > 2023-01-26T16:44:36.107Z|00048|connmgr|INFO|br-underlay: added service > controller > "punix:/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/br-underlay.mgmt" > 2023-01-26T16:44:36.147Z|00049|vconn|DBG|unix#0: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x1): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.147Z|00050|vconn|DBG|unix#0: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:36.147Z|00051|vconn|DBG|unix#0: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.147Z|00052|vconn|DBG|unix#0: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:36.148Z|00053|vconn|DBG|unix#0: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=0, lookup=0, matched=0 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > tables 1...253: ditto > 2023-01-26T16:44:36.148Z|00054|vconn|DBG|unix#1: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x2): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.148Z|00055|vconn|DBG|unix#1: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:36.148Z|00056|vconn|DBG|unix#1: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.148Z|00057|vconn|DBG|unix#1: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:36.148Z|00058|vconn|DBG|unix#1: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:000016215abb444a > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > LOCAL(br0): addr:16:21:5a:bb:44:4a > config: PORT_DOWN > state: LINK_DOWN > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:36.148Z|00059|vconn|DBG|unix#2: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x3): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.148Z|00060|vconn|DBG|unix#2: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:36.148Z|00061|vconn|DBG|unix#2: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.148Z|00062|vconn|DBG|unix#2: received: OFPT_FLOW_MOD > (xid=0x6): ADD actions=NORMAL > 2023-01-26T16:44:36.148Z|00063|vconn|DBG|unix#2: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:36.148Z|00064|vconn|DBG|unix#2: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:36.148Z|00065|connmgr|INFO|br0<->unix#2: 1 flow_mods in the > last 0 s (1 adds) > 2023-01-26T16:44:36.152Z|00066|vconn|DBG|unix#3: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x4): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.152Z|00067|vconn|DBG|unix#3: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:36.152Z|00068|vconn|DBG|unix#3: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.152Z|00069|vconn|DBG|unix#3: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:36.152Z|00070|vconn|DBG|unix#3: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=0, lookup=0, matched=0 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > tables 1...253: ditto > 2023-01-26T16:44:36.152Z|00071|vconn|DBG|unix#4: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x5): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.152Z|00072|vconn|DBG|unix#4: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:36.152Z|00073|vconn|DBG|unix#4: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.152Z|00074|vconn|DBG|unix#4: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:36.153Z|00075|vconn|DBG|unix#4: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:00002a96e384084e > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > LOCAL(br-underlay): addr:2a:96:e3:84:08:4e > config: PORT_DOWN > state: LINK_DOWN > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:36.153Z|00076|vconn|DBG|unix#5: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x6): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:36.153Z|00077|vconn|DBG|unix#5: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:36.153Z|00078|vconn|DBG|unix#5: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:36.153Z|00079|vconn|DBG|unix#5: received: OFPT_FLOW_MOD > (xid=0x6): ADD actions=NORMAL > 2023-01-26T16:44:36.153Z|00080|vconn|DBG|unix#5: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:36.153Z|00081|vconn|DBG|unix#5: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:36.153Z|00082|connmgr|INFO|br-underlay<->unix#5: 1 flow_mods > in the last 0 s (1 adds) > 2023-01-26T16:44:36.213Z|00083|netdev_offload_tc|INFO|added ingress qdisc to > ovs-p0 > 2023-01-26T16:44:36.213Z|00084|netdev_offload|INFO|ovs-p0: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.213Z|00085|bridge|INFO|bridge br-underlay: added > interface ovs-p0 on port 1 > 2023-01-26T16:44:36.231Z|00086|netdev_offload_tc|INFO|added ingress qdisc to > at_gre0 > 2023-01-26T16:44:36.231Z|00087|netdev_offload|INFO|at_gre0: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.231Z|00088|bridge|INFO|bridge br0: added interface > at_gre0 on port 1 > 2023-01-26T16:44:36.695Z|00089|netdev_offload_tc|INFO|added ingress qdisc to > ovs-p1 > 2023-01-26T16:44:36.695Z|00090|netdev_offload|INFO|ovs-p1: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.695Z|00091|bridge|INFO|bridge br0: added interface ovs-p1 > on port 2 > 2023-01-26T16:44:36.851Z|00092|netdev_offload_tc|INFO|added ingress qdisc to > ovs-p2 > 2023-01-26T16:44:36.851Z|00093|netdev_offload|INFO|ovs-p2: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.851Z|00094|bridge|INFO|bridge br0: added interface ovs-p2 > on port 3 > 2023-01-26T16:44:36.879Z|00095|netdev_offload_tc|INFO|added ingress qdisc to > p2 > 2023-01-26T16:44:36.879Z|00096|netdev_offload|INFO|p2: Assigned flow API > 'linux_tc'. > 2023-01-26T16:44:36.879Z|00097|bridge|INFO|bridge br0: added interface p2 on > port 4 > 2023-01-26T16:44:36.902Z|00001|ofproto_dpif_upcall(handler1)|INFO|received > packet on unassociated datapath port 7 (no OpenFlow port for datapath port 7) > 2023-01-26T16:44:37.122Z|00098|vconn|DBG|unix#6: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x7): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.122Z|00099|vconn|DBG|unix#6: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:37.122Z|00100|vconn|DBG|unix#6: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.122Z|00101|vconn|DBG|unix#6: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:37.127Z|00102|vconn|DBG|unix#6: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=1, lookup=1190, matched=1190 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > table 1: > active=0, lookup=0, matched=0 > (same features) > > tables 2...253: ditto > 2023-01-26T16:44:37.206Z|00103|vconn|DBG|unix#7: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x8): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.206Z|00104|vconn|DBG|unix#7: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:37.206Z|00105|vconn|DBG|unix#7: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.228Z|00106|vconn|DBG|unix#7: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:37.228Z|00107|vconn|DBG|unix#7: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:000016215abb444a > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > 1(at_gre0): addr:a2:f9:64:45:eb:65 > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2(ovs-p1): addr:32:68:ed:0f:cc:60 > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > 3(ovs-p2): addr:0e:8a:4c:65:90:6c > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > 4(p2): addr:8e:57:dd:84:91:3f > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > LOCAL(br0): addr:16:21:5a:bb:44:4a > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:37.282Z|00108|vconn|DBG|unix#8: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x9): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.282Z|00109|vconn|DBG|unix#8: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:37.283Z|00110|vconn|DBG|unix#8: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.294Z|00001|dpif_netlink(handler5)|WARN|system@ovs-system: > lost packet on port channel 2 of handler 3 (last polled 11 ms ago) > 2023-01-26T16:44:37.322Z|00111|vconn|DBG|unix#8: received: OFPT_FLOW_MOD > (xid=0x6): DEL actions=drop > 2023-01-26T16:44:37.322Z|00112|vconn|DBG|unix#8: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:37.322Z|00113|vconn|DBG|unix#8: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:37.428Z|00002|dpif_netlink(handler1)|WARN|system@ovs-system: > lost packet on port channel 2 of handler 0 (last polled 0 ms ago) > 2023-01-26T16:44:37.526Z|00114|connmgr|INFO|br0<->unix#8: 1 flow_mods in the > last 0 s (1 deletes) > 2023-01-26T16:44:37.528Z|00115|vconn|DBG|unix#9: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xa): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.528Z|00116|vconn|DBG|unix#9: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:37.528Z|00117|vconn|DBG|unix#9: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.528Z|00118|vconn|DBG|unix#9: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:37.528Z|00119|vconn|DBG|unix#9: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=0, lookup=225928, matched=153998 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > table 1: > active=0, lookup=0, matched=0 > (same features) > > tables 2...253: ditto > 2023-01-26T16:44:37.528Z|00120|vconn|DBG|unix#10: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xb): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.528Z|00121|vconn|DBG|unix#10: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:37.528Z|00122|vconn|DBG|unix#10: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.528Z|00123|vconn|DBG|unix#10: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:37.528Z|00124|vconn|DBG|unix#10: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:000016215abb444a > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > 1(at_gre0): addr:a2:f9:64:45:eb:65 > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2(ovs-p1): addr:32:68:ed:0f:cc:60 > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > 3(ovs-p2): addr:0e:8a:4c:65:90:6c > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > 4(p2): addr:8e:57:dd:84:91:3f > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > LOCAL(br0): addr:16:21:5a:bb:44:4a > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:37.528Z|00125|vconn|DBG|unix#11: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xc): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.528Z|00126|vconn|DBG|unix#11: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:37.528Z|00127|vconn|DBG|unix#11: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.528Z|00128|vconn|DBG|unix#11: received: OFPT_FLOW_MOD > (xid=0x6): ADD priority=99,in_port=1 > actions=output(port=2,max_len=100),output(port=3,max_len=100) > 2023-01-26T16:44:37.529Z|00129|vconn|DBG|unix#11: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:37.529Z|00130|vconn|DBG|unix#11: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:37.529Z|00131|vconn|DBG|unix#11: received: OFPT_FLOW_MOD > (xid=0x8): ADD priority=99,udp,in_port=2 actions=output(port=1,max_len=100) > 2023-01-26T16:44:37.529Z|00132|vconn|DBG|unix#11: received: > OFPT_BARRIER_REQUEST (xid=0x9): > 2023-01-26T16:44:37.529Z|00133|vconn|DBG|unix#11: sent (Success): > OFPT_BARRIER_REPLY (xid=0x9): > 2023-01-26T16:44:37.529Z|00134|vconn|DBG|unix#11: received: OFPT_FLOW_MOD > (xid=0xa): ADD priority=1,ip,in_port=4 actions=drop > 2023-01-26T16:44:37.529Z|00135|vconn|DBG|unix#11: received: > OFPT_BARRIER_REQUEST (xid=0xb): > 2023-01-26T16:44:37.529Z|00136|vconn|DBG|unix#11: sent (Success): > OFPT_BARRIER_REPLY (xid=0xb): > 2023-01-26T16:44:37.529Z|00137|vconn|DBG|unix#11: received: OFPT_FLOW_MOD > (xid=0xc): ADD priority=1 actions=drop > 2023-01-26T16:44:37.529Z|00138|vconn|DBG|unix#11: received: > OFPT_BARRIER_REQUEST (xid=0xd): > 2023-01-26T16:44:37.529Z|00139|vconn|DBG|unix#11: sent (Success): > OFPT_BARRIER_REPLY (xid=0xd): > 2023-01-26T16:44:37.529Z|00140|connmgr|INFO|br0<->unix#11: 4 flow_mods in the > last 0 s (4 adds) > 2023-01-26T16:44:37.531Z|00141|vconn|DBG|unix#12: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xd): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.531Z|00142|vconn|DBG|unix#12: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:37.531Z|00143|vconn|DBG|unix#12: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.531Z|00144|vconn|DBG|unix#12: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:37.532Z|00145|vconn|DBG|unix#12: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=1, lookup=79377, matched=79377 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > table 1: > active=0, lookup=0, matched=0 > (same features) > > tables 2...253: ditto > 2023-01-26T16:44:37.532Z|00146|vconn|DBG|unix#13: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xe): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.532Z|00147|vconn|DBG|unix#13: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:37.532Z|00148|vconn|DBG|unix#13: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.532Z|00149|vconn|DBG|unix#13: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:37.532Z|00150|vconn|DBG|unix#13: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:00002a96e384084e > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > 1(ovs-p0): addr:1e:12:f0:27:f1:79 > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > LOCAL(br-underlay): addr:2a:96:e3:84:08:4e > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:37.532Z|00151|vconn|DBG|unix#14: sent (Success): OFPT_HELLO > (OF1.5) (xid=0xf): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.532Z|00152|vconn|DBG|unix#14: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:37.532Z|00153|vconn|DBG|unix#14: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.532Z|00154|vconn|DBG|unix#14: received: OFPT_FLOW_MOD > (xid=0x6): DEL actions=drop > 2023-01-26T16:44:37.532Z|00155|vconn|DBG|unix#14: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:37.532Z|00156|vconn|DBG|unix#14: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:37.720Z|00157|connmgr|INFO|br-underlay<->unix#14: 1 > flow_mods in the last 0 s (1 deletes) > 2023-01-26T16:44:37.721Z|00158|vconn|DBG|unix#15: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x10): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.721Z|00159|vconn|DBG|unix#15: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:37.721Z|00160|vconn|DBG|unix#15: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.721Z|00161|vconn|DBG|unix#15: received: OFPST_TABLE > request (xid=0x2): > 2023-01-26T16:44:37.723Z|00162|vconn|DBG|unix#15: sent (Success): OFPST_TABLE > reply (xid=0x2): > table 0: > active=0, lookup=79377, matched=79377 > max_entries=1000000 > matching: > exact match or wildcard: in_port eth_{src,dst,type} vlan_{vid,pcp} > ip_{src,dst} nw_{proto,tos} tcp_{src,dst} > > table 1: > active=0, lookup=0, matched=0 > (same features) > > tables 2...253: ditto > 2023-01-26T16:44:37.724Z|00163|vconn|DBG|unix#16: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x11): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.724Z|00164|vconn|DBG|unix#16: received: OFPT_HELLO > (xid=0x3): > version bitmap: 0x01 > 2023-01-26T16:44:37.724Z|00165|vconn|DBG|unix#16: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.724Z|00166|vconn|DBG|unix#16: received: > OFPT_FEATURES_REQUEST (xid=0x4): > 2023-01-26T16:44:37.725Z|00167|vconn|DBG|unix#16: sent (Success): > OFPT_FEATURES_REPLY (xid=0x4): dpid:00002a96e384084e > n_tables:254, n_buffers:0 > capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP > actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src > mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst > 1(ovs-p0): addr:1e:12:f0:27:f1:79 > config: 0 > state: 0 > current: 10GB-FD COPPER > speed: 10000 Mbps now, 0 Mbps max > LOCAL(br-underlay): addr:2a:96:e3:84:08:4e > config: 0 > state: 0 > speed: 0 Mbps now, 0 Mbps max > 2023-01-26T16:44:37.726Z|00168|vconn|DBG|unix#17: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x12): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:37.726Z|00169|vconn|DBG|unix#17: received: OFPT_HELLO > (xid=0x5): > version bitmap: 0x01 > 2023-01-26T16:44:37.726Z|00170|vconn|DBG|unix#17: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:37.726Z|00171|vconn|DBG|unix#17: received: OFPT_FLOW_MOD > (xid=0x6): ADD priority=99,ip,in_port=1,nw_proto=47 actions=LOCAL > 2023-01-26T16:44:37.727Z|00172|vconn|DBG|unix#17: received: > OFPT_BARRIER_REQUEST (xid=0x7): > 2023-01-26T16:44:37.727Z|00173|vconn|DBG|unix#17: sent (Success): > OFPT_BARRIER_REPLY (xid=0x7): > 2023-01-26T16:44:37.807Z|00174|vconn|DBG|unix#17: received: OFPT_FLOW_MOD > (xid=0x8): ADD priority=99,ip,in_port=LOCAL,nw_dst=172.31.1.0/24,nw_proto=47 > actions=output:1 > 2023-01-26T16:44:37.807Z|00175|vconn|DBG|unix#17: received: > OFPT_BARRIER_REQUEST (xid=0x9): > 2023-01-26T16:44:37.807Z|00176|vconn|DBG|unix#17: sent (Success): > OFPT_BARRIER_REPLY (xid=0x9): > 2023-01-26T16:44:37.808Z|00177|vconn|DBG|unix#17: received: OFPT_FLOW_MOD > (xid=0xa): ADD priority=1 actions=drop > 2023-01-26T16:44:37.808Z|00178|vconn|DBG|unix#17: received: > OFPT_BARRIER_REQUEST (xid=0xb): > 2023-01-26T16:44:37.809Z|00179|vconn|DBG|unix#17: sent (Success): > OFPT_BARRIER_REPLY (xid=0xb): > 2023-01-26T16:44:37.850Z|00180|connmgr|INFO|br-underlay<->unix#17: 3 > flow_mods in the last 0 s (3 adds) > 2023-01-26T16:44:40.839Z|00181|unixctl|DBG|received request > revalidator/purge[], id=0 > 2023-01-26T16:44:40.991Z|00001|dpif(revalidator9)|WARN|system@ovs-system: > failed to flow_get (No such file or directory) > ufid:36468b48-f637-4680-820e-67d0e80cb6f3 <empty>, packets:0, bytes:0, > used:never > 2023-01-26T16:44:40.992Z|00002|ofproto_dpif_upcall(revalidator9)|WARN|Failed > to acquire udpif_key corresponding to unexpected flow (No such file or > directory): ufid:36468b48-f637-4680-820e-67d0e80cb6f3 > 2023-01-26T16:44:40.992Z|00003|dpif(revalidator9)|WARN|system@ovs-system: > failed to flow_get (No such file or directory) > ufid:b6c69a20-4978-4923-89d9-17f32746ab9e <empty>, packets:0, bytes:0, > used:never > 2023-01-26T16:44:40.992Z|00004|ofproto_dpif_upcall(revalidator9)|WARN|Failed > to acquire udpif_key corresponding to unexpected flow (No such file or > directory): ufid:b6c69a20-4978-4923-89d9-17f32746ab9e > 2023-01-26T16:44:41.083Z|00182|unixctl|DBG|replying with success, id=0: "" > 2023-01-26T16:44:41.094Z|00183|vconn|DBG|unix#19: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x13): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:41.094Z|00184|vconn|DBG|unix#19: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:41.094Z|00185|vconn|DBG|unix#19: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:41.094Z|00186|vconn|DBG|unix#19: received: > NXT_SET_FLOW_FORMAT (xid=0x2): format=nxm > 2023-01-26T16:44:41.094Z|00187|vconn|DBG|unix#19: received: > OFPT_BARRIER_REQUEST (xid=0x3): > 2023-01-26T16:44:41.094Z|00188|vconn|DBG|unix#19: sent (Success): > OFPT_BARRIER_REPLY (xid=0x3): > 2023-01-26T16:44:41.094Z|00189|vconn|DBG|unix#19: received: NXST_FLOW request > (xid=0x4): > 2023-01-26T16:44:41.094Z|00190|vconn|DBG|unix#19: sent (Success): NXST_FLOW > reply (xid=0x4): > cookie=0x0, duration=3.565s, table=0, n_packets=3, n_bytes=250, idle_age=2, > priority=99,in_port=1 > actions=output(port=2,max_len=100),output(port=3,max_len=100) > cookie=0x0, duration=3.565s, table=0, n_packets=1, n_bytes=242, idle_age=3, > priority=99,udp,in_port=2 actions=output(port=1,max_len=100) > cookie=0x0, duration=3.565s, table=0, n_packets=0, n_bytes=0, idle_age=3, > priority=1,ip,in_port=4 actions=drop > cookie=0x0, duration=3.566s, table=0, n_packets=73, n_bytes=11575, > idle_age=0, priority=1 actions=drop > 2023-01-26T16:44:41.100Z|00191|vconn|DBG|unix#20: sent (Success): OFPT_HELLO > (OF1.5) (xid=0x14): > version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06 > 2023-01-26T16:44:41.100Z|00192|vconn|DBG|unix#20: received: OFPT_HELLO > (xid=0x1): > version bitmap: 0x01 > 2023-01-26T16:44:41.100Z|00193|vconn|DBG|unix#20: negotiated OpenFlow version > 0x01 (we support version 0x06 and earlier, peer supports version 0x01) > 2023-01-26T16:44:41.100Z|00194|vconn|DBG|unix#20: received: > NXT_SET_FLOW_FORMAT (xid=0x2): format=nxm > 2023-01-26T16:44:41.100Z|00195|vconn|DBG|unix#20: received: > OFPT_BARRIER_REQUEST (xid=0x3): > 2023-01-26T16:44:41.100Z|00196|vconn|DBG|unix#20: sent (Success): > OFPT_BARRIER_REPLY (xid=0x3): > 2023-01-26T16:44:41.100Z|00197|vconn|DBG|unix#20: received: NXST_FLOW request > (xid=0x4): > 2023-01-26T16:44:41.100Z|00198|vconn|DBG|unix#20: sent (Success): NXST_FLOW > reply (xid=0x4): > cookie=0x0, duration=3.373s, table=0, n_packets=3, n_bytes=364, idle_age=2, > priority=99,ip,in_port=1,nw_proto=47 actions=LOCAL > cookie=0x0, duration=3.293s, table=0, n_packets=18446744073709511148, > n_bytes=18446744073703563162, idle_age=3, > priority=99,ip,in_port=LOCAL,nw_dst=172.31.1.0/24,nw_proto=47 actions=output:1 > cookie=0x0, duration=3.291s, table=0, n_packets=20, n_bytes=3265, > idle_age=0, priority=1 actions=drop 2023-01-26T16:44:41Z|00001|daemon_unix|WARN|/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovs-vswitchd.pid: open: No such file or directory ovs-appctl: cannot read pidfile "/home/horms/projects/openvswitch/ovs/tests/system-offloads-testsuite.dir/051/ovs-vswitchd.pid" (No such file or directory) ovs-dpctl: opening datapath (No such device) 51. system-traffic.at:1768: FAILED (system-traffic.at:1838) ## ------------- ## ## Test results. ## ## ------------- ## ERROR: All 2 tests were run, 2 failed unexpectedly. ## ------------------------------------------ ## ## system-offloads-testsuite.log was created. ## ## ------------------------------------------ ## Please send `tests/system-offloads-testsuite.log' and all information you think might help: To: <b...@openvswitch.org> Subject: [openvswitch 3.1.90] system-offloads-testsuite: 50 51 failed You may investigate any problem if you feel able to do so, in which case the test suite provides a good starting point. Its output may be found below `tests/system-offloads-testsuite.dir'. make: *** [Makefile:7042: check-offloads] Fout 1 _______________________________________________ dev mailing list d...@openvswitch.org https://mail.openvswitch.org/mailman/listinfo/ovs-dev