ppp in 2.6.11-rc2 Badness in local_bh_enable at kernel/softirq.c

ppp in 2.6.11-rc2 Badness in local_bh_enable at kernel/softirq.c

[Pete Clements]

FYI:
Get the following with 2.6.11-rc2 and ppp (pppoe), continuous. 
Non-ppp boxes fine.  Last prior kernel 2.6.11-rc1-bk5 is good
(have not tried bk6 - bk9).

 Badness in local_bh_enable at kernel/softirq.c:140
  [local_bh_enable+44/104] local_bh_enable+0x2c/0x68
  [ppp_async_push+358/372] ppp_async_push+0x166/0x174
  [ppp_async_send+13/72] ppp_async_send+0xd/0x48
  [ppp_push+70/176] ppp_push+0x46/0xb0
  [ppp_send_frame+941/992] ppp_send_frame+0x3ad/0x3e0
  [ppp_xmit_process+54/172] ppp_xmit_process+0x36/0xac
  [ppp_start_xmit+459/520] ppp_start_xmit+0x1cb/0x208
  [qdisc_restart+102/236] qdisc_restart+0x66/0xec
  [dev_queue_xmit+199/476] dev_queue_xmit+0xc7/0x1dc
  [ip_finish_output+340/456] ip_finish_output+0x154/0x1c8
  [ip_forward_finish+0/68] ip_forward_finish+0x0/0x44
  [ip_output+86/92] ip_output+0x56/0x5c
  [ip_forward_finish+37/68] ip_forward_finish+0x25/0x44
  [nf_hook_slow+165/240] nf_hook_slow+0xa5/0xf0
  [ip_forward+492/572] ip_forward+0x1ec/0x23c
  [ip_forward_finish+0/68] ip_forward_finish+0x0/0x44
  [ip_rcv+881/1024] ip_rcv+0x371/0x400
  [netif_receive_skb+284/332] netif_receive_skb+0x11c/0x14c
  [process_backlog+112/248] process_backlog+0x70/0xf8
  [net_rx_action+118/244] net_rx_action+0x76/0xf4
  [gcc2_compiled.+58/136] __do_softirq+0x3a/0x88
  [do_softirq+34/44] do_softirq+0x22/0x2c
  [irq_exit+39/40] irq_exit+0x27/0x28
  [do_IRQ+33/40] do_IRQ+0x21/0x28
  [common_interrupt+26/32] common_interrupt+0x1a/0x20
  [default_idle+0/52] default_idle+0x0/0x34
  [default_idle+38/52] default_idle+0x26/0x34
  [cpu_idle+69/88] cpu_idle+0x45/0x58
  [stext+26/28] _stext+0x1a/0x1c
  [start_kernel+326/328] start_kernel+0x146/0x148

-- 
Pete Clements 

Re: ppp in 2.6.11-rc2 Badness in local_bh_enable at kernel/softirq.c

[boris mogwitz]

On Sat, Jan 22, 2005 at 11:04:57AM -0500, Pete Clements wrote:

> FYI:
> Get the following with 2.6.11-rc2 and ppp (pppoe), continuous.
> Non-ppp boxes fine.  Last prior kernel 2.6.11-rc1-bk5 is good
> (have not tried bk6 - bk9).
>
>  Badness in local_bh_enable at kernel/softirq.c:140
>   [local_bh_enable+44/104] local_bh_enable+0x2c/0x68

 I have a simmilar problem here when I try to access may
 madwifi (cvs) device:

 Badness in local_bh_enable at kernel/softirq.c:140
  [<c011ace3>] local_bh_enable+0x83/0x90
  [<e18ac6c4>] ath_hardstart+0x1b4/0x290 [ath_pci]
  [<c029b966>] arp_create+0x1d6/0x250
  [<c02723d3>] qdisc_restart+0x73/0x150
  [<c026657e>] dev_queue_xmit+0x1be/0x260
  [<c029b2b8>] arp_solicit+0x108/0x200
  [<c026b494>] neigh_timer_handler+0x184/0x2e0
  [<c026b310>] neigh_timer_handler+0x0/0x2e0
  [<c011e9f1>] run_timer_softirq+0xe1/0x1d0
  [<c0106f68>] timer_interrupt+0x48/0xf0
  [<c011ac19>] __do_softirq+0x79/0x90
  cut cut

               mfg
                         boris
								

Re: ppp in 2.6.11-rc2 Badness in local_bh_enable at kernel/softirq.c

[Johnny Strom]

Hi

I have the same problem with 2.6.11-rc2 I am using ppp with rp-pppoe-3.5 
it starts like this as soon as it brings upp the link.

This is from the booutup of my system:

Jan 21 19:45:14 mail kernel:  [<c03650e8>] ip_send_reply+0x1e8/0x250
Jan 21 19:45:14 mail kernel:  [<c0364e70>] ip_reply_glue_bits+0x0/0x90
Jan 21 19:45:14 mail kernel:  [<c03a1f9b>] ip_nat_used_tuple+0x2b/0x40
Jan 21 19:45:14 mail kernel:  [<c03a254f>] ip_nat_setup_info+0xbf/0x300
Jan 21 19:45:14 mail kernel:  [<c0379591>] tcp_v4_send_reset+0xf1/0x150
Jan 21 19:45:15 mail kernel:  [<c037abef>] tcp_v4_rcv+0x43f/0x7e0
Jan 21 19:45:15 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:15 mail kernel:  [<c036023c>] 
ip_local_deliver_finish+0xbc/0x170
Jan 21 19:45:15 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:15 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:15 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:15 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:15 mail kernel:  [<c035ff59>] ip_local_deliver+0x59/0x60
Jan 21 19:45:15 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:15 mail kernel:  [<c03603d9>] ip_rcv_finish+0xe9/0x250
Jan 21 19:45:16 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:16 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:16 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:16 mail kernel:  [<c03600cd>] ip_rcv+0x16d/0x220
Jan 21 19:45:16 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:16 mail kernel:  [<c034b468>] netif_receive_skb+0x128/0x1b0
Jan 21 19:45:16 mail kernel:  [<c02847df>] ppp_input+0xff/0x1a0
Jan 21 19:45:17 mail kernel:  [<c034b563>] process_backlog+0x73/0x100
Jan 21 19:45:17 mail kernel:  [<c034b65a>] net_rx_action+0x6a/0xf0
Jan 21 19:45:17 mail kernel:  [<c01197b8>] __do_softirq+0x78/0x90
Jan 21 19:45:17 mail kernel:  [<c01197f6>] do_softirq+0x26/0x30
Jan 21 19:45:17 mail kernel:  [<c011985c>] local_bh_enable+0x5c/0x90
Jan 21 19:45:17 mail kernel:  [<c03b35f4>] packet_poll+0x84/0xa0
Jan 21 19:45:17 mail kernel:  [<c03419b9>] sock_poll+0x29/0x40
Jan 21 19:45:18 mail kernel:  [<c01666d2>] do_select+0x272/0x2e0
Jan 21 19:45:18 mail kernel:  [<c01662b0>] __pollwait+0x0/0xd0
Jan 21 19:45:18 mail kernel:  [<c0166a2f>] sys_select+0x2bf/0x4d0
Jan 21 19:45:18 mail kernel:  [<c010277d>] sysenter_past_esp+0x52/0x75
Jan 21 19:45:18 mail kernel: Badness in local_bh_enable at 
kernel/softirq.c:140
Jan 21 19:45:18 mail kernel:  [<c0119887>] local_bh_enable+0x87/0x90
Jan 21 19:45:18 mail kernel:  [<c02884db>] ppp_async_push+0xab/0x180
Jan 21 19:45:18 mail kernel:  [<c02ae931>] ide_intr+0x141/0x1b0
Jan 21 19:45:18 mail kernel:  [<c02883f5>] ppp_async_send+0x15/0x50
Jan 21 19:45:18 mail kernel:  [<c02845d5>] ppp_push+0xf5/0x100
Jan 21 19:45:18 mail kernel:  [<c028421d>] ppp_send_frame+0x25d/0x520
Jan 21 19:45:18 mail kernel:  [<c039a350>] tcp_in_window+0x470/0x480
Jan 21 19:45:18 mail kernel:  [<c0283f5f>] ppp_xmit_process+0x7f/0xe0
Jan 21 19:45:18 mail kernel:  [<c0283be8>] ppp_start_xmit+0xd8/0x240
Jan 21 19:45:18 mail kernel:  [<c0357cf0>] qdisc_restart+0x70/0x180
Jan 21 19:45:19 mail kernel:  [<c034af2f>] dev_queue_xmit+0x1df/0x2a0
Jan 21 19:45:19 mail kernel:  [<c03652d6>] ip_finish_output2+0x106/0x1f0
Jan 21 19:45:19 mail kernel:  [<c03651d0>] ip_finish_output2+0x0/0x1f0
Jan 21 19:45:19 mail kernel:  [<c03651d0>] ip_finish_output2+0x0/0x1f0
Jan 21 19:45:19 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:19 mail kernel:  [<c03651d0>] ip_finish_output2+0x0/0x1f0
Jan 21 19:45:19 mail kernel:  [<c03651a0>] dst_output+0x0/0x30
Jan 21 19:45:19 mail kernel:  [<c0362d4a>] ip_finish_output+0x4a/0x50
Jan 21 19:45:19 mail kernel:  [<c03651d0>] ip_finish_output2+0x0/0x1f0
Jan 21 19:45:19 mail kernel:  [<c03651b4>] dst_output+0x14/0x30
Jan 21 19:45:19 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:19 mail kernel:  [<c03651a0>] dst_output+0x0/0x30
Jan 21 19:45:19 mail kernel:  [<c0364c61>] 
ip_push_pending_frames+0x2f1/0x420
Jan 21 19:45:19 mail kernel:  [<c03651a0>] dst_output+0x0/0x30
Jan 21 19:45:19 mail kernel:  [<c0362d4a>] ip_finish_output+0x4a/0x50
Jan 21 19:45:19 mail kernel:  [<c03651d0>] ip_finish_output2+0x0/0x1f0
Jan 21 19:45:19 mail kernel:  [<c03651b4>] dst_output+0x14/0x30
Jan 21 19:45:19 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:19 mail kernel:  [<c03651a0>] dst_output+0x0/0x30
Jan 21 19:45:19 mail kernel:  [<c0364c61>] 
ip_push_pending_frames+0x2f1/0x420
Jan 21 19:45:19 mail kernel:  [<c03651a0>] dst_output+0x0/0x30
Jan 21 19:45:19 mail kernel:  [<c03650e8>] ip_send_reply+0x1e8/0x250
Jan 21 19:45:19 mail kernel:  [<c0364e70>] ip_reply_glue_bits+0x0/0x90
Jan 21 19:45:20 mail kernel:  [<c03a1f9b>] ip_nat_used_tuple+0x2b/0x40
Jan 21 19:45:20 mail kernel:  [<c03a254f>] ip_nat_setup_info+0xbf/0x300
Jan 21 19:45:20 mail kernel:  [<c0379591>] tcp_v4_send_reset+0xf1/0x150
Jan 21 19:45:20 mail kernel:  [<c037abef>] tcp_v4_rcv+0x43f/0x7e0
Jan 21 19:45:20 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:20 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:21 mail kernel:  [<c036023c>] 
ip_local_deliver_finish+0xbc/0x170
LPF/eth1/52:54:4c:1a:14:8b/192.168.1.0/24
Jan 21 19:45:21 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:21 mail dhcpd:
Jan 21 19:45:21 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:21 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:21 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:21 mail kernel:  [<c035ff59>] ip_local_deliver+0x59/0x60
Jan 21 19:45:22 mail kernel:  [<c0360180>] ip_local_deliver_finish+0x0/0x170
Jan 21 19:45:22 mail kernel:  [<c03603d9>] ip_rcv_finish+0xe9/0x250
Jan 21 19:45:22 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:22 mail kernel:  [<c0356bea>] nf_hook_slow+0x11a/0x180
Jan 21 19:45:22 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:22 mail kernel:  [<c03600cd>] ip_rcv+0x16d/0x220
Jan 21 19:45:23 mail kernel:  [<c03602f0>] ip_rcv_finish+0x0/0x250
Jan 21 19:45:23 mail kernel:  [<c034b468>] netif_receive_skb+0x128/0x1b0

Re: ppp in 2.6.11-rc2 Badness in local_bh_enable at kernel/softirq.c

[Rogério Brito]

On Jan 23 2005, Johnny Strom wrote:
> I have the same problem with 2.6.11-rc2 I am using ppp with rp-pppoe-3.5 
> it starts like this as soon as it brings upp the link.

I am also seeing this "Badness in local_bh_enable at kernel/softirq.c:140"
message spamming my logs. It is quite scary, might I add. I have only seen
it with 2.6.11-rc2.

Aside from that, the system seems to be working fine, but I only noticed
this message for the last few hours. Before that, I run kernel 2.6.11-rc2
for 2 days straight and didn't see anything like that.

It seems to have started when I first loaded the netfilter modules. I can
provide more information. Just let me know what would be desired and I'll
try to get it.


Hope this helps, Rogério Brito.

-- 
=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
  Rogério Brito - rbrito@ime.usp.br - http://www.ime.usp.br/~rbrito
=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=