lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite for Android: free password hash cracker in your pocket
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <5bf0d0d9.2S1lqKo/21KXGcuH%lkp@intel.com>
Date:   Sun, 18 Nov 2018 10:39:21 +0800
From:   kernel test robot <lkp@...el.com>
To:     Omar Sandoval <osandov@...com>
Cc:     LKP <lkp@...org>, linux-kernel@...r.kernel.org,
        linux-block@...r.kernel.org, Jens Axboe <axboe@...nel.dk>
Subject: a9f38e1dec ("floppy: convert to blk-mq"):  INFO: task mount:661
 blocked for more than 120 seconds.

Greetings,

0day kernel testing robot got the below dmesg and the first bad commit is

https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master

commit a9f38e1dec107af70d81338332494bf0a1e76597
Author:     Omar Sandoval <osandov@...com>
AuthorDate: Mon Oct 15 09:21:34 2018 -0600
Commit:     Jens Axboe <axboe@...nel.dk>
CommitDate: Tue Oct 16 09:50:14 2018 -0600

    floppy: convert to blk-mq
    
    This driver likes to fetch requests from all over the place, so make
    queue_rq put requests on a list so that the logic stays the same. Tested
    with QEMU.
    
    Signed-off-by: Omar Sandoval <osandov@...com>
    
    Converted to blk_mq_init_sq_queue() and fixed a few spots where the
    tag_set leaked on cleanup.
    
    Signed-off-by: Jens Axboe <axboe@...nel.dk>

6ec3938cff  ataflop: convert to blk-mq
a9f38e1dec  floppy: convert to blk-mq
1ce80e0fe9  Merge tag 'fsnotify_for_v4.20-rc3' of git://git.kernel.org/pub/scm/linux/kernel/git/jack/linux-fs
0821492104  Add linux-next specific files for 20181116
+--------------------------------------------------+------------+------------+------------+---------------+
|                                                  | 6ec3938cff | a9f38e1dec | 1ce80e0fe9 | next-20181116 |
+--------------------------------------------------+------------+------------+------------+---------------+
| boot_successes                                   | 194        | 49         | 47         | 55            |
| boot_failures                                    | 0          | 19         | 23         | 13            |
| INFO:task_blocked_for_more_than#seconds          | 0          | 19         | 23         | 13            |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0          | 19         | 23         | 13            |
| RIP:delay_tsc                                    | 0          | 1          | 3          | 1             |
| RIP:smp_reschedule_interrupt                     | 0          | 1          |            |               |
| RIP:native_safe_halt                             | 0          | 1          |            |               |
| RIP:set_next_entity                              | 0          | 1          |            |               |
+--------------------------------------------------+------------+------------+------------+---------------+

