Hide Forgot
Description of problem: while run module_load test for tg3 unregister_netdevice: waiting for eth1 to become free. Usage count = 4 Clocksource tsc unstable (delta = 14060839050 ns) Switching to clocksource acpi_pm File is still growing.. File is still growing.. SysRq : Show Blocked State task PC stack pid father modprobe D 0000000000000006 0 2402 2269 0x00000080 ffff880834b0fc48 0000000000000086 0000000000000000 0000000000000001 ffffffff81b15804 0000000000000286 000000000001125d 0000000000000001 ffff8808338db038 ffff880834b0ffd8 000000000000f508 ffff8808338db038 Call Trace: [<ffffffff814ec962>] schedule_timeout+0x192/0x2e0 [<ffffffff8107c180>] ? process_timeout+0x0/0x10 [<ffffffff814ecace>] schedule_timeout_uninterruptible+0x1e/0x20 [<ffffffff8107d200>] msleep+0x20/0x30 [<ffffffff8142bfba>] netdev_run_todo+0xba/0x220 [<ffffffff81438ebe>] rtnl_unlock+0xe/0x10 [<ffffffff8142cac3>] unregister_netdev+0x23/0x30 [<ffffffffa031bada>] tg3_remove_one+0x93/0xea [tg3] [<ffffffff8128a3d7>] pci_device_remove+0x37/0x70 [<ffffffff8134581f>] __device_release_driver+0x6f/0xe0 [<ffffffff81345958>] driver_detach+0xc8/0xd0 [<ffffffff813446be>] bus_remove_driver+0x8e/0x110 [<ffffffff81346122>] driver_unregister+0x62/0xa0 [<ffffffff8128a6e4>] pci_unregister_driver+0x44/0xb0 [<ffffffffa031b9fd>] tg3_cleanup+0x15/0x5f [tg3] [<ffffffff810ac604>] sys_delete_module+0x194/0x260 [<ffffffff810d4602>] ? audit_syscall_entry+0x272/0x2a0 [<ffffffff814f15ae>] ? do_page_fault+0x3e/0xa0 [<ffffffff8100b0b2>] system_call_fastpath+0x16/0x1b Sched Debug Version: v0.09, 2.6.32-203.el6.x86_64 #1 now at 3702662.316767 msecs .jiffies : 4298369965 .sysctl_sched_latency : 20.000000 .sysctl_sched_min_granularity : 4.000000 .sysctl_sched_wakeup_granularity : 4.000000 .sysctl_sched_child_runs_first : 0.000000 .sysctl_sched_features : 3183 .sysctl_sched_tunable_scaling : 1 (logaritmic) cpu#0, 2394.010 MHz .nr_running : 1 .load : 1024 .nr_switches : 456520 .nr_load_updates : 151070 .nr_uninterruptible : 0 .next_balance : 4298.369004 .curr->pid : 31023 .clock : 3702543.546509 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 5 .sched_switch : 0 .sched_count : 462251 .sched_goidle : 210778 .avg_idle : 1000000 .ttwu_count : 245605 .ttwu_local : 17333 .bkl_count : 4131 cfs_rq[0]:/ .exec_clock : 29729.810252 .MIN_vruntime : 0.000001 .min_vruntime : 24736.207964 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 0.000000 .nr_spread_over : 2 .nr_running : 1 .load : 1024 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- Rrhts-system-inf 31023 24729.384009 40 120 24729.384009 16758.675718 13081.249131 / cpu#1, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 326512 .nr_load_updates : 185611 .nr_uninterruptible : 0 .next_balance : 4298.370180 .curr->pid : 0 .clock : 3702889.077489 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 327915 .sched_goidle : 134071 .avg_idle : 1000000 .ttwu_count : 164838 .ttwu_local : 63538 .bkl_count : 91 cfs_rq[1]:/ .exec_clock : 38983.548598 .MIN_vruntime : 0.000001 .min_vruntime : 132675.412678 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 107939.204714 .nr_spread_over : 15 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#2, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 196831 .nr_load_updates : 107556 .nr_uninterruptible : 0 .next_balance : 4298.368998 .curr->pid : 0 .clock : 3701698.113858 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 198150 .sched_goidle : 80333 .avg_idle : 1000000 .ttwu_count : 110590 .ttwu_local : 7843 .bkl_count : 5 cfs_rq[2]:/ .exec_clock : 8441.305311 .MIN_vruntime : 0.000001 .min_vruntime : 35383.652686 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 10647.444722 .nr_spread_over : 1 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#3, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 78499 .nr_load_updates : 81633 .nr_uninterruptible : 0 .next_balance : 4298.368995 .curr->pid : 0 .clock : 3701695.118922 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 79936 .sched_goidle : 22655 .avg_idle : 1000000 .ttwu_count : 51725 .ttwu_local : 4358 .bkl_count : 3 cfs_rq[3]:/ .exec_clock : 4755.223540 .MIN_vruntime : 0.000001 .min_vruntime : 4315.381415 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : -20420.826549 .nr_spread_over : 2 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#4, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 154002 .nr_load_updates : 173516 .nr_uninterruptible : 0 .next_balance : 4298.368992 .curr->pid : 0 .clock : 3701692.104024 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 155518 .sched_goidle : 67836 .avg_idle : 1000000 .ttwu_count : 86214 .ttwu_local : 24247 .bkl_count : 62 cfs_rq[4]:/ .exec_clock : 24383.610157 .MIN_vruntime : 0.000001 .min_vruntime : 28466.732689 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 3730.524725 .nr_spread_over : 3 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#5, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 153341 .nr_load_updates : 178381 .nr_uninterruptible : 0 .next_balance : 4298.369989 .curr->pid : 0 .clock : 3702689.054729 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 154791 .sched_goidle : 60178 .avg_idle : 1000000 .ttwu_count : 67742 .ttwu_local : 29069 .bkl_count : 17 cfs_rq[5]:/ .exec_clock : 52186.946841 .MIN_vruntime : 0.000001 .min_vruntime : 214082.867150 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 189346.659186 .nr_spread_over : 14 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#6, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 87715 .nr_load_updates : 127761 .nr_uninterruptible : 0 .next_balance : 4298.370870 .curr->pid : 0 .clock : 3703571.080223 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 89276 .sched_goidle : 35468 .avg_idle : 875819 .ttwu_count : 46799 .ttwu_local : 8440 .bkl_count : 20 cfs_rq[6]:/ .exec_clock : 18433.879426 .MIN_vruntime : 0.000001 .min_vruntime : 25504.771326 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : 768.563362 .nr_spread_over : 9 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- cpu#7, 2394.010 MHz .nr_running : 0 .load : 0 .nr_switches : 44533 .nr_load_updates : 45449 .nr_uninterruptible : 0 .next_balance : 4298.370986 .curr->pid : 0 .clock : 3703683.132395 .cpu_load[0] : 0 .cpu_load[1] : 0 .cpu_load[2] : 0 .cpu_load[3] : 0 .cpu_load[4] : 0 .yld_count : 0 .sched_switch : 0 .sched_count : 45601 .sched_goidle : 14654 .avg_idle : 875609 .ttwu_count : 28657 .ttwu_local : 6286 .bkl_count : 34 cfs_rq[7]:/ .exec_clock : 10440.575293 .MIN_vruntime : 0.000001 .min_vruntime : 9876.526663 .max_vruntime : 0.000001 .spread : 0.000000 .spread0 : -14859.681301 .nr_spread_over : 1 .nr_running : 0 .load : 0 .load_avg : 0.000000 .load_period : 0.000000 .load_contrib : 0 .load_tg : 0 runnable tasks: task PID tree-key switches prio exec-runtime sum-exec sum-sleep ---------------------------------------------------------------------------------------------------------- File is still growing.. unregister_netdevice: waiting for eth1 to become free. Usage count = 4 File is still growing.. Version-Release number of selected component (if applicable): How reproducible: frequently, but some time the test passed Steps to Reproduce: 1. install rhel6.2-20110929.n.0 2. booting with kernel-2.6.32-203.el6 3. do "modprobe tg3; modeprobe -r tg3" for 100 times. Actual results: get "unregister_netdevice: waiting for eth0 to become free. Usage count = 4" in console. Expected results: no error message Additional info:
Since RHEL 6.2 External Beta has begun, and this bug remains unresolved, it has been rejected as it is not proposed as exception or blocker. Red Hat invites you to ask your support representative to propose this request, if appropriate and relevant, in the next release of Red Hat Enterprise Linux.
*** Bug 744188 has been marked as a duplicate of this bug. ***
Same as bz740477 which has just gone to POST state for 6.2.
*** This bug has been marked as a duplicate of bug 740477 ***