Re: upgrade to 3.8.1 : BUG Scheduling while atomic in bondingdriver:

From: Eric Dumazet
Date: Fri Mar 01 2013 - 11:24:58 EST


On Fri, 2013-03-01 at 00:15 -0800, Linda Walsh wrote:
> Just installed 3.8.1....
>
> Thought this had been fixed? Note it causes the kernel to
> show up as tainted after the 1st...
>

CC netdev & Jay Vosburgh & Jeff Kirsher

>
>
> As the system was coming up and initializing the bond0 driver:
>
>
> [ 19.847743] ixgbe 0000:06:00.0: registered PHC device on eth_s2_0
> [ 20.258245] BUG: scheduling while atomic: ifup-bonding/2003/0x00000002
> [ 20.264812] 4 locks held by ifup-bonding/2003:
> [ 20.269298] #0: (&buffer->mutex){......}, at: [<ffffffff811c401f>]
> sysfs_write_file+0x3f/0x150
> [ 20.278319] #1: (s_active#59){......}, at: [<ffffffff811c409b>]
> sysfs_write_file+0xbb/0x150
> [ 20.287088] #2: (rtnl_mutex){......}, at: [<ffffffff81590bf0>]
> rtnl_trylock+0x10/0x20
> [ 20.295373] #3: (&bond->lock){......}, at: [<ffffffff8145be6f>]
> bond_enslave+0x4ef/0xb80
> [ 20.303912] Modules linked in: iptable_filter kvm_intel kvm acpi_cpufreq
> mperf button processor mousedev iTCO_wdt
> [ 20.314695] Pid: 2003, comm: ifup-bonding Not tainted 3.8.1-Isht-Van #5
> [ 20.321340] Call Trace:
> [ 20.323833] [<ffffffff8162b029>] __schedule_bug+0x5e/0x6c
> [ 20.329356] [<ffffffff81634592>] __schedule+0x762/0x7f0
> [ 20.334701] [<ffffffff81634734>] schedule+0x24/0x70
> [ 20.339703] [<ffffffff816336f4>] schedule_hrtimeout_range_clock+0xa4/0x130
> [ 20.346699] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 20.352130] [<ffffffff81068f9f>] ? hrtimer_start_range_ns+0xf/0x20
> [ 20.358434] [<ffffffff8163378e>] schedule_hrtimeout_range+0xe/0x10
> [ 20.364734] [<ffffffff8104ec1b>] usleep_range+0x3b/0x40
> [ 20.370082] [<ffffffff814b2d7c>] ixgbe_acquire_swfw_sync_X540+0xbc/0x100
> [ 20.376905] [<ffffffff814aeb0d>] ixgbe_read_phy_reg_generic+0x3d/0x140
> [ 20.383553] [<ffffffff814aedac>]
> ixgbe_get_copper_link_capabilities_generic+0x2c/0x60
> [ 20.391499] [<ffffffff8145be6f>] ? bond_enslave+0x4ef/0xb80
> [ 20.397194] [<ffffffff814a64e4>] ixgbe_get_settings+0x34/0x340
> [ 20.403148] [<ffffffff81586ab8>] __ethtool_get_settings+0x88/0x130
> [ 20.409448] [<ffffffff814568a3>] bond_update_speed_duplex+0x23/0x60
> [ 20.415833] [<ffffffff8145bed9>] bond_enslave+0x559/0xb80
> [ 20.421356] [<ffffffff8146454f>] bonding_store_slaves+0x16f/0x1c0
> [ 20.427569] [<ffffffff813bfb83>] dev_attr_store+0x13/0x30
> [ 20.433091] [<ffffffff811c40b4>] sysfs_write_file+0xd4/0x150
> [ 20.438872] [<ffffffff81154b81>] vfs_write+0xb1/0x190
> [ 20.444047] [<ffffffff81154ee0>] sys_write+0x50/0xa0
> [ 20.449137] [<ffffffff81637092>] system_call_fastpath+0x16/0x1b
> [ 20.455264] BUG: scheduling while atomic: ifup-bonding/2003/0x00000002
> [ 20.461851] 4 locks held by ifup-bonding/2003:
> [ 20.466334] #0: (&buffer->mutex){......}, at: [<ffffffff811c401f>]
> sysfs_write_file+0x3f/0x150
> [ 20.475356] #1: (s_active#59){......}, at: [<ffffffff811c409b>]
> sysfs_write_file+0xbb/0x150
> [ 20.484117] #2: (rtnl_mutex){......}, at: [<ffffffff81590bf0>]
> rtnl_trylock+0x10/0x20
> [ 20.492403] #3: (&bond->lock){......}, at: [<ffffffff8145be6f>]
> bond_enslave+0x4ef/0xb80
> [ 20.500902] Modules linked in: iptable_filter kvm_intel kvm acpi_cpufreq
> mperf button processor mousedev iTCO_wdt
> [ 20.511640] Pid: 2003, comm: ifup-bonding Tainted: G W
> 3.8.1-Isht-Van #5
> [ 20.519240] Call Trace:
> [ 20.521729] [<ffffffff8162b029>] __schedule_bug+0x5e/0x6c
> [ 20.527251] [<ffffffff81634592>] __schedule+0x762/0x7f0
> [ 20.532599] [<ffffffff81634734>] schedule+0x24/0x70
> [ 20.537599] [<ffffffff816336f4>] schedule_hrtimeout_range_clock+0xa4/0x130
> [ 20.544592] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 20.550026] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 20.555462] [<ffffffff81068f9f>] ? hrtimer_start_range_ns+0xf/0x20
> [ 20.561763] [<ffffffff8163378e>] schedule_hrtimeout_range+0xe/0x10
> [ 20.568064] [<ffffffff8104ec1b>] usleep_range+0x3b/0x40
> [ 20.573415] [<ffffffff814b2cae>] ixgbe_release_swfw_sync_X540+0x4e/0x60
> [ 20.580146] [<ffffffff814aebdd>] ixgbe_read_phy_reg_generic+0x10d/0x140
> [ 20.586960] [<ffffffff814aedac>]
> ixgbe_get_copper_link_capabilities_generic+0x2c/0x60
> [ 20.594908] [<ffffffff8145be6f>] ? bond_enslave+0x4ef/0xb80
> [ 20.600601] [<ffffffff814a64e4>] ixgbe_get_settings+0x34/0x340
> [ 20.606557] [<ffffffff81586ab8>] __ethtool_get_settings+0x88/0x130
> [ 20.612858] [<ffffffff814568a3>] bond_update_speed_duplex+0x23/0x60
> [ 20.619244] [<ffffffff8145bed9>] bond_enslave+0x559/0xb80
> [ 20.624767] [<ffffffff8146454f>] bonding_store_slaves+0x16f/0x1c0
> [ 20.630983] [<ffffffff813bfb83>] dev_attr_store+0x13/0x30
> [ 20.636503] [<ffffffff811c40b4>] sysfs_write_file+0xd4/0x150
> [ 20.642283] [<ffffffff81154b81>] vfs_write+0xb1/0x190
> [ 20.647462] [<ffffffff81154ee0>] sys_write+0x50/0xa0
> [ 20.652548] [<ffffffff81637092>] system_call_fastpath+0x16/0x1b
> [ 20.658696] bonding: bond0: enslaving eth_s2_0 as an active interface with a
> down link.
> [ 20.676577] bonding: bond0: Adding slave eth_s2_1.
> [ 20.743760] pps pps1: new PPS source ptp1
> [ 20.747792] ixgbe 0000:06:00.1: registered PHC device on eth_s2_1
> [ 21.150267] BUG: scheduling while atomic: ifup-bonding/2003/0x00000002
> [ 21.156836] 4 locks held by ifup-bonding/2003:
> [ 21.161319] #0: (&buffer->mutex){......}, at: [<ffffffff811c401f>]
> sysfs_write_file+0x3f/0x150
> [ 21.170388] #1: (s_active#59){......}, at: [<ffffffff811c409b>]
> sysfs_write_file+0xbb/0x150
> [ 21.179149] #2: (rtnl_mutex){......}, at: [<ffffffff81590bf0>]
> rtnl_trylock+0x10/0x20
> [ 21.187403] #3: (&bond->lock){......}, at: [<ffffffff8145be6f>]
> bond_enslave+0x4ef/0xb80
> [ 21.195904] Modules linked in: iptable_filter kvm_intel kvm acpi_cpufreq
> mperf button processor mousedev iTCO_wdt
> [ 21.206644] Pid: 2003, comm: ifup-bonding Tainted: G W
> 3.8.1-Isht-Van #5
> [ 21.214240] Call Trace:
> [ 21.216732] [<ffffffff8162b029>] __schedule_bug+0x5e/0x6c
> [ 21.222254] [<ffffffff81634592>] __schedule+0x762/0x7f0
> [ 21.227604] [<ffffffff81634734>] schedule+0x24/0x70
> [ 21.232606] [<ffffffff816336f4>] schedule_hrtimeout_range_clock+0xa4/0x130
> [ 21.239601] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 21.245033] [<ffffffff81068f9f>] ? hrtimer_start_range_ns+0xf/0x20
> [ 21.251339] [<ffffffff8163378e>] schedule_hrtimeout_range+0xe/0x10
> [ 21.257635] [<ffffffff8104ec1b>] usleep_range+0x3b/0x40
> [ 21.262987] [<ffffffff814b2d7c>] ixgbe_acquire_swfw_sync_X540+0xbc/0x100
> [ 21.269811] [<ffffffff814aeb0d>] ixgbe_read_phy_reg_generic+0x3d/0x140
> [ 21.276461] [<ffffffff814aedac>]
> ixgbe_get_copper_link_capabilities_generic+0x2c/0x60
> [ 21.284409] [<ffffffff8145be6f>] ? bond_enslave+0x4ef/0xb80
> [ 21.290106] [<ffffffff814a64e4>] ixgbe_get_settings+0x34/0x340
> [ 21.296067] [<ffffffff81586ab8>] __ethtool_get_settings+0x88/0x130
> [ 21.302369] [<ffffffff814568a3>] bond_update_speed_duplex+0x23/0x60
> [ 21.308754] [<ffffffff8145bed9>] bond_enslave+0x559/0xb80
> [ 21.314278] [<ffffffff8146454f>] bonding_store_slaves+0x16f/0x1c0
> [ 21.320491] [<ffffffff813bfb83>] dev_attr_store+0x13/0x30
> [ 21.326009] [<ffffffff811c40b4>] sysfs_write_file+0xd4/0x150
> [ 21.331793] [<ffffffff81154b81>] vfs_write+0xb1/0x190
> [ 21.336964] [<ffffffff81154ee0>] sys_write+0x50/0xa0
> [ 21.342053] [<ffffffff81637092>] system_call_fastpath+0x16/0x1b
> [ 21.348191] BUG: scheduling while atomic: ifup-bonding/2003/0x00000002
> [ 21.354775] 4 locks held by ifup-bonding/2003:
> [ 21.359258] #0: (&buffer->mutex){......}, at: [<ffffffff811c401f>]
> sysfs_write_file+0x3f/0x150
> [ 21.368283] #1: (s_active#59){......}, at: [<ffffffff811c409b>]
> sysfs_write_file+0xbb/0x150
> [ 21.377104] #2: (rtnl_mutex){......}, at: [<ffffffff81590bf0>]
> rtnl_trylock+0x10/0x20
> [ 21.385343] #3: (&bond->lock){......}, at: [<ffffffff8145be6f>]
> bond_enslave+0x4ef/0xb80
> [ 21.393887] Modules linked in: iptable_filter kvm_intel kvm acpi_cpufreq
> mperf button processor mousedev iTCO_wdt
> [ 21.404575] Pid: 2003, comm: ifup-bonding Tainted: G W
> 3.8.1-Isht-Van #5
> [ 21.412176] Call Trace:
> [ 21.414666] [<ffffffff8162b029>] __schedule_bug+0x5e/0x6c
> [ 21.420188] [<ffffffff81634592>] __schedule+0x762/0x7f0
> [ 21.425536] [<ffffffff81634734>] schedule+0x24/0x70
> [ 21.430541] [<ffffffff816336f4>] schedule_hrtimeout_range_clock+0xa4/0x130
> [ 21.437532] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 21.442967] [<ffffffff81068250>] ? update_rmtp+0x60/0x60
> [ 21.448407] [<ffffffff81068f9f>] ? hrtimer_start_range_ns+0xf/0x20
> [ 21.454712] [<ffffffff8163378e>] schedule_hrtimeout_range+0xe/0x10
> [ 21.461015] [<ffffffff8104ec1b>] usleep_range+0x3b/0x40
> [ 21.466370] [<ffffffff814b2cae>] ixgbe_release_swfw_sync_X540+0x4e/0x60
> [ 21.473105] [<ffffffff814aebdd>] ixgbe_read_phy_reg_generic+0x10d/0x140
> [ 21.479843] [<ffffffff814aedac>]
> ixgbe_get_copper_link_capabilities_generic+0x2c/0x60
> [ 21.487787] [<ffffffff8145be6f>] ? bond_enslave+0x4ef/0xb80
> [ 21.493513] [<ffffffff814a64e4>] ixgbe_get_settings+0x34/0x340
> [ 21.499468] [<ffffffff81586ab8>] __ethtool_get_settings+0x88/0x130
> [ 21.505767] [<ffffffff814568a3>] bond_update_speed_duplex+0x23/0x60
> [ 21.512153] [<ffffffff8145bed9>] bond_enslave+0x559/0xb80
> [ 21.517677] [<ffffffff8146454f>] bonding_store_slaves+0x16f/0x1c0
> [ 21.523889] [<ffffffff813bfb83>] dev_attr_store+0x13/0x30
> [ 21.529412] [<ffffffff811c40b4>] sysfs_write_file+0xd4/0x150
> [ 21.535193] [<ffffffff81154b81>] vfs_write+0xb1/0x190
> [ 21.540373] [<ffffffff81154ee0>] sys_write+0x50/0xa0
> [ 21.545463] [<ffffffff81637092>] system_call_fastpath+0x16/0x1b
> --

--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/