log

Host: Linux snabb1 4.4.80 x86_64 Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz
Image: lwaftr/snabb-test
Pull Request: #1165
Target Head: 49d5e765ad5e3f2e50ef8efc7d5d2b339e3bcf4a
Pull Request Head: f5c63444b08a4de4d1d46c0f2e8cc5b0cc15218c
SNABB_PCI0=0000:81:00.0 Ethernet controller: Intel Corporation 82599ES 10-Gigabit SFI/SFP+ Network Connection (rev 01)
SNABB_PCI1=0000:81:00.1 Ethernet controller: Intel Corporation 82599ES 10-Gigabit SFI/SFP+ Network Connection (rev 01)
SNABB_PCI_INTEL0=0000:81:00.0 Ethernet controller: Intel Corporation 82599ES 10-Gigabit SFI/SFP+ Network Connection (rev 01)
SNABB_PCI_INTEL1=0000:81:00.1 Ethernet controller: Intel Corporation 82599ES 10-Gigabit SFI/SFP+ Network Connection (rev 01)

Checking test suite:
DIR       testlog
TEST      core.timer
TEST      core.counter
TEST      core.worker
TEST      core.lib
TEST      core.main
TEST      core.packet
TEST      core.app
TEST      core.memory
TEST      core.shm
TEST      core.link
TEST      core.histogram
TEST      apps.intel.intel_app
ERROR     testlog/apps.intel.intel_app

ERROR during tests:
src/testlog/apps.intel.intel_app:
selftest: intel_app
100 VF initializations:

