BTRFS info (device sdb1): flagging fs with big metadata feature
BTRFS info (device sdb1): disk space caching is enabled
BTRFS info (device sdb1): has skinny extents
BTRFS info (device sdb1): enabling ssd optimizations
install debs round one: dpkg -i --force-confdef --force-depends /opt/deb/ntpdate_1%3a4.2.8p12+dfsg-4_amd64.deb

/opt/deb/automake_1%3a1.16.1-4_all.deb

/opt/deb/libpsm-infinipath1_3.3+20.604758e7-6_amd64.deb

/opt/deb/libquadmath0_8.3.0-6_amd64.deb

/opt/deb/netcat-openbsd_1.195-2_amd64.deb

/opt/deb/python-pip-whl_18.1-5_all.deb

/opt/deb/python-pip_18.1-5_all.deb

/opt/deb/python-pkg-resources_40.8.0-1_all.deb

/opt/deb/python-setuptools_40.8.0-1_all.deb

/opt/deb/python-wheel_0.32.3-2_all.deb

/opt/deb/gawk_1%3a4.2.1+dfsg-1_amd64.deb

Selecting previously unselected package ntpdate.

(Reading database ... 16553 files and directories currently installed.)

Preparing to unpack .../ntpdate_1%3a4.2.8p12+dfsg-4_amd64.deb ...

Unpacking ntpdate (1:4.2.8p12+dfsg-4) ...

Selecting previously unselected package automake.

Preparing to unpack .../automake_1%3a1.16.1-4_all.deb ...

Unpacking automake (1:1.16.1-4) ...

Selecting previously unselected package libpsm-infinipath1.

Preparing to unpack .../libpsm-infinipath1_3.3+20.604758e7-6_amd64.deb ...

Unpacking libpsm-infinipath1 (3.3+20.604758e7-6) ...

Selecting previously unselected package libquadmath0:amd64.

Preparing to unpack .../libquadmath0_8.3.0-6_amd64.deb ...

Unpacking libquadmath0:amd64 (8.3.0-6) ...

Selecting previously unselected package netcat-openbsd.

Preparing to unpack .../netcat-openbsd_1.195-2_amd64.deb ...

Unpacking netcat-openbsd (1.195-2) ...

Selecting previously unselected package python-pip-whl.

Preparing to unpack .../python-pip-whl_18.1-5_all.deb ...

Unpacking python-pip-whl (18.1-5) ...

Selecting previously unselected package python-pip.

Preparing to unpack .../deb/python-pip_18.1-5_all.deb ...

Unpacking python-pip (18.1-5) ...

Selecting previously unselected package python-pkg-resources.

Preparing to unpack .../python-pkg-resources_40.8.0-1_all.deb ...

Unpacking python-pkg-resources (40.8.0-1) ...

Selecting previously unselected package python-setuptools.

Preparing to unpack .../python-setuptools_40.8.0-1_all.deb ...

Unpacking python-setuptools (40.8.0-1) ...

Selecting previously unselected package python-wheel.

Preparing to unpack .../python-wheel_0.32.3-2_all.deb ...

Unpacking python-wheel (0.32.3-2) ...

Selecting previously unselected package gawk.

Preparing to unpack .../gawk_1%3a4.2.1+dfsg-1_amd64.deb ...

Unpacking gawk (1:4.2.1+dfsg-1) ...

Setting up ntpdate (1:4.2.8p12+dfsg-4) ...

Setting up libpsm-infinipath1 (3.3+20.604758e7-6) ...

x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
x86/PAT: bmc-watchdog:715 map pfn expected mapping type uncached-minus for [mem 0xd52bd000-0xd52bdfff], got write-back
update-alternatives: using /usr/lib/libpsm1/libpsm_infinipath.so.1.16 to provide /usr/lib/x86_64-linux-gnu/libpsm_infinipath.so.1 (libpsm_infinipath.so.1) in auto mode

Setting up libquadmath0:amd64 (8.3.0-6) ...

Setting up netcat-openbsd (1.195-2) ...

update-alternatives: using /bin/nc.openbsd to provide /bin/nc (nc) in auto mode

Setting up python-pip-whl (18.1-5) ...

Setting up python-pip (18.1-5) ...

Setting up python-pkg-resources (40.8.0-1) ...

Setting up python-setuptools (40.8.0-1) ...

Setting up python-wheel (0.32.3-2) ...

