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-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <20210126074440.GD19582@xsang-OptiPlex-9020>
Date:   Tue, 26 Jan 2021 15:44:40 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     Yejune Deng <yejune.deng@...il.com>
Cc:     0day robot <lkp@...el.com>, LKML <linux-kernel@...r.kernel.org>,
        lkp@...ts.01.org, john.stultz@...aro.org, tglx@...utronix.de,
        sboyd@...nel.org, yejune.deng@...il.com
Subject: [ntp]  a29bace5d3:
 BUG:Bad_rss-counter_state_mm:#type:MM_FILEPAGES_val


Greeting,

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

commit: a29bace5d3c06a350b4b5788fa0a304f2695d9e8 ("[PATCH] ntp: use memset and offsetof init")
url: https://github.com/0day-ci/linux/commits/Yejune-Deng/ntp-use-memset-and-offsetof-init/20210120-110830
base: https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git 3cabca87b329cbcbdf295be0094adbd72c7b1f67

in testcase: trinity
version: trinity-static-i386-x86_64-f93256fb_2019-08-28
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 8G

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


+-----------------------------------------------------------------------------------------+------------+------------+
|                                                                                         | 3cabca87b3 | a29bace5d3 |
+-----------------------------------------------------------------------------------------+------------+------------+
| boot_successes                                                                          | 18         | 4          |
| boot_failures                                                                           | 3          | 30         |
| invoked_oom-killer:gfp_mask=0x                                                          | 2          | 1          |
| Mem-Info                                                                                | 2          | 1          |
| BUG:kernel_hang_in_boot_stage                                                           | 1          | 1          |
| BUG:Bad_rss-counter_state_mm:#type:MM_FILEPAGES_val                                     | 0          | 5          |
| BUG:Bad_rss-counter_state_mm:#type:MM_ANONPAGES_val                                     | 0          | 5          |
| BUG:Bad_rss-counter_state_mm:#type:MM_SHMEMPAGES_val                                    | 0          | 5          |
| BUG:unable_to_handle_page_fault_for_address                                             | 0          | 7          |
| Oops:#[##]                                                                              | 0          | 19         |
| EIP:vt_console_print                                                                    | 0          | 6          |
| Kernel_panic-not_syncing:Fatal_exception                                                | 0          | 17         |
| EIP:native_machine_emergency_restart                                                    | 0          | 6          |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt                                   | 0          | 9          |
| WARNING:at_kernel/events/core.c:#perf_event_groups_delete                               | 0          | 4          |
| EIP:perf_event_groups_delete                                                            | 0          | 4          |
| BUG:kernel_NULL_pointer_dereference,address                                             | 0          | 12         |
| EIP:shmem_fault                                                                         | 0          | 1          |
| EIP:__copy_user_ll                                                                      | 0          | 1          |
| EIP:enqueue_task_fair                                                                   | 0          | 2          |
| EIP:default_idle                                                                        | 0          | 2          |
| EIP:strlen                                                                              | 0          | 1          |
| EIP:filp_close                                                                          | 0          | 2          |
| EIP:__splice_from_pipe                                                                  | 0          | 1          |
| BUG:non-zero_pgtables_bytes_on_freeing_mm                                               | 0          | 4          |
| EIP:unmap_page_range                                                                    | 0          | 1          |
| PANIC:double_fault                                                                      | 0          | 1          |
| double_fault:#[##]                                                                      | 0          | 1          |
| EIP:no_context                                                                          | 0          | 1          |
| EIP:queued_spin_lock_slowpath                                                           | 0          | 1          |
| EIP:list_lru_del                                                                        | 0          | 2          |
| EIP:freeary                                                                             | 0          | 1          |
| EIP:__perf_event_task_sched_in                                                          | 0          | 1          |
| Kernel_panic-not_syncing:stack-protector:Kernel_stack_is_corrupted_in:show_opcodes.cold | 0          | 1          |
| EIP:get_rr_interval_fair                                                                | 0          | 1          |
+-----------------------------------------------------------------------------------------+------------+------------+


If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang@...el.com>


