[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2020-02-11 Thread Colin Ian King
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

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Fix Released

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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_netdevi

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2020-02-11 Thread Colin Ian King
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.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Fix Released

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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:

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-06 Thread Colin Ian King
** Changed in: linux (Ubuntu)
   Importance: High => Low

** Changed in: linux (Ubuntu)
   Status: Incomplete => Triaged

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Triaged

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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 f

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
See: https://lkml.org/lkml/2019/12/5/476

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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] 

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
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/0x0200
[   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]  0286 2fa171e7 88007c8e7ab8 
813f7594
[   34.458139]  88007fc96b80 7fff 88007c8e7ac8 
810a8f6b
[   34.458143]  88007c8e7b18 8184905b 00ff88007c8e7ae8 
8106463e
[   34.458147] Call Trace:
[   34.458161]  [] dump_stack+0x63/0x8f
[   34.458166]  [] __schedule_bug+0x4b/0x60
[   34.458185]  [] __schedule+0x5eb/0x7a0
[   34.458191]  [] ? kvm_sched_clock_read+0x1e/0x30
[   34.458195]  [] schedule+0x35/0x80
[   34.458203]  [] schedule_timeout+0x1b2/0x270
[   34.458207]  [] ? __schedule+0x304/0x7a0
[   34.458212]  [] wait_for_completion+0xb3/0x140
[   34.458217]  [] ? wake_up_q+0x70/0x70
[   34.458226]  [] __wait_rcu_gp+0xc8/0xf0
[   34.458231]  [] synchronize_sched.part.58+0x38/0x50
[   34.458235]  [] ? call_rcu_bh+0x20/0x20
[   34.458239]  [] ? 
trace_raw_output_rcu_utilization+0x60/0x60
[   34.458244]  [] synchronize_sched+0x33/0x40
[   34.458251]  [] __l2tp_session_unhash+0xd1/0xe0 [l2tp_core]
[   34.458256]  [] l2tp_tunnel_closeall+0x9e/0x140 [l2tp_core]
[   34.458261]  [] l2tp_tunnel_delete+0x19/0x70 [l2tp_core]
[   34.458265]  [] l2tp_exit_net+0x4b/0x80 [l2tp_core]
[   34.458269]  [] ops_exit_list.isra.4+0x38/0x60
[   34.458273]  [] cleanup_net+0x1c4/0x2a0
[   34.458281]  [] process_one_work+0x1fc/0x490
[   34.458285]  [] worker_thread+0x4b/0x500
[   34.458290]  [] ? process_one_work+0x490/0x490
[   34.458293]  [] kthread+0xd8/0xf0
[   34.458298]  [] ret_from_fork+0x22/0x40
[   34.458302]  [] ? kthread_create_on_node+0x1b0/0x1b0
[   34.514067] [ cut here ]

