2009-09-30 12:24:41

by Ralf Hildebrandt

[permalink] [raw]
Subject: 2.6.31: WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()

This machine runs openvpn:

Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259235] ------------[ cut here ]------------
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259246] WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259249] Hardware name: ProLiant DL360 G4p
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259251] Modules linked in: ipt_REJECT ipt_LOG xt_multiport tun xt_tcpudp xt_state iptable_nat nf_nat iptable_filter ip_tables x_tables nf_conntrack_ipv4 nf_defrag_ipv4 ipv6 psmouse nf_conntrack_ftp nf_conntrack tg3 libphy
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259274] Pid: 2286, comm: openvpn Not tainted 2.6.31 #1
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259276] Call Trace:
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259282] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259288] [<c10326fb>] ? warn_slowpath_common+0x6f/0xcd
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259292] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259296] [<c1032779>] ? warn_slowpath_null+0x20/0x3c
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259300] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259305] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259309] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259314] [<c121bc78>] ? __sk_free+0x21/0xd6
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259318] [<c121be41>] ? sk_common_release+0x5b/0x97
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259321] [<c126cc05>] ? inet_release+0x39/0x66
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259325] [<c1218eaa>] ? sock_release+0x22/0x8d
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259329] [<c1218f31>] ? sock_close+0x1c/0x42
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259334] [<c10a125c>] ? __fput+0xd6/0x1e0
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259338] [<c109dd34>] ? filp_close+0x41/0x72
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259342] [<c109ddda>] ? sys_close+0x75/0xc0
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259347] [<c1002ecf>] ? sysenter_do_call+0x12/0x26
Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259350] ---[ end trace 4715d461fc27d993 ]---

--
Ralf Hildebrandt
Geschäftsbereich IT | Abteilung Netzwerk
Charité - Universitätsmedizin Berlin
Campus Benjamin Franklin
Hindenburgdamm 30 | D-12203 Berlin
Tel. +49 30 450 570 155 | Fax: +49 30 450 570 962
[email protected] | http://www.charite.de


2009-09-30 12:33:48

by Ralf Hildebrandt

[permalink] [raw]
Subject: Re: 2.6.31: WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()

* Ralf Hildebrandt <[email protected]>:
> This machine runs openvpn:
>
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259235] ------------[ cut here ]------------
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259246] WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259249] Hardware name: ProLiant DL360 G4p
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259251] Modules linked in: ipt_REJECT ipt_LOG xt_multiport tun xt_tcpudp xt_state iptable_nat nf_nat iptable_filter ip_tables x_tables nf_conntrack_ipv4 nf_defrag_ipv4 ipv6 psmouse nf_conntrack_ftp nf_conntrack tg3 libphy
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259274] Pid: 2286, comm: openvpn Not tainted 2.6.31 #1
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259276] Call Trace:
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259282] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259288] [<c10326fb>] ? warn_slowpath_common+0x6f/0xcd
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259292] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259296] [<c1032779>] ? warn_slowpath_null+0x20/0x3c
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259300] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259305] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259309] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259314] [<c121bc78>] ? __sk_free+0x21/0xd6
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259318] [<c121be41>] ? sk_common_release+0x5b/0x97
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259321] [<c126cc05>] ? inet_release+0x39/0x66
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259325] [<c1218eaa>] ? sock_release+0x22/0x8d
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259329] [<c1218f31>] ? sock_close+0x1c/0x42
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259334] [<c10a125c>] ? __fput+0xd6/0x1e0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259338] [<c109dd34>] ? filp_close+0x41/0x72
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259342] [<c109ddda>] ? sys_close+0x75/0xc0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259347] [<c1002ecf>] ? sysenter_do_call+0x12/0x26
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259350] ---[ end trace 4715d461fc27d993 ]---

This bug can also be found here:
http://bugzilla.kernel.org/show_bug.cgi?id=14002

2009-09-30 12:36:26

by Eric Dumazet

[permalink] [raw]
Subject: Re: 2.6.31: WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()

Ralf Hildebrandt a écrit :
> This machine runs openvpn:
>
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259235] ------------[ cut here ]------------
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259246] WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259249] Hardware name: ProLiant DL360 G4p
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259251] Modules linked in: ipt_REJECT ipt_LOG xt_multiport tun xt_tcpudp xt_state iptable_nat nf_nat iptable_filter ip_tables x_tables nf_conntrack_ipv4 nf_defrag_ipv4 ipv6 psmouse nf_conntrack_ftp nf_conntrack tg3 libphy
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259274] Pid: 2286, comm: openvpn Not tainted 2.6.31 #1
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259276] Call Trace:
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259282] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259288] [<c10326fb>] ? warn_slowpath_common+0x6f/0xcd
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259292] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259296] [<c1032779>] ? warn_slowpath_null+0x20/0x3c
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259300] [<c126d154>] ? inet_sock_destruct+0x164/0x1c0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259305] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259309] [<c128bdcb>] ? _spin_lock_bh+0x16/0x40
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259314] [<c121bc78>] ? __sk_free+0x21/0xd6
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259318] [<c121be41>] ? sk_common_release+0x5b/0x97
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259321] [<c126cc05>] ? inet_release+0x39/0x66
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259325] [<c1218eaa>] ? sock_release+0x22/0x8d
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259329] [<c1218f31>] ? sock_close+0x1c/0x42
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259334] [<c10a125c>] ? __fput+0xd6/0x1e0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259338] [<c109dd34>] ? filp_close+0x41/0x72
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259342] [<c109ddda>] ? sys_close+0x75/0xc0
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259347] [<c1002ecf>] ? sysenter_do_call+0x12/0x26
> Sep 30 08:48:05 vpn-gw-int kernel: [1706466.259350] ---[ end trace 4715d461fc27d993 ]---
>

