Ubuntu
linux package

stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

Bug #1854968 reported by Colin Ian King
20
This bug affects 1 person
Affects Status Importance Assigned to Milestone
linux (Ubuntu)
Fix Released
Low
Colin Ian King

Bug Description

stress-ng sctp stressor breaks 5.4.0.7-8 on s390x during ADT regression testing:

https://objectstorage.prodstack4-5.canonical.com/v1/AUTH_77e2ada1e7a84929a74ba3b87153c0ac/autopkgtest-focal-canonical-kernel-team-unstable/focal/s390x/l/linux/20191203_153629_d7a41@/log.gz

14:44:30 DEBUG| [stdout] sctp STARTING
14:44:30 DEBUG| [stdout] [ 3491.098762] sctp: Hash tables configured (bind 256/256)
14:44:33 DEBUG| [stdout] [ 3494.694285] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:44:43 DEBUG| [stdout] [ 3504.714324] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:44:54 DEBUG| [stdout] [ 3514.974288] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:04 DEBUG| [stdout] [ 3525.234306] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:14 DEBUG| [stdout] [ 3535.494291] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:25 DEBUG| [stdout] [ 3545.754323] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:35 DEBUG| [stdout] [ 3556.014294] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:45 DEBUG| [stdout] [ 3566.034317] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:45:55 DEBUG| [stdout] [ 3576.054296] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:05 DEBUG| [stdout] [ 3586.324332] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:15 DEBUG| [stdout] [ 3596.334306] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:25 DEBUG| [stdout] [ 3606.594337] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:36 DEBUG| [stdout] [ 3616.854305] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:46 DEBUG| [stdout] [ 3627.124323] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:46:56 DEBUG| [stdout] [ 3637.154313] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:06 DEBUG| [stdout] [ 3647.414304] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:16 DEBUG| [stdout] [ 3657.674353] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:27 DEBUG| [stdout] [ 3667.734297] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:37 DEBUG| [stdout] [ 3677.994396] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:44 DEBUG| [stdout] [ 3684.814335] INFO: task modprobe:2063628 blocked for more than 122 seconds.
14:47:44 DEBUG| [stdout] [ 3684.814345] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:47:44 DEBUG| [stdout] [ 3684.814346] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:47:44 DEBUG| [stdout] [ 3684.814348] modprobe D 0 2063628 2063618 0x08000000
14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
14:47:44 DEBUG| [stdout] [ 3684.814360] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:47:44 DEBUG| [stdout] [ 3684.814362] [<00000000be310e0a>] schedule+0x4a/0xe0
14:47:44 DEBUG| [stdout] [ 3684.814366] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:47:44 DEBUG| [stdout] [ 3684.814370] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:47:44 DEBUG| [stdout] [ 3684.814411] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:47:44 DEBUG| [stdout] [ 3684.814414] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:47:44 DEBUG| [stdout] [ 3684.814416] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:47:44 DEBUG| [stdout] [ 3684.814418] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:47:44 DEBUG| [stdout] [ 3684.814419] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:47:44 DEBUG| [stdout] [ 3684.814421] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:47:47 DEBUG| [stdout] [ 3688.014291] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:47:57 DEBUG| [stdout] [ 3698.064370] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:07 DEBUG| [stdout] [ 3708.084328] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:17 DEBUG| [stdout] [ 3718.134297] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:27 DEBUG| [stdout] [ 3728.214335] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:37 DEBUG| [stdout] [ 3738.474354] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:48 DEBUG| [stdout] [ 3748.734396] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:48:58 DEBUG| [stdout] [ 3758.744352] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:08 DEBUG| [stdout] [ 3768.754349] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:18 DEBUG| [stdout] [ 3779.014352] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:28 DEBUG| [stdout] [ 3789.024354] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:38 DEBUG| [stdout] [ 3799.284378] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:46 DEBUG| [stdout] [ 3807.694434] INFO: task modprobe:2063628 blocked for more than 245 seconds.
14:49:46 DEBUG| [stdout] [ 3807.694444] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:49:46 DEBUG| [stdout] [ 3807.694445] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:49:46 DEBUG| [stdout] [ 3807.694447] modprobe D 0 2063628 2063618 0x08000000
14:49:46 DEBUG| [stdout] [ 3807.694450] Call Trace:
14:49:46 DEBUG| [stdout] [ 3807.694460] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:49:46 DEBUG| [stdout] [ 3807.694462] [<00000000be310e0a>] schedule+0x4a/0xe0
14:49:46 DEBUG| [stdout] [ 3807.694467] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:49:46 DEBUG| [stdout] [ 3807.694470] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:49:46 DEBUG| [stdout] [ 3807.694512] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:49:46 DEBUG| [stdout] [ 3807.694515] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:49:46 DEBUG| [stdout] [ 3807.694517] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:49:46 DEBUG| [stdout] [ 3807.694519] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:49:46 DEBUG| [stdout] [ 3807.694520] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:49:46 DEBUG| [stdout] [ 3807.694522] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:49:48 DEBUG| [stdout] [ 3809.544356] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:49:58 DEBUG| [stdout] [ 3819.564421] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:08 DEBUG| [stdout] [ 3829.574345] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:18 DEBUG| [stdout] [ 3839.624346] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:28 DEBUG| [stdout] [ 3849.644403] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:39 DEBUG| [stdout] [ 3859.904379] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:49 DEBUG| [stdout] [ 3869.914380] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:50:59 DEBUG| [stdout] [ 3879.934358] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:09 DEBUG| [stdout] [ 3889.954341] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:19 DEBUG| [stdout] [ 3900.214390] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:29 DEBUG| [stdout] [ 3910.224359] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:39 DEBUG| [stdout] [ 3920.274391] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:49 DEBUG| [stdout] [ 3930.284403] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:51:49 DEBUG| [stdout] [ 3930.574457] INFO: task modprobe:2063628 blocked for more than 368 seconds.
14:51:49 DEBUG| [stdout] [ 3930.574467] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:51:49 DEBUG| [stdout] [ 3930.574468] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:51:49 DEBUG| [stdout] [ 3930.574471] modprobe D 0 2063628 2063618 0x08000000
14:51:49 DEBUG| [stdout] [ 3930.574473] Call Trace:
14:51:49 DEBUG| [stdout] [ 3930.574484] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:51:49 DEBUG| [stdout] [ 3930.574485] [<00000000be310e0a>] schedule+0x4a/0xe0
14:51:49 DEBUG| [stdout] [ 3930.574491] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:51:49 DEBUG| [stdout] [ 3930.574495] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:51:49 DEBUG| [stdout] [ 3930.574534] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:51:49 DEBUG| [stdout] [ 3930.574536] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:51:49 DEBUG| [stdout] [ 3930.574539] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:51:49 DEBUG| [stdout] [ 3930.574540] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:51:49 DEBUG| [stdout] [ 3930.574542] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:51:49 DEBUG| [stdout] [ 3930.574544] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:51:59 DEBUG| [stdout] [ 3940.544371] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:52:09 DEBUG| [stdout] [ 3950.654376] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:52:19 DEBUG| [stdout] [ 3960.694371] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:52:29 DEBUG| [stdout] [ 3970.704389] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:52:40 DEBUG| [stdout] [ 3980.724335] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:52:50 DEBUG| [stdout] [ 3990.984428] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:00 DEBUG| [stdout] [ 4001.244408] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:10 DEBUG| [stdout] [ 4011.504351] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:21 DEBUG| [stdout] [ 4021.764392] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:31 DEBUG| [stdout] [ 4031.874380] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:41 DEBUG| [stdout] [ 4041.914382] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:51 DEBUG| [stdout] [ 4051.954371] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:53:52 DEBUG| [stdout] [ 4053.454418] INFO: task modprobe:2063628 blocked for more than 491 seconds.
14:53:52 DEBUG| [stdout] [ 4053.454427] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:53:52 DEBUG| [stdout] [ 4053.454428] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:53:52 DEBUG| [stdout] [ 4053.454430] modprobe D 0 2063628 2063618 0x08000000
14:53:52 DEBUG| [stdout] [ 4053.454432] Call Trace:
14:53:52 DEBUG| [stdout] [ 4053.454442] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:53:52 DEBUG| [stdout] [ 4053.454444] [<00000000be310e0a>] schedule+0x4a/0xe0
14:53:52 DEBUG| [stdout] [ 4053.454449] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:53:52 DEBUG| [stdout] [ 4053.454452] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:53:52 DEBUG| [stdout] [ 4053.454495] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:53:52 DEBUG| [stdout] [ 4053.454497] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:53:52 DEBUG| [stdout] [ 4053.454500] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:53:52 DEBUG| [stdout] [ 4053.454501] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:53:52 DEBUG| [stdout] [ 4053.454503] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:53:52 DEBUG| [stdout] [ 4053.454505] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:54:01 DEBUG| [stdout] [ 4062.014420] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:54:11 DEBUG| [stdout] [ 4072.274351] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:54:21 DEBUG| [stdout] [ 4082.324323] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:54:31 DEBUG| [stdout] [ 4092.584360] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:54:41 DEBUG| [stdout] [ 4102.604440] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:54:51 DEBUG| [stdout] [ 4112.644378] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:02 DEBUG| [stdout] [ 4122.904341] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:12 DEBUG| [stdout] [ 4133.164335] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:22 DEBUG| [stdout] [ 4143.184368] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:32 DEBUG| [stdout] [ 4153.454367] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:42 DEBUG| [stdout] [ 4163.534357] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:52 DEBUG| [stdout] [ 4173.554329] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:55:55 DEBUG| [stdout] [ 4176.334391] INFO: task modprobe:2063628 blocked for more than 614 seconds.
14:55:55 DEBUG| [stdout] [ 4176.334401] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:55:55 DEBUG| [stdout] [ 4176.334402] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:55:55 DEBUG| [stdout] [ 4176.334405] modprobe D 0 2063628 2063618 0x08000000
14:55:55 DEBUG| [stdout] [ 4176.334407] Call Trace:
14:55:55 DEBUG| [stdout] [ 4176.334417] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:55:55 DEBUG| [stdout] [ 4176.334419] [<00000000be310e0a>] schedule+0x4a/0xe0
14:55:55 DEBUG| [stdout] [ 4176.334424] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:55:55 DEBUG| [stdout] [ 4176.334427] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:55:55 DEBUG| [stdout] [ 4176.334473] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:55:55 DEBUG| [stdout] [ 4176.334475] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:55:55 DEBUG| [stdout] [ 4176.334478] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:55:55 DEBUG| [stdout] [ 4176.334479] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:55:55 DEBUG| [stdout] [ 4176.334481] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:55:55 DEBUG| [stdout] [ 4176.334483] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:56:02 DEBUG| [stdout] [ 4183.584340] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:56:13 DEBUG| [stdout] [ 4193.844333] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:56:23 DEBUG| [stdout] [ 4203.864349] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:56:33 DEBUG| [stdout] [ 4213.874367] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:56:43 DEBUG| [stdout] [ 4223.894371] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:56:53 DEBUG| [stdout] [ 4234.164406] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:03 DEBUG| [stdout] [ 4244.184340] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:13 DEBUG| [stdout] [ 4254.444348] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:23 DEBUG| [stdout] [ 4264.464358] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:34 DEBUG| [stdout] [ 4274.724397] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:44 DEBUG| [stdout] [ 4284.984365] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:54 DEBUG| [stdout] [ 4295.244374] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:57:58 DEBUG| [stdout] [ 4299.214417] INFO: task modprobe:2063628 blocked for more than 737 seconds.
14:57:58 DEBUG| [stdout] [ 4299.214426] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
14:57:58 DEBUG| [stdout] [ 4299.214427] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
14:57:58 DEBUG| [stdout] [ 4299.214429] modprobe D 0 2063628 2063618 0x08000000
14:57:58 DEBUG| [stdout] [ 4299.214432] Call Trace:
14:57:58 DEBUG| [stdout] [ 4299.214442] ([<00000000be310914>] __schedule+0x304/0x7b0)
14:57:58 DEBUG| [stdout] [ 4299.214443] [<00000000be310e0a>] schedule+0x4a/0xe0
14:57:58 DEBUG| [stdout] [ 4299.214449] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
14:57:58 DEBUG| [stdout] [ 4299.214452] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
14:57:58 DEBUG| [stdout] [ 4299.214492] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
14:57:58 DEBUG| [stdout] [ 4299.214494] [<00000000bda288c0>] do_one_initcall+0x40/0x200
14:57:58 DEBUG| [stdout] [ 4299.214497] [<00000000bdb594a0>] do_init_module+0x70/0x270
14:57:58 DEBUG| [stdout] [ 4299.214498] [<00000000bdb5b892>] load_module+0x1142/0x1440
14:57:58 DEBUG| [stdout] [ 4299.214500] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
14:57:58 DEBUG| [stdout] [ 4299.214502] [<00000000be315fc6>] system_call+0x2aa/0x2c8
14:58:04 DEBUG| [stdout] [ 4305.504344] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:58:15 DEBUG| [stdout] [ 4315.764380] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:58:25 DEBUG| [stdout] [ 4326.034327] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:58:35 DEBUG| [stdout] [ 4336.294373] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:58:45 DEBUG| [stdout] [ 4346.554338] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:58:56 DEBUG| [stdout] [ 4356.814344] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:06 DEBUG| [stdout] [ 4367.074314] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:16 DEBUG| [stdout] [ 4377.334371] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:26 DEBUG| [stdout] [ 4387.364386] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:36 DEBUG| [stdout] [ 4397.624409] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:47 DEBUG| [stdout] [ 4407.884422] unregister_netdevice: waiting for lo to become free. Usage count = 1
14:59:57 DEBUG| [stdout] [ 4418.144379] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:01 DEBUG| [stdout] [ 4422.094438] INFO: task modprobe:2063628 blocked for more than 860 seconds.
15:00:01 DEBUG| [stdout] [ 4422.094448] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
15:00:01 DEBUG| [stdout] [ 4422.094449] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
15:00:01 DEBUG| [stdout] [ 4422.094451] modprobe D 0 2063628 2063618 0x08000000
15:00:01 DEBUG| [stdout] [ 4422.094454] Call Trace:
15:00:01 DEBUG| [stdout] [ 4422.094464] ([<00000000be310914>] __schedule+0x304/0x7b0)
15:00:01 DEBUG| [stdout] [ 4422.094466] [<00000000be310e0a>] schedule+0x4a/0xe0
15:00:01 DEBUG| [stdout] [ 4422.094471] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
15:00:01 DEBUG| [stdout] [ 4422.094474] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
15:00:01 DEBUG| [stdout] [ 4422.094517] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
15:00:01 DEBUG| [stdout] [ 4422.094519] [<00000000bda288c0>] do_one_initcall+0x40/0x200
15:00:01 DEBUG| [stdout] [ 4422.094522] [<00000000bdb594a0>] do_init_module+0x70/0x270
15:00:01 DEBUG| [stdout] [ 4422.094524] [<00000000bdb5b892>] load_module+0x1142/0x1440
15:00:01 DEBUG| [stdout] [ 4422.094525] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
15:00:01 DEBUG| [stdout] [ 4422.094527] [<00000000be315fc6>] system_call+0x2aa/0x2c8
15:00:07 DEBUG| [stdout] [ 4428.204380] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:17 DEBUG| [stdout] [ 4438.224364] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:27 DEBUG| [stdout] [ 4448.494371] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:37 DEBUG| [stdout] [ 4458.504340] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:47 DEBUG| [stdout] [ 4468.514346] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:00:57 DEBUG| [stdout] [ 4478.544321] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:07 DEBUG| [stdout] [ 4488.574327] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:17 DEBUG| [stdout] [ 4498.644341] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:27 DEBUG| [stdout] [ 4508.694366] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:38 DEBUG| [stdout] [ 4518.724420] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:48 DEBUG| [stdout] [ 4528.984393] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:01:58 DEBUG| [stdout] [ 4539.004406] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:04 DEBUG| [stdout] [ 4544.974468] INFO: task modprobe:2063628 blocked for more than 983 seconds.
15:02:04 DEBUG| [stdout] [ 4544.974478] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
15:02:04 DEBUG| [stdout] [ 4544.974479] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
15:02:04 DEBUG| [stdout] [ 4544.974482] modprobe D 0 2063628 2063618 0x08000000
15:02:04 DEBUG| [stdout] [ 4544.974484] Call Trace:
15:02:04 DEBUG| [stdout] [ 4544.974496] ([<00000000be310914>] __schedule+0x304/0x7b0)
15:02:04 DEBUG| [stdout] [ 4544.974497] [<00000000be310e0a>] schedule+0x4a/0xe0
15:02:04 DEBUG| [stdout] [ 4544.974503] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
15:02:04 DEBUG| [stdout] [ 4544.974506] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
15:02:04 DEBUG| [stdout] [ 4544.974550] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
15:02:04 DEBUG| [stdout] [ 4544.974552] [<00000000bda288c0>] do_one_initcall+0x40/0x200
15:02:04 DEBUG| [stdout] [ 4544.974555] [<00000000bdb594a0>] do_init_module+0x70/0x270
15:02:04 DEBUG| [stdout] [ 4544.974557] [<00000000bdb5b892>] load_module+0x1142/0x1440
15:02:04 DEBUG| [stdout] [ 4544.974558] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
15:02:04 DEBUG| [stdout] [ 4544.974560] [<00000000be315fc6>] system_call+0x2aa/0x2c8
15:02:08 DEBUG| [stdout] [ 4549.264370] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:18 DEBUG| [stdout] [ 4559.284391] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:28 DEBUG| [stdout] [ 4569.544440] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:39 DEBUG| [stdout] [ 4579.804498] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:49 DEBUG| [stdout] [ 4590.064480] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:02:59 DEBUG| [stdout] [ 4600.334382] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:03:09 DEBUG| [stdout] [ 4610.604381] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:03:19 DEBUG| [stdout] [ 4620.624435] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:03:30 DEBUG| [stdout] [ 4630.884408] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:03:40 DEBUG| [stdout] [ 4640.904423] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:03:50 DEBUG| [stdout] [ 4651.164374] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:00 DEBUG| [stdout] [ 4661.194393] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:07 DEBUG| [stdout] [ 4667.854393] INFO: task modprobe:2063628 blocked for more than 1105 seconds.
15:04:07 DEBUG| [stdout] [ 4667.854402] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
15:04:07 DEBUG| [stdout] [ 4667.854404] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
15:04:07 DEBUG| [stdout] [ 4667.854406] modprobe D 0 2063628 2063618 0x08000000
15:04:07 DEBUG| [stdout] [ 4667.854408] Call Trace:
15:04:07 DEBUG| [stdout] [ 4667.854418] ([<00000000be310914>] __schedule+0x304/0x7b0)
15:04:07 DEBUG| [stdout] [ 4667.854420] [<00000000be310e0a>] schedule+0x4a/0xe0
15:04:07 DEBUG| [stdout] [ 4667.854425] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
15:04:07 DEBUG| [stdout] [ 4667.854428] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
15:04:07 DEBUG| [stdout] [ 4667.854470] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
15:04:07 DEBUG| [stdout] [ 4667.854472] [<00000000bda288c0>] do_one_initcall+0x40/0x200
15:04:07 DEBUG| [stdout] [ 4667.854475] [<00000000bdb594a0>] do_init_module+0x70/0x270
15:04:07 DEBUG| [stdout] [ 4667.854476] [<00000000bdb5b892>] load_module+0x1142/0x1440
15:04:07 DEBUG| [stdout] [ 4667.854478] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0
15:04:07 DEBUG| [stdout] [ 4667.854480] [<00000000be315fc6>] system_call+0x2aa/0x2c8
15:04:10 DEBUG| [stdout] [ 4671.324360] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:20 DEBUG| [stdout] [ 4681.584418] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:31 DEBUG| [stdout] [ 4691.854370] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:41 DEBUG| [stdout] [ 4702.114397] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:04:51 DEBUG| [stdout] [ 4712.124402] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:01 DEBUG| [stdout] [ 4722.144379] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:11 DEBUG| [stdout] [ 4732.404372] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:21 DEBUG| [stdout] [ 4742.664409] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:32 DEBUG| [stdout] [ 4752.924361] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:42 DEBUG| [stdout] [ 4763.184352] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:05:52 DEBUG| [stdout] [ 4773.444396] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:06:02 DEBUG| [stdout] [ 4783.704422] unregister_netdevice: waiting for lo to become free. Usage count = 1
15:06:10 DEBUG| [stdout] [ 4790.734424] INFO: task modprobe:2063628 blocked for more than 1228 seconds.
15:06:10 DEBUG| [stdout] [ 4790.734434] Tainted: P OE 5.4.0-7-generic #8-Ubuntu
15:06:10 DEBUG| [stdout] [ 4790.734436] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
15:06:10 DEBUG| [stdout] [ 4790.734438] modprobe D 0 2063628 2063618 0x08000000
15:06:10 DEBUG| [stdout] [ 4790.734441] Call Trace:
15:06:10 DEBUG| [stdout] [ 4790.734451] ([<00000000be310914>] __schedule+0x304/0x7b0)
15:06:10 DEBUG| [stdout] [ 4790.734453] [<00000000be310e0a>] schedule+0x4a/0xe0
15:06:10 DEBUG| [stdout] [ 4790.734459] [<00000000bdb071cc>] rwsem_down_write_slowpath+0x22c/0x530
15:06:10 DEBUG| [stdout] [ 4790.734462] [<00000000be14d66c>] register_pernet_subsys+0x2c/0x60
15:06:10 DEBUG| [stdout] [ 4790.734505] [<000003ff80766638>] sctp_init+0x2f0/0x520 [sctp]
15:06:10 DEBUG| [stdout] [ 4790.734508] [<00000000bda288c0>] do_one_initcall+0x40/0x200
15:06:10 DEBUG| [stdout] [ 4790.734510] [<00000000bdb594a0>] do_init_module+0x70/0x270
15:06:10 DEBUG| [stdout] [ 4790.734512] [<00000000bdb5b892>] load_module+0x1142/0x1440
15:06:10 DEBUG| [stdout] [ 4790.734513] [<00000000bdb5bdc4>] __do_sys_finit_module+0xa4/0xf0 1G

