__step=000468
__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_int_bst_tm_auto.debra.hytm1 -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000468.txt
__path_data=data/data000468.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000439.400191583
binary=./brown_int_bst_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_int_bst_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=200000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=32
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
HyTM1 system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.041s
prefilling_size=100056 prefilling_elapsed_millis=1s
finished prefilling to size 100052 for expected size 100000 keysum=10000761220, performing 47460584 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100052
pref_millis=1102
prefill_elapsed_ms=1125
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=598
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000440.756326123
REALTIME_END_PERF_FORMAT=7000450.756404070
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 779 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 31 60 114 219 411 718 1226 1948 2906 4136 5503 6695 7463 7591 7097 6192 4771 3402 2256 1339 791 472 246 124 70 23 9 5 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 1 1 4 1 15 61 118 283 506 915 1466 2277 3212 3843 4275 4164 4001 3216 2373 1662 955 570 367 188 86 63 18 5 4 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 61 118 220 426 779 1344 2231 3412 5051 6969 8972 10675 11434 11372 10356 8772 6618 4629 3001 1746 1042 613 312 156 86 27 10 5 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 61 118 220 426 779 1344 2231 3412 5051 6969 8972 10675 11434 11372 10356 8772 6618 4629 3001 1746 1042 613 312 156 86 27 10 5 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.9375 1.95082 1.89831 1.94091 1.86385 1.80359 1.74777 1.65621 1.62866 1.56088 1.49778 1.4436 1.37199 1.33068 1.28658 1.24913 1.21056 1.1854 1.16094 1.13562 1.14376 1.13532 1.10767 1.10256 1.10256 1.04651 1.03704 1 1 1
tree_stats_height=35
tree_stats_numInternals=65850
tree_stats_numLeaves=34651
tree_stats_numNodes=100501
tree_stats_numKeys=100501
tree_stats_avgDegreeInternal=1.52621
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34478
tree_stats_avgKeyDepth=18.3362
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=12643
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:16 2:297 4:3945 8:82882 16:846985 32:25682 64:1
[2^00, 2^01]: 16
(2^01, 2^02]: 297
(2^02, 2^03]: 3945
(2^03, 2^04]: 82882
(2^04, 2^05]: 846985
(2^05, 2^06]: 25682
(2^06, 2^07]: 1
sum_limbo_reclamation_event_size_total=20978697
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=959808
sum_limbo_reclamation_event_count_total=1156320
first_thread_announced_epoch_by_thread=25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286 25286
sum_num_inserts_by_thread=523543 523868 546014 457766 542738 537567 489076 551465 546018 548473 526417 546528 538103 542325 547361 400060 527933 551804 465496 554524 521780 506223 528808 517648 531474 517884 533568 474272 544145 533721 508444 546725 539226 528523 530175 547486 536198 550022 546272 201760 491474 538031 539190 554571 473058 554491 544431 516038 546195 557909 525903 550684 525656 541810 464889 559527 450361 501910 559231 508729 540169 543626 550019 541504 555303 548191 507518 527754 547439 557321 527664 553023 523011 551868 544271 546568 517559 555215 556815 556012 555677 495905 560782 553344 557129 540189 541120 554108 497859 538706 522877 399892 537822 556894 541022 540987
sum_num_inserts_total=50560684
sum_num_deletes_by_thread=523483 524177 546432 456697 542166 537083 489215 550509 545898 549742 525887 547920 537991 542183 548312 400584 529485 551409 465587 553433 522004 505931 527029 517498 532250 516825 531701 475513 544010 532163 507306 549036 539600 527338 529415 548197 536817 549389 546431 201760 491116 537706 540294 554517 471320 553030 544842 516545 547912 558012 525667 550503 525967 540699 463619 558562 451072 501161 557627 508435 539193 544447 551200 539948 556388 547729 506536 529320 548297 557228 526985 551493 523551 551876 543436 546736 515700 554049 555395 556049 555615 496013 560729 553900 557676 540204 539533 555023 497502 537603 523082 399063 537409 557357 539340 540338
sum_num_deletes_total=50542955
sum_num_searches_by_thread=9424873 9443337 9836407 8220634 9748903 9684467 8812369 9893661 9820044 9884797 9479666 9842350 9673690 9756526 9872383 7189725 9521860 9919872 8391164 9961195 9399350 9120697 9489435 9326659 9562230 9307750 9587103 8556212 9794974 9576518 9148326 9868993 9713611 9500723 9531703 9855801 9653297 9889065 9830582 3638758 8831673 9671800 9719460 9965516 8502975 9946503 9812500 9297401 9850341 10035238 9446042 9906294 9461360 9726091 8354596 10061866 8106588 9022015 10043697 9156994 9727738 9787409 9905031 9730990 10014196 9847663 9117976 9506833 9872812 10010661 9505191 9919497 9419121 9953237 9788207 9836326 9290111 9978450 10011295 10014064 9997512 8915819 10089661 9961314 10019393 9728482 9738212 9976965 8948546 9698417 9421996 7199420 9680648 10029513 9723468 9737569
sum_num_searches_total=909752403
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10471899 10491382 10928853 9135097 10833807 10759117 9790660 10995635 10911960 10983012 10531970 10936798 10749784 10841034 10968056 7990369 10579278 11023085 9322247 11069152 10443134 10132851 10545272 10361805 10625954 10342459 10652372 9505997 10883129 10642402 10164076 10964754 10792437 10556584 10591293 10951484 10726312 10988476 10923285 4042278 9814263 10747537 10798944 11074604 9447353 11054024 10901773 10329984 10944448 11151159 10497612 11007481 10512983 10808600 9283104 11179955 9008021 10025086 11160555 10174158 10807100 10875482 11006250 10812442 11125887 10943583 10132030 10563907 10968548 11125210 10559840 11024013 10465683 11056981 10875914 10929630 10323370 11087714 11123505 11126125 11108804 9907737 11211172 11068558 11134198 10808875 10818865 11086096 9943907 10774726 10467955 7998375 10755879 11143764 10803830 10818894
average_num_operations_total=10529750
stdev_num_operations_total=93340
sum_num_operations_total=1010856042
min_num_operations_total=4042278
max_num_operations_total=11211172
first_time_thread_terminate_by_thread=10000080 10000078 10000079 10000079 10000080 10000079 10000080 10000080 10000079 10000078 10000080 10000080 10000080 10000076 10000080 10000080 10000080 10000077 10000080 10000080 10000077 10000078 10000076 10000076 10000080 10000078 10000079 10000079 10000080 10000079 10000080 10000080 10000079 10000078 10000080 10000080 10000080 10000076 10000080 10000078 10000080 10000077 10000079 10000080 10000077 10000078 10000080 10000080 10000078 10000078 10000077 10000078 10000078 10000078 10000078 10000078 10000079 10000077 10000077 10000077 10000078 10000077 10000079 10000079 10000079 10000077 10000076 10000077 10000079 10000077 10000077 10000079 10000078 10000078 10000077 10000079 10000078 10000079 10000078 10000078 10000079 10000077 10000077 10000077 10000078 10000077 10000079 10000079 10000079 10000077 10000078 10000077 10000079 10000077 10000077 10000077
min_time_thread_terminate_total=10000076
max_time_thread_terminate_total=10000080
first_time_thread_start_by_thread=4 4 4 4 4 5 4 5 4 5 4 5 4 5 5 5 4 5 5 4 4 5 5 4 4 4 4 4 4 5 4 5 4 5 4 5 4 5 5 5 4 5 5 4 4 5 5 4 4 4 4 4 4 5 4 4 4 4 4 5 5 4 5 4 4 4 4 4 4 5 5 5 4 4 4 4 4 5 4 4 4 4 4 5 5 4 5 4 4 4 4 4 4 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=10047393095
threads_final_size=100501
final_keysum=10047393095
final_size=100501
validate_result=success
Validation OK.
Structural validation OK.
total_find=909752403
total_rq=0
total_inserts=50560684
total_deletes=50542955
total_updates=101103639
total_queries=909752403
total_ops=1010856042
find_throughput=90975240
rq_throughput=0
update_throughput=10110363
query_throughput=90975240
total_throughput=101085604
total find : 909752403
total rq : 0
total inserts : 50560684
total deletes : 50542955
total updates : 101103639
total queries : 909752403
total ops : 1010856042
find throughput : 90975240
rq throughput : 0
update throughput : 10110363
query throughput : 90975240
total throughput : 101085604
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=4.05777
PAPI_L3_TCM=0.241791
PAPI_TOT_CYC=2538.2
PAPI_TOT_INS=1271.48
garbage=44025139235856
total_execution_walltime=11.517s
REALTIME_MAIN_END_PERF_FORMAT=7000450.917980483
HyTM1 system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 1057588570
[slow htm]
[fallback]
total fallback commit : 728057
seconds global lock is held : 0.576233
[time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=86585, mem_maxresident_kb=333308, user_cputime=1093.30, sys_cputime=3.40, percent_cpu=9419%
timeout=false
algorithm=brown_int_bst_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=2