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-9/tools/testing/selftests'
make[1]: Entering directory '/home/virtme/testing-9/tools/testing/selftests/drivers/net/bonding'
make[1]: Nothing to be done for 'all'.
make[1]: Leaving directory '/home/virtme/testing-9/tools/testing/selftests/drivers/net/bonding'
make[1]: Entering directory '/home/virtme/testing-9/tools/testing/selftests/drivers/net/bonding'
TAP version 13
1..1
# timeout set to 1200
# selftests: drivers/net/bonding: mode-1-recovery-updelay.sh
[   38.281713] eth0: renamed from lag1
[   38.317107] eth0: renamed from lag1-end
[   38.366893] eth1: renamed from lag1
[   38.398910] eth1: renamed from lag1-end
[   38.465989] br0: port 1(eth0) entered blocking state
[   38.466401] br0: port 1(eth0) entered disabled state
[   38.466785] eth0: entered allmulticast mode
[   38.467174] eth0: entered promiscuous mode
[   38.498867] br0: port 2(eth1) entered blocking state
[   38.499159] br0: port 2(eth1) entered disabled state
[   38.499416] eth1: entered allmulticast mode
[   38.499740] eth1: entered promiscuous mode
[   38.643806] bond0: (slave eth0): making interface the new active one
[   38.644194] bond0: (slave eth0): Enslaving as an active interface with an up link
[   38.644843] br0: port 1(eth0) entered blocking state
[   38.645107] br0: port 1(eth0) entered forwarding state
[   38.674344] bond0: (slave eth1): Enslaving as a backup interface with an up link
[   38.675318] br0: port 2(eth1) entered blocking state
[   38.675726] br0: port 2(eth1) entered forwarding state
[   39.828180] br0: port 1(eth0) entered disabled state
[   39.845896] bond0: (slave eth0): link status definitely down, disabling slave
[   39.846322] bond0: (slave eth1): making interface the new active one
[   41.859829] br0: port 1(eth0) entered blocking state
[   41.860119] br0: port 1(eth0) entered forwarding state
[   41.883469] br0: port 2(eth1) entered disabled state
[   41.925752] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[   41.926195] bond0: (slave eth1): link status definitely down, disabling slave
[   41.926555] bond0: (slave eth0): making interface the new active one
# TEST: mode (1) bond recovery                                        [ OK ]
[   52.969542] bond0 (unregistering): (slave eth0): Releasing backup interface
[   52.979018] bond0 (unregistering): (slave eth1): Releasing backup interface
[   52.984820] bond0 (unregistering): Released all slaves
[   52.985863] br0: port 1(eth0) entered disabled state
[   53.123568] bond0: (slave eth0): Enslaving as a backup interface with an up link
[   53.124233] br0: port 1(eth0) entered blocking state
[   53.124497] br0: port 1(eth0) entered forwarding state
[   53.147169] bond0: (slave eth1): Enslaving as a backup interface with an up link
[   53.147948] br0: port 2(eth1) entered blocking state
[   53.148212] br0: port 2(eth1) entered forwarding state
[   53.168867] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[   53.169526] bond0: (slave eth0): making interface the new active one
[   53.170231] bond0: active interface up!
[   53.381794] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[   54.293080] br0: port 1(eth0) entered disabled state
[   54.317758] bond0: (slave eth0): link status definitely down, disabling slave
[   54.318186] bond0: (slave eth1): making interface the new active one
[   56.324139] br0: port 1(eth0) entered blocking state
[   56.324430] br0: port 1(eth0) entered forwarding state
[   56.346679] br0: port 2(eth1) entered disabled state
[   56.397755] bond0: (slave eth0): link status up, enabling it in 200 ms
[   56.398148] bond0: (slave eth0): invalid new link 3 on slave
[   56.398479] bond0: (slave eth1): link status definitely down, disabling slave
[   56.398906] bond0: (slave eth0): making interface the new active one 100 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[   67.430817] bond0 (unregistering): (slave eth0): Releasing backup interface
[   67.443904] bond0 (unregistering): (slave eth1): Releasing backup interface
[   67.449804] bond0 (unregistering): Released all slaves
[   67.450611] br0: port 1(eth0) entered disabled state
[   67.581239] bond0: (slave eth0): Enslaving as a backup interface with an up link
[   67.581944] br0: port 1(eth0) entered blocking state
[   67.582207] br0: port 1(eth0) entered forwarding state
[   67.603992] bond0: (slave eth1): Enslaving as a backup interface with an up link
[   67.604856] br0: port 2(eth1) entered blocking state
[   67.605120] br0: port 2(eth1) entered forwarding state
[   67.629069] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[   67.629520] bond0: (slave eth0): making interface the new active one
[   67.630009] bond0: active interface up!
[   68.149805] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[   68.758757] br0: port 1(eth0) entered disabled state
[   68.773737] bond0: (slave eth0): link status definitely down, disabling slave
[   68.774147] bond0: (slave eth1): making interface the new active one
[   70.791146] br0: port 1(eth0) entered blocking state
[   70.791491] br0: port 1(eth0) entered forwarding state
[   70.819590] br0: port 2(eth1) entered disabled state
[   70.853718] bond0: (slave eth0): link status up, enabling it in 500 ms
[   70.854158] bond0: (slave eth0): invalid new link 3 on slave
[   70.854476] bond0: (slave eth1): link status definitely down, disabling slave
[   70.854853] bond0: (slave eth0): making interface the new active one 100 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[   81.895870] bond0 (unregistering): (slave eth0): Releasing backup interface
[   81.904939] bond0 (unregistering): (slave eth1): Releasing backup interface
[   81.910814] bond0 (unregistering): Released all slaves
[   81.911670] br0: port 1(eth0) entered disabled state
[   82.065380] bond0: (slave eth0): Enslaving as a backup interface with an up link
[   82.066152] br0: port 1(eth0) entered blocking state
[   82.066425] br0: port 1(eth0) entered forwarding state
[   82.090242] bond0: (slave eth1): Enslaving as a backup interface with an up link
[   82.090982] br0: port 2(eth1) entered blocking state
[   82.091245] br0: port 2(eth1) entered forwarding state
[   82.113351] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[   82.113852] bond0: (slave eth0): making interface the new active one
[   82.114348] bond0: active interface up!
[   83.157801] bond0: (slave eth1): link status definitely up, 10000 Mbps full duplex
[   83.224686] br0: port 1(eth0) entered disabled state
[   83.263751] bond0: (slave eth0): link status definitely down, disabling slave
[   83.264181] bond0: (slave eth1): making interface the new active one
[   85.258534] br0: port 1(eth0) entered blocking state
[   85.258866] br0: port 1(eth0) entered forwarding state
[   85.287845] br0: port 2(eth1) entered disabled state
[   85.341737] bond0: (slave eth0): link status up, enabling it in 1000 ms
[   85.342146] bond0: (slave eth0): invalid new link 3 on slave
[   85.342567] bond0: (slave eth1): link status definitely down, disabling slave
[   85.342970] bond0: (slave eth0): making interface the new active one 100 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[   96.362234] bond0 (unregistering): (slave eth0): Releasing backup interface
[   96.371911] bond0 (unregistering): (slave eth1): Releasing backup interface
[   96.380815] bond0 (unregistering): Released all slaves
[   96.381631] br0: port 1(eth0) entered disabled state
[   96.535332] bond0: (slave eth0): Enslaving as a backup interface with an up link
[   96.536040] br0: port 1(eth0) entered blocking state
[   96.536320] br0: port 1(eth0) entered forwarding state
[   96.561012] bond0: (slave eth1): Enslaving as a backup interface with an up link
[   96.561706] br0: port 2(eth1) entered blocking state
[   96.562008] br0: port 2(eth1) entered forwarding state
[   96.587910] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[   96.588743] bond0: (slave eth0): making interface the new active one
[   96.589380] bond0: active interface up!
[   97.683030] br0: port 1(eth0) entered disabled state
[   97.733812] bond0: (slave eth0): link status definitely down, disabling slave
[   97.734216] bond0: (slave eth1): making interface the new active one 1200 ms earlier
[   99.715224] br0: port 1(eth0) entered blocking state
[   99.715531] br0: port 1(eth0) entered forwarding state
[   99.745927] br0: port 2(eth1) entered disabled state
[   99.813780] bond0: (slave eth0): link status up, enabling it in 2000 ms
[   99.814194] bond0: (slave eth0): invalid new link 3 on slave
[   99.814528] bond0: (slave eth1): link status definitely down, disabling slave
[   99.814904] bond0: (slave eth0): making interface the new active one 100 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  110.825932] bond0 (unregistering): (slave eth0): Releasing backup interface
[  110.831935] bond0 (unregistering): (slave eth1): Releasing backup interface
[  110.837833] bond0 (unregistering): Released all slaves
[  110.838655] br0: port 1(eth0) entered disabled state
[  110.991022] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  110.991690] br0: port 1(eth0) entered blocking state
[  110.991972] br0: port 1(eth0) entered forwarding state
[  111.018237] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  111.018936] br0: port 2(eth1) entered blocking state
[  111.019197] br0: port 2(eth1) entered forwarding state
[  111.042026] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  111.042473] bond0: (slave eth0): making interface the new active one
[  111.042996] bond0: active interface up!
[  112.151929] br0: port 1(eth0) entered disabled state
[  112.189793] bond0: (slave eth0): link status definitely down, disabling slave
[  112.190194] bond0: (slave eth1): making interface the new active one 1200 ms earlier
[  114.183590] br0: port 1(eth0) entered blocking state
[  114.183922] br0: port 1(eth0) entered forwarding state
[  114.209068] br0: port 2(eth1) entered disabled state
[  114.269818] bond0: (slave eth0): link status up, enabling it in 5000 ms
[  114.270442] bond0: (slave eth0): invalid new link 3 on slave
[  114.270972] bond0: (slave eth1): link status definitely down, disabling slave
[  114.271546] bond0: (slave eth0): making interface the new active one 100 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  125.290213] bond0 (unregistering): (slave eth0): Releasing backup interface
[  125.299914] bond0 (unregistering): (slave eth1): Releasing backup interface
[  125.305873] bond0 (unregistering): Released all slaves
[  125.306836] br0: port 1(eth0) entered disabled state
[  125.470542] bond0: (slave eth0): Enslaving as a backup interface with an up link
[  125.471194] br0: port 1(eth0) entered blocking state
[  125.471467] br0: port 1(eth0) entered forwarding state
[  125.496585] bond0: (slave eth1): Enslaving as a backup interface with an up link
[  125.497240] br0: port 2(eth1) entered blocking state
[  125.497502] br0: port 2(eth1) entered forwarding state
[  125.524365] bond0: (slave eth0): link status definitely up, 10000 Mbps full duplex
[  125.524821] bond0: (slave eth0): making interface the new active one
[  125.525311] bond0: active interface up!
[  126.612359] br0: port 1(eth0) entered disabled state
[  126.669826] bond0: (slave eth0): link status definitely down, disabling slave
[  126.670411] bond0: (slave eth1): making interface the new active one 1200 ms earlier
[  128.642116] br0: port 1(eth0) entered blocking state
[  128.642424] br0: port 1(eth0) entered forwarding state
[  128.645830] bond0: (slave eth0): link status up, enabling it in 10000 ms
[  128.646554] bond0: (slave eth0): invalid new link 3 on slave
[  128.663371] br0: port 2(eth1) entered disabled state
[  128.749801] bond0: (slave eth1): link status definitely down, disabling slave
[  128.750212] bond0: (slave eth0): making interface the new active one 200 ms earlier
# TEST: mode (1) bond recovery                                        [ OK ]
[  139.751031] bond0 (unregistering): (slave eth0): Releasing backup interface
[  139.760058] bond0 (unregistering): (slave eth1): Releasing backup interface
[  139.765850] bond0 (unregistering): Released all slaves
[  139.766822] br0: port 1(eth0) entered disabled state
[  139.863799] eth1: left allmulticast mode
[  139.864041] eth1: left promiscuous mode
[  139.864278] br0: port 2(eth1) entered disabled state
[  139.864730] eth0: left allmulticast mode
[  139.864974] eth0: left promiscuous mode
[  139.865204] br0: port 1(eth0) entered disabled state
# modprobe: FATAL: Module bonding is builtin.
ok 1 selftests: drivers/net/bonding: mode-1-recovery-updelay.sh
make[1]: Leaving directory '/home/virtme/testing-9/tools/testing/selftests/drivers/net/bonding'
make: Leaving directory '/home/virtme/testing-9/tools/testing/selftests'
xx__-> echo $?
0
xx__->