Subject: dad4f140ed ("Merge branch 'xarray' of .."): Mem-Info:

From: kernel test robot <[email-masked]>
Date: Sat, 24 Nov 2018 09:20:38 +0800

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 dad4f140edaa3f6bb452b6913d41af1ffd672e45
Merge: 69d5b97c59730 3a08cd52c37c7
Author:     Linus Torvalds <[email-masked]>
AuthorDate: Sun Oct 28 11:35:40 2018 -0700
Commit:     Linus Torvalds <[email-masked]>
CommitDate: Sun Oct 28 11:35:40 2018 -0700

    Merge branch 'xarray' of git://git.infradead.org/users/willy/linux-dax
    
    Pull XArray conversion from Matthew Wilcox:
     "The XArray provides an improved interface to the radix tree data
      structure, providing locking as part of the API, specifying GFP flags
      at allocation time, eliminating preloading, less re-walking the tree,
      more efficient iterations and not exposing RCU-protected pointers to
      its users.
    
      This patch set
    
       1. Introduces the XArray implementation
    
       2. Converts the pagecache to use it
    
       3. Converts memremap to use it
    
      The page cache is the most complex and important user of the radix
      tree, so converting it was most important. Converting the memremap
      code removes the only other user of the multiorder code, which allows
      us to remove the radix tree code that supported it.
    
      I have 40+ followup patches to convert many other users of the radix
      tree over to the XArray, but I'd like to get this part in first. The
      other conversions haven't been in linux-next and aren't suitable for
      applying yet, but you can see them in the xarray-conv branch if you're
      interested"
    
    * 'xarray' of git://git.infradead.org/users/willy/linux-dax: (90 commits)
      radix tree: Remove multiorder support
      radix tree test: Convert multiorder tests to XArray
      radix tree tests: Convert item_delete_rcu to XArray
      radix tree tests: Convert item_kill_tree to XArray
      radix tree tests: Move item_insert_order
      radix tree test suite: Remove multiorder benchmarking
      radix tree test suite: Remove __item_insert
      memremap: Convert to XArray
      xarray: Add range store functionality
      xarray: Move multiorder_check to in-kernel tests
      xarray: Move multiorder_shrink to kernel tests
      xarray: Move multiorder account test in-kernel
      radix tree test suite: Convert iteration test to XArray
      radix tree test suite: Convert tag_tagged_items to XArray
      radix tree: Remove radix_tree_clear_tags
      radix tree: Remove radix_tree_maybe_preload_order
      radix tree: Remove split/join code
      radix tree: Remove radix_tree_update_node_t
      page cache: Finish XArray conversion
      dax: Convert page fault handlers to XArray
      ...

69d5b97c59  HID: we do not randomly make new drivers 'default y'
3a08cd52c3  radix tree: Remove multiorder support
dad4f140ed  Merge branch 'xarray' of git://git.infradead.org/users/willy/linux-dax
7c98a42618  Merge tag 'ceph-for-4.20-rc4' of https://github.com/ceph/ceph-client
8c9733fd98  Add linux-next specific files for 20181123
+---------------------------------------------------------------------+------------+------------+------------+------------+---------------+
|                                                                     | 69d5b97c59 | 3a08cd52c3 | dad4f140ed | 7c98a42618 | next-20181123 |
+---------------------------------------------------------------------+------------+------------+------------+------------+---------------+
| boot_successes                                                      | 33         | 0          | 0          | 0          | 11            |
| boot_failures                                                       | 0          | 46         | 17         | 2          |               |
| INFO:trying_to_register_non-static_key                              | 0          | 46         |            |            |               |
| WARNING:at_mm/slab_common.c:#kmalloc_slab                           | 0          | 46         |            |            |               |
| EIP:kmalloc_slab                                                    | 0          | 46         |            |            |               |
| Mem-Info                                                            | 0          | 46         | 17         | 2          |               |
| WARNING:at_include/linux/xarray.h:#xa_mk_value                      | 0          | 46         | 17         | 2          |               |
| EIP:xa_mk_value                                                     | 0          | 46         | 17         | 2          |               |
| BUG:workqueue_lockup-pool                                           | 0          | 9          | 6          | 2          |               |
| INFO:rcu_preempt_detected_stalls_on_CPUs/tasks                      | 0          | 37         | 11         |            |               |
| WARNING:suspicious_RCU_usage                                        | 0          | 0          | 17         | 2          |               |
| include/linux/xarray.h:#suspicious_rcu_dereference_check()usage     | 0          | 0          | 17         | 2          |               |
| include/linux/xarray.h:#suspicious_rcu_dereference_protected()usage | 0          | 0          | 17         | 2          |               |
+---------------------------------------------------------------------+------------+------------+------------+------------+---------------+

