make -C tools/testing/selftests TARGETS="net" TEST_PROGS=txtimestamp.sh TEEST_GEN_PROGS="" run_tests make: Entering directory '/home/virtme/testing/wt-1/tools/testing/selftests' make[1]: Entering directory '/home/virtme/testing/wt-1/tools/testing/selftests/net' make[1]: Nothing to be done for 'all'. make[1]: Leaving directory '/home/virtme/testing/wt-1/tools/testing/selftests/net' make[1]: Entering directory '/home/virtme/testing/wt-1/tools/testing/selftests/net/lib' make[1]: Nothing to be done for 'all'. make[1]: Leaving directory '/home/virtme/testing/wt-1/tools/testing/selftests/net/lib' make[1]: Entering directory '/home/virtme/testing/wt-1/tools/testing/selftests/net' TAP version 13 1..1 # timeout set to 3600 # selftests: net: txtimestamp.sh # 0.17 [+0.17] protocol: TCP # 0.17 [+0.00] payload: 10 # 0.17 [+0.00] server port: 9000 # 0.17 [+0.00] # 0.17 [+0.00] family: INET # 0.17 [+0.00] test SND # 0.23 [+0.06] USR: 1761612357 s 446605 us (seq=0, len=0) # 0.31 [+0.08] SND: 1761612357 s 456648 us (seq=9, len=10) (USR +10042 us) # 0.31 [+0.00] USR: 1761612357 s 526982 us (seq=0, len=0) # 0.39 [+0.08] SND: 1761612357 s 537006 us (seq=19, len=10) (USR +10024 us) # 0.39 [+0.00] USR: 1761612357 s 607120 us (seq=0, len=0) # 0.47 [+0.08] SND: 1761612357 s 617153 us (seq=29, len=10) (USR +10032 us) # 0.47 [+0.00] USR: 1761612357 s 687269 us (seq=0, len=0) # 0.55 [+0.08] SND: 1761612357 s 697301 us (seq=39, len=10) (USR +10032 us) # 0.55 [+0.00] USR-SND: count=4, avg=10033 us, min=10024 us, max=10042 us # 0.65 [+0.10] test ENQ # 0.71 [+0.06] USR: 1761612357 s 927797 us (seq=0, len=0) # 0.79 [+0.08] ENQ: 1761612357 s 927827 us (seq=9, len=10) (USR +29 us) # 0.79 [+0.00] USR: 1761612358 s 7956 us (seq=0, len=0) # 0.87 [+0.08] ENQ: 1761612358 s 7972 us (seq=19, len=10) (USR +16 us) # 0.87 [+0.00] USR: 1761612358 s 88102 us (seq=0, len=0) # 0.95 [+0.08] ENQ: 1761612358 s 88118 us (seq=29, len=10) (USR +15 us) # 0.95 [+0.00] USR: 1761612358 s 168253 us (seq=0, len=0) # 1.03 [+0.08] ENQ: 1761612358 s 168271 us (seq=39, len=10) (USR +17 us) # 1.03 [+0.00] USR-ENQ: count=4, avg=19 us, min=15 us, max=29 us # 1.13 [+0.10] test ENQ + SND # 1.19 [+0.06] USR: 1761612358 s 408821 us (seq=0, len=0) # 1.27 [+0.08] ENQ: 1761612358 s 408851 us (seq=9, len=10) (USR +30 us) # 1.27 [+0.00] SND: 1761612358 s 418861 us (seq=9, len=10) (USR +10039 us) # 1.28 [+0.00] USR: 1761612358 s 488995 us (seq=0, len=0) # 1.35 [+0.08] ENQ: 1761612358 s 489017 us (seq=19, len=10) (USR +21 us) # 1.35 [+0.00] SND: 1761612358 s 499038 us (seq=19, len=10) (USR +10042 us) # 1.36 [+0.00] USR: 1761612358 s 569172 us (seq=0, len=0) # 1.43 [+0.08] ENQ: 1761612358 s 569192 us (seq=29, len=10) (USR +19 us) # 1.43 [+0.00] SND: 1761612358 s 579215 us (seq=29, len=10) (USR +10042 us) # 1.44 [+0.00] USR: 1761612358 s 649342 us (seq=0, len=0) # 1.51 [+0.08] ENQ: 1761612358 s 649362 us (seq=39, len=10) (USR +19 us) # 1.52 [+0.00] SND: 1761612358 s 659386 us (seq=39, len=10) (USR +10043 us) # 1.52 [+0.00] USR-ENQ: count=4, avg=22 us, min=19 us, max=30 us # 1.52 [+0.00] USR-SND: count=4, avg=10042 us, min=10039 us, max=10043 us # 1.61 [+0.09] # 1.61 [+0.00] test ACK # 1.67 [+0.06] USR: 1761612358 s 889881 us (seq=0, len=0) # 1.75 [+0.08] ACK: 1761612358 s 950000 us (seq=9, len=10) (USR +60119 us) # 1.76 [+0.00] USR: 1761612358 s 970034 us (seq=0, len=0) # 1.83 [+0.08] ACK: 1761612359 s 30180 us (seq=19, len=10) (USR +60145 us) # 1.84 [+0.00] USR: 1761612359 s 50208 us (seq=0, len=0) # 1.91 [+0.08] ACK: 1761612359 s 110387 us (seq=29, len=10) (USR +60178 us) # 1.92 [+0.00] USR: 1761612359 s 130368 us (seq=0, len=0) # 1.99 [+0.08] ACK: 1761612359 s 190520 us (seq=39, len=10) (USR +60152 us) # 2.00 [+0.00] USR-ACK: count=4, avg=60148 us, min=60119 us, max=60178 us # 2.09 [+0.10] # 2.09 [+0.00] test SND + ACK # 2.15 [+0.06] USR: 1761612359 s 370878 us (seq=0, len=0) # 2.23 [+0.08] SND: 1761612359 s 380920 us (seq=9, len=10) (USR +10042 us) # 2.24 [+0.00] ACK: 1761612359 s 430992 us (seq=9, len=10) (USR +60113 us) # 2.24 [+0.00] USR: 1761612359 s 451058 us (seq=0, len=0) # 2.31 [+0.08] SND: 1761612359 s 461099 us (seq=19, len=10) (USR +10041 us) # 2.32 [+0.00] ACK: 1761612359 s 511205 us (seq=19, len=10) (USR +60147 us) # 2.32 [+0.00] USR: 1761612359 s 531220 us (seq=0, len=0) # 2.39 [+0.08] SND: 1761612359 s 541254 us (seq=29, len=10) (USR +10033 us) # 2.40 [+0.00] ACK: 1761612359 s 591361 us (seq=29, len=10) (USR +60141 us) # 2.40 [+0.00] USR: 1761612359 s 611386 us (seq=0, len=0) # 2.48 [+0.08] SND: 1761612359 s 621421 us (seq=39, len=10) (USR +10034 us) # 2.48 [+0.00] ACK: 1761612359 s 671519 us (seq=39, len=10) (USR +60133 us) # 2.48 [+0.00] USR-SND: count=4, avg=10038 us, min=10033 us, max=10042 us # 2.48 [+0.00] USR-ACK: count=4, avg=60133 us, min=60113 us, max=60147 us # 2.58 [+0.09] # 2.58 [+0.00] test ENQ + SND + ACK # 2.64 [+0.06] USR: 1761612359 s 851921 us (seq=0, len=0) # 2.72 [+0.08] ENQ: 1761612359 s 851956 us (seq=9, len=10) (USR +34 us) # 2.72 [+0.00] SND: 1761612359 s 861976 us (seq=9, len=10) (USR +10055 us) # 2.72 [+0.00] ACK: 1761612359 s 912060 us (seq=9, len=10) (USR +60139 us) # 2.72 [+0.00] USR: 1761612359 s 932103 us (seq=0, len=0) # 2.80 [+0.08] ENQ: 1761612359 s 932124 us (seq=19, len=10) (USR +20 us) # 2.80 [+0.00] SND: 1761612359 s 942145 us (seq=19, len=10) (USR +10042 us) # 2.80 [+0.00] ACK: 1761612359 s 992252 us (seq=19, len=10) (USR +60149 us) # 2.80 [+0.00] USR: 1761612360 s 12268 us (seq=0, len=0) # 2.88 [+0.07] ENQ: 1761612360 s 12282 us (seq=29, len=10) (USR +14 us) # 2.88 [+0.00] SND: 1761612360 s 22302 us (seq=29, len=10) (USR +10034 us) # 2.88 [+0.00] ACK: 1761612360 s 72438 us (seq=29, len=10) (USR +60169 us) # 2.88 [+0.00] USR: 1761612360 s 92437 us (seq=0, len=0) # 2.96 [+0.07] ENQ: 1761612360 s 92458 us (seq=39, len=10) (USR +20 us) # 2.96 [+0.00] SND: 1761612360 s 102483 us (seq=39, len=10) (USR +10045 us) # 2.96 [+0.00] ACK: 1761612360 s 152593 us (seq=39, len=10) (USR +60155 us) # 2.96 [+0.00] USR-ENQ: count=4, avg=22 us, min=14 us, max=34 us # 2.96 [+0.00] USR-SND: count=4, avg=10044 us, min=10034 us, max=10055 us # 2.96 [+0.00] USR-ACK: count=4, avg=60153 us, min=60139 us, max=60169 us # 3.06 [+0.10] protocol: TCP # 3.06 [+0.00] payload: 10 # 3.06 [+0.00] server port: 9000 # 3.07 [+0.00] # 3.07 [+0.00] family: INET6 # 3.07 [+0.00] test SND # 3.12 [+0.06] USR: 1761612360 s 339429 us (seq=0, len=0) # 3.20 [+0.08] SND: 1761612360 s 349477 us (seq=9, len=10) (USR +10048 us) # 3.21 [+0.00] USR: 1761612360 s 419865 us (seq=0, len=0) # 3.28 [+0.08] SND: 1761612360 s 429894 us (seq=19, len=10) (USR +10029 us) # 3.29 [+0.00] USR: 1761612360 s 500031 us (seq=0, len=0) # 3.36 [+0.08] SND: 1761612360 s 510075 us (seq=29, len=10) (USR +10044 us) # 3.37 [+0.00] USR: 1761612360 s 580191 us (seq=0, len=0) # 3.44 [+0.08] SND: 1761612360 s 590227 us (seq=39, len=10) (USR +10035 us) # 3.45 [+0.00] USR-SND: count=4, avg=10039 us, min=10029 us, max=10048 us # 3.54 [+0.10] test ENQ # 3.60 [+0.06] USR: 1761612360 s 820969 us (seq=0, len=0) # 3.69 [+0.08] ENQ: 1761612360 s 821009 us (seq=9, len=10) (USR +40 us) # 3.69 [+0.00] USR: 1761612360 s 905506 us (seq=0, len=0) # 3.77 [+0.08] ENQ: 1761612360 s 905529 us (seq=19, len=10) (USR +23 us) # 3.77 [+0.00] USR: 1761612360 s 986393 us (seq=0, len=0) # 3.85 [+0.08] ENQ: 1761612360 s 986417 us (seq=29, len=10) (USR +24 us) # 3.85 [+0.00] USR: 1761612361 s 66631 us (seq=0, len=0) # 3.94 [+0.09] ENQ: 1761612361 s 66655 us (seq=39, len=10) (USR +23 us) # 3.94 [+0.00] USR-ENQ: count=4, avg=27 us, min=23 us, max=40 us # 4.03 [+0.09] test ENQ + SND # 4.09 [+0.06] USR: 1761612361 s 310683 us (seq=0, len=0) # 4.18 [+0.08] ENQ: 1761612361 s 310720 us (seq=9, len=10) (USR +36 us) # 4.18 [+0.00] SND: 1761612361 s 321563 us (seq=9, len=10) (USR +10879 us) # 4.18 [+0.00] USR: 1761612361 s 391657 us (seq=0, len=0) # 4.26 [+0.08] ENQ: 1761612361 s 391679 us (seq=19, len=10) (USR +22 us) # 4.26 [+0.00] SND: 1761612361 s 402569 us (seq=19, len=10) (USR +10912 us) # 4.26 [+0.00] USR: 1761612361 s 472643 us (seq=0, len=0) # 4.34 [+0.08] ENQ: 1761612361 s 472666 us (seq=29, len=10) (USR +22 us) # 4.34 [+0.01] SND: 1761612361 s 483567 us (seq=29, len=10) (USR +10923 us) # 4.35 [+0.00] USR: 1761612361 s 553641 us (seq=0, len=0) # 4.42 [+0.07] ENQ: 1761612361 s 553664 us (seq=39, len=10) (USR +23 us) # 4.42 [+0.00] SND: 1761612361 s 563688 us (seq=39, len=10) (USR +10047 us) # 4.42 [+0.00] USR-ENQ: count=4, avg=26 us, min=22 us, max=36 us # 4.42 [+0.00] USR-SND: count=4, avg=10690 us, min=10047 us, max=10923 us # 4.52 [+0.10] # 4.52 [+0.00] test ACK # 4.58 [+0.06] USR: 1761612361 s 797685 us (seq=0, len=0) # 4.66 [+0.08] ACK: 1761612361 s 859619 us (seq=9, len=10) (USR +61934 us) # 4.66 [+0.00] USR: 1761612361 s 878652 us (seq=0, len=0) # 4.75 [+0.09] ACK: 1761612361 s 940619 us (seq=19, len=10) (USR +61966 us) # 4.75 [+0.00] USR: 1761612361 s 965512 us (seq=0, len=0) # 4.85 [+0.10] ERROR: 79935 us expected between 60000 and 68000 # 4.85 [+0.00] ACK: 1761612362 s 45447 us (seq=29, len=10) (USR +79934 us) # 4.85 [+0.00] USR: 1761612362 s 55517 us (seq=0, len=0) # 4.94 [+0.08] ERROR: 90084 us expected between 60000 and 68000 # 4.94 [+0.00] ACK: 1761612362 s 145601 us (seq=39, len=10) (USR +90083 us) # 4.94 [+0.00] USR-ACK: count=4, avg=73479 us, min=61934 us, max=90083 us # 5.03 [+0.09] # 5.03 [+0.00] test SND + ACK # 5.09 [+0.06] USR: 1761612362 s 307668 us (seq=0, len=0) # 5.17 [+0.08] SND: 1761612362 s 317796 us (seq=9, len=10) (USR +10127 us) # 5.17 [+0.00] ACK: 1761612362 s 375495 us (seq=9, len=10) (USR +67827 us) # 5.18 [+0.00] USR: 1761612362 s 387881 us (seq=0, len=0) # 5.25 [+0.08] SND: 1761612362 s 398563 us (seq=19, len=10) (USR +10682 us) # 5.25 [+0.00] ACK: 1761612362 s 449884 us (seq=19, len=10) (USR +62002 us) # 5.26 [+0.01] USR: 1761612362 s 468873 us (seq=0, len=0) # 5.34 [+0.08] SND: 1761612362 s 479803 us (seq=29, len=10) (USR +10929 us) # 5.34 [+0.00] ERROR: 76575 us expected between 60000 and 68000 # 5.34 [+0.00] ACK: 1761612362 s 545448 us (seq=29, len=10) (USR +76575 us) # 5.34 [+0.00] USR: 1761612362 s 555527 us (seq=0, len=0) # 5.43 [+0.09] ERROR: 19898 us expected between 10000 and 18000 # 5.43 [+0.00] SND: 1761612362 s 575425 us (seq=39, len=10) (USR +19898 us) # 5.44 [+0.01] USR-SND: count=4, avg=12909 us, min=10127 us, max=19898 us # 5.48 [+0.04] USR-ACK: count=3, avg=68801 us, min=62002 us, max=76575 us # 5.54 [+0.06] # 5.54 [+0.00] test ENQ + SND + ACK # 5.59 [+0.05] USR: 1761612362 s 806679 us (seq=0, len=0) # 5.67 [+0.08] ENQ: 1761612362 s 806716 us (seq=9, len=10) (USR +37 us) # 5.67 [+0.00] SND: 1761612362 s 817500 us (seq=9, len=10) (USR +10821 us) # 5.68 [+0.00] ACK: 1761612362 s 868618 us (seq=9, len=10) (USR +61939 us) # 5.68 [+0.00] USR: 1761612362 s 887591 us (seq=0, len=0) # 5.76 [+0.08] ENQ: 1761612362 s 887615 us (seq=19, len=10) (USR +24 us) # 5.76 [+0.00] SND: 1761612362 s 898494 us (seq=19, len=10) (USR +10902 us) # 5.76 [+0.00] ACK: 1761612362 s 949514 us (seq=19, len=10) (USR +61922 us) # 5.76 [+0.00] USR: 1761612362 s 968590 us (seq=0, len=0) # 5.83 [+0.07] ENQ: 1761612362 s 968614 us (seq=29, len=10) (USR +23 us) # 5.83 [+0.00] SND: 1761612362 s 979486 us (seq=29, len=10) (USR +10895 us) # 5.84 [+0.00] ACK: 1761612363 s 35559 us (seq=29, len=10) (USR +66969 us) # 5.84 [+0.00] USR: 1761612363 s 48771 us (seq=0, len=0) # 5.91 [+0.08] ENQ: 1761612363 s 48795 us (seq=39, len=10) (USR +23 us) # 5.95 [+0.04] SND: 1761612363 s 58818 us (seq=39, len=10) (USR +10047 us) # 5.95 [+0.00] ACK: 1761612363 s 112507 us (seq=39, len=10) (USR +63736 us) # 5.95 [+0.00] USR-ENQ: count=4, avg=27 us, min=23 us, max=37 us # 5.95 [+0.00] USR-SND: count=4, avg=10666 us, min=10047 us, max=10902 us # 5.96 [+0.00] USR-ACK: count=4, avg=63641 us, min=61922 us, max=66969 us not ok 1 selftests: net: txtimestamp.sh # exit=1 make[1]: Leaving directory '/home/virtme/testing/wt-1/tools/testing/selftests/net' make: Leaving directory '/home/virtme/testing/wt-1/tools/testing/selftests' xx__-> echo $? 0 xx__->