* kernel 4.5.1 issue at system boot
@ 2016-05-23 6:49 Arturo Borrero Gonzalez
2016-05-23 6:50 ` Arturo Borrero Gonzalez
0 siblings, 1 reply; 6+ messages in thread
From: Arturo Borrero Gonzalez @ 2016-05-23 6:49 UTC (permalink / raw)
To: Netfilter Development Mailing list
This was in the log of my system boot today:
May 23 08:25:08 debianhost kernel: [ 240.104042] INFO: task
modprobe:776 blocked for more than 120 seconds.
May 23 08:25:08 debianhost kernel: [ 240.104049] Tainted: G
E 4.5.0-2-amd64 #1
May 23 08:25:08 debianhost kernel: [ 240.104051] "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 23 08:25:08 debianhost kernel: [ 240.104054] modprobe D
ffff88007fa15980 0 776 98 0x00000000
May 23 08:25:08 debianhost kernel: [ 240.104060] ffff880078e4e600
ffffffff81a12500 ffff88007b20c000 ffff88007b20bc88
May 23 08:25:08 debianhost kernel: [ 240.104065] ffffffff81ad9ae4
ffff880078e4e600 00000000ffffffff ffffffff81ad9ae8
May 23 08:25:08 debianhost kernel: [ 240.104069] ffffffff815b36e1
ffffffff81ad9ae0 ffffffff815b396a ffffffff815b53f4
May 23 08:25:08 debianhost kernel: [ 240.104073] Call Trace:
May 23 08:25:08 debianhost kernel: [ 240.104083]
[<ffffffff815b36e1>] ? schedule+0x31/0x80
May 23 08:25:08 debianhost kernel: [ 240.104087]
[<ffffffff815b396a>] ? schedule_preempt_disabled+0xa/0x10
May 23 08:25:08 debianhost kernel: [ 240.104091]
[<ffffffff815b53f4>] ? __mutex_lock_slowpath+0xb4/0x130
May 23 08:25:08 debianhost kernel: [ 240.104099]
[<ffffffffc06e600c>] ? nf_conntrack_ipv4_compat_init+0xc/0xc
[nf_conntrack_ipv4]
May 23 08:25:08 debianhost kernel: [ 240.104103]
[<ffffffff815b548b>] ? mutex_lock+0x1b/0x30
May 23 08:25:08 debianhost kernel: [ 240.104108]
[<ffffffff814b0aa5>] ? register_pernet_subsys+0x15/0x40
May 23 08:25:08 debianhost kernel: [ 240.104112]
[<ffffffffc06e6048>] ? nf_conntrack_l3proto_ipv4_init+0x3c/0xff4
[nf_conntrack_ipv4]
May 23 08:25:08 debianhost kernel: [ 240.104117]
[<ffffffff81002122>] ? do_one_initcall+0xb2/0x200
May 23 08:25:08 debianhost kernel: [ 240.104122]
[<ffffffff8116a27a>] ? do_init_module+0x5b/0x1ce
May 23 08:25:08 debianhost kernel: [ 240.104126]
[<ffffffff810f98f6>] ? load_module+0x2146/0x2790
May 23 08:25:08 debianhost kernel: [ 240.104129]
[<ffffffff810f6450>] ? __symbol_put+0x60/0x60
May 23 08:25:08 debianhost kernel: [ 240.104133]
[<ffffffff810f68a8>] ? copy_module_from_fd.isra.51+0xf8/0x140
May 23 08:25:08 debianhost kernel: [ 240.104137]
[<ffffffff810fa158>] ? SYSC_finit_module+0xa8/0xd0
May 23 08:25:08 debianhost kernel: [ 240.104141]
[<ffffffff815b7472>] ? system_call_fast_compare_end+0xc/0x67
May 23 08:25:08 debianhost kernel: [ 240.104145] INFO: task
(ostnamed):780 blocked for more than 120 seconds.
May 23 08:25:08 debianhost kernel: [ 240.104148] Tainted: G
E 4.5.0-2-amd64 #1
May 23 08:25:08 debianhost kernel: [ 240.104150] "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 23 08:25:08 debianhost kernel: [ 240.104151] (ostnamed) D
0000000000000000 0 780 1 0x00000004
May 23 08:25:08 debianhost kernel: [ 240.104156] ffff8800797d7040
ffff88007a7aed40 ffff880036688000 ffff880036687dd8
May 23 08:25:08 debianhost kernel: [ 240.104160] ffffffffc04635a4
ffff8800797d7040 00000000ffffffff ffffffffc04635a8
May 23 08:25:08 debianhost kernel: [ 240.104164] ffffffff815b36e1
ffffffffc04635a0 ffffffff815b396a ffffffff815b53f4
May 23 08:25:08 debianhost kernel: [ 240.104168] Call Trace:
May 23 08:25:08 debianhost kernel: [ 240.104172]
[<ffffffff815b36e1>] ? schedule+0x31/0x80
May 23 08:25:08 debianhost kernel: [ 240.104176]
[<ffffffff815b396a>] ? schedule_preempt_disabled+0xa/0x10
May 23 08:25:08 debianhost kernel: [ 240.104179]
[<ffffffff815b53f4>] ? __mutex_lock_slowpath+0xb4/0x130
May 23 08:25:08 debianhost kernel: [ 240.104183]
[<ffffffff815b548b>] ? mutex_lock+0x1b/0x30
May 23 08:25:08 debianhost kernel: [ 240.104191]
[<ffffffffc04a0833>] ? nft_register_afinfo+0x23/0x50 [nf_tables]
May 23 08:25:08 debianhost kernel: [ 240.104196]
[<ffffffffc046611d>] ? nf_tables_ipv4_init_net+0xed/0x110
[nf_tables_ipv4]
May 23 08:25:08 debianhost kernel: [ 240.104199]
[<ffffffff814b06f9>] ? ops_init+0x39/0x100
May 23 08:25:08 debianhost kernel: [ 240.104202]
[<ffffffff814b0845>] ? setup_net+0x85/0x130
May 23 08:25:08 debianhost kernel: [ 240.104205]
[<ffffffff814b10d4>] ? copy_net_ns+0x74/0x100
May 23 08:25:08 debianhost kernel: [ 240.104209]
[<ffffffff8109768b>] ? create_new_namespaces+0xfb/0x190
May 23 08:25:08 debianhost kernel: [ 240.104212]
[<ffffffff81097875>] ? unshare_nsproxy_namespaces+0x55/0xa0
May 23 08:25:08 debianhost kernel: [ 240.104216]
[<ffffffff81078a07>] ? SyS_unshare+0x1e7/0x390
May 23 08:25:08 debianhost kernel: [ 240.104220]
[<ffffffff815b7472>] ? system_call_fast_compare_end+0xc/0x67
May 23 08:25:08 debianhost kernel: [ 240.104224] INFO: task
modprobe:791 blocked for more than 120 seconds.
May 23 08:25:08 debianhost kernel: [ 240.104226] Tainted: G
E 4.5.0-2-amd64 #1
May 23 08:25:08 debianhost kernel: [ 240.104228] "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 23 08:25:08 debianhost kernel: [ 240.104230] modprobe D
ffff88007fa95980 0 791 102 0x00000000
May 23 08:25:08 debianhost kernel: [ 240.104234] ffff88007942e600
ffff88007c8ece00 ffff88007b0c8000 ffff88007b0c7c88
May 23 08:25:08 debianhost kernel: [ 240.104238] ffffffff81ad9ae4
ffff88007942e600 00000000ffffffff ffffffff81ad9ae8
May 23 08:25:08 debianhost kernel: [ 240.104242] ffffffff815b36e1
ffffffff81ad9ae0 ffffffff815b396a ffffffff815b53f4
May 23 08:25:08 debianhost kernel: [ 240.104246] Call Trace:
May 23 08:25:08 debianhost kernel: [ 240.104250]
[<ffffffff815b36e1>] ? schedule+0x31/0x80
May 23 08:25:08 debianhost kernel: [ 240.104254]
[<ffffffff815b396a>] ? schedule_preempt_disabled+0xa/0x10
May 23 08:25:08 debianhost kernel: [ 240.104257]
[<ffffffff815b53f4>] ? __mutex_lock_slowpath+0xb4/0x130
May 23 08:25:08 debianhost kernel: [ 240.104261]
[<ffffffffc06fd000>] ? 0xffffffffc06fd000
May 23 08:25:08 debianhost kernel: [ 240.104264]
[<ffffffff815b548b>] ? mutex_lock+0x1b/0x30
May 23 08:25:08 debianhost kernel: [ 240.104267]
[<ffffffff814b0aa5>] ? register_pernet_subsys+0x15/0x40
May 23 08:25:08 debianhost kernel: [ 240.104273]
[<ffffffffc06fd00d>] ? nfnetlink_log_init+0xd/0x1000 [nfnetlink_log]
May 23 08:25:08 debianhost kernel: [ 240.104276]
[<ffffffff81002122>] ? do_one_initcall+0xb2/0x200
May 23 08:25:08 debianhost kernel: [ 240.104280]
[<ffffffff8116a27a>] ? do_init_module+0x5b/0x1ce
May 23 08:25:08 debianhost kernel: [ 240.104283]
[<ffffffff810f98f6>] ? load_module+0x2146/0x2790
May 23 08:25:08 debianhost kernel: [ 240.104286]
[<ffffffff810f6450>] ? __symbol_put+0x60/0x60
May 23 08:25:08 debianhost kernel: [ 240.104290]
[<ffffffff810f68a8>] ? copy_module_from_fd.isra.51+0xf8/0x140
May 23 08:25:08 debianhost kernel: [ 240.104294]
[<ffffffff810fa158>] ? SYSC_finit_module+0xa8/0xd0
May 23 08:25:08 debianhost kernel: [ 240.104297]
[<ffffffff815b7472>] ? system_call_fast_compare_end+0xc/0x67
May 23 08:25:08 debianhost kernel: [ 240.104315] INFO: task
(t-daemon):1319 blocked for more than 120 seconds.
May 23 08:25:08 debianhost kernel: [ 240.104318] Tainted: G
E 4.5.0-2-amd64 #1
May 23 08:25:08 debianhost kernel: [ 240.104319] "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 23 08:25:08 debianhost kernel: [ 240.104321] (t-daemon) D
0000000000000000 0 1319 1 0x00000004
May 23 08:25:08 debianhost kernel: [ 240.104325] ffff8800790ba400
ffff880079e69140 ffff88005d8a8000 ffff88005d8a7e70
May 23 08:25:08 debianhost kernel: [ 240.104329] ffffffff81ad9ae4
ffff8800790ba400 00000000ffffffff ffffffff81ad9ae8
May 23 08:25:08 debianhost kernel: [ 240.104333] ffffffff815b36e1
ffffffff81ad9ae0 ffffffff815b396a ffffffff815b53f4
May 23 08:25:08 debianhost kernel: [ 240.104337] Call Trace:
May 23 08:25:08 debianhost kernel: [ 240.104341]
[<ffffffff815b36e1>] ? schedule+0x31/0x80
May 23 08:25:08 debianhost kernel: [ 240.104344]
[<ffffffff815b396a>] ? schedule_preempt_disabled+0xa/0x10
May 23 08:25:08 debianhost kernel: [ 240.104348]
[<ffffffff815b53f4>] ? __mutex_lock_slowpath+0xb4/0x130
May 23 08:25:08 debianhost kernel: [ 240.104351]
[<ffffffff815b548b>] ? mutex_lock+0x1b/0x30
May 23 08:25:08 debianhost kernel: [ 240.104355]
[<ffffffff814b10c9>] ? copy_net_ns+0x69/0x100
May 23 08:25:08 debianhost kernel: [ 240.104358]
[<ffffffff8109768b>] ? create_new_namespaces+0xfb/0x190
May 23 08:25:08 debianhost kernel: [ 240.104361]
[<ffffffff81097875>] ? unshare_nsproxy_namespaces+0x55/0xa0
May 23 08:25:08 debianhost kernel: [ 240.104364]
[<ffffffff81078a07>] ? SyS_unshare+0x1e7/0x390
May 23 08:25:08 debianhost kernel: [ 240.104368]
[<ffffffff815b7472>] ? system_call_fast_compare_end+0xc/0x67
--
Arturo Borrero González
--
To unsubscribe from this list: send the line "unsubscribe netfilter-devel" in
the body of a message to majordomo@vger.kernel.org
More majordomo info at http://vger.kernel.org/majordomo-info.html
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: kernel 4.5.1 issue at system boot
2016-05-23 6:49 kernel 4.5.1 issue at system boot Arturo Borrero Gonzalez
@ 2016-05-23 6:50 ` Arturo Borrero Gonzalez
2016-05-23 9:57 ` Pablo Neira Ayuso
2016-05-23 10:08 ` Florian Westphal
0 siblings, 2 replies; 6+ messages in thread
From: Arturo Borrero Gonzalez @ 2016-05-23 6:50 UTC (permalink / raw)
To: Netfilter Development Mailing list
On 23 May 2016 at 08:49, Arturo Borrero Gonzalez
<arturo.borrero.glez@gmail.com> wrote:
> This was in the log of my system boot today:
>
Probably more readable in this link:
http://paste.debian.net/695904/
--
Arturo Borrero González
--
To unsubscribe from this list: send the line "unsubscribe netfilter-devel" in
the body of a message to majordomo@vger.kernel.org
More majordomo info at http://vger.kernel.org/majordomo-info.html
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: kernel 4.5.1 issue at system boot
2016-05-23 6:50 ` Arturo Borrero Gonzalez
@ 2016-05-23 9:57 ` Pablo Neira Ayuso
2016-05-23 10:08 ` Florian Westphal
1 sibling, 0 replies; 6+ messages in thread
From: Pablo Neira Ayuso @ 2016-05-23 9:57 UTC (permalink / raw)
To: Arturo Borrero Gonzalez; +Cc: Netfilter Development Mailing list
On Mon, May 23, 2016 at 08:50:29AM +0200, Arturo Borrero Gonzalez wrote:
> On 23 May 2016 at 08:49, Arturo Borrero Gonzalez
> <arturo.borrero.glez@gmail.com> wrote:
> > This was in the log of my system boot today:
> >
>
> Probably more readable in this link:
>
> http://paste.debian.net/695904/
Please, give a try to this one to confirm this resolves your issue:
http://patchwork.ozlabs.org/patch/622175/
Thanks.
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: kernel 4.5.1 issue at system boot
2016-05-23 6:50 ` Arturo Borrero Gonzalez
2016-05-23 9:57 ` Pablo Neira Ayuso
@ 2016-05-23 10:08 ` Florian Westphal
2016-05-30 17:22 ` Pablo Neira Ayuso
1 sibling, 1 reply; 6+ messages in thread
From: Florian Westphal @ 2016-05-23 10:08 UTC (permalink / raw)
To: Arturo Borrero Gonzalez; +Cc: Netfilter Development Mailing list
Arturo Borrero Gonzalez <arturo.borrero.glez@gmail.com> wrote:
> On 23 May 2016 at 08:49, Arturo Borrero Gonzalez
> <arturo.borrero.glez@gmail.com> wrote:
> > This was in the log of my system boot today:
> >
>
> Probably more readable in this link:
>
> http://paste.debian.net/695904/
This looks like an ABBA-style deadlock of
net_mutex and nfnl_lock(NFNL_SUBSYS_NFTABLES).
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: kernel 4.5.1 issue at system boot
2016-05-23 10:08 ` Florian Westphal
@ 2016-05-30 17:22 ` Pablo Neira Ayuso
2016-05-30 18:38 ` Arturo Borrero Gonzalez
0 siblings, 1 reply; 6+ messages in thread
From: Pablo Neira Ayuso @ 2016-05-30 17:22 UTC (permalink / raw)
To: Florian Westphal
Cc: Arturo Borrero Gonzalez, Netfilter Development Mailing list
On Mon, May 23, 2016 at 12:08:11PM +0200, Florian Westphal wrote:
> Arturo Borrero Gonzalez <arturo.borrero.glez@gmail.com> wrote:
> > On 23 May 2016 at 08:49, Arturo Borrero Gonzalez
> > <arturo.borrero.glez@gmail.com> wrote:
> > > This was in the log of my system boot today:
> > >
> >
> > Probably more readable in this link:
> >
> > http://paste.debian.net/695904/
>
> This looks like an ABBA-style deadlock of
> net_mutex and nfnl_lock(NFNL_SUBSYS_NFTABLES).
@Arturo: Could you enable CONFIG_LOCKDEP and CONFIG_DEBUG_MUTEXES?
this instrumention should provide a bit more information on the locks
that are involved in the deadlock.
Thanks.
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: kernel 4.5.1 issue at system boot
2016-05-30 17:22 ` Pablo Neira Ayuso
@ 2016-05-30 18:38 ` Arturo Borrero Gonzalez
0 siblings, 0 replies; 6+ messages in thread
From: Arturo Borrero Gonzalez @ 2016-05-30 18:38 UTC (permalink / raw)
To: Pablo Neira Ayuso; +Cc: Florian Westphal, Netfilter Development Mailing list
On 30 May 2016 at 19:22, Pablo Neira Ayuso <pablo@netfilter.org> wrote:
> On Mon, May 23, 2016 at 12:08:11PM +0200, Florian Westphal wrote:
>> Arturo Borrero Gonzalez <arturo.borrero.glez@gmail.com> wrote:
>> > On 23 May 2016 at 08:49, Arturo Borrero Gonzalez
>> > <arturo.borrero.glez@gmail.com> wrote:
>> > > This was in the log of my system boot today:
>> > >
>> >
>> > Probably more readable in this link:
>> >
>> > http://paste.debian.net/695904/
>>
>> This looks like an ABBA-style deadlock of
>> net_mutex and nfnl_lock(NFNL_SUBSYS_NFTABLES).
>
> @Arturo: Could you enable CONFIG_LOCKDEP and CONFIG_DEBUG_MUTEXES?
> this instrumention should provide a bit more information on the locks
> that are involved in the deadlock.
>
> Thanks.
I have been totally unable to reproduce the issue, I tried with
several boot configs and module-loading order, but no way.
I've not seen the issue to appear by itself neither, so I'm a bit
tempted to simply move on.
--
Arturo Borrero González
--
To unsubscribe from this list: send the line "unsubscribe netfilter-devel" in
the body of a message to majordomo@vger.kernel.org
More majordomo info at http://vger.kernel.org/majordomo-info.html
^ permalink raw reply [flat|nested] 6+ messages in thread
end of thread, other threads:[~2016-05-30 18:39 UTC | newest]
Thread overview: 6+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2016-05-23 6:49 kernel 4.5.1 issue at system boot Arturo Borrero Gonzalez
2016-05-23 6:50 ` Arturo Borrero Gonzalez
2016-05-23 9:57 ` Pablo Neira Ayuso
2016-05-23 10:08 ` Florian Westphal
2016-05-30 17:22 ` Pablo Neira Ayuso
2016-05-30 18:38 ` Arturo Borrero Gonzalez
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).