uvm_fault(0xfffffd8069955588, 0x7, 0, 1) -> e kernel: page fault trap, code=0 Stopped at witness_checkorder+0x1ec: movl 0x8(%r14),%ebx TID PID UID PRFLAGS PFLAGS CPU COMMAND 427927 96192 0 0 0x4000000 1 syz-executor.4 witness_checkorder(fffffd806ef97010,9,0) at witness_checkorder+0x1ec sys/kern/subr_witness.c:794 mtx_enter(fffffd806ef97000) at mtx_enter+0x3e sys/kern/kern_lock.c:265 knote_remove(ffff80002129f2a0,fffffd806ef97000,fffffd806ef97088,3,0) at knote_remove+0x20d sys/kern/kern_event.c:1881 knote_fdclose(ffff80002129f2a0,3) at knote_fdclose+0xae sys/kern/kern_event.c:1934 fdfree(ffff80002129f2a0) at fdfree+0xdf sys/kern/kern_descrip.c:1196 exit1(ffff80002129f2a0,0,0,1) at exit1+0x3e4 sys/kern/kern_exit.c:206 sys_exit(ffff80002129f2a0,ffff800024721e70,ffff800024721ec0) at sys_exit+0x1a sys/kern/kern_exit.c:89 syscall(ffff800024721f40) at syscall+0x5e2 mi_syscall sys/sys/syscall_mi.h:110 [inline] syscall(ffff800024721f40) at syscall+0x5e2 sys/arch/amd64/amd64/trap.c:623 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0x707743a10e60, count: 6 https://www.openbsd.org/ddb.html describes the minimum info required in bug reports. Insufficient info makes it difficult to find and fix bugs. ddb{0}> ddb{0}> set $lines = 0 ddb{0}> set $maxwidth = 0 ddb{0}> show panic *cpu0: uvm_fault(0xfffffd8069955588, 0x7, 0, 1) -> e ddb{0}> trace witness_checkorder(fffffd806ef97010,9,0) at witness_checkorder+0x1ec sys/kern/subr_witness.c:794 mtx_enter(fffffd806ef97000) at mtx_enter+0x3e sys/kern/kern_lock.c:265 knote_remove(ffff80002129f2a0,fffffd806ef97000,fffffd806ef97088,3,0) at knote_remove+0x20d sys/kern/kern_event.c:1881 knote_fdclose(ffff80002129f2a0,3) at knote_fdclose+0xae sys/kern/kern_event.c:1934 fdfree(ffff80002129f2a0) at fdfree+0xdf sys/kern/kern_descrip.c:1196 exit1(ffff80002129f2a0,0,0,1) at exit1+0x3e4 sys/kern/kern_exit.c:206 sys_exit(ffff80002129f2a0,ffff800024721e70,ffff800024721ec0) at sys_exit+0x1a sys/kern/kern_exit.c:89 syscall(ffff800024721f40) at syscall+0x5e2 mi_syscall sys/sys/syscall_mi.h:110 [inline] syscall(ffff800024721f40) at syscall+0x5e2 sys/arch/amd64/amd64/trap.c:623 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0x707743a10e60, count: -9 ddb{0}> show registers rdi 0 rsi 0x20000 acpi_pdirpa+0xbe63 rbp 0xffff800024721c10 rbx 0xe rdx 0 rcx 0xffff80002129f2a0 rax 0xffffffff82c26ff0 cpu_info_full_primary+0x1ff0 r8 0x1 r9 0 r10 0x18f827871985a2d0 r11 0xf52a4f153458d5f9 r12 0 r13 0xfffffd806ef97010 r14 0xffffffffffffffff r15 0xffff80002129f2a0 rip 0xffffffff81d5339c witness_checkorder+0x1ec cs 0x8 rflags 0x10246 __ALIGN_SIZE+0xf246 rsp 0xffff800024721b60 ss 0x10 witness_checkorder+0x1ec: movl 0x8(%r14),%ebx ddb{0}> show proc PROC (syz-executor.1) pid=359650 stat=onproc flags process=1008 proc=2000 pri=0, usrpri=83, nice=20 forw=0xffffffffffffffff, list=0xffff80002129fa98,0xffff80002129ed60 process=0xffff80002959d510 user=0xffff80002471c000, vmspace=0xfffffd8069955588 estcpu=36, cpticks=1, pctcpu=0.0 user=0, sys=1, intr=0 ddb{0}> ps PID TID PPID UID S FLAGS WAIT COMMAND 75412 159805 43776 0 2 0 syz-executor.0 75412 14423 43776 0 2 0x4000000 syz-executor.0 96192 171791 12259 0 2 0 syz-executor.4 96192 427927 12259 0 7 0x4000000 syz-executor.4 1560 319310 5679 0 2 0 syz-executor.2 41144 159737 842 0 2 0 syz-executor.3 41144 54921 842 0 3 0x4000080 kqsel syz-executor.3 2033 348697 5903 0 2 0 syz-executor.5 2033 82340 5903 0 3 0x4000080 kqsel syz-executor.5 2033 197247 5903 0 3 0x4000080 kqread syz-executor.5 43744 106497 0 0 3 0x14280 nfsidl nfsio 34040 73185 0 0 3 0x14280 nfsidl nfsio 83303 74673 0 0 3 0x14280 nfsidl nfsio 5035 227785 0 0 3 0x14280 nfsidl nfsio 26083 508508 0 0 3 0x14280 nfsidl nfsio 48229 24806 0 0 3 0x14280 nfsidl nfsio 48873 26863 0 0 3 0x14280 nfsidl nfsio 83357 106251 0 0 3 0x14280 nfsidl nfsio 97716 477032 0 0 3 0x14280 nfsidl nfsio 20284 29593 0 0 3 0x14280 nfsidl nfsio 59666 273333 0 0 3 0x14280 nfsidl nfsio 78228 245634 0 0 3 0x14280 nfsidl nfsio 2303 195379 0 0 3 0x14280 nfsidl nfsio 92941 80670 0 0 3 0x14280 nfsidl nfsio 4431 276635 0 0 3 0x14280 nfsidl nfsio 57875 267 0 0 3 0x14280 nfsidl nfsio 40792 344438 0 0 3 0x14280 nfsidl nfsio 20724 202463 0 0 3 0x14280 nfsidl nfsio 68396 200191 0 0 3 0x14280 nfsidl nfsio 9851 263234 0 0 3 0x14280 nfsidl nfsio 808 31579 18429 0 2 0x2 syz-executor.6 22024 74734 18429 0 3 0x82 nanoslp syz-executor.7 5903 358151 18429 0 2 0x2 syz-executor.5 12259 388240 18429 0 3 0x82 nanoslp syz-executor.4 5679 292683 18429 0 3 0x82 nanoslp syz-executor.2 842 286715 18429 0 2 0x2 syz-executor.3 70105 496726 18429 0 3 0x82 nanoslp syz-executor.1 43776 293086 18429 0 3 0x82 nanoslp syz-executor.0 18429 334459 17531 0 3 0x2000082 thrsleep syz-fuzzer 18429 208972 17531 0 3 0x6000082 nanoslp syz-fuzzer 18429 291989 17531 0 3 0x6000082 wait syz-fuzzer 18429 20603 17531 0 3 0x6000082 wait syz-fuzzer 18429 180066 17531 0 3 0x6000082 thrsleep syz-fuzzer 18429 240001 17531 0 3 0x6000082 wait syz-fuzzer 18429 481522 17531 0 3 0x6000082 wait syz-fuzzer 18429 147512 17531 0 3 0x6000082 wait syz-fuzzer 18429 435950 17531 0 3 0x6000082 wait syz-fuzzer 18429 295829 17531 0 3 0x6000082 thrsleep syz-fuzzer 18429 199091 17531 0 3 0x6000082 wait syz-fuzzer 18429 451139 17531 0 3 0x6000082 kqread syz-fuzzer 18429 117507 17531 0 3 0x6000082 wait syz-fuzzer 18429 209491 17531 0 3 0x6000082 thrsleep syz-fuzzer 18429 33986 17531 0 3 0x6000082 thrsleep syz-fuzzer 18429 179726 17531 0 3 0x6000082 thrsleep syz-fuzzer 17531 402254 14946 0 3 0x10008a sigsusp ksh 14946 522117 28308 0 3 0x9a kqread sshd 23561 101063 1 0 3 0x100083 ttyin getty 28308 161740 1 0 3 0x88 kqread sshd 24172 272919 114 74 3 0x1100092 bpf pflogd 114 60248 1 0 3 0x80 netio pflogd 88991 10480 31450 73 3 0x1100090 kqread syslogd 31450 131888 1 0 3 0x100082 netio syslogd 30469 503782 1 0 3 0x100080 kqread resolvd 82908 395326 65963 77 3 0x100092 kqread dhcpleased 43287 338768 65963 77 3 0x100092 kqread dhcpleased 65963 303014 1 0 3 0x80 kqread dhcpleased 45914 288508 0 0 3 0x14200 bored smr 38390 122249 0 0 2 0x14200 zerothread 65646 493621 0 0 3 0x14200 aiodoned aiodoned 97800 347492 0 0 3 0x14200 syncer update 59403 15526 0 0 3 0x14200 cleaner cleaner 35441 84862 0 0 2 0x14200 reaper 49864 36299 0 0 3 0x14200 pgdaemon pagedaemon 89784 186621 0 0 3 0x14200 bored viomb 59876 435451 0 0 3 0x40014200 acpi0 acpi0 74060 213827 0 0 3 0x40014200 idle1 2132 138480 0 0 3 0x14200 bored softnet3 53688 56684 0 0 3 0x14200 bored softnet2 94471 237588 0 0 3 0x14200 bored softnet1 27477 434711 0 0 3 0x14200 bored softnet0 46418 347200 0 0 3 0x14200 bored systqmp 52161 89012 0 0 3 0x14200 bored systq 11081 275617 0 0 3 0x40014200 bored softclock 90426 73005 0 0 3 0x40014200 idle0 1 172319 0 0 3 0x82 wait init 0 0 -1 0 3 0x10200 scheduler swapper ddb{0}> show all locks Process 808 (syz-executor.6) thread 0xffff80002121bd38 (31579) exclusive rrwlock inode r = 0 (0xfffffd80669feb38) #0 witness_lock+0x447 #1 rw_enter+0x3c8 sys/kern/kern_rwlock.c:309 #2 rrw_enter+0x8c sys/kern/kern_rwlock.c:464 #3 VOP_LOCK+0x8b sys/kern/vfs_vops.c:518 #4 vn_lock+0x84 sys/kern/vfs_vnops.c:564 #5 vget+0x200 sys/kern/vfs_subr.c:676 #6 ufs_ihashget+0x121 sys/ufs/ufs/ufs_ihash.c:119 #7 ffs_vget+0x7c sys/ufs/ffs/ffs_vfsops.c:1314 #8 ufs_lookup+0x13ba sys/ufs/ufs/ufs_lookup.c:487 #9 VOP_LOOKUP+0x5c sys/kern/vfs_vops.c:85 #10 vfs_lookup+0x6e2 sys/kern/vfs_lookup.c:566 #11 namei+0x55a sys/kern/vfs_lookup.c:250 #12 dounlinkat+0x9d sys/kern/vfs_syscalls.c:1847 #13 syscall+0x5e2 mi_syscall sys/sys/syscall_mi.h:110 [inline] #13 syscall+0x5e2 sys/arch/amd64/amd64/trap.c:623 #14 Xsyscall+0x128 exclusive rrwlock inode r = 0 (0xfffffd8067be71b8) #0 witness_lock+0x447 #1 rw_enter+0x3c8 sys/kern/kern_rwlock.c:309 #2 rrw_enter+0x8c sys/kern/kern_rwlock.c:464 #3 VOP_LOCK+0x8b sys/kern/vfs_vops.c:518 #4 vn_lock+0x84 sys/kern/vfs_vnops.c:564 #5 vfs_lookup+0xd5 sys/kern/vfs_lookup.c:418 #6 namei+0x55a sys/kern/vfs_lookup.c:250 #7 dounlinkat+0x9d sys/kern/vfs_syscalls.c:1847 #8 syscall+0x5e2 mi_syscall sys/sys/syscall_mi.h:110 [inline] #8 syscall+0x5e2 sys/arch/amd64/amd64/trap.c:623 #9 Xsyscall+0x128 ddb{0}> show malloc Type InUse MemUse HighUse Limit Requests Type Lim devbuf 10196 6491K 6684K 78643K 14242 0 pcb 14 10K 12K 78643K 1271 0 rtable 234 6K 6K 78643K 354 0 pf 32 9K 10K 78643K 43 0 ifaddr 45 15K 15K 78643K 47 0 ifgroup 55 2K 2K 78643K 55 0 counters 60 35K 35K 78643K 60 0 ioctlops 0 0K 4K 78643K 3096 0 iov 0 0K 12K 78643K 920 0 mount 1 1K 1K 78643K 1 0 log 0 0K 0K 78643K 4 0 vnodes 1346 84K 84K 78643K 3973 0 UFS quota 1 32K 32K 78643K 1 0 UFS mount 5 36K 36K 78643K 5 0 shm 2 1K 17K 78643K 825 0 VM map 2 1K 1K 78643K 2 0 sem 12 0K 0K 78643K 1171 0 dirhash 12 2K 2K 78643K 12 0 ACPI 1697 195K 286K 78643K 12548 0 file desc 16 57K 89K 78643K 27182 0 proc 68 91K 127K 78643K 527 0 subproc 104 6K 6K 78643K 104 0 NFS srvsock 1 0K 0K 78643K 1 0 NFS daemon 1 16K 16K 78643K 1 0 in_multi 99 7K 7K 78643K 99 0 ether_multi 1 0K 0K 78643K 1 0 ISOFS mount 1 32K 32K 78643K 1 0 MSDOSFS mount 1 16K 16K 78643K 1 0 ttys 73 334K 334K 78643K 73 0 exec 0 0K 1K 78643K 387 0 tdb 3 0K 0K 78643K 3 0 pagedep 1 8K 8K 78643K 1 0 inodedep 1 32K 32K 78643K 1 0 newblk 1 0K 0K 78643K 1 0 VM swap 8 62K 64K 78643K 10 0 UVM amap 318 82K 83K 78643K 234220 0 UVM aobj 131 6K 6K 78643K 201 0 memdesc 1 4K 4K 78643K 1 0 crypto data 1 1K 1K 78643K 1 0 NDP 12 0K 1K 78643K 28 0 temp 75 5916K 6044K 78643K 62339 0 kqueue 13 20K 32K 78643K 890 0 SYN cache 2 16K 16K 78643K 2 0 ddb{0}> show all pools Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle plcache 128 22 0 0 1 0 1 1 0 8 0 rtpcb 120 36 0 33 1 0 1 1 0 8 0 rtentry 112 111 0 1 4 0 4 4 0 8 0 unpcb 144 21009 0 20994 79 78 1 8 0 8 0 syncache 304 4 0 4 1 1 0 1 0 8 0 tcpqe 32 282 0 282 1 1 0 1 0 8 0 tcpcb 808 55 0 51 1 0 1 1 0 8 0 arp 120 18 0 0 1 0 1 1 0 8 0 inpcb 368 1686 0 1678 20 19 1 7 0 8 0 nd6 136 24 0 0 1 0 1 1 0 8 0 kcovpl 48 8 0 0 1 0 1 1 0 8 0 pfosfp 40 1428 0 1005 5 0 5 5 0 8 0 pfosfpen 112 1428 0 714 21 0 21 21 0 8 0 pfstitem 24 26 0 24 1 0 1 1 0 8 0 pfstkey 128 26 0 24 1 0 1 1 0 8 0 pfstate 376 26 0 24 3 2 1 3 0 8 0 pfrule 1344 21 0 16 2 1 1 2 0 8 0 art_heap8 4096 1 0 0 1 0 1 1 0 8 0 art_heap4 256 453 0 0 29 0 29 29 0 8 0 art_table 32 454 0 0 4 0 4 4 0 8 0 art_node 16 110 0 10 1 0 1 1 0 8 0 semapl 112 1169 0 1159 1 0 1 1 0 8 0 shmpl 112 198 0 70 4 0 4 4 0 8 0 dirhash 1024 17 0 0 3 0 3 3 0 8 0 dino2pl 256 29988 0 28542 91 0 91 91 0 8 0 ffsino 272 29988 0 28542 97 0 97 97 0 8 0 nchpl 144 65752 0 64065 64 0 64 64 0 8 0 uvmvnodes 80 5926 0 0 121 0 121 121 0 8 0 vnodes 216 5926 0 0 330 0 330 330 0 8 0 namei 1024 164413 0 164413 2 1 1 2 0 8 1 percpumem 16 43 0 0 1 0 1 1 0 8 0 kstatmem 264 24 0 0 2 0 2 2 0 8 0 scxspl 216 171906 0 171906 14 13 1 8 1 8 1 plimitpl 152 86 0 70 1 0 1 1 0 8 0 sigapl 424 27524 0 27457 10 2 8 8 0 8 0 futexpl 64 160351 0 160351 1 0 1 1 0 8 1 knotepl 120 150 0 0 4 0 4 4 0 8 0 kqueuepl 216 1975 0 1964 6 4 2 3 0 8 1 pipepl 320 9285 0 9257 103 100 3 13 0 8 0 fdescpl 496 27487 0 27458 5 1 4 5 0 8 0 filepl 152 111698 0 111458 135 125 10 19 0 8 0 lockfpl 104 2023 0 2021 1 0 1 1 0 8 0 lockfspl 48 921 0 919 1 0 1 1 0 8 0 sessionpl 144 24 0 7 1 0 1 1 0 8 0 pgrppl 48 24 0 7 1 0 1 1 0 8 0 ucredpl 104 8501 0 8489 1 0 1 1 0 8 0 zombiepl 144 27459 0 27457 1 0 1 1 0 8 0 processpl 1072 27524 0 27457 5 0 5 5 0 8 0 procpl 680 58853 0 58765 29 21 8 9 0 8 0 sockpl 488 22731 0 22705 244 240 4 28 0 8 0 mcl64k 65536 33 0 0 3 0 3 3 0 8 0 mcl16k 16384 25 0 0 3 0 3 3 0 8 0 mcl12k 12288 26 0 0 2 0 2 2 0 8 0 mcl9k 9216 17 0 0 2 0 2 2 0 8 0 mcl8k 8192 41 0 0 4 1 3 3 0 8 0 mcl4k 4096 33 0 0 3 0 3 3 0 8 0 mcl2k2 2112 10 0 0 1 0 1 1 0 8 0 mcl2k 2048 310 0 0 32 10 22 32 0 8 0 mtagpl 96 2 0 0 1 0 1 1 0 8 0 mbufpl 256 826 0 0 18 2 16 18 0 8 0 bufpl 288 31314 0 24985 453 0 453 453 0 8 0 anonpl 24 1992080 0 1984081 63 13 50 58 0 186 0 amapchunkpl 152 736658 0 735902 96 62 34 34 0 158 2 amappl16 200 30254 0 30114 8 0 8 8 0 8 0 amappl15 192 12 0 12 1 1 0 1 0 8 0 amappl14 184 163 0 150 2 1 1 2 0 8 0 amappl13 176 18 0 17 1 0 1 1 0 8 0 amappl12 168 28151 0 28121 4 2 2 3 0 8 0 amappl11 160 56 0 42 1 0 1 1 0 8 0 amappl10 152 61 0 49 1 0 1 1 0 8 0 amappl9 144 242 0 242 1 1 0 1 0 8 0 amappl8 136 365 0 288 3 0 3 3 0 8 0 amappl7 128 85 0 75 1 0 1 1 0 8 0 amappl6 120 307 0 286 2 1 1 2 0 8 0 amappl5 112 686 0 672 1 0 1 1 0 8 0 amappl4 104 1121 0 1079 3 1 2 3 0 8 0 amappl3 96 149176 0 149094 4 1 3 3 0 8 0 amappl2 88 28661 0 28595 3 1 2 3 0 8 0 amappl1 80 99453 0 98894 23 10 13 23 0 8 0 amappl 88 233679 0 233477 8 2 6 6 0 92 0 dma4096 4096 1 0 1 1 1 0 1 0 8 0 dma1024 1024 1 0 0 1 0 1 1 0 8 0 dma256 256 6 0 6 1 1 0 1 0 8 0 dma128 128 253 0 253 1 1 0 1 0 8 0 dma64 64 6 0 6 1 1 0 1 0 8 0 dma32 32 7 0 7 1 1 0 1 0 8 0 dma16 16 18 0 17 1 0 1 1 0 8 0 aobjpl 72 200 0 70 3 0 3 3 0 8 0 uaddrrnd 24 27487 0 27458 1 0 1 1 0 8 0 uaddrbest 32 2 0 0 1 0 1 1 0 8 0 uaddr 24 27487 0 27458 1 0 1 1 0 8 0 vmmpekpl 168 192064 0 192016 3 0 3 3 0 8 0 vmmpepl 168 1459671 0 1457614 192 96 96 117 0 357 2 vmsppl 464 27486 0 27458 5 1 4 5 0 8 0 rwobjpl 56 303035 0 295746 104 0 104 104 0 8 0 pdppl 4096 54981 0 54916 1131 1062 69 81 0 8 4 pvpl 32 6684862 0 6671122 395 277 118 359 0 265 0 pmappl 248 27486 0 27458 3 1 2 3 0 8 0 extentpl 40 56 0 38 1 0 1 1 0 8 0 phpool 112 1923 0 1118 24 0 24 24 0 8 0 ddb{0}> machine ddbcpu 0 Invalid cpu 0 ddb{0}> trace witness_checkorder(fffffd806ef97010,9,0) at witness_checkorder+0x1ec sys/kern/subr_witness.c:794 mtx_enter(fffffd806ef97000) at mtx_enter+0x3e sys/kern/kern_lock.c:265 knote_remove(ffff80002129f2a0,fffffd806ef97000,fffffd806ef97088,3,0) at knote_remove+0x20d sys/kern/kern_event.c:1881 knote_fdclose(ffff80002129f2a0,3) at knote_fdclose+0xae sys/kern/kern_event.c:1934 fdfree(ffff80002129f2a0) at fdfree+0xdf sys/kern/kern_descrip.c:1196 exit1(ffff80002129f2a0,0,0,1) at exit1+0x3e4 sys/kern/kern_exit.c:206 sys_exit(ffff80002129f2a0,ffff800024721e70,ffff800024721ec0) at sys_exit+0x1a sys/kern/kern_exit.c:89 syscall(ffff800024721f40) at syscall+0x5e2 mi_syscall sys/sys/syscall_mi.h:110 [inline] syscall(ffff800024721f40) at syscall+0x5e2 sys/arch/amd64/amd64/trap.c:623 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0x707743a10e60, count: -9 ddb{0}> machine ddbcpu 1 Stopped at x86_ipi_db+0x1e: addq $0x8,%rsp x86_ipi_db(ffff800020d58ff0) at x86_ipi_db+0x1e sys/arch/amd64/amd64/db_interface.c:393 x86_ipi_handler() at x86_ipi_handler+0xb7 sys/arch/amd64/amd64/ipi.c:106 Xresume_lapic_ipi() at Xresume_lapic_ipi+0x27 __sanitizer_cov_trace_pc() at __sanitizer_cov_trace_pc+0x30 kd_curproc sys/dev/kcov.c:590 [inline] __sanitizer_cov_trace_pc() at __sanitizer_cov_trace_pc+0x30 sys/dev/kcov.c:158 __mp_lock(ffffffff82c85f30) at __mp_lock+0x133 __mp_lock_spin sys/kern/kern_lock.c:116 [inline] __mp_lock(ffffffff82c85f30) at __mp_lock+0x133 sys/kern/kern_lock.c:147 end trace frame: 0x0, count: 10 ddb{1}> trace x86_ipi_db(ffff800020d58ff0) at x86_ipi_db+0x1e sys/arch/amd64/amd64/db_interface.c:393 x86_ipi_handler() at x86_ipi_handler+0xb7 sys/arch/amd64/amd64/ipi.c:106 Xresume_lapic_ipi() at Xresume_lapic_ipi+0x27 __sanitizer_cov_trace_pc() at __sanitizer_cov_trace_pc+0x30 kd_curproc sys/dev/kcov.c:590 [inline] __sanitizer_cov_trace_pc() at __sanitizer_cov_trace_pc+0x30 sys/dev/kcov.c:158 __mp_lock(ffffffff82c85f30) at __mp_lock+0x133 __mp_lock_spin sys/kern/kern_lock.c:116 [inline] __mp_lock(ffffffff82c85f30) at __mp_lock+0x133 sys/kern/kern_lock.c:147 end trace frame: 0x0, count: -5