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
[  777.189754][ T5291] eth0: renamed from lag1
[  777.382086][ T5295] eth0: renamed from lag1-end
[  777.831904][ T5304] eth1: renamed from lag1
[  778.053448][ T5307] eth1: renamed from lag1-end
[  778.710075][ T5310] br0: port 1(eth0) entered blocking state
[  778.710624][ T5310] br0: port 1(eth0) entered disabled state
[  778.711064][ T5310] eth0: entered allmulticast mode
[  778.712662][ T5310] eth0: entered promiscuous mode
[  779.061087][ T5311] br0: port 2(eth1) entered blocking state
[  779.062134][ T5311] br0: port 2(eth1) entered disabled state
[  779.062494][ T5311] eth1: entered allmulticast mode
[  779.063821][ T5311] eth1: entered promiscuous mode
[  780.706110][ T5317] bond0: (slave eth0): making interface the new active one
[  780.712817][ T5317] bond0: (slave eth0): Enslaving as an active interface with an up link
[  780.713972][   T33] br0: port 1(eth0) entered blocking state
[  780.714293][   T33] br0: port 1(eth0) entered forwarding state
[  781.190345][ T5318] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  781.192058][ T3018] br0: port 2(eth1) entered blocking state
[  781.192545][ T3018] br0: port 2(eth1) entered forwarding state
[  783.779829][ T5323] br0: port 1(eth0) entered disabled state
[  783.822434][  T254] bond0: (slave eth0): link status definitely down, disabling slave
[  783.823183][  T254] bond0: (slave eth1): making interface the new active one
[  786.242901][   T33] br0: port 1(eth0) entered blocking state
[  786.243266][   T33] br0: port 1(eth0) entered forwarding state
[  786.325731][  T254] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  786.596501][ T5326] br0: port 2(eth1) entered disabled state
[  786.638883][  T254] bond0: (slave eth1): link status definitely down, disabling slave
[  786.639422][  T254] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  788.469448][ T5329] bond0 (unregistering): (slave eth0): Releasing backup interface
[  788.484370][ T5329] bond0 (unregistering): (slave eth1): Releasing backup interface
[  788.495590][ T5329] bond0 (unregistering): Released all slaves
[  788.522237][ T5229] br0: port 1(eth0) entered disabled state
[  790.619877][ T5336] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  790.620725][ T2558] br0: port 1(eth0) entered blocking state
[  790.621042][ T2558] br0: port 1(eth0) entered forwarding state
[  790.974405][ T5337] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  790.976957][ T2674] br0: port 2(eth1) entered blocking state
[  790.977465][ T2674] br0: port 2(eth1) entered forwarding state
[  791.377794][  T254] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  791.378332][  T254] bond0: (slave eth0): making interface the new active one
[  791.379269][  T254] bond0: active interface up!
[  791.485750][   T71] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  793.500882][ T5342] br0: port 1(eth0) entered disabled state
[  793.565853][   T71] bond0: (slave eth0): link status definitely down, disabling slave
[  793.566429][   T71] bond0: (slave eth1): making interface the new active one
[  795.963785][ T5229] br0: port 1(eth0) entered blocking state
[  795.964144][ T5229] br0: port 1(eth0) entered forwarding state
[  796.061369][   T71] bond0: (slave eth0): link status up, enabling it in 200 ms
[  796.061883][   T71] bond0: (slave eth0): invalid new link 3 on slave
[  796.271026][   T71] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  796.290401][ T5345] br0: port 2(eth1) entered disabled state
[  796.373726][   T71] bond0: (slave eth1): link status definitely down, disabling slave
[  796.374199][   T71] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  798.066428][ T5348] bond0 (unregistering): (slave eth0): Releasing backup interface
[  798.081616][ T5348] bond0 (unregistering): (slave eth1): Releasing backup interface
[  798.089153][ T5348] bond0 (unregistering): Released all slaves
[  798.101873][   T33] br0: port 1(eth0) entered disabled state
[  800.296143][ T5355] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  800.297271][ T2558] br0: port 1(eth0) entered blocking state
[  800.297613][ T2558] br0: port 1(eth0) entered forwarding state
[  800.640755][ T5356] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  800.651463][   T33] br0: port 2(eth1) entered blocking state
[  800.651887][   T33] br0: port 2(eth1) entered forwarding state
[  800.988802][   T71] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  800.989331][   T71] bond0: (slave eth0): making interface the new active one
[  800.990198][   T71] bond0: active interface up!
[  801.405704][   T71] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  803.127992][ T5361] br0: port 1(eth0) entered disabled state
[  803.173785][   T71] bond0: (slave eth0): link status definitely down, disabling slave
[  803.174261][   T71] bond0: (slave eth1): making interface the new active one
[  805.688071][ T2674] br0: port 1(eth0) entered blocking state
[  805.688609][ T2674] br0: port 1(eth0) entered forwarding state
[  805.773403][   T71] bond0: (slave eth0): link status up, enabling it in 500 ms
[  805.774191][   T71] bond0: (slave eth0): invalid new link 3 on slave
[  806.053075][ T5364] br0: port 2(eth1) entered disabled state
[  806.085825][   T71] bond0: (slave eth1): link status definitely down, disabling slave
[  806.086342][   T71] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  807.885999][ T5367] bond0 (unregistering): (slave eth0): Releasing backup interface
[  807.903658][ T5367] bond0 (unregistering): (slave eth1): Releasing backup interface
[  807.914253][ T5367] bond0 (unregistering): Released all slaves
[  807.928825][ T2674] br0: port 1(eth0) entered disabled state
[  810.387381][ T5374] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  810.388426][ T2674] br0: port 1(eth0) entered blocking state
[  810.388900][ T2674] br0: port 1(eth0) entered forwarding state
[  810.797561][ T5375] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  810.799298][ T2558] br0: port 2(eth1) entered blocking state
[  810.799788][ T2558] br0: port 2(eth1) entered forwarding state
[  811.151946][   T71] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  811.152499][   T71] bond0: (slave eth0): making interface the new active one
[  811.153413][   T71] bond0: active interface up!
[  812.093752][  T254] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  813.266590][ T5380] br0: port 1(eth0) entered disabled state
[  813.342752][  T254] bond0: (slave eth0): link status definitely down, disabling slave
[  813.343237][  T254] bond0: (slave eth1): making interface the new active one
[  815.782006][ T2674] br0: port 1(eth0) entered blocking state
[  815.782556][ T2674] br0: port 1(eth0) entered forwarding state
[  815.837397][  T254] bond0: (slave eth0): link status up, enabling it in 1000 ms
[  815.837979][  T254] bond0: (slave eth0): invalid new link 3 on slave
[  816.174629][ T5383] br0: port 2(eth1) entered disabled state
[  816.253901][  T254] bond0: (slave eth1): link status definitely down, disabling slave
[  816.254552][  T254] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  818.058727][ T5386] bond0 (unregistering): (slave eth0): Releasing backup interface
[  818.073894][ T5386] bond0 (unregistering): (slave eth1): Releasing backup interface
[  818.085807][ T5386] bond0 (unregistering): Released all slaves
[  818.119947][   T33] br0: port 1(eth0) entered disabled state
[  820.201844][ T5393] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  820.202884][ T5229] br0: port 1(eth0) entered blocking state
[  820.203375][ T5229] br0: port 1(eth0) entered forwarding state
[  820.543757][ T5394] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  820.546020][ T2558] br0: port 2(eth1) entered blocking state
[  820.546365][ T2558] br0: port 2(eth1) entered forwarding state
[  820.885900][  T254] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  820.886455][  T254] bond0: (slave eth0): making interface the new active one
[  820.887431][  T254] bond0: active interface up!
[  822.861622][   T71] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  823.023218][ T5399] br0: port 1(eth0) entered disabled state
[  823.069795][   T71] bond0: (slave eth0): link status definitely down, disabling slave
[  823.070263][   T71] bond0: (slave eth1): making interface the new active one
[  825.453855][ T2674] br0: port 1(eth0) entered blocking state
[  825.454235][ T2674] br0: port 1(eth0) entered forwarding state
[  825.461349][   T71] bond0: (slave eth0): link status up, enabling it in 2000 ms
[  825.461860][   T71] bond0: (slave eth0): invalid new link 3 on slave
[  825.794165][ T5402] br0: port 2(eth1) entered disabled state
[  825.882434][   T71] bond0: (slave eth1): link status definitely down, disabling slave
[  825.882962][   T71] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  827.599719][ T5405] bond0 (unregistering): (slave eth0): Releasing backup interface
[  827.618131][ T5405] bond0 (unregistering): (slave eth1): Releasing backup interface
[  827.630579][ T5405] bond0 (unregistering): Released all slaves
[  827.646995][ T2558] br0: port 1(eth0) entered disabled state
[  829.714061][ T5412] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  829.715488][ T2558] br0: port 1(eth0) entered blocking state
[  829.715908][ T2558] br0: port 1(eth0) entered forwarding state
[  830.034511][ T5413] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  830.036009][   T33] br0: port 2(eth1) entered blocking state
[  830.036376][   T33] br0: port 2(eth1) entered forwarding state
[  830.431816][   T71] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  830.432366][   T71] bond0: (slave eth0): making interface the new active one
[  830.433314][   T71] bond0: active interface up!
[  832.549844][ T5419] br0: port 1(eth0) entered disabled state
[  832.621817][   T71] bond0: (slave eth0): link status definitely down, disabling slave
[  832.622365][   T71] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  835.027032][   T33] br0: port 1(eth0) entered blocking state
[  835.027543][   T33] br0: port 1(eth0) entered forwarding state
[  835.117379][   T71] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  835.117891][   T71] bond0: (slave eth0): invalid new link 3 on slave
[  835.329145][ T5422] br0: port 2(eth1) entered disabled state
[  835.429770][   T71] bond0: (slave eth1): link status definitely down, disabling slave
[  835.430284][   T71] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  837.103066][ T5425] bond0 (unregistering): (slave eth0): Releasing backup interface
[  837.116817][ T5425] bond0 (unregistering): (slave eth1): Releasing backup interface
[  837.124640][ T5425] bond0 (unregistering): Released all slaves
[  837.154791][ T2558] br0: port 1(eth0) entered disabled state
[  839.048683][ T5432] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  839.051929][ T5229] br0: port 1(eth0) entered blocking state
[  839.052260][ T5229] br0: port 1(eth0) entered forwarding state
[  839.376542][ T5433] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  839.383369][   T33] br0: port 2(eth1) entered blocking state
[  839.383732][   T33] br0: port 2(eth1) entered forwarding state
[  839.743004][   T71] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  839.743551][   T71] bond0: (slave eth0): making interface the new active one
[  839.744487][   T71] bond0: active interface up!
[  841.884103][ T5438] br0: port 1(eth0) entered disabled state
[  841.926899][ T5415] bond0: (slave eth0): link status definitely down, disabling slave
[  841.927403][ T5415] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  844.334813][   T33] br0: port 1(eth0) entered blocking state
[  844.335182][   T33] br0: port 1(eth0) entered forwarding state
[  844.429449][ T5415] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  844.430027][ T5415] bond0: (slave eth0): invalid new link 3 on slave
[  844.654220][ T5441] br0: port 2(eth1) entered disabled state
[  844.743013][ T5415] bond0: (slave eth1): link status definitely down, disabling slave
[  844.743698][ T5415] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  846.507230][ T5444] bond0 (unregistering): (slave eth0): Releasing backup interface
[  846.527371][ T5444] bond0 (unregistering): (slave eth1): Releasing backup interface
[  846.537420][ T5444] bond0 (unregistering): Released all slaves
[  846.558765][ T2558] br0: port 1(eth0) entered disabled state
[  847.380032][ T5415] eth1: left allmulticast mode
[  847.380406][ T5415] eth1: left promiscuous mode
[  847.380840][ T5415] br0: port 2(eth1) entered disabled state
[  847.382562][ T5415] eth0: left allmulticast mode
[  847.382840][ T5415] eth0: left promiscuous mode
[  847.383217][ T5415] 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__->