Profiling results ----------------- Total cpu time observed: 2728ms (out of 2920ms) Number of samples taken: 16 (once every 170ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 2728(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [3] 100.0% -------------------------------------------------------------------- matcher [45] 100.0% [2] 184(6.7%) 0(0.0%) ??? ...erbie/faster-rr/src/core/matcher.rkt:131:11 for-loop [4] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [3] 2728(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [5] 100.0% -------------------------------------------------------------------- ??? [2] 100.0% [4] 184(6.7%) 0(0.0%) for-loop .../faster-rr/src/core/matcher.rkt:133:15 hash-ref! [42] 100.0% -------------------------------------------------------------------- profile-thunk16 [3] 100.0% [5] 2728(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [6] 100.0% -------------------------------------------------------------------- for-loop [40] 6.0% run [5] 94.0% [6] 2728(100.0%) 0(0.0%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [7] 63.1% run-improve47 [8] 16.2% errors [37] 8.7% ??? [9] 6.0% oracle-error [10] 5.9% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [7] 1722(63.1%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:120:0 loop [11] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [8] 524(19.2%) 0(0.0%) run-improve47 .../faster-rr/src/mainloop.rkt:346:0 for-loop [12] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [9] 330(12.1%) 330(12.1%) ??? ...tract/private/arrow-higher-order.rkt:375:33 -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [6] 100.0% [10] 162(5.9%) 0(0.0%) oracle-error ...bie/faster-rr/src/points.rkt:177:0 for-loop [13] 100.0% -------------------------------------------------------------------- prepare-points-intervals [7] 100.0% [11] 1722(63.1%) 178(6.5%) loop ...lies/herbie/faster-rr/src/points.rkt:132:4 loop [14] 80.1% ??? [16] 9.5% -------------------------------------------------------------------- run-improve47 [8] 100.0% [12] 524(19.2%) 0(0.0%) for-loop ...erbie/faster-rr/src/mainloop.rkt:365:4 run-iter! [15] 100.0% -------------------------------------------------------------------- oracle-error [10] 100.0% [13] 162(5.9%) 0(0.0%) for-loop .../herbie/faster-rr/src/points.rkt:178:2 map [17] 100.0% -------------------------------------------------------------------- loop [11] 100.0% [14] 1380(50.6%) 698(25.6%) loop ...tlies/herbie/faster-rr/src/points.rkt:79:2 ??? [18] 49.4% -------------------------------------------------------------------- for-loop [12] 100.0% [15] 524(19.2%) 0(0.0%) run-iter! ...rbie/faster-rr/src/mainloop.rkt:327:0 gen-rewrites! [19] 35.1% simplify! [20] 34.0% finalize-iter! [22] 30.9% -------------------------------------------------------------------- loop [11] 100.0% [16] 164(6.0%) 164(6.0%) ??? ...tlies/herbie/faster-rr/src/points.rkt:113:6 -------------------------------------------------------------------- for-loop [13] 100.0% [17] 162(5.9%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 ??? [21] 100.0% -------------------------------------------------------------------- loop [14] 100.0% [18] 682(25.0%) 0(0.0%) ??? ...tract/private/arrow-higher-order.rkt:379:33 ival-div [23] 52.2% ival-sub [26] 24.6% ival-add [28] 23.2% -------------------------------------------------------------------- run-iter! [15] 100.0% [19] 184(6.7%) 0(0.0%) gen-rewrites! .../faster-rr/src/mainloop.rkt:183:0 for-loop [24] 100.0% -------------------------------------------------------------------- run-iter! [15] 100.0% [20] 178(6.5%) 0(0.0%) simplify! ...rbie/faster-rr/src/mainloop.rkt:224:0 ??? [25] 100.0% -------------------------------------------------------------------- map [17] 100.0% [21] 162(5.9%) 162(5.9%) ??? ...lies/herbie/faster-rr/src/points.rkt:179:26 -------------------------------------------------------------------- run-iter! [15] 100.0% [22] 162(5.9%) 0(0.0%) finalize-iter! ...faster-rr/src/mainloop.rkt:278:0 ??? [27] 100.0% -------------------------------------------------------------------- ??? [18] 100.0% [23] 356(13.0%) 356(13.0%) ival-div ...ie/faster-rr/src/biginterval.rkt:156:0 -------------------------------------------------------------------- gen-rewrites! [19] 100.0% [24] 184(6.7%) 0(0.0%) for-loop ...rbie/faster-rr/src/mainloop.rkt:191:11 rewrite-expression-head24 [29] 100.0% -------------------------------------------------------------------- simplify! [20] 100.0% [25] 178(6.5%) 0(0.0%) ??? ...herbie/faster-rr/src/core/simplify.rkt:42:0 egraph-run [30] 100.0% -------------------------------------------------------------------- ??? [18] 100.0% [26] 168(6.2%) 0(0.0%) ival-sub ...ie/faster-rr/src/biginterval.rkt:108:0 bfsub [31] 100.0% -------------------------------------------------------------------- finalize-iter! [22] 100.0% [27] 162(5.9%) 0(0.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 for-loop [32] 100.0% -------------------------------------------------------------------- ??? [18] 100.0% [28] 158(5.8%) 158(5.8%) ival-add ...ie/faster-rr/src/biginterval.rkt:102:0 -------------------------------------------------------------------- for-loop [24] 100.0% [29] 184(6.7%) 0(0.0%) rewrite-expression-head24 ...core/matcher.rkt:85:0 rewriter [33] 100.0% -------------------------------------------------------------------- ??? [25] 100.0% [30] 178(6.5%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [34] 100.0% -------------------------------------------------------------------- ival-sub [26] 100.0% [31] 168(6.2%) 0(0.0%) bfsub ...-lib/math/private/bigfloat/mpfr.rkt:835:4 new-mpfr [35] 100.0% -------------------------------------------------------------------- ??? [27] 100.0% [32] 162(5.9%) 0(0.0%) for-loop .../faster-rr/src/core/alt-table.rkt:46:2 atab-add-altn [36] 100.0% -------------------------------------------------------------------- rewrite-expression-head24 [29] 25.0% matcher [45] 75.0% [33] 184(6.7%) 0(0.0%) rewriter ...ie/faster-rr/src/core/matcher.rkt:87:2 for-loop [38] 100.0% -------------------------------------------------------------------- egraph-run [30] 100.0% [34] 178(6.5%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [39] 100.0% -------------------------------------------------------------------- bfsub [31] 100.0% [35] 168(6.2%) 168(6.2%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:348:0 -------------------------------------------------------------------- for-loop [32] 100.0% [36] 162(5.9%) 0(0.0%) atab-add-altn ...r-rr/src/core/alt-table.rkt:194:0 errors [37] 100.0% -------------------------------------------------------------------- atab-add-altn [36] 33.6% .../more-scheme.rkt:261:28 [6] 66.4% [37] 482(17.7%) 0(0.0%) errors ...es/herbie/faster-rr/src/points.rkt:190:0 for-loop [40] 100.0% -------------------------------------------------------------------- rewriter [33] 100.0% [38] 184(6.7%) 0(0.0%) for-loop ...ie/faster-rr/src/core/matcher.rkt:89:4 hash-ref! [42] 75.0% for-loop [41] 25.0% -------------------------------------------------------------------- egraph-add-exprs [34] 100.0% [39] 178(6.5%) 0(0.0%) ??? ...erbie/faster-rr/src/core/simplify.rkt:102:6 egg-run-rules [43] 100.0% -------------------------------------------------------------------- errors [37] 100.0% [40] 482(17.7%) 152(5.6%) for-loop .../herbie/faster-rr/src/points.rkt:192:2 .../more-scheme.rkt:261:28 [6] 68.5% -------------------------------------------------------------------- for-loop [38] 100.0% [41] 184(6.7%) 0(0.0%) for-loop ...ie/faster-rr/src/core/matcher.rkt:96:8 fix-up-variables [44] 100.0% -------------------------------------------------------------------- for-loop [4] 50.0% for-loop [38] 50.0% [42] 184(6.7%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 matcher [45] 100.0% -------------------------------------------------------------------- ??? [39] 100.0% [43] 178(6.5%) 178(6.5%) egg-run-rules ...er-rr/src/core/simplify.rkt:108:0 -------------------------------------------------------------------- for-loop [41] 100.0% [44] 184(6.7%) 0(0.0%) fix-up-variables ...-rr/src/core/matcher.rkt:108:2 pattern-match [46] 100.0% -------------------------------------------------------------------- hash-ref! [42] 100.0% [45] 184(6.7%) 0(0.0%) matcher ...ie/faster-rr/src/core/matcher.rkt:119:2 ??? [2] 50.0% rewriter [33] 50.0% -------------------------------------------------------------------- fix-up-variables [44] 100.0% [46] 184(6.7%) 0(0.0%) pattern-match ...ster-rr/src/core/matcher.rkt:29:0 for-loop [47] 100.0% -------------------------------------------------------------------- pattern-match [46] 100.0% [47] 184(6.7%) 0(0.0%) for-loop ...ie/faster-rr/src/core/matcher.rkt:26:9 core457 [48] 100.0% -------------------------------------------------------------------- for-loop [47] 100.0% [48] 184(6.7%) 0(0.0%) core457 ...acket/contract/private/arr-i.rkt:976:19 build-unary-very-simple--> [49]100.0% -------------------------------------------------------------------- core457 [48] 100.0% [49] 184(6.7%) 0(0.0%) build-unary-very-simple--> ...val-first.rkt:1150:0 chaperone-contract? [50] 100.0% -------------------------------------------------------------------- build-unary-very-simple--> [49]100.0% [50] 184(6.7%) 184(6.7%) chaperone-contract? ...ract/private/guts.rkt:135:0 --------------------------------------------------------------------