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.0
# selftests: drivers/net/bonding: mode-1-recovery-updelay.sh
[  777.181042][ T5255] eth0: renamed from lag1
[  777.419316][ T5260] eth0: renamed from lag1-end
[  777.840621][ T5268] eth1: renamed from lag1
[  778.091983][ T5271] eth1: renamed from lag1-end
[  778.869343][ T5273] br0: port 1(eth0) entered blocking state
[  778.869843][ T5273] br0: port 1(eth0) entered disabled state
[  778.871019][ T5273] eth0: entered allmulticast mode
[  778.873303][ T5273] eth0: entered promiscuous mode
[  779.273104][ T5274] br0: port 2(eth1) entered blocking state
[  779.273496][ T5274] br0: port 2(eth1) entered disabled state
[  779.273954][ T5274] eth1: entered allmulticast mode
[  779.275506][ T5274] eth1: entered promiscuous mode
[  781.044359][ T5280] bond0: (slave eth0): making interface the new active one
[  781.045207][ T5280] bond0: (slave eth0): Enslaving as an active interface with an up link
[  781.046440][ T3204] br0: port 1(eth0) entered blocking state
[  781.046788][ T3204] br0: port 1(eth0) entered forwarding state
[  781.447814][ T5281] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  781.453041][ T3204] br0: port 2(eth1) entered blocking state
[  781.453511][ T3204] br0: port 2(eth1) entered forwarding state
[  784.066174][ T5286] br0: port 1(eth0) entered disabled state
[  784.138131][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  784.138720][   T72] bond0: (slave eth1): making interface the new active one
[  786.552550][ T3204] br0: port 1(eth0) entered blocking state
[  786.552959][ T3204] br0: port 1(eth0) entered forwarding state
[  786.633348][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  786.972017][ T5289] br0: port 2(eth1) entered disabled state
[  787.049555][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  787.050272][   T72] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  788.871875][ T5292] bond0 (unregistering): (slave eth0): Releasing backup interface
[  788.882157][ T5292] bond0 (unregistering): (slave eth1): Releasing backup interface
[  788.899311][ T5292] bond0 (unregistering): Released all slaves
[  788.919272][  T262] br0: port 1(eth0) entered disabled state
[  791.221779][ T5299] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  791.223143][  T262] br0: port 1(eth0) entered blocking state
[  791.223466][  T262] br0: port 1(eth0) entered forwarding state
[  791.560745][ T5300] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  791.561946][ T2768] br0: port 2(eth1) entered blocking state
[  791.562283][ T2768] br0: port 2(eth1) entered forwarding state
[  791.880595][ T4942] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  791.881385][ T4942] bond0: (slave eth0): making interface the new active one
[  791.883874][ T4942] bond0: active interface up!
[  791.985358][ T4942] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  794.037440][ T5305] br0: port 1(eth0) entered disabled state
[  794.066598][ T4942] bond0: (slave eth0): link status definitely down, disabling slave
[  794.067305][ T4942] bond0: (slave eth1): making interface the new active one
[  796.543676][  T262] br0: port 1(eth0) entered blocking state
[  796.544231][  T262] br0: port 1(eth0) entered forwarding state
[  796.569007][ T4942] bond0: (slave eth0): link status up, enabling it in 200 ms
[  796.569773][ T4942] bond0: (slave eth0): invalid new link 3 on slave
[  796.777224][ T4942] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  796.883818][ T5309] br0: port 2(eth1) entered disabled state
[  796.985563][ T4942] bond0: (slave eth1): link status definitely down, disabling slave
[  796.986325][ T4942] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  798.706572][ T5312] bond0 (unregistering): (slave eth0): Releasing backup interface
[  798.719086][ T5312] bond0 (unregistering): (slave eth1): Releasing backup interface
[  798.735828][ T5312] bond0 (unregistering): Released all slaves
[  798.750126][ T2768] br0: port 1(eth0) entered disabled state
[  800.882038][ T5319] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  800.885169][ T2768] br0: port 1(eth0) entered blocking state
[  800.885501][ T2768] br0: port 1(eth0) entered forwarding state
[  801.213423][ T5320] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  801.215445][  T262] br0: port 2(eth1) entered blocking state
[  801.215957][  T262] br0: port 2(eth1) entered forwarding state
[  801.529952][ T4942] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  801.530726][ T4942] bond0: (slave eth0): making interface the new active one
[  801.532153][ T4942] bond0: active interface up!
[  801.945256][ T4942] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  803.717145][ T5325] br0: port 1(eth0) entered disabled state
[  803.817441][ T4942] bond0: (slave eth0): link status definitely down, disabling slave
[  803.818095][ T4942] bond0: (slave eth1): making interface the new active one
[  806.244448][  T262] br0: port 1(eth0) entered blocking state
[  806.244826][  T262] br0: port 1(eth0) entered forwarding state
[  806.313995][ T4942] bond0: (slave eth0): link status up, enabling it in 500 ms
[  806.314797][ T4942] bond0: (slave eth0): invalid new link 3 on slave
[  806.591113][ T5328] br0: port 2(eth1) entered disabled state
[  806.625569][ T4942] bond0: (slave eth1): link status definitely down, disabling slave
[  806.626398][ T4942] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  808.436841][ T5331] bond0 (unregistering): (slave eth0): Releasing backup interface
[  808.452336][ T5331] bond0 (unregistering): (slave eth1): Releasing backup interface
[  808.462069][ T5331] bond0 (unregistering): Released all slaves
[  808.477052][   T48] br0: port 1(eth0) entered disabled state
[  810.633841][ T5338] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  810.634599][ T5306] br0: port 1(eth0) entered blocking state
[  810.634936][ T5306] br0: port 1(eth0) entered forwarding state
[  810.996587][ T5339] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  810.997788][ T5306] br0: port 2(eth1) entered blocking state
[  810.998134][ T5306] br0: port 2(eth1) entered forwarding state
[  811.378509][ T4942] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  811.379078][ T4942] bond0: (slave eth0): making interface the new active one
[  811.380024][ T4942] bond0: active interface up!
[  812.313289][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  813.598459][ T5344] br0: port 1(eth0) entered disabled state
[  813.666459][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  813.667025][   T72] bond0: (slave eth1): making interface the new active one
[  816.088450][ T5033] br0: port 1(eth0) entered blocking state
[  816.088844][ T5033] br0: port 1(eth0) entered forwarding state
[  816.168985][   T72] bond0: (slave eth0): link status up, enabling it in 1000 ms
[  816.169543][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  816.409779][ T5347] br0: port 2(eth1) entered disabled state
[  816.481427][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  816.482122][   T72] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  818.264399][ T5350] bond0 (unregistering): (slave eth0): Releasing backup interface
[  818.274668][ T5350] bond0 (unregistering): (slave eth1): Releasing backup interface
[  818.287294][ T5350] bond0 (unregistering): Released all slaves
[  818.318791][  T262] br0: port 1(eth0) entered disabled state
[  820.352344][ T5357] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  820.353129][ T5306] br0: port 1(eth0) entered blocking state
[  820.353465][ T5306] br0: port 1(eth0) entered forwarding state
[  820.667013][ T5358] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  820.670593][ T5306] br0: port 2(eth1) entered blocking state
[  820.670951][ T5306] br0: port 2(eth1) entered forwarding state
[  821.003778][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  821.004657][   T72] bond0: (slave eth0): making interface the new active one
[  821.013015][   T72] bond0: active interface up!
[  822.994401][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  823.270375][ T5363] br0: port 1(eth0) entered disabled state
[  823.305439][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  823.305988][   T72] bond0: (slave eth1): making interface the new active one
[  825.758668][ T2768] br0: port 1(eth0) entered blocking state
[  825.759194][ T2768] br0: port 1(eth0) entered forwarding state
[  825.800984][   T72] bond0: (slave eth0): link status up, enabling it in 2000 ms
[  825.801734][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  826.103596][ T5366] br0: port 2(eth1) entered disabled state
[  826.115692][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  826.116516][   T72] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  827.947727][ T5369] bond0 (unregistering): (slave eth0): Releasing backup interface
[  827.964220][ T5369] bond0 (unregistering): (slave eth1): Releasing backup interface
[  827.972132][ T5369] bond0 (unregistering): Released all slaves
[  827.990719][ T5306] br0: port 1(eth0) entered disabled state
[  830.071549][ T5376] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  830.072670][ T2768] br0: port 1(eth0) entered blocking state
[  830.073198][ T2768] br0: port 1(eth0) entered forwarding state
[  830.482107][ T5377] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  830.485628][ T5306] br0: port 2(eth1) entered blocking state
[  830.485989][ T5306] br0: port 2(eth1) entered forwarding state
[  830.856591][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  830.857388][   T72] bond0: (slave eth0): making interface the new active one
[  830.858691][   T72] bond0: active interface up!
[  832.973808][ T5382] br0: port 1(eth0) entered disabled state
[  833.041431][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  833.041906][   T72] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  835.429435][ T5306] br0: port 1(eth0) entered blocking state
[  835.429821][ T5306] br0: port 1(eth0) entered forwarding state
[  835.432993][   T72] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  835.433546][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  835.771508][ T5385] br0: port 2(eth1) entered disabled state
[  835.849380][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  835.849882][   T72] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  837.585233][ T5388] bond0 (unregistering): (slave eth0): Releasing backup interface
[  837.604125][ T5388] bond0 (unregistering): (slave eth1): Releasing backup interface
[  837.610873][ T5388] bond0 (unregistering): Released all slaves
[  837.624942][ T5306] br0: port 1(eth0) entered disabled state
[  839.820803][ T5395] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  839.821578][  T262] br0: port 1(eth0) entered blocking state
[  839.821907][  T262] br0: port 1(eth0) entered forwarding state
[  840.146942][ T5396] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  840.148857][ T5306] br0: port 2(eth1) entered blocking state
[  840.149209][ T5306] br0: port 2(eth1) entered forwarding state
[  840.518452][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  840.519007][   T72] bond0: (slave eth0): making interface the new active one
[  840.519906][   T72] bond0: active interface up!
[  842.694575][ T5401] br0: port 1(eth0) entered disabled state
[  842.705565][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  842.706076][   T72] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  845.189438][ T2768] br0: port 1(eth0) entered blocking state
[  845.189818][ T2768] br0: port 1(eth0) entered forwarding state
[  845.200976][   T72] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  845.201557][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  845.519826][ T5404] br0: port 2(eth1) entered disabled state
[  845.618354][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  845.619047][   T72] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  847.320417][ T5407] bond0 (unregistering): (slave eth0): Releasing backup interface
[  847.330203][ T5407] bond0 (unregistering): (slave eth1): Releasing backup interface
[  847.338986][ T5407] bond0 (unregistering): Released all slaves
[  847.360980][  T262] br0: port 1(eth0) entered disabled state
[  848.195088][   T72] eth1: left allmulticast mode
[  848.195535][   T72] eth1: left promiscuous mode
[  848.196191][   T72] br0: port 2(eth1) entered disabled state
[  848.198848][   T72] eth0: left allmulticast mode
[  848.199276][   T72] eth0: left promiscuous mode
[  848.199821][   T72] 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__->