__step=000077
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 numactl -i all /usr/bin/time -f "[time_cmd_output] time_elapsed_sec=%e, faults_major=%F, faults_minor=%R, mem_maxresident_kb=%M, user_cputime=%U, sys_cputime=%S, percent_cpu=%P" ./brown_sigouin_int_avl_tm_auto.debra.hytm1 -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000077.txt
__path_data=data/data000077.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6993909.532133800
binary=./brown_sigouin_int_avl_tm_auto.debra.hytm1
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_sigouin_int_avl_tm_auto
FIND_FUNC=FIND_FUNC
INSERT_FUNC=insertIfAbsent
ERASE_FUNC=ERASE_FUNC
RQ_FUNC=RQ_FUNC
RECLAIM=reclaimer_debra
ALLOC=allocator_new
POOL=pool_none
MAX_THREADS_POW2=512
CPU_FREQ_GHZ=2.1
MILLIS_TO_RUN=10000
INS_FRAC=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=48
ACTUAL_THREAD_BINDINGS=0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.026s
prefilling_size=816795 prefilling_elapsed_millis=1.001s
prefilling_size=940290 prefilling_elapsed_millis=1.101s
prefilling_size=1044981 prefilling_elapsed_millis=1.201s
prefilling_size=1134815 prefilling_elapsed_millis=1.301s
prefilling_size=1218623 prefilling_elapsed_millis=1.402s
prefilling_size=1301293 prefilling_elapsed_millis=1.502s
prefilling_size=1383082 prefilling_elapsed_millis=1.602s
prefilling_size=1464746 prefilling_elapsed_millis=1.702s
prefilling_size=1546198 prefilling_elapsed_millis=1.802s
prefilling_size=1626904 prefilling_elapsed_millis=1.902s
prefilling_size=1706658 prefilling_elapsed_millis=2.003s
prefilling_size=1786124 prefilling_elapsed_millis=2.103s
prefilling_size=1865176 prefilling_elapsed_millis=2.203s
prefilling_size=1943976 prefilling_elapsed_millis=2.303s
prefilling_size=2022622 prefilling_elapsed_millis=2.403s
prefilling_size=2101713 prefilling_elapsed_millis=2.504s
prefilling_size=2179215 prefilling_elapsed_millis=2.604s
prefilling_size=2256549 prefilling_elapsed_millis=2.704s
prefilling_size=2332934 prefilling_elapsed_millis=2.804s
prefilling_size=2416012 prefilling_elapsed_millis=2.904s
prefilling_size=2533008 prefilling_elapsed_millis=3.005s
prefilling_size=2609768 prefilling_elapsed_millis=3.105s
prefilling_size=2685522 prefilling_elapsed_millis=3.205s
prefilling_size=2757896 prefilling_elapsed_millis=3.305s
prefilling_size=2830403 prefilling_elapsed_millis=3.405s
prefilling_size=2903195 prefilling_elapsed_millis=3.506s
prefilling_size=2976343 prefilling_elapsed_millis=3.606s
prefilling_size=3051633 prefilling_elapsed_millis=3.706s
prefilling_size=3129106 prefilling_elapsed_millis=3.806s
prefilling_size=3209790 prefilling_elapsed_millis=3.906s
prefilling_size=3298402 prefilling_elapsed_millis=4.007s
prefilling_size=3408459 prefilling_elapsed_millis=4.107s
prefilling_size=3507994 prefilling_elapsed_millis=4.207s
prefilling_size=3605582 prefilling_elapsed_millis=4.307s
prefilling_size=3680170 prefilling_elapsed_millis=4.407s
prefilling_size=3748165 prefilling_elapsed_millis=4.508s
prefilling_size=3814399 prefilling_elapsed_millis=4.608s
prefilling_size=3880687 prefilling_elapsed_millis=4.708s
prefilling_size=3945144 prefilling_elapsed_millis=4.808s
prefilling_size=4009765 prefilling_elapsed_millis=4.908s
prefilling_size=4074155 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 5925785 keys with 144 threads...
tid=0 thread_prefill_amount=29148 percent_done_estimate=70.8 elapsed_s=5 est_remaining_s=5 / 10
tid=0 thread_prefill_amount=30536 percent_done_estimate=74.2 elapsed_s=5 est_remaining_s=4 / 10
tid=0 thread_prefill_amount=31924 percent_done_estimate=77.6 elapsed_s=6 est_remaining_s=4 / 9
tid=0 thread_prefill_amount=33312 percent_done_estimate=81.0 elapsed_s=6 est_remaining_s=3 / 9
tid=0 thread_prefill_amount=34700 percent_done_estimate=84.3 elapsed_s=6 est_remaining_s=3 / 9
tid=0 thread_prefill_amount=36088 percent_done_estimate=87.7 elapsed_s=6 est_remaining_s=2 / 8
tid=0 thread_prefill_amount=37476 percent_done_estimate=91.1 elapsed_s=7 est_remaining_s=1 / 8
tid=0 thread_prefill_amount=38864 percent_done_estimate=94.4 elapsed_s=7 est_remaining_s=1 / 8
tid=0 thread_prefill_amount=40252 percent_done_estimate=97.8 elapsed_s=7 est_remaining_s=0 / 7
tid=0 thread_prefill_amount=41640 percent_done_estimate=101.2 elapsed_s=7 est_remaining_s=-0 / 7
tid=0 thread_prefill_amount=43028 percent_done_estimate=104.6 elapsed_s=8 est_remaining_s=-1 / 7
tid=0 thread_prefill_amount=44416 percent_done_estimate=107.9 elapsed_s=8 est_remaining_s=-1 / 6
tid=0 thread_prefill_amount=45804 percent_done_estimate=111.3 elapsed_s=8 est_remaining_s=-2 / 6
tid=0 thread_prefill_amount=47192 percent_done_estimate=114.7 elapsed_s=8 est_remaining_s=-2 / 6
tid=0 thread_prefill_amount=48580 percent_done_estimate=118.1 elapsed_s=8 est_remaining_s=-3 / 5
tid=0 thread_prefill_amount=49968 percent_done_estimate=121.4 elapsed_s=8 est_remaining_s=-3 / 5
tid=0 thread_prefill_amount=51356 percent_done_estimate=124.8 elapsed_s=9 est_remaining_s=-4 / 5
tid=0 thread_prefill_amount=52744 percent_done_estimate=128.2 elapsed_s=9 est_remaining_s=-4 / 4
tid=0 thread_prefill_amount=54132 percent_done_estimate=131.5 elapsed_s=9 est_remaining_s=-5 / 4
tid=0 thread_prefill_amount=55520 percent_done_estimate=134.9 elapsed_s=9 est_remaining_s=-5 / 4
tid=0 thread_prefill_amount=56908 percent_done_estimate=138.3 elapsed_s=9 est_remaining_s=-6 / 4
tid=0 thread_prefill_amount=58296 percent_done_estimate=141.7 elapsed_s=10 est_remaining_s=-6 / 3
tid=0 thread_prefill_amount=59684 percent_done_estimate=145.0 elapsed_s=10 est_remaining_s=-7 / 3
tid=0 thread_prefill_amount=61072 percent_done_estimate=148.4 elapsed_s=10 est_remaining_s=-7 / 3
tid=0 thread_prefill_amount=62460 percent_done_estimate=151.8 elapsed_s=10 est_remaining_s=-8 / 2
tid=0 thread_prefill_amount=63848 percent_done_estimate=155.2 elapsed_s=11 est_remaining_s=-9 / 2
tid=0 thread_prefill_amount=65236 percent_done_estimate=158.5 elapsed_s=11 est_remaining_s=-9 / 2
tid=0 thread_prefill_amount=66624 percent_done_estimate=161.9 elapsed_s=11 est_remaining_s=-10 / 2
tid=0 thread_prefill_amount=68012 percent_done_estimate=165.3 elapsed_s=11 est_remaining_s=-10 / 1
tid=0 thread_prefill_amount=69400 percent_done_estimate=168.6 elapsed_s=11 est_remaining_s=-10 / 1
timing_elapsed 6.2038s
prefilling_size=10000000 prefilling_elapsed_millis=6.218s
finished prefilling to size 10000000 for expected size 10000000 keysum=100022493761061, performing 19772727 updates; total_prefilling_elapsed_ms=6218 ms)
pref_size=10000000
pref_millis=6218
prefill_elapsed_ms=6218
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6993921.110046494
REALTIME_END_PERF_FORMAT=6993931.110126008

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (144 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.023s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131071 261817 516338 947309 1399592 1376064 759750 199754 19310 383 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 301 6472 72784 403457 1105427 1467889 924459 252993 24380 463
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262118 522810 1020093 1803049 2481491 2227639 1124213 272303 24763 463
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262118 522810 1020093 1803049 2481491 2227639 1124213 272303 24763 463
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99981 1.99571 1.96355 1.83888 1.60004 1.34317 1.16361 1.06453 1.02003 1.00323 1

tree_stats_height=28
tree_stats_numInternals=5742459
tree_stats_numLeaves=4258626
tree_stats_numNodes=10001085
tree_stats_numKeys=10001085

tree_stats_avgDegreeInternal=1.7416
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42582
tree_stats_avgKeyDepth=21.7362


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
    [2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=170495
first_thread_announced_epoch_by_thread=2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574 2574
sum_num_inserts_by_thread=81160 81993 82690 81285 80754 81007 82413 82090 83223 83849 83074 82467 82639 83231 82312 83375 83076 82405 81604 81939 82715 82096 82643 81499 82370 82246 82747 82807 82405 82021 82902 82654 81647 82800 82241 81025 81540 82021 81991 83042 82628 82707 77465 82354 82459 82395 82641 81727 81619 81148 82397 81994 78187 81975 80807 82816 83493 82978 82216 81998 83299 82585 83576 82365 83438 80984 82162 81143 83101 82959 82717 81456 81790 80232 81790 82642 79665 82838 82109 82517 83464 81802 81872 82107 82936 82080 83611 83567 82888 81854 82181 82669 82993 82624 81476 81902 80335 80594 82991 82054 82426 79352 81271 81737 80870 82529 82099 81820 81404 80641 82392 81389 82267 79934 81569 81481 82211 81847 81636 74513 80227 82078 82584 82098 82352 79702 80898 81066 82761 82326 81241 80822 82347 78672 82645 82079 81516 80206 80862 81884 82029 82164 81554 79175
sum_num_inserts_total=11794046
sum_num_deletes_by_thread=80822 81925 82248 81408 81375 81288 82263 81736 82210 83896 82490 82718 82428 83071 82867 83125 83613 82645 82055 81472 83105 82214 83219 81554 81957 82581 83386 82850 82455 81918 82531 82706 81775 83033 81846 81540 80971 82229 82067 82777 82864 82753 77969 82100 83208 82406 82904 82053 81150 81068 82291 81745 78062 82296 80422 82299 82936 82705 82110 82240 82602 82829 83703 82142 83196 80887 82035 81436 83191 82951 82692 82263 82447 80208 82179 83114 79556 82399 82499 82360 83984 81106 81503 81417 82349 81675 83583 83162 83395 81297 81797 82170 83382 82440 81771 82363 80093 80856 82435 82113 82447 79121 81433 81619 81055 82981 82036 81391 81549 80875 83041 80787 81396 80320 81110 81195 82911 82693 81944 74567 80958 81408 82774 81888 83061 79146 80268 81480 82463 83023 81369 80930 81966 78402 83117 82099 81378 80900 80732 81609 82533 82520 81799 79148
sum_num_deletes_total=11794972
sum_num_searches_by_thread=1451466 1473352 1492446 1469254 1459299 1459639 1485829 1481826 1494605 1505099 1490402 1486012 1484091 1496307 1487476 1500316 1493021 1481283 1464657 1476223 1492910 1482381 1484726 1467739 1473050 1480115 1490236 1488682 1484944 1475028 1486353 1487620 1467803 1497311 1491132 1466155 1462929 1486582 1487009 1498163 1494101 1485031 1390356 1477243 1490971 1483359 1484815 1470655 1464327 1465131 1478823 1468527 1412496 1478173 1460112 1484929 1496464 1494065 1477440 1478334 1488811 1485245 1507612 1483170 1496891 1462645 1478005 1467307 1499246 1499325 1486984 1475408 1478402 1443889 1479078 1493771 1431462 1485067 1478895 1478304 1497678 1463311 1466036 1464069 1484351 1479462 1505569 1501151 1494273 1470148 1480321 1486025 1500881 1487448 1463172 1479426 1447820 1461975 1486108 1474825 1487470 1430600 1466224 1463236 1457319 1488378 1476315 1465677 1471398 1449140 1485436 1463505 1478393 1447446 1456648 1466450 1482833 1483523 1464378 1339933 1451556 1467591 1480399 1474675 1481946 1429216 1450493 1463878 1482432 1489073 1464406 1450407 1476697 1421389 1488057 1476801 1468669 1451444 1448552 1467022 1482478 1481854 1477940 1428469
sum_num_searches_total=212292135
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1613448 1637270 1657384 1631947 1621428 1621934 1650505 1645652 1660038 1672844 1655966 1651197 1649158 1662609 1652655 1666816 1659710 1646333 1628316 1639634 1658730 1646691 1650588 1630792 1637377 1644942 1656369 1654339 1649804 1638967 1651786 1652980 1631225 1663144 1655219 1628720 1625440 1650832 1651067 1663982 1659593 1650491 1545790 1641697 1656638 1648160 1650360 1634435 1627096 1627347 1643511 1632266 1568745 1642444 1621341 1650044 1662893 1659748 1641766 1642572 1654712 1650659 1674891 1647677 1663525 1624516 1642202 1629886 1665538 1665235 1652393 1639127 1642639 1604329 1643047 1659527 1590683 1650304 1643503 1643181 1665126 1626219 1629411 1627593 1649636 1643217 1672763 1667880 1660556 1633299 1644299 1650864 1667256 1652512 1626419 1643691 1608248 1623425 1651534 1638992 1652343 1589073 1628928 1626592 1619244 1653888 1640450 1628888 1634351 1610656 1650869 1625681 1642056 1607700 1619327 1629126 1647955 1648063 1627958 1489013 1612741 1631077 1645757 1638661 1647359 1588064 1611659 1626424 1647656 1654422 1627016 1612159 1641010 1578463 1653819 1640979 1631563 1612550 1610146 1630515 1647040 1646538 1641293 1586792
average_num_operations_total=1638063
stdev_num_operations_total=2026
sum_num_operations_total=235881153
min_num_operations_total=1489013
max_num_operations_total=1674891
first_time_thread_terminate_by_thread=10000293 10000292 10000116 10000119 10000119 10000118 10000119 10000121 10000121 10000120 10000119 10000292 10000118 10000121 10000121 10000119 10000119 10000121 10000118 10000121 10000118 10000120 10000120 10000117 10000119 10000122 10000119 10000119 10000119 10000122 10000119 10000122 10000293 10000120 10000293 10000118 10000118 10000121 10000121 10000119 10000119 10000121 10000118 10000121 10000118 10000120 10000120 10000121 10000122 10000120 10000118 10000120 10000119 10000120 10000118 10000119 10000119 10000118 10000117 10000118 10000118 10000118 10000118 10000120 10000120 10000118 10000118 10000118 10000120 10000118 10000117 10000120 10000122 10000118 10000118 10000120 10000119 10000120 10000118 10000119 10000119 10000118 10000117 10000118 10000118 10000118 10000118 10000293 10000120 10000118 10000118 10000120 10000120 10000118 10000122 10000118 10000116 10000119 10000116 10000293 10000116 10000118 10000120 10000121 10000121 10000116 10000122 10000116 10000120 10000120 10000118 10000119 10000116 10000116 10000117 10000117 10000117 10000116 10000118 10000116 10000116 10000743 10000116 10000116 10000121 10000117 10000120 10000121 10000116 10000118 10000122 10000117 10000293 10000120 10000116 10000117 10000119 10000122 10000117 10000117 10000117 10000116 10000118 10000116
min_time_thread_terminate_total=10000116
max_time_thread_terminate_total=10000743
first_time_thread_start_by_thread=7 3 4 3 3 4 3 3 3 3 4 3 3 4 3 3 3 3 3 3 3 4 4 4 3 3 4 3 3 4 3 3 3 3 4 3 3 4 3 3 3 3 3 3 3 4 3 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 4 4 4 5 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=100008172796599
threads_final_size=10001085
final_keysum=100008172796599
final_size=10001085
validate_result=success
Validation OK.
Structural validation OK.

total_find=212292135
total_rq=0
total_inserts=11794046
total_deletes=11794972
total_updates=23589018
total_queries=212292135
total_ops=235881153
find_throughput=21229213
rq_throughput=0
update_throughput=2358901
query_throughput=21229213
total_throughput=23588115


total find                    : 212292135
total rq                      : 0
total inserts                 : 11794046
total deletes                 : 11794972
total updates                 : 23589018
total queries                 : 212292135
total ops                     : 235881153
find throughput               : 21229213
rq throughput                 : 0
update throughput             : 2358901
query throughput              : 21229213
total throughput              : 23588115

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=22.5885
PAPI_L3_TCM=7.79685
PAPI_TOT_CYC=16793.8
PAPI_TOT_INS=17887.8
garbage=1031861394650392
total_execution_walltime=21.716s
REALTIME_MAIN_END_PERF_FORMAT=6993931.250219348
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 255359077
[slow htm]
[fallback]
total fallback commit         : 294804
seconds global lock is held   : 17.2284
[time_cmd_output] time_elapsed_sec=21.92, faults_major=0, faults_minor=474342, mem_maxresident_kb=1170584, user_cputime=3061.35, sys_cputime=18.27, percent_cpu=14045%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.hytm1
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1