[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20170928075531.GV17200@yexl-desktop>
Date: Thu, 28 Sep 2017 15:55:32 +0800
From: kernel test robot <xiaolong.ye@...el.com>
To: "Paul E. McKenney" <paulmck@...ux.vnet.ibm.com>
Cc: LKML <linux-kernel@...r.kernel.org>,
"Paul E. McKenney" <paulmck@...ux.vnet.ibm.com>, lkp@...org
Subject: [lkp-robot] [EXP] a74063662f:
INFO:task_blocked_for_more_than#seconds
FYI, we noticed the following commit:
commit: a74063662f3a456a402bd40fa23e104196c78993 ("EXP: Fine-grained timer diagnostics")
https://git.kernel.org/cgit/linux/kernel/git/paulmck/linux-rcu.git dev.2017.09.21b
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu IvyBridge -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+--------------------------------------------------+------------+------------+
| | ad6a4baa92 | a74063662f |
+--------------------------------------------------+------------+------------+
| boot_successes | 24 | 1 |
| boot_failures | 0 | 21 |
| BUG:kernel_hang_in_boot_stage | 0 | 12 |
| INFO:task_blocked_for_more_than#seconds | 0 | 9 |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0 | 9 |
+--------------------------------------------------+------------+------------+
[ 245.387603] INFO: task swapper:1 blocked for more than 120 seconds.
[ 245.391458] Not tainted 4.14.0-rc1-00036-ga740636 #1
[ 245.394939] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 245.399647] swapper D 0 1 0 0x80000000
[ 245.402789] Call Trace:
[ 245.404509] ? __schedule+0x221/0x5c0
[ 245.406281] ? schedule+0x1b/0x30
[ 245.408629] ? schedule_timeout+0x1a5/0x380
[ 245.411794] ? trace_hardirqs_on_caller+0x10c/0x190
[ 245.414410] ? wait_for_completion+0xf3/0x140
[ 245.416345] ? do_task_dead+0x40/0x40
[ 245.419067] ? kthread_stop+0x2f/0x60
[ 245.421645] ? test_rht_init+0x834/0x883
[ 245.424521] ? config_sync_direct_show+0x40/0x40
[ 245.426762] ? config_sync_direct_show+0x40/0x40
[ 245.429468] ? list_sort_test+0x1c6/0x1c6
[ 245.432146] ? do_one_initcall+0x79/0x119
[ 245.434786] ? parse_args+0xc0/0x300
[ 245.436898] ? kernel_init_freeable+0xc9/0x15b
[ 245.439583] ? kernel_init_freeable+0xe6/0x15b
[ 245.442276] ? rest_init+0x90/0x90
[ 245.444435] ? kernel_init+0x5/0xf0
[ 245.446290] ? ret_from_fork+0x19/0x30
[ 245.448983]
[ 245.448983] Showing all locks held in the system:
[ 245.453032] 2 locks held by khungtaskd/9:
[ 245.455878] #0: (rcu_read_lock){....}, at: [<b10ac7eb>] watchdog+0x9b/0x390
[ 245.460547] #1: (tasklist_lock){.+.+}, at: [<b1075d00>] debug_show_all_locks+0x30/0x1a0
[ 245.466089]
[ 245.468114] =============================================
[ 245.468114]
[ 245.472781] Kernel panic - not syncing: hung_task: blocked tasks
[ 245.475726] CPU: 0 PID: 9 Comm: khungtaskd Not tainted 4.14.0-rc1-00036-ga740636 #1
[ 245.475728] Call Trace:
[ 245.475728] ? panic+0x8a/0x1ac
[ 245.475728] ? watchdog+0x390/0x390
[ 245.475728] ? kthread+0x10b/0x140
[ 245.475728] ? hung_task_panic+0x10/0x10
[ 245.475728] ? __kthread_create_on_node+0x160/0x160
[ 245.475728] ? ret_from_fork+0x19/0x30
[ 245.475728] Kernel Offset: disabled
Elapsed time: 250
initrds=(
/osimage/yocto/yocto-tiny-i386-2016-04-22.cgz
/lkp/scheduled/vm-ivb41-yocto-ia32-21/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-a74063662f3a456a402bd40fa23e104196c78993-20170926-10223-190qn8m-0.cgz
/lkp/lkp/lkp-i386.cgz
/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig.i386_2016-09-03.cgz
/osimage/pkg/static/trinity-i386.cgz
)
cat "${initrds[@]}" > /fs/sda5/initrd-vm-ivb41-yocto-ia32-21
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu IvyBridge
-kernel /pkg/linux/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/vmlinuz-4.14.0-rc1-00036-ga740636
-initrd /fs/sda5/initrd-vm-ivb41-yocto-ia32-21
-m 420
-smp 1
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-watchdog-action debug
-rtc base=localtime
-drive file=/fs/sda5/disk0-vm-ivb41-yocto-ia32-21,media=disk,if=virtio
-pidfile /dev/shm/kboot/pid-vm-ivb41-yocto-ia32-21
-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-21/serial
-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-21/kmsg
-daemonize
-display none
-monitor null
)
append=(
ip=::::vm-ivb41-yocto-ia32-21::dhcp
root=/dev/ram0
user=lkp
job=/lkp/scheduled/vm-ivb41-yocto-ia32-21/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-a74063662f3a456a402bd40fa23e104196c78993-20170926-10223-190qn8m-0.yaml
ARCH=i386
kconfig=i386-randconfig-b0-09251522
branch=linux-devel/devel-hourly-2017092501
commit=a74063662f3a456a402bd40fa23e104196c78993
BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/vmlinuz-4.14.0-rc1-00036-ga740636
max_uptime=1500
RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-ia32/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/0
LKP_SERVER=inn
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
View attachment "config-4.14.0-rc1-00036-ga740636" of type "text/plain" (77553 bytes)
View attachment "job-script" of type "text/plain" (3759 bytes)
Download attachment "dmesg.xz" of type "application/x-xz" (7120 bytes)
Powered by blists - more mailing lists