[    0.752701] test_overflow: kmalloc_node detected saturation
[    0.753134] test_overflow: kzalloc detected saturation
[    0.753536] test_overflow: kzalloc_node detected saturation
[    0.753972] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[    0.754743] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.755283] Call Trace:
[    0.755480]  ? dump_stack+0x16/0x18
[    0.755753]  ? warn_alloc+0x72/0xdf
[    0.756026]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.756380]  ? lockdep_hardirqs_off+0x2d/0x8c
[    0.756716]  ? __vmalloc_node+0x40/0x47
[    0.757016]  ? test_overflow_allocation+0x321/0x914
[    0.757394]  ? __vmalloc_node_flags_caller+0x30/0x38
[    0.757783]  ? test_overflow_allocation+0x321/0x914
[    0.758160]  ? kvmalloc_node+0x5a/0x63
[    0.758455]  ? test_overflow_allocation+0x321/0x914
[    0.758829]  ? test_overflow_allocation+0x321/0x914
[    0.759205]  ? preempt_count_add+0x58/0x5d
[    0.759526]  ? wake_up_klogd+0x34/0x44
[    0.759817]  ? vprintk_emit+0x20e/0x219
[    0.760115]  ? test_overflow_allocation+0x914/0x914
[    0.760493]  ? vprintk_default+0x12/0x14
[    0.760797]  ? test_overflow_allocation+0x914/0x914
[    0.761180]  ? test_module_init+0x17/0x3f
[    0.761495]  ? do_one_initcall+0x85/0x1ce
[    0.761807]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.762169]  ? trace_initcall_level+0x5a/0x86
[    0.762509]  ? kernel_init_freeable+0xd5/0x176
[    0.762852]  ? kernel_init_freeable+0xf7/0x176
[    0.763195]  ? rest_init+0xab/0xab
[    0.763463]  ? kernel_init+0x8/0xda
[    0.763735]  ? ret_from_fork+0x19/0x24
[    0.764029] Mem-Info:
[    0.764212] active_anon:0 inactive_anon:0 isolated_anon:0
[    0.764212]  active_file:0 inactive_file:0 isolated_file:0
[    0.764212]  unevictable:5175 dirty:0 writeback:0 unstable:0
[    0.764212]  slab_reclaimable:1128 slab_unreclaimable:660
[    0.764212]  mapped:0 shmem:0 pagetables:0 bounce:0
[    0.764212]  free:98004 free_pcp:182 free_cma:0
[    0.766558] Node 0 active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:20700kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:0kB writeback:0kB shmem:0kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[    0.768517] DMA free:15916kB min:96kB low:120kB high:144kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15916kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[    0.770415] lowmem_reserve[]: 0 391 391
[    0.770716] Normal free:376100kB min:2480kB low:3100kB high:3720kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:20700kB writepending:0kB present:507776kB managed:405404kB mlocked:0kB kernel_stack:304kB pagetables:0kB bounce:0kB free_pcp:728kB local_pcp:728kB free_cma:0kB
[    0.772739] lowmem_reserve[]: 0 0 0
[    0.773012] DMA: 1*4kB (U) 1*8kB (U) 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (U) 3*4096kB (M) = 15916kB
[    0.774009] Normal: 5*4kB (UM) 4*8kB (ME) 5*16kB (UME) 5*32kB (UME) 6*64kB (UM) 1*128kB (M) 4*256kB (UM) 3*512kB (ME) 4*1024kB (ME) 4*2048kB (ME) 88*4096kB (M) = 376100kB
[    0.775165] 5185 total pagecache pages
[    0.775460] 130942 pages RAM
[    0.775686] 0 pages HighMem/MovableOnly
[    0.775982] 25612 pages reserved
[    0.776234] test_overflow: kvmalloc detected saturation
[    0.776642] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[    0.777402] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.777944] Call Trace:
[    0.778139]  ? dump_stack+0x16/0x18
[    0.778415]  ? warn_alloc+0x72/0xdf
[    0.778686]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.779036]  ? lockdep_hardirqs_off+0x2d/0x8c
[    0.779375]  ? __vmalloc_node+0x40/0x47
[    0.779673]  ? test_overflow_allocation+0x3c8/0x914
[    0.780048]  ? __vmalloc_node_flags_caller+0x30/0x38
[    0.780433]  ? test_overflow_allocation+0x3c8/0x914
[    0.780806]  ? kvmalloc_node+0x5a/0x63
[    0.781111]  ? test_overflow_allocation+0x3c8/0x914
[    0.781490]  ? test_overflow_allocation+0x3c8/0x914
[    0.781864]  ? preempt_count_add+0x58/0x5d
[    0.782181]  ? wake_up_klogd+0x34/0x44
[    0.782476]  ? vprintk_emit+0x20e/0x219
[    0.782773]  ? test_overflow_allocation+0x914/0x914
[    0.783148]  ? vprintk_default+0x12/0x14
[    0.783455]  ? test_overflow_allocation+0x914/0x914
[    0.783830]  ? test_module_init+0x17/0x3f
[    0.784139]  ? do_one_initcall+0x85/0x1ce
[    0.784466]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.784828]  ? trace_initcall_level+0x5a/0x86
[    0.785164]  ? kernel_init_freeable+0xd5/0x176
[    0.785510]  ? kernel_init_freeable+0xf7/0x176
[    0.785853]  ? rest_init+0xab/0xab
[    0.786118]  ? kernel_init+0x8/0xda
[    0.786393]  ? ret_from_fork+0x19/0x24
[    0.786685] test_overflow: kvmalloc_node detected saturation
[    0.787126] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[    0.787962] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.788501] Call Trace:
[    0.788695]  ? dump_stack+0x16/0x18
[    0.788967]  ? warn_alloc+0x72/0xdf
[    0.789242]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.789592]  ? lockdep_hardirqs_off+0x2d/0x8c
[    0.789928]  ? __vmalloc_node+0x40/0x47
[    0.790226]  ? test_overflow_allocation+0x46f/0x914
[    0.790604]  ? __vmalloc_node_flags_caller+0x30/0x38
[    0.790985]  ? test_overflow_allocation+0x46f/0x914
[    0.791375]  ? kvmalloc_node+0x5a/0x63
[    0.791667]  ? test_overflow_allocation+0x46f/0x914
[    0.792042]  ? test_overflow_allocation+0x46f/0x914
[    0.792421]  ? preempt_count_add+0x58/0x5d
[    0.792738]  ? wake_up_klogd+0x34/0x44
[    0.793030]  ? vprintk_emit+0x20e/0x219
[    0.793331]  ? test_overflow_allocation+0x914/0x914
[    0.793708]  ? test_overflow_allocation+0x914/0x914
[    0.794083]  ? test_module_init+0x17/0x3f
[    0.794411]  ? do_one_initcall+0x85/0x1ce
[    0.794722]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.795090]  ? trace_initcall_level+0x5a/0x86
[    0.795429]  ? kernel_init_freeable+0xd5/0x176
[    0.795772]  ? kernel_init_freeable+0xf7/0x176
[    0.796115]  ? rest_init+0xab/0xab
[    0.796383]  ? kernel_init+0x8/0xda
[    0.796655]  ? ret_from_fork+0x19/0x24
[    0.796946] test_overflow: kvzalloc detected saturation
[    0.797356] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[    0.798189] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.798728] Call Trace:
[    0.798922]  ? dump_stack+0x16/0x18
[    0.799195]  ? warn_alloc+0x72/0xdf
[    0.799470]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.799819]  ? lockdep_hardirqs_off+0x2d/0x8c
[    0.800155]  ? __vmalloc_node+0x40/0x47
[    0.800456]  ? test_overflow_allocation+0x516/0x914
[    0.800831]  ? __vmalloc_node_flags_caller+0x30/0x38
[    0.801220]  ? test_overflow_allocation+0x516/0x914
[    0.801599]  ? kvmalloc_node+0x5a/0x63
[    0.801889]  ? test_overflow_allocation+0x516/0x914
[    0.802267]  ? test_overflow_allocation+0x516/0x914
[    0.802642]  ? preempt_count_add+0x58/0x5d
[    0.802960]  ? wake_up_klogd+0x34/0x44
[    0.803256]  ? vprintk_emit+0x20e/0x219
[    0.803553]  ? test_overflow_allocation+0x914/0x914
[    0.803929]  ? test_module_init+0x17/0x3f
[    0.804243]  ? do_one_initcall+0x85/0x1ce
[    0.804561]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.804924]  ? trace_initcall_level+0x5a/0x86
[    0.805265]  ? kernel_init_freeable+0xd5/0x176
[    0.805607]  ? kernel_init_freeable+0xf7/0x176
[    0.805950]  ? rest_init+0xab/0xab
[    0.806215]  ? kernel_init+0x8/0xda
[    0.806490]  ? ret_from_fork+0x19/0x24
[    0.806781] test_overflow: kvzalloc_node detected saturation
[    0.807234] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[    0.808044] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.808636] Call Trace:
[    0.808850]  ? dump_stack+0x16/0x18
[    0.809148]  ? warn_alloc+0x72/0xdf
[    0.809450]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.809834]  ? debug_check_no_obj_freed+0xe9/0x129
[    0.810242]  ? __vmalloc_node+0x40/0x47
[    0.810567]  ? vmalloc+0x10/0x12
[    0.810845]  ? __vmalloc_node_flags+0x30/0x38
[    0.811231]  ? vmalloc+0x10/0x12
[    0.811510]  ? vmalloc+0x10/0x12
[    0.811788]  ? test_overflow_allocation+0x5a5/0x914
[    0.812200]  ? preempt_count_add+0x58/0x5d
[    0.812553]  ? wake_up_klogd+0x34/0x44
[    0.812873]  ? vprintk_emit+0x20e/0x219
[    0.813200]  ? test_overflow_allocation+0x914/0x914
[    0.813615]  ? test_module_init+0x17/0x3f
[    0.813955]  ? do_one_initcall+0x85/0x1ce
[    0.814300]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.814731]  ? trace_initcall_level+0x5a/0x86
[    0.815115]  ? kernel_init_freeable+0xd5/0x176
[    0.815510]  ? kernel_init_freeable+0xf7/0x176
[    0.815899]  ? rest_init+0xab/0xab
[    0.816200]  ? kernel_init+0x8/0xda
[    0.816519]  ? ret_from_fork+0x19/0x24
[    0.816849] test_overflow: vmalloc detected saturation
[    0.817315] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[    0.818179] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.818791] Call Trace:
[    0.819011]  ? dump_stack+0x16/0x18
[    0.819323]  ? warn_alloc+0x72/0xdf
[    0.819631]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.820026]  ? __vmalloc_node+0x40/0x47
[    0.820367]  ? test_overflow_allocation+0x63d/0x914
[    0.820791]  ? vmalloc_node+0x34/0x3b
[    0.821128]  ? test_overflow_allocation+0x63d/0x914
[    0.821556]  ? test_overflow_allocation+0x63d/0x914
[    0.821981]  ? preempt_count_add+0x58/0x5d
[    0.822344]  ? wake_up_klogd+0x34/0x44
[    0.822673]  ? vprintk_emit+0x20e/0x219
[    0.823010]  ? test_overflow_allocation+0x914/0x914
[    0.823438]  ? test_module_init+0x17/0x3f
[    0.823790]  ? do_one_initcall+0x85/0x1ce
[    0.824141]  ? rcu_read_lock_sched_held+0x4d/0x57
[    0.824562]  ? trace_initcall_level+0x5a/0x86
[    0.824945]  ? kernel_init_freeable+0xd5/0x176
[    0.825337]  ? kernel_init_freeable+0xf7/0x176
[    0.825724]  ? rest_init+0xab/0xab
[    0.826023]  ? kernel_init+0x8/0xda
[    0.826333]  ? ret_from_fork+0x19/0x24
[    0.826662] test_overflow: vmalloc_node detected saturation
[    0.827164] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[    0.828116] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-07913-gdad4f14 #1
[    0.828760] Call Trace:
[    0.828980]  ? dump_stack+0x16/0x18
[    0.829291]  ? warn_alloc+0x72/0xdf
[    0.829597]  ? __vmalloc_node_range+0x1ad/0x1ba
[    0.829992]  ? debug_check_no_obj_freed+0xe9/0x129
[    0.830411]  ? __vmalloc_node+0x40/0x47
[    0.830747]  ? vzalloc+0x10/0x12
[    0.831041]  ? __vmalloc_node_flags+0x30/0x38
[    0.831424]  ? vzalloc+0x10/0x12

                                                          # HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 9ff01193a20d391e8dbce4403dd5ef87c7eaaca6 v4.19 --
