Copyright (c) 2003-2026 The DragonFly Project. Copyright (c) 1992-2003 The FreeBSD Project. Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 The Regents of the University of California. All rights reserved. DragonFly 6.5-DEVELOPMENT #0: Thu Jul 2 06:02:54 UTC 2026 root@dfbsd:/usr/obj/usr/src/sys/X86_64_GENERIC acpi_hpet: frequency 100000000 Using cputimer HPET for TSC calibration Timer latency (in TSC ticks): 32225 min=31934 max=32524 TSC clock: 3600007430 Hz, NOT invariant CPU: QEMU Virtual CPU version 2.5+ (3600.01-MHz K8-class CPU) Origin="GenuineIntel" Id=0x60fb1 Family=0xf Model=0x6b Stepping=1 Features=0x1783fbfd Features2=0x80202001 AMD Features=0x20100800 AMD Features2=0x1 MONITOR/MWAIT Features=0x2 VMM/Hypervisor: Origin="KVMKVMKVM" real memory = 4293381120 (4094 MB) avail memory = 4088926208 (3899 MB) LAPIC: enter X2APIC mode madt_lapic_probe: lapic_count=6 x2apic_count=0 ACPI CPUS = 6 lapic: divisor index 0, frequency 500002815 Hz CPU Topology: cores_per_chip: 6; threads_per_core: 1; chips_per_package: 1; srat_probe: can't locate SRAT SMI Frequency (worst case): 30303 Hz (33 us) Initialize MI interrupts for 6 cpus TSC is not invariant, no further tests will be performed Spectre: support=( none ) req=ffff operating=( none ) MDS: support=( none ) req=ffff operating=( none ) machdep.meltdown_mitigation enabled to protect against (mostly Intel) meltdown bug system call performance will be impacted interrupt uses mplock: swi_taskq wdog: In-kernel automatic watchdog reset enabled md0: Malloc disk evdev device loaded. kbd1 at kbdmux0 ACPI: RSDP 0x00000000000F59A0 000014 (v00 BOCHS ) ACPI: RSDT 0x00000000BFFE1CAC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: FACP 0x00000000BFFE1B38 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: DSDT 0x00000000BFFE0040 001AF8 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: FACS 0x00000000BFFE0000 000040 ACPI: APIC 0x00000000BFFE1BAC 0000A0 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: HPET 0x00000000BFFE1C4C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: WAET 0x00000000BFFE1C84 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) sc0: on motherboard sc0: VGA <16 virtual consoles, flags=0x100> acpi0: on motherboard ACPI: 1 ACPI AML tables successfully acquired and loaded ACPI FADT: SCI testing interrupt mode ... ACPI FADT: SCI select level/high acpi0: Power Button (fixed) acpi_hpet0: iomem 0xfed00000-0xfed003ff on acpi0 acpi_timer0 on acpi0 isab0: on acpi0 isa0: on isab0 cpu0: on acpi0 cpu_cst0: on cpu0 cpu1: on acpi0 cpu_cst1: on cpu1 cpu2: on acpi0 cpu_cst2: on cpu2 cpu3: on acpi0 cpu_cst3: on cpu3 cpu4: on acpi0 cpu_cst4: on cpu4 cpu5: on acpi0 cpu_cst5: on cpu5 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 isab1: at device 1.0 on pci0 isa1: on isab1 atapci0: port 0xc0a0-0xc0af,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 at device 1.1 on pci0 ata0: on atapci0 interrupt uses mplock: ata0 ata1: on atapci0 interrupt uses mplock: ata1 acd0: DVDROM at ata1-master WDMA2 pci0: (vendor 0x8086, dev 0x7113) at device 1.3 irq 9 vgapci0: mem 0xfebd0000-0xfebd0fff,0xfd000000-0xfdffffff at device 2.0 on pci0 vgapci0: Boot video device virtio_pci0: port 0xc080-0xc09f mem 0xfe000000-0xfe003fff,0xfebd1000-0xfebd1fff irq 11 at device 3.0 on pci0 vtnet0: on virtio_pci0 virtio_pci0: host features: 0x79bf8064 virtio_pci0: negotiated features: 0x198f8020 virtio_pci0: using 3 MSI-X vectors vtnet0: MAC address: 52:54:00:12:34:56 virtio_pci1: port 0xc000-0xc07f mem 0xfe004000-0xfe007fff,0xfebd2000-0xfebd2fff irq 11 at device 4.0 on pci0 vtblk0: on virtio_pci1 virtio_pci1: host features: 0x79007e54 virtio_pci1: negotiated features: 0x10001a54 virtio_pci1: using 6 MSI-X vectors vtblk0: Virtio: ncylinders at legacy maximum (16383), recalculating to 62415 vtblk0: Block size: 512 vtblk0: 30720MB (62914560 512 byte sectors: 16H 63S/T 16383C) atkbdc0: port 0x64,0x60 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 psm0: irq 12 on atkbdc0 interrupt uses mplock: psm0 psm0: model IntelliMouse Explorer, device ID 4 sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 on acpi0 sio0: type 16550A, console ACPI: Enabled 2 GPEs in block 00 to 0F rdrand0: No RdRand support. orm0: at iomem 0xe8000-0xeffff on isa1 vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa1 sio2: can't drain, serial port might not exist, disabling hpt27xx: no controller detected. CAM: Configuring 2 busses CAM: finished configuring all busses cd0 at ata1 bus 0 target 0 lun 0 cd0: Removable CD-ROM SCSI-0 device cd0: 16.000MB/s transfers cd0: Attempt to query device size failed: NOT READY, Medium not present Mounting root from hammer2:vbd0s1d hammer2_mount: root devstr="vbd0s1d" hammer2_mount: device="vbd0s1d" label="ROOT" rdonly=1 hammer2_ondisk: "/dev/vbd0s1d" zone=2 id=0 offset=0x0000000000000000 size=0x000000063f000000 hammer2_mount: hmp=0xfffff8008fae0000 pmp=0xfffff80090280000 DMA space used: 13580k, remaining available: 131072k Mounting devfs hammer2_mount: "vbd0s1d": no recovery needed hammer2: enable read/write HAMMER2: VOLDATA DUMP HAMMER2: INITIATE SPANs swap low/high-water marks set to 41940/62910 boot() called on cpu#2 Switching to cpu #0 for shutdown Waiting (max 60 seconds) for system thread swapcached to stop...stopped Waiting (max 60 seconds) for system thread vnlru to stop...stopped Waiting (max 60 seconds) for system thread consttyd to stop...stopped Waiting (max 60 seconds) for system thread bufdaemon to stop...stopped Waiting (max 60 seconds) for system thread bufdaemon_hw to stop...stopped syncing disks... 0 0 0 done v-chain 0xfffff8008fb604c0 volume.0 0000000000000010 0000000000000000/0 mir=00000000000000cf [00002000] (?) refs=1 f-chain 0xfffff8008fb60640 freemap.0 0000000000000010 0000000000000000/0 mir=00000000000000cf [00002000] (?) refs=1 Uptime: 9m3s Rebooting... Copyright (c) 2003-2026 The DragonFly Project. Copyright (c) 1992-2003 The FreeBSD Project. Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 The Regents of the University of California. All rights reserved. DragonFly 6.5-DEVELOPMENT #1: Mon Sep 7 20:24:03 UTC 2026 root@dfbsd:/usr/obj/usr/src/sys/X86_64_GENERIC acpi_hpet: frequency 100000000 Using cputimer HPET for TSC calibration Timer latency (in TSC ticks): 33284 min=31840 max=99286 TSC clock: 3600010589 Hz, NOT invariant CPU: QEMU Virtual CPU version 2.5+ (3600.01-MHz K8-class CPU) Origin="GenuineIntel" Id=0x60fb1 Family=0xf Model=0x6b Stepping=1 Features=0x1783fbfd Features2=0x80202001 AMD Features=0x20100800 AMD Features2=0x1 MONITOR/MWAIT Features=0x2 VMM/Hypervisor: Origin="KVMKVMKVM" real memory = 4293381120 (4094 MB) avail memory = 4088795136 (3899 MB) LAPIC: enter X2APIC mode madt_lapic_probe: lapic_count=6 x2apic_count=0 ACPI CPUS = 6 lapic: divisor index 0, frequency 500002834 Hz CPU Topology: cores_per_chip: 6; threads_per_core: 1; chips_per_package: 1; srat_probe: can't locate SRAT SMI Frequency (worst case): 45454 Hz (22 us) Initialize MI interrupts for 6 cpus TSC is not invariant, no further tests will be performed Spectre: support=( none ) req=ffff operating=( none ) MDS: support=( none ) req=ffff operating=( none ) machdep.meltdown_mitigation enabled to protect against (mostly Intel) meltdown bug system call performance will be impacted interrupt uses mplock: swi_taskq wdog: In-kernel automatic watchdog reset enabled md0: Malloc disk evdev device loaded. kbd1 at kbdmux0 ACPI: RSDP 0x00000000000F59A0 000014 (v00 BOCHS ) ACPI: RSDT 0x00000000BFFE1CAC 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: FACP 0x00000000BFFE1B38 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: DSDT 0x00000000BFFE0040 001AF8 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: FACS 0x00000000BFFE0000 000040 ACPI: APIC 0x00000000BFFE1BAC 0000A0 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: HPET 0x00000000BFFE1C4C 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) ACPI: WAET 0x00000000BFFE1C84 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) sc0: on motherboard sc0: VGA <16 virtual consoles, flags=0x100> acpi0: on motherboard ACPI: 1 ACPI AML tables successfully acquired and loaded ACPI FADT: SCI testing interrupt mode ... ACPI FADT: SCI select level/high acpi0: Power Button (fixed) acpi_hpet0: iomem 0xfed00000-0xfed003ff on acpi0 acpi_timer0 on acpi0 isab0: on acpi0 isa0: on isab0 cpu0: on acpi0 cpu_cst0: on cpu0 cpu1: on acpi0 cpu_cst1: on cpu1 cpu2: on acpi0 cpu_cst2: on cpu2 cpu3: on acpi0 cpu_cst3: on cpu3 cpu4: on acpi0 cpu_cst4: on cpu4 cpu5: on acpi0 cpu_cst5: on cpu5 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 isab1: at device 1.0 on pci0 isa1: on isab1 atapci0: port 0xc0a0-0xc0af,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 at device 1.1 on pci0 ata0: on atapci0 interrupt uses mplock: ata0 ata1: on atapci0 interrupt uses mplock: ata1 acd0: DVDROM at ata1-master WDMA2 pci0: (vendor 0x8086, dev 0x7113) at device 1.3 irq 9 vgapci0: mem 0xfebd0000-0xfebd0fff,0xfd000000-0xfdffffff at device 2.0 on pci0 vgapci0: Boot video device virtio_pci0: port 0xc080-0xc09f mem 0xfe000000-0xfe003fff,0xfebd1000-0xfebd1fff irq 11 at device 3.0 on pci0 vtnet0: on virtio_pci0 virtio_pci0: host features: 0x79bf8064 virtio_pci0: negotiated features: 0x198f8020 virtio_pci0: using 3 MSI-X vectors vtnet0: MAC address: 52:54:00:12:34:56 virtio_pci1: port 0xc000-0xc07f mem 0xfe004000-0xfe007fff,0xfebd2000-0xfebd2fff irq 11 at device 4.0 on pci0 vtblk0: on virtio_pci1 virtio_pci1: host features: 0x79007e54 virtio_pci1: negotiated features: 0x10001a54 virtio_pci1: using 6 MSI-X vectors vtblk0: Virtio: ncylinders at legacy maximum (16383), recalculating to 62415 vtblk0: Block size: 512 vtblk0: 30720MB (62914560 512 byte sectors: 16H 63S/T 16383C) atkbdc0: port 0x64,0x60 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 psm0: irq 12 on atkbdc0 interrupt uses mplock: psm0 psm0: model IntelliMouse Explorer, device ID 4 sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 on acpi0 sio0: type 16550A, console ACPI: Enabled 2 GPEs in block 00 to 0F rdrand0: No RdRand support. orm0: at iomem 0xe8000-0xeffff on isa1 vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa1 sio2: can't drain, serial port might not exist, disabling hpt27xx: no controller detected. CAM: Configuring 2 busses CAM: finished configuring all busses cd0 at ata1 bus 0 target 0 lun 0 cd0: Removable CD-ROM SCSI-0 device cd0: 16.000MB/s transfers cd0: Attempt to query device size failed: NOT READY, Medium not present Mounting root from hammer2:vbd0s1d hammer2_mount: root devstr="vbd0s1d" hammer2_mount: device="vbd0s1d" label="ROOT" rdonly=1 hammer2_ondisk: "/dev/vbd0s1d" zone=0 id=0 offset=0x0000000000000000 size=0x000000063f000000 hammer2_mount: hmp=0xfffff8008fae0000 pmp=0xfffff80090280000 DMA space used: 13580k, remaining available: 131072k Mounting devfs hammer2_mount: "vbd0s1d": no recovery needed hammer2: enable read/write HAMMER2: VOLDATA DUMP HAMMER2: INITIATE SPANs swap low/high-water marks set to 41940/62910 DF3173: autofs mount /df3173_mp amp=0xfffff8008d5d7c00 root=0xfffff8008da90f00 DF3173: harness loaded; sysctl debug.df3173_mode=1|2 to start DF3173: mode=1 starting (PANIC variant: foreign-queue STAILQ_REMOVE) DF3173: R01 T0 creator=userstat id=0 ar=0xfffff80118745a00 home_tq=cpu3-queue key=k3173_r001 DF3173: R01 t0.0 req=alive id=0 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R01 t0.6 req=alive id=0 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 8533 (now 8463) DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R01 w req=alive id=0 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: sleeper done at tick 8534 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 w req=alive id=1 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R01 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff80089944400 (request was 0xfffff801187dd000) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R01 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R01 complete (request freed=yes) DF3173: R02 T0 creator=userstat id=3 ar=0xfffff80118745a00 home_tq=cpu3-queue key=k3173_r002 DF3173: R02 t0.0 req=alive id=3 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 t0.6 req=alive id=3 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 8881 (now 8811) DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R02 w req=alive id=3 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: sleeper done at tick 8881 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=alive id=4 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R02 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R02 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[2] obj=0xfffff8011880de00 (request was 0xfffff80118745a00) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R02 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R02 complete (request freed=yes) DF3173: R03 T0 creator=userstat id=8 ar=0xfffff80118785a00 home_tq=cpu1-queue key=k3173_r003 DF3173: R03 t0.0 req=alive id=8 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 t0.6 req=alive id=8 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 9319 (now 9249) DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=1 tq=cpu1 cflags=0 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=1 tq=cpu1 cflags=0 DF3173: R03 w req=alive id=8 ref=2 done=0 inprog=0 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 9320 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=10 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=11 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R03 w req=alive id=12 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=12 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=12 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=12 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 w req=alive id=12 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R03 post req=alive id=12 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: MARKER[3] obj=0xfffff80118747000 (request was 0xfffff80118788600) different-block e0=60 DF3173: MARKER[4] obj=0xfffff801187c0200 (request was 0xfffff80118788600) different-block e0=60 DF3173: MARKER[5] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[3] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 (no post-get write this round) DF3173: R03 complete (request freed=NO (still queued?)) DF3173: R04 T0 creator=userstat id=13 ar=0xfffff8011878c800 home_tq=cpu1-queue key=k3173_r004 DF3173: R04 t0.0 req=alive id=13 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 t0.6 req=alive id=13 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 9832 (now 9762) DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R04 w req=alive id=13 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper done at tick 9832 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 w req=alive id=15 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R04 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff80118788600 (request was 0xfffff8011878b200) different-block e0=60 DF3173: MARKER[4] obj=0xfffff801187c2e00 (request was 0xfffff8011878b200) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R04 freed-object resurfaced on cpu2 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R04 complete (request freed=yes) DF3173: R05 T0 creator=userstat id=18 ar=0xfffff80118785a00 home_tq=cpu5-queue key=k3173_r005 DF3173: R05 t0.0 req=alive id=18 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 t0.6 req=alive id=18 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: sleeper running on cpu5 until tick 10183 (now 10113) DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=0 ta_pending=1 tq=cpu5 cflags=0 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu5 cflags=0 DF3173: R05 w req=alive id=18 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu5 cflags=0 DF3173: sleeper done at tick 10184 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=19 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu4 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=alive id=21 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu5 cflags=1 DF3173: R05 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R05 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[3] obj=0xfffff80118749c00 (request was 0xfffff801187e0200) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187e0200 (request was 0xfffff801187e0200) SAME-BLOCK e0=60 DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[2] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[3] readback e=0 done=0 (no post-get write this round) DF3173: R05 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R05 complete (request freed=yes) DF3173: R06 T0 creator=userstat id=24 ar=0xfffff80118790a00 home_tq=cpu1-queue key=k3173_r006 DF3173: R06 t0.0 req=alive id=24 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 t0.6 req=alive id=24 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 10922 (now 10852) DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R06 w req=alive id=24 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 10922 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 w req=alive id=25 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R06 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187e2e00 (request was 0xfffff80118792000) different-block e0=60 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[5] readback e=60 done=1 (no post-get write this round) DF3173: R06 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R06 complete (request freed=yes) DF3173: R07 T0 creator=userstat id=28 ar=0xfffff80118796200 home_tq=cpu1-queue key=k3173_r007 DF3173: R07 t0.0 req=alive id=28 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R07 t0.6 req=alive id=28 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 11551 (now 11481) DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R07 w req=alive id=28 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 11551 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 w req=alive id=29 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R07 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[3] obj=0xfffff80118790a00 (request was 0xfffff80118796200) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[3] readback e=0 done=1 (no post-get write this round) DF3173: R07 freed-object resurfaced on cpu5 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R07 complete (request freed=yes) DF3173: R08 T0 creator=userstat id=31 ar=0xfffff80118797800 home_tq=cpu1-queue key=k3173_r008 DF3173: R08 t0.0 req=alive id=31 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R08 t0.6 req=alive id=31 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 11909 (now 11839) DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R08 w req=alive id=31 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 11909 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 w req=alive id=32 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R08 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187e4400 (request was 0xfffff80118797800) different-block e0=60 DF3173: MARKER[4] obj=0xfffff801187c5a00 (request was 0xfffff80118797800) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R08 freed-object resurfaced on cpu2 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R08 complete (request freed=yes) DF3173: R09 T0 creator=userstat id=36 ar=0xfffff8011879d000 home_tq=cpu1-queue key=k3173_r009 DF3173: R09 t0.0 req=alive id=36 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R09 t0.6 req=alive id=36 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 12647 (now 12577) DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R09 w req=alive id=36 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 12647 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=alive id=37 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R09 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R09 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187e5a00 (request was 0xfffff8011879d000) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 <== WRITE-AFTER-FREE (e0 already 145 at get) DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: R09 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R09 complete (request freed=yes) DF3173: R10 T0 creator=userstat id=39 ar=0xfffff8011874de00 home_tq=cpu3-queue key=k3173_r010 DF3173: R10 t0.0 req=alive id=39 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 t0.6 req=alive id=39 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 13009 (now 12939) DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R10 w req=alive id=39 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: sleeper done at tick 13010 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=40 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=alive id=41 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R10 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R10 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187e7000 (request was 0xfffff8011874f400) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187c7000 (request was 0xfffff8011874f400) different-block e0=60 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 (no post-get write this round) DF3173: R10 freed-object resurfaced on cpu1 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R10 complete (request freed=yes) DF3173: R11 T0 creator=userstat id=44 ar=0xfffff80118752000 home_tq=cpu3-queue key=k3173_r011 DF3173: R11 t0.0 req=alive id=44 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R11 t0.6 req=alive id=44 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 13748 (now 13678) DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R11 w req=alive id=44 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: sleeper done at tick 13748 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=alive id=45 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu5 cflags=1 DF3173: R11 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R11 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[3] obj=0xfffff801187e8600 (request was 0xfffff801187e8600) SAME-BLOCK e0=60 DF3173: MARKER[4] obj=0xfffff801187c8600 (request was 0xfffff801187e8600) different-block e0=0 DF3173: MARKER[1] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R11 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R11 complete (request freed=yes) DF3173: R12 T0 creator=userstat id=47 ar=0xfffff80118752000 home_tq=cpu3-queue key=k3173_r012 DF3173: R12 t0.0 req=alive id=47 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 t0.6 req=alive id=47 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 14110 (now 14040) DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R12 w req=alive id=47 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: sleeper done at tick 14111 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=48 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=alive id=50 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R12 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R12 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187eb200 (request was 0xfffff80118753600) different-block e0=60 DF3173: MARKER[4] obj=0xfffff801187c9c00 (request was 0xfffff80118753600) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=60 done=1 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R12 freed-object resurfaced on cpu2 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R12 complete (request freed=yes) DF3173: R13 T0 creator=userstat id=53 ar=0xfffff80118757800 home_tq=cpu3-queue key=k3173_r013 DF3173: R13 t0.0 req=alive id=53 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R13 t0.6 req=alive id=53 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: sleeper running on cpu3 until tick 14849 (now 14779) DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: R13 w req=alive id=53 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu3 cflags=0 DF3173: sleeper done at tick 14850 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=alive id=54 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R13 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R13 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[4] obj=0xfffff80118757800 (request was 0xfffff80118757800) SAME-BLOCK e0=60 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 <== WRITE-AFTER-FREE (e0 already 145 at get) DF3173: R13 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R13 complete (request freed=yes) DF3173: R14 T0 creator=userstat id=56 ar=0xfffff80118781800 home_tq=cpu1-queue key=k3173_r014 DF3173: R14 t0.0 req=alive id=56 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 t0.6 req=alive id=56 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 15211 (now 15141) DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R14 w req=alive id=56 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 15211 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=57 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=58 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R14 w req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 w req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R14 post req=alive id=59 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: MARKER[2] obj=0xfffff80118816200 (request was 0xfffff80118758e00) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187cb200 (request was 0xfffff80118758e00) different-block e0=60 DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[3] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[2] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 (no post-get write this round) DF3173: R14 complete (request freed=NO (still queued?)) DF3173: R15 T0 creator=userstat id=61 ar=0xfffff80118758e00 home_tq=cpu1-queue key=k3173_r015 DF3173: R15 t0.0 req=alive id=61 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 t0.6 req=alive id=61 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 15848 (now 15778) DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R15 w req=alive id=61 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 15848 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 w req=alive id=62 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R15 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff80089957800 (request was 0xfffff8011889e600) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: R15 freed-object resurfaced on cpu5 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R15 complete (request freed=yes) DF3173: R16 T0 creator=userstat id=65 ar=0xfffff80118882e00 home_tq=cpu1-queue key=k3173_r016 DF3173: R16 t0.0 req=alive id=65 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 t0.6 req=alive id=65 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 16482 (now 16412) DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R16 w req=alive id=65 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 16482 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 w req=alive id=66 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R16 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff80118758e00 (request was 0xfffff80118881800) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187cde00 (request was 0xfffff80118881800) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=0 done=1 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R16 freed-object resurfaced on cpu2 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R16 complete (request freed=yes) DF3173: R17 T0 creator=userstat id=71 ar=0xfffff80118887000 home_tq=cpu1-queue key=k3173_r017 DF3173: R17 t0.0 req=alive id=71 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R17 t0.6 req=alive id=71 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 17413 (now 17343) DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R17 w req=alive id=71 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 17413 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=alive id=72 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu4 cflags=1 DF3173: R17 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R17 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187ef400 (request was 0xfffff80118887000) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 <== WRITE-AFTER-FREE (e0 already 145 at get) DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: R17 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R17 complete (request freed=yes) DF3173: R18 T0 creator=userstat id=74 ar=0xfffff80118888600 home_tq=cpu1-queue key=k3173_r018 DF3173: R18 t0.0 req=alive id=74 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 t0.6 req=alive id=74 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 17773 (now 17703) DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R18 w req=alive id=74 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 17773 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=75 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=76 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R18 w req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 w req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: R18 post req=alive id=77 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu3 cflags=1 DF3173: MARKER[0] obj=0xfffff801188be600 (request was 0xfffff80118740200) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187cf400 (request was 0xfffff80118740200) different-block e0=60 DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[3] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 (no post-get write this round) DF3173: R18 complete (request freed=NO (still queued?)) DF3173: R19 T0 creator=userstat id=79 ar=0xfffff80118740200 home_tq=cpu1-queue key=k3173_r019 DF3173: R19 t0.0 req=alive id=79 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 t0.6 req=alive id=79 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 18410 (now 18340) DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R19 w req=alive id=79 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 18410 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 w req=alive id=80 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R19 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff801188a0200 (request was 0xfffff80118889c00) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R19 freed-object resurfaced on cpu5 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R19 complete (request freed=yes) DF3173: R20 T0 creator=userstat id=83 ar=0xfffff8011888de00 home_tq=cpu1-queue key=k3173_r020 DF3173: R20 t0.0 req=alive id=83 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 t0.6 req=alive id=83 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 19046 (now 18976) DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R20 w req=alive id=83 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 19046 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=84 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=85 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R20 w req=alive id=86 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=86 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=86 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=86 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 w req=alive id=86 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: R20 post req=alive id=86 ref=1 done=0 inprog=1 ta_pending=0 tq=cpu2 cflags=1 DF3173: MARKER[5] obj=0xfffff80118740200 (request was 0xfffff8011881ba00) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R20 complete (request freed=NO (still queued?)) DF3173: R21 T0 creator=userstat id=88 ar=0xfffff8011881ba00 home_tq=cpu1-queue key=k3173_r021 DF3173: R21 t0.0 req=alive id=88 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 t0.6 req=alive id=88 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 19675 (now 19605) DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R21 w req=alive id=88 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 19675 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 w req=alive id=89 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R21 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187f2000 (request was 0xfffff8011888c800) different-block e0=0 DF3173: MARKER[4] obj=0xfffff8011888c800 (request was 0xfffff8011888c800) SAME-BLOCK e0=60 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 <== WRITE-AFTER-FREE (e0 already 145 at get) DF3173: R21 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R21 complete (request freed=yes) DF3173: R22 T0 creator=userstat id=92 ar=0xfffff80118892000 home_tq=cpu1-queue key=k3173_r022 DF3173: R22 t0.0 req=alive id=92 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 t0.6 req=alive id=92 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 20306 (now 20236) DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R22 w req=alive id=92 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 20306 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 w req=alive id=93 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R22 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff801188a4400 (request was 0xfffff80118890a00) different-block e0=0 DF3173: MARKER[4] readback e=0 done=1 (no post-get write this round) DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: R22 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R22 complete (request freed=yes) DF3173: R23 T0 creator=userstat id=98 ar=0xfffff80118896200 home_tq=cpu1-queue key=k3173_r023 DF3173: R23 t0.0 req=alive id=98 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 t0.6 req=alive id=98 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 21235 (now 21165) DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R23 w req=alive id=98 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 21235 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=alive id=99 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R23 w req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: R23 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff801188a5a00 (request was 0xfffff80118894c00) different-block e0=0 DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: R23 freed-object resurfaced on cpu5 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R23 complete (request freed=yes) DF3173: R24 T0 creator=userstat id=102 ar=0xfffff8011889a400 home_tq=cpu1-queue key=k3173_r024 DF3173: R24 t0.0 req=alive id=102 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 t0.6 req=alive id=102 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 21865 (now 21795) DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R24 w req=alive id=102 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 21865 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 w req=alive id=103 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R24 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff801188a7000 (request was 0xfffff80118898e00) different-block e0=0 DF3173: MARKER[4] obj=0xfffff801187d4c00 (request was 0xfffff80118898e00) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=0 done=0 (no post-get write this round) DF3173: R24 freed-object resurfaced on cpu2 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R24 complete (request freed=yes) DF3173: R25 T0 creator=userstat id=108 ar=0xfffff80118936200 home_tq=cpu1-queue key=k3173_r025 DF3173: R25 t0.0 req=alive id=108 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 t0.6 req=alive id=108 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 22795 (now 22725) DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R25 w req=alive id=108 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 22795 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 w req=alive id=109 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R25 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[5] obj=0xfffff801187f4c00 (request was 0xfffff80118937800) different-block e0=0 DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[5] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[4] readback e=60 done=1 <== WRITE-AFTER-FREE (e0 already 145 at get) DF3173: R25 freed-object resurfaced on cpu4 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R25 complete (request freed=yes) DF3173: R26 T0 creator=userstat id=112 ar=0xfffff8011893ba00 home_tq=cpu1-queue key=k3173_r026 DF3173: R26 t0.0 req=alive id=112 ref=1 done=0 inprog=0 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 t0.6 req=alive id=112 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: sleeper running on cpu1 until tick 23425 (now 23355) DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: R26 w req=alive id=112 ref=2 done=0 inprog=1 ta_pending=1 tq=cpu1 cflags=0 DF3173: sleeper done at tick 23425 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 w req=alive id=113 ref=2 done=0 inprog=1 ta_pending=0 tq=cpu1 cflags=1 DF3173: R26 post req=GONE id=-1 ref=-1 done=-1 inprog=-1 ta_pending=-1 tq=cpu-2 cflags=ffffffff DF3173: MARKER[0] obj=0xfffff801188a9c00 (request was 0xfffff8011893a400) different-block e0=0 DF3173: MARKER[1] readback e=0 done=0 (no post-get write this round) DF3173: MARKER[0] readback e=0 done=0 (no post-get write this round) DF3173: R26 freed-object resurfaced on cpu3 magazine (home=cpu-1) <== CROSS-CPU FREE DF3173: R26 complete (request freed=yes) DF3173: R27 creator never created?! DF3173: R28 creator never created?! DF3173: R29 creator never created?! DF3173: R30 creator never created?!