[    9.822672] floppy: error 10 while reading block 0
[    9.849337] floppy: error 10 while reading block 0
[   61.376436] Writes:  Total: 57441655  Max/Min: 0/0   Fail: 0 
[  122.816014] Writes:  Total: 125315933  Max/Min: 0/0   Fail: 0 
[  184.255930] Writes:  Total: 188657228  Max/Min: 0/0   Fail: 0 
[  245.696025] INFO: task mount:661 blocked for more than 120 seconds.
[  245.697504]       Not tainted 4.19.0-rc6-00172-ga9f38e1 #1
[  245.698209] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  245.699213] mount           D    0   661    420 0x00000000
[  245.699931] Call Trace:
[  245.700267]  ? __schedule+0x496/0x5b0
[  245.700743]  ? wait_for_completion+0xd7/0x180
[  245.701311]  schedule+0x70/0x90
[  245.701721]  schedule_timeout+0x37/0x360
[  245.702115]  ? find_held_lock+0x2d/0x90
[  245.702517]  ? wait_for_completion+0xd7/0x180
[  245.702952]  wait_for_completion+0xf6/0x180
[  245.703377]  ? do_sched_yield+0x80/0x80
[  245.703760]  __floppy_read_block_0+0x165/0x1a0
[  245.704205]  ? floppy_find+0x50/0x50
[  245.704562]  floppy_revalidate+0x1c4/0x210
[  245.704968]  check_disk_change+0x4a/0x60
[  245.705381]  floppy_open+0x2c3/0x360
[  245.705738]  __blkdev_get+0x155/0x4d0
[  245.706110]  blkdev_get+0x2d6/0x3e0
[  245.706480]  ? ocfs2_initialize_super+0x1090/0x1090
[  245.707037]  blkdev_get_by_path+0x26/0x60
[  245.707445]  mount_bdev+0x3b/0x1a0
[  245.707785]  mount_fs+0xa/0x70
[  245.708092]  vfs_kern_mount+0x60/0x150
[  245.708495]  do_mount+0x90b/0xd10
[  245.708838]  ? __might_fault+0x24/0x30
[  245.709235]  ? memdup_user+0x39/0x60
[  245.709592]  ksys_mount+0x86/0xb0
[  245.709924]  __x64_sys_mount+0x1c/0x20
[  245.710308]  do_syscall_64+0x51/0xe0
[  245.710666]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
[  245.711176] RIP: 0033:0x7f91fe8c421a
[  245.711535] Code: Bad RIP value.
[  245.711857] RSP: 002b:00007ffe25af5fe8 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
[  245.712616] RAX: ffffffffffffffda RBX: 0000000000008010 RCX: 00007f91fe8c421a
[  245.713318] RDX: 00000000015b5f70 RSI: 00007ffe25af6f14 RDI: 00007ffe25af6f0b
[  245.714039] RBP: 00007ffe25af6150 R08: 0000000000000000 R09: 0101010101010101
[  245.714740] R10: 0000000000008010 R11: 0000000000000206 R12: 00007f91fed906a8
[  245.715465] R13: 0000000000000000 R14: 00000000ffffffff R15: 00000000015b5fd0
[  245.716383] 
[  245.716383] Showing all locks held in the system:
[  245.717204] 1 lock held by khungtaskd/24:
[  245.717736]  #0: 0000000083235bb0 (rcu_read_lock){....}, at: debug_show_all_locks+0x16/0x120
[  245.718852] 2 locks held by torture_shuffle/129:
[  245.719501] 3 locks held by mount/661:
[  245.720002]  #0: 00000000f7fd944d (&bdev->bd_mutex){....}, at: __blkdev_get+0x44e/0x4d0
[  245.721076]  #1: 00000000c4114bad (floppy_mutex){....}, at: floppy_open+0x30/0x360
[  245.722078]  #2: 00000000f9c6db70 (open_lock){....}, at: floppy_open+0x41/0x360
[  245.723019] 
[  245.723229] =============================================
[  245.723229] 
[  245.724105] NMI backtrace for cpu 1
[  245.724558] CPU: 1 PID: 24 Comm: khungtaskd Not tainted 4.19.0-rc6-00172-ga9f38e1 #1
[  245.725543] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  245.726599] Call Trace:
[  245.726921]  dump_stack+0x5c/0x7b
[  245.727355]  nmi_cpu_backtrace+0x81/0x90
[  245.727860]  ? lapic_can_unplug_cpu+0x90/0x90
[  245.728423]  nmi_trigger_cpumask_backtrace+0x4e/0xd0
[  245.729059]  watchdog+0x3b5/0x3f0
[  245.729494]  kthread+0x113/0x120
[  245.729912]  ? hung_task_panic+0x10/0x10
[  245.730437]  ? __kthread_bind_mask+0x60/0x60
[  245.730985]  ret_from_fork+0x1f/0x30
[  245.731458] Sending NMI from CPU 1 to CPUs 0:
[  245.732041] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10
[  245.733026] Kernel panic - not syncing: hung_task: blocked tasks
[  245.733875] CPU: 1 PID: 24 Comm: khungtaskd Not tainted 4.19.0-rc6-00172-ga9f38e1 #1
[  245.734858] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  245.735934] Call Trace:
[  245.736260]  dump_stack+0x5c/0x7b
[  245.736690]  panic+0xd0/0x22b
[  245.737079]  watchdog+0x3c1/0x3f0
[  245.737512]  kthread+0x113/0x120
[  245.737927]  ? hung_task_panic+0x10/0x10
[  245.738432]  ? __kthread_bind_mask+0x60/0x60
[  245.738956]  ret_from_fork+0x1f/0x30
[  245.739376] Kernel Offset: disabled


                                                          # HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start ccda4af0f4b92f7b4c308d3acc262f4a7e3affad v4.19 --