Revision history for this message
Colin Ian King (colin-king) wrote :

This stress test has not changed much lately, so I'm assuming this is a racy kernel regression.

Last stress-sctp changes in stress-ng were:

commit 27b045a498b360ccbc761c3b62e3dd38dd744f09
Author: Colin Ian King <email address hidden>
Date: Sat Aug 10 13:25:34 2019 +0100

    stress-sctp: voidify unused return

    Signed-off-by: Colin Ian King <email address hidden>

commit 29043afe6d3c2fa95d6ce22c88aa4545d070e722
Author: Colin Ian King <email address hidden>
Date: Wed Jun 26 12:42:00 2019 +0100

    stress-sctp: use setsockopt for more socket option exercising

Changed in linux (Ubuntu):
importance: Undecided → High
Revision history for this message
Colin Ian King (colin-king) wrote :

I can't easily reproduce this on a s390 VM instance.

Revision history for this message
Colin Ian King (colin-king) wrote :

net/core/dev.c netdev_wait_allrefs() states:

**
 * netdev_wait_allrefs - wait until all references are gone.
 * @dev: target net_device
 *
 * This is called when unregistering network devices.
 *
 * Any protocol or device that holds a reference should register
 * for netdevice notification, and cleanup and put back the
 * reference if they receive an UNREGISTER event.
 * We can get stuck here if buggy protocols don't correctly
 * call dev_put.
 */