We believe following patch should fix this problem.

http://lkml.org/lkml/2009/9/29/62

2009-10-01 11:08:09

by Ralf Hildebrandt

[permalink] [raw]
Subject: Re: 2.6.31: WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()

> We believe following patch should fix this problem.
>
> http://lkml.org/lkml/2009/9/29/62

Nope. I applied the patch to 2.6.31.1, rebooted. And now I'm seeing:

Oct 1 13:05:41 vpn-gw-int kernel: [79964.507696] ------------[ cut here ]------------
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507696] ------------[ cut here ]------------
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507706] WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507706] WARNING: at net/ipv4/af_inet.c:154 inet_sock_destruct+0x164/0x1c0()
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507709] Hardware name: ProLiant DL360 G4p
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507709] Hardware name: ProLiant DL360 G4p
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507711] Modules linked in: ipt_REJECT ipt_LOG xt_multiport tun xt_tcpudp xt_state iptable_nat
nf_nat iptable_filter ip_tables x_tables nf_conntrack_ipv4 nf_defrag_ipv4 ipv6 psmouse nf_conntrack_ftp nf_conntrack tg3 libphy
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507711] Modules linked in: ipt_REJECT ipt_LOG xt_multiport tun xt_tcpudp xt_state iptable_nat
nf_nat iptable_filter ip_tables x_tables nf_conntrack_ipv4 nf_defrag_ipv4 ipv6 psmouse nf_conntrack_ftp nf_conntrack tg3 libphy
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507734] Pid: 15083, comm: openvpn Not tainted 2.6.31.1 #1
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507734] Pid: 15083, comm: openvpn Not tainted 2.6.31.1 #1
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507736] Call Trace: Oct 1 13:05:41 vpn-gw-int kernel: [79964.507736] Call Trace:
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507742] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507742] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507748] [<c103270b>] ? warn_slowpath_common+0x6f/0xcd
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507748] [<c103270b>] ? warn_slowpath_common+0x6f/0xcd
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507752] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507752] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507756] [<c1032789>] ? warn_slowpath_null+0x20/0x3c
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507756] [<c1032789>] ? warn_slowpath_null+0x20/0x3c
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507760] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507760] [<c126d2b4>] ? inet_sock_destruct+0x164/0x1c0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507764] [<c128bf1b>] ? _spin_lock_bh+0x16/0x40
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507764] [<c128bf1b>] ? _spin_lock_bh+0x16/0x40
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507768] [<c128bf1b>] ? _spin_lock_bh+0x16/0x40
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507768] [<c128bf1b>] ? _spin_lock_bh+0x16/0x40
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507773] [<c121bdc8>] ? __sk_free+0x21/0xd6
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507773] [<c121bdc8>] ? __sk_free+0x21/0xd6
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507777] [<c121bf9c>] ? sk_common_release+0x5b/0x97
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507777] [<c121bf9c>] ? sk_common_release+0x5b/0x97
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507780] [<c126cd65>] ? inet_release+0x39/0x66
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507780] [<c126cd65>] ? inet_release+0x39/0x66
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507784] [<c1218ffa>] ? sock_release+0x22/0x8d
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507784] [<c1218ffa>] ? sock_release+0x22/0x8d
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507787] [<c1219081>] ? sock_close+0x1c/0x42
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507787] [<c1219081>] ? sock_close+0x1c/0x42
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507792] [<c10a132c>] ? __fput+0xd6/0x1e0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507792] [<c10a132c>] ? __fput+0xd6/0x1e0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507796] [<c109de04>] ? filp_close+0x41/0x72
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507796] [<c109de04>] ? filp_close+0x41/0x72
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507799] [<c109deaa>] ? sys_close+0x75/0xc0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507799] [<c109deaa>] ? sys_close+0x75/0xc0
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507804] [<c1002ecf>] ? sysenter_do_call+0x12/0x26
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507804] [<c1002ecf>] ? sysenter_do_call+0x12/0x26
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507807] ---[ end trace 37b30e0c4f46add6 ]---
Oct 1 13:05:41 vpn-gw-int kernel: [79964.507807] ---[ end trace 37b30e0c4f46add6 ]---

--
Ralf Hildebrandt
Geschäftsbereich IT | Abteilung Netzwerk
Charité - Universitätsmedizin Berlin
Campus Benjamin Franklin
Hindenburgdamm 30 | D-12203 Berlin
Tel. +49 30 450 570 155 | Fax: +49 30 450 570 962
[email protected] | http://www.charite.de