git bisect  bad b22b6beae6116e3a9c46ced312c626f6737a3fa6  # 03:11  B      0    19   33   0  Merge tag 'armsoc-drivers' of git://git.kernel.org/pub/scm/linux/kernel/git/arm/arm-soc
git bisect good a41efc2a0f68cea26665ab9e6d991c9bf33b3f59  # 03:44  G     11     0   11  24  Merge tag 'dmaengine-4.20-rc1' of git://git.infradead.org/users/vkoul/slave-dma
git bisect good 685f7e4f161425b137056abe35ba8ef7b669d83d  # 04:17  G     11     0   11  28  Merge tag 'powerpc-4.20-1' of git://git.kernel.org/pub/scm/linux/kernel/git/powerpc/linux
git bisect  bad 53b3b6bbfde6aae8d1ededc86ad4e0e1e00eb5f8  # 04:17  B      0    19   33   0  Merge tag 'drm-next-2018-10-24' of git://anongit.freedesktop.org/drm/drm
git bisect good c7b7eefa57ae3c8802fdec7d07ac4df6c49d1e7a  # 04:17  G     11     0    0   0  Merge tag 'rtc-4.20' of git://git.kernel.org/pub/scm/linux/kernel/git/abelloni/linux
git bisect  bad dad4f140edaa3f6bb452b6913d41af1ffd672e45  # 04:17  B      0    15   29   0  Merge branch 'xarray' of git://git.infradead.org/users/willy/linux-dax
git bisect good 5ecf3e110c32c5756351eed067cdf6a91c308e62  # 04:17  G     11     0    0   0  Merge tag 'linux-watchdog-4.20-rc1' of git://www.linux-watchdog.org/linux-watchdog
git bisect good 69d5b97c597307773fe6c59775a5d5a88bb7e6b3  # 04:17  G     11     0    0   0  HID: we do not randomly make new drivers 'default y'
git bisect good 77da9389b9d5f07d54fda092d1ab56002ec0019a  # 04:52  G     11     0   11  22  mm: Convert collapse_shmem to XArray
git bisect good 07f2d89cc270936ac314e7cc4ac57077d7f08aef  # 05:25  G     11     0   11  26  dax: Convert __dax_invalidate_entry to XArray
git bisect good d6427f8179b5dd65eb468c61fc8cc24657c336c9  # 05:59  G     11     0   11  24  xarray: Move multiorder account test in-kernel
git bisect good 879a9ae7b5bc046f195a725d62bbc96258e5d0c8  # 06:32  G     10     0   10  21  radix tree test suite: Remove multiorder benchmarking
git bisect good b66b5a48b8a0e43dc114573da11c1a9c586a2d4f  # 07:14  G     11     0   11  11  radix tree tests: Convert item_delete_rcu to XArray
git bisect good 3a08cd52c37c793ffc199f6fc2ecfc368e284b2d  # 07:55  G     11     0   11  13  radix tree: Remove multiorder support
# first bad commit: [dad4f140edaa3f6bb452b6913d41af1ffd672e45] Merge branch 'xarray' of git://git.infradead.org/users/willy/linux-dax
git bisect good 69d5b97c597307773fe6c59775a5d5a88bb7e6b3  # 08:28  G     31     0    0   0  HID: we do not randomly make new drivers 'default y'
git bisect good 3a08cd52c37c793ffc199f6fc2ecfc368e284b2d  # 09:02  G     30     0   30  43  radix tree: Remove multiorder support
# extra tests on HEAD of linux-devel/devel-spot-201811230742
git bisect  bad f67b8e8443b97e33fa3e4676d43df4136ca7b883  # 09:02  B      0    24   41   0  0day head guard for 'devel-spot-201811230742'
# extra tests on tree/branch linus/master
git bisect  bad 7c98a42618271210c60b79128b220107d35938d9  # 09:11  B      0     1   15   0  Merge tag 'ceph-for-4.20-rc4' of https://github.com/ceph/ceph-client
# extra tests on tree/branch linux-next/master
git bisect good 8c9733fd9806c71e7f2313a280f98cb3051f93df  # 09:17  G     11     0    0   0  Add linux-next specific files for 20181123

---
0-DAY kernel test infrastructure                Open Source Technology Center
https://lists.01.org/pipermail/lkp                          Intel Corporation