<_PROGS=veth_bql_test.sh TEST_GEN_PROGS="" run_tests make: Entering directory '/srv/vmksft/testing/wt-2/tools/testing/selftests' make[1]: Nothing to be done for 'all'. make[1]: Nothing to be done for 'all'. TAP version 13 1..1 # overriding timeout to 7200 # selftests: net: veth_bql_test.sh # 0.07 [+0.07] --- Compiling UDP flood tool --- # 0.89 [+0.82] INFO: Setting up veth pair with GRO # 1.48 [+0.59] INFO: Threaded NAPI enabled # 1.48 [+0.00] INFO: Installing qdisc: sfq # 1.89 [+0.41] INFO: Loaded 3500 iptables rules in consumer NS # 1.91 [+0.02] INFO: kernel: 7.0.0-rc7-virtme # 1.91 [+0.00] INFO: BQL sysfs found: /sys/class/net/veth_bql0/queues/tx-0/byte_queue_limits # 1.94 [+0.03] INFO: Starting UDP sink in namespace # 2.15 [+0.21] INFO: Starting ping to 10.99.0.2 (5/s) to measure latency under load # 2.15 [+0.00] INFO: Flooding 1400-byte UDP packets for 30s # 2.17 [+0.02] INFO: bpftrace napi_poll histogram started (pid=24414) # 6.97 [+4.79] sink: 28796 pkts (5756 pps) drops=54989 reorders=8 latency min/avg/max = 1.372/21.199/35.123 ms # 7.33 [+0.36] [5s] BQL inflight=3 limit=2 watchdog=0 # 7.40 [+0.07] [5s] qdisc sfq pkts=31354 drops=60201 requeues=29765 backlog=183134 qlen=127 overlimits=0 # 7.43 [+0.03] [5s] softnet: processed=31390 time_squeeze=0 multi-CPU(3): cpu0(+4635) cpu2(+10) cpu3(+26745) # 7.48 [+0.05] [5s] ping RTT=2.16ms # 11.97 [+4.49] sink: 58860 pkts (6012 pps) drops=117143 reorders=8 latency min/avg/max = 1.372/21.314/35.393 ms # 12.59 [+0.63] [10s] BQL inflight=3 limit=2 watchdog=0 # 12.67 [+0.07] [10s] qdisc sfq pkts=63061 drops=126131 requeues=60023 backlog=183134 qlen=127 overlimits=0 # 12.71 [+0.04] [10s] consumer: 6345 pps (~0.158ms/pkt, NAPI-64 cycle ~10.1ms) # 12.72 [+0.02] [10s] softnet: processed=31904 time_squeeze=0 multi-CPU(3): cpu0(+31888) cpu1(+9) cpu2(+7) # 12.74 [+0.02] [10s] napi_poll: polls=0 full_budget=0 partial=0 avg_work=0 # 12.77 [+0.02] [10s] ping RTT=3.06ms # 16.97 [+4.20] sink: 88620 pkts (5951 pps) drops=177926 reorders=8 latency min/avg/max = 1.372/21.518/35.393 ms # 17.89 [+0.92] [15s] BQL inflight=3 limit=2 watchdog=0 # 17.94 [+0.06] [15s] qdisc sfq pkts=94498 drops=190736 requeues=89669 backlog=183134 qlen=127 overlimits=0 # 17.99 [+0.04] [15s] consumer: 6294 pps (~0.159ms/pkt, NAPI-64 cycle ~10.2ms) # 18.01 [+0.02] [15s] softnet: processed=31500 time_squeeze=0 multi-CPU(4): cpu0(+31478) cpu1(+6) cpu2(+2) cpu3(+14) # 18.03 [+0.02] [15s] napi_poll: polls=0 full_budget=0 partial=0 avg_work=0 # 18.08 [+0.05] [15s] ping RTT=1.71ms # 21.97 [+3.89] sink: 118566 pkts (5989 pps) drops=240209 reorders=8 latency min/avg/max = 1.372/21.551/54.113 ms # 23.20 [+1.23] [20s] BQL inflight=3 limit=2 watchdog=0 # 23.26 [+0.07] [20s] qdisc sfq pkts=126516 drops=256994 requeues=120008 backlog=183134 qlen=127 overlimits=0 # 23.30 [+0.04] [20s] consumer: 6387 pps (~0.157ms/pkt, NAPI-64 cycle ~10.0ms) # 23.33 [+0.02] [20s] softnet: processed=32093 time_squeeze=0 multi-CPU(4): cpu0(+21668) cpu1(+18) cpu2(+3) cpu3(+10404) # 23.36 [+0.03] [20s] napi_poll: polls=0 full_budget=0 partial=0 avg_work=0 # 23.38 [+0.02] [20s] ping RTT=2.99ms # 26.97 [+3.59] sink: 148481 pkts (5982 pps) drops=301609 reorders=8 latency min/avg/max = 1.372/21.606/54.113 ms # 28.48 [+1.52] [25s] BQL inflight=0 limit=2 watchdog=0 # 28.55 [+0.06] [25s] qdisc sfq pkts=158178 drops=322137 requeues=150392 backlog=183134 qlen=127 overlimits=0 # 28.61 [+0.06] [25s] consumer: 6343 pps (~0.158ms/pkt, NAPI-64 cycle ~10.1ms) # 28.63 [+0.03] [25s] softnet: processed=31739 time_squeeze=0 multi-CPU(4): cpu0(+20267) cpu1(+18) cpu2(+6) cpu3(+11448) # 28.66 [+0.03] [25s] napi_poll: polls=0 full_budget=0 partial=0 avg_work=0 # 28.69 [+0.03] [25s] ping RTT=2.68ms # 31.97 [+3.27] sink: 178380 pkts (5979 pps) drops=363688 reorders=8 latency min/avg/max = 0.636/21.628/54.113 ms # 32.17 [+0.20] Total sent: 546079 packets (0.5 M) # 33.79 [+1.63] [30s] BQL inflight=0 limit=2 watchdog=0 # 33.85 [+0.06] [30s] qdisc sfq pkts=179930 drops=366309 requeues=171029 backlog=0 qlen=0 overlimits=0 # 33.89 [+0.04] [30s] consumer: 4386 pps (~0.228ms/pkt, NAPI-64 cycle ~14.6ms) # 33.91 [+0.02] [30s] softnet: processed=21414 time_squeeze=0 multi-CPU(3): cpu0(+13229) cpu2(+6870) cpu3(+1315) # 33.94 [+0.03] [30s] napi_poll: polls=0 full_budget=0 partial=0 avg_work=0 # 33.97 [+0.03] INFO: Ping loss: 0% packet loss # 33.98 [+0.01] INFO: Ping summary: rtt min/avg/max/mdev = 0.776/2.329/9.913/1.093 ms # 34.03 [+0.05] TEST: veth_bql [ OK ] # 34.28 [+0.25] sink: 179694 pkts (5560 avg pps) drops=366393 reorders=8 latency min/avg/max/stddev = 0.636/21.630/54.113/1.918 ms ok 1 selftests: net: veth_bql_test.sh make: Leaving directory '/srv/vmksft/testing/wt-2/tools/testing/selftests' xx__-> echo $? 0 xx__-> echo scan > /sys/kernel/debug/kmemleak xx__->