[   67.177129] BUG: Bad rss-counter state mm:db2c2924 type:MM_FILEPAGES val:-2657
[   67.178244] BUG: Bad rss-counter state mm:db2c2924 type:MM_ANONPAGES val:-814
[   67.179219] BUG: Bad rss-counter state mm:db2c2924 type:MM_SHMEMPAGES val:-4591
[   68.282064] audit: type=1326 audit(1611623366.489:46): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1192 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   69.314061] audit: type=1326 audit(1611623367.521:47): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1216 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   69.329549] audit: type=1326 audit(1611623367.537:48): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1083 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   69.352702] audit: type=1326 audit(1611623367.560:49): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1228 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   71.391986] audit: type=1326 audit(1611623369.598:50): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1241 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   72.127879] audit: type=1326 audit(1611623370.335:51): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1225 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   73.147217] [main] 31727 iterations. [F:23666 S:7901 HI:2077]
[   73.147222]
[   73.151518] audit: type=1326 audit(1611623371.358:52): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1258 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   73.205068] audit: type=1326 audit(1611623371.412:53): auid=4294967295 uid=65534 gid=65534 ses=4294967295 pid=1256 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f60549 code=0x0
[   74.557386] trinity-c0 invoked oom-killer: gfp_mask=0x100cca(GFP_HIGHUSER_MOVABLE), order=0, oom_score_adj=500
[   74.558865] CPU: 0 PID: 1269 Comm: trinity-c0 Not tainted 5.10.0-rc1-ga29bace5d3c0 #1
[   74.560004] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[   74.561175] Call Trace:
[   74.561587] dump_stack (kbuild/src/consumer/lib/dump_stack.c:120) 
[   74.562084] dump_header (kbuild/src/consumer/mm/oom_kill.c:462) 
[   74.562616] oom_kill_process.cold (kbuild/src/consumer/mm/oom_kill.c:978) 
[   74.563241] ? oom_badness (kbuild/src/consumer/mm/oom_kill.c:514) 
[   74.563887] out_of_memory (kbuild/src/consumer/mm/oom_kill.c:1115 kbuild/src/consumer/mm/oom_kill.c:1047) 
[   74.564455] __alloc_pages_slowpath+0xaf4/0xba0 
[   74.565276] __alloc_pages_nodemask (kbuild/src/consumer/mm/page_alloc.c:4956) 
[   74.568673] shmem_getpage_gfp+0x13c/0x710 
[   74.569389] ? finish_task_switch (kbuild/src/consumer/include/linux/perf_event.h:1219 kbuild/src/consumer/kernel/sched/core.c:3611) 
[   74.570037] ? __schedule (kbuild/src/consumer/kernel/sched/core.c:3777 kbuild/src/consumer/kernel/sched/core.c:4523) 
[   74.570593] shmem_fallocate (kbuild/src/consumer/mm/shmem.c:2857) 
[   74.571194] ? do_setitimer (kbuild/src/consumer/include/linux/hrtimer.h:423 kbuild/src/consumer/kernel/time/itimer.c:237) 
[   74.571782] vfs_fallocate (kbuild/src/consumer/fs/open.c:309) 
[   74.572351] ? vfs_fallocate (kbuild/src/consumer/fs/open.c:309) 
[   74.574028] ksys_fallocate (kbuild/src/consumer/include/linux/file.h:45 kbuild/src/consumer/fs/open.c:333) 
[   74.574590] __ia32_sys_ia32_fallocate (kbuild/src/consumer/arch/x86/kernel/sys_ia32.c:119) 
[   74.575264] __do_fast_syscall_32 (kbuild/src/consumer/arch/x86/entry/common.c:78 kbuild/src/consumer/arch/x86/entry/common.c:137) 
[   74.575861] do_fast_syscall_32 (kbuild/src/consumer/arch/x86/entry/common.c:160) 
[   74.576500] do_SYSENTER_32 (kbuild/src/consumer/arch/x86/entry/common.c:204) 
[   74.577083] entry_SYSENTER_32 (kbuild/src/consumer/arch/x86/entry/entry_32.S:953) 
[   74.577694] EIP: 0xb7f60549
[ 74.578173] Code: 03 74 c0 01 10 05 03 74 b8 01 10 06 03 74 b4 01 10 07 03 74 b0 01 10 08 03 74 d8 01 00 00 00 00 00 51 52 55 89 e5 0f 34 cd 80 <5d> 5a 59 c3 90 90 90 90 8d 76 00 58 b8 77 00 00 00 cd 80 90 8d 76
All code
========
   0:	03 74 c0 01          	add    0x1(%rax,%rax,8),%esi
   4:	10 05 03 74 b8 01    	adc    %al,0x1b87403(%rip)        # 0x1b8740d
   a:	10 06                	adc    %al,(%rsi)
   c:	03 74 b4 01          	add    0x1(%rsp,%rsi,4),%esi
  10:	10 07                	adc    %al,(%rdi)
  12:	03 74 b0 01          	add    0x1(%rax,%rsi,4),%esi
  16:	10 08                	adc    %cl,(%rax)
  18:	03 74 d8 01          	add    0x1(%rax,%rbx,8),%esi
  1c:	00 00                	add    %al,(%rax)
  1e:	00 00                	add    %al,(%rax)
  20:	00 51 52             	add    %dl,0x52(%rcx)
  23:	55                   	push   %rbp
  24:	89 e5                	mov    %esp,%ebp
  26:	0f 34                	sysenter 
  28:	cd 80                	int    $0x80
  2a:*	5d                   	pop    %rbp		<-- trapping instruction
  2b:	5a                   	pop    %rdx
  2c:	59                   	pop    %rcx
  2d:	c3                   	retq   
  2e:	90                   	nop
  2f:	90                   	nop
  30:	90                   	nop
  31:	90                   	nop
  32:	8d 76 00             	lea    0x0(%rsi),%esi
  35:	58                   	pop    %rax
  36:	b8 77 00 00 00       	mov    $0x77,%eax
  3b:	cd 80                	int    $0x80
  3d:	90                   	nop
  3e:	8d                   	.byte 0x8d
  3f:	76                   	.byte 0x76