...

                if (refcnt && time_after(jiffies, warning_time + 10 * HZ)) {
                        pr_emerg("unregister_netdevice: waiting for %s to become free. Usage count = %d\n",
                                 dev->name, refcnt);
                        warning_time = jiffies;
                }

Revision history for this message
Colin Ian King (colin-king) wrote :

The unregister_netdevice message appears after the af-alg stressor starts, so it maybe a crypto algo that is the root cause:

14:34:33 DEBUG| [stdout] af-alg STARTING
14:34:35 DEBUG| [stdout] [ 2895.954700] unregister_netdevice: waiting for lo to become free. Usage count = 1

Revision history for this message
Colin Ian King (colin-king) wrote :

This makes sense as the af-alg stressor now exercises a far wider set of crypto engines.

Revision history for this message
Ubuntu Kernel Bot (ubuntu-kernel-bot) wrote : Missing required logs.

This bug is missing log files that will aid in diagnosing the problem. While running an Ubuntu kernel (not a mainline or third-party kernel) please enter the following command in a terminal window:

apport-collect 1854968

and then change the status of the bug to 'Confirmed'.

If, due to the nature of the issue you have encountered, you are unable to run this command, please add a comment stating that fact and change the bug status to 'Confirmed'.

This change has been made by an automated script, maintained by the Ubuntu Kernel Team.

