Ian Pratt
2005-May-30 01:08 UTC
RE: [Xen-users] Badness in softirq.c / no modules loaded / relatedtonetwork interface
> kernel: Badness in local_bh_enable at kernel/softirq.c:140 > kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 > kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 > kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 > kernel: [sock_poll+41/64] sock_poll+0x29/0x40 > kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 > kernel: [do_poll+106/208] do_poll+0x6a/0xd0 > kernel: [sys_poll+353/576] sys_poll+0x161/0x240 > kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 > kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 > kernel: [syscall_call+7/11] syscall_call+0x7/0xb > > e1000 compiled in, and this is a 1U rackmount with onboard > nics so changing nic is not really an option. This did not > happen with 2.6.10/2.0.5. > > Any other info that would be useful?It''s certainly interesting that you didn''t have this with 2.0.5. This suggests that its either a bug in the forward port to 2.6.11, or some other patch that was added. It would be very helpful if you could try and work out which UDP application is triggering this, so we can try and create a simple recipe to reproduce the issue. Thanks, Ian _______________________________________________ Xen-users mailing list Xen-users@lists.xensource.com http://lists.xensource.com/xen-users
Andy Smith
2005-May-30 01:34 UTC
Re: [Xen-users] Badness in softirq.c / no modules loaded / relatedtonetwork interface
On Mon, May 30, 2005 at 02:08:46AM +0100, Ian Pratt wrote:> It would be very helpful if you could try and work out which UDP > application is triggering this, so we can try and create a simple recipe > to reproduce the issue.Every ping from dom0 to a domU will produce it: $ ping strugglers.net PING strugglers.net (212.13.198.70) 56(84) bytes of data. May 30 01:29:36 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:36 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 May 30 01:29:36 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:36 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:36 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:36 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:36 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:36 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:36 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:36 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:36 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb May 30 01:29:37 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:37 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 May 30 01:29:37 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:37 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:37 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:37 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:37 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:37 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:37 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:37 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:37 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb 64 bytes from strugglers.net (212.13.198.70): icmp_seq=1 ttl=64 time=0.093 ms 64 bytes from strugglers.net (212.13.198.70): icmp_seq=2 ttl=64 time=0.085 ms 64 bytes from strugglers.net (212.13.198.70): icmp_seq=3 ttl=64 time=0.092 ms May 30 01:29:38 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:38 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 May 30 01:29:38 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:38 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:38 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:38 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:38 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:38 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:38 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:38 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:38 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb May 30 01:29:39 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:39 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 64 bytes from strugglers.net (212.13.198.70): icmp_seq=4 ttl=64 time=0.084 ms May 30 01:29:39 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:39 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:39 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:39 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:39 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:39 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:39 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:39 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:39 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb 64 bytes from strugglers.net (212.13.198.70): icmp_seq=5 ttl=64 time=0.085 ms May 30 01:29:40 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:40 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 May 30 01:29:40 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:40 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:40 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:40 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:40 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:40 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:40 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:40 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:40 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb 64 bytes from strugglers.net (212.13.198.70): icmp_seq=6 ttl=64 time=0.088 ms May 30 01:29:41 curacao kernel: Badness in local_bh_enable at kernel/softirq.c:140 May 30 01:29:41 curacao kernel: [local_bh_enable+130/144] local_bh_enable+0x82/0x90 May 30 01:29:41 curacao kernel: [skb_checksum+317/704] skb_checksum+0x13d/0x2c0 May 30 01:29:41 curacao kernel: [udp_poll+154/352] udp_poll+0x9a/0x160 May 30 01:29:41 curacao kernel: [sock_poll+41/64] sock_poll+0x29/0x40 May 30 01:29:41 curacao kernel: [do_pollfd+149/160] do_pollfd+0x95/0xa0 May 30 01:29:41 curacao kernel: [do_poll+106/208] do_poll+0x6a/0xd0 May 30 01:29:41 curacao kernel: [sys_poll+353/576] sys_poll+0x161/0x240 May 30 01:29:41 curacao kernel: [sys_gettimeofday+60/144] sys_gettimeofday+0x3c/0x90 May 30 01:29:41 curacao kernel: [__pollwait+0/208] __pollwait+0x0/0xd0 May 30 01:29:41 curacao kernel: [syscall_call+7/11] syscall_call+0x7/0xb 64 bytes from strugglers.net (212.13.198.70): icmp_seq=7 ttl=64 time=0.082 ms I''m pretty sure it''s the ping that''s triggering it there because if I don''t do anything then it can be several minutes between occurences, but when I ping I get one occurence for every ping. _______________________________________________ Xen-users mailing list Xen-users@lists.xensource.com http://lists.xensource.com/xen-users