make -C tools/testing/selftests TARGETS=drivers/net/bonding TEST_PROGS=modde-1-recovery-updelay.sh TEST_GEN_PROGS="" run_tests
make: Entering directory '/home/virtme/testing-10/tools/testing/selftests'
make[1]: Entering directory '/home/virtme/testing-10/tools/testing/selftests/drivers/net/bonding'
make[1]: Nothing to be done for 'all'.
make[1]: Leaving directory '/home/virtme/testing-10/tools/testing/selftests/drivers/net/bonding'
make[1]: Entering directory '/home/virtme/testing-10/tools/testing/selftests/drivers/net/bonding'
TAP version 13
1..1
# overriding timeout to 2400
# selftests: drivers/net/bonding: mode-1-recovery-updelay.sh
[  845.299161][ T5498] eth0: renamed from lag1
[  845.537682][ T5503] eth0: renamed from lag1-end
[  845.854948][ T5511] eth1: renamed from lag1
[  846.085589][ T5514] eth1: renamed from lag1-end
[  846.823271][ T5517] br0: port 1(eth0) entered blocking state
[  846.823929][ T5517] br0: port 1(eth0) entered disabled state
[  846.824300][ T5517] eth0: entered allmulticast mode
[  846.825649][ T5517] eth0: entered promiscuous mode
[  847.246129][ T5518] br0: port 2(eth1) entered blocking state
[  847.246682][ T5518] br0: port 2(eth1) entered disabled state
[  847.247194][ T5518] eth1: entered allmulticast mode
[  847.249304][ T5518] eth1: entered promiscuous mode
[  849.154832][ T5524] bond0: (slave eth0): making interface the new active one
[  849.155932][ T5524] bond0: (slave eth0): Enslaving as an active interface with an up link
[  849.158870][ T5128] br0: port 1(eth0) entered blocking state
[  849.159383][ T5128] br0: port 1(eth0) entered forwarding state
[  849.506208][ T5525] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  849.507659][ T5238] br0: port 2(eth1) entered blocking state
[  849.508082][ T5238] br0: port 2(eth1) entered forwarding state
[  852.048109][ T5530] br0: port 1(eth0) entered disabled state
[  852.111094][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  852.111643][   T72] bond0: (slave eth1): making interface the new active one
[  854.538012][ T5238] br0: port 1(eth0) entered blocking state
[  854.538545][ T5238] br0: port 1(eth0) entered forwarding state
[  854.613582][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  854.888002][ T5533] br0: port 2(eth1) entered disabled state
[  854.927928][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  854.928740][   T72] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  856.690985][ T5536] bond0 (unregistering): (slave eth0): Releasing backup interface
[  856.711071][ T5536] bond0 (unregistering): (slave eth1): Releasing backup interface
[  856.723114][ T5536] bond0 (unregistering): Released all slaves
[  856.741464][ T2694] br0: port 1(eth0) entered disabled state
[  858.893908][ T5543] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  858.897432][ T5238] br0: port 1(eth0) entered blocking state
[  858.897793][ T5238] br0: port 1(eth0) entered forwarding state
[  859.286959][ T5544] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  859.288138][ T2817] br0: port 2(eth1) entered blocking state
[  859.288491][ T2817] br0: port 2(eth1) entered forwarding state
[  859.653895][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  859.654472][   T72] bond0: (slave eth0): making interface the new active one
[  859.655523][   T72] bond0: active interface up!
[  859.757577][ T1244] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  861.872792][ T5549] br0: port 1(eth0) entered disabled state
[  861.942806][ T1244] bond0: (slave eth0): link status definitely down, disabling slave
[  861.943306][ T1244] bond0: (slave eth1): making interface the new active one
[  864.400779][ T2428] br0: port 1(eth0) entered blocking state
[  864.401314][ T2428] br0: port 1(eth0) entered forwarding state
[  864.437335][ T1244] bond0: (slave eth0): link status up, enabling it in 200 ms
[  864.437898][ T1244] bond0: (slave eth0): invalid new link 3 on slave
[  864.651419][ T1244] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  864.796490][ T5552] br0: port 2(eth1) entered disabled state
[  864.861798][ T1244] bond0: (slave eth1): link status definitely down, disabling slave
[  864.862341][ T1244] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  866.758956][ T5555] bond0 (unregistering): (slave eth0): Releasing backup interface
[  866.770069][ T5555] bond0 (unregistering): (slave eth1): Releasing backup interface
[  866.782056][ T5555] bond0 (unregistering): Released all slaves
[  866.800522][ T2817] br0: port 1(eth0) entered disabled state
[  868.994259][ T5562] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  868.995183][ T5238] br0: port 1(eth0) entered blocking state
[  868.995521][ T5238] br0: port 1(eth0) entered forwarding state
[  869.358220][ T5563] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  869.359896][ T2817] br0: port 2(eth1) entered blocking state
[  869.360494][ T2817] br0: port 2(eth1) entered forwarding state
[  869.692043][ T1244] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  869.692849][ T1244] bond0: (slave eth0): making interface the new active one
[  869.694353][ T1244] bond0: active interface up!
[  870.110629][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  872.012928][ T5568] br0: port 1(eth0) entered disabled state
[  872.085744][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  872.086255][   T72] bond0: (slave eth1): making interface the new active one
[  874.465656][ T2817] br0: port 1(eth0) entered blocking state
[  874.466180][ T2817] br0: port 1(eth0) entered forwarding state
[  874.478336][   T72] bond0: (slave eth0): link status up, enabling it in 500 ms
[  874.478822][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  874.799582][ T5571] br0: port 2(eth1) entered disabled state
[  874.894896][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  874.895588][   T72] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  876.703232][ T5574] bond0 (unregistering): (slave eth0): Releasing backup interface
[  876.714205][ T5574] bond0 (unregistering): (slave eth1): Releasing backup interface
[  876.725773][ T5574] bond0 (unregistering): Released all slaves
[  876.755375][ T2817] br0: port 1(eth0) entered disabled state
[  878.945754][ T5581] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  878.946812][ T2817] br0: port 1(eth0) entered blocking state
[  878.947298][ T2817] br0: port 1(eth0) entered forwarding state
[  879.315272][ T5582] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  879.316519][ T2694] br0: port 2(eth1) entered blocking state
[  879.316846][ T2694] br0: port 2(eth1) entered forwarding state
[  879.672071][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  879.672840][   T72] bond0: (slave eth0): making interface the new active one
[  879.674214][   T72] bond0: active interface up!
[  880.613863][ T1244] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  881.891394][ T5587] br0: port 1(eth0) entered disabled state
[  881.967189][ T1244] bond0: (slave eth0): link status definitely down, disabling slave
[  881.967700][ T1244] bond0: (slave eth1): making interface the new active one
[  884.404290][ T2817] br0: port 1(eth0) entered blocking state
[  884.404663][ T2817] br0: port 1(eth0) entered forwarding state
[  884.469365][ T1244] bond0: (slave eth0): link status up, enabling it in 1000 ms
[  884.469974][ T1244] bond0: (slave eth0): invalid new link 3 on slave
[  884.751446][ T5590] br0: port 2(eth1) entered disabled state
[  884.781765][ T1244] bond0: (slave eth1): link status definitely down, disabling slave
[  884.782332][ T1244] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  886.571312][ T5593] bond0 (unregistering): (slave eth0): Releasing backup interface
[  886.582747][ T5593] bond0 (unregistering): (slave eth1): Releasing backup interface
[  886.594306][ T5593] bond0 (unregistering): Released all slaves
[  886.625242][ T2817] br0: port 1(eth0) entered disabled state
[  888.714572][ T5600] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  888.715535][ T5238] br0: port 1(eth0) entered blocking state
[  888.715862][ T5238] br0: port 1(eth0) entered forwarding state
[  889.055027][ T5601] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  889.066223][   T33] br0: port 2(eth1) entered blocking state
[  889.066585][   T33] br0: port 2(eth1) entered forwarding state
[  889.415919][ T1244] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  889.416512][ T1244] bond0: (slave eth0): making interface the new active one
[  889.417549][ T1244] bond0: active interface up!
[  891.399648][ T1244] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  891.599120][ T5606] br0: port 1(eth0) entered disabled state
[  891.605910][ T1244] bond0: (slave eth0): link status definitely down, disabling slave
[  891.606572][ T1244] bond0: (slave eth1): making interface the new active one
[  894.076469][ T2694] br0: port 1(eth0) entered blocking state
[  894.076842][ T2694] br0: port 1(eth0) entered forwarding state
[  894.102364][ T1244] bond0: (slave eth0): link status up, enabling it in 2000 ms
[  894.102911][ T1244] bond0: (slave eth0): invalid new link 3 on slave
[  894.442191][ T5609] br0: port 2(eth1) entered disabled state
[  894.518116][ T1244] bond0: (slave eth1): link status definitely down, disabling slave
[  894.518972][ T1244] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  896.274911][ T5612] bond0 (unregistering): (slave eth0): Releasing backup interface
[  896.286463][ T5612] bond0 (unregistering): (slave eth1): Releasing backup interface
[  896.297484][ T5612] bond0 (unregistering): Released all slaves
[  896.314444][ T2694] br0: port 1(eth0) entered disabled state
[  898.482013][ T5619] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  898.483040][ T5238] br0: port 1(eth0) entered blocking state
[  898.483517][ T5238] br0: port 1(eth0) entered forwarding state
[  898.801624][ T5620] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  898.803202][ T2817] br0: port 2(eth1) entered blocking state
[  898.803570][ T2817] br0: port 2(eth1) entered forwarding state
[  899.143921][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  899.144540][   T72] bond0: (slave eth0): making interface the new active one
[  899.151273][   T72] bond0: active interface up!
[  901.257492][ T5625] br0: port 1(eth0) entered disabled state
[  901.334050][ T1244] bond0: (slave eth0): link status definitely down, disabling slave
[  901.334845][ T1244] bond0: (slave eth1): making interface the new active one 2400 ms earlier
[  903.750822][ T2817] br0: port 1(eth0) entered blocking state
[  903.751198][ T2817] br0: port 1(eth0) entered forwarding state
[  903.837350][ T1244] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  903.838044][ T1244] bond0: (slave eth0): invalid new link 3 on slave
[  904.103360][ T5628] br0: port 2(eth1) entered disabled state
[  904.150877][ T1244] bond0: (slave eth1): link status definitely down, disabling slave
[  904.151385][ T1244] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  905.945015][ T5631] bond0 (unregistering): (slave eth0): Releasing backup interface
[  905.964307][ T5631] bond0 (unregistering): (slave eth1): Releasing backup interface
[  905.974477][ T5631] bond0 (unregistering): Released all slaves
[  905.988761][ T2694] br0: port 1(eth0) entered disabled state
[  908.086147][ T5638] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  908.089464][   T33] br0: port 1(eth0) entered blocking state
[  908.089810][   T33] br0: port 1(eth0) entered forwarding state
[  908.438024][ T5639] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  908.439532][ T2817] br0: port 2(eth1) entered blocking state
[  908.439897][ T2817] br0: port 2(eth1) entered forwarding state
[  908.798002][ T1244] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  908.798627][ T1244] bond0: (slave eth0): making interface the new active one
[  908.799657][ T1244] bond0: active interface up!
[  910.965651][ T5644] br0: port 1(eth0) entered disabled state
[  910.981932][ T1244] bond0: (slave eth0): link status definitely down, disabling slave
[  910.982644][ T1244] bond0: (slave eth1): making interface the new active one 2600 ms earlier
[  913.405914][ T5176] br0: port 1(eth0) entered blocking state
[  913.406310][ T5176] br0: port 1(eth0) entered forwarding state
[  913.485391][ T1244] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  913.486163][ T1244] bond0: (slave eth0): invalid new link 3 on slave
[  913.776850][ T5647] br0: port 2(eth1) entered disabled state
[  913.799214][ T1244] bond0: (slave eth1): link status definitely down, disabling slave
[  913.799970][ T1244] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  915.624894][ T5650] bond0 (unregistering): (slave eth0): Releasing backup interface
[  915.643741][ T5650] bond0 (unregistering): (slave eth1): Releasing backup interface
[  915.651198][ T5650] bond0 (unregistering): Released all slaves
[  915.664719][ T5128] br0: port 1(eth0) entered disabled state
[  916.722530][ T1244] eth1: left allmulticast mode
[  916.722976][ T1244] eth1: left promiscuous mode
[  916.723613][ T1244] br0: port 2(eth1) entered disabled state
[  916.725730][ T1244] eth0: left allmulticast mode
[  916.726132][ T1244] eth0: left promiscuous mode
[  916.726708][ T1244] br0: port 1(eth0) entered disabled state
ok 1 selftests: drivers/net/bonding: mode-1-recovery-updelay.sh
make[1]: Leaving directory '/home/virtme/testing-10/tools/testing/selftests/drivers/net/bonding'
make: Leaving directory '/home/virtme/testing-10/tools/testing/selftests'
xx__-> echo $?
0
xx__->