Changed in linux (Ubuntu):
status: New → Incomplete
Revision history for this message
Colin Ian King (colin-king) wrote :
Download full text (4.5 KiB)

And on an arm64 platform we have something similar:

15:55:45 DEBUG| [stdout] Number of CPUs: 4
15:55:45 DEBUG| [stdout] Number of CPUs Online: 4
15:55:45 DEBUG| [stdout]
15:55:45 DEBUG| [stdout] access STARTING
15:55:49 DEBUG| [stdout] [ 7016.776865] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:55:50 DEBUG| [stdout] access RETURNED 0
15:55:50 DEBUG| [stdout] access PASSED
15:55:50 DEBUG| [stdout] af-alg STARTING
15:55:50 DEBUG| [stdout] [ 7017.948549] cryptd: max_cpu_qlen set to 1000
15:55:55 DEBUG| [stdout] af-alg RETURNED 0
15:55:55 DEBUG| [stdout] af-alg PASSED
15:55:55 DEBUG| [stdout] affinity STARTING
15:55:59 DEBUG| [stdout] [ 7026.984742] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:56:00 DEBUG| [stdout] affinity RETURNED 0
15:56:00 DEBUG| [stdout] affinity PASSED
15:56:00 DEBUG| [stdout] aio STARTING
15:56:05 DEBUG| [stdout] aio RETURNED 0
15:56:05 DEBUG| [stdout] aio PASSED
15:56:05 DEBUG| [stdout] aiol STARTING
15:56:09 DEBUG| [stdout] [ 7037.068696] unregister_netdevice: waiting for eth0 to become free. Usage count = 1

