__step=000454
__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.rhnorec_post -nwork 144 -nprefill 144 -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=data000454.txt
__path_data=data/data000454.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000271.997871614
binary=./brown_int_bst_tm_auto.debra.rhnorec_post
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=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=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,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


RH noREC w/postfix htm system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.05s
prefilling_size=88693 prefilling_elapsed_millis=1s
prefilling_size=91082 prefilling_elapsed_millis=1.101s
prefilling_size=92809 prefilling_elapsed_millis=1.201s
prefilling_size=94422 prefilling_elapsed_millis=1.302s
prefilling_size=95432 prefilling_elapsed_millis=1.402s
prefilling_size=96048 prefilling_elapsed_millis=1.502s
prefilling_size=96957 prefilling_elapsed_millis=1.603s
prefilling_size=97397 prefilling_elapsed_millis=1.703s
prefilling_size=98013 prefilling_elapsed_millis=1.803s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 2014 keys with 144 threads...
timing_elapsed 0.00991163s
prefilling_size=100000 prefilling_elapsed_millis=0.01s
finished prefilling to size 100000 for expected size 100000 keysum=10000345690, performing 809816 updates; total_prefilling_elapsed_ms=10 ms)
pref_size=100000
pref_millis=10
prefill_elapsed_ms=10
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=4

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000274.180161144
REALTIME_END_PERF_FORMAT=7000284.180256526

###############################################################################
################################## 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 803 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.013s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 121 231 422 748 1259 1995 2861 3911 4948 5794 6327 6428 6059 5448 4560 3786 2975 2213 1580 1128 807 600 420 282 195 126 78 54 40 24 7 3 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 8 23 55 120 288 628 974 1556 2192 2791 3288 3588 3469 3352 2814 2372 1973 1466 1064 764 536 402 296 201 146 89 51 31 26 20 5 2 0 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 122 239 445 803 1379 2283 3489 4885 6504 7986 9118 9716 9647 8917 7912 6600 5347 4186 3046 2192 1571 1136 822 578 396 272 167 105 71 50 27 8 3 1 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 122 239 445 803 1379 2283 3489 4885 6504 7986 9118 9716 9647 8917 7912 6600 5347 4186 3046 2192 1571 1136 822 578 396 272 167 105 71 50 27 8 3 1 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.93651 1.96721 1.8954 1.85618 1.7858 1.74257 1.6544 1.58011 1.53081 1.4671 1.41623 1.37168 1.33131 1.29626 1.27633 1.25784 1.23652 1.22648 1.199 1.20092 1.2021 1.20942 1.19542 1.19221 1.19723 1.19444 1.15074 1.16168 1.1619 1.14085 1.06 1.03704 1 1 1 1

tree_stats_height=42
tree_stats_numInternals=65558
tree_stats_numLeaves=34592
tree_stats_numNodes=100150
tree_stats_numKeys=100150

tree_stats_avgDegreeInternal=1.52765
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.3454
tree_stats_avgKeyDepth=19.0494

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=298


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:712 16:37903 32:3338
    (2^03, 2^04]: 712
    (2^04, 2^05]: 37903
    (2^05, 2^06]: 3338
sum_limbo_reclamation_event_size_total=1046288
count_limbo_reclamation_event_size_by_thread=291 291 291 291 291 291 291 291 292 291 291 291 291 292 292 291 291 292 291 291 292 292 291 291 292 291 291 292 291 292 291 292 292 291 292 292 291 292 292 291 291 292 291 292 292 291 291 292 291 292 291 291 291 291 291 291 292 291 291 292 291 291 292 291 292 291 292 291 291 291 291 292 291 292 291 292 291 291 291 291 292 291 291 291 291 291 292 291 292 291 292 292 292 291 291 291 292 292 292 291 291 291 291 292 292 292 291 291 292 291 291 291 291 291 292 292 291 291 291 291 291 291 292 291 291 291 292 292 291 291 291 291 292 291 291 291 291 291 291 292 291 291 291 292
count_limbo_reclamation_event_size_total=41953
sum_limbo_reclamation_event_count_total=42241
first_thread_announced_epoch_by_thread=594 594 594 594 594 594 594 594 596 594 594 594 594 596 596 594 594 596 594 594 596 596 594 594 596 594 594 596 594 596 594 596 596 594 596 596 594 596 596 594 594 596 594 596 596 594 594 596 594 596 594 594 594 594 594 594 596 594 594 596 594 594 596 594 596 594 596 594 594 594 594 596 594 596 594 596 594 594 594 594 596 594 594 594 594 594 596 594 596 594 596 596 596 594 594 594 596 596 596 594 594 594 594 596 596 596 594 594 596 594 594 594 594 594 596 596 594 594 594 594 594 594 596 594 594 594 596 596 594 594 594 594 596 594 594 594 594 594 594 596 594 594 594 596
sum_commit_tx_reader_total=
sum_commit_tx_reader_by_thread=
sum_commit_tx_writer_total=
sum_commit_tx_writer_by_thread=
sum_abort_tx_total=
sum_abort_tx_by_thread=
max_ht_capacity_by_thread=

