Skip to content

Instantly share code, notes, and snippets.

@mattrberry
Created April 7, 2021 06:49
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save mattrberry/13f3e536bdac9d6102fc681f7f314c18 to your computer and use it in GitHub Desktop.
Save mattrberry/13f3e536bdac9d6102fc681f7f314c18 to your computer and use it in GitHub Desktop.
aw profiling
total executions of each stack trace:
Entry: 1/67 Calls: 187/1409 = 13.27% [sum: 187; 187/1409 = 13.27%]
system.nim: .. 865/1409 = 61.39%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 2/67 Calls: 159/1409 = 11.28% [sum: 346; 346/1409 = 24.56%]
system.nim: .. 865/1409 = 61.39%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 3/67 Calls: 145/1409 = 10.29% [sum: 491; 491/1409 = 34.85%]
system.nim: .. 865/1409 = 61.39%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 4/67 Calls: 143/1409 = 10.15% [sum: 634; 634/1409 = 45.00%]
system.nim: .. 865/1409 = 61.39%
bus.nim: read 266/1409 = 18.88%
cpu.nim: readInstr 214/1409 = 15.19%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 5/67 Calls: 114/1409 = 8.09% [sum: 748; 748/1409 = 53.09%]
system.nim: .. 865/1409 = 61.39%
arm.nim: immediateOffset 132/1409 = 9.37%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 6/67 Calls: 100/1409 = 7.10% [sum: 848; 848/1409 = 60.18%]
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 7/67 Calls: 43/1409 = 3.05% [sum: 891; 891/1409 = 63.24%]
system.nim: .. 865/1409 = 61.39%
arm.nim: branch 72/1409 = 5.11%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 8/67 Calls: 39/1409 = 2.77% [sum: 930; 930/1409 = 66.00%]
system.nim: .. 865/1409 = 61.39%
arm.nim: rotateRegister 47/1409 = 3.34%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 9/67 Calls: 37/1409 = 2.63% [sum: 967; 967/1409 = 68.63%]
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 10/67 Calls: 36/1409 = 2.56% [sum: 1003; 1003/1409 = 71.19%]
cpu.nim: readInstr 214/1409 = 15.19%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 11/67 Calls: 35/1409 = 2.48% [sum: 1038; 1038/1409 = 73.67%]
bus.nim: read 266/1409 = 18.88%
cpu.nim: readInstr 214/1409 = 15.19%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 12/67 Calls: 33/1409 = 2.34% [sum: 1071; 1071/1409 = 76.01%]
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 13/67 Calls: 32/1409 = 2.27% [sum: 1103; 1103/1409 = 78.28%]
cpu.nim: checkCond 32/1409 = 2.27%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 14/67 Calls: 29/1409 = 2.06% [sum: 1132; 1132/1409 = 80.34%]
bus.nim: newBus 30/1409 = 2.13%
gba.nim: newGBA 32/1409 = 2.27%
gba.nim: gba 1408/1409 = 99.93%
Entry: 15/67 Calls: 26/1409 = 1.85% [sum: 1158; 1158/1409 = 82.19%]
system.nim: .. 865/1409 = 61.39%
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 16/67 Calls: 23/1409 = 1.63% [sum: 1181; 1181/1409 = 83.82%]
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 17/67 Calls: 18/1409 = 1.28% [sum: 1199; 1199/1409 = 85.10%]
regs.nim: toU16 18/1409 = 1.28%
regs.nim: read 266/1409 = 18.88%
ppu.nim: [] 56/1409 = 3.97%
mmio.nim: [] 56/1409 = 3.97%
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 18/67 Calls: 16/1409 = 1.14% [sum: 1215; 1215/1409 = 86.23%]
regs.nim: read 266/1409 = 18.88%
ppu.nim: [] 56/1409 = 3.97%
mmio.nim: [] 56/1409 = 3.97%
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 19/67 Calls: 14/1409 = 0.99% [sum: 1229; 1229/1409 = 87.22%]
cpu.nim: setReg 45/1409 = 3.19%
arm.nim: branch 72/1409 = 5.11%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 20/67 Calls: 12/1409 = 0.85% [sum: 1241; 1241/1409 = 88.08%]
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 21/67 Calls: 12/1409 = 0.85% [sum: 1253; 1253/1409 = 88.93%]
cpu.nim: setReg 45/1409 = 3.19%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 22/67 Calls: 12/1409 = 0.85% [sum: 1265; 1265/1409 = 89.78%]
mmio.nim: [] 56/1409 = 3.97%
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 23/67 Calls: 11/1409 = 0.78% [sum: 1276; 1276/1409 = 90.56%]
cpu.nim: setReg 45/1409 = 3.19%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 24/67 Calls: 10/1409 = 0.71% [sum: 1286; 1286/1409 = 91.27%]
ppu.nim: [] 56/1409 = 3.97%
mmio.nim: [] 56/1409 = 3.97%
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 25/67 Calls: 10/1409 = 0.71% [sum: 1296; 1296/1409 = 91.98%]
cpu.nim: stepArm 20/1409 = 1.42%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 26/67 Calls: 10/1409 = 0.71% [sum: 1306; 1306/1409 = 92.69%]
arm.nim: immediateOffset 132/1409 = 9.37%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 27/67 Calls: 8/1409 = 0.57% [sum: 1314; 1314/1409 = 93.26%]
cpu.nim: stepArm 20/1409 = 1.42%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 28/67 Calls: 8/1409 = 0.57% [sum: 1322; 1322/1409 = 93.83%]
cpu.nim: ror 8/1409 = 0.57%
arm.nim: immediateOffset 132/1409 = 9.37%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 29/67 Calls: 8/1409 = 0.57% [sum: 1330; 1330/1409 = 94.39%]
ppu.nim: scanline 14/1409 = 0.99%
ppu.nim: :anonymous 26/1409 = 1.85%
scheduler.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 30/67 Calls: 8/1409 = 0.57% [sum: 1338; 1338/1409 = 94.96%]
cpu.nim: clearPipeline 8/1409 = 0.57%
cpu.nim: setReg 45/1409 = 3.19%
arm.nim: branch 72/1409 = 5.11%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 31/67 Calls: 7/1409 = 0.50% [sum: 1345; 1345/1409 = 95.46%]
arm.nim: branch 72/1409 = 5.11%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 32/67 Calls: 6/1409 = 0.43% [sum: 1351; 1351/1409 = 95.88%]
ppu.nim: getLine 6/1409 = 0.43%
ppu.nim: scanline 14/1409 = 0.99%
ppu.nim: :anonymous 26/1409 = 1.85%
scheduler.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 33/67 Calls: 5/1409 = 0.35% [sum: 1356; 1356/1409 = 96.24%]
bus.nim: read 266/1409 = 18.88%
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 34/67 Calls: 5/1409 = 0.35% [sum: 1361; 1361/1409 = 96.59%]
bus.nim: readRotate 92/1409 = 6.53%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 35/67 Calls: 4/1409 = 0.28% [sum: 1365; 1365/1409 = 96.88%]
cpu.nim: setNegAndZeroFlags 5/1409 = 0.35%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 36/67 Calls: 4/1409 = 0.28% [sum: 1369; 1369/1409 = 97.16%]
arm.nim: rotateRegister 47/1409 = 3.34%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 37/67 Calls: 3/1409 = 0.21% [sum: 1372; 1372/1409 = 97.37%]
system.nim: .. 865/1409 = 61.39%
arm.nim: single_data_transfer 5/1409 = 0.35%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 38/67 Calls: 3/1409 = 0.21% [sum: 1375; 1375/1409 = 97.59%]
bus.nim: []= 6/1409 = 0.43%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 39/67 Calls: 3/1409 = 0.21% [sum: 1378; 1378/1409 = 97.80%]
system.nim: .. 865/1409 = 61.39%
bus.nim: []= 6/1409 = 0.43%
arm.nim: halfword_data_transfer 288/1409 = 20.44%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 40/67 Calls: 2/1409 = 0.14% [sum: 1380; 1380/1409 = 97.94%]
cpu.nim: stepArm 20/1409 = 1.42%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 41/67 Calls: 2/1409 = 0.14% [sum: 1382; 1382/1409 = 98.08%]
cpu.nim: shift 4/1409 = 0.28%
arm.nim: rotateRegister 47/1409 = 3.34%
arm.nim: dataProcessing 416/1409 = 29.52%
arm.nim: execArm 993/1409 = 70.48%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Entry: 42/67 Calls: 2/1409 = 0.14% [sum: 1384; 1384/1409 = 98.23%]
thumb.nim: multipleLoadStore 3/1409 = 0.21%
thumb.nim: execThumb 5/1409 = 0.35%
cpu.nim: tick 1339/1409 = 95.03%
gba.nim: runFrame 1376/1409 = 97.66%
gba.nim: loop 1376/1409 = 97.66%
gba.nim: gba 1408/1409 = 99.93%
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment