Profiling results ----------------- Total cpu time observed: 3246ms (out of 3396ms) Number of samples taken: 18 (once every 180ms) ==================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ==================================================================== [1] 3246(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [8] 100.0% -------------------------------------------------------------------- hash-ref! [63] 100.0% [2] 486(15.0%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:67:15 hash-ref! [63] 66.7% ??? [57] 33.3% -------------------------------------------------------------------- hash-ref! [63] 42.4% map [29] 57.6% [3] 486(15.0%) 0(0.0%) f40 (unknown source) map [29] 100.0% -------------------------------------------------------------------- ??? [57] 100.0% [4] 486(15.0%) 0(0.0%) approximate9 ...ie/master/src/core/taylor.rkt:11:0 loop [9] 100.0% -------------------------------------------------------------------- hash-ref! [63] 100.0% [5] 486(15.0%) 0(0.0%) ??? ...es/herbie/master/src/core/taylor.rkt:290:26 for-loop [10] 100.0% -------------------------------------------------------------------- loop [31] 100.0% [6] 264(8.1%) 0(0.0%) expand-capturing-lifts (unknown source) dispatch-transformer41 [12] 100.0% -------------------------------------------------------------------- map [29] 100.0% [7] 264(8.1%) 0(0.0%) parse-loop74 (unknown source) eval-const-expr [11] 100.0% -------------------------------------------------------------------- ??? [1] 100.0% [8] 3246(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [13] 100.0% -------------------------------------------------------------------- approximate9 [4] 100.0% [9] 486(15.0%) 0(0.0%) loop ...ies/herbie/master/src/core/taylor.rkt:86:4 hash-ref! [63] 100.0% -------------------------------------------------------------------- ??? [5] 100.0% [10] 486(15.0%) 0(0.0%) for-loop ...rbie/master/src/core/taylor.rkt:290:52 hash-ref! [63] 100.0% -------------------------------------------------------------------- parse-loop74 [7] 100.0% [11] 264(8.1%) 0(0.0%) eval-const-expr ...e/master/src/programs.rkt:144:0 loop [31] 100.0% -------------------------------------------------------------------- expand-capturing-lifts [6] 100.0% [12] 264(8.1%) 0(0.0%) dispatch-transformer41 (unknown source) apply-transformer52 [14] 100.0% -------------------------------------------------------------------- profile-thunk16 [8] 100.0% [13] 3246(100.0%) 0(0.0%) run ...et-7.5/share/pkgs/profile-lib/main.rkt:39:2 .../more-scheme.rkt:261:28 [15]100.0% -------------------------------------------------------------------- dispatch-transformer41 [12] 100.0% [14] 264(8.1%) 0(0.0%) apply-transformer52 (unknown source) loop [31] 100.0% -------------------------------------------------------------------- for-loop [24] 2.4% run [13] 97.6% [15] 3246(100.0%) 156(4.8%) .../more-scheme.rkt:261:28 (unknown source) prepare-points-intervals [16] 46.5% run-improve47 [17] 28.3% get-final-combination [18] 10.8% errors [19] 7.2% oracle-error [20] 4.8% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [16] 1510(46.5%) 0(0.0%) prepare-points-intervals ...r/src/points.rkt:122:0 loop [21] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [17] 918(28.3%) 0(0.0%) run-improve47 ...bie/master/src/mainloop.rkt:364:0 for-loop [22] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [18] 350(10.8%) 0(0.0%) get-final-combination ...er/src/mainloop.rkt:389:0 infer-splitpoints [23] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [19] 312(9.6%) 0(0.0%) errors ...tlies/herbie/master/src/points.rkt:192:0 for-loop [24] 100.0% -------------------------------------------------------------------- .../more-scheme.rkt:261:28 [15]100.0% [20] 156(4.8%) 0(0.0%) oracle-error ...herbie/master/src/points.rkt:179:0 for-loop [25] 100.0% -------------------------------------------------------------------- prepare-points-intervals [16] 100.0% [21] 1510(46.5%) 160(4.9%) loop ...ghtlies/herbie/master/src/points.rkt:134:4 ??? [27] 45.3% loop [28] 44.1% -------------------------------------------------------------------- run-improve47 [17] 100.0% [22] 918(28.3%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:383:4 run-iter! [26] 100.0% -------------------------------------------------------------------- get-final-combination [18] 100.0% [23] 350(10.8%) 0(0.0%) infer-splitpoints ...ter/src/core/regimes.rkt:33:0 for-loop [30] 100.0% -------------------------------------------------------------------- errors [19] 100.0% [24] 312(9.6%) 156(4.8%) for-loop ...ies/herbie/master/src/points.rkt:194:2 .../more-scheme.rkt:261:28 [15] 50.0% -------------------------------------------------------------------- oracle-error [20] 100.0% [25] 156(4.8%) 0(0.0%) for-loop ...ies/herbie/master/src/points.rkt:180:2 map [29] 100.0% -------------------------------------------------------------------- for-loop [22] 100.0% [26] 918(28.3%) 0(0.0%) run-iter! .../herbie/master/src/mainloop.rkt:345:0 gen-series! [32] 52.9% simplify! [33] 47.1% -------------------------------------------------------------------- loop [21] 100.0% [27] 684(21.1%) 0(0.0%) ??? ...ightlies/herbie/master/src/points.rkt:115:6 loop [31] 100.0% -------------------------------------------------------------------- loop [21] 100.0% [28] 666(20.5%) 0(0.0%) loop ...ightlies/herbie/master/src/points.rkt:79:2 real->precision [35] 48.0% ??? [57] 27.6% ??? [37] 24.3% -------------------------------------------------------------------- for-loop [25] 24.3% f40 [3] 75.7% [29] 642(19.8%) 0(0.0%) map ...t-7.5/collects/racket/private/map.rkt:35:13 f40 [3] 43.6% ??? [38] 24.3% parse-loop74 [7] 20.6% simplify* [36] 11.5% -------------------------------------------------------------------- infer-splitpoints [23] 100.0% [30] 350(10.8%) 0(0.0%) for-loop ...erbie/master/src/core/regimes.rkt:45:6 option-on-expr [34] 100.0% -------------------------------------------------------------------- apply-transformer52 [14] 13.9% eval-const-expr [11] 13.9% ??? [27] 72.2% [31] 948(29.2%) 324(10.0%) loop (unknown source) sample-multi-bounded [41] 38.0% expand-capturing-lifts [6] 13.9% core-form-sym [42] 13.9% -------------------------------------------------------------------- run-iter! [26] 100.0% [32] 486(15.0%) 0(0.0%) gen-series! ...erbie/master/src/mainloop.rkt:159:0 for-loop [39] 100.0% -------------------------------------------------------------------- run-iter! [26] 100.0% [33] 432(13.3%) 0(0.0%) simplify! .../herbie/master/src/mainloop.rkt:223:0 ??? [40] 100.0% -------------------------------------------------------------------- for-loop [30] 100.0% [34] 350(10.8%) 0(0.0%) option-on-expr ...aster/src/core/regimes.rkt:124:0 sort-context-on-expr [43] 52.0% err-lsts->split-indices [44] 48.0% -------------------------------------------------------------------- loop [28] 100.0% [35] 320(9.9%) 0(0.0%) real->precision .../master/src/programs.rkt:118:11 ??? [57] 100.0% -------------------------------------------------------------------- map [29] 100.0% [36] 222(6.8%) 222(6.8%) simplify* ...erbie/master/src/core/reduce.rkt:28:0 -------------------------------------------------------------------- loop [28] 100.0% [37] 162(5.0%) 162(5.0%) ??? ...contract/private/arrow-val-first.rkt:486:18 -------------------------------------------------------------------- map [29] 100.0% [38] 156(4.8%) 0(0.0%) ??? ...ghtlies/herbie/master/src/points.rkt:181:26 ??? [57] 100.0% -------------------------------------------------------------------- gen-series! [32] 100.0% [39] 486(15.0%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:166:7 taylor-alt [45] 100.0% -------------------------------------------------------------------- simplify! [33] 100.0% [40] 432(13.3%) 0(0.0%) ??? ...es/herbie/master/src/core/simplify.rkt:42:0 egraph-run [46] 100.0% -------------------------------------------------------------------- loop [31] 100.0% [41] 360(11.1%) 0(0.0%) sample-multi-bounded ...master/src/points.rkt:14:0 random-ranges [47] 100.0% -------------------------------------------------------------------- loop [31] 100.0% [42] 264(8.1%) 0(0.0%) core-form-sym (unknown source) resolve+shift28 [48] 100.0% -------------------------------------------------------------------- option-on-expr [34] 100.0% [43] 182(5.6%) 0(0.0%) sort-context-on-expr ...src/core/regimes.rkt:117:0 ??? [49] 100.0% -------------------------------------------------------------------- option-on-expr [34] 100.0% [44] 168(5.2%) 0(0.0%) err-lsts->split-indices .../core/regimes.rkt:263:0 loop [50] 100.0% -------------------------------------------------------------------- for-loop [39] 100.0% [45] 486(15.0%) 0(0.0%) taylor-alt ...herbie/master/src/mainloop.rkt:145:0 for-loop [51] 100.0% -------------------------------------------------------------------- ??? [40] 100.0% [46] 432(13.3%) 0(0.0%) egraph-run .../pkgs/egg-herbie-linux/main.rkt:49:0 egraph-add-exprs [52] 100.0% -------------------------------------------------------------------- sample-multi-bounded [41] 100.0% [47] 360(11.1%) 184(5.7%) random-ranges ...erbie/master/src/common.rkt:164:0 build--> [55] 48.9% -------------------------------------------------------------------- core-form-sym [42] 100.0% [48] 264(8.1%) 0(0.0%) resolve+shift28 (unknown source) fallback-loop [53] 100.0% -------------------------------------------------------------------- sort-context-on-expr [43] 100.0% [49] 182(5.6%) 0(0.0%) ??? ...-7.5/collects/racket/private/sort.rkt:369:3 generic-sort/key [54] 100.0% -------------------------------------------------------------------- err-lsts->split-indices [44] 100.0% [50] 168(5.2%) 0(0.0%) loop ...s/herbie/master/src/core/regimes.rkt:314:4 for-loop [56] 100.0% -------------------------------------------------------------------- taylor-alt [45] 100.0% [51] 486(15.0%) 0(0.0%) for-loop ...s/herbie/master/src/mainloop.rkt:151:6 ??? [57] 100.0% -------------------------------------------------------------------- egraph-run [46] 100.0% [52] 432(13.3%) 0(0.0%) egraph-add-exprs ...gg-herbie-linux/main.rkt:111:0 ??? [58] 100.0% -------------------------------------------------------------------- resolve+shift28 [48] 100.0% [53] 264(8.1%) 0(0.0%) fallback-loop (unknown source) for-loop [59] 100.0% -------------------------------------------------------------------- ??? [49] 100.0% [54] 182(5.6%) 0(0.0%) generic-sort/key .../racket/private/sort.rkt:156:2 copying-mergesort [60] 100.0% -------------------------------------------------------------------- random-ranges [47] 100.0% [55] 176(5.4%) 0(0.0%) build--> ...act/private/arrow-val-first.rkt:1214:0 coerce-contract [61] 100.0% -------------------------------------------------------------------- loop [50] 100.0% [56] 168(5.2%) 168(5.2%) for-loop ...rbie/master/src/core/regimes.rkt:279:4 -------------------------------------------------------------------- ??? [38] 13.6% ??? [2] 14.1% location-do [62] 14.1% for-loop [51] 14.1% loop [28] 16.1% real->precision [35] 27.9% [57] 1146(35.3%) 324(10.0%) ??? ...tract/private/arrow-higher-order.rkt:375:33 ival-mult [65] 16.1% location-do [62] 14.1% approximate9 [4] 14.1% hash-ref! [63] 14.1% bf [68] 13.3% -------------------------------------------------------------------- egraph-add-exprs [52] 100.0% [58] 432(13.3%) 0(0.0%) ??? ...s/herbie/master/src/core/simplify.rkt:103:6 for-loop [64] 100.0% -------------------------------------------------------------------- fallback-loop [53] 100.0% [59] 264(8.1%) 264(8.1%) for-loop (unknown source) -------------------------------------------------------------------- generic-sort/key [54] 33.3% copying-mergesort [60] 66.7% [60] 182(5.6%) 0(0.0%) copying-mergesort ...racket/private/sort.rkt:129:8 copying-mergesort [60] 66.7% jloop [66] 33.3% -------------------------------------------------------------------- build--> [55] 100.0% [61] 176(5.4%) 0(0.0%) coerce-contract ...contract/private/guts.rkt:307:0 coerce-contract/f [67] 100.0% -------------------------------------------------------------------- ??? [57] 100.0% [62] 486(15.0%) 0(0.0%) location-do ...herbie/master/src/programs.rkt:87:0 ??? [57] 100.0% -------------------------------------------------------------------- for-loop [10] 16.7% ??? [69] 16.7% ??? [57] 16.7% loop [9] 16.7% ??? [2] 33.3% [63] 486(15.0%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 50.0% ??? [69] 16.7% ??? [5] 16.7% f40 [3] 16.7% -------------------------------------------------------------------- ??? [58] 100.0% [64] 432(13.3%) 432(13.3%) for-loop ...bie/master/src/core/simplify.rkt:121:2 -------------------------------------------------------------------- ??? [57] 100.0% [65] 184(5.7%) 0(0.0%) ival-mult ...rbie/master/src/biginterval.rkt:129:0 bfmul [70] 100.0% -------------------------------------------------------------------- copying-mergesort [60] 100.0% [66] 182(5.6%) 0(0.0%) jloop ...5/collects/racket/private/sort.rkt:120:23 ??? [71] 100.0% -------------------------------------------------------------------- coerce-contract [61] 100.0% [67] 176(5.4%) 0(0.0%) coerce-contract/f ...ntract/private/guts.rkt:372:0 coerce-simple-value [72] 100.0% -------------------------------------------------------------------- ??? [57] 100.0% [68] 152(4.7%) 0(0.0%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:615:2 ??? [73] 100.0% -------------------------------------------------------------------- hash-ref! [63] 100.0% [69] 486(15.0%) 0(0.0%) ??? ...ies/herbie/master/src/core/taylor.rkt:44:15 hash-ref! [63] 100.0% -------------------------------------------------------------------- ival-mult [65] 100.0% [70] 184(5.7%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:835:4 ??? [73] 100.0% -------------------------------------------------------------------- jloop [66] 100.0% [71] 182(5.6%) 182(5.6%) ??? ...ects/racket/contract/private/guts.rkt:770:8 -------------------------------------------------------------------- coerce-contract/f [67] 100.0% [72] 176(5.4%) 176(5.4%) coerce-simple-value ...ract/private/guts.rkt:385:0 -------------------------------------------------------------------- bf [68] 45.2% bfmul [70] 54.8% [73] 336(10.4%) 336(10.4%) ??? /opt/racket-7.5/collects/ffi/unsafe.rkt:938:4 --------------------------------------------------------------------