linear_histogram_of_none_tx_rdset_size_full_data=

linear_histogram_of_none_tx_wrset_size_full_data=
sum_fasthtm_commit_total=40141427
sum_fasthtm_abort_total=86702716
sum_htmpostfix_commit_total=2094393
sum_htmpostfix_abort_total=2158403
sum_htmprefix_commit_total=
sum_htmprefix_abort_total=
sum_htmprefix_abort_explicit_total=
sum_htmprefix_abort_conflict_total=
sum_htmprefix_abort_capacity_total=
sum_htmprefix_abort_nesting_total=
sum_htmprefix_abort_illegal_total=
sum_htmprefix_abort_zero_total=
sum_stmprefix_abort_total=50062681
sum_stmprefix_commit_total=1269
sum_slow_commit_total=14849
sum_abtree_insert_repeat_total=
sum_abtree_erase_repeat_total=
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=
sum_abtree_fix_weight_viol_attempt_total=
sum_abtree_fix_degree_viol_attempt_total=
sum_abtree_rebalancing_kcas_attempt_total=
sum_abtree_update_kcas_attempt_total=
sum_abtree_internal_complex_search_while_iters_total=
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=15235 14853 15313 15054 15617 16014 15239 15316 14746 15385 15323 16110 14768 15329 15154 15843 15415 16402 14845 14958 15338 15774 15459 16005 15183 15040 15267 14745 15318 16111 15022 15272 15199 15509 15374 16066 15066 14816 15128 16155 15495 16331 14934 14780 15306 15788 15299 15707 14521 14359 15244 13882 14692 14517 14673 14777 14774 15165 15147 14729 14269 15037 14469 14499 14818 14653 14516 14341 14339 15058 14912 14657 14474 14423 14834 13848 14919 14667 14787 14564 14810 14995 14962 14880 14198 14582 14381 14914 14740 14499 14444 14577 14529 14912 14857 15094 13915 13847 14088 13119 14420 14053 13734 14162 13882 14253 14130 14131 13902 13893 13838 13970 14145 13888 14251 14340 14175 14223 14160 13921 13975 13575 13847 13069 14215 13897 14008 14328 13965 14105 14009 13940 14127 13875 13909 14179 13921 13754 14257 14117 14346 14292 14288 14002
sum_num_inserts_total=2114784
sum_num_deletes_by_thread=15201 14930 15124 15233 15635 16114 14847 15201 14965 15662 15411 15968 14789 15131 15326 15672 15530 16252 14760 15154 15362 15577 15541 15782 15003 15005 15148 14846 15415 16207 14783 15411 15152 15472 15440 15759 14822 14823 15358 15952 15408 16382 14995 14777 15133 15824 15286 15539 14441 14385 15030 13776 14373 14524 14870 14875 14537 15049 14942 14868 14311 14720 14455 14815 14747 14449 14221 14620 14347 15120 14956 14727 14538 14154 14477 14107 14892 14605 14742 14562 14688 14890 14819 14912 14369 14348 14478 14624 14924 14491 14279 14257 14314 15235 14863 14775 13770 13880 14272 13404 14629 14022 13638 14017 14386 14190 14092 14159 13982 13986 13734 13815 14259 13913 14065 14136 14338 14362 14364 13972 13661 13778 13655 13159 14367 13719 13957 14055 14029 14146 14294 14024 14227 14036 13845 14169 14001 13703 14092 13953 14210 14367 14466 13702
sum_num_deletes_total=2111608
sum_num_searches_by_thread=276634 267582 274929 272500 283859 289910 270273 276447 272372 279731 276703 289727 265969 273607 271122 282255 279636 295586 270532 270297 277050 278547 279062 286513 273973 270177 272883 264774 277841 290027 269751 278627 272787 279624 280222 285787 269827 266281 273653 290733 280262 294594 268196 263483 272592 285616 273888 278777 262504 257231 271372 248993 261503 259905 266611 265621 264090 269356 270815 265684 259141 269747 259302 266628 265266 261047 255082 261767 260220 270565 268447 265917 261771 256830 264023 251768 267316 263302 263392 263049 264425 267065 268001 269925 256947 259103 258691 268672 265239 262394 260790 260228 258510 271465 268018 265402 247731 249149 253599 239391 261101 251660 244240 254804 254086 252503 253570 251108 248974 250417 248459 252690 253459 249532 254533 255319 255222 255404 258380 253604 249552 245777 247727 233711 257449 251203 251591 252035 253738 251374 255226 247963 256285 252076 249723 255966 250946 246103 255728 253227 254137 257392 258749 250575
sum_num_searches_total=38025546
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=307070 297365 305366 302787 315111 322038 300359 306964 302083 310778 307437 321805 295526 304067 301602 313770 310581 328240 300137 300409 307750 309898 310062 318300 304159 300222 303298 294365 308574 322345 299556 309310 303138 310605 311036 317612 299715 295920 304139 322840 311165 327307 298125 293040 303031 317228 304473 310023 291466 285975 301646 276651 290568 288946 296154 295273 293401 299570 300904 295281 287721 299504 288226 295942 294831 290149 283819 290728 288906 300743 298315 295301 290783 285407 293334 279723 297127 292574 292921 292175 293923 296950 297782 299717 285514 288033 287550 298210 294903 291384 289513 289062 287353 301612 297738 295271 275416 276876 281959 265914 290150 279735 271612 282983 282354 280946 281792 279398 276858 278296 276031 280475 281863 277333 282849 283795 283735 283989 286904 281497 277188 273130 275229 259939 286031 278819 279556 280418 281732 279625 283529 275927 284639 279987 277477 284314 278868 273560 284077 281297 282693 286051 287503 278279
average_num_operations_total=293416
stdev_num_operations_total=1107
sum_num_operations_total=42251938
min_num_operations_total=259939
max_num_operations_total=328240
first_time_thread_terminate_by_thread=10000411 10000259 10000323 10000247 10000264 10000395 10000099 10000305 10000200 10000109 10000219 10000415 10000822 10000849 10000095 10000364 10000136 10000178 10000302 10000253 10000099 10000095 10000822 10000151 10000209 10000281 10000838 10000095 10000781 10000235 10000108 10000370 10000349 10000372 10000811 10000809 10000252 10000376 10000162 10000382 10000186 10000099 10000189 10000139 10000386 10000163 10000415 10000785 10000315 10000844 10000863 10000875 10000814 10000852 10000357 10000384 10000778 10000209 10000187 10000354 10000395 10000847 10000796 10000787 10000393 10000807 10000865 10000349 10000358 10000220 10000869 10000350 10000837 10000247 10000871 10000876 10000396 10000188 10000096 10000221 10000856 10000178 10000767 10000380 10000843 10000867 10000285 10000233 10000201 10000101 10000342 10000862 10000401 10000870 10000874 10000095 10000184 10000312 10000099 10000866 10000412 10000802 10000198 10000155 10000794 10000097 10000793 10000111 10000414 10000407 10000825 10000851 10000873 10000805 10000833 10000097 10000397 10000419 10000329 10000105 10000369 10000184 10000817 10000792 10000200 10000766 10000104 10000768 10000373 10000831 10000299 10000376 10000097 10000392 10000416 10000198 10000859 10000765 10000113 10000855 10000154 10000841 10000351 10000214
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000876
first_time_thread_start_by_thread=8 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 4 5 5 4 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 4 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=10003006781
threads_final_size=100150
final_keysum=10003006781
final_size=100150
validate_result=success
Validation OK.
Structural validation OK.

total_find=38025546
total_rq=0
total_inserts=2114784
total_deletes=2111608
total_updates=4226392
total_queries=38025546
total_ops=42251938
find_throughput=3802554
rq_throughput=0
update_throughput=422639
query_throughput=3802554
total_throughput=4225193


total find                    : 38025546
total rq                      : 0
total inserts                 : 2114784
total deletes                 : 2111608
total updates                 : 4226392
total queries                 : 38025546
total ops                     : 42251938
find throughput               : 3802554
rq throughput                 : 0
update throughput             : 422639
query throughput              : 3802554
total throughput              : 4225193

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=21.7319
PAPI_L3_TCM=6.11395
PAPI_TOT_CYC=87023.6
PAPI_TOT_INS=3173.22
garbage=1903471464072
total_execution_walltime=12.32s
REALTIME_MAIN_END_PERF_FORMAT=7000284.318977018
RH noREC w/postfix htm system shutdown:
    HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=12.44, faults_major=0, faults_minor=97182, mem_maxresident_kb=385120, user_cputime=1713.66, sys_cputime=19.83, percent_cpu=13927%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.rhnorec_post
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2