[<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