git bisect  bad ac435075892e3e651c667b4a9f2267cf3ef1d5a2  # 04:21  B     15     1    0   0  Merge tag 'csky-for-linus-4.20' of https://github.com/c-sky/csky-linux
git bisect  bad 01aa9d518eae8a4d75cd3049defc6ed0b6d0a658  # 04:41  B     32     4    0   0  Merge tag 'docs-4.20' of git://git.lwn.net/linux
git bisect  bad e1d20beae70eb918cca7f07a77ce199fd148fdd2  # 04:57  B     38     3    0   0  Merge branch 'x86-asm-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect  bad c403993a41d50db1e7d9bc2d43c3c8498162312f  # 05:22  B     19     2    0   0  Merge tag 'for-linus-4.20' of https://github.com/cminyard/linux-ipmi
git bisect  bad 6214a9fe2aeca5e22184b20954774424e2efc1f6  # 05:38  B     29     1    0   0  Merge tag 'regmap-v5.0' of git://git.kernel.org/pub/scm/linux/kernel/git/broonie/regmap
git bisect  bad 13775dacca5c158a257320f4b47e1220b82e3b21  # 05:57  B     47     2    1   2  Merge tag 'for-4.20/libata-20181021' of git://git.kernel.dk/linux-block
git bisect good 528985117126f11beea339cf39120ee99da04cd2  # 06:23  G     68     0    1   1  Merge tag 'arm64-upstream' of git://git.kernel.org/pub/scm/linux/kernel/git/arm64/linux
git bisect  bad 6ab9e09238fdfd742fe23b81e2d385a1cab49d9b  # 06:40  B     47    19    0   0  Merge tag 'for-4.20/block-20181021' of git://git.kernel.dk/linux-block
git bisect good 2cf99bbd106f89fc72f778e8ad9d5538f1ef939b  # 06:56  G     67     0    0   0  lightnvm: pblk: add helpers for chunk addresses
git bisect good fab1adcf9503ccf191aec9ee42580f7dc1eb6237  # 07:12  G     68     0    1   1  ps3disk: convert to blk-mq
git bisect  bad 40581d1a91a1527e1e15350e479156810a389a96  # 07:32  B     28     2    0   0  nvme-pci: fix nvme_suspend_queue() kernel-doc header
git bisect good 3e6b8c3c4b14f4f0c4a74027156eb31544c0b0da  # 07:50  G     64     0    0   0  ataflop: fold headers into C file
git bisect  bad 0585b75437d335c6580066c1ab9ea3092139df32  # 08:08  B     33     5    0   0  sx8: convert to blk-mq
git bisect  bad a9f38e1dec107af70d81338332494bf0a1e76597  # 08:27  B     15     1    0   0  floppy: convert to blk-mq
git bisect good 6ec3938cff95fe792a05fdf4ba14f92977e5e31d  # 08:49  G     66     0    0   0  ataflop: convert to blk-mq
# first bad commit: [a9f38e1dec107af70d81338332494bf0a1e76597] floppy: convert to blk-mq
git bisect good 6ec3938cff95fe792a05fdf4ba14f92977e5e31d  # 09:02  G    186     0    2   2  ataflop: convert to blk-mq
# extra tests with debug options
git bisect  bad a9f38e1dec107af70d81338332494bf0a1e76597  # 09:18  B     28     2    1   1  floppy: convert to blk-mq
# extra tests on HEAD of linux-devel/devel-spot-201811172042
git bisect  bad 6124b3bde8b63d3d258222f314372af20070f0c3  # 09:24  B      9     4    0   0  0day head guard for 'devel-spot-201811172042'
# extra tests on tree/branch linus/master
git bisect  bad 1ce80e0fe98e72af4125f47c65b0bc01b60a7feb  # 09:46  B     43     1    0   0  Merge tag 'fsnotify_for_v4.20-rc3' of git://git.kernel.org/pub/scm/linux/kernel/git/jack/linux-fs
# extra tests with first bad commit reverted
git bisect good eb42ecfb204d550b4c40c1c2e81405498ba08a64  # 10:13  G     65     0    0   0  Revert "floppy: convert to blk-mq"
# extra tests on tree/branch linux-next/master
git bisect  bad 0821492104244755800cb812b0e2e5887fa76f6a  # 10:31  B     24     2    0   0  Add linux-next specific files for 20181116

---
0-DAY kernel test infrastructure                Open Source Technology Center
https://lists.01.org/pipermail/lkp                          Intel Corporation

Download attachment "dmesg-yocto-lkp-kboot01-16:20181118082320:x86_64-randconfig-s2-11172114:4.19.0-rc6-00172-ga9f38e1:1.gz" of type "application/gzip" (21837 bytes)

Download attachment "dmesg-yocto-lkp-kboot01-13:20181118085317:x86_64-randconfig-s2-11172114:4.19.0-rc6-00171-g6ec3938c:1.gz" of type "application/gzip" (44659 bytes)

View attachment "reproduce-yocto-lkp-kboot01-16:20181118082320:x86_64-randconfig-s2-11172114:4.19.0-rc6-00172-ga9f38e1:1" of type "text/plain" (922 bytes)

View attachment "config-4.19.0-rc6-00172-ga9f38e1" of type "text/plain" (133637 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