Running iterated VMDq test...
test #  1: VMDq VLAN=101; 100ms burst. packet sent: 674,424
test #  2: VMDq VLAN=102; 100ms burst. packet sent: 1,559,274
test #  3: VMDq VLAN=103; 100ms burst. packet sent: 2,224,212
test #  4: VMDq VLAN=104; 100ms burst. packet sent: 2,860,080
test #  5: VMDq VLAN=105; 100ms burst. packet sent: 3,484,728
test #  6: VMDq VLAN=106; 100ms burst. packet sent: 4,111,008
test #  7: VMDq VLAN=107; 100ms burst. packet sent: 4,727,190
test #  8: VMDq VLAN=108; 100ms burst. packet sent: 5,351,736
test #  9: VMDq VLAN=109; 100ms burst. packet sent: 6,168,042
test # 10: VMDq VLAN=110; 100ms burst. packet sent: 6,955,176
test # 11: VMDq VLAN=111; 100ms burst. packet sent: 7,564,626
test # 12: VMDq VLAN=112; 100ms burst. packet sent: 8,188,050
test # 13: VMDq VLAN=113; 100ms burst. packet sent: 8,797,500
test # 14: VMDq VLAN=114; 100ms burst. packet sent: 9,407,766
test # 15: VMDq VLAN=115; 100ms burst. packet sent: 10,016,196
test # 16: VMDq VLAN=116; 100ms burst. packet sent: 10,629,828
test # 17: VMDq VLAN=117; 100ms burst. packet sent: 11,248,254
test # 18: VMDq VLAN=118; 100ms burst. packet sent: 11,847,708
test # 19: VMDq VLAN=119; 100ms burst. packet sent: 12,623,928
test # 20: VMDq VLAN=120; 100ms burst. packet sent: 13,424,322
test # 21: VMDq VLAN=121; 100ms burst. packet sent: 14,019,900
test # 22: VMDq VLAN=122; 100ms burst. packet sent: 14,617,008
test # 23: VMDq VLAN=123; 100ms burst. packet sent: 15,212,382
test # 24: VMDq VLAN=124; 100ms burst. packet sent: 15,815,712
test # 25: VMDq VLAN=125; 100ms burst. packet sent: 16,404,456
test # 26: VMDq VLAN=126; 100ms burst. packet sent: 17,001,462
test # 27: VMDq VLAN=127; 100ms burst. packet sent: 17,598,366
test # 28: VMDq VLAN=128; 100ms burst. packet sent: 18,191,700
test # 29: VMDq VLAN=129; 100ms burst. packet sent: 18,785,238
test # 30: VMDq VLAN=130; 100ms burst. packet sent: 19,379,286
test # 31: VMDq VLAN=131; 100ms burst. packet sent: 19,972,314
test # 32: VMDq VLAN=132; 100ms burst. packet sent: 20,570,340
test # 33: VMDq VLAN=133; 100ms burst. packet sent: 21,162,348
test # 34: VMDq VLAN=134; 100ms burst. packet sent: 21,766,086
test # 35: VMDq VLAN=135; 100ms burst. packet sent: 22,355,034
test # 36: VMDq VLAN=136; 100ms burst. packet sent: 22,949,082
test # 37: VMDq VLAN=137; 100ms burst. packet sent: 23,539,050
test # 38: VMDq VLAN=138; 100ms burst. packet sent: 24,126,876
test # 39: VMDq VLAN=139; 100ms burst. packet sent: 24,715,008
test # 40: VMDq VLAN=140; 100ms burst. packet sent: 25,302,732
test # 41: VMDq VLAN=141; 100ms burst. packet sent: 25,889,436
test # 42: VMDq VLAN=142; 100ms burst. packet sent: 26,475,018
test # 43: VMDq VLAN=143; 100ms burst. packet sent: 27,058,254
test # 44: VMDq VLAN=144; 100ms burst. packet sent: 27,643,122
test # 45: VMDq VLAN=145; 100ms burst. packet sent: 28,226,766
test # 46: VMDq VLAN=146; 100ms burst. packet sent: 28,810,206
test # 47: VMDq VLAN=147; 100ms burst. packet sent: 29,389,260
test # 48: VMDq VLAN=148; 100ms burst. packet sent: 29,973,516
test # 49: VMDq VLAN=149; 100ms burst. packet sent: 30,555,630
test # 50: VMDq VLAN=150; 100ms burst. packet sent: 31,137,642
test # 51: VMDq VLAN=151; 100ms burst. packet sent: 31,730,670
test # 52: VMDq VLAN=152; 100ms burst. packet sent: 32,310,030
test # 53: VMDq VLAN=153; 100ms burst. packet sent: 32,890,308
test # 54: VMDq VLAN=154; 100ms burst. packet sent: 33,470,994
test # 55: VMDq VLAN=155; 100ms burst. packet sent: 34,051,578
test # 56: VMDq VLAN=156; 100ms burst. packet sent: 34,630,938
test # 57: VMDq VLAN=157; 100ms burst. packet sent: 35,211,522
test # 58: VMDq VLAN=158; 100ms burst. packet sent: 35,792,412
test # 59: VMDq VLAN=159; 100ms burst. packet sent: 36,372,486
test # 60: VMDq VLAN=160; 100ms burst. packet sent: 36,950,112
test # 61: VMDq VLAN=161; 100ms burst. packet sent: 37,530,084
test # 62: VMDq VLAN=162; 100ms burst. packet sent: 38,112,198
test # 63: VMDq VLAN=163; 100ms burst. packet sent: 38,691,966
test # 64: VMDq VLAN=164; 100ms burst. packet sent: 39,278,058
test # 65: VMDq VLAN=165; 100ms burst. packet sent: 39,857,316
test # 66: VMDq VLAN=166; 100ms burst. packet sent: 40,437,288
test # 67: VMDq VLAN=167; 100ms burst. packet sent: 41,017,464
test # 68: VMDq VLAN=168; 100ms burst. packet sent: 41,607,330
test # 69: VMDq VLAN=169; 100ms burst. packet sent: 42,186,996
test # 70: VMDq VLAN=170; 100ms burst. packet sent: 42,761,460
test # 71: VMDq VLAN=171; 100ms burst. packet sent: 43,288,188
test # 72: VMDq VLAN=172; 100ms burst. packet sent: 43,839,396
test # 73: VMDq VLAN=173; 100ms burst. packet sent: 44,415,696
test # 74: VMDq VLAN=174; 100ms burst. packet sent: 44,991,078
test # 75: VMDq VLAN=175; 100ms burst. packet sent: 45,563,298
test # 76: VMDq VLAN=176; 100ms burst. packet sent: 46,137,966
test # 77: VMDq VLAN=177; 100ms burst. packet sent: 46,714,164
test # 78: VMDq VLAN=178; 100ms burst. packet sent: 47,290,464
test # 79: VMDq VLAN=179; 100ms burst. packet sent: 47,868,600
test # 80: VMDq VLAN=180; 100ms burst. packet sent: 48,449,490
test # 81: VMDq VLAN=181; 100ms burst. packet sent: 49,031,706
test # 82: VMDq VLAN=182; 100ms burst. packet sent: 49,613,616
test # 83: VMDq VLAN=183; 100ms burst. packet sent: 50,195,016
test # 84: VMDq VLAN=184; 100ms burst. packet sent: 50,772,030
test # 85: VMDq VLAN=185; 100ms burst. packet sent: 51,346,290
test # 86: VMDq VLAN=186; 100ms burst. packet sent: 51,926,058
test # 87: VMDq VLAN=187; 100ms burst. packet sent: 52,507,662
test # 88: VMDq VLAN=188; 100ms burst. packet sent: 53,088,348
test # 89: VMDq VLAN=189; 100ms burst. packet sent: 53,670,156
test # 90: VMDq VLAN=190; 100ms burst. packet sent: 54,249,312
test # 91: VMDq VLAN=191; 100ms burst. packet sent: 54,829,590
test # 92: VMDq VLAN=192; 100ms burst. packet sent: 55,408,746
test # 93: VMDq VLAN=193; 100ms burst. packet sent: 55,987,392
test # 94: VMDq VLAN=194; 100ms burst. packet sent: 56,563,488
test # 95: VMDq VLAN=195; 100ms burst. packet sent: 57,139,074
test # 96: VMDq VLAN=196; 100ms burst. packet sent: 57,714,252
test # 97: VMDq VLAN=197; 100ms burst. packet sent: 58,289,124
test # 98: VMDq VLAN=198; 100ms burst. packet sent: 58,865,220
test # 99: VMDq VLAN=199; 100ms burst. packet sent: 59,440,602
test #100: VMDq VLAN=200; 100ms burst. packet sent: 60,016,698
0000:81:00.0: avg wait_lu: 184, max redos: 0, avg: 0
100 PF full cycles

