Profiling results ----------------- Total cpu time observed: 23182ms (out of 23736ms) Number of samples taken: 64 (once every 362ms) ===================================================================== Caller Idx Total Self Name+src Local% ms(pct) ms(pct) Callee ===================================================================== ??? [15] 100.0% [1] 23182(100.0%) 0(0.0%) profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0 run [4] 100.0% --------------------------------------------------------------------- hash-ref! [34] 100.0% [2] 1486(6.4%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:188:5 loop [28] 100.0% --------------------------------------------------------------------- ??? [15] 100.0% [3] 1016(4.4%) 0(0.0%) run-improve43 ...ie/develop/src/mainloop.rkt:362:0 for-loop [5] 66.9% simplify! [6] 33.1% --------------------------------------------------------------------- profile-thunk16 [1] 100.0% [4] 23182(100.0%) 0(0.0%) run ...et-7.0/share/pkgs/profile-lib/main.rkt:39:2 ??? [15] 100.0% --------------------------------------------------------------------- run-improve43 [3] 100.0% [5] 680(2.9%) 0(0.0%) for-loop .../herbie/develop/src/mainloop.rkt:377:4 run-iter! [7] 100.0% --------------------------------------------------------------------- run-improve43 [3] 100.0% [6] 336(1.4%) 0(0.0%) simplify! ...herbie/develop/src/mainloop.rkt:239:0 ??? [8] 100.0% --------------------------------------------------------------------- for-loop [5] 100.0% [7] 680(2.9%) 0(0.0%) run-iter! ...herbie/develop/src/mainloop.rkt:343:0 localize! [9] 100.0% --------------------------------------------------------------------- simplify! [6] 100.0% [8] 336(1.4%) 0(0.0%) ??? ...s/herbie/develop/src/core/simplify.rkt:29:0 loop [10] 100.0% --------------------------------------------------------------------- run-iter! [7] 100.0% [9] 680(2.9%) 0(0.0%) localize! ...herbie/develop/src/mainloop.rkt:138:0 localize-error [11] 100.0% --------------------------------------------------------------------- ??? [8] 100.0% [10] 336(1.4%) 0(0.0%) loop .../herbie/develop/src/core/simplify.rkt:43:2 one-iter [12] 100.0% --------------------------------------------------------------------- localize! [9] 100.0% [11] 680(2.9%) 0(0.0%) localize-error ...velop/src/core/localize.rkt:52:0 hash-ref! [34] 100.0% --------------------------------------------------------------------- loop [10] 100.0% [12] 336(1.4%) 0(0.0%) one-iter ...bie/develop/src/core/simplify.rkt:98:0 set-precompute! [13] 100.0% --------------------------------------------------------------------- one-iter [12] 100.0% [13] 336(1.4%) 0(0.0%) set-precompute! ...lop/src/core/simplify.rkt:103:0 for-loop [14] 100.0% --------------------------------------------------------------------- set-precompute! [13] 100.0% [14] 336(1.4%) 0(0.0%) for-loop ...ie/develop/src/core/simplify.rkt:106:2 ??? [15] 100.0% --------------------------------------------------------------------- for-loop [14] 0.5% run [4] 49.8% [15] 23182(100.0%) 0(0.0%) ??? ...lects/racket/private/more-scheme.rkt:261:28 profile-thunk16 [1] 49.8% loop [16] 23.6% errors [29] 8.2% eval-errors [17] 7.1% oracle-error [18] 5.8% get-final-combination [19] 3.2% run-improve43 [3] 1.9% ??? [43] 0.5% --------------------------------------------------------------------- ??? [15] 100.0% [16] 10928(47.1%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:315:2 loop [25] 65.4% loop [22] 21.0% make-exacts-halfpoints35 [23] 13.6% --------------------------------------------------------------------- ??? [15] 100.0% [17] 3284(14.2%) 0(0.0%) eval-errors ...herbie/develop/src/points.rkt:209:0 for-loop [20] 100.0% --------------------------------------------------------------------- ??? [15] 100.0% [18] 2694(11.6%) 0(0.0%) oracle-error ...erbie/develop/src/points.rkt:218:0 for-loop [21] 100.0% --------------------------------------------------------------------- ??? [15] 100.0% [19] 1462(6.3%) 0(0.0%) get-final-combination ...op/src/mainloop.rkt:383:0 argmins [24] 100.0% --------------------------------------------------------------------- eval-errors [17] 100.0% [20] 3284(14.2%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:211:2 ??? [43] 91.0% ??? [46] 9.0% --------------------------------------------------------------------- oracle-error [18] 100.0% [21] 2694(11.6%) 0(0.0%) for-loop ...es/herbie/develop/src/points.rkt:219:2 loop [28] 55.9% map [39] 44.1% --------------------------------------------------------------------- loop [16] 100.0% [22] 2294(9.9%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:270:2 loop [25] 59.7% make-exacts-walkup [26] 40.3% --------------------------------------------------------------------- loop [16] 100.0% [23] 1486(6.4%) 0(0.0%) make-exacts-halfpoints35 ...p/src/points.rkt:268:0 make-exacts-walkup [26] 100.0% --------------------------------------------------------------------- get-final-combination [19] 100.0% [24] 1462(6.3%) 0(0.0%) argmins ...lies/herbie/develop/src/common.rkt:93:0 ??? [27] 100.0% --------------------------------------------------------------------- loop [22] 16.1% loop [16] 83.9% [25] 8518(36.7%) 0(0.0%) loop ...htlies/herbie/develop/src/points.rkt:253:4 loop [28] 90.7% loop [31] 9.3% --------------------------------------------------------------------- loop [22] 38.3% make-exacts-halfpoints35 [23] 61.7% [26] 2410(10.4%) 0(0.0%) make-exacts-walkup ...develop/src/points.rkt:250:0 eval-prog [30] 61.7% loop [28] 38.3% --------------------------------------------------------------------- argmins [24] 100.0% [27] 1462(6.3%) 0(0.0%) ??? ...lies/herbie/develop/src/mainloop.rkt:126:19 errors [29] 100.0% --------------------------------------------------------------------- make-exacts-walkup [26] 0.0% loop [25] 0.1% parse-loop15 [36] 5.5% ??? [2] 12.1% for-loop [21] 12.2% loop [28] 70.0% [28] 12318(53.1%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:40:19 loop [28] 70.0% hash-ref! [34] 14.9% ??? [43] 10.0% map [39] 2.7% ??? [46] 2.4% composed [33] 0.0% ??? [48] 0.0% --------------------------------------------------------------------- ??? [27] 27.8% ??? [15] 72.2% [29] 5260(22.7%) 0(0.0%) errors ...lies/herbie/develop/src/points.rkt:234:0 for-loop [32] 100.0% --------------------------------------------------------------------- make-exacts-walkup [26] 100.0% [30] 1486(6.4%) 0(0.0%) eval-prog ...herbie/develop/src/programs.rkt:129:0 hash-ref! [34] 100.0% --------------------------------------------------------------------- loop [25] 100.0% [31] 796(3.4%) 796(3.4%) loop ...-7.0/collects/racket/private/map.rkt:277:4 --------------------------------------------------------------------- errors [29] 100.0% [32] 5260(22.7%) 318(1.4%) for-loop ...es/herbie/develop/src/points.rkt:236:2 ??? [43] 77.0% ??? [46] 11.3% point-error [38] 5.7% --------------------------------------------------------------------- loop [28] 100.0% [33] 2482(10.7%) 346(1.5%) composed ...ollects/racket/private/list.rkt:321:16 ??? [43] 86.1% --------------------------------------------------------------------- localize-error [11] 20.7% eval-prog [30] 22.9% loop [28] 56.4% [34] 2166(9.3%) 0(0.0%) hash-ref! .../racket/private/more-scheme.rkt:376:2 ??? [2] 45.7% parse-loop15 [36] 26.0% bigfloat-hash [35] 22.9% f9 [37] 5.4% --------------------------------------------------------------------- hash-ref! [34] 100.0% [35] 1486(6.4%) 0(0.0%) bigfloat-hash ...h/private/bigfloat/mpfr.rkt:167:0 bfcanonicalize [40] 100.0% --------------------------------------------------------------------- hash-ref! [34] 100.0% [36] 680(2.9%) 0(0.0%) parse-loop15 ...s/racket/match/compiler.rkt:418:15 loop [28] 100.0% --------------------------------------------------------------------- hash-ref! [34] 100.0% [37] 348(1.5%) 0(0.0%) f9 ....0/collects/racket/match/compiler.rkt:507:40 map [39] 100.0% --------------------------------------------------------------------- for-loop [32] 100.0% [38] 298(1.3%) 298(1.3%) point-error ...herbie/develop/src/points.rkt:201:0 --------------------------------------------------------------------- loop [28] 17.8% f9 [37] 18.6% for-loop [21] 63.6% [39] 1868(8.1%) 0(0.0%) map ...t-7.0/collects/racket/private/map.rkt:35:13 ??? [41] 63.6% loop [42] 18.6% ??? [46] 17.8% --------------------------------------------------------------------- bigfloat-hash [35] 100.0% [40] 1486(6.4%) 1486(6.4%) bfcanonicalize .../private/bigfloat/mpfr.rkt:157:0 --------------------------------------------------------------------- map [39] 100.0% [41] 1188(5.1%) 0(0.0%) ??? ...htlies/herbie/develop/src/points.rkt:220:26 ??? [43] 74.2% ??? [46] 25.8% --------------------------------------------------------------------- map [39] 11.1% loop [42] 88.9% [42] 348(1.5%) 0(0.0%) loop ...-7.0/collects/racket/private/map.rkt:54:19 loop [42] 88.9% ??? [44] 11.1% --------------------------------------------------------------------- ??? [15] 2.7% ??? [41] 7.1% loop [28] 16.0% composed [33] 17.3% for-loop [20] 24.1% for-loop [32] 32.7% [43] 12378(53.4%) 0(0.0%) ??? ...tlies/herbie/develop/src/programs.rkt:145:2 ??? [45] 78.1% ->bf [47] 14.5% ??? [46] 4.9% ??? [48] 2.4% --------------------------------------------------------------------- loop [42] 100.0% [44] 348(1.5%) 0(0.0%) ??? .../herbie/develop/src/core/localize.rkt:43:32 ??? [46] 100.0% --------------------------------------------------------------------- ??? [43] 100.0% [45] 9666(41.7%) 1508(6.5%) ??? ...t-7.0/collects/racket/private/kw.rkt:592:14 double->posit16 [49] 73.1% big-posit16-add [52] 7.3% big-posit16-mul [54] 4.0% --------------------------------------------------------------------- for-loop [20] 3.8% ??? [41] 3.9% map [39] 4.2% ??? [44] 4.4% for-loop [32] 7.5% ??? [43] 7.8% loop [28] 68.4% [46] 7872(34.0%) 332(1.4%) ??? ...tract/private/arrow-higher-order.rkt:357:33 double->posit16 [49] 52.3% ->flonum [50] 43.5% --------------------------------------------------------------------- ??? [43] 100.0% [47] 1800(7.8%) 402(1.7%) ->bf ...tlies/herbie/develop/src/programs.rkt:61:0 bf [51] 59.4% ??? [55] 18.2% --------------------------------------------------------------------- loop [28] 50.0% ??? [43] 50.0% [48] 600(2.6%) 0(0.0%) ??? ...ects/racket/contract/private/prop.rkt:519:4 ??? [53] 100.0% --------------------------------------------------------------------- ??? [46] 36.8% ??? [45] 63.2% [49] 11178(48.2%) 0(0.0%) double->posit16 ...ftposit-rkt/softposit.rkt:248:0 get-ffi-obj* [56] 100.0% --------------------------------------------------------------------- ??? [46] 100.0% [50] 3424(14.8%) 2484(10.7%) ->flonum ...s/herbie/develop/src/programs.rkt:37:0 ??? [59] 10.6% return/no-unsupplied [60] 8.6% keyword-apply [57] 8.2% --------------------------------------------------------------------- ->bf [47] 100.0% [51] 1070(4.6%) 354(1.5%) bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2 new-mpfr [66] 33.5% ??? [67] 33.5% --------------------------------------------------------------------- ??? [45] 100.0% [52] 708(3.1%) 0(0.0%) big-posit16-add .../src/syntax/softposit.rkt:108:0 ??? [62] 100.0% --------------------------------------------------------------------- ??? [48] 100.0% [53] 600(2.6%) 300(1.3%) ??? ...lects/racket/contract/private/orc.rkt:83:14 keyword-apply [57] 50.0% --------------------------------------------------------------------- ??? [45] 100.0% [54] 388(1.7%) 0(0.0%) big-posit16-mul .../src/syntax/softposit.rkt:110:0 bf* [58] 100.0% --------------------------------------------------------------------- ->bf [47] 100.0% [55] 328(1.4%) 328(1.4%) ??? ...-7.0/collects/racket/lazy-require.rkt:106:6 --------------------------------------------------------------------- double->posit16 [49] 100.0% [56] 11178(48.2%) 1602(6.9%) get-ffi-obj* ...-7.0/collects/ffi/unsafe.rkt:209:2 get-ffi-lib9 [61] 85.7% --------------------------------------------------------------------- ->flonum [50] 48.3% ??? [53] 51.7% [57] 580(2.5%) 580(2.5%) keyword-apply ...lects/racket/private/kw.rkt:421:2 --------------------------------------------------------------------- big-posit16-mul [54] 100.0% [58] 388(1.7%) 0(0.0%) bf* ...ath/private/bigfloat/bigfloat-mpfr.rkt:95:0 ??? [62] 100.0% --------------------------------------------------------------------- ->flonum [50] 100.0% [59] 364(1.6%) 364(1.6%) ??? ...ects/racket/contract/private/guts.rkt:746:8 --------------------------------------------------------------------- ->flonum [50] 100.0% [60] 296(1.3%) 296(1.3%) return/no-unsupplied ...ct/private/arr-i.rkt:534:0 --------------------------------------------------------------------- get-ffi-obj* [56] 100.0% [61] 9576(41.3%) 2978(12.8%) get-ffi-lib9 ...-7.0/collects/ffi/unsafe.rkt:121:0 get-cross-lib-search-dirs [63] 65.4% get-lib-search-dirs [65] 3.5% --------------------------------------------------------------------- bf* [58] 35.4% big-posit16-add [52] 64.6% [62] 1096(4.7%) 0(0.0%) ??? ...-racket/utils/simple-result-arrow.rkt:39:12 bfmul [64] 100.0% --------------------------------------------------------------------- get-ffi-lib9 [61] 100.0% [63] 6264(27.0%) 5936(25.6%) get-cross-lib-search-dirs ...rivate/dirs.rkt:168:7 ??? [68] 5.2% --------------------------------------------------------------------- ??? [62] 100.0% [64] 1096(4.7%) 0(0.0%) bfmul ...-lib/math/private/bigfloat/mpfr.rkt:821:4 new-mpfr [66] 68.1% ??? [67] 31.9% --------------------------------------------------------------------- get-ffi-lib9 [61] 100.0% [65] 334(1.4%) 334(1.4%) get-lib-search-dirs ...llects/setup/dirs.rkt:177:0 --------------------------------------------------------------------- bf [51] 32.4% bfmul [64] 67.6% [66] 1104(4.8%) 1104(4.8%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0 --------------------------------------------------------------------- bfmul [64] 49.4% bf [51] 50.6% [67] 708(3.1%) 708(3.1%) ??? /opt/racket-7.0/collects/ffi/unsafe.rkt:898:4 --------------------------------------------------------------------- get-cross-lib-search-dirs [63]100.0% [68] 328(1.4%) 328(1.4%) ??? ...racket-7.0/collects/racket/promise.rkt:42:2 ---------------------------------------------------------------------