Code starting with the faulting instruction
===========================================
   0:	5d                   	pop    %rbp
   1:	5a                   	pop    %rdx
   2:	59                   	pop    %rcx
   3:	c3                   	retq   
   4:	90                   	nop
   5:	90                   	nop
   6:	90                   	nop
   7:	90                   	nop
   8:	8d 76 00             	lea    0x0(%rsi),%esi
   b:	58                   	pop    %rax
   c:	b8 77 00 00 00       	mov    $0x77,%eax
  11:	cd 80                	int    $0x80
  13:	90                   	nop
  14:	8d                   	.byte 0x8d
  15:	76                   	.byte 0x76
[   74.580624] EAX: ffffffda EBX: 00000117 ECX: 00000000 EDX: 00001000
[   74.581445] ESI: 00000004 EDI: 00020000 EBP: 00000064 ESP: bf91ce9c
[   74.582280] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000292
[   74.583236] Mem-Info:
[   74.585128] active_anon:5960 inactive_anon:722051 isolated_anon:0
[   74.585128]  active_file:0 inactive_file:0 isolated_file:0
[   74.585128]  unevictable:36763 dirty:0 writeback:0
[   74.585128]  slab_reclaimable:5105 slab_unreclaimable:2319
[   74.585128]  mapped:7877 shmem:711742 pagetables:314 bounce:0
[   74.585128]  free:1409 free_pcp:217 free_cma:0
[   74.594070] Node 0 active_anon:23840kB inactive_anon:2888204kB active_file:0kB inactive_file:0kB unevictable:147052kB isolated(anon):0kB isolated(file):0kB mapped:31508kB dirty:0kB writeback:0kB shmem:2846968kB writeback_tmp:0kB kernel_stack:688kB all_unreclaimable? yes
[   74.600900] DMA free:1652kB min:96kB low:120kB high:144kB reserved_highatomic:0KB active_anon:0kB inactive_anon:14236kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15916kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[   74.600902] lowmem_reserve[]: 0 392 2975 392
[   74.609397] Normal free:3260kB min:8068kB low:8688kB high:9308kB reserved_highatomic:0KB active_anon:0kB inactive_anon:392740kB active_file:0kB inactive_file:0kB unevictable:8760kB writepending:0kB present:483320kB managed:437924kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:620kB local_pcp:620kB free_cma:0kB
[   74.609401] lowmem_reserve[]: 0 0 20671 0
[   74.618257] HighMem free:724kB min:4608kB low:8700kB high:12792kB reserved_highatomic:0KB active_anon:23840kB inactive_anon:2481124kB active_file:0kB inactive_file:0kB unevictable:138292kB writepending:0kB present:2645896kB managed:2645896kB mlocked:36kB pagetables:1256kB bounce:0kB free_pcp:248kB local_pcp:248kB free_cma:0kB
[   74.618258] lowmem_reserve[]: 0 0 0 0
[   74.627934] DMA: 1*4kB (U) 2*8kB (UM) 0*16kB 1*32kB (U) 3*64kB (UM) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (M) 0*2048kB 0*4096kB = 1652kB
[   74.631546] Normal: 0*4kB 110*8kB (UE) 71*16kB (UE) 33*32kB (UE) 1*64kB (E) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3136kB
[   74.635123] HighMem: 49*4kB (UM) 18*8kB (UM) 2*16kB (UM) 1*32kB (U) 1*64kB (M) 0*128kB 1*256kB (M) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 724kB
[   74.636824] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=4096kB
[   74.641687] 748496 total pagecache pages
[   74.642302] 0 pages in swap cache
[   74.642814] Swap cache stats: add 0, delete 0, find 0/0
[   74.644272] Free swap  = 0kB
[   74.645216] Total swap = 0kB
[   74.646094] 786302 pages RAM
[   74.646620] 661474 pages HighMem/MovableOnly
[   74.648037] 11368 pages reserved
[   74.648612] Tasks state (memory values in pages):
[   74.649995] [  pid  ]   uid  tgid total_vm      rss pgtables_bytes swapents oom_score_adj name
[   74.652122] [     71]     0    71      869      628    16384        0             0 plymouthd
[   74.653402] [     73]     0    73      856      442    16384        0             0 lkp-bootstrap
[   74.656217] [     75]     0    75     1362      887    20480        0         -1000 lkp-setup-rootf
[   74.657495] [     95]     0    95      969      323    16384        0         -1000 tail
[   74.660090] [     96]     0    96     9170     8337    49152        0         -1000 sed
[   74.661260] [     97]     0    97      968      318    16384        0         -1000 tail
[   74.663876] [     98]     0    98     6535     5658    45056        0         -1000 sed
[   74.665035] [    169]     0   169      705      456    16384        0             0 upstart-udev-br
[   74.667784] [    176]     0   176      775      619    16384        0         -1000 udevd
[   74.668966] [    180]     0   180     1416      917    20480        0         -1000 run-lkp
[   74.671455] [    254]     0   254      742      460    16384        0         -1000 udevd
[   74.673566] [    268]     0   268      742      459    16384        0         -1000 udevd
[   74.674747] [    356]     0   356      702       36    16384        0             0 upstart-socket-
[   74.677586] [    375]     0   375      882      740    16384        0             0 rc
[   74.678680] [    376]     0   376      645      472    16384        0             0 getty
[   74.681308] [    378]     0   378      645      481    16384        0             0 getty
[   74.682478] [    379]     0   379      645      485    16384        0             0 getty
[   74.684994] [    382]     0   382      645      470    16384        0             0 getty
[   74.686182] [    383]     0   383      645      443    16384        0             0 getty
[   74.688870] [    394]     0   394      870      747    16384        0             0 S99rc.local
[   74.690122] [    400]     0   400      836      665    16384        0             0 rc.local
[   74.692726] [    401]     0   401      837      680    16384        0             0 lkp-bootstrap
[   74.693980] [    404]     0   404      537      135    16384        0             0 sleep
[   74.696210] [    407]     0   407     1319      830    20480        0          1000 trinity-300s-qu
[   74.698619] [    411]     0   411      970      291    12288        0             0 cat
[   74.699764] [    413]     0   413     1001      369    16384        0             0 vmstat
[   74.702157] [    415]     0   415     1280      789    20480        0             0 meminfo
[   74.704115] [    431]     0   431      244       11    12288        0             0 wakeup
[   74.705232] [    433]     0   433      244       12    16384        0             0 wakeup
[   74.707438] [    442]     0   442      966      287    20480        0             0 cat
[   74.709516] [    446]     0   446      638      425    12288        0             0 gzip-meminfo
[   74.710764] [    457]     0   457     1280      774    20480        0             0 trinity
[   74.713267] [    460]     0   460      961      368    16384        0             0 tee


To reproduce:

        # build kernel
	cd linux
	cp config-5.10.0-rc1-ga29bace5d3c0 .config
	make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare modules_prepare bzImage

        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,
Oliver Sang


View attachment "config-5.10.0-rc1-ga29bace5d3c0" of type "text/plain" (122790 bytes)

View attachment "job-script" of type "text/plain" (4173 bytes)

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

View attachment "trinity" of type "text/plain" (4305 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