...and a stack dump too. protocol family 5 is AF_APPLETALK and stress-ng does not use exercise this, so this is pretty weird and unexpected.

15:57:08 DEBUG| [stdout] [ 7096.221119] NET: Registered protocol family 5
15:57:10 DEBUG| [stdout] [ 7098.023954] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:57:20 DEBUG| [stdout] [ 7108.103839] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:57:30 DEBUG| [stdout] [ 7118.183729] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:57:41 DEBUG| [stdout] [ 7128.267622] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:57:51 DEBUG| [stdout] [ 7138.343507] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:01 DEBUG| [stdout] [ 7148.427381] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:11 DEBUG| [stdout] [ 7158.503282] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:21 DEBUG| [stdout] [ 7168.587157] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:31 DEBUG| [stdout] [ 7178.663042] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:41 DEBUG| [stdout] [ 7188.742924] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:58:51 DEBUG| [stdout] [ 7198.822826] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:01 DEBUG| [stdout] [ 7208.902688] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:11 DEBUG| [stdout] [ 7218.982579] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:21 DEBUG| [stdout] [ 7229.062465] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:31 DEBUG| [stdout] [ 7239.142348] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:42 DEBUG| [stdout] [ 7249.222274] unregister_netdevice: waiting for eth0 to become free. Usage count = 1
15:59:44 DEBUG| [stdout] [ 7251.334302] INFO: task modprobe:1184184 blocked for more than 120 second...