4.12.14:
[   20.760253] [ cut here ]
[   20.760256] kernel BUG at /home/kernel/COD/linux/net/ipv6/xfrm6_policy.c:265!
[   20.760299] invalid opcode:  [#1] SMP
[   20.760320] Modules linked in: appletalk psnap llc esp6 xfrm6_mode_transport 
esp4 xfrm4_mode_transport xfrm_user xfrm_algo l2tp_ip6 l2tp_eth l2tp_ip 
l2tp_netlink veth l2tp_core ip6_udp_tunnel udp_tunnel binfmt_misc dm_multipath 
scsi_dh_rdac scsi_dh_emc scsi_dh_alua joydev ppdev snd_hda_codec_generic 
kvm_intel kvm irqbypass snd_hda_intel snd_hda_codec snd_hda_core input_leds 
snd_hwdep serio_raw snd_pcm snd_timer hid_generic snd soundcore parport_pc 
parport mac_hid qemu_fw_cfg sch_fq_codel virtio_rng ip_tables x_tables autofs4 
usbhid hid btrfs raid10 raid456 async_raid6_recov async_memcpy async_pq 
async_xor async_tx xor raid6_pq libcrc32c raid1 raid0 multipath linear 
crct10dif_pclmul crc32_pclmul ghash_clmulni_intel pcbc aesni_intel aes_x86_64 
crypto_simd qxl glue_helper ttm cryptd drm_kms_helper psmouse
[   20.760677]  syscopyarea sysfillrect virtio_blk sysimgblt fb_sys_fops drm 
floppy virtio_net i2c_piix4 pata_acpi
[   20.760731] CPU: 3 PID: 49 Comm: kworker/u8:1 Not tainted 
4.12.14-041214-generic #201709200843
[   20.760772] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 
1.12.0-1 04/01/2014
[   20.760814] Workqueue: netns cleanup_net
[   20.760836] task: 8aa4bcbbad00 task.stack: 9dc5804c
[   20.760867] RIP: 0010:xfrm6_dst_ifdown+0xa0/0xb0
[   20.760890] RSP: 0018:9dc5804c3be0 EFLAGS: 00010246
[   20.760916] RAX: 8aa4b6e6a000 RBX: 8aa4bc1b3500 RCX: 
[   20.760950] RDX: 0001 RSI: 8aa4b6f39000 RDI: 8aa4bc1b3500
[   20.760984] RBP: 9dc5804c3c08 R08: 000

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
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 
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 
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.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
Occurs between 5.3 and 5.4-rc1

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
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 
#include 
#include 
#include 

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.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
system_call+0x2aa/0x2c8 
  14:47:47 DEBUG| [stdout] [ 3688.014291] unregister_netdevice: waiting for lo 
to become f

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-05 Thread Colin Ian King
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.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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] 

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-04 Thread Colin Ian King
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.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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 =

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
** Changed in: linux (Ubuntu)
 Assignee: (unassigned) => Colin Ian King (colin-king)

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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 coun

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
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.74] 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 seconds.
15:59:44 DEBUG| [stdout] [ 7251.335644]   Tainted: G   OE 
5.4.0-7-generic #8-Ubuntu
15:59:44 DEBUG| [stdout] [ 7251.336889] "echo 0 > 
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
15:59:44 DEBUG| [stdout] [ 7251.338455] modprobeD0 1184184 1142782 
0x0028
15:59:44 DEBUG| [stdout] [ 7251.338461] Call trace:
15:59:44 DEBUG| [stdout] [ 7251.338472]  __switch_to+0xe4/0x148
15:59:44 DEBUG| [stdout] [ 7251.338478]  __schedule+0x2fc/0x7c0
15:59:44 DEBUG| [stdout] [ 7251.338489]  schedule+0x3c/0xb8
15:59:44 DEBUG| [stdout] [ 7251.338501]  rwsem_down_write_slowpath+0x2e8/0x5b0
15:59:44 DEBUG| [stdout] [ 7251.338512]  down_write+0x70/0x80
15:59:44 DEBUG| [stdout] [ 7251.338525]  register_netdevice_notifier+0x4c/0x208
15:59:44 DEBUG| [stdout] [ 7251.338548]  atalk_init+0xa0/0x118 [appletalk]
15:59:44 DEBUG| [stdout] [ 7251.338570]  do_one_initcall+0x50/0x220
15:59:44 DEBUG| [stdout] [ 7251.338575]  do_init_module+0x5c/0x248
15:59:44 DEBUG| [stdout] [ 7251.338582]  load_module+0xecc/0x1170
15:59:44 DEBUG| [stdout] [ 7251.338585]  __do_sys_finit_module+0xac/0x110
15:59:44 DEBUG| [stdout] [ 7251.338587]  __arm64_sys_finit_module+0x28/0x38
15:59:44 DEBUG| [stdout] [ 7251.338591]  el0_svc_common.constprop.0+0xdc/0x1d8
15:59:44 DEBUG| [stdout] [ 7251.338593]  el0_svc_handler+0x34/0xa0
15:59:44 DEBUG| [stdout] [ 7251.338595]  el0_svc+0x10/0x14

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  Incomplete

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

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
I can't easily reproduce this on a s390 VM instance.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  New

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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.734

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
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;
}

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  New

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
system_call+0x2aa/0x2c8

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
This makes sense as the af-alg stressor now exercises a far wider set of
crypto engines.

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  New

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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
 

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
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

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  New

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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.214

[Kernel-packages] [Bug 1854968] Re: stress-ng sctp stressor breaks 5.4.0.7-8 on s390x

2019-12-03 Thread Colin Ian King
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 
Date:   Sat Aug 10 13:25:34 2019 +0100

stress-sctp: voidify unused return

Signed-off-by: Colin Ian King 

commit 29043afe6d3c2fa95d6ce22c88aa4545d070e722
Author: Colin Ian King 
Date:   Wed Jun 26 12:42:00 2019 +0100

stress-sctp: use setsockopt for more socket option exercising

-- 
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1854968

Title:
  stress-ng sctp stressor breaks 5.4.0.7-8  on s390x

Status in linux package in Ubuntu:
  New

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] modprobeD0 2063628 
2063618 0x0800
  14:47:44 DEBUG| [stdout] [ 3684.814351] Call Trace:
  14:47:44 DEBUG| [stdout] [ 3684.814360] ([] 
__schedule+0x304/0x7b0)
  14:47:44 DEBUG| [stdout] [ 3684.814362]  [] 
schedule+0x4a/0xe0 
  14:47:44 DEBUG| [stdout] [ 3684.814366]  [] 
rwsem_down_write_slowpath+0x22c/0x530 
  14:47:44 DEBUG| [stdout] [ 3684.814370]  [] 
register_pernet_subsys+0x2c/0x60 
  14:47:44 DEBUG| [stdout] [ 3684.814411]  [<03ff80766638>] 
sctp_init+0x2f0/0x520 [sctp] 
  14:47:44 DEBUG| [stdout] [ 3684.814414]  [] 
do_one_initcall+0x40/0x200 
  14:47:44 DEBUG| [stdout] [ 3684.814416]  [] 
do_init_module+0x70/0x270 
  14:47:44 DEBUG| [stdout] [ 3684.814418]  [] 
load_module+0x1142/0x1440 
  14:47:44 DEBUG| [stdout] [ 3684.814419]  [] 
__do_sys_finit_module+0xa4/0xf0 
  14:47:44 DEBUG| [stdout] [ 3684.814421]  [] 
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]