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.15 [+0.15] protocol: TCP # 0.15 [+0.00] payload: 10 # 0.16 [+0.00] server port: 9000 # 0.16 [+0.00] # 0.16 [+0.00] family: INET # 0.16 [+0.00] test SND # 0.21 [+0.06] USR: 1759257057 s 845924 us (seq=0, len=0) # 0.29 [+0.08] SND: 1759257057 s 855969 us (seq=9, len=10) (USR +10044 us) # 0.30 [+0.00] USR: 1759257057 s 926442 us (seq=0, len=0) # 0.37 [+0.08] SND: 1759257057 s 936486 us (seq=19, len=10) (USR +10044 us) # 0.38 [+0.00] USR: 1759257058 s 6600 us (seq=0, len=0) # 0.46 [+0.08] SND: 1759257058 s 16630 us (seq=29, len=10) (USR +10030 us) # 0.46 [+0.00] USR: 1759257058 s 86760 us (seq=0, len=0) # 0.54 [+0.08] SND: 1759257058 s 96798 us (seq=39, len=10) (USR +10037 us) # 0.54 [+0.00] USR-SND: count=4, avg=10039 us, min=10030 us, max=10044 us # 0.64 [+0.10] test ENQ # 0.70 [+0.06] USR: 1759257058 s 327270 us (seq=0, len=0) # 0.78 [+0.08] ENQ: 1759257058 s 327306 us (seq=9, len=10) (USR +35 us) # 0.78 [+0.00] USR: 1759257058 s 407436 us (seq=0, len=0) # 0.86 [+0.08] ENQ: 1759257058 s 407453 us (seq=19, len=10) (USR +17 us) # 0.86 [+0.00] USR: 1759257058 s 487596 us (seq=0, len=0) # 0.94 [+0.08] ENQ: 1759257058 s 487615 us (seq=29, len=10) (USR +19 us) # 0.94 [+0.00] USR: 1759257058 s 567756 us (seq=0, len=0) # 1.02 [+0.08] ENQ: 1759257058 s 567775 us (seq=39, len=10) (USR +18 us) # 1.02 [+0.00] USR-ENQ: count=4, avg=22 us, min=17 us, max=35 us # 1.12 [+0.10] test ENQ + SND # 1.18 [+0.06] USR: 1759257058 s 808290 us (seq=0, len=0) # 1.26 [+0.08] ENQ: 1759257058 s 808320 us (seq=9, len=10) (USR +30 us) # 1.26 [+0.00] SND: 1759257058 s 818324 us (seq=9, len=10) (USR +10034 us) # 1.26 [+0.00] USR: 1759257058 s 888453 us (seq=0, len=0) # 1.34 [+0.08] ENQ: 1759257058 s 888468 us (seq=19, len=10) (USR +15 us) # 1.34 [+0.00] SND: 1759257058 s 898481 us (seq=19, len=10) (USR +10028 us) # 1.34 [+0.00] USR: 1759257058 s 968600 us (seq=0, len=0) # 1.42 [+0.08] ENQ: 1759257058 s 968615 us (seq=29, len=10) (USR +15 us) # 1.42 [+0.00] SND: 1759257058 s 978628 us (seq=29, len=10) (USR +10028 us) # 1.42 [+0.00] USR: 1759257059 s 48755 us (seq=0, len=0) # 1.50 [+0.08] ENQ: 1759257059 s 48770 us (seq=39, len=10) (USR +15 us) # 1.50 [+0.00] SND: 1759257059 s 58788 us (seq=39, len=10) (USR +10033 us) # 1.50 [+0.00] USR-ENQ: count=4, avg=19 us, min=15 us, max=30 us # 1.50 [+0.00] USR-SND: count=4, avg=10031 us, min=10028 us, max=10034 us # 1.60 [+0.10] # 1.60 [+0.00] test ACK # 1.66 [+0.06] USR: 1759257059 s 289284 us (seq=0, len=0) # 1.74 [+0.08] ACK: 1759257059 s 349414 us (seq=9, len=10) (USR +60129 us) # 1.74 [+0.00] USR: 1759257059 s 369455 us (seq=0, len=0) # 1.82 [+0.08] ACK: 1759257059 s 429595 us (seq=19, len=10) (USR +60139 us) # 1.82 [+0.00] USR: 1759257059 s 449620 us (seq=0, len=0) # 1.90 [+0.08] ACK: 1759257059 s 509754 us (seq=29, len=10) (USR +60134 us) # 1.90 [+0.00] USR: 1759257059 s 529792 us (seq=0, len=0) # 1.98 [+0.08] ACK: 1759257059 s 589946 us (seq=39, len=10) (USR +60154 us) # 1.98 [+0.00] USR-ACK: count=4, avg=60139 us, min=60129 us, max=60154 us # 2.08 [+0.10] # 2.08 [+0.00] test SND + ACK # 2.14 [+0.06] USR: 1759257059 s 770289 us (seq=0, len=0) # 2.22 [+0.08] SND: 1759257059 s 780323 us (seq=9, len=10) (USR +10034 us) # 2.22 [+0.00] ACK: 1759257059 s 830417 us (seq=9, len=10) (USR +60128 us) # 2.22 [+0.00] USR: 1759257059 s 850454 us (seq=0, len=0) # 2.30 [+0.08] SND: 1759257059 s 860481 us (seq=19, len=10) (USR +10027 us) # 2.30 [+0.00] ACK: 1759257059 s 910550 us (seq=19, len=10) (USR +60096 us) # 2.30 [+0.00] USR: 1759257059 s 930626 us (seq=0, len=0) # 2.38 [+0.08] SND: 1759257059 s 940668 us (seq=29, len=10) (USR +10041 us) # 2.38 [+0.00] ACK: 1759257059 s 990767 us (seq=29, len=10) (USR +60141 us) # 2.38 [+0.00] USR: 1759257060 s 10782 us (seq=0, len=0) # 2.46 [+0.08] SND: 1759257060 s 20815 us (seq=39, len=10) (USR +10032 us) # 2.46 [+0.00] ACK: 1759257060 s 70909 us (seq=39, len=10) (USR +60127 us) # 2.46 [+0.00] USR-SND: count=4, avg=10034 us, min=10027 us, max=10041 us # 2.46 [+0.00] USR-ACK: count=4, avg=60123 us, min=60096 us, max=60141 us # 2.56 [+0.10] # 2.56 [+0.00] test ENQ + SND + ACK # 2.62 [+0.06] USR: 1759257060 s 251310 us (seq=0, len=0) # 2.70 [+0.08] ENQ: 1759257060 s 251346 us (seq=9, len=10) (USR +35 us) # 2.70 [+0.00] SND: 1759257060 s 261350 us (seq=9, len=10) (USR +10039 us) # 2.70 [+0.00] ACK: 1759257060 s 311425 us (seq=9, len=10) (USR +60115 us) # 2.70 [+0.00] USR: 1759257060 s 331476 us (seq=0, len=0) # 2.78 [+0.08] ENQ: 1759257060 s 331492 us (seq=19, len=10) (USR +15 us) # 2.78 [+0.00] SND: 1759257060 s 341507 us (seq=19, len=10) (USR +10030 us) # 2.78 [+0.00] ACK: 1759257060 s 391587 us (seq=19, len=10) (USR +60111 us) # 2.79 [+0.00] USR: 1759257060 s 411632 us (seq=0, len=0) # 2.86 [+0.07] ENQ: 1759257060 s 411647 us (seq=29, len=10) (USR +15 us) # 2.86 [+0.00] SND: 1759257060 s 421663 us (seq=29, len=10) (USR +10031 us) # 2.86 [+0.00] ACK: 1759257060 s 471750 us (seq=29, len=10) (USR +60118 us) # 2.86 [+0.00] USR: 1759257060 s 491782 us (seq=0, len=0) # 2.94 [+0.08] ENQ: 1759257060 s 491796 us (seq=39, len=10) (USR +14 us) # 2.94 [+0.00] SND: 1759257060 s 501809 us (seq=39, len=10) (USR +10027 us) # 2.94 [+0.00] ACK: 1759257060 s 551903 us (seq=39, len=10) (USR +60120 us) # 2.95 [+0.00] USR-ENQ: count=4, avg=20 us, min=14 us, max=35 us # 2.95 [+0.00] USR-SND: count=4, avg=10032 us, min=10027 us, max=10039 us # 2.95 [+0.00] USR-ACK: count=4, avg=60116 us, min=60111 us, max=60120 us # 3.05 [+0.10] protocol: TCP # 3.05 [+0.00] payload: 10 # 3.05 [+0.00] server port: 9000 # 3.05 [+0.00] # 3.05 [+0.00] family: INET6 # 3.05 [+0.00] test SND # 3.11 [+0.06] USR: 1759257060 s 738283 us (seq=0, len=0) # 3.19 [+0.08] SND: 1759257060 s 748337 us (seq=9, len=10) (USR +10054 us) # 3.19 [+0.00] USR: 1759257060 s 818759 us (seq=0, len=0) # 3.27 [+0.08] SND: 1759257060 s 828802 us (seq=19, len=10) (USR +10042 us) # 3.27 [+0.00] USR: 1759257060 s 898920 us (seq=0, len=0) # 3.35 [+0.08] SND: 1759257060 s 908965 us (seq=29, len=10) (USR +10044 us) # 3.35 [+0.00] USR: 1759257060 s 979070 us (seq=0, len=0) # 3.43 [+0.08] SND: 1759257060 s 989103 us (seq=39, len=10) (USR +10033 us) # 3.43 [+0.00] USR-SND: count=4, avg=10043 us, min=10033 us, max=10054 us # 3.53 [+0.10] test ENQ # 3.59 [+0.06] USR: 1759257061 s 219636 us (seq=0, len=0) # 3.67 [+0.08] ENQ: 1759257061 s 219674 us (seq=9, len=10) (USR +38 us) # 3.67 [+0.00] USR: 1759257061 s 299834 us (seq=0, len=0) # 3.75 [+0.08] ENQ: 1759257061 s 299872 us (seq=19, len=10) (USR +38 us) # 3.75 [+0.00] USR: 1759257061 s 380023 us (seq=0, len=0) # 3.83 [+0.08] ENQ: 1759257061 s 380046 us (seq=29, len=10) (USR +23 us) # 3.83 [+0.00] USR: 1759257061 s 462273 us (seq=0, len=0) # 3.91 [+0.08] ENQ: 1759257061 s 462296 us (seq=39, len=10) (USR +23 us) # 3.91 [+0.00] USR-ENQ: count=4, avg=30 us, min=23 us, max=38 us # 4.04 [+0.13] test ENQ + SND # 4.10 [+0.06] USR: 1759257061 s 713589 us (seq=0, len=0) # 4.17 [+0.08] ERROR: 8726 us expected between 0 and 8000 # 4.17 [+0.00] ENQ: 1759257061 s 722315 us (seq=9, len=10) (USR +8725 us) # 4.17 [+0.00] ERROR: 18749 us expected between 10000 and 18000 # 4.18 [+0.00] SND: 1759257061 s 732338 us (seq=9, len=10) (USR +18749 us) # 4.18 [+0.00] USR: 1759257061 s 802504 us (seq=0, len=0) # 4.25 [+0.08] ENQ: 1759257061 s 802524 us (seq=19, len=10) (USR +19 us) # 4.25 [+0.00] SND: 1759257061 s 812898 us (seq=19, len=10) (USR +10393 us) # 4.25 [+0.00] USR: 1759257061 s 882956 us (seq=0, len=0) # 4.33 [+0.08] ENQ: 1759257061 s 882974 us (seq=29, len=10) (USR +17 us) # 4.33 [+0.00] SND: 1759257061 s 893774 us (seq=29, len=10) (USR +10817 us) # 4.33 [+0.00] USR: 1759257061 s 963118 us (seq=0, len=0) # 4.42 [+0.09] ENQ: 1759257061 s 963134 us (seq=39, len=10) (USR +16 us) # 4.42 [+0.00] SND: 1759257061 s 975069 us (seq=39, len=10) (USR +11951 us) # 4.42 [+0.00] USR-ENQ: count=4, avg=2194 us, min=16 us, max=8725 us # 4.42 [+0.00] USR-SND: count=4, avg=12977 us, min=10393 us, max=18749 us # 4.52 [+0.10] # 4.52 [+0.00] test ACK # 4.58 [+0.06] USR: 1759257062 s 204410 us (seq=0, len=0) # 4.67 [+0.09] ACK: 1759257062 s 265658 us (seq=9, len=10) (USR +61247 us) # 4.67 [+0.00] USR: 1759257062 s 284818 us (seq=0, len=0) # 4.74 [+0.07] ACK: 1759257062 s 345539 us (seq=19, len=10) (USR +60721 us) # 4.81 [+0.07] USR: 1759257062 s 364986 us (seq=0, len=0) # 4.82 [+0.01] ACK: 1759257062 s 426957 us (seq=29, len=10) (USR +61971 us) # 4.82 [+0.00] USR: 1759257062 s 450279 us (seq=0, len=0) # 4.90 [+0.08] ACK: 1759257062 s 511411 us (seq=39, len=10) (USR +61131 us) # 4.91 [+0.01] USR-ACK: count=4, avg=61267 us, min=60721 us, max=61971 us # 5.00 [+0.09] # 5.00 [+0.00] test SND + ACK # 5.06 [+0.06] USR: 1759257062 s 693147 us (seq=0, len=0) # 5.15 [+0.09] SND: 1759257062 s 703249 us (seq=9, len=10) (USR +10102 us) # 5.15 [+0.00] ACK: 1759257062 s 753441 us (seq=9, len=10) (USR +60293 us) # 5.15 [+0.00] USR: 1759257062 s 782278 us (seq=0, len=0) # 5.24 [+0.09] SND: 1759257062 s 792318 us (seq=19, len=10) (USR +10039 us) # 5.24 [+0.00] ERROR: 71110 us expected between 60000 and 68000 # 5.24 [+0.00] ACK: 1759257062 s 853388 us (seq=19, len=10) (USR +71109 us) # 5.25 [+0.00] USR: 1759257062 s 862448 us (seq=0, len=0) # 5.31 [+0.07] SND: 1759257062 s 872485 us (seq=29, len=10) (USR +10037 us) # 5.31 [+0.00] ACK: 1759257062 s 922651 us (seq=29, len=10) (USR +60203 us) # 5.32 [+0.00] USR: 1759257062 s 942621 us (seq=0, len=0) # 5.39 [+0.08] SND: 1759257062 s 952691 us (seq=39, len=10) (USR +10069 us) # 5.39 [+0.00] ACK: 1759257063 s 2809 us (seq=39, len=10) (USR +60188 us) # 5.39 [+0.00] USR-SND: count=4, avg=10062 us, min=10037 us, max=10102 us # 5.40 [+0.00] USR-ACK: count=4, avg=62948 us, min=60188 us, max=71109 us # 5.50 [+0.10] # 5.50 [+0.00] test ENQ + SND + ACK # 5.55 [+0.05] USR: 1759257063 s 183245 us (seq=0, len=0) # 5.63 [+0.08] ENQ: 1759257063 s 183280 us (seq=9, len=10) (USR +34 us) # 5.64 [+0.00] SND: 1759257063 s 193829 us (seq=9, len=10) (USR +10583 us) # 5.64 [+0.00] ACK: 1759257063 s 244048 us (seq=9, len=10) (USR +60802 us) # 5.64 [+0.01] USR: 1759257063 s 264132 us (seq=0, len=0) # 5.71 [+0.07] ENQ: 1759257063 s 264157 us (seq=19, len=10) (USR +24 us) # 5.72 [+0.00] SND: 1759257063 s 274196 us (seq=19, len=10) (USR +10064 us) # 5.72 [+0.00] ACK: 1759257063 s 325399 us (seq=19, len=10) (USR +61266 us) # 5.72 [+0.00] USR: 1759257063 s 344885 us (seq=0, len=0) # 5.79 [+0.08] ENQ: 1759257063 s 344908 us (seq=29, len=10) (USR +23 us) # 5.80 [+0.01] SND: 1759257063 s 355289 us (seq=29, len=10) (USR +10404 us) # 5.80 [+0.00] ACK: 1759257063 s 405439 us (seq=29, len=10) (USR +60553 us) # 5.81 [+0.00] USR: 1759257063 s 425409 us (seq=0, len=0) # 5.88 [+0.07] ENQ: 1759257063 s 425432 us (seq=39, len=10) (USR +23 us) # 5.88 [+0.00] SND: 1759257063 s 435934 us (seq=39, len=10) (USR +10524 us) # 5.88 [+0.00] ACK: 1759257063 s 486096 us (seq=39, len=10) (USR +60686 us) # 5.89 [+0.00] USR-ENQ: count=4, avg=26 us, min=23 us, max=34 us # 5.89 [+0.00] USR-SND: count=4, avg=10394 us, min=10064 us, max=10583 us # 5.89 [+0.00] USR-ACK: count=4, avg=60827 us, min=60553 us, max=61266 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__->