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.882439][ T5212] eth0: renamed from lag1
[  778.045167][ T5217] eth0: renamed from lag1-end
[  778.442169][ T5225] eth1: renamed from lag1
[  778.594280][ T5229] eth1: renamed from lag1-end
[  779.375227][ T5231] br0: port 1(eth0) entered blocking state
[  779.376244][ T5231] br0: port 1(eth0) entered disabled state
[  779.376656][ T5231] eth0: entered allmulticast mode
[  779.378261][ T5231] eth0: entered promiscuous mode
[  779.724395][ T5232] br0: port 2(eth1) entered blocking state
[  779.724771][ T5232] br0: port 2(eth1) entered disabled state
[  779.725112][ T5232] eth1: entered allmulticast mode
[  779.726423][ T5232] eth1: entered promiscuous mode
[  781.642732][ T5238] bond0: (slave eth0): making interface the new active one
[  781.643462][ T5238] bond0: (slave eth0): Enslaving as an active interface with an up link
[  781.644861][ T2633] br0: port 1(eth0) entered blocking state
[  781.645180][ T2633] br0: port 1(eth0) entered forwarding state
[  782.019674][ T5239] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  782.020778][ T5150] br0: port 2(eth1) entered blocking state
[  782.021092][ T5150] br0: port 2(eth1) entered forwarding state
[  784.597232][ T5244] br0: port 1(eth0) entered disabled state
[  784.606775][ T3175] bond0: (slave eth0): link status definitely down, disabling slave
[  784.607608][ T3175] bond0: (slave eth1): making interface the new active one
[  787.164196][   T47] br0: port 1(eth0) entered blocking state
[  787.164587][   T47] br0: port 1(eth0) entered forwarding state
[  787.214845][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  787.544362][ T5247] br0: port 2(eth1) entered disabled state
[  787.631091][ T3175] bond0: (slave eth1): link status definitely down, disabling slave
[  787.631626][ T3175] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  789.428492][ T5250] bond0 (unregistering): (slave eth0): Releasing backup interface
[  789.452645][ T5250] bond0 (unregistering): (slave eth1): Releasing backup interface
[  789.460092][ T5250] bond0 (unregistering): Released all slaves
[  789.486198][ T5147] br0: port 1(eth0) entered disabled state
[  791.725079][ T5257] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  791.726741][ T5147] br0: port 1(eth0) entered blocking state
[  791.727066][ T5147] br0: port 1(eth0) entered forwarding state
[  792.110574][ T5258] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  792.111786][ T5147] br0: port 2(eth1) entered blocking state
[  792.112119][ T5147] br0: port 2(eth1) entered forwarding state
[  792.523101][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  792.523644][ T3175] bond0: (slave eth0): making interface the new active one
[  792.524598][ T3175] bond0: active interface up!
[  792.629978][ T3175] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  794.658271][ T5263] br0: port 1(eth0) entered disabled state
[  794.710169][ T3175] bond0: (slave eth0): link status definitely down, disabling slave
[  794.710858][ T3175] bond0: (slave eth1): making interface the new active one
[  797.155180][   T45] br0: port 1(eth0) entered blocking state
[  797.155573][   T45] br0: port 1(eth0) entered forwarding state
[  797.213594][ T3175] bond0: (slave eth0): link status up, enabling it in 200 ms
[  797.214357][ T3175] bond0: (slave eth0): invalid new link 3 on slave
[  797.421971][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  797.507110][ T5266] br0: port 2(eth1) entered disabled state
[  797.526163][ T3175] bond0: (slave eth1): link status definitely down, disabling slave
[  797.526914][ T3175] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  799.338469][ T5269] bond0 (unregistering): (slave eth0): Releasing backup interface
[  799.361155][ T5269] bond0 (unregistering): (slave eth1): Releasing backup interface
[  799.372113][ T5269] bond0 (unregistering): Released all slaves
[  799.397294][ T5147] br0: port 1(eth0) entered disabled state
[  801.599288][ T5276] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  801.600027][   T47] br0: port 1(eth0) entered blocking state
[  801.600341][   T47] br0: port 1(eth0) entered forwarding state
[  801.969821][ T5277] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  801.971172][   T45] br0: port 2(eth1) entered blocking state
[  801.971543][   T45] br0: port 2(eth1) entered forwarding state
[  802.296322][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  802.297118][ T3175] bond0: (slave eth0): making interface the new active one
[  802.298633][ T3175] bond0: active interface up!
[  802.717852][ T3175] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  804.554028][ T5283] br0: port 1(eth0) entered disabled state
[  804.590016][ T3175] bond0: (slave eth0): link status definitely down, disabling slave
[  804.590695][ T3175] bond0: (slave eth1): making interface the new active one
[  807.028392][   T47] br0: port 1(eth0) entered blocking state
[  807.028777][   T47] br0: port 1(eth0) entered forwarding state
[  807.085574][ T3175] bond0: (slave eth0): link status up, enabling it in 500 ms
[  807.086096][ T3175] bond0: (slave eth0): invalid new link 3 on slave
[  807.378219][ T5286] br0: port 2(eth1) entered disabled state
[  807.398150][ T3175] bond0: (slave eth1): link status definitely down, disabling slave
[  807.398863][ T3175] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  809.215381][ T5289] bond0 (unregistering): (slave eth0): Releasing backup interface
[  809.229026][ T5289] bond0 (unregistering): (slave eth1): Releasing backup interface
[  809.245603][ T5289] bond0 (unregistering): Released all slaves
[  809.258726][ T5150] br0: port 1(eth0) entered disabled state
[  811.485743][ T5296] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  811.486490][   T45] br0: port 1(eth0) entered blocking state
[  811.486946][   T45] br0: port 1(eth0) entered forwarding state
[  811.866924][ T5297] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  811.869177][   T45] br0: port 2(eth1) entered blocking state
[  811.869748][   T45] br0: port 2(eth1) entered forwarding state
[  812.216388][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  812.217302][ T3175] bond0: (slave eth0): making interface the new active one
[  812.225391][ T3175] bond0: active interface up!
[  813.165955][ T3175] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  814.361164][ T5302] br0: port 1(eth0) entered disabled state
[  814.415203][ T3175] bond0: (slave eth0): link status definitely down, disabling slave
[  814.415894][ T3175] bond0: (slave eth1): making interface the new active one
[  816.845373][ T5150] br0: port 1(eth0) entered blocking state
[  816.845765][ T5150] br0: port 1(eth0) entered forwarding state
[  816.917621][ T3175] bond0: (slave eth0): link status up, enabling it in 1000 ms
[  816.918423][ T3175] bond0: (slave eth0): invalid new link 3 on slave
[  817.177333][ T5305] br0: port 2(eth1) entered disabled state
[  817.230990][ T3175] bond0: (slave eth1): link status definitely down, disabling slave
[  817.231603][ T3175] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  819.101326][ T5308] bond0 (unregistering): (slave eth0): Releasing backup interface
[  819.121333][ T5308] bond0 (unregistering): (slave eth1): Releasing backup interface
[  819.132572][ T5308] bond0 (unregistering): Released all slaves
[  819.145804][ T5150] br0: port 1(eth0) entered disabled state
[  821.165438][ T5315] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  821.166433][ T2357] br0: port 1(eth0) entered blocking state
[  821.166917][ T2357] br0: port 1(eth0) entered forwarding state
[  821.479114][ T5316] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  821.483180][ T5001] br0: port 2(eth1) entered blocking state
[  821.483526][ T5001] br0: port 2(eth1) entered forwarding state
[  821.815039][ T3175] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  821.815583][ T3175] bond0: (slave eth0): making interface the new active one
[  821.816532][ T3175] bond0: active interface up!
[  823.789792][ T3175] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  824.097392][ T5321] br0: port 1(eth0) entered disabled state
[  824.101934][ T3175] bond0: (slave eth0): link status definitely down, disabling slave
[  824.102375][ T3175] bond0: (slave eth1): making interface the new active one
[  826.577847][ T5147] br0: port 1(eth0) entered blocking state
[  826.578365][ T5147] br0: port 1(eth0) entered forwarding state
[  826.598613][ T3175] bond0: (slave eth0): link status up, enabling it in 2000 ms
[  826.599388][ T3175] bond0: (slave eth0): invalid new link 3 on slave
[  826.948870][ T5324] br0: port 2(eth1) entered disabled state
[  827.014053][ T3175] bond0: (slave eth1): link status definitely down, disabling slave
[  827.014708][ T3175] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  828.719951][ T5327] bond0 (unregistering): (slave eth0): Releasing backup interface
[  828.731258][ T5327] bond0 (unregistering): (slave eth1): Releasing backup interface
[  828.747113][ T5327] bond0 (unregistering): Released all slaves
[  828.761226][ T5147] br0: port 1(eth0) entered disabled state
[  830.707462][ T5334] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  830.710760][ T2357] br0: port 1(eth0) entered blocking state
[  830.711098][ T2357] br0: port 1(eth0) entered forwarding state
[  831.057296][ T5335] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  831.058433][ T5147] br0: port 2(eth1) entered blocking state
[  831.058768][ T5147] br0: port 2(eth1) entered forwarding state
[  831.407201][   T70] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  831.407775][   T70] bond0: (slave eth0): making interface the new active one
[  831.414718][   T70] bond0: active interface up!
[  833.615394][ T5340] br0: port 1(eth0) entered disabled state
[  833.702022][   T70] bond0: (slave eth0): link status definitely down, disabling slave
[  833.702544][   T70] bond0: (slave eth1): making interface the new active one 2400 ms earlier
[  836.065455][ T5147] br0: port 1(eth0) entered blocking state
[  836.065840][ T5147] br0: port 1(eth0) entered forwarding state
[  836.093577][   T70] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  836.094117][   T70] bond0: (slave eth0): invalid new link 3 on slave
[  836.404914][ T5343] br0: port 2(eth1) entered disabled state
[  836.406040][   T70] bond0: (slave eth1): link status definitely down, disabling slave
[  836.406465][   T70] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  838.235672][ T5346] bond0 (unregistering): (slave eth0): Releasing backup interface
[  838.252075][ T5346] bond0 (unregistering): (slave eth1): Releasing backup interface
[  838.259616][ T5346] bond0 (unregistering): Released all slaves
[  838.273107][ T5147] br0: port 1(eth0) entered disabled state
[  840.301159][ T5353] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  840.310033][ T2357] br0: port 1(eth0) entered blocking state
[  840.310400][ T2357] br0: port 1(eth0) entered forwarding state
[  840.675130][ T5354] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  840.676807][ T5147] br0: port 2(eth1) entered blocking state
[  840.677190][ T5147] br0: port 2(eth1) entered forwarding state
[  841.004462][   T70] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  841.005236][   T70] bond0: (slave eth0): making interface the new active one
[  841.006708][   T70] bond0: active interface up!
[  843.165610][ T5359] br0: port 1(eth0) entered disabled state
[  843.190075][   T70] bond0: (slave eth0): link status definitely down, disabling slave
[  843.190570][   T70] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  845.652723][ T2357] br0: port 1(eth0) entered blocking state
[  845.653171][ T2357] br0: port 1(eth0) entered forwarding state
[  845.685589][   T70] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  845.686330][   T70] bond0: (slave eth0): invalid new link 3 on slave
[  845.959290][ T5362] br0: port 2(eth1) entered disabled state
[  845.998115][   T70] bond0: (slave eth1): link status definitely down, disabling slave
[  845.998804][   T70] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  847.829468][ T5365] bond0 (unregistering): (slave eth0): Releasing backup interface
[  847.841883][ T5365] bond0 (unregistering): (slave eth1): Releasing backup interface
[  847.853459][ T5365] bond0 (unregistering): Released all slaves
[  847.873478][ T5147] br0: port 1(eth0) entered disabled state
[  848.706111][   T70] eth1: left allmulticast mode
[  848.706625][   T70] eth1: left promiscuous mode
[  848.707253][   T70] br0: port 2(eth1) entered disabled state
[  848.709919][   T70] eth0: left allmulticast mode
[  848.710312][   T70] eth0: left promiscuous mode
[  848.710982][   T70] 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__->