Running iterated VMDq test...
test #  1: VMDq VLAN=101; 100ms burst. packet sent: 628,932
test #  2: VMDq VLAN=102; 100ms burst. packet sent: 625,668
test #  3: VMDq VLAN=103; 100ms burst. packet sent: 623,424
test #  4: VMDq VLAN=104; 100ms burst. packet sent: 562,938
test #  5: VMDq VLAN=105; 100ms burst. packet sent: 565,386
test #  6: VMDq VLAN=106; 100ms burst. packet sent: 628,728
test #  7: VMDq VLAN=107; 100ms burst. packet sent: 546,516
test #  8: VMDq VLAN=108; 100ms burst. packet sent: 527,544
test #  9: VMDq VLAN=109; 100ms burst. packet sent: 787,134
test # 10: VMDq VLAN=110; 100ms burst. packet sent: 666,978
test # 11: VMDq VLAN=111; 100ms burst. packet sent: 477,666
test # 12: VMDq VLAN=112; 100ms burst. packet sent: 668,100
test # 13: VMDq VLAN=113; 100ms burst. packet sent: 634,950
test # 14: VMDq VLAN=114; 100ms burst. packet sent: 634,950
test # 15: VMDq VLAN=115; 100ms burst. packet sent: 710,634
test # 16: VMDq VLAN=116; 100ms burst. packet sent: 446,862
test # 17: VMDq VLAN=117; 100ms burst. packet sent: 622,608
test # 18: VMDq VLAN=118; 100ms burst. packet sent: 632,400
test # 19: VMDq VLAN=119; 100ms burst. packet sent: 648,720
test # 20: VMDq VLAN=120; 100ms burst. packet sent: 849,456
test # 21: VMDq VLAN=121; 100ms burst. packet sent: 753,168
test # 22: VMDq VLAN=122; 100ms burst. packet sent: 858,840
test # 23: VMDq VLAN=123; 100ms burst. packet sent: 632,094
test # 24: VMDq VLAN=124; 100ms burst. packet sent: 666,162
test # 25: VMDq VLAN=125; 100ms burst. packet sent: 796,416
test # 26: VMDq VLAN=126; 100ms burst. packet sent: 877,608
test # 27: VMDq VLAN=127; 100ms burst. packet sent: 876,486
test # 28: VMDq VLAN=128; 100ms burst. packet sent: 620,670
test # 29: VMDq VLAN=129; 100ms burst. packet sent: 633,726
test # 30: VMDq VLAN=130; 100ms burst. packet sent: 633,420
test # 31: VMDq VLAN=131; 100ms burst. packet sent: 847,314
test # 32: VMDq VLAN=132; 100ms burst. packet sent: 883,626
test # 33: VMDq VLAN=133; 100ms burst. packet sent: 867,102
test # 34: VMDq VLAN=134; 100ms burst. packet sent: 824,058
test # 35: VMDq VLAN=135; 100ms burst. packet sent: 881,280
test # 36: VMDq VLAN=136; 100ms burst. packet sent: 880,974
test # 37: VMDq VLAN=137; 100ms burst. packet sent: 877,914
test # 38: VMDq VLAN=138; 100ms burst. packet sent: 613,224
test # 39: VMDq VLAN=139; 100ms burst. packet sent: 874,140
test # 40: VMDq VLAN=140; 100ms burst. packet sent: 629,748
test # 41: VMDq VLAN=141; 100ms burst. packet sent: 748,170
test # 42: VMDq VLAN=142; 100ms burst. packet sent: 863,838
test # 43: VMDq VLAN=143; 100ms burst. packet sent: 870,774
test # 44: VMDq VLAN=144; 100ms burst. packet sent: 872,406
test # 45: VMDq VLAN=145; 100ms burst. packet sent: 877,200
test # 46: VMDq VLAN=146; 100ms burst. packet sent: 670,548
test # 47: VMDq VLAN=147; 100ms burst. packet sent: 879,036
test # 48: VMDq VLAN=148; 100ms burst. packet sent: 817,428
test # 49: VMDq VLAN=149; 100ms burst. packet sent: 883,830
test # 50: VMDq VLAN=150; 100ms burst. packet sent: 872,100
test # 51: VMDq VLAN=151; 100ms burst. packet sent: 868,224
test # 52: VMDq VLAN=152; 100ms burst. packet sent: 868,224
test # 53: VMDq VLAN=153; 100ms burst. packet sent: 876,078
test # 54: VMDq VLAN=154; 100ms burst. packet sent: 870,978
test # 55: VMDq VLAN=155; 100ms burst. packet sent: 814,878
test # 56: VMDq VLAN=156; 100ms burst. packet sent: 876,384
test # 57: VMDq VLAN=157; 100ms burst. packet sent: 875,976
test # 58: VMDq VLAN=158; 100ms burst. packet sent: 865,878
test # 59: VMDq VLAN=159; 100ms burst. packet sent: 876,996
test # 60: VMDq VLAN=160; 100ms burst. packet sent: 861,900
test # 61: VMDq VLAN=161; 100ms burst. packet sent: 851,394
test # 62: VMDq VLAN=162; 100ms burst. packet sent: 866,694
test # 63: VMDq VLAN=163; 100ms burst. packet sent: 869,448
test # 64: VMDq VLAN=164; 100ms burst. packet sent: 627,606
test # 65: VMDq VLAN=165; 100ms burst. packet sent: 629,136
test # 66: VMDq VLAN=166; 100ms burst. packet sent: 880,668
test # 67: VMDq VLAN=167; 100ms burst. packet sent: 866,388
test # 68: VMDq VLAN=168; 100ms burst. packet sent: 850,272
test # 69: VMDq VLAN=169; 100ms burst. packet sent: 824,874
test # 70: VMDq VLAN=170; 100ms burst. packet sent: 876,384
test # 71: VMDq VLAN=171; 100ms burst. packet sent: 877,812
test # 72: VMDq VLAN=172; 100ms burst. packet sent: 858,636
test # 73: VMDq VLAN=173; 100ms burst. packet sent: 849,660
test # 74: VMDq VLAN=174; 100ms burst. packet sent: 872,508
test # 75: VMDq VLAN=175; 100ms burst. packet sent: 840,888
test # 76: VMDq VLAN=176; 100ms burst. packet sent: 842,724
test # 77: VMDq VLAN=177; 100ms burst. packet sent: 876,894
test # 78: VMDq VLAN=178; 100ms burst. packet sent: 870,060
test # 79: VMDq VLAN=179; 100ms burst. packet sent: 830,178
test # 80: VMDq VLAN=180; 100ms burst. packet sent: 619,752
test # 81: VMDq VLAN=181; 100ms burst. packet sent: 867,510
test # 82: VMDq VLAN=182; 100ms burst. packet sent: 818,550
test # 83: VMDq VLAN=183; 100ms burst. packet sent: 874,242
test # 84: VMDq VLAN=184; 100ms burst. packet sent: 871,590
test # 85: VMDq VLAN=185; 100ms burst. packet sent: 844,866
test # 86: VMDq VLAN=186; 100ms burst. packet sent: 813,756
test # 87: VMDq VLAN=187; 100ms burst. packet sent: 885,360
test # 88: VMDq VLAN=188; 100ms burst. packet sent: 875,670
test # 89: VMDq VLAN=189; 100ms burst. packet sent: 630,054
test # 90: VMDq VLAN=190; 100ms burst. packet sent: 624,954
test # 91: VMDq VLAN=191; 100ms burst. packet sent: 630,972
test # 92: VMDq VLAN=192; 100ms burst. packet sent: 633,012
test # 93: VMDq VLAN=193; 100ms burst. packet sent: 843,438
test # 94: VMDq VLAN=194; 100ms burst. packet sent: 626,994
test # 95: VMDq VLAN=195; 100ms burst. packet sent: 632,604
test # 96: VMDq VLAN=196; 100ms burst. packet sent: 623,118
test # 97: VMDq VLAN=197; 100ms burst. packet sent: 629,442
test # 98: VMDq VLAN=198; 100ms burst. packet sent: 875,262
test # 99: VMDq VLAN=199; 100ms burst. packet sent: 881,280
test #100: VMDq VLAN=200; 100ms burst. packet sent: 880,056
0000:81:00.0: avg wait_lu: 165.01, max redos: 0, avg: 0
-------
Send a bunch of packets from Am0
half of them go to nicAm1 and half go nowhere
link report:
                   0 sent on nicAm0.tx -> sink_ms.in1 (loss rate: 0%)
           3,350,244 sent on nicAm1.tx -> sink_ms.in2 (loss rate: 0%)
           6,700,788 sent on repeater_ms.output -> nicAm0.rx (loss rate: 0%)
                   2 sent on source_ms.output -> repeater_ms.input (loss rate: 0%)
