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
[  846.585724][ T6229] eth0: renamed from lag1
[  846.738422][ T6234] eth0: renamed from lag1-end
[  847.087315][ T6243] eth1: renamed from lag1
[  847.283113][ T6246] eth1: renamed from lag1-end
[  847.960486][ T6248] br0: port 1(eth0) entered blocking state
[  847.960886][ T6248] br0: port 1(eth0) entered disabled state
[  847.961238][ T6248] eth0: entered allmulticast mode
[  847.962734][ T6248] eth0: entered promiscuous mode
[  848.290764][ T6249] br0: port 2(eth1) entered blocking state
[  848.291114][ T6249] br0: port 2(eth1) entered disabled state
[  848.291461][ T6249] eth1: entered allmulticast mode
[  848.292861][ T6249] eth1: entered promiscuous mode
[  850.080576][ T6255] bond0: (slave eth0): making interface the new active one
[  850.082122][ T6255] bond0: (slave eth0): Enslaving as an active interface with an up link
[  850.084450][ T5504] br0: port 1(eth0) entered blocking state
[  850.084816][ T5504] br0: port 1(eth0) entered forwarding state
[  850.402275][ T6256] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  850.403494][  T187] br0: port 2(eth1) entered blocking state
[  850.403858][  T187] br0: port 2(eth1) entered forwarding state
[  852.886782][ T6261] br0: port 1(eth0) entered disabled state
[  852.904396][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  852.904935][   T72] bond0: (slave eth1): making interface the new active one
[  855.375434][ T5504] br0: port 1(eth0) entered blocking state
[  855.375815][ T5504] br0: port 1(eth0) entered forwarding state
[  855.406878][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  855.700895][ T6264] br0: port 2(eth1) entered disabled state
[  855.719051][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  855.719535][   T72] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  857.472128][ T6267] bond0 (unregistering): (slave eth0): Releasing backup interface
[  857.483257][ T6267] bond0 (unregistering): (slave eth1): Releasing backup interface
[  857.494518][ T6267] bond0 (unregistering): Released all slaves
[  857.512539][ T5925] br0: port 1(eth0) entered disabled state
[  859.400144][ T6274] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  859.400869][ T5929] br0: port 1(eth0) entered blocking state
[  859.401183][ T5929] br0: port 1(eth0) entered forwarding state
[  859.708543][ T6275] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  859.713061][ T5504] br0: port 2(eth1) entered blocking state
[  859.713406][ T5504] br0: port 2(eth1) entered forwarding state
[  860.093071][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  860.093602][   T72] bond0: (slave eth0): making interface the new active one
[  860.094530][   T72] bond0: active interface up!
[  860.199015][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  862.206885][ T6280] br0: port 1(eth0) entered disabled state
[  862.279072][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  862.279528][   T72] bond0: (slave eth1): making interface the new active one
[  864.640135][ T5925] br0: port 1(eth0) entered blocking state
[  864.640499][ T5925] br0: port 1(eth0) entered forwarding state
[  864.670662][   T72] bond0: (slave eth0): link status up, enabling it in 200 ms
[  864.671181][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  864.879125][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  864.967656][ T6283] br0: port 2(eth1) entered disabled state
[  864.983244][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  864.984014][   T72] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[  866.753377][ T6286] bond0 (unregistering): (slave eth0): Releasing backup interface
[  866.765229][ T6286] bond0 (unregistering): (slave eth1): Releasing backup interface
[  866.776493][ T6286] bond0 (unregistering): Released all slaves
[  866.794928][ T5925] br0: port 1(eth0) entered disabled state
[  868.677466][ T6293] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  868.678703][ T5925] br0: port 1(eth0) entered blocking state
[  868.679023][ T5925] br0: port 1(eth0) entered forwarding state
[  869.003147][ T6294] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  869.007555][ T5925] br0: port 2(eth1) entered blocking state
[  869.007936][ T5925] br0: port 2(eth1) entered forwarding state
[  869.318132][   T72] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  869.318688][   T72] bond0: (slave eth0): making interface the new active one
[  869.319713][   T72] bond0: active interface up!
[  869.736207][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  871.362222][ T6299] br0: port 1(eth0) entered disabled state
[  871.400073][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  871.400555][   T72] bond0: (slave eth1): making interface the new active one
[  873.790677][   T72] bond0: (slave eth0): link status up, enabling it in 500 ms
[  873.791803][ T5925] br0: port 1(eth0) entered blocking state
[  873.792205][ T5925] br0: port 1(eth0) entered forwarding state
[  873.793646][   T72] bond0: (slave eth0): link status up, enabling it in 500 ms
[  873.794063][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  874.111526][ T6302] br0: port 2(eth1) entered disabled state
[  874.207221][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  874.207944][   T72] bond0: (slave eth0): making interface the new active one 500 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  875.927829][ T6305] bond0 (unregistering): (slave eth0): Releasing backup interface
[  875.938148][ T6305] bond0 (unregistering): (slave eth1): Releasing backup interface
[  875.949570][ T6305] bond0 (unregistering): Released all slaves
[  875.967323][ T3434] br0: port 1(eth0) entered disabled state
[  877.995333][ T6312] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  877.998639][ T5929] br0: port 1(eth0) entered blocking state
[  877.998968][ T5929] br0: port 1(eth0) entered forwarding state
[  878.323454][ T6313] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  878.324957][ T5504] br0: port 2(eth1) entered blocking state
[  878.325294][ T5504] br0: port 2(eth1) entered forwarding state
[  878.631116][ T5916] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  878.631680][ T5916] bond0: (slave eth0): making interface the new active one
[  878.632737][ T5916] bond0: active interface up!
[  879.566958][ T5916] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  880.705972][ T6318] br0: port 1(eth0) entered disabled state
[  880.711195][ T5916] bond0: (slave eth0): link status definitely down, disabling slave
[  880.711918][ T5916] bond0: (slave eth1): making interface the new active one
[  883.125918][ T3434] br0: port 1(eth0) entered blocking state
[  883.126300][ T3434] br0: port 1(eth0) entered forwarding state
[  883.206670][ T5916] bond0: (slave eth0): link status up, enabling it in 1000 ms
[  883.207208][ T5916] bond0: (slave eth0): invalid new link 3 on slave
[  883.426928][ T6321] br0: port 2(eth1) entered disabled state
[  883.520056][ T5916] bond0: (slave eth1): link status definitely down, disabling slave
[  883.520551][ T5916] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  885.171790][ T6324] bond0 (unregistering): (slave eth0): Releasing backup interface
[  885.190321][ T6324] bond0 (unregistering): (slave eth1): Releasing backup interface
[  885.200515][ T6324] bond0 (unregistering): Released all slaves
[  885.212373][ T3434] br0: port 1(eth0) entered disabled state
[  887.180655][ T6331] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  887.182342][ T5929] br0: port 1(eth0) entered blocking state
[  887.182679][ T5929] br0: port 1(eth0) entered forwarding state
[  887.505071][ T6332] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  887.507312][ T5925] br0: port 2(eth1) entered blocking state
[  887.507653][ T5925] br0: port 2(eth1) entered forwarding state
[  887.828109][ T5916] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  887.828686][ T5916] bond0: (slave eth0): making interface the new active one
[  887.829640][ T5916] bond0: active interface up!
[  889.806889][   T72] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[  889.892595][ T6337] br0: port 1(eth0) entered disabled state
[  889.911050][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  889.911521][   T72] bond0: (slave eth1): making interface the new active one
[  892.305188][ T5504] br0: port 1(eth0) entered blocking state
[  892.305582][ T5504] br0: port 1(eth0) entered forwarding state
[  892.406688][   T72] bond0: (slave eth0): link status up, enabling it in 2000 ms
[  892.407420][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  892.607102][ T6340] br0: port 2(eth1) entered disabled state
[  892.615129][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  892.615633][   T72] bond0: (slave eth0): making interface the new active one 300 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  894.387018][ T6343] bond0 (unregistering): (slave eth0): Releasing backup interface
[  894.396890][ T6343] bond0 (unregistering): (slave eth1): Releasing backup interface
[  894.407557][ T6343] bond0 (unregistering): Released all slaves
[  894.426002][ T5504] br0: port 1(eth0) entered disabled state
[  896.336942][ T6350] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  896.338290][ T5504] br0: port 1(eth0) entered blocking state
[  896.338636][ T5504] br0: port 1(eth0) entered forwarding state
[  896.670291][ T6351] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  896.671651][ T5925] br0: port 2(eth1) entered blocking state
[  896.671979][ T5925] br0: port 2(eth1) entered forwarding state
[  896.998358][ T5916] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  896.999165][ T5916] bond0: (slave eth0): making interface the new active one
[  897.000677][ T5916] bond0: active interface up!
[  899.058124][ T6356] br0: port 1(eth0) entered disabled state
[  899.079077][ T5916] bond0: (slave eth0): link status definitely down, disabling slave
[  899.079644][ T5916] bond0: (slave eth1): making interface the new active one 2600 ms earlier
[  901.478223][ T3434] br0: port 1(eth0) entered blocking state
[  901.478598][ T3434] br0: port 1(eth0) entered forwarding state
[  901.574687][ T5916] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  901.575216][ T5916] bond0: (slave eth0): invalid new link 3 on slave
[  901.799990][ T6359] br0: port 2(eth1) entered disabled state
[  901.887356][ T5916] bond0: (slave eth1): link status definitely down, disabling slave
[  901.887831][ T5916] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  903.561446][ T6362] bond0 (unregistering): (slave eth0): Releasing backup interface
[  903.570451][ T6362] bond0 (unregistering): (slave eth1): Releasing backup interface
[  903.588082][ T6362] bond0 (unregistering): Released all slaves
[  903.599794][ T5504] br0: port 1(eth0) entered disabled state
[  905.536553][ T6369] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  905.540501][ T3434] br0: port 1(eth0) entered blocking state
[  905.540848][ T3434] br0: port 1(eth0) entered forwarding state
[  905.855481][ T6370] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  905.857178][ T5929] br0: port 2(eth1) entered blocking state
[  905.857502][ T5929] br0: port 2(eth1) entered forwarding state
[  906.168284][ T5916] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  906.169066][ T5916] bond0: (slave eth0): making interface the new active one
[  906.170601][ T5916] bond0: active interface up!
[  908.315985][ T6375] br0: port 1(eth0) entered disabled state
[  908.359042][   T72] bond0: (slave eth0): link status definitely down, disabling slave
[  908.359521][   T72] bond0: (slave eth1): making interface the new active one 2300 ms earlier
[  910.776877][ T5504] br0: port 1(eth0) entered blocking state
[  910.777449][ T5504] br0: port 1(eth0) entered forwarding state
[  910.854692][   T72] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  910.855238][   T72] bond0: (slave eth0): invalid new link 3 on slave
[  911.072390][ T6378] br0: port 2(eth1) entered disabled state
[  911.167088][   T72] bond0: (slave eth1): link status definitely down, disabling slave
[  911.167588][   T72] bond0: (slave eth0): making interface the new active one 400 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  912.835931][ T6381] bond0 (unregistering): (slave eth0): Releasing backup interface
[  912.846222][ T6381] bond0 (unregistering): (slave eth1): Releasing backup interface
[  912.857565][ T6381] bond0 (unregistering): Released all slaves
[  912.875094][ T6008] br0: port 1(eth0) entered disabled state
[  913.732558][   T72] eth1: left allmulticast mode
[  913.732923][   T72] eth1: left promiscuous mode
[  913.733356][   T72] br0: port 2(eth1) entered disabled state
[  913.735136][   T72] eth0: left allmulticast mode
[  913.735421][   T72] eth0: left promiscuous mode
[  913.735877][   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__->