Re: Bug 5.7-rc: root leak, eb leak

[Johannes Thumshirn <Johannes.Thumshirn@wdc.com>]

[-- Attachment #1: Type: text/plain, Size: 202 bytes --]

On 13/05/2020 01:04, David Sterba wrote:
[...]
> 
> Johannes, do you have logs from the test?



I recreated the logs for btrfs/028 (dmesg, kmemleak and fstests log). Please find them attached.

[-- Attachment #2: 028.dmesg --]
[-- Type: text/plain, Size: 55401 bytes --]

[    0.000000] Linux version 5.7.0-rc5+ (johannes@redsun60) (gcc version 9.2.1 20191209 [gcc-9-branch revision 279114] (SUSE Linux), GNU ld (GNU Binutils; openSUSE Tumbleweed) 2.33.1.20191023-2) #599 SMP Wed May 13 19:16:40 JST 2020
[    0.000000] Command line: rapido.vm_num=1 ip=none 			 rd.systemd.unit=emergency 		         rd.shell=1 console=ttyS0 rd.lvm=0 rd.luks=0 			 loglevel=9
[    0.000000] x86/fpu: x87 FPU will use FXSAVE
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdffff] usable
[    0.000000] BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000023fffffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.0-59-gc9ba527-rebuilt.opensuse.org 04/01/2014
[    0.000000] tsc: Fast TSC calibration using PIT
[    0.000000] tsc: Detected 2200.029 MHz processor
[    0.003025] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.003028] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.003036] last_pfn = 0x240000 max_arch_pfn = 0x400000000
[    0.003066] MTRR default type: write-back
[    0.003068] MTRR fixed ranges enabled:
[    0.003070]   00000-9FFFF write-back
[    0.003072]   A0000-BFFFF uncachable
[    0.003074]   C0000-FFFFF write-protect
[    0.003075] MTRR variable ranges enabled:
[    0.003078]   0 base 000C0000000 mask 3FFC0000000 uncachable
[    0.003079]   1 disabled
[    0.003081]   2 disabled
[    0.003082]   3 disabled
[    0.003083]   4 disabled
[    0.003084]   5 disabled
[    0.003085]   6 disabled
[    0.003087]   7 disabled
[    0.003096] x86/PAT: PAT not supported by the CPU.
[    0.003106] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
[    0.003108] last_pfn = 0xbffe0 max_arch_pfn = 0x400000000
[    0.013238] found SMP MP-table at [mem 0x000f5c80-0x000f5c8f]
[    0.013286] BRK [0x03801000, 0x03801fff] PGTABLE
[    0.013288] BRK [0x03802000, 0x03802fff] PGTABLE
[    0.013290] BRK [0x03803000, 0x03803fff] PGTABLE
[    0.013406] BRK [0x03804000, 0x03804fff] PGTABLE
[    0.014243] BRK [0x03805000, 0x03805fff] PGTABLE
[    0.014263] BRK [0x03806000, 0x03806fff] PGTABLE
[    0.014408] RAMDISK: [mem 0x7874c000-0x7fffffff]
[    0.014424] ACPI: Early table checksum verification disabled
[    0.014439] ACPI: RSDP 0x00000000000F5A40 000014 (v00 BOCHS )
[    0.014448] ACPI: RSDT 0x00000000BFFE15C9 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.014461] ACPI: FACP 0x00000000BFFE149D 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.014471] ACPI: DSDT 0x00000000BFFE0040 00145D (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.014477] ACPI: FACS 0x00000000BFFE0000 000040
[    0.014482] ACPI: APIC 0x00000000BFFE1511 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.014489] ACPI: HPET 0x00000000BFFE1591 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.014504] ACPI: Local APIC address 0xfee00000
[    0.014556] Zone ranges:
[    0.014558]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.014560]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.014562]   Normal   [mem 0x0000000100000000-0x000000023fffffff]
[    0.014564] Movable zone start for each node
[    0.014565] Early memory node ranges
[    0.014567]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.014572]   node   0: [mem 0x0000000000100000-0x00000000bffdffff]
[    0.014575]   node   0: [mem 0x0000000100000000-0x000000023fffffff]
[    0.015385] Zeroed struct page in unavailable ranges: 130 pages
[    0.015387] Initmem setup node 0 [mem 0x0000000000001000-0x000000023fffffff]
[    0.015390] On node 0 totalpages: 2097022
[    0.015394]   DMA zone: 64 pages used for memmap
[    0.015396]   DMA zone: 21 pages reserved
[    0.015398]   DMA zone: 3998 pages, LIFO batch:0
[    0.015630]   DMA32 zone: 12224 pages used for memmap
[    0.015632]   DMA32 zone: 782304 pages, LIFO batch:63
[    0.065708]   Normal zone: 20480 pages used for memmap
[    0.065713]   Normal zone: 1310720 pages, LIFO batch:63
[    0.417194] kasan: KernelAddressSanitizer initialized
[    0.417475] ACPI: PM-Timer IO Port: 0x608
[    0.417479] ACPI: Local APIC address 0xfee00000
[    0.417491] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.417532] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.417538] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.417540] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.417542] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.417550] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.417552] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.417555] ACPI: IRQ0 used by override.
[    0.417557] ACPI: IRQ5 used by override.
[    0.417558] ACPI: IRQ9 used by override.
[    0.417560] ACPI: IRQ10 used by override.
[    0.417561] ACPI: IRQ11 used by override.
[    0.417565] Using ACPI (MADT) for SMP configuration information
[    0.417568] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.417578] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[    0.417608] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[    0.417615] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.422546] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1
[    0.423166] percpu: Embedded 51 pages/cpu s171480 r8192 d29224 u1048576
[    0.423191] pcpu-alloc: s171480 r8192 d29224 u1048576 alloc=1*2097152
[    0.423193] pcpu-alloc: [0] 0 1 
[    0.423255] Built 1 zonelists, mobility grouping on.  Total pages: 2064233
[    0.423258] Kernel command line: rapido.vm_num=1 ip=none 			 rd.systemd.unit=emergency 		         rd.shell=1 console=ttyS0 rd.lvm=0 rd.luks=0 			 loglevel=9
[    0.425583] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.426679] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.426762] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.597569] Memory: 6959648K/8388088K available (12291K kernel code, 2631K rwdata, 3160K rodata, 1084K init, 15416K bss, 1428440K reserved, 0K cma-reserved)
[    0.598623] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.598712] Kernel/User page tables isolation: enabled
[    0.599500] rcu: Hierarchical RCU implementation.
[    0.599502] rcu: 	RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[    0.599506] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.599508] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.599557] NR_IRQS: 4352, nr_irqs: 56, preallocated irqs: 16
[    0.600206] random: get_random_bytes called from start_kernel+0x3c0/0x5b2 with crng_init=0
[    0.610266] Console: colour VGA+ 80x25
[    0.677556] printk: console [ttyS0] enabled
[    0.678044] ACPI: Core revision 20200326
[    0.679169] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.680218] APIC: Switch to symmetric I/O mode setup
[    0.682357] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.700205] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1fb64e4135c, max_idle_ns: 440795292232 ns
[    0.702602] Calibrating delay loop (skipped), value calculated using timer frequency.. 4400.05 BogoMIPS (lpj=8800116)
[    0.703647] pid_max: default: 32768 minimum: 301
[    0.707144] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.707946] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.711031] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.711591] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.712236] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.713101] Spectre V2 : Mitigation: Full generic retpoline
[    0.713668] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.714510] Speculative Store Bypass: Vulnerable
[    0.714598] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[    0.715597] Freeing SMP alternatives memory: 20K
[    0.824933] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    0.826588] Performance Events: PMU not available due to virtualization, using software events only.
[    0.835331] rcu: Hierarchical SRCU implementation.
[    0.841798] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.843067] smp: Bringing up secondary CPUs ...
[    0.844811] x86: Booting SMP configuration:
[    0.845288] .... node  #0, CPUs:      #1
[    0.082460] smpboot: CPU 1 Converting physical 0 to logical die 1
[    0.930693] smp: Brought up 1 node, 2 CPUs
[    0.931105] smpboot: Max logical packages: 2
[    0.931529] smpboot: Total of 2 processors activated (8800.08 BogoMIPS)
[    0.934116] devtmpfs: initialized
[    0.939908] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.940847] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[    0.942181] thermal_sys: Registered thermal governor 'step_wise'
[    0.943084] NET: Registered protocol family 16
[    0.947237] cpuidle: using governor ladder
[    0.947776] ACPI: bus type PCI registered
[    0.948198] PCI: Using configuration type 1 for base access
[    0.991085] ACPI: Added _OSI(Module Device)
[    0.991490] ACPI: Added _OSI(Processor Device)
[    0.991906] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.992352] ACPI: Added _OSI(Processor Aggregator Device)
[    0.992886] ACPI: Added _OSI(Linux-Dell-Video)
[    0.993328] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.993847] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    1.054669] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    1.068921] ACPI: Interpreter enabled
[    1.069374] ACPI: (supports S0 S5)
[    1.069727] ACPI: Using IOAPIC for interrupt routing
[    1.070490] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    1.075665] ACPI: Enabled 2 GPEs in block 00 to 0F
[    1.205983] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    1.206648] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments HPX-Type3]
[    1.208662] PCI host bridge to bus 0000:00
[    1.209115] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    1.209846] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    1.210612] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    1.211409] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[    1.212210] pci_bus 0000:00: root bus resource [mem 0x240000000-0x2bfffffff window]
[    1.213019] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.213870] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    1.219099] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    1.224273] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    1.226467] pci 0000:00:01.1: reg 0x20: [io  0xc040-0xc04f]
[    1.227372] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    1.228130] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    1.228822] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    1.229575] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    1.234806] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    1.235820] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    1.236583] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    1.241632] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    1.243100] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    1.245696] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    1.250179] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    1.255865] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200
[    1.257699] pci 0000:00:03.0: reg 0x10: [io  0xc000-0xc01f]
[    1.259134] pci 0000:00:03.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    1.263153] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[    1.269443] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00
[    1.270595] pci 0000:00:04.0: reg 0x10: [io  0xc020-0xc03f]
[    1.274093] pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
[    1.280734] pci_bus 0000:00: on NUMA node 0
[    1.294459] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    1.298012] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    1.301993] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    1.305991] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    1.307973] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    1.321220] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    1.321851] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    1.328725] pci 0000:00:02.0: vgaarb: bridge control possible
[    1.329322] vgaarb: loaded
[    1.332461] SCSI subsystem initialized
[    1.335472] PCI: Using ACPI for IRQ routing
[    1.335945] PCI: pci_cache_line_size set to 64 bytes
[    1.336550] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    1.337193] e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff]
[    1.352252] clocksource: Switched to clocksource tsc-early
[    1.354516] FS-Cache: Loaded
[    1.355102] pnp: PnP ACPI init
[    1.356209] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    1.357706] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    1.359154] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    1.360129] pnp 00:03: [dma 2]
[    1.360734] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    1.362737] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    1.364737] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    1.373485] pnp: PnP ACPI: found 6 devices
[    1.405228] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    1.406173] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    1.406815] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    1.407441] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    1.408109] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[    1.408814] pci_bus 0000:00: resource 8 [mem 0x240000000-0x2bfffffff window]
[    1.410929] NET: Registered protocol family 2
[    1.413083] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear)
[    1.414072] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    1.415316] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[    1.416861] TCP: Hash tables configured (established 65536 bind 65536)
[    1.417751] UDP hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    1.418562] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    1.419885] NET: Registered protocol family 1
[    1.420906] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    1.421516] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    1.422150] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    1.422824] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    1.423706] PCI: CLS 0 bytes, default 64
[    1.424712] Trying to unpack rootfs image as initramfs...
[    2.192302] Freeing initrd memory: 123600K
[    2.193149] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    2.193816] software IO TLB: mapped [mem 0xbbfe0000-0xbffe0000] (64MB)
[    2.197110] Initialise system trusted keyrings
[    2.198286] workingset: timestamp_bits=62 max_order=21 bucket_order=0
[    2.250032] SGI XFS with ACLs, security attributes, no debug enabled
[    2.263575] 9p: Installing v9fs 9p2000 file system support
[    2.264677] FS-Cache: Netfs '9p' registered for caching
[    2.268760] ceph: loaded (mds proto 32)
[    2.277100] Key type asymmetric registered
[    2.277552] Asymmetric key parser 'x509' registered
[    2.278199] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[    2.278964] io scheduler mq-deadline registered
[    2.280657] io scheduler bfq registered
[    2.285338] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    2.286140] ACPI: Power Button [PWRF]
[    2.286878] Warning: Processor Platform Limit event detected, but not handled.
[    2.287583] Consider compiling CPUfreq support into your kernel.
[    5.565706] PCI Interrupt Link [LNKC] enabled at IRQ 11
[    8.845953] PCI Interrupt Link [LNKD] enabled at IRQ 10
[    8.848450] tsc: Refined TSC clocksource calibration: 2200.024 MHz
[    8.849102] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1fb64996fe0, max_idle_ns: 440795277019 ns
[    8.850206] clocksource: Switched to clocksource tsc
[    8.850804] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    8.851797] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    8.859715] random: fast init done
[    8.860214] random: crng init done
[    8.907820] brd: module loaded
[    8.910454] rbd: loaded (major 253)
[    8.910937] Loading iSCSI transport class v2.0-870.
[    8.924742] iscsi: registered transport (tcp)
[    8.928843] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    8.929782] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    8.931703] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    8.934352] serio: i8042 KBD port at 0x60,0x64 irq 1
[    8.935175] serio: i8042 AUX port at 0x60,0x64 irq 12
[    8.939431] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised: dm-devel@redhat.com
[    8.946918] NET: Registered protocol family 10
[    8.952221] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    8.958247] Segment Routing with IPv6
[    8.958958] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    8.963019] NET: Registered protocol family 17
[    8.964432] 9pnet: Installing 9P2000 support
[    8.966187] Key type dns_resolver registered
[    8.966809] Key type ceph registered
[    8.969539] libceph: loaded (mon/osd proto 15/24)
[    8.970285] IPI shorthand broadcast: enabled
[    8.970942] sched_clock: Marking stable (8889931296, 78460886)->(8994523547, -26131365)
[    8.972589] Loading compiled-in X.509 certificates
[    8.974328] kmemleak: Kernel memory leak detector initialized (mem pool available: 14433)
[    8.981186] Freeing unused kernel image (initmem) memory: 1084K
[    8.982047] kmemleak: Automatic memory scanning thread started
[    9.438099] Write protecting the kernel read-only data: 18432k
[    9.444258] Freeing unused kernel image (text/rodata gap) memory: 2044K
[    9.446524] Freeing unused kernel image (rodata/data gap) memory: 936K
[    9.447452] rodata_test: all tests were successful
[    9.448118] Run /init as init process
[    9.448631]   with arguments:
[    9.449047]     /init
[    9.449367]   with environment:
[    9.449805]     HOME=/
[    9.450152]     TERM=linux
[    9.793324] dracut: dracut-049+git115.c2d8d6fb-1.1
[    9.856624] dracut: FATAL: No or empty root= argument
[    9.857387] dracut: Refusing to continue
[    9.867175] dracut Warning: 
[    9.883318] dracut Warning: dracut: FATAL: No or empty root= argument
[    9.884862] dracut Warning: dracut: Refusing to continue
[   10.348557] zram: Added device: zram0
[   10.352322] zram: Added device: zram1
[   10.357538] zram: Added device: zram2
[   10.363696] zram: Added device: zram3
[   10.367574] zram: Added device: zram4
[   10.370238] zram: Added device: zram5
[   10.419688] zram0: detected capacity change from 0 to 3221225472
[   10.429761] zram1: detected capacity change from 0 to 3221225472
[   10.439662] zram2: detected capacity change from 0 to 3221225472
[   10.449521] zram3: detected capacity change from 0 to 3221225472
[   10.458582] zram4: detected capacity change from 0 to 3221225472
[   10.467675] zram5: detected capacity change from 0 to 3221225472
[   10.590900] raid6: skip pq benchmark and using algorithm sse2x4
[   10.591525] raid6: using intx1 recovery algorithm
[   10.604946] xor: measuring software checksum speed
[   10.644353]    prefetch64-sse: 16683.000 MB/sec
[   10.684352]    generic_sse: 12352.000 MB/sec
[   10.684793] xor: using function: prefetch64-sse (16683.000 MB/sec)
[   10.762364] Btrfs loaded, crc32c=crc32c-generic, debug=on, assert=on, ref-verify=on
[   10.763542] BTRFS: selftest: sectorsize: 4096  nodesize: 4096
[   10.764125] BTRFS: selftest: running btrfs free space cache tests
[   10.765016] BTRFS: selftest: running extent only tests
[   10.765883] BTRFS: selftest: running bitmap only tests
[   10.766534] BTRFS: selftest: running bitmap and extent tests
[   10.767385] BTRFS: selftest: running space stealing from bitmap to extent tests
[   10.768729] BTRFS: selftest: running extent buffer operation tests
[   10.769360] BTRFS: selftest: running btrfs_split_item tests
[   10.770163] BTRFS: selftest: running extent I/O tests
[   10.770681] BTRFS: selftest: running find delalloc tests
[   10.943587] BTRFS: selftest: running find_first_clear_extent_bit test
[   10.944389] BTRFS: selftest: running extent buffer bitmap tests
[   11.011671] BTRFS: selftest: running inode tests
[   11.012110] BTRFS: selftest: running btrfs_get_extent tests
[   11.013735] BTRFS: selftest: running hole first btrfs_get_extent test
[   11.014670] BTRFS: selftest: running outstanding_extents tests
[   11.015952] BTRFS: selftest: running qgroup tests
[   11.016439] BTRFS: selftest: running qgroup add/remove tests
[   11.017837] BTRFS: selftest: running qgroup multiple refs test
[   11.019956] BTRFS: selftest: running free space tree tests
[   11.061631] BTRFS: selftest: sectorsize: 4096  nodesize: 8192
[   11.062233] BTRFS: selftest: running btrfs free space cache tests
[   11.062969] BTRFS: selftest: running extent only tests
[   11.063541] BTRFS: selftest: running bitmap only tests
[   11.064154] BTRFS: selftest: running bitmap and extent tests
[   11.065034] BTRFS: selftest: running space stealing from bitmap to extent tests
[   11.066413] BTRFS: selftest: running extent buffer operation tests
[   11.067055] BTRFS: selftest: running btrfs_split_item tests
[   11.067763] BTRFS: selftest: running extent I/O tests
[   11.068255] BTRFS: selftest: running find delalloc tests
[   11.238357] BTRFS: selftest: running find_first_clear_extent_bit test
[   11.239153] BTRFS: selftest: running extent buffer bitmap tests
[   11.305129] BTRFS: selftest: running inode tests
[   11.305614] BTRFS: selftest: running btrfs_get_extent tests
[   11.307322] BTRFS: selftest: running hole first btrfs_get_extent test
[   11.308185] BTRFS: selftest: running outstanding_extents tests
[   11.309381] BTRFS: selftest: running qgroup tests
[   11.309885] BTRFS: selftest: running qgroup add/remove tests
[   11.311240] BTRFS: selftest: running qgroup multiple refs test
[   11.313332] BTRFS: selftest: running free space tree tests
[   11.356765] BTRFS: selftest: sectorsize: 4096  nodesize: 16384
[   11.357393] BTRFS: selftest: running btrfs free space cache tests
[   11.358146] BTRFS: selftest: running extent only tests
[   11.358813] BTRFS: selftest: running bitmap only tests
[   11.360689] BTRFS: selftest: running bitmap and extent tests
[   11.363285] BTRFS: selftest: running space stealing from bitmap to extent tests
[   11.367156] BTRFS: selftest: running extent buffer operation tests
[   11.368886] BTRFS: selftest: running btrfs_split_item tests
[   11.370686] BTRFS: selftest: running extent I/O tests
[   11.371378] BTRFS: selftest: running find delalloc tests
[   11.584883] BTRFS: selftest: running find_first_clear_extent_bit test
[   11.585900] BTRFS: selftest: running extent buffer bitmap tests
[   11.664444] BTRFS: selftest: running inode tests
[   11.664922] BTRFS: selftest: running btrfs_get_extent tests
[   11.666539] BTRFS: selftest: running hole first btrfs_get_extent test
[   11.667436] BTRFS: selftest: running outstanding_extents tests
[   11.668712] BTRFS: selftest: running qgroup tests
[   11.669189] BTRFS: selftest: running qgroup add/remove tests
[   11.670556] BTRFS: selftest: running qgroup multiple refs test
[   11.672721] BTRFS: selftest: running free space tree tests
[   11.713644] BTRFS: selftest: sectorsize: 4096  nodesize: 32768
[   11.714260] BTRFS: selftest: running btrfs free space cache tests
[   11.714992] BTRFS: selftest: running extent only tests
[   11.715645] BTRFS: selftest: running bitmap only tests
[   11.716959] BTRFS: selftest: running bitmap and extent tests
[   11.718598] BTRFS: selftest: running space stealing from bitmap to extent tests
[   11.721218] BTRFS: selftest: running extent buffer operation tests
[   11.722408] BTRFS: selftest: running btrfs_split_item tests
[   11.723831] BTRFS: selftest: running extent I/O tests
[   11.724811] BTRFS: selftest: running find delalloc tests
[   11.886515] BTRFS: selftest: running find_first_clear_extent_bit test
[   11.887300] BTRFS: selftest: running extent buffer bitmap tests
[   11.955221] BTRFS: selftest: running inode tests
[   11.955696] BTRFS: selftest: running btrfs_get_extent tests
[   11.957294] BTRFS: selftest: running hole first btrfs_get_extent test
[   11.958234] BTRFS: selftest: running outstanding_extents tests
[   11.959409] BTRFS: selftest: running qgroup tests
[   11.959861] BTRFS: selftest: running qgroup add/remove tests
[   11.961207] BTRFS: selftest: running qgroup multiple refs test
[   11.963361] BTRFS: selftest: running free space tree tests
[   12.005711] BTRFS: selftest: sectorsize: 4096  nodesize: 65536
[   12.006321] BTRFS: selftest: running btrfs free space cache tests
[   12.007061] BTRFS: selftest: running extent only tests
[   12.007622] BTRFS: selftest: running bitmap only tests
[   12.008239] BTRFS: selftest: running bitmap and extent tests
[   12.009223] BTRFS: selftest: running space stealing from bitmap to extent tests
[   12.010592] BTRFS: selftest: running extent buffer operation tests
[   12.011223] BTRFS: selftest: running btrfs_split_item tests
[   12.011936] BTRFS: selftest: running extent I/O tests
[   12.012455] BTRFS: selftest: running find delalloc tests
[   12.175015] BTRFS: selftest: running find_first_clear_extent_bit test
[   12.175796] BTRFS: selftest: running extent buffer bitmap tests
[   12.243650] BTRFS: selftest: running inode tests
[   12.244125] BTRFS: selftest: running btrfs_get_extent tests
[   12.245730] BTRFS: selftest: running hole first btrfs_get_extent test
[   12.246655] BTRFS: selftest: running outstanding_extents tests
[   12.247804] BTRFS: selftest: running qgroup tests
[   12.248264] BTRFS: selftest: running qgroup add/remove tests
[   12.249640] BTRFS: selftest: running qgroup multiple refs test
[   12.251740] BTRFS: selftest: running free space tree tests
[   12.293852] BTRFS: selftest: running extent_map tests
[   12.294807] BTRFS: selftest: running rmap tests
[   12.327257] BTRFS: device fsid ee267483-a433-4b1b-b876-4b63dc196002 devid 1 transid 5 /dev/zram0 scanned by mkfs.btrfs (213)
[   12.347590] BTRFS info (device zram0): disk space caching is enabled
[   12.349138] BTRFS info (device zram0): has skinny extents
[   12.350292] BTRFS info (device zram0): flagging fs with big metadata feature
[   12.366656] BTRFS info (device zram0): enabling ssd optimizations
[   12.368934] BTRFS info (device zram0): checking UUID tree
[   91.856300] kmemleak: Automatic memory scanning thread ended
[  100.340620] BTRFS: device fsid facfaba2-1682-4b38-b1e2-7c2fdcfc0e37 devid 1 transid 5 /dev/zram1 scanned by mkfs.btrfs (435)
[  100.407707] BTRFS info (device zram1): disk space caching is enabled
[  100.409505] BTRFS info (device zram1): has skinny extents
[  100.410242] BTRFS info (device zram1): flagging fs with big metadata feature
[  100.431160] BTRFS info (device zram1): enabling ssd optimizations
[  100.434768] BTRFS info (device zram1): checking UUID tree
[  100.603013] BTRFS info (device zram0): disk space caching is enabled
[  100.603878] BTRFS info (device zram0): has skinny extents
[  100.625292] BTRFS info (device zram0): enabling ssd optimizations
[  100.732105] run fstests btrfs/028 at 2020-05-13 11:47:40
[  101.558205] BTRFS: device fsid 99328c0b-e5c6-4294-b029-52349bd82617 devid 1 transid 5 /dev/zram1 scanned by mkfs.btrfs (684)
[  101.614335] BTRFS info (device zram1): disk space caching is enabled
[  101.615018] BTRFS info (device zram1): has skinny extents
[  101.615575] BTRFS info (device zram1): flagging fs with big metadata feature
[  101.632747] BTRFS info (device zram1): enabling ssd optimizations
[  101.634937] BTRFS info (device zram1): checking UUID tree
[  101.655198] BTRFS info (device zram1): qgroup scan completed (inconsistency flag cleared)
[  101.669886] BTRFS info (device zram1): qgroup scan completed (inconsistency flag cleared)
[  101.691198] BTRFS info (device zram1): balance: start -d
[  101.693380] BTRFS info (device zram1): relocating block group 13631488 flags data
[  101.735597] BTRFS info (device zram1): balance: ended with status: 0
[  101.794444] BTRFS info (device zram1): balance: start -d
[  101.803402] BTRFS info (device zram1): relocating block group 22020096 flags data
[  101.926736] BTRFS info (device zram1): found 10 extents, stage: move data extents
[  102.012792] BTRFS info (device zram1): found 2 extents, stage: update data pointers
[  102.115506] BTRFS info (device zram1): balance: ended with status: 0
[  102.190146] BTRFS info (device zram1): balance: start -d
[  102.194042] BTRFS info (device zram1): relocating block group 357564416 flags data
[  102.289709] BTRFS info (device zram1): found 11 extents, stage: move data extents
[  102.354188] BTRFS info (device zram1): balance: ended with status: 0
[  102.416422] BTRFS info (device zram1): balance: start -d
[  102.421795] BTRFS info (device zram1): relocating block group 693108736 flags data
[  102.517431] BTRFS info (device zram1): found 10 extents, stage: move data extents
[  102.547929] BTRFS info (device zram1): found 1 extents, stage: update data pointers
[  102.583036] BTRFS info (device zram1): balance: ended with status: 0
[  102.616377] BTRFS info (device zram1): balance: start -d
[  102.621194] BTRFS info (device zram1): relocating block group 1028653056 flags data
[  102.702836] BTRFS info (device zram1): found 3 extents, stage: move data extents
[  102.771673] BTRFS info (device zram1): balance: ended with status: 0
[  102.818480] BTRFS info (device zram1): balance: start -d
[  102.822449] BTRFS info (device zram1): relocating block group 1364197376 flags data
[  102.861911] BTRFS info (device zram1): found 1 extents, stage: move data extents
[  102.893575] BTRFS info (device zram1): balance: ended with status: 0
[  102.923675] BTRFS info (device zram1): balance: start -d
[  102.929569] BTRFS info (device zram1): relocating block group 1699741696 flags data
[  102.954953] BTRFS info (device zram1): balance: ended with status: 0
[  103.025334] BTRFS info (device zram1): balance: start -d
[  103.037426] BTRFS info (device zram1): relocating block group 2035286016 flags data
[  103.122232] BTRFS info (device zram1): found 5 extents, stage: move data extents
[  103.226419] BTRFS info (device zram1): balance: ended with status: 0
[  103.279285] BTRFS info (device zram1): balance: start -d
[  103.281939] BTRFS info (device zram1): relocating block group 2370830336 flags data
[  103.357618] BTRFS info (device zram1): found 9 extents, stage: move data extents
[  103.398757] BTRFS info (device zram1): found 3 extents, stage: update data pointers
[  103.438958] BTRFS info (device zram1): balance: ended with status: 0
[  103.470934] BTRFS info (device zram1): balance: start -d
[  103.475474] BTRFS info (device zram1): relocating block group 2706374656 flags data
[  103.522741] BTRFS info (device zram1): found 1 extents, stage: move data extents
[  103.557964] BTRFS info (device zram1): balance: ended with status: 0
[  103.593913] BTRFS info (device zram1): balance: start -d
[  103.605763] BTRFS info (device zram1): relocating block group 3041918976 flags data
[  103.671578] BTRFS info (device zram1): found 7 extents, stage: move data extents
[  103.715241] BTRFS info (device zram1): balance: ended with status: 0
[  103.745683] BTRFS info (device zram1): balance: start -d
[  103.751039] BTRFS info (device zram1): relocating block group 3377463296 flags data
[  103.776387] BTRFS info (device zram1): balance: ended with status: 0
[  103.806670] BTRFS info (device zram1): balance: start -d
[  103.815855] BTRFS info (device zram1): relocating block group 3713007616 flags data
[  103.870624] BTRFS info (device zram1): found 3 extents, stage: move data extents
[  103.914588] BTRFS info (device zram1): balance: ended with status: 0
[  103.953775] BTRFS info (device zram1): balance: start -d
[  103.959377] BTRFS info (device zram1): relocating block group 4048551936 flags data
[  104.037340] BTRFS info (device zram1): found 5 extents, stage: move data extents
[  104.079935] BTRFS info (device zram1): found 2 extents, stage: update data pointers
[  104.112588] BTRFS info (device zram1): balance: ended with status: 0
[  104.148486] BTRFS info (device zram1): balance: start -d
[  104.151146] BTRFS info (device zram1): relocating block group 4384096256 flags data
[  104.370288] BTRFS info (device zram1): found 21 extents, stage: move data extents
[  104.412890] BTRFS info (device zram1): balance: ended with status: 0
[  104.446927] BTRFS info (device zram1): balance: start -d
[  104.453099] BTRFS info (device zram1): relocating block group 4719640576 flags data
[  104.585025] BTRFS info (device zram1): found 6 extents, stage: move data extents
[  104.684846] BTRFS info (device zram1): balance: ended with status: 0
[  104.756936] BTRFS info (device zram1): balance: start -d
[  104.773942] BTRFS info (device zram1): relocating block group 5055184896 flags data
[  104.950791] BTRFS info (device zram1): found 14 extents, stage: move data extents
[  105.090886] BTRFS info (device zram1): found 3 extents, stage: update data pointers
[  105.207900] BTRFS info (device zram1): balance: ended with status: 0
[  105.250306] BTRFS info (device zram1): balance: start -d
[  105.253014] BTRFS info (device zram1): relocating block group 5390729216 flags data
[  105.322589] BTRFS info (device zram1): found 6 extents, stage: move data extents
[  105.372642] BTRFS info (device zram1): found 1 extents, stage: update data pointers
[  105.414903] BTRFS info (device zram1): balance: ended with status: 0
[  105.446151] BTRFS info (device zram1): balance: start -d
[  105.451814] BTRFS info (device zram1): relocating block group 5726273536 flags data
[  105.614075] BTRFS info (device zram1): found 14 extents, stage: move data extents
[  105.666515] BTRFS info (device zram1): found 2 extents, stage: update data pointers
[  105.708743] BTRFS info (device zram1): balance: ended with status: 0
[  105.749616] BTRFS info (device zram1): balance: start -d
[  105.754530] BTRFS info (device zram1): relocating block group 6061817856 flags data
[  105.814052] BTRFS info (device zram1): found 6 extents, stage: move data extents
[  105.867463] BTRFS info (device zram1): found 3 extents, stage: update data pointers
[  105.970152] BTRFS info (device zram1): balance: ended with status: 0
[  106.037924] BTRFS info (device zram1): balance: start -d
[  106.049718] BTRFS info (device zram1): relocating block group 6397362176 flags data
[  106.131016] BTRFS info (device zram1): found 5 extents, stage: move data extents
[  106.182276] BTRFS info (device zram1): balance: ended with status: 0
[  106.221259] BTRFS info (device zram1): balance: start -d
[  106.225156] BTRFS info (device zram1): relocating block group 6732906496 flags data
[  106.300434] BTRFS info (device zram1): found 2 extents, stage: move data extents
[  106.396793] BTRFS info (device zram1): balance: ended with status: 0
[  106.431796] BTRFS info (device zram1): balance: start -d
[  106.444708] BTRFS info (device zram1): relocating block group 7068450816 flags data
[  106.476413] BTRFS info (device zram1): found 1 extents, stage: move data extents
[  106.504342] BTRFS info (device zram1): balance: ended with status: 0
[  106.530801] BTRFS info (device zram1): balance: start -d
[  106.542725] BTRFS info (device zram1): relocating block group 7403995136 flags data
[  106.609953] BTRFS info (device zram1): balance: ended with status: 0
[  106.675311] BTRFS info (device zram1): balance: start -d
[  106.687304] BTRFS info (device zram1): relocating block group 7739539456 flags data
[  106.807621] BTRFS info (device zram1): found 11 extents, stage: move data extents
[  106.899079] BTRFS info (device zram1): balance: ended with status: 0
[  106.954156] BTRFS info (device zram1): balance: start -d
[  106.958271] BTRFS info (device zram1): relocating block group 8075083776 flags data
[  107.040905] BTRFS info (device zram1): found 14 extents, stage: move data extents
[  107.102913] BTRFS info (device zram1): found 12 extents, stage: update data pointers
[  107.150381] BTRFS info (device zram1): balance: ended with status: 0
[  107.185289] BTRFS info (device zram1): balance: start -d
[  107.203224] BTRFS info (device zram1): relocating block group 8410628096 flags data
[  107.341105] BTRFS info (device zram1): found 22 extents, stage: move data extents
[  107.457973] BTRFS info (device zram1): found 12 extents, stage: update data pointers
[  107.552365] BTRFS info (device zram1): balance: ended with status: 0
[  107.650969] BTRFS info (device zram1): balance: start -d
[  107.659650] BTRFS info (device zram1): relocating block group 8746172416 flags data
[  107.865106] BTRFS info (device zram1): found 19 extents, stage: move data extents
[  107.964861] BTRFS info (device zram1): found 4 extents, stage: update data pointers
[  108.058675] BTRFS info (device zram1): balance: ended with status: 0
[  108.093332] BTRFS info (device zram1): balance: start -d
[  108.098199] BTRFS info (device zram1): relocating block group 9081716736 flags data
[  108.194178] BTRFS info (device zram1): found 17 extents, stage: move data extents
[  108.314179] BTRFS info (device zram1): found 11 extents, stage: update data pointers
[  108.407668] BTRFS info (device zram1): balance: ended with status: 0
[  108.462258] BTRFS info (device zram1): balance: start -d
[  108.464899] BTRFS info (device zram1): relocating block group 9417261056 flags data
[  108.624913] BTRFS info (device zram1): found 23 extents, stage: move data extents
[  108.694130] BTRFS info (device zram1): found 14 extents, stage: update data pointers
[  108.736944] BTRFS info (device zram1): balance: ended with status: 0
[  108.765029] BTRFS info (device zram1): balance: start -d
[  108.770189] BTRFS info (device zram1): relocating block group 9752805376 flags data
[  108.932352] BTRFS info (device zram1): found 28 extents, stage: move data extents
[  108.981375] BTRFS info (device zram1): found 2 extents, stage: update data pointers
[  109.016169] BTRFS info (device zram1): balance: ended with status: 0
[  109.062165] BTRFS info (device zram1): balance: start -d
[  109.068630] BTRFS info (device zram1): relocating block group 10088349696 flags data
[  109.231787] BTRFS info (device zram1): found 12 extents, stage: move data extents
[  109.381323] BTRFS info (device zram1): found 4 extents, stage: update data pointers
[  109.485989] BTRFS info (device zram1): balance: ended with status: 0
[  109.538976] BTRFS info (device zram1): balance: start -d
[  109.542823] BTRFS info (device zram1): relocating block group 10423894016 flags data
[  109.709069] BTRFS info (device zram1): found 23 extents, stage: move data extents
[  109.844119] BTRFS info (device zram1): found 16 extents, stage: update data pointers
[  109.946432] BTRFS info (device zram1): balance: ended with status: 0
[  110.005083] BTRFS info (device zram1): balance: start -d
[  110.009205] BTRFS info (device zram1): relocating block group 10759438336 flags data
[  110.211262] BTRFS info (device zram1): found 21 extents, stage: move data extents
[  110.311553] BTRFS info (device zram1): found 7 extents, stage: update data pointers
[  110.397339] BTRFS info (device zram1): balance: ended with status: 0
[  110.449486] BTRFS info (device zram1): balance: start -d
[  110.463676] BTRFS info (device zram1): relocating block group 11094982656 flags data
[  110.602316] BTRFS info (device zram1): found 16 extents, stage: move data extents
[  110.727579] BTRFS info (device zram1): found 10 extents, stage: update data pointers
[  110.857247] BTRFS info (device zram1): balance: ended with status: 0
[  110.917966] BTRFS info (device zram1): balance: start -d
[  110.923576] BTRFS info (device zram1): relocating block group 11430526976 flags data
[  111.174154] BTRFS info (device zram1): found 37 extents, stage: move data extents
[  111.326162] BTRFS info (device zram1): found 21 extents, stage: update data pointers
[  111.480798] BTRFS info (device zram1): balance: ended with status: 0
[  111.536928] BTRFS info (device zram1): balance: start -d
[  111.541594] BTRFS info (device zram1): relocating block group 11766071296 flags data
[  111.827456] BTRFS info (device zram1): found 36 extents, stage: move data extents
[  112.049714] BTRFS info (device zram1): found 29 extents, stage: update data pointers
[  112.198988] BTRFS info (device zram1): balance: ended with status: 0
[  112.261825] BTRFS info (device zram1): balance: start -d
[  112.267170] BTRFS info (device zram1): relocating block group 12101615616 flags data
[  112.563540] BTRFS info (device zram1): found 39 extents, stage: move data extents
[  112.753981] BTRFS info (device zram1): found 15 extents, stage: update data pointers
[  112.902709] BTRFS info (device zram1): balance: ended with status: 0
[  112.965764] BTRFS info (device zram1): balance: start -d
[  112.969805] BTRFS info (device zram1): relocating block group 12437159936 flags data
[  113.268425] BTRFS info (device zram1): found 44 extents, stage: move data extents
[  113.571189] BTRFS info (device zram1): found 39 extents, stage: update data pointers
[  113.841803] BTRFS info (device zram1): balance: ended with status: 0
[  113.901172] BTRFS info (device zram1): balance: start -d
[  113.906105] BTRFS info (device zram1): relocating block group 12772704256 flags data
[  114.228217] BTRFS info (device zram1): found 56 extents, stage: move data extents
[  114.441556] BTRFS info (device zram1): found 42 extents, stage: update data pointers
[  114.589625] BTRFS info (device zram1): balance: ended with status: 0
[  114.656714] BTRFS info (device zram1): balance: start -d
[  114.663372] BTRFS info (device zram1): relocating block group 13108248576 flags data
[  115.091216] BTRFS info (device zram1): found 49 extents, stage: move data extents
[  115.328552] BTRFS info (device zram1): found 6 extents, stage: update data pointers
[  115.483049] BTRFS info (device zram1): balance: ended with status: 0
[  115.575523] BTRFS info (device zram1): balance: start -d
[  115.579596] BTRFS info (device zram1): relocating block group 13443792896 flags data
[  115.843025] BTRFS info (device zram1): found 41 extents, stage: move data extents
[  115.995682] BTRFS info (device zram1): found 22 extents, stage: update data pointers
[  116.114182] BTRFS info (device zram1): balance: ended with status: 0
[  116.208764] BTRFS info (device zram1): balance: start -d
[  116.224506] BTRFS info (device zram1): relocating block group 13779337216 flags data
[  116.571208] BTRFS info (device zram1): found 43 extents, stage: move data extents
[  116.807278] BTRFS info (device zram1): found 9 extents, stage: update data pointers
[  116.986508] BTRFS info (device zram1): balance: ended with status: 0
[  117.095661] BTRFS info (device zram1): balance: start -d
[  117.115637] BTRFS info (device zram1): relocating block group 14114881536 flags data
[  117.384672] BTRFS info (device zram1): found 51 extents, stage: move data extents
[  117.641877] BTRFS info (device zram1): found 38 extents, stage: update data pointers
[  117.801795] BTRFS info (device zram1): found 1 extents, stage: update data pointers
[  117.931877] BTRFS info (device zram1): balance: ended with status: 0
[  118.004841] BTRFS info (device zram1): balance: start -d
[  118.011516] BTRFS info (device zram1): relocating block group 14450425856 flags data
[  118.278850] BTRFS info (device zram1): found 25 extents, stage: move data extents
[  118.357162] BTRFS info (device zram1): found 3 extents, stage: update data pointers
[  118.430276] BTRFS info (device zram1): balance: ended with status: 0
[  118.473592] BTRFS info (device zram1): balance: start -d
[  118.484678] BTRFS info (device zram1): relocating block group 14785970176 flags data
[  118.597953] BTRFS info (device zram1): found 13 extents, stage: move data extents
[  118.728094] BTRFS info (device zram1): found 9 extents, stage: update data pointers
[  118.851539] BTRFS info (device zram1): balance: ended with status: 0
[  118.890532] BTRFS info (device zram1): balance: start -d
[  118.895567] BTRFS info (device zram1): relocating block group 15121514496 flags data
[  119.028695] BTRFS info (device zram1): found 20 extents, stage: move data extents
[  119.141682] BTRFS info (device zram1): found 12 extents, stage: update data pointers
[  119.271458] BTRFS info (device zram1): balance: ended with status: 0
[  119.327474] BTRFS info (device zram1): balance: start -d
[  119.332754] BTRFS info (device zram1): relocating block group 15457058816 flags data
[  119.581570] BTRFS info (device zram1): found 24 extents, stage: move data extents
[  119.816340] BTRFS info (device zram1): found 18 extents, stage: update data pointers
[  119.932668] BTRFS info (device zram1): balance: ended with status: 0
[  120.017701] BTRFS info (device zram1): balance: start -d
[  120.029622] BTRFS info (device zram1): relocating block group 15792603136 flags data
[  120.286311] BTRFS info (device zram1): found 33 extents, stage: move data extents
[  120.444792] BTRFS info (device zram1): found 23 extents, stage: update data pointers
[  120.508598] BTRFS info (device zram1): balance: ended with status: 0
[  120.555342] BTRFS info (device zram1): balance: start -d
[  120.559267] BTRFS info (device zram1): relocating block group 16128147456 flags data
[  120.809781] BTRFS info (device zram1): found 40 extents, stage: move data extents
[  120.959677] BTRFS info (device zram1): found 23 extents, stage: update data pointers
[  121.097418] BTRFS info (device zram1): balance: ended with status: 0
[  121.161688] BTRFS info (device zram1): balance: start -d
[  121.166957] BTRFS info (device zram1): relocating block group 16463691776 flags data
[  121.339976] BTRFS info (device zram1): found 20 extents, stage: move data extents
[  121.513268] BTRFS info (device zram1): found 15 extents, stage: update data pointers
[  121.653531] BTRFS info (device zram1): balance: ended with status: 0
[  121.732587] BTRFS info (device zram1): balance: start -d
[  121.736477] BTRFS info (device zram1): relocating block group 16799236096 flags data
[  122.049906] BTRFS info (device zram1): found 34 extents, stage: move data extents
[  122.247059] BTRFS info (device zram1): found 11 extents, stage: update data pointers
[  122.411034] BTRFS info (device zram1): balance: ended with status: 0
[  122.468237] BTRFS info (device zram1): balance: start -d
[  122.473058] BTRFS info (device zram1): relocating block group 17134780416 flags data
[  122.627619] BTRFS info (device zram1): found 21 extents, stage: move data extents
[  122.749555] BTRFS info (device zram1): found 20 extents, stage: update data pointers
[  122.848919] BTRFS info (device zram1): balance: ended with status: 0
[  122.893378] BTRFS info (device zram1): balance: start -d
[  122.897941] BTRFS info (device zram1): relocating block group 17470324736 flags data
[  123.111299] BTRFS info (device zram1): found 26 extents, stage: move data extents
[  123.261099] BTRFS info (device zram1): found 7 extents, stage: update data pointers
[  123.362856] BTRFS info (device zram1): balance: ended with status: 0
[  123.410215] BTRFS info (device zram1): balance: start -d
[  123.421133] BTRFS info (device zram1): relocating block group 17805869056 flags data
[  123.608956] BTRFS info (device zram1): found 24 extents, stage: move data extents
[  123.732247] BTRFS info (device zram1): found 12 extents, stage: update data pointers
[  123.831218] BTRFS info (device zram1): balance: ended with status: 0
[  123.907535] BTRFS info (device zram1): balance: start -d
[  123.914332] BTRFS info (device zram1): relocating block group 18141413376 flags data
[  124.132307] BTRFS info (device zram1): found 23 extents, stage: move data extents
[  124.249633] BTRFS info (device zram1): found 5 extents, stage: update data pointers
[  124.351459] BTRFS info (device zram1): balance: ended with status: 0
[  124.399812] BTRFS info (device zram1): balance: start -d
[  124.402535] BTRFS info (device zram1): relocating block group 18476957696 flags data
[  124.659231] BTRFS info (device zram1): found 26 extents, stage: move data extents
[  124.840265] BTRFS info (device zram1): found 17 extents, stage: update data pointers
[  125.005601] BTRFS info (device zram1): balance: ended with status: 0
[  125.112638] BTRFS info (device zram1): balance: start -d
[  125.116227] BTRFS info (device zram1): relocating block group 18812502016 flags data
[  125.403383] BTRFS info (device zram1): found 46 extents, stage: move data extents
[  125.512397] BTRFS info (device zram1): found 3 extents, stage: update data pointers
[  125.604700] BTRFS info (device zram1): balance: ended with status: 0
[  125.642788] BTRFS info (device zram1): balance: start -d
[  125.649286] BTRFS info (device zram1): relocating block group 19148046336 flags data
[  125.849670] BTRFS info (device zram1): found 29 extents, stage: move data extents
[  126.045467] BTRFS info (device zram1): found 15 extents, stage: update data pointers
[  126.182621] BTRFS info (device zram1): balance: ended with status: 0
[  126.267549] BTRFS info (device zram1): balance: start -d
[  126.280835] BTRFS info (device zram1): relocating block group 19483590656 flags data
[  126.566546] BTRFS info (device zram1): found 29 extents, stage: move data extents
[  126.708179] BTRFS info (device zram1): found 8 extents, stage: update data pointers
[  126.878932] BTRFS info (device zram1): balance: ended with status: 0
[  126.979435] BTRFS info (device zram1): balance: start -d
[  126.984788] BTRFS info (device zram1): relocating block group 19819134976 flags data
[  127.319787] BTRFS info (device zram1): found 49 extents, stage: move data extents
[  127.516268] BTRFS info (device zram1): found 21 extents, stage: update data pointers
[  127.667637] BTRFS info (device zram1): balance: ended with status: 0
[  127.725129] BTRFS info (device zram1): balance: start -d
[  127.730342] BTRFS info (device zram1): relocating block group 20154679296 flags data
[  127.964326] BTRFS info (device zram1): found 36 extents, stage: move data extents
[  128.112685] BTRFS info (device zram1): found 18 extents, stage: update data pointers
[  128.261205] BTRFS info (device zram1): balance: ended with status: 0
[  128.352856] BTRFS info (device zram1): balance: start -d
[  128.356841] BTRFS info (device zram1): relocating block group 20490223616 flags data
[  128.578815] BTRFS info (device zram1): found 28 extents, stage: move data extents
[  128.727703] BTRFS info (device zram1): found 16 extents, stage: update data pointers
[  128.873412] BTRFS info (device zram1): balance: ended with status: 0
[  128.915392] BTRFS info (device zram1): balance: start -d
[  128.921869] BTRFS info (device zram1): relocating block group 20825767936 flags data
[  129.042418] BTRFS info (device zram1): found 21 extents, stage: move data extents
[  129.147856] BTRFS info (device zram1): found 14 extents, stage: update data pointers
[  129.240346] BTRFS info (device zram1): balance: ended with status: 0
[  129.320126] BTRFS info (device zram1): balance: start -d
[  129.324849] BTRFS info (device zram1): relocating block group 21161312256 flags data
[  129.575682] BTRFS info (device zram1): found 23 extents, stage: move data extents
[  129.732482] BTRFS info (device zram1): found 19 extents, stage: update data pointers
[  129.867402] BTRFS info (device zram1): balance: ended with status: 0
[  129.957238] BTRFS info (device zram1): balance: start -d
[  129.976981] BTRFS info (device zram1): relocating block group 21496856576 flags data
[  130.258870] BTRFS info (device zram1): found 47 extents, stage: move data extents
[  130.519069] BTRFS info (device zram1): found 39 extents, stage: update data pointers
[  130.691861] BTRFS info (device zram1): balance: ended with status: 0
[  130.781972] BTRFS info (device zram1): balance: start -d
[  130.788070] BTRFS info (device zram1): relocating block group 21832400896 flags data
[  131.170865] BTRFS info (device zram1): found 47 extents, stage: move data extents
[  131.403068] BTRFS info (device zram1): found 9 extents, stage: update data pointers
[  131.540487] BTRFS info (device zram1): balance: ended with status: 0
[  131.634335] BTRFS info (device zram1): balance: start -d
[  131.639344] BTRFS info (device zram1): relocating block group 22167945216 flags data
[  131.836136] BTRFS info (device zram1): balance: canceled
[  132.005718] BTRFS warning (device zram1): page private not zero on page 7110656
[  132.007230] BTRFS warning (device zram1): page private not zero on page 7114752
[  132.008496] BTRFS warning (device zram1): page private not zero on page 7118848
[  132.010104] BTRFS warning (device zram1): page private not zero on page 7122944
[  132.011258] BTRFS warning (device zram1): page private not zero on page 7176192
[  132.012410] BTRFS warning (device zram1): page private not zero on page 7180288
[  132.013555] BTRFS warning (device zram1): page private not zero on page 7184384
[  132.014701] BTRFS warning (device zram1): page private not zero on page 7188480
[  132.017214] BTRFS error (device zram1): leaked root 18446744073709551608-5 refcount 1
[  132.018063] BTRFS error (device zram1): leaked root 18446744073709551608-18446744073709551607 refcount 1
[  132.019058] BTRFS: buffer leak start 7176192 len 16384 refs 1 bflags 529 owner 18446744073709551607
[  132.019991] BTRFS: buffer leak start 7110656 len 16384 refs 1 bflags 529 owner 5
[  140.112118] kmemleak: 2 new suspected memory leaks (see /sys/kernel/debug/kmemleak)

