[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20180507011559.dvxfa2jbanwyzk6n@shao2-debian>
Date: Mon, 7 May 2018 09:15:59 +0800
From: kernel test robot <shun.hao@...el.com>
To: David Howells <dhowells@...hat.com>
Cc: linux-afs@...ts.infradead.org, netdev@...r.kernel.org,
linux-kernel@...r.kernel.org, LKP <lkp@...org>
Subject: [lkp-robot] ace45bec6d [ 44.030009] watchdog: BUG: soft lockup -
CPU#0 stuck for 23s! [kworker/0:1:19]
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 ace45bec6d77bc061c3c3d8ad99e298ea9800c2b
Author: David Howells <dhowells@...hat.com>
AuthorDate: Fri Mar 30 21:04:43 2018 +0100
Commit: David Howells <dhowells@...hat.com>
CommitDate: Fri Mar 30 21:04:43 2018 +0100
rxrpc: Fix firewall route keepalive
Fix the firewall route keepalive part of AF_RXRPC which is currently
function incorrectly by replying to VERSION REPLY packets from the server
with VERSION REQUEST packets.
Instead, send VERSION REPLY packets to the peers of service connections to
act as keep-alives 20s after the latest packet was transmitted to that
peer.
Also, just discard VERSION REPLY packets rather than replying to them.
Signed-off-by: David Howells <dhowells@...hat.com>
c0b6edef0b tc-testing: Add newline when writing test case files
ace45bec6d rxrpc: Fix firewall route keepalive
c1c07416cd Merge tag 'kbuild-fixes-v4.17' of git://git.kernel.org/pub/scm/linux/kernel/git/masahiroy/linux-kbuild
+------------------------------------------------+------------+------------+------------+
| | c0b6edef0b | ace45bec6d | c1c07416cd |
+------------------------------------------------+------------+------------+------------+
| boot_successes | 159 | 24 | 22 |
| boot_failures | 2 | 11 | 18 |
| Mem-Info | 2 | | |
| BUG:soft_lockup-CPU##stuck_for#s | 0 | 8 | 14 |
| EIP:arch_local_irq_enable | 0 | 3 | 7 |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0 | 11 | 18 |
| EIP:arch_local_irq_restore | 0 | 6 | 9 |
| EIP:do_raw_spin_unlock | 0 | 1 | |
| EIP:rxrpc_peer_keepalive_worker | 0 | 1 | 1 |
| calltrace:rxrpc_peer_keepalive_worker | 0 | 1 | 1 |
| EIP:__local_bh_disable_ip | 0 | 0 | 1 |
+------------------------------------------------+------------+------------+------------+
Starting udev
Kernel tests: Boot OK!
[ 5.636456] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary.
[ 5.676092] VFS: Warning: trinity-c3 using old stat() call. Recompile your binary.
[ 44.030009] watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [kworker/0:1:19]
[ 44.044662] Modules linked in:
[ 44.045074] irq event stamp: 181031373
[ 44.045594] hardirqs last enabled at (181031371): [<fc1697fb>] __local_bh_enable_ip+0xae/0xba
[ 44.046757] hardirqs last disabled at (181031373): [<40d2972d>] apic_timer_interrupt+0x3a/0x50
[ 44.047914] softirqs last enabled at (181031370): [<50cc2190>] rxrpc_peer_keepalive_worker+0x11a/0x326
[ 44.049135] softirqs last disabled at (181031372): [<cd96f8e7>] rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.050291] CPU: 0 PID: 19 Comm: kworker/0:1 Not tainted 4.16.0-rc6-02064-gace45be #213
[ 44.051322] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 44.052442] Workqueue: krxrpcd rxrpc_peer_keepalive_worker
[ 44.053238] EIP: arch_local_irq_restore+0x5/0xb
[ 44.053907] EFLAGS: 00000246 CPU: 0
[ 44.054394] EAX: 00000246 EBX: 8f4c7080 ECX: 81edc1a8 EDX: 539ce25c
[ 44.055220] ESI: 8dc171b0 EDI: 00000246 EBP: 8f4d7e74 ESP: 8f4d7e74
[ 44.056083] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 44.056859] CR0: 80050033 CR2: 09bcf850 CR3: 0d3ab000 CR4: 00000690
[ 44.057776] DR0: 76d86000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[ 44.058678] DR6: ffff0ff0 DR7: 00000600
[ 44.059234] Call Trace:
[ 44.059592] lock_acquire+0x6a/0x75
[ 44.060085] ? rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.060811] _raw_spin_lock_bh+0x28/0x37
[ 44.061383] ? rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.062085] rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.062791] ? lock_acquire+0x6a/0x75
[ 44.063292] ? process_one_work+0x164/0x29a
[ 44.063880] process_one_work+0x183/0x29a
[ 44.064405] ? process_one_work+0x164/0x29a
[ 44.076043] worker_thread+0x178/0x21b
[ 44.076552] kthread+0xd3/0xd5
[ 44.076945] ? rescuer_thread+0x23a/0x23a
[ 44.077459] ? kthread_create_worker_on_cpu+0x17/0x17
[ 44.078243] ret_from_fork+0x2e/0x40
[ 44.078837] Code: 00 8d 43 34 6a 00 8b 4d f4 89 f2 e8 2f 0f 00 00 89 5b 30 5e 8d 65 f8 5b 5e 5d c3 55 89 e5 9c 58 8d 74 26 00 5d c3 55 89 e5 50 9d <8d> 74 26 00 5d c3 55 89 e5 e8 e2 ff ff ff 89 c1 fa 90 8d 74 26
[ 44.081585] Kernel panic - not syncing: softlockup: hung tasks
[ 44.082307] CPU: 0 PID: 19 Comm: kworker/0:1 Tainted: G L 4.16.0-rc6-02064-gace45be #213
[ 44.083693] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 44.085102] Workqueue: krxrpcd rxrpc_peer_keepalive_worker
[ 44.095951] Call Trace:
[ 44.096279] dump_stack+0x73/0xa5
[ 44.096739] panic+0x99/0x1d8
[ 44.097144] watchdog_timer_fn+0x1ad/0x1d2
[ 44.097709] __hrtimer_run_queues+0xa5/0x117
[ 44.098283] ? watchdog+0x16/0x16
[ 44.098737] hrtimer_run_queues+0x9c/0xd3
[ 44.099252] run_local_timers+0x15/0x2c
[ 44.099777] update_process_times+0x18/0x39
[ 44.100344] tick_periodic+0x99/0xa5
[ 44.100827] tick_handle_periodic+0x1d/0x5c
[ 44.101371] smp_apic_timer_interrupt+0x54/0x67
[ 44.101944] apic_timer_interrupt+0x41/0x50
[ 44.102463] EIP: arch_local_irq_restore+0x5/0xb
[ 44.103164] EFLAGS: 00000246 CPU: 0
[ 44.103781] EAX: 00000246 EBX: 8f4c7080 ECX: 81edc1a8 EDX: 539ce25c
[ 44.104803] ESI: 8dc171b0 EDI: 00000246 EBP: 8f4d7e74 ESP: 8f4d7e74
[ 44.116848] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 44.117580] ? rcu_read_unlock+0x24/0x56
[ 44.118098] ? startup_32_smp+0x18/0x170
[ 44.118614] ? prepare_to_wait_exclusive+0x17/0x5f
[ 44.119265] lock_acquire+0x6a/0x75
[ 44.119750] ? rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.120401] _raw_spin_lock_bh+0x28/0x37
[ 44.120908] ? rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.121532] rxrpc_peer_keepalive_worker+0xb8/0x326
[ 44.122168] ? lock_acquire+0x6a/0x75
[ 44.122671] ? process_one_work+0x164/0x29a
[ 44.123285] process_one_work+0x183/0x29a
[ 44.123905] ? process_one_work+0x164/0x29a
[ 44.124511] worker_thread+0x178/0x21b
[ 44.125052] kthread+0xd3/0xd5
[ 44.125481] ? rescuer_thread+0x23a/0x23a
[ 44.126032] ? kthread_create_worker_on_cpu+0x17/0x17
[ 44.137746] ret_from_fork+0x2e/0x40
[ 44.138569] Kernel Offset: disabled
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 60cc43fc888428bb2f18f08997432d426a243338 v4.16 --
git bisect bad 3c0d551e02b2590fa71a1354f2f1994551a33315 # 07:54 B 4 2 3 3 Merge tag 'pci-v4.17-changes' of git://git.kernel.org/pub/scm/linux/kernel/git/helgaas/pci
git bisect bad 17dec0a949153d9ac00760ba2f5b78cb583e995f # 08:09 B 0 1 15 0 Merge branch 'userns-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/ebiederm/user-namespace
git bisect good f5a8eb632b562bd9c16c389f5db3a5260fba4157 # 08:15 G 21 0 0 1 Merge tag 'arch-removal' of git://git.kernel.org/pub/scm/linux/kernel/git/arnd/asm-generic
git bisect good 77624cd2a7783fccf2c518768a6fd7a7aeccd002 # 08:36 G 23 0 1 1 Merge tag 'pinctrl-v4.17-1' of git://git.kernel.org/pub/scm/linux/kernel/git/linusw/linux-pinctrl
git bisect bad 0734e00ef9e48e78c5c3ce1648572f160d07e323 # 08:47 B 0 1 20 4 Merge branch 'parisc-4.17-1' of git://git.kernel.org/pub/scm/linux/kernel/git/deller/parisc-linux
git bisect good bb2407a7219760926760f0448fddf00d625e5aec # 08:52 G 21 0 0 1 Merge tag 'docs-4.17' of git://git.lwn.net/linux
git bisect bad 5bb053bef82523a8fd78d650bca81c9f114fa276 # 08:52 B 4 4 0 8 Merge git://git.kernel.org/pub/scm/linux/kernel/git/davem/net-next
git bisect good 489b30b53f0540b9f8e391cbb2839cea48b5d1c1 # 09:01 G 25 0 1 1 net: Convert l2tp_net_ops
git bisect good 038d49baab571800e3077b9d322a004f95c8aa8f # 09:09 G 25 0 0 1 Merge branch 'Introduce-net_rwsem-to-protect-net_namespace_list'
git bisect good d162190bded8b3f635d1ba1e27e63d1b4a720ba8 # 09:14 G 25 0 0 0 Merge git://git.kernel.org/pub/scm/linux/kernel/git/pablo/nf-next
git bisect bad 70ae7222c61d4f19c844c8fe75f053f8976b9552 # 09:14 B 8 4 0 9 Merge branch 'inet-frags-bring-rhashtables-to-IP-defrag'
git bisect bad e2e80c027f5adab3cc44c3d07c4484291384d278 # 09:19 B 4 10 0 7 Merge tag 'rxrpc-next-20180330' of git://git.kernel.org/pub/scm/linux/kernel/git/dhowells/linux-fs
git bisect bad 17226f1240381812c3a4927dc9da2814fb71c8ac # 09:19 B 9 7 0 5 rxrpc: Fix leak of rxrpc_peer objects
git bisect good 6f14f49ce5eb00f533133df06c663fbaea13cd50 # 09:27 G 46 0 1 1 Merge branch 'ieee802154-for-davem-2018-03-29' of git://git.kernel.org/pub/scm/linux/kernel/git/sschmidt/wpan-next
git bisect bad 59299aa1028fce051adbd25aaff7c387b865cd6d # 09:27 B 8 5 0 6 rxrpc: Fix resend event time calculation
git bisect bad ace45bec6d77bc061c3c3d8ad99e298ea9800c2b # 09:27 B 9 6 0 6 rxrpc: Fix firewall route keepalive
git bisect good c0b6edef0bf0e33c12eaf80c676ff09def011518 # 09:27 G 49 0 0 0 tc-testing: Add newline when writing test case files
# first bad commit: [ace45bec6d77bc061c3c3d8ad99e298ea9800c2b] rxrpc: Fix firewall route keepalive
git bisect good c0b6edef0bf0e33c12eaf80c676ff09def011518 # 09:54 G 136 0 4 4 tc-testing: Add newline when writing test case files
# extra tests on HEAD of linux-devel/devel-catchup-201805060551
git bisect bad 51ecf81e1818f38e84576c21d6098cfef3b27d29 # 09:54 B 5 5 0 4 0day head guard for 'devel-catchup-201805060551'
# extra tests on tree/branch linus/master
git bisect bad c1c07416cdd47161a359286021d483f449ad8c4f # 09:54 B 4 9 0 9 Merge tag 'kbuild-fixes-v4.17' of git://git.kernel.org/pub/scm/linux/kernel/git/masahiroy/linux-kbuild
# extra tests with first bad commit reverted
git bisect good e1f21b9be760e1e983900105c90b1349447f9aec # 10:00 G 48 0 0 0 Revert "rxrpc: Fix firewall route keepalive"
# extra tests on tree/branch linux-next/master
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
Download attachment "dmesg-yocto-intel12-10:20180506085351:i386-randconfig-s0-201818:4.16.0-rc6-02064-gace45be:213.gz" of type "application/gzip" (14862 bytes)
Download attachment "dmesg-yocto-intel12-16:20180506094629:i386-randconfig-s0-201818:4.16.0-rc6-02063-gc0b6ede:216.gz" of type "application/gzip" (19447 bytes)
View attachment "reproduce-yocto-intel12-10:20180506085351:i386-randconfig-s0-201818:4.16.0-rc6-02064-gace45be:213" of type "text/plain" (920 bytes)
View attachment "config-4.16.0-rc6-02064-gace45be" of type "text/plain" (140908 bytes)
Powered by blists - more mailing lists