-------
Transmitting bidirectionally between nicA and nicB
link report:
                   0 sent on nicA.tx -> sink.in1 (loss rate: 0%)
                   0 sent on nicB.tx -> sink.in2 (loss rate: 0%)
           4,244,526 sent on source1.out -> nicA.rx (loss rate: 0%)
               2,046 sent on source2.out -> nicB.rx (loss rate: 99%)
sq_sq: missing packets
EXITCODE: 1

src/testlog/core.app:
Restarting app2 (died at 4340305.469213: core/app.lua:763: Push error.)
Restarting app1 (died at 4340305.469213: core/app.lua:757: Pull error.)
Restarting app2 (died at 4340307.469338: core/app.lua:763: Push error.)
Restarting app1 (died at 4340307.469338: core/app.lua:757: Pull error.)
Restarting app3 (died at 4340309.467791: core/app.lua:769: Report error.)
Restarting app2 (died at 4340309.469362: core/app.lua:763: Push error.)
Restarting app1 (died at 4340309.469362: core/app.lua:757: Pull error.)
selftest: app
empty -> c1
c1 -> c1
c1 -> c2
c2 -> c1
c1 -> empty
c_fail
apps report:
app3
app2	[dead: core/app.lua:763: Push error.]
app1	[dead: core/app.lua:757: Pull error.]
apps report:
app3
app2	[dead: core/app.lua:763: Push error.]
app1	[dead: core/app.lua:757: Pull error.]

