netpoll: netconsole: interface 'eth0' netpoll: netconsole: remote port 6679 netpoll: netconsole: remote IPv4 address 192.168.3.200 netpoll: netconsole: remote ethernet address 3c:fd:fe:d2:0f:7c netpoll: netconsole: local IP 192.168.3.102 printk: console [netcon0] enabled netconsole: network logging started BTRFS info (device sda1): using crc32c (crc32c-intel) checksum algorithm BTRFS info (device sda1): disk space caching is enabled BTRFS info (device sda1): enabling ssd optimizations device-mapper: uevent: version 1.0.3 device-mapper: ioctl: 4.47.0-ioctl (2022-07-28) initialised: dm-devel@redhat.com LKP: stdout: 278: /lkp/lkp/src/bin/run-lkp /lkp/jobs/scheduled/lkp-ivb-d05/ltp-1HDD-f2fs-dio-03-debian-12-x86_64-20220629.cgz-040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4-20220930-50020-1ctjfjr-6.yaml RESULT_ROOT=/result/ltp/1HDD-f2fs-dio-03/lkp-ivb-d05/debian-12-x86_64-20220629.cgz/x86_64-rhel-8.3-func/gcc-11/040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4/8 job=/lkp/jobs/scheduled/lkp-ivb-d05/ltp-1HDD-f2fs-dio-03-debian-12-x86_64-20220629.cgz-040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4-20220930-50020-1ctjfjr-6.yaml F2FS-fs (sdb1): Found nat_bits in checkpoint F2FS-fs (sdb1): Mounted with checkpoint version = 58867f2f x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back x86/PAT: bmc-watchdog:3844 map pfn expected mapping type uncached-minus for [mem 0xd8d1e000-0xd8d1efff], got write-back LTP: starting dio02 (diotest2) error: dpkg -i /opt/deb/trousers_0.3.15-0.2+b1_amd64.deb failed. LTP: starting dio06 (diotest6) ldconfig: /lib/x86_64-linux-gnu/ld-linux-x86-64.so.2 is not a symbolic link result_service: raw_upload, RESULT_MNT: /internal-lkp-server/result, RESULT_ROOT: /internal-lkp-server/result/ltp/1HDD-f2fs-dio-03/lkp-ivb-d05/debian-12-x86_64-20220629.cgz/x86_64-rhel-8.3-func/gcc-11/040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4/8, TMP_RESULT_ROOT: /tmp/lkp/result run-job /lkp/jobs/scheduled/lkp-ivb-d05/ltp-1HDD-f2fs-dio-03-debian-12-x86_64-20220629.cgz-040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4-20220930-50020-1ctjfjr-6.yaml LTP: starting dio12 (diotest6 -b 65536) /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-ivb-d05/ltp-1HDD-f2fs-dio-03-debian-12-x86_64-20220629.cgz-040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4-20220930-50020-1ctjfjr-6.yaml&job_state=running -O /dev/null target ucode: 0x21 current_version: 21, target_version: 21 2022-09-30 09:43:02 dmsetup remove_all 2022-09-30 09:43:02 wipefs -a --force /dev/sdb1 /dev/sdb1: 4 bytes were erased at offset 0x00000400 (f2fs): 10 20 f5 f2 2022-09-30 09:43:02 mkfs -t f2fs /dev/sdb1 F2FS-tools: mkfs.f2fs Ver: 1.14.0 (2020-08-24) Info: Disable heap-based policy Info: Debug level = 0 Info: Trim is enabled Info: [/dev/sdb1] Disk Model: ST1000DM003-1CH1 Info: Segments per section = 1 Info: Sections per zone = 1 Info: sector size = 512 Info: total sectors = 419430400 (204800 MB) Info: zone aligned segment0 blkaddr: 512 Info: format version with "Linux version 6.0.0-rc2-00011-g040b83fcecfb (kbuild@46157cbb990f) (gcc-11 (Debian 11.3.0-5) 11.3.0, GNU ld (GNU Binutils for Debian) 2.38.90.20220713) #1 SMP Fri Sep 30 13:56:07 CST 2022" Info: [/dev/sdb1] Discarding device Info: This device doesn't support BLKSECDISCARD Info: This device doesn't support BLKDISCARD Info: Overprovision ratio = 0.440% Info: Overprovision segments = 909 (GC reserved = 462) Info: format successful 2022-09-30 09:43:04 mkdir -p /fs/sdb1 f2fs 2022-09-30 09:43:04 mount -t f2fs /dev/sdb1 /fs/sdb1 /usr/bin/mkisofs 2022-09-30 09:43:06 ln -sf /usr/sbin/iptables-nft /usr/bin/iptables 2022-09-30 09:43:06 ln -sf /usr/sbin/ip6tables-nft /usr/bin/ip6tables 2022-09-30 09:43:06 export LTP_RUNTIME_MUL=2 2022-09-30 09:43:06 ./runltp -f dio-03 -d /fs/sdb1/tmpdir INFO: creating /lkp/benchmarks/ltp/output directory INFO: creating /lkp/benchmarks/ltp/results directory Checking for required user/group ids 'nobody' user id and group found. 'bin' user id and group found. 'daemon' user id and group found. Users group found. Sys group found. Required users/groups exist. If some fields are empty or look unusual you may have an old version. Compare to the current minimal requirements in Documentation/Changes. /etc/os-release PRETTY_NAME="Debian GNU/Linux bookworm/sid" NAME="Debian GNU/Linux" ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" uname: Linux lkp-ivb-d05 6.0.0-rc2-00011-g040b83fcecfb #1 SMP Fri Sep 30 13:56:07 CST 2022 x86_64 GNU/Linux /proc/cmdline LTP: starting dio14 (diotest2 -b 65536 -i 1000) ip=::::lkp-ivb-d05::dhcp root=/dev/ram0 RESULT_ROOT=/result/ltp/1HDD-f2fs-dio-03/lkp-ivb-d05/debian-12-x86_64-20220629.cgz/x86_64-rhel-8.3-func/gcc-11/040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4/8 BOOT_IMAGE=/pkg/linux/x86_64-rhel-8.3-func/gcc-11/040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4/vmlinuz-6.0.0-rc2-00011-g040b83fcecfb branch=linux-next/master job=/lkp/jobs/scheduled/lkp-ivb-d05/ltp-1HDD-f2fs-dio-03-debian-12-x86_64-20220629.cgz-040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4-20220930-50020-1ctjfjr-6.yaml user=lkp ARCH=x86_64 kconfig=x86_64-rhel-8.3-func commit=040b83fcecfb86f3225d3a5de7fd9b3fbccf83b4 max_uptime=2100 LKP_SERVER=internal-lkp-server nokaslr selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level LTP: starting dio16 (diotest5 -b 65536 -i 1000) Gnu C gcc (Debian 12.2.0-3) 12.2.0 Clang Gnu make 4.3 util-linux 2.38 mount linux 2.38 (libmount 2.38.0: selinux, smack, btrfs, verity, namespaces, assert, debug) modutils 29 e2fsprogs 1.46.5 Linux C Library gnu/libc.so.6 Dynamic linker (ldd) 2.33 Procps 3.3.17 Net-tools 2.10-alpha iproute2 0.8.0 iputils 20211215 ethtool 5.19 Kbd loadkeys: Sh-utils 8.32 Modules Loaded dm_mod f2fs crc32_generic netconsole btrfs blake2b_generic xor raid6_pq zstd_compress libcrc32c i915 sd_mod t10_pi crc64_rocksoft_generic crc64_rocksoft crc64 sg drm_buddy intel_rapl_msr intel_rapl_common intel_gtt x86_pkg_temp_thermal intel_powerclamp drm_display_helper ttm usb_storage coretemp crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel drm_kms_helper syscopyarea ahci rapl libahci sysfillrect intel_cstate intel_uncore sysimgblt ipmi_devintf mei_me libata mei fb_sys_fops ipmi_msghandler video drm fuse ip_tables free reports: total used free shared buff/cache available Mem: 6641220 846844 2681064 5312 3113312 2612064 Swap: 0 0 0 cpuinfo: Architecture: x86_64 CPU op-mode(s): 32-bit, 64-bit Address sizes: 36 bits physical, 48 bits virtual Byte Order: Little Endian CPU(s): 4 On-line CPU(s) list: 0-3 Vendor ID: GenuineIntel BIOS Vendor ID: Intel(R) Corporation Model name: Intel(R) Core(TM) i3-3220 CPU @ 3.30GHz BIOS Model name: Intel(R) Core(TM) i3-3220 CPU @ 3.30GHz CPU @ 3.3GHz BIOS CPU family: 206 CPU family: 6 Model: 58 Thread(s) per core: 2 Core(s) per socket: 2 Socket(s): 1 Stepping: 9 CPU(s) scaling MHz: 100% CPU max MHz: 3300.0000 CPU min MHz: 1600.0000 BogoMIPS: 6584.66 Flags: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc cpuid aperfmperf pni pclmulqdq dtes64 monitor ds_cpl est tm2 ssse3 cx16 xtpr pdcm pcid sse4_1 sse4_2 popcnt tsc_deadline_timer xsave avx f16c lahf_lm cpuid_fault epb pti ssbd ibrs ibpb stibp fsgsbase smep erms xsaveopt dtherm arat pln pts md_clear flush_l1d L1d cache: 64 KiB (2 instances) L1i cache: 64 KiB (2 instances) L2 cache: 512 KiB (2 instances) L3 cache: 3 MiB (1 instance) NUMA node(s): 1 NUMA node0 CPU(s): 0-3 Vulnerability Itlb multihit: KVM: Mitigation: VMX unsupported Vulnerability L1tf: Mitigation; PTE Inversion Vulnerability Mds: Mitigation; Clear CPU buffers; SMT vulnerable Vulnerability Meltdown: Mitigation; PTI Vulnerability Mmio stale data: Not affected Vulnerability Retbleed: Not affected Vulnerability Spec store bypass: Mitigation; Speculative Store Bypass disabled via prctl Vulnerability Spectre v1: Mitigation; usercopy/swapgs barriers and __user pointer sanitization Vulnerability Spectre v2: Mitigation; Retpolines, IBPB conditional, IBRS_FW, STIBP conditional, RSB filling, PBRSB-eIBRS Not affected Vulnerability Srbds: Not affected Vulnerability Tsx async abort: Not affected available filesystems: 9p autofs bdev btrfs cgroup cgroup2 configfs cpuset debugfs devpts devtmpfs ext3 ext4 f2fs fuse fuseblk fusectl hugetlbfs mqueue nfs nfs4 pipefs proc pstore ramfs rpc_pipefs securityfs sockfs sysfs tmpfs tracefs mounted filesystems (/proc/mounts): rootfs / rootfs rw 0 0 proc /proc proc rw,nosuid,nodev,noexec,relatime 0 0 sysfs /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 devtmpfs /dev devtmpfs rw,nosuid,size=4096k,nr_inodes=1048576,mode=755 0 0 securityfs /sys/kernel/security securityfs rw,nosuid,nodev,noexec,relatime 0 0 tmpfs /dev/shm tmpfs rw,nosuid,nodev 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 tmpfs /run tmpfs rw,nosuid,nodev,size=1328244k,nr_inodes=819200,mode=755 0 0 tmpfs /run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0 cgroup2 /sys/fs/cgroup cgroup2 rw,nosuid,nodev,noexec,relatime,nsdelegate,memory_recursiveprot 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 systemd-1 /proc/sys/fs/binfmt_misc autofs rw,relatime,fd=30,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=316 0 0 hugetlbfs /dev/hugepages hugetlbfs rw,relatime,pagesize=2M 0 0 mqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime 0 0 tracefs /sys/kernel/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 ramfs /run/credentials/systemd-sysusers.service ramfs ro,nosuid,nodev,noexec,relatime,mode=700 0 0 fusectl /sys/fs/fuse/connections fusectl rw,nosuid,nodev,noexec,relatime 0 0 sunrpc /run/rpc_pipefs rpc_pipefs rw,relatime 0 0 tmp /tmp tmpfs rw,relatime 0 0 /dev/sda1 /opt/rootfs btrfs rw,relatime,ssd,space_cache,subvolid=5,subvol=/ 0 0 /dev/sdb1 /fs/sdb1 f2fs rw,lazytime,relatime,background_gc=on,nodiscard,no_heap,user_xattr,inline_xattr,acl,inline_data,inline_dentry,flush_merge,extent_cache,mode=adaptive,active_logs=6,alloc_mode=default,checkpoint_merge,fsync_mode=posix,discard_unit=block,memory=normal 0 0 mounted filesystems (df): Filesystem Type Size Used Avail Use% Mounted on devtmpfs devtmpfs 4.0M 0 4.0M 0% /dev tmpfs tmpfs 3.2G 0 3.2G 0% /dev/shm tmpfs tmpfs 1.3G 616K 1.3G 1% /run tmpfs tmpfs 5.0M 0 5.0M 0% /run/lock tmp tmpfs 3.2G 352K 3.2G 1% /tmp /dev/sda1 btrfs 500G 19G 481G 4% /opt/rootfs /dev/sdb1 f2fs 200G 2.5G 198G 2% /fs/sdb1 AppArmor disabled SELinux mode: unknown no big block device was specified on commandline. Tests which require a big block device are disabled. You can specify it with option -z COMMAND: /lkp/benchmarks/ltp/bin/ltp-pan -e -S -a 3926 -n 3926 -p -f /fs/sdb1/tmpdir/ltp-998RhUqWjV/alltests -l /lkp/benchmarks/ltp/results/LTP_RUN_ON-2022_09_30-09h_43m_06s.log -C /lkp/benchmarks/ltp/output/LTP_RUN_ON-2022_09_30-09h_43m_06s.failed -T /lkp/benchmarks/ltp/output/LTP_RUN_ON-2022_09_30-09h_43m_06s.tconf LOG File: /lkp/benchmarks/ltp/results/LTP_RUN_ON-2022_09_30-09h_43m_06s.log FAILED COMMAND File: /lkp/benchmarks/ltp/output/LTP_RUN_ON-2022_09_30-09h_43m_06s.failed TCONF COMMAND File: /lkp/benchmarks/ltp/output/LTP_RUN_ON-2022_09_30-09h_43m_06s.tconf Running tests....... <<>> tag=dio02 stime=1664530986 cmdline="diotest2" contacts="" analysis=exit <<>> diotest02 1 TPASS : Read with Direct IO, Write without diotest02 2 TPASS : Write with Direct IO, Read without diotest02 3 TPASS : Read, Write with Direct IO diotest02 0 TINFO : 3 testblocks 100 iterations completed <<>> initiation_status="ok" duration=0 termination_type=exited termination_id=0 corefile=no cutime=1 cstime=3 <<>> <<>> tag=dio06 stime=1664530986 cmdline="diotest6" contacts="" analysis=exit <<>> diotest06 1 TPASS : Read with Direct IO, Write without diotest06 1 TPASS : Read with Direct IO, Write without diotest06 2 TPASS : Write with Direct IO, Read without diotest06 1 TPASS : Read with Direct IO, Write without diotest06 2 TPASS : Write with Direct IO, Read without diotest06 3 TPASS : Read, Write with Direct IO diotest06 0 TINFO : 3 testblocks 100 iterations with 1 children completed <<>> initiation_status="ok" duration=3 termination_type=exited termination_id=0 corefile=no cutime=15 cstime=9 <<>> <<>> tag=dio12 stime=1664530989 cmdline="diotest6 -b 65536" contacts="" analysis=exit <<>> IPMI BMC is not supported on this machine, skip bmc-watchdog setup! diotest06 1 TPASS : Read with Direct IO, Write without diotest06 1 TPASS : Read with Direct IO, Write without diotest06 2 TPASS : Write with Direct IO, Read without diotest06 1 TPASS : Read with Direct IO, Write without diotest06 2 TPASS : Write with Direct IO, Read without diotest06 3 TPASS : Read, Write with Direct IO diotest06 0 TINFO : 3 testblocks 100 iterations with 1 children completed <<>> initiation_status="ok" duration=9 termination_type=exited termination_id=0 corefile=no cutime=259 cstime=46 <<>> <<>> tag=dio14 stime=1664530998 cmdline="diotest2 -b 65536 -i 1000" contacts="" analysis=exit <<>> diotest02 1 TPASS : Read with Direct IO, Write without diotest02 2 TPASS : Write with Direct IO, Read without diotest02 3 TPASS : Read, Write with Direct IO diotest02 0 TINFO : 3 testblocks 1000 iterations completed <<>> initiation_status="ok" duration=4 termination_type=exited termination_id=0 corefile=no cutime=126 cstime=53 <<>> <<>> tag=dio16 stime=1664531002 cmdline="diotest5 -b 65536 -i 1000" contacts="" analysis=exit <<>> LTP: starting dio19 (diotest3 -b 65536 -i 1000 -o 1024000) diotest05 1 TPASS : Read with Direct IO, Write without diotest05 2 TPASS : Write with Direct IO, Read without diotest05 3 TPASS : Read, Write with Direct IO diotest05 0 TINFO : 3 testblocks 1000 iterations with 20 vector array completed <<>> initiation_status="ok" duration=85 termination_type=exited termination_id=0 corefile=no cutime=4847 cstime=417 <<>> <<>> tag=dio19 stime=1664531087 cmdline="diotest3 -b 65536 -i 1000 -o 1024000" contacts="" analysis=exit <<>> diotest03 1 TPASS : Read with Direct IO, Write without LTP: starting dio20 (diotest5 -b 65536 -i 1000 -o 1024000) diotest03 1 TPASS : Read with Direct IO, Write without diotest03 2 TPASS : Write with Direct IO, Read without diotest03 1 TPASS : Read with Direct IO, Write without diotest03 2 TPASS : Write with Direct IO, Read without diotest03 3 TPASS : Read, Write with Direct IO diotest03 0 TINFO : 3 testblocks 1000 iterations with 1 children completed <<>> initiation_status="ok" duration=18 termination_type=exited termination_id=0 corefile=no cutime=139 cstime=62 <<>> <<>> tag=dio20 stime=1664531105 cmdline="diotest5 -b 65536 -i 1000 -o 1024000" contacts="" analysis=exit <<>> LTP: starting dio22 (diotest2 -b 65536 -i 1000 -o 104857600) diotest05 1 TPASS : Read with Direct IO, Write without diotest05 2 TPASS : Write with Direct IO, Read without diotest05 3 TPASS : Read, Write with Direct IO diotest05 0 TINFO : 3 testblocks 1000 iterations with 20 vector array completed <<>> initiation_status="ok" duration=85 termination_type=exited termination_id=0 corefile=no cutime=4817 cstime=413 <<>> <<>> tag=dio22 stime=1664531190 cmdline="diotest2 -b 65536 -i 1000 -o 104857600" contacts="" analysis=exit <<>> LTP: starting dio29 (diotest3 -b 65536 -n 100 -i 100 -o 1024000) diotest02 1 TPASS : Read with Direct IO, Write without diotest02 2 TPASS : Write with Direct IO, Read without diotest02 3 TPASS : Read, Write with Direct IO diotest02 0 TINFO : 3 testblocks 1000 iterations completed <<>> initiation_status="ok" duration=4 termination_type=exited termination_id=0 corefile=no cutime=120 cstime=55 <<>> <<>> tag=dio29 stime=1664531194 cmdline="diotest3 -b 65536 -n 100 -i 100 -o 1024000" contacts="" analysis=exit <<>> watchdog: BUG: soft lockup - CPU#2 stuck for 26s! [diotest3:4818] Modules linked in: dm_mod f2fs crc32_generic netconsole btrfs blake2b_generic xor raid6_pq zstd_compress libcrc32c i915 sd_mod t10_pi crc64_rocksoft_generic crc64_rocksoft crc64 sg drm_buddy intel_rapl_msr intel_rapl_common intel_gtt x86_pkg_temp_thermal intel_powerclamp drm_display_helper ttm usb_storage coretemp crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel drm_kms_helper syscopyarea ahci rapl libahci sysfillrect intel_cstate intel_uncore sysimgblt ipmi_devintf mei_me libata mei fb_sys_fops ipmi_msghandler video drm fuse ip_tables CPU: 2 PID: 4818 Comm: diotest3 Not tainted 6.0.0-rc2-00011-g040b83fcecfb #1 Hardware name: Hewlett-Packard p6-1451cx/2ADA, BIOS 8.15 02/05/2013 RIP: 0010:__sbq_wake_up+0xe3/0x380 Code: 28 41 bd 08 00 00 00 48 ba 00 00 00 00 00 fc ff df 48 63 dd 48 c1 e3 06 48 01 cb 4c 8d 63 10 4c 89 e0 48 c1 e8 03 80 3c 10 00 <0f> 85 0f 02 00 00 48 8b 43 10 49 39 c4 75 21 83 c5 01 83 e5 07 41 RSP: 0018:ffffc90000220da8 EFLAGS: 00000246 RAX: 1ffff11043ebe112 RBX: ffff88821f5f0880 RCX: ffff88821f5f0800 RDX: dffffc0000000000 RSI: 0000000000000004 RDI: ffff888218207938 RBP: 0000000000000002 R08: 0000000000000000 R09: ffff888218207937 R10: ffffed1043040f26 R11: 0000000000000001 R12: ffff88821f5f0890 R13: 0000000000000008 R14: ffff888218207910 R15: ffff888218207934 FS: 00007f01ba9ee740(0000) GS:ffff888180700000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007feb7870f500 CR3: 0000000215fec006 CR4: 00000000001706e0 Call Trace: sbitmap_queue_clear+0xb2/0x240 __blk_mq_free_request+0x26e/0x340 ? blk_mq_free_request+0x237/0x480 scsi_end_request+0x2db/0x600 scsi_io_completion+0x126/0xb00 ? scsi_run_host_queues+0x80/0x80 ? scsi_device_unbusy+0x171/0x340 blk_complete_reqs+0xaa/0x100 __do_softirq+0x1a2/0x5fb __irq_exit_rcu+0x17a/0x200 common_interrupt+0x7d/0xc0 asm_common_interrupt+0x22/0x40 RIP: 0010:_raw_spin_unlock_irqrestore+0x1b/0x40 Code: cc cc cc cc cc cc cc cc cc cc cc cc cc cc cc 0f 1f 44 00 00 c6 07 00 0f 1f 00 f7 c6 00 02 00 00 74 01 fb 65 ff 0d a5 20 b6 7c cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 66 66 2e 0f 1f 84 RSP: 0018:ffffc90003d4f4e8 EFLAGS: 00000286 RAX: 0000000000000000 RBX: ffff88821f5f0888 RCX: ffffffff812572a5 RDX: 1ffff920007f9ec3 RSI: 0000000000000246 RDI: ffff88821f5f0888 RBP: 0000000000000000 R08: 0000000000000000 R09: ffff888180736800 R10: ffff888180737198 R11: 0000000000000001 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000003 R15: 0000000000000246 ? check_preempt_curr+0x165/0x280 __wake_up_common_lock+0xe3/0x140 ? __wake_up_common+0x600/0x600 ? attempt_merge+0xb17/0x17c0 __sbq_wake_up+0x1ef/0x380 sbitmap_queue_clear+0xb2/0x240 __blk_mq_free_request+0x26e/0x340 ? blk_mq_free_request+0x237/0x480 dd_bio_merge+0xf0/0x140 ? deadline_dispatch1_stop+0xc0/0xc0 ? recalibrate_cpu_khz+0x40/0x40 blk_mq_get_new_requests+0x1cd/0x540 ? blk_mq_alloc_request+0x200/0x200 ? iov_iter_get_pages2+0x68/0xc0 blk_mq_submit_bio+0x636/0x10c0 ? __bio_iov_iter_get_pages+0x52b/0x940 ? blk_mq_try_issue_list_directly+0x440/0x440 submit_bio_noacct_nocheck+0x2a2/0x3c0 ? should_fail_request+0x80/0x80 ? bio_set_pages_dirty+0x121/0x280 iomap_dio_bio_iter+0xb96/0x1580 __iomap_dio_rw+0x995/0x1480 ? schedule+0x14e/0x240 ? iomap_dio_bio_iter+0x1580/0x1580 ? schedule_timeout+0x1f8/0x2c0 ? rwsem_down_read_slowpath+0xcc0/0xcc0 ? f2fs_move_node_page+0x400/0x400 [f2fs] f2fs_dio_read_iter+0x1b3/0x480 [f2fs] f2fs_file_read_iter+0x29d/0x6c0 [f2fs] ? fsnotify_perm+0x13b/0x4c0 vfs_read+0x57f/0x840 ? kernel_read+0x140/0x140 ? __might_fault+0x4d/0x80 ? rseq_ip_fixup+0x28f/0x400 ? rseq_get_rseq_cs+0x600/0x600 ? __fget_light+0x51/0x240 ksys_read+0xed/0x1c0 ? __ia32_sys_pwrite64+0x200/0x200 ? f2fs_llseek+0x175/0x240 [f2fs] do_syscall_64+0x3b/0xc0 entry_SYSCALL_64_after_hwframe+0x63/0xcd RIP: 0033:0x7f01baaeb20e Code: c0 e9 b6 fe ff ff 50 48 8d 3d 0e 06 0c 00 e8 99 f7 01 00 66 0f 1f 84 00 00 00 00 00 64 8b 04 25 18 00 00 00 85 c0 75 14 0f 05 <48> 3d 00 f0 ff ff 77 5a c3 66 0f 1f 84 00 00 00 00 00 48 83 ec 28 RSP: 002b:00007fff4b657b38 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 000000000000002b RCX: 00007f01baaeb20e RDX: 0000000000010000 RSI: 000055a3c54fa000 RDI: 0000000000000005 RBP: 000055a3c54e9000 R08: 0000000000000001 R09: 000000000000005e R10: 00007f01ba9f75d8 R11: 0000000000000246 R12: 0000000000000004 R13: 000055a3c54fa000 R14: 0000000000000005 R15: 000000000043a000 Kernel panic - not syncing: softlockup: hung tasks CPU: 2 PID: 4818 Comm: diotest3 Tainted: G L 6.0.0-rc2-00011-g040b83fcecfb #1 Hardware name: Hewlett-Packard p6-1451cx/2ADA, BIOS 8.15 02/05/2013 Call Trace: dump_stack_lvl+0x34/0x48 panic+0x211/0x45d ? panic_print_sys_info+0x64/0x64 ? add_taint+0x26/0x80 watchdog_timer_fn.cold+0x11/0x1b ? lockup_detector_update_enable+0x80/0x80 __hrtimer_run_queues+0x2a9/0x600 ? enqueue_hrtimer+0x200/0x200 ? _raw_read_unlock_irqrestore+0x40/0x40 ? recalibrate_cpu_khz+0x40/0x40 ? ktime_get_update_offsets_now+0x74/0x2c0 hrtimer_interrupt+0x2c8/0x740 __sysvec_apic_timer_interrupt+0xcd/0x280 sysvec_apic_timer_interrupt+0x34/0xc0 asm_sysvec_apic_timer_interrupt+0x16/0x20 RIP: 0010:__sbq_wake_up+0xe3/0x380 Code: 28 41 bd 08 00 00 00 48 ba 00 00 00 00 00 fc ff df 48 63 dd 48 c1 e3 06 48 01 cb 4c 8d 63 10 4c 89 e0 48 c1 e8 03 80 3c 10 00 <0f> 85 0f 02 00 00 48 8b 43 10 49 39 c4 75 21 83 c5 01 83 e5 07 41 RSP: 0018:ffffc90000220da8 EFLAGS: 00000246 RAX: 1ffff11043ebe112 RBX: ffff88821f5f0880 RCX: ffff88821f5f0800 RDX: dffffc0000000000 RSI: 0000000000000004 RDI: ffff888218207938 RBP: 0000000000000002 R08: 0000000000000000 R09: ffff888218207937 R10: ffffed1043040f26 R11: 0000000000000001 R12: ffff88821f5f0890 R13: 0000000000000008 R14: ffff888218207910 R15: ffff888218207934 ? __sbq_wake_up+0x69/0x380 sbitmap_queue_clear+0xb2/0x240 __blk_mq_free_request+0x26e/0x340 ? blk_mq_free_request+0x237/0x480 scsi_end_request+0x2db/0x600 scsi_io_completion+0x126/0xb00 ? scsi_run_host_queues+0x80/0x80 ? scsi_device_unbusy+0x171/0x340 blk_complete_reqs+0xaa/0x100 __do_softirq+0x1a2/0x5fb __irq_exit_rcu+0x17a/0x200 common_interrupt+0x7d/0xc0 asm_common_interrupt+0x22/0x40 RIP: 0010:_raw_spin_unlock_irqrestore+0x1b/0x40 Code: cc cc cc cc cc cc cc cc cc cc cc cc cc cc cc 0f 1f 44 00 00 c6 07 00 0f 1f 00 f7 c6 00 02 00 00 74 01 fb 65 ff 0d a5 20 b6 7c cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 66 66 2e 0f 1f 84 RSP: 0018:ffffc90003d4f4e8 EFLAGS: 00000286 RAX: 0000000000000000 RBX: ffff88821f5f0888 RCX: ffffffff812572a5 RDX: 1ffff920007f9ec3 RSI: 0000000000000246 RDI: ffff88821f5f0888 RBP: 0000000000000000 R08: 0000000000000000 R09: ffff888180736800 R10: ffff888180737198 R11: 0000000000000001 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000003 R15: 0000000000000246 ? check_preempt_curr+0x165/0x280 __wake_up_common_lock+0xe3/0x140 ? __wake_up_common+0x600/0x600 ? attempt_merge+0xb17/0x17c0 __sbq_wake_up+0x1ef/0x380 sbitmap_queue_clear+0xb2/0x240 __blk_mq_free_request+0x26e/0x340 ? blk_mq_free_request+0x237/0x480 dd_bio_merge+0xf0/0x140 ? deadline_dispatch1_stop+0xc0/0xc0 ? recalibrate_cpu_khz+0x40/0x40 blk_mq_get_new_requests+0x1cd/0x540 ? blk_mq_alloc_request+0x200/0x200 ? iov_iter_get_pages2+0x68/0xc0 blk_mq_submit_bio+0x636/0x10c0 ? __bio_iov_iter_get_pages+0x52b/0x940 ? blk_mq_try_issue_list_directly+0x440/0x440 submit_bio_noacct_nocheck+0x2a2/0x3c0 ? should_fail_request+0x80/0x80 ? bio_set_pages_dirty+0x121/0x280 iomap_dio_bio_iter+0xb96/0x1580 __iomap_dio_rw+0x995/0x1480 ? schedule+0x14e/0x240 ? iomap_dio_bio_iter+0x1580/0x1580 ? schedule_timeout+0x1f8/0x2c0 ? rwsem_down_read_slowpath+0xcc0/0xcc0 ? f2fs_move_node_page+0x400/0x400 [f2fs] f2fs_dio_read_iter+0x1b3/0x480 [f2fs] f2fs_file_read_iter+0x29d/0x6c0 [f2fs] ? fsnotify_perm+0x13b/0x4c0 vfs_read+0x57f/0x840 ? kernel_read+0x140/0x140 ? __might_fault+0x4d/0x80 ? rseq_ip_fixup+0x28f/0x400 ? rseq_get_rseq_cs+0x600/0x600 ? __fget_light+0x51/0x240 ksys_read+0xed/0x1c0 ? __ia32_sys_pwrite64+0x200/0x200 ? f2fs_llseek+0x175/0x240 [f2fs] do_syscall_64+0x3b/0xc0 entry_SYSCALL_64_after_hwframe+0x63/0xcd RIP: 0033:0x7f01baaeb20e Code: c0 e9 b6 fe ff ff 50 48 8d 3d 0e 06 0c 00 e8 99 f7 01 00 66 0f 1f 84 00 00 00 00 00 64 8b 04 25 18 00 00 00 85 c0 75 14 0f 05 <48> 3d 00 f0 ff ff 77 5a c3 66 0f 1f 84 00 00 00 00 00 48 83 ec 28 RSP: 002b:00007fff4b657b38 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 000000000000002b RCX: 00007f01baaeb20e RDX: 0000000000010000 RSI: 000055a3c54fa000 RDI: 0000000000000005 RBP: 000055a3c54e9000 R08: 0000000000000001 R09: 000000000000005e R10: 00007f01ba9f75d8 R11: 0000000000000246 R12: 0000000000000004 R13: 000055a3c54fa000 R14: 0000000000000005 R15: 000000000043a000 Kernel Offset: disabled