Profiling results
-----------------
  Total cpu time observed: 1348ms (out of 1672ms)
  Number of samples taken: 5 (once every 270ms)

=================================================================
                               Caller
 Idx   Total       Self      Name+src                      Local%
       ms(pct)     ms(pct)     Callee
=================================================================
                               ??? [3]                     100.0%
 [1] 1348(100.0%)   0(0.0%)  profile-thunk16 ...e/pkgs/profile-lib/main.rkt:9:0
                               run [2]                     100.0%
-----------------------------------------------------------------
                               profile-thunk16 [1]         100.0%
 [2] 1348(100.0%)   0(0.0%)  run ...et-7.2/share/pkgs/profile-lib/main.rkt:39:2
                               ??? [3]                     100.0%
-----------------------------------------------------------------
                               run [2]                      50.0%
 [3] 1348(100.0%)   0(0.0%)  ??? ...lects/racket/private/more-scheme.rkt:261:28
                               profile-thunk16 [1]          50.0%
                               run-improve47 [4]            50.0%
-----------------------------------------------------------------
                               ??? [3]                     100.0%
 [4] 1348(100.0%)   0(0.0%)  run-improve47 ...mplify-bug/src/mainloop.rkt:345:0
                               prepare-points-intervals [5]100.0%
-----------------------------------------------------------------
                               run-improve47 [4]           100.0%
 [5] 1348(100.0%)   0(0.0%)  prepare-points-intervals ...g/src/points.rkt:110:0
                               loop [6]                    100.0%
-----------------------------------------------------------------
                               prepare-points-intervals [5]100.0%
 [6] 1348(100.0%)   0(0.0%)  loop ...s/herbie/simplify-bug/src/points.rkt:123:4
                               loop [7]                    100.0%
-----------------------------------------------------------------
                               loop [6]                    100.0%
 [7] 1348(100.0%)   0(0.0%)  loop ...es/herbie/simplify-bug/src/points.rkt:81:2
                               ??? [8]                     100.0%
-----------------------------------------------------------------
                               loop [7]                    100.0%
 [8] 1348(100.0%)   0(0.0%)  ??? .../herbie/simplify-bug/src/programs.rkt:115:2
                               ??? [9]                      80.6%
                               ??? [10]                     19.4%
-----------------------------------------------------------------
                               ??? [8]                     100.0%
 [9] 1086(80.6%)    0(0.0%)  ??? ...t-7.2/collects/racket/private/kw.rkt:594:14
                               ??? [11]                    100.0%
-----------------------------------------------------------------
                               ??? [8]                     100.0%
[10]  262(19.4%)    0(0.0%)  ??? ...tract/private/arrow-higher-order.rkt:360:33
                               mk-ival [12]                100.0%
-----------------------------------------------------------------
                               ??? [9]                     100.0%
[11] 1086(80.6%)    0(0.0%)  ??? ...tract/private/arrow-higher-order.rkt:364:33
                               ival-sqrt [13]               76.8%
                               ival-sub [15]                23.2%
-----------------------------------------------------------------
                               ??? [10]                    100.0%
[12]  262(19.4%)    0(0.0%)  mk-ival ...e/simplify-bug/src/biginterval.rkt:57:0
                               bf [14]                     100.0%
-----------------------------------------------------------------
                               ??? [11]                    100.0%
[13]  834(61.9%)  280(20.8%) ival-sqrt ...implify-bug/src/biginterval.rkt:197:0
                               bfsqrt [16]                  66.4%
-----------------------------------------------------------------
                               mk-ival [12]                100.0%
[14]  262(19.4%)    0(0.0%)  bf ...ath-lib/math/private/bigfloat/mpfr.rkt:601:2
                               new-mpfr [18]               100.0%
-----------------------------------------------------------------
                               ??? [11]                    100.0%
[15]  252(18.7%)    0(0.0%)  ival-sub .../simplify-bug/src/biginterval.rkt:99:0
                               bfsub [17]                  100.0%
-----------------------------------------------------------------
                               ival-sqrt [13]              100.0%
[16]  554(41.1%)    0(0.0%)  bfsqrt ...lib/math/private/bigfloat/mpfr.rkt:618:4
                               ??? [19]                     50.2%
                               new-mpfr [18]                49.8%
-----------------------------------------------------------------
                               ival-sub [15]               100.0%
[17]  252(18.7%)    0(0.0%)  bfsub ...-lib/math/private/bigfloat/mpfr.rkt:821:4
                               ??? [19]                    100.0%
-----------------------------------------------------------------
                               bf [14]                      48.7%
                               bfsqrt [16]                  51.3%
[18]  538(39.9%)  538(39.9%) new-mpfr ...b/math/private/bigfloat/mpfr.rkt:335:0
-----------------------------------------------------------------
                               bfsub [17]                   47.5%
                               bfsqrt [16]                  52.5%
[19]  530(39.3%)  530(39.3%) ??? /opt/racket-7.2/collects/ffi/unsafe.rkt:905:4
-----------------------------------------------------------------