Setting up gawk (1:4.2.1+dfsg-1) ...

Setting up automake (1:1.16.1-4) ...

update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode

Processing triggers for libc-bin (2.28-10) ...

22 Jan 06:43:16 ntpdate[596]: step time server 192.168.1.200 offset 678.732533 sec

/lkp/lkp/src/bin/run-lkp

RESULT_ROOT=/result/ocfs2test/1HDD-test-aiostress-ucode=0x28/lkp-hsw-d05/debian-10.4-x86_64-20200603.cgz/x86_64-rhel-8.3-func/gcc-9/32e1a3dbeb6b569a29d843426cb163b5fd27a348/3

job=/lkp/jobs/scheduled/lkp-hsw-d05/ocfs2test-1HDD-test-aiostress-ucode=0x28-debian-10.4-x86_64-20200603.cgz-32e1a3dbeb6b569a29d843426cb163b5fd27a348-20220122-65617-z7ubxd-4.yaml

ocfs2: Registered cluster interface o2cb
o2hb: Heartbeat mode set to local
mkfs.ocfs2 1.8.5

result_service: raw_upload, RESULT_MNT: /internal-lkp-server/result, RESULT_ROOT: /internal-lkp-server/result/ocfs2test/1HDD-test-aiostress-ucode=0x28/lkp-hsw-d05/debian-10.4-x86_64-20200603.cgz/x86_64-rhel-8.3-func/gcc-9/32e1a3dbeb6b569a29d843426cb163b5fd27a348/3, TMP_RESULT_ROOT: /tmp/lkp/result

run-job /lkp/jobs/scheduled/lkp-hsw-d05/ocfs2test-1HDD-test-aiostress-ucode=0x28-debian-10.4-x86_64-20200603.cgz-32e1a3dbeb6b569a29d843426cb163b5fd27a348-20220122-65617-z7ubxd-4.yaml

/usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://internal-lkp-server:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_file=/lkp/jobs/scheduled/lkp-hsw-d05/ocfs2test-1HDD-test-aiostress-ucode=0x28-debian-10.4-x86_64-20200603.cgz-32e1a3dbeb6b569a29d843426cb163b5fd27a348-20220122-65617-z7ubxd-4.yaml&job_state=running -O /dev/null

target ucode: 0x28

current_version: 28, target_version: 28

linux-kernel/

Processing /lkp/benchmarks/ocfs2test/timing-0.0.1.tar.gz

Building wheels for collected packages: timing

Running setup.py bdist_wheel for timing: started

Running setup.py bdist_wheel for timing: finished with status 'done'

Stored in directory: /root/.cache/pip/wheels/46/f8/5a/63e3adfe4f4475f9bda916662054b9c4945d910b02d8ec5fce

Successfully built timing

Installing collected packages: timing

Successfully installed timing-0.0.1

Output log is /home/ocfs2test/ocfs2log/2022-01-22_06:43/single_run.log

