__step=000449
__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 48 -nprefill 48 -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=data000449.txt
__path_data=data/data000449.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000211.188134156
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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
RH noREC w/postfix htm system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=99094 prefilling_elapsed_millis=1.001s
finished prefilling to size 99095 for expected size 100000 keysum=9898205026, performing 971048 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99095
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=49
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000212.474043018
REALTIME_END_PERF_FORMAT=7000222.474204830
###############################################################################
################################## 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 (192 threads)...
partitioned into 932 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.049s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 253 486 878 1480 2334 3409 4552 5637 6525 6902 7022 6703 5836 4682 3500 2333 1385 739 359 154 71 26 8 5 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 14 54 145 334 684 1218 1864 2539 3295 3584 3866 4007 3734 3052 2449 1727 1063 587 288 120 57 23 4 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 255 500 932 1625 2668 4093 5770 7501 9064 10197 10606 10569 9843 8416 6552 4782 3112 1802 946 442 191 83 31 9 5 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 255 500 932 1625 2668 4093 5770 7501 9064 10197 10606 10569 9843 8416 6552 4782 3112 1802 946 442 191 83 31 9 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.96863 1.892 1.8015 1.73108 1.6593 1.57684 1.51109 1.45687 1.40512 1.36324 1.33443 1.2971 1.26212 1.2222 1.19567 1.1629 1.134 1.11487 1.08774 1.08371 1.06283 1.06024 1.03226 1 1 1
tree_stats_height=34
tree_stats_numInternals=65536
tree_stats_numLeaves=34715
tree_stats_numNodes=100251
tree_stats_numKeys=100251
tree_stats_avgDegreeInternal=1.52971
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34628
tree_stats_avgKeyDepth=18.1252
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=22833
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:62 2:1521 4:50733 8:369503 16:58075 32:1
[2^00, 2^01]: 62
(2^01, 2^02]: 1521
(2^02, 2^03]: 50733
(2^03, 2^04]: 369503
(2^04, 2^05]: 58075
(2^05, 2^06]: 1
sum_limbo_reclamation_event_size_total=5534271
count_limbo_reclamation_event_size_by_thread=9998 9997 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9995 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479895
sum_limbo_reclamation_event_count_total=1093632
first_thread_announced_epoch_by_thread=45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666 45666
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=489273274
sum_fasthtm_abort_total=81822950
sum_htmpostfix_commit_total=1410551
sum_htmpostfix_abort_total=1574962
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=19755404
sum_stmprefix_commit_total=179
sum_slow_commit_total=9076
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=510842 511702 510317 514852 505762 507875 511527 513368 517138 518014 511247 513046 505222 510229 512344 516878 511456 513169 506537 510148 512089 517773 506771 509310 509560 509621 511149 513793 510566 509941 507857 509945 515380 514486 509952 511266 507864 508875 510760 513695 509192 512246 507748 508507 510848 516414 505816 510918
sum_num_inserts_total=24534015
sum_num_deletes_by_thread=509783 509740 511063 514124 506558 508333 511249 512761 518610 517397 511493 513046 506642 507838 513358 517613 511889 514117 506831 510248 512299 516919 506877 509801 508702 510585 511636 512278 509277 508413 508461 510216 515416 514708 509166 510622 509322 509961 510341 512979 509213 511595 508685 509550 511448 517039 505941 509714
sum_num_deletes_total=24533857
sum_num_searches_by_thread=9189407 9174073 9208143 9265555 9120126 9143374 9186192 9224101 9320631 9316428 9204132 9231832 9095528 9170207 9243599 9317485 9208944 9251099 9113542 9199858 9235426 9321071 9109209 9164692 9175838 9182570 9208462 9244300 9186781 9158004 9142446 9171201 9277166 9252046 9177712 9199239 9145959 9174720 9188692 9245904 9158946 9216280 9159210 9173424 9210255 9294470 9109007 9157922
sum_num_searches_total=441625208
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10210032 10195515 10229523 10294531 10132446 10159582 10208968 10250230 10356379 10351839 10226872 10257924 10107392 10188274 10269301 10351976 10232289 10278385 10126910 10220254 10259814 10355763 10122857 10183803 10194100 10202776 10231247 10270371 10206624 10176358 10158764 10191362 10307962 10281240 10196830 10221127 10163145 10193556 10209793 10272578 10177351 10240121 10175643 10191481 10232551 10327923 10120764 10178554
average_num_operations_total=10222772
stdev_num_operations_total=9269
sum_num_operations_total=490693080
min_num_operations_total=10107392
max_num_operations_total=10356379
first_time_thread_terminate_by_thread=10000197 10000222 10000206 10000163 10000209 10000202 10000207 10000215 10000203 10000192 10000226 10000195 10000213 10000186 10000215 10000177 10000190 10000230 10000224 10000210 10000206 10000217 10000163 10000174 10000222 10000182 10000191 10000201 10000228 10000163 10000179 10000218 10000228 10000172 10000211 10000220 10000208 10000227 10000172 10000199 10000201 10000230 10000188 10000193 10000221 10000204 10000163 10000167
min_time_thread_terminate_total=10000163
max_time_thread_terminate_total=10000230
first_time_thread_start_by_thread=3 3 3 3 2 3 2 3 3 3 2 3 3 3 2 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 3 3 3 2 3 3 2 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=10026453167
threads_final_size=100251
final_keysum=10026453167
final_size=100251
validate_result=success
Validation OK.
Structural validation OK.
total_find=441625208
total_rq=0
total_inserts=24534015
total_deletes=24533857
total_updates=49067872
total_queries=441625208
total_ops=490693080
find_throughput=44162520
rq_throughput=0
update_throughput=4906787
query_throughput=44162520
total_throughput=49069308
total find : 441625208
total rq : 0
total inserts : 24534015
total deletes : 24533857
total updates : 49067872
total queries : 441625208
total ops : 490693080
find throughput : 44162520
rq throughput : 0
update throughput : 4906787
query throughput : 44162520
total throughput : 49069308
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=4.8351
PAPI_L3_TCM=0.00296792
PAPI_TOT_CYC=2547.02
PAPI_TOT_INS=1080.74
garbage=22086245912723
total_execution_walltime=11.53s
REALTIME_MAIN_END_PERF_FORMAT=7000222.718923903
RH noREC w/postfix htm system shutdown:
HTM_ATTEMPT_THRESH=40
[time_cmd_output] time_elapsed_sec=11.67, faults_major=0, faults_minor=86404, mem_maxresident_kb=347724, user_cputime=552.88, sys_cputime=8.66, percent_cpu=4811%
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=1