Read more...

Colin Ian King (colin-king)
Changed in linux (Ubuntu):
assignee: nobody → Colin Ian King (colin-king)
Revision history for this message
Colin Ian King (colin-king) wrote :

I added a background task to dump out new dmesg messages and I now see messages such as the following *before* any stress-ng tests run. I think we can therefore assume the damage to the kernel occurred in prior ADT tests.

11:02:46 DEBUG| [stdout] [ 3093.210307] unregister_netdevice: waiting for lo to become free. Usage count = 1

Current hypothesis is that corruption is happening with the bpf kernel regression tests.

Revision history for this message
Colin Ian King (colin-king) wrote :

The unregister_netdevice issue occurs running the kernel self test in testing/selftests/net/l2tp.sh after modprobing the l2tp driver. A hang can be the produced by running the stress-ng close stressor, this is just expediting an eventual hang caused by this test.

Revision history for this message
Colin Ian King (colin-king) wrote :

Easy steps to reproduce this issue:

sudo modprobe l2tp_core
sudo ./linux-5.4.0/tools/testing/selftests/net/l2tp.sh
./close

where close is compiled from:

#include <sys/types.h>
#include <sys/socket.h>
#include <unistd.h>
#include <stdio.h>

int main()
{
        int fd;

        printf("calling socket..\n");
        fd = socket(AF_APPLETALK, SOCK_STREAM, 0);
        printf("socket returned: %d\n", fd);
}

