[<prev] [next>] [day] [month] [year] [list]
Date: Wed, 27 Jan 2016 08:45:53 +0800
From: kernel test robot <ying.huang@...ux.intel.com>
TO: Pantelis Antoniou <pantelis.antoniou@...sulko.com>
CC: Geert Uytterhoeven <geert+renesas@...der.be>
Subject: [lkp] [of] 78b8dbaa57: INFO: task swapper:1 blocked for more than
120 seconds.
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/geert/renesas-drivers.git topic/overlays
commit 78b8dbaa5715c56d5bc6e9d361856f8d92fe490c ("of: unittest: changeset helpers")
+-------------------------------------------------------+------------+------------+
| | d2ab96ea3d | 78b8dbaa57 |
+-------------------------------------------------------+------------+------------+
| boot_successes | 62 | 0 |
| boot_failures | 1 | 26 |
| BUG:unable_to_handle_kernel | 1 | |
| Oops | 1 | |
| EIP_is_at_perf_prepare_sample | 1 | |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 1 | |
| INFO:task_blocked_for_more_than#seconds | 0 | 26 |
| EIP_is_at_default_send_IPI_mask_logical | 0 | 22 |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0 | 22 |
| backtrace:of_unittest | 0 | 26 |
| backtrace:kernel_init_freeable | 0 | 26 |
| backtrace:watchdog | 0 | 22 |
| BUG:kernel_boot_hang | 0 | 4 |
+-------------------------------------------------------+------------+------------+
[ 3.504995] /testcase-data/phandle-tests/consumer-a: arguments longer than property
[ 3.982145] tsc: Refined TSC clocksource calibration: 2693.505 MHz
[ 3.983012] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d346f670a, max_idle_ns: 440795255135 ns
[ 240.329025] INFO: task swapper:1 blocked for more than 120 seconds.
[ 240.333860] Not tainted 4.5.0-rc1-00021-g78b8dba #107
[ 240.335123] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 240.336933] swapper D 00000000 5856 1 0 0x00000000
[ 240.338565] d3dffe00 00000046 cab95a00 00000000 d3dffe40 c8991cec c88912e0 00000000
[ 240.341284] 00000000 cab95a00 d3e10000 c76a1c90 d3e00000 d3e10000 d3dffe10 c827847b
[ 240.343539] c76a1c90 c8991cc0 d3dffe18 c827891f d3dffe5c c827e8b6 00000000 00000001
[ 240.345131] Call Trace:
[ 240.345609] [<c76a1c90>] ? native_save_fl+0x30/0x30
[ 240.346306] [<c827847b>] schedule+0x7b/0x180
[ 240.346923] [<c76a1c90>] ? native_save_fl+0x30/0x30
[ 240.347597] [<c827891f>] schedule_preempt_disabled+0x2f/0x60
[ 240.348429] [<c827e8b6>] mutex_lock_nested+0x446/0x940
[ 240.349156] [<c8137825>] ? of_changeset_apply+0x25/0x70
[ 240.349850] [<c8137825>] ? of_changeset_apply+0x25/0x70
[ 240.350564] [<c8137825>] of_changeset_apply+0x25/0x70
[ 240.351278] [<c8a95a55>] of_unittest+0xde4/0x16ee
[ 240.351945] [<c78f225a>] ? kfree+0x54a/0x680
[ 240.352563] [<c81cd6ab>] ? add_sysfs_fw_map_entry+0xad/0x102
[ 240.353324] [<c760219d>] ? do_one_initcall+0xcd/0x480
[ 240.354021] [<c8a94c71>] ? of_unittest_platform_populate+0x603/0x603
[ 240.354830] [<c76021d6>] do_one_initcall+0x106/0x480
[ 240.355522] [<c8a94c71>] ? of_unittest_platform_populate+0x603/0x603
[ 240.356352] [<c8a06e6d>] ? kernel_init_freeable+0x422/0x5be
[ 240.357095] [<c8a06e9b>] kernel_init_freeable+0x450/0x5be
[ 240.357807] [<c827204e>] kernel_init+0x1e/0x200
[ 240.358462] [<c77207ff>] ? schedule_tail+0x1f/0xc0
[ 240.359153] [<c8284348>] ret_from_kernel_thread+0x20/0x34
[ 240.359868] [<c8272030>] ? rest_init+0x160/0x160
[ 240.360531] 2 locks held by swapper/1:
[ 240.361090] #0: (of_mutex){......}, at: [<c8a95a40>] of_unittest+0xdcf/0x16ee
[ 240.362439] #1: (of_mutex){......}, at: [<c8137825>] of_changeset_apply+0x25/0x70
[ 360.362993] INFO: task swapper:1 blocked for more than 120 seconds.
[ 360.367053] Not tainted 4.5.0-rc1-00021-g78b8dba #107
[ 360.368384] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 360.370464] swapper D 00000000 5856 1 0 0x00000000
[ 360.372220] d3dffe00 00000046 cab95a00 00000000 d3dffe40 c8991cec c88912e0 00000000
[ 360.376046] 00000000 cab95a00 d3e10000 c76a1c90 d3e00000 d3e10000 d3dffe10 c827847b
[ 360.383960] c76a1c90 c8991cc0 d3dffe18 c827891f d3dffe5c c827e8b6 00000000 00000001
[ 360.386894] Call Trace:
[ 360.387688] [<c76a1c90>] ? native_save_fl+0x30/0x30
[ 360.388936] [<c827847b>] schedule+0x7b/0x180
[ 360.391087] [<c76a1c90>] ? native_save_fl+0x30/0x30
[ 360.392315] [<c827891f>] schedule_preempt_disabled+0x2f/0x60
[ 360.393739] [<c827e8b6>] mutex_lock_nested+0x446/0x940
[ 360.395015] [<c8137825>] ? of_changeset_apply+0x25/0x70
[ 360.396296] [<c8137825>] ? of_changeset_apply+0x25/0x70
[ 360.397643] [<c8137825>] of_changeset_apply+0x25/0x70
[ 360.398905] [<c8a95a55>] of_unittest+0xde4/0x16ee
[ 360.400138] [<c78f225a>] ? kfree+0x54a/0x680
[ 360.401252] [<c81cd6ab>] ? add_sysfs_fw_map_entry+0xad/0x102
[ 360.402666] [<c760219d>] ? do_one_initcall+0xcd/0x480
[ 360.403926] [<c8a94c71>] ? of_unittest_platform_populate+0x603/0x603
[ 360.405410] [<c76021d6>] do_one_initcall+0x106/0x480
[ 360.406710] [<c8a94c71>] ? of_unittest_platform_populate+0x603/0x603
[ 360.408193] [<c8a06e6d>] ? kernel_init_freeable+0x422/0x5be
[ 360.409587] [<c8a06e9b>] kernel_init_freeable+0x450/0x5be
[ 360.410902] [<c827204e>] kernel_init+0x1e/0x200
[ 360.412094] [<c77207ff>] ? schedule_tail+0x1f/0xc0
[ 360.413298] [<c8284348>] ret_from_kernel_thread+0x20/0x34
[ 360.414665] [<c8272030>] ? rest_init+0x160/0x160
[ 360.415841] 2 locks held by swapper/1:
[ 360.416856] #0: (of_mutex){......}, at: [<c8a95a40>] of_unittest+0xdcf/0x16ee
[ 360.419407] #1: (of_mutex){......}, at: [<c8137825>] of_changeset_apply+0x25/0x70
Elapsed time: 440
BUG: kernel boot hang
qemu-system-i386 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/i386-randconfig-s0-201604/gcc-5/78b8dbaa5715c56d5bc6e9d361856f8d92fe490c/vmlinuz-4.5.0-rc1-00021-g78b8dba -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-vp-quantal-i386-8/rand_boot-1-quantal-core-i386.cgz-i386-randconfig-s0-201604-78b8dbaa5715c56d5bc6e9d361856f8d92fe490c-20160126-108904-l5r34w-1.yaml ARCH=i386 kconfig=i386-randconfig-s0-201604 branch=linux-devel/devel-catchup-201601262142 commit=78b8dbaa5715c56d5bc6e9d361856f8d92fe490c BOOT_IMAGE=/pkg/linux/i386-randconfig-s0-201604/gcc-5/78b8dbaa5715c56d5bc6e9d361856f8d92fe490c/vmlinuz-4.5.0-rc1-00021-g78b8dba max_uptime=600 RESULT_ROOT=/result/boot/1/vm-vp-quantal-i386/quantal-core-i386.cgz/i386-randconfig-s0-201604/gcc-5/78b8dbaa5715c56d5bc6e9d361856f8d92fe490c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-vp-quantal-i386-8::dhcp drbd.minor_count=8' -initrd /fs/sdd1/initrd-vm-vp-quantal-i386-8 -m 360 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -pidfile /dev/shm/kboot/pid-vm-vp-quantal-i386-8 -serial file:/dev/shm/kboot/serial-vm-vp-quantal-i386-8 -daemonize -display none -monitor null
Thanks,
Kernel Test Robot
View attachment "config-4.5.0-rc1-00021-g78b8dba" of type "text/plain" (92015 bytes)
Download attachment "dmesg.xz" of type "application/x-xz" (9984 bytes)
Powered by blists - more mailing lists