lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <20181105070337.GX24195@shao2-debian>
Date:   Mon, 5 Nov 2018 15:03:37 +0800
From:   kernel test robot <rong.a.chen@...el.com>
To:     Matthew Wilcox <willy@...radead.org>
Cc:     LKML <linux-kernel@...r.kernel.org>,
        Linus Torvalds <torvalds@...ux-foundation.org>, lkp@...org
Subject: [LKP] [xarray] 0e9446c35a:
 WARNING:at_include/linux/xarray.h:#xa_mk_value

FYI, we noticed the following commit (built with gcc-6):

commit: 0e9446c35a80931044b6d8d2d74a9cabd248539f ("xarray: Add range store functionality")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master

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-i386 -enable-kvm -cpu SandyBridge -smp 2 -m 512M

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


+------------------------------------------------+------------+------------+
|                                                | 4f06d6302d | 0e9446c35a |
+------------------------------------------------+------------+------------+
| boot_successes                                 | 0          | 0          |
| boot_failures                                  | 2          | 5          |
| INFO:trying_to_register_non-static_key         | 2          | 5          |
| WARNING:at_include/linux/xarray.h:#xa_mk_value | 0          | 5          |
| EIP:xa_mk_value                                | 0          | 5          |
| BUG:workqueue_lockup-pool                      | 0          | 5          |
+------------------------------------------------+------------+------------+



[    7.782700] INFO: trying to register non-static key.
[    7.783426] the code is fine but needs lockdep annotation.
[    7.784282] turning off the locking correctness validator.
[    7.784300] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-rc5-00321-g0e9446c #1082
[    7.784300] Call Trace:
[    7.784300]  dump_stack+0x16/0x18
[    7.784300]  register_lock_class+0xb0/0x2c9
[    7.784300]  ? check_chain_key+0x86/0xe1
[    7.784300]  __lock_acquire+0x83/0x535
[    7.784300]  lock_acquire+0x55/0x71
[    7.784300]  ? ida_alloc_range+0x6e/0x271
[    7.784300]  _raw_spin_lock_irqsave+0x2e/0x3e
[    7.784300]  ? ida_alloc_range+0x6e/0x271
[    7.784300]  ? ida_check_destroy_1+0x6e/0x6e
[    7.784300]  ida_alloc_range+0x6e/0x271
[    7.784300]  ? ida_check_destroy_1+0x6e/0x6e
[    7.784300]  ida_alloc+0x12/0x14
[    7.784300]  ida_checks+0x64/0x409
[    7.784300]  ? ida_check_destroy_1+0x6e/0x6e
[    7.784300]  do_one_initcall+0x68/0x13c
[    7.784300]  ? parse_args+0xb3/0x1e4
[    7.784300]  kernel_init_freeable+0xea/0x174
[    7.784300]  ? rest_init+0xbb/0xbb
[    7.784300]  kernel_init+0x8/0xd5
[    7.784300]  ret_from_fork+0x2e/0x38
[    7.836203] IDA: 147321 of 147321 tests passed
[    7.844144] Running rhashtable test nelem=8, max_size=0, shrinking=0
[    7.844873] Test 00:
[    7.845204]   Adding 50000 keys
[    7.867003]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.879473]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.880945]   Deleting 50000 keys
[    7.894870]   Duration of test: 49291795 ns
[    7.895561] Test 01:
[    7.895935]   Adding 50000 keys
[    7.921117]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.930886]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.931857]   Deleting 50000 keys
[    7.945511]   Duration of test: 49131953 ns
[    7.946111] Test 02:
[    7.946459]   Adding 50000 keys
[    7.981622]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.994316]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.995612]   Deleting 50000 keys
[    8.010064]   Duration of test: 63114566 ns
[    8.010902] Test 03:
[    8.011439]   Adding 50000 keys
[    8.039327]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    8.049556]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    8.051717]   Deleting 50000 keys
[    8.066370]   Duration of test: 54316782 ns
[    8.072054] test if its possible to exceed max_size 8192: no, ok
[    8.072824] Average test time: 53963774
[    8.073359] test inserting duplicates
[    8.074002] 
[    8.074002] ---- ht: ----
[    8.074002] bucket[1] -> [[ val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[    8.074002] -------------
[    8.075543] 
[    8.075543] ---- ht: ----
[    8.075543] bucket[1] -> [[ val 1 (tid=2),  val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[    8.075543] -------------
[    8.077243] 
[    8.077243] ---- ht: ----
[    8.077243] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=0) ]]
[    8.077243] -------------
[    8.078745] 
[    8.078745] ---- ht: ----
[    8.078745] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=2),  val 1 (tid=0) ]]
[    8.078745] -------------
[    8.080424] Testing concurrent rhashtable access from 10 threads
[    9.293946] test 3125 add/delete pairs into rhlist
[    9.317554] test 3125 random rhlist add/delete operations
[    9.344294] Started 10 threads, 0 failed, rhltable test returns 0
[    9.345095] test passed
[    9.345428] test_printf: crng possibly not yet initialized. plain 'p' buffer contains "(ptrval)"
[    9.345526] test_printf: all 240 tests passed
[    9.347158] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 915
[    9.349541] test_bitmap: all 1524 tests passed
[    9.350059] test_uuid: all 18 tests passed
[   11.880031] WARNING: CPU: 0 PID: 1 at include/linux/xarray.h:54 xa_mk_value+0x7/0x10
[   11.881093] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-rc5-00321-g0e9446c #1082
[   11.881944] EIP: xa_mk_value+0x7/0x10
[   11.882374] Code: 04 96 5b 5e 5d c3 55 89 e5 e8 8a 5b ff ff 5d c3 55 89 e5 5d c3 55 31 c9 89 e5 6a 00 e8 59 46 53 00 c9 c3 55 85 c0 89 e5 79 02 <0f> 0b 01 c0 83 c8 01 5d c3 55 89 e5 53 89 c3 89 d0 25 ff ff ff 7f
[   11.883565] EAX: ffffffff EBX: ffffffff ECX: 00000000 EDX: ffffffff
[   11.883565] ESI: ffffffff EDI: 00000080 EBP: 9ec2bf04 ESP: 9ec2bf04
[   11.883565] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068 EFLAGS: 00210286
[   11.883565] CR0: 80050033 CR2: 00000000 CR3: 01bac000 CR4: 000406b0
[   11.883565] Call Trace:
[   11.883565]  __check_store_range+0xe/0x171
[   11.883565]  check_store_range+0x5d/0x87
[   11.883565]  ? check_reserve+0x321/0x321
[   11.883565]  xarray_checks+0x58/0xab
[   11.883565]  do_one_initcall+0x68/0x13c
[   11.883565]  ? parse_args+0xb3/0x1e4
[   11.883565]  kernel_init_freeable+0xea/0x174
[   11.883565]  ? rest_init+0xbb/0xbb
[   11.883565]  kernel_init+0x8/0xd5
[   11.883565]  ret_from_fork+0x2e/0x38
[   11.883565] _warn_unseeded_randomness: 5 callbacks suppressed
[   11.883565] random: get_random_bytes called from init_oops_id+0x23/0x3f with crng_init=1
[   11.883565] ---[ end trace 4caf99c850e11324 ]---


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,
Rong Chen

View attachment "config-4.19.0-rc5-00321-g0e9446c" of type "text/plain" (104330 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (9068 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