Greetings, 0day kernel testing robot got the below dmesg and the first bad commit is git://git.infradead.org/users/willy/linux-dax.git xarray-conv commit fb640435affdc7e9ed20fc29628252058d4d6c66 Author: Matthew Wilcox <willy(a)infradead.org&gt; AuthorDate: Wed Nov 14 08:52:14 2018 -0500 Commit: Matthew Wilcox <willy(a)infradead.org&gt; CommitDate: Sat Feb 9 00:00:55 2019 -0500 pid: Convert to XArray The new semantics for xa_alloc_cyclic match the PID allocator much better than the way the IDR cyclic allocation had evolved. 77bd725565 rxrpc: Convert to XArray fb640435af pid: Convert to XArray +---------------------------------------------------------+------------+------------+ | | 77bd725565 | fb640435af | +---------------------------------------------------------+------------+------------+ | boot_successes | 107 | 16 | | boot_failures | 0 | 23 | | WARNING:possible_irq_lock_inversion_dependency_detected | 0 | 23 | | BUG:KASAN:null-ptr-deref_in_c | 0 | 23 | | BUG:unable_to_handle_kernel | 0 | 23 | | Oops:#[##] | 0 | 23 | | RIP:copy_process | 0 | 23 | | Kernel_panic-not_syncing:Fatal_exception | 0 | 23 | | WARNING:at_kernel/locking/lockdep.c:#lock_downgrade | 0 | 1 | | RIP:lock_downgrade | 0 | 1 | +---------------------------------------------------------+------------+------------+ [child2:1015] vm86 (166:[32BIT]) returned ENOSYS, marking as inactive. [child1:1088] mq_timedreceive (280:[32BIT]) returned ENOSYS, marking as inactive. [child2:1166] kexec_load (283:[32BIT]) returned ENOSYS, marking as inactive. [ 44.287019] [ 44.287479] ======================================================== [ 44.288630] WARNING: possible irq lock inversion dependency detected [ 44.289770] 5.0.0-rc5-00095-gfb64043 #2 Tainted: G T [ 44.291104] -------------------------------------------------------- [ 44.292094] trinity-c3/1020 just changed the state of lock: [ 44.292916] 00000000039b4f04 (init_pid_ns.pids.xa_lock){+...}, at: xa_erase+0x21/0x56 [ 44.294228] but this lock was taken by another, HARDIRQ-safe lock in the past: [ 44.295296] (&(&sighand->siglock)->rlock){-.-.} [ 44.295301] [ 44.295301] and interrupts could create inverse lock ordering between them. [ 44.295301] [ 44.297906] [ 44.297906] other info that might help us debug this: [ 44.298909] Chain exists of: [ 44.298909] &(&sighand->siglock)->rlock --> &(&sig->stats_lock)->seqcount --> init_pid_ns.pids.xa_lock [ 44.298909] [ 44.300866] Possible interrupt unsafe locking scenario: [ 44.300866] [ 44.301887] CPU0 CPU1 [ 44.302571] ---- ---- [ 44.303251] lock(init_pid_ns.pids.xa_lock); [ 44.303909] local_irq_disable(); [ 44.304734] lock(&(&sighand->siglock)->rlock); [ 44.305704] lock(&(&sig->stats_lock)->seqcount); [ 44.306809] <Interrupt> [ 44.307265] lock(&(&sighand->siglock)->rlock); [ 44.307987] [ 44.307987] *** DEADLOCK *** [ 44.307987] [ 44.308979] no locks held by trinity-c3/1020. [ 44.309634] [ 44.309634] the shortest dependencies between 2nd lock and 1st lock: [ 44.310745] -> (&(&sighand->siglock)->rlock){-.-.} ops: 24170 { [ 44.311638] IN-HARDIRQ-W at: [ 44.312196] lock_acquire+0x1d2/0x23b [ 44.313049] _raw_spin_lock_irqsave+0x5e/0x80 [ 44.313987] __lock_task_sighand+0x118/0x1c3 [ 44.314909] do_send_sig_info+0x85/0x11c [ 44.315766] group_send_sig_info+0xe5/0x104 [ 44.316643] kill_pid_info+0xaf/0x125 [ 44.317499] it_real_fn+0x1ba/0x1ca [ 44.318330] __hrtimer_run_queues+0x46d/0x7bc [ 44.319464] hrtimer_interrupt+0x14d/0x34c [ 44.320364] smp_apic_timer_interrupt+0x1c2/0x369 [ 44.321340] apic_timer_interrupt+0xf/0x20 [ 44.322239] __asan_load4+0x47/0xeb [ 44.323065] ___might_sleep+0x1c3/0x378 [ 44.323934] apply_mlockall_flags+0x235/0x294 [ 44.324867] __ia32_sys_munlockall+0x60/0x9b [ 44.325784] do_syscall_64+0x195/0x526 [ 44.326646] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 44.327721] IN-SOFTIRQ-W at: [ 44.328281] lock_acquire+0x1d2/0x23b [ 44.329125] _raw_spin_lock_irqsave+0x5e/0x80 [ 44.330043] __lock_task_sighand+0x118/0x1c3 [ 44.330962] do_send_sig_info+0x85/0x11c [ 44.331862] group_send_sig_info+0xe5/0x104 [ 44.332769] kill_pid_info+0xaf/0x125 [ 44.333612] it_real_fn+0x1ba/0x1ca [ 44.334426] __hrtimer_run_queues+0x46d/0x7bc [ 44.335535] hrtimer_interrupt+0x14d/0x34c [ 44.336430] smp_apic_timer_interrupt+0x1c2/0x369 [ 44.337395] apic_timer_interrupt+0xf/0x20 [ 44.338314] __asan_store8+0xee/0xf0 [ 44.348160] update_stack_state+0x2e6/0x368 [ 44.349080] unwind_next_frame+0x2c8/0x588 [ 44.349952] __save_stack_trace+0xdb/0x130 [ 44.350855] save_stack_trace+0x1f/0x28 [ 44.351726] __kasan_slab_free+0x1e7/0x2e7 [ 44.352595] kasan_slab_free+0x15/0x1e [ 44.353462] kmem_cache_free+0x1e2/0x3b8 [ 44.354341] __put_task_struct+0x186/0x1cc [ 44.355243] delayed_put_task_struct+0x1a7/0x1f8 [ 44.356195] rcu_process_callbacks+0x1ee/0x24e [ 44.357105] __do_softirq+0x27b/0x616 [ 44.357960] run_ksoftirqd+0x37/0x97 [ 44.358793] smpboot_thread_fn+0x46b/0x499 [ 44.359694] kthread+0x256/0x272 [ 44.360529] ret_from_fork+0x3a/0x50 [ 44.361360] INITIAL USE at: [ 44.361905] lock_acquire+0x1d2/0x23b [ 44.362752] _raw_spin_lock_irq+0x52/0x6f [ 44.363632] calculate_sigpending+0x3d/0x81 [ 44.364533] schedule_tail+0xa1/0xae [ 44.365360] ret_from_fork+0x8/0x50 [ 44.366176] } [ 44.366558] ... key at: [<ffffffff848390e0>] __key.61286+0x0/0x40 [ 44.367532] ... acquired at: [ 44.368076] lock_acquire+0x1d2/0x23b [ 44.368685] _raw_spin_lock+0x3e/0x5b [ 44.369315] release_task+0x548/0xc27 [ 44.369952] do_exit+0x1809/0x1b78 [ 44.370512] kthread+0x116/0x272 [ 44.371075] ret_from_fork+0x3a/0x50 [ 44.371678] [ 44.372006] -> (&(&(&sig->stats_lock)->lock)->rlock){....} ops: 2124 { [ 44.372949] INITIAL USE at: [ 44.373465] lock_acquire+0x1d2/0x23b [ 44.374289] _raw_spin_lock+0x3e/0x5b [ 44.375106] release_task+0x548/0xc27 [ 44.375922] do_exit+0x1809/0x1b78 [ 44.376702] kthread+0x116/0x272 [ 44.377470] ret_from_fork+0x3a/0x50 [ 44.378272] } [ 44.378642] ... key at: [<ffffffff848391a0>] __key.60967+0x0/0x40 [ 44.379597] ... acquired at: [ 44.380121] lock_acquire+0x1d2/0x23b [ 44.380723] release_task+0x5a5/0xc27 [ 44.381333] do_exit+0x1809/0x1b78 [ 44.381908] kthread+0x116/0x272 [ 44.382466] ret_from_fork+0x3a/0x50 [ 44.383060] [ 44.383377] -> (&(&sig->stats_lock)->seqcount){....} ops: 3243 { [ 44.384258] INITIAL USE at: [ 44.384781] lock_acquire+0x1d2/0x23b [ 44.385577] release_task+0x5a5/0xc27 [ 44.386372] do_exit+0x1809/0x1b78 [ 44.387136] kthread+0x116/0x272 [ 44.387883] ret_from_fork+0x3a/0x50 [ 44.388660] } [ 44.389019] ... key at: [<ffffffff848391e0>] __key.60966+0x0/0x40 [ 44.389965] ... acquired at: [ 44.390477] lock_acquire+0x1d2/0x23b [ 44.391089] _raw_spin_lock_irqsave+0x5e/0x80 [ 44.391775] free_pid+0x55/0x1c6 [ 44.392331] __change_pid+0x130/0x148 # HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD git bisect start 152bad6f84761f7e4c0630ee6c19fdfaefe2d9a1 f17b5f06cb92ef2250513a1e154c47b78df07d40 -- git bisect bad a9f8249e991f72315c7f35d897877f32dc1aef86 # 04:59 B 0 4 19 0 Merge 'linux-review/Martin-K-Petersen/scsi-MAINTAINERS-SCSI-initiator-and-target-tweaks/20190209-120148' into devel-hourly-2019021013 git bisect bad 2eed2d1f2deb6a429d0615cfe6289bc5e91bb2e3 # 05:28 B 1 1 1 1 Merge 'ojeda-linux/auxdisplay' into devel-hourly-2019021013 git bisect bad 9f1015db7d67a4ea5ad4d3abbecce00fc52598d7 # 05:59 B 0 7 22 0 Merge 'linux-review/Chris-Wilson/drm-amdgpu-Transfer-fences-to-dmabuf-importer/20190130-190911' into devel-hourly-2019021013 git bisect bad 872802b0508aeac2566b9ef507ac917138596ae2 # 06:20 B 1 6 1 1 Merge 'linux-review/Kai-Renzig/platform-x86-silead_dmi-Add-touchscreen-platform-data-for-the-Chuwi-Hi8-Air-tablet/20190204-111336' into devel-hourly-2019021013 git bisect good e52afc6d638ad862be4a4b0fa3792fae2ce899b9 # 00:11 G 38 0 2 4 Merge 'linux-review/Christophe-Leroy/powerpc-6xx-Don-t-set-back-MSR_RI-before-reenabling-MMU/20190201-114545' into devel-hourly-2019021013 git bisect good 8f27b5bf6d29767deb87de26b8790186ea53a598 # 01:17 G 37 0 5 5 Merge 'sunxi/sunxi/clk-fixes-for-5.0' into devel-hourly-2019021013 git bisect bad 8da2c8e5da0820bf52135632fde256c908850461 # 02:01 B 2 3 0 0 Merge 'linux-review/Nate-Dailey/md-raid1-don-t-clear-bitmap-bits-on-interrupted-recovery/20190208-144536' into devel-hourly-2019021013 git bisect bad 9aa264cc70ab518dfa7060bbbb8b66d5fbe8a606 # 02:33 B 3 6 2 2 Merge 'dax/xarray-conv' into devel-hourly-2019021013 git bisect good 0c543a64f6c64880f375961df80613ba06a09a42 # 03:13 G 38 0 3 3 Merge 'l2-mtd-boris/master' into devel-hourly-2019021013 git bisect good 2e02782f4e25921fc684d29f00a5693b249cb9c8 # 04:15 G 38 0 3 3 ipc: Convert ipcs_idr to XArray git bisect bad 52251f9820e6815def47b6d762c6e31ce29d1d76 # 04:57 B 0 1 0 0 sctp: Convert sctp_assocs_id to XArray git bisect bad 6a432577e79362cc0e3e2623bd278d55bb711d26 # 05:58 B 0 6 21 0 x86,hyperv: Convert conn_to_evt to XArray git bisect good 36b0d9c0f729610e514e2f54e41aaf9993a611a8 # 08:37 G 38 0 2 2 nfs: Convert cb_ident_idr to XArray git bisect bad fb640435affdc7e9ed20fc29628252058d4d6c66 # 09:06 B 0 8 23 0 pid: Convert to XArray git bisect good 63136570245807c6d5a0e1d2cac13294e8a9e8ca # 09:45 G 38 0 7 7 scsi: Convert same_target_siblings to XArray git bisect good 77bd725565c0f8d21e49f668dc8aca432489df93 # 10:19 G 36 0 3 3 rxrpc: Convert to XArray # first bad commit: [fb640435affdc7e9ed20fc29628252058d4d6c66] pid: Convert to XArray git bisect good 77bd725565c0f8d21e49f668dc8aca432489df93 # 10:56 G 112 0 9 12 rxrpc: Convert to XArray # extra tests with debug options git bisect bad fb640435affdc7e9ed20fc29628252058d4d6c66 # 11:34 B 1 2 1 1 pid: Convert to XArray # extra tests on HEAD of linux-devel/devel-hourly-2019021013 git bisect bad 152bad6f84761f7e4c0630ee6c19fdfaefe2d9a1 # 11:34 B 2 9 0 4 0day head guard for 'devel-hourly-2019021013' # extra tests on tree/branch dax/xarray-conv # extra tests with first bad commit reverted --- 0-DAY kernel test infrastructure Open Source Technology Center https://lists.01.org/pipermail/lkp Intel Corporation