When running the above program we just see "calling socket" and it blocks forever on the socket call. After a couple of minutes we get the kernel hung task warning. We also see repeated messages:

unregister_netdevice: waiting for eth0 to become free. Usage count = 1

I'll bisect the kernel next.

Revision history for this message
Colin Ian King (colin-king) wrote :

Occurs between 5.3 and 5.4-rc1

Revision history for this message
Colin Ian King (colin-king) wrote :

Ah, fails on 5.2.0-15-generic, 5.3.0-18 generic too. Appears that the regression test was enabled quite recently:

commit b5b9181c2403025b2c7ae7ea44333fd8fe6dbb54 (between 5.4-rc3 and 5.4-rc4)
Author: David Ahern <email address hidden>
Date: Mon Oct 21 19:02:43 2019 -0600

    selftests: Make l2tp.sh executable

commit e858ef1cd4bc1bdfcd18114a8195236e336cee42 (between 5.4-rc3 and 5.4-rc4)
Author: David Ahern <email address hidden>
Date: Mon Aug 5 15:41:37 2019 -0700

Since this breaks in 5.3 then this issue is in eoan and hence is not a focal regression.

Revision history for this message
Colin Ian King (colin-king) wrote :
Download full text (6.8 KiB)

This goes right back to 4.6.x:

.6.7 crash (see below)
4.7.10 crash in xfrm6_dst_ifdown
4.8.17 crash in xfrm6_dst_ifdown
4.12.14 crash (see below)
4.13.16 reports "unregister_netdevice: waiting for eth0 to become free. Usage count = 2"
4.14.157 reports "unregister_netdevice: waiting for eth0 to become free. Usage count = 2""
4.15.18 .. 5.4 hangs on socket() call