[-- Attachment #3: 028.full --]
[-- Type: text/plain, Size: 356 bytes --]

# /home/johannes/src/btrfs-progs/btrfs quota enable /mnt/scratch
# /home/johannes/src/btrfs-progs/btrfs quota rescan -w /mnt/scratch
quota rescan started
Run fsstress  -z -f write=10 -f unlink=10 -f creat=10 -f fsync=10 -f fsync=10 -n 100000 -p 2 -d /mnt/scratch/stress_dir
Start balance
# /home/johannes/src/btrfs-progs/btrfs filesystem sync /mnt/scratch

[-- Attachment #4: 028.kmemleak --]
[-- Type: text/plain, Size: 2582 bytes --]

EXPERIMENTAL kmemleak reported some memory leaks!  Due to the way kmemleak
works, the leak might be from an earlier test, or something totally unrelated.
unreferenced object 0xffff8881f646e940 (size 576):
  comm "mount", pid 695, jiffies 4294917533 (age 38.508s)
  hex dump (first 32 bytes):
    06 00 01 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
    68 2a 19 e0 81 88 ff ff 58 e9 46 f6 81 88 ff ff  h*......X.F.....
  backtrace:
    [<00000000dff11222>] radix_tree_node_alloc.constprop.0+0xd7/0x160
    [<000000000d1e18ac>] radix_tree_insert+0x117/0x2c0
    [<00000000d19a3dbb>] alloc_extent_buffer+0x56a/0x6d0 [btrfs]
    [<0000000018b71b0f>] read_tree_block+0x15/0x60 [btrfs]
    [<0000000010a55e05>] open_ctree+0x137c/0x277a [btrfs]
    [<0000000036160822>] btrfs_mount_root.cold+0x12/0xec [btrfs]
    [<00000000388e9139>] legacy_get_tree+0x6b/0xa0
    [<00000000e21e39e7>] vfs_get_tree+0x42/0xf0
    [<000000002689bf53>] fc_mount+0xa/0x40
    [<000000002a92a0e8>] vfs_kern_mount.part.0+0x6c/0x80
    [<0000000069d5b91e>] btrfs_mount+0x1ba/0x5d0 [btrfs]
    [<00000000388e9139>] legacy_get_tree+0x6b/0xa0
    [<00000000e21e39e7>] vfs_get_tree+0x42/0xf0
    [<0000000041afc687>] do_mount+0xa90/0xe00
    [<00000000e2f69bd0>] __x64_sys_mount+0xb9/0xf0
    [<00000000667f0b0a>] do_syscall_64+0x5e/0x1c0
unreferenced object 0xffff8881cad8ec00 (size 576):
  comm "fsstress", pid 723, jiffies 4294921132 (age 24.112s)
  hex dump (first 32 bytes):
    00 1b 02 00 00 00 00 00 40 e9 46 f6 81 88 ff ff  ........@.F.....
    68 2a 19 e0 81 88 ff ff 18 ec d8 ca 81 88 ff ff  h*..............
  backtrace:
    [<00000000dff11222>] radix_tree_node_alloc.constprop.0+0xd7/0x160
    [<000000000d1e18ac>] radix_tree_insert+0x117/0x2c0
    [<00000000d19a3dbb>] alloc_extent_buffer+0x56a/0x6d0 [btrfs]
    [<00000000e36da7fe>] btrfs_init_new_buffer+0x3e/0x3b0 [btrfs]
    [<00000000a40b3d56>] btrfs_alloc_tree_block+0x1f7/0x4b0 [btrfs]
    [<00000000d37cefa6>] alloc_tree_block_no_bg_flush+0xba/0xe0 [btrfs]
    [<0000000049aac05e>] __btrfs_cow_block+0x22f/0x840 [btrfs]
    [<000000004b88f003>] btrfs_cow_block+0x1f1/0x290 [btrfs]
    [<000000008f1ed34a>] btrfs_search_slot+0x878/0xef0 [btrfs]
    [<0000000066c12130>] btrfs_insert_empty_items+0x77/0xd0 [btrfs]
    [<0000000002f3d164>] btrfs_new_inode+0x52c/0x9c0 [btrfs]
    [<00000000741f8f60>] btrfs_create+0x171/0x310 [btrfs]
    [<00000000ed9bffe6>] path_openat+0x840/0x1510
    [<000000002e5e9c08>] do_filp_open+0x10c/0x180
    [<0000000035e673af>] do_sys_openat2+0x28f/0x370
    [<000000007e6b0b42>] do_sys_open+0x75/0xb0