src/testlog/core.counter:
selftest: core.counter
selftest ok

src/testlog/core.histogram:
selftest: histogram
selftest ok

src/testlog/core.lib:
selftest: lib
Testing equal
Testing load_string
Testing load/store_conf
Testing csum
Testing hex(un)dump
Testing ntohl
Testing parse

src/testlog/core.link:
selftest: link
selftest OK

src/testlog/core.main:
selftest

src/testlog/core.memory:
selftest: memory
Kernel vm.nr_hugepages: 10000
  Allocating a 2MB HugeTLB:Got 2MB
    Physical address: 0x000e03e00000
    Virtual address:  0x500e03e00000
  Allocating a 2MB HugeTLB:Got 2MB
    Physical address: 0x000f4c200000
    Virtual address:  0x500f4c200000
  Allocating a 2MB HugeTLB:Got 2MB
    Physical address: 0x000f2c200000
    Virtual address:  0x500f2c200000
  Allocating a 2MB HugeTLB:Got 2MB
    Physical address: 0x000f28e00000
    Virtual address:  0x500f28e00000
Kernel vm.nr_hugepages: 10000
Testing automatic remapping of DMA memory
    Unmapping cdata<char *>: 0x500e03e00000
    Unmapping cdata<char *>: 0x500f4c200000
    Unmapping cdata<char *>: 0x500f2c200000
    Unmapping cdata<char *>: 0x500f28e00000
    Writing   cdata<char *>: 0x500e03e00000
    Writing   cdata<char *>: 0x500f4c200000
    Writing   cdata<char *>: 0x500f2c200000
    Writing   cdata<char *>: 0x500f28e00000
Created 4 on-demand memory mappings with SIGSEGV handler.
HugeTLB page allocation OK.

src/testlog/core.packet:
[mounting /var/run/snabb/hugetlbfs]

src/testlog/core.shm:
selftest: shm
checking resolve..
checking shared memory..
create shm/selftest/obj
checking exists..
checking many objects..
10000 objects created
10000 objects unmapped
selftest ok

src/testlog/core.timer:
selftest: timer
ok (973,855 callbacks in 0.2863 seconds)

src/testlog/core.worker:
selftest: worker
Starting children
Worker status:
  worker w3: pid=87 alive=true
  worker w1: pid=85 alive=true
  worker w2: pid=86 alive=true
Stopping children
Worker status:
  worker w3: pid=87 alive=false
  worker w1: pid=85 alive=false
  worker w2: pid=86 alive=false
selftest: done