4.6.7:
[ 34.457967] BUG: scheduling while atomic: kworker/u8:0/6/0x00000200
[ 34.458021] Modules linked in: esp6 xfrm6_mode_transport drbg ansi_cprng seqiv esp4 xfrm4_mode_transport xfrm_user xfrm_algo l2tp_ip6 l2tp_eth l2tp_ip l2tp_netlink veth l2tp_core ip6_udp_tunnel udp_tunnel squashfs binfmt_misc dm_multipath scsi_dh_rdac scsi_dh_emc scsi_dh_alua ppdev kvm_intel kvm irqbypass joydev input_leds snd_hda_codec_generic serio_raw snd_hda_intel snd_hda_codec parport_pc 8250_fintek parport snd_hda_core qemu_fw_cfg snd_hwdep snd_pcm snd_timer mac_hid snd soundcore sch_fq_codel virtio_rng ip_tables x_tables autofs4 btrfs raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx xor hid_generic usbhid hid raid6_pq libcrc32c raid1 raid0 multipath linear crct10dif_pclmul crc32_pclmul ghash_clmulni_intel qxl ttm drm_kms_helper syscopyarea sysfillrect aesni_intel sysimgblt
[ 34.458086] fb_sys_fops aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd i2c_piix4 drm psmouse pata_acpi floppy
[ 34.458100] CPU: 1 PID: 6 Comm: kworker/u8:0 Not tainted 4.6.7-040607-generic #201608160432
[ 34.458103] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 34.458131] Workqueue: netns cleanup_net
[ 34.458135] 0000000000000286 000000002fa171e7 ffff88007c8e7ab8 ffffffff813f7594
[ 34.458139] ffff88007fc96b80 7fffffffffffffff ffff88007c8e7ac8 ffffffff810a8f6b
[ 34.458143] ffff88007c8e7b18 ffffffff8184905b 00ff88007c8e7ae8 ffffffff8106463e
[ 34.458147] Call Trace:
[ 34.458161] [<ffffffff813f7594>] dump_stack+0x63/0x8f
[ 34.458166] [<ffffffff810a8f6b>] __schedule_bug+0x4b/0x60
[ 34.458185] [<ffffffff8184905b>] __schedule+0x5eb/0x7a0
[ 34.458191] [<ffffffff8106463e>] ? kvm_sched_clock_read+0x1e/0x30
[ 34.458195] [<ffffffff81849245>] schedule+0x35/0x80
[ 34.458203] [<ffffffff8184c402>] schedule_timeout+0x1b2/0x270
[ 34.458207] [<ffffffff81848d74>] ? __schedule+0x304/0x7a0
[ 34.458212] [<ffffffff81849ca3>] wait_for_completion+0xb3/0x140
[ 34.458217] [<ffffffff810aeed0>] ? wake_up_q+0x70/0x70
[ 34.458226] [<ffffffff810e7f68>] __wait_rcu_gp+0xc8/0xf0
[ 34.458231] [<ffffffff810e9fd8>] synchronize_sched.part.58+0x38/0x50
[ 34.458235] [<ffffffff810ec570>] ? call_rcu_bh+0x20/0x20
[ 34.458239] [<ffffffff810e7e80>] ? trace_raw_output_rcu_utilization+0x60/0x60
[ 34.458244] [<ffffffff810ec643>] synchronize_sched+0x33/0x40
[ 34.458251] [<ffffffffc0510f71>] __l2tp_session_unhash+0xd1/0xe0 [l2tp_core]
[ 34.458256] [<ffffffffc051101e>] l2tp_tunnel_closeall+0x9e/0x140 [l2tp_core]
[ 34.458261] [<ffffffffc0511219>] l2tp_tunnel_delete+0x19/0x70 [l2tp_core]
[ 34.458265] [<ffffffffc05112bb>] l2tp_exit_net+0x4b/0x80 [l2tp_core]
[ 34.458269] [<ffffffff81732188>] ops_exit_list.isra.4+0x38/0x60
[ 34.458273] [<...

Read more...

Revision history for this message
Colin Ian King (colin-king) wrote :

See: https://lkml.org/lkml/2019/12/5/476

Colin Ian King (colin-king)
Changed in linux (Ubuntu):
importance: High → Low
status: Incomplete → Triaged
Revision history for this message
Colin Ian King (colin-king) wrote :

AppleTalk is disabled on focal s390x 5.4.0-12 kernels so this bug cannot be tripped. Marking this as fixed released even though it's not a direct fix, it does stop the issue.

Changed in linux (Ubuntu):
status: Triaged → Fix Released
Revision history for this message
Colin Ian King (colin-king) wrote :

Just to say, I did retry the reproducer test and also re-ran the adt tests to double check that this no longer fails on 5.4.0-12.

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Duplicates of this bug

Subscribing...

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.