JBD2: Ignoring recovery information on journal
ocfs2: Mounting device (8,1) on (node local, slot 0) with writeback data mode.
------------[ cut here ]------------
kernel BUG at fs/ocfs2/uptodate.c:65!
invalid opcode: 0000 [#1] SMP KASAN PTI
CPU: 2 PID: 970 Comm: aio-stress Not tainted 5.16.0-06519-g32e1a3dbeb6b #1
Hardware name: Gigabyte Technology Co., Ltd. Z97X-UD5H/Z97X-UD5H, BIOS F9 04/21/2015
RIP: 0010:ocfs2_metadata_cache_get_super+0x58/0x80 [ocfs2]
Code: 29 48 b8 00 00 00 00 00 fc ff df 48 8d 7b 08 48 89 fa 48 c1 ea 03 80 3c 02 00 75 17 48 8b 43 08 48 89 ef 5b 5d e9 08 01 ae c1 <0f> 0b e8 21 e1 b8 bf eb c5 e8 1a e1 b8 bf eb e2 66 66 2e 0f 1f 84
RSP: 0018:ffffc90001b3ecd0 EFLAGS: 00010246
RAX: dffffc0000000000 RBX: 0000000000000000 RCX: 0000000000000001
RDX: 1ffff110833fee09 RSI: ffffc90001b3ee20 RDI: ffff888419ff704c
RBP: ffff888419ff704c R08: 0000000000000001 R09: ffff888183cc8800
R10: dffffc0000000000 R11: 0000000000000000 R12: ffffc90001b3ee20
R13: 0000000000000000 R14: 0000000000000000 R15: ffffc90001b3ee38
FS:  00007f70925db700(0000) GS:ffff8883a7300000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f70915c8000 CR3: 0000000418668005 CR4: 00000000001706e0
Call Trace:
<TASK>
ocfs2_add_clusters_in_btree+0xb8/0xcc0 [ocfs2]
? kasan_save_stack+0x1e/0x80
? __kasan_slab_alloc+0x66/0x80
? kmem_cache_alloc+0x123/0x480
? jbd2__journal_start+0x173/0x7c0
? ocfs2_insert_extent+0x6c0/0x6c0 [ocfs2]
? ocfs2_direct_IO+0x1c8/0x380 [ocfs2]
? generic_file_direct_write+0x1a4/0x440
? __generic_file_write_iter+0x1fa/0x480
? ocfs2_file_write_iter+0x6c7/0xf40 [ocfs2]
? __jbd2_journal_unfile_buffer+0xc0/0xc0
? __x64_sys_io_submit+0x14d/0x3c0
? do_syscall_64+0x3b/0xc0
? entry_SYSCALL_64_after_hwframe+0x44/0xae
ocfs2_add_inode_data+0x88/0xc0 [ocfs2]
? ocfs2_truncate_file+0x1500/0x1500 [ocfs2]
? start_this_handle+0xdb3/0x1240
ocfs2_write_cluster+0xb16/0x13c0 [ocfs2]
? kasan_unpoison+0x23/0x80
? ocfs2_map_page_blocks+0xdc0/0xdc0 [ocfs2]
? mutex_unlock+0x80/0x100
? jbd2_journal_get_write_access+0xba/0x140
? __ocfs2_journal_access+0x50a/0x700 [ocfs2]
? ocfs2_complete_recovery+0xb80/0xb80 [ocfs2]
? _raw_spin_lock+0x81/0x100
ocfs2_write_begin_nolock+0x2ad8/0x3d40 [ocfs2]
? ocfs2_size_fits_inline_data+0xc0/0xc0 [ocfs2]
? ocfs2_read_inode_block_full+0xc2/0x180 [ocfs2]
? ocfs2_refresh_inode+0x900/0x900 [ocfs2]
? __raw_callee_save___native_queued_spin_unlock+0x11/0x1e
? ocfs2_inode_lock_full_nested+0x450/0x7c0 [ocfs2]
? ocfs2_allocate_extend_trans+0x3c0/0x3c0 [ocfs2]
? down_write_killable+0x140/0x140
ocfs2_dio_wr_get_block+0x62f/0x1780 [ocfs2]
? iov_iter_get_pages+0x177/0xd40
? ocfs2_write_end_nolock+0x1240/0x1240 [ocfs2]
? iov_iter_get_pages_alloc+0x10c0/0x10c0
? __kasan_init_slab_obj+0x21/0x40
? allocate_slab+0x20f/0x3c0
do_direct_IO+0x52f/0x3700
? _raw_write_lock_irq+0x100/0x100
? kasan_unpoison+0x23/0x80
? do_blockdev_direct_IO+0x1d7/0x2900
do_blockdev_direct_IO+0xb0e/0x2900
? ocfs2_dio_end_io_write+0xb40/0xb40 [ocfs2]
? do_direct_IO+0x3700/0x3700
? native_queued_spin_lock_slowpath+0x167/0x940
? ocfs2_read_blocks_sync+0x840/0x840 [ocfs2]
? .slowpath+0xe/0xe
? truncate_pagecache_range+0xc0/0xc0
? _raw_spin_lock+0xc8/0x100
? _raw_write_lock_irq+0x100/0x100
? ocfs2_write_end_nolock+0x1240/0x1240 [ocfs2]
? filemap_fdatawait_keep_errors+0x40/0x40
? __mark_inode_dirty+0x594/0x840
? generic_update_time+0x193/0x300
ocfs2_direct_IO+0x1c8/0x380 [ocfs2]
generic_file_direct_write+0x1a4/0x440
__generic_file_write_iter+0x1fa/0x480
ocfs2_file_write_iter+0x6c7/0xf40 [ocfs2]
? ocfs2_prepare_inode_for_write+0x880/0x880 [ocfs2]
? stack_trace_save+0x91/0xc0
aio_write+0x2f5/0x680
? aio_prep_rw+0x780/0x780
? kasan_save_stack+0x38/0x80
? kasan_save_stack+0x1e/0x80
? __kasan_slab_alloc+0x66/0x80
? io_submit_one+0xb8/0x1400
? __x64_sys_io_submit+0x14d/0x3c0
? do_syscall_64+0x3b/0xc0
? tcp_mtu_probe+0x16c0/0x2380
? _raw_spin_lock_irqsave+0x87/0x100
? get_random_u32+0xe1/0x180
? __kasan_init_slab_obj+0x21/0x40
? setup_object+0x17/0xc0
? __io_submit_one+0xa7d/0x1040
__io_submit_one+0xa7d/0x1040
? aio_poll_complete_work+0x1500/0x1500
? kasan_unpoison+0x23/0x80
? __kasan_slab_alloc+0x66/0x80
? __get_reqs_available+0x115/0x200
io_submit_one+0x210/0x1400
? exc_page_fault+0x57/0xc0
? asm_exc_page_fault+0x1e/0x30
? __io_submit_one+0x1040/0x1040
? __get_user_4+0x1c/0x30
__x64_sys_io_submit+0x14d/0x3c0
? __ia32_compat_sys_io_submit+0x380/0x380
? switch_fpu_return+0xe7/0x200
? exit_to_user_mode_prepare+0x1a2/0x240
do_syscall_64+0x3b/0xc0
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f7093ee5f59
Code: 00 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 07 6f 0c 00 f7 d8 64 89 01 48
RSP: 002b:00007f70925dad58 EFLAGS: 00000246 ORIG_RAX: 00000000000000d1
RAX: ffffffffffffffda RBX: 00007f70925db680 RCX: 00007f7093ee5f59
RDX: 00005557274dfdb0 RSI: 0000000000000010 RDI: 00007f70915c8000
RBP: 00007f70915c8000 R08: 00007fff7c5d7080 R09: 00005557274dfdb0
R10: 0000000061eba79f R11: 0000000000000246 R12: 0000000000000010
R13: 0000000000000000 R14: 00005557274dfdb0 R15: 00005557274db360
</TASK>
Modules linked in: ocfs2_stack_o2cb ocfs2_dlm ocfs2 ocfs2_nodemanager ocfs2_stackglue netconsole btrfs blake2b_generic xor ipmi_devintf ipmi_msghandler raid6_pq zstd_compress libcrc32c sd_mod intel_rapl_msr t10_pi intel_rapl_common sg x86_pkg_temp_thermal intel_powerclamp coretemp i915 kvm_intel kvm intel_gtt irqbypass crct10dif_pclmul ttm crc32_pclmul crc32c_intel drm_kms_helper ghash_clmulni_intel rapl intel_cstate syscopyarea sysfillrect mei_me sysimgblt ahci libahci fb_sys_fops drm mei intel_uncore libata mxm_wmi wmi video acpi_pad ip_tables
---[ end trace 9549ba6a15dd5463 ]---
RIP: 0010:ocfs2_metadata_cache_get_super+0x58/0x80 [ocfs2]
Code: 29 48 b8 00 00 00 00 00 fc ff df 48 8d 7b 08 48 89 fa 48 c1 ea 03 80 3c 02 00 75 17 48 8b 43 08 48 89 ef 5b 5d e9 08 01 ae c1 <0f> 0b e8 21 e1 b8 bf eb c5 e8 1a e1 b8 bf eb e2 66 66 2e 0f 1f 84
RSP: 0018:ffffc90001b3ecd0 EFLAGS: 00010246
RAX: dffffc0000000000 RBX: 0000000000000000 RCX: 0000000000000001
RDX: 1ffff110833fee09 RSI: ffffc90001b3ee20 RDI: ffff888419ff704c
RBP: ffff888419ff704c R08: 0000000000000001 R09: ffff888183cc8800
R10: dffffc0000000000 R11: 0000000000000000 R12: ffffc90001b3ee20
R13: 0000000000000000 R14: 0000000000000000 R15: ffffc90001b3ee38
FS:  00007f70925db700(0000) GS:ffff8883a7300000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f70915c8000 CR3: 0000000418668005 CR4: 00000000001706e0
Kernel panic - not syncing: Fatal exception
Kernel Offset: disabled