__step=000434
__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.norec -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=data000434.txt
__path_data=data/data000434.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000026.36521870
binary=./brown_int_bst_tm_auto.debra.norec
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


noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.008s
prefilling_size=99832 prefilling_elapsed_millis=1.001s
finished prefilling to size 99816 for expected size 100000 keysum=9963676478, performing 1874146 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99816
pref_millis=1102
prefill_elapsed_ms=1124
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=88

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000027.334004205
REALTIME_END_PERF_FORMAT=7000037.334157852

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

tree_stats_computeWalltime=0.031s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 62 118 229 419 748 1298 2080 3076 4211 5273 6175 6641 6668 6197 5613 4699 3777 2845 2013 1351 859 471 230 118 59 33 22 16 13 6 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 2 3 4 17 46 101 306 583 1072 1704 2304 3049 3465 3831 3578 3454 2947 2453 1959 1379 933 657 367 170 90 38 21 16 10 11 7 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 121 233 436 794 1399 2386 3659 5283 6977 8479 9690 10133 10028 9191 8153 6724 5298 3972 2730 1792 1128 597 288 149 71 43 32 23 17 8 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 121 233 436 794 1399 2386 3659 5283 6977 8479 9690 10133 10028 9191 8153 6724 5298 3972 2730 1792 1128 597 288 149 71 43 32 23 17 8 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.92188 1.95041 1.88841 1.86009 1.8199 1.7777 1.66178 1.60317 1.52357 1.45951 1.41455 1.36037 1.33159 1.29856 1.27636 1.24837 1.2262 1.21272 1.18051 1.16154 1.15011 1.1117 1.09715 1.10764 1.08054 1.14085 1.23256 1.21875 1.17391 1.11765 1.125 1

tree_stats_height=38
tree_stats_numInternals=65384
tree_stats_numLeaves=34579
tree_stats_numNodes=99963
tree_stats_numKeys=99963

tree_stats_avgDegreeInternal=1.52886
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34592
tree_stats_avgKeyDepth=18.6078

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:41 2:990 4:35536 8:255798 16:38832
    [2^00, 2^01]: 41
    (2^01, 2^02]: 990
    (2^02, 2^03]: 35536
    (2^03, 2^04]: 255798
    (2^04, 2^05]: 38832
sum_limbo_reclamation_event_size_total=3802385
count_limbo_reclamation_event_size_by_thread=6900 6900 6900 6900 6900 6900 6900 6900 6899 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6899 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6900 6899 6900 6900 6900 6900 6900
count_limbo_reclamation_event_size_total=331197
sum_limbo_reclamation_event_count_total=331296
first_thread_announced_epoch_by_thread=13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980 13980
sum_commit_tx_reader_total=144662513
sum_commit_tx_reader_by_thread=0 2972230 3002939 2990141 3055943 3025791 3003702 2991018 3010267 3044609 3004973 3039217 3031354 3032343 3002456 3018683 3007092 2982336 3027468 3018193 3012496 3039202 3013290 3050687 3016691 3003067 3025461 2962150 3021949 2993351 2997361 3028949 2988569 3053858 3076060 3010604 2964486 2986366 2995912 3025026 2980711 3003055 3037439 3007021 3041293 3003080 3005563 3009348 3048713
sum_commit_tx_writer_total=7608227
sum_commit_tx_writer_by_thread=0 155961 158006 157141 160154 158467 157969 158043 157630 160161 158310 159439 159535 158943 158884 158630 158012 157019 158814 158367 158302 159532 158326 160774 158911 158317 158983 155869 158904 157874 158122 159952 157157 160642 161630 158614 156264 156495 158170 158422 156358 158009 159935 158179 159807 158137 158064 158700 160293
sum_abort_tx_total=13689
sum_abort_tx_by_thread=0 269 279 276 271 270 285 265 302 306 291 291 286 296 293 281 280 284 287 267 294 263 319 270 278 280 287 256 312 286 286 297 303 275 293 282 275 307 278 316 283 282 289 286 255 296 315 280 267
max_ht_capacity_by_thread=0 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048

linear_histogram_of_none_tx_rdset_size_full_data=13.2:10 20.4:130 27.6:843 34.8:6862 42:12495 49.2:17484 56.4:7998 63.6:1849 70.8:312 78:14
    [        6.00,        13.20]: 10
    (       13.20,        20.40]: 130
    (       20.40,        27.60]: 843
    (       27.60,        34.80]: 6862
    (       34.80,        42.00]: 12495
    (       42.00,        49.20]: 17484
    (       49.20,        56.40]: 7998
    (       56.40,        63.60]: 1849
    (       63.60,        70.80]: 312
    (       70.80,        78.00]: 14

linear_histogram_of_none_tx_wrset_size_full_data=1.4:15612 3.4:8192
    [        1.00,         1.40]: 15612
    (        3.00,         3.40]: 8192
sum_fasthtm_commit_total=
sum_fasthtm_abort_total=
sum_htmpostfix_commit_total=
sum_htmpostfix_abort_total=
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=
sum_stmprefix_commit_total=
sum_slow_commit_total=
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=159147 157388 160530 158110 157827 158534 155445 158662 157986 160801 157714 159402 158478 160085 159104 158667 158749 158305 157008 159363 157506 157786 160273 156773 158635 158230 157911 158454 161284 157788 156596 158128 158991 162064 159832 158609 159655 158070 158816 161002 160435 158009 158583 158502 156480 158648 159027 156389
sum_num_inserts_total=7613781
sum_num_deletes_by_thread=159704 157017 159808 157971 157352 158189 156501 159261 158163 161066 159286 160365 157858 160852 159037 157294 158123 159148 157057 159605 157281 158167 159109 156571 159113 157758 158245 158114 159440 158260 156144 157662 158609 161250 159654 158376 159783 158310 159286 160440 159594 157637 158076 157671 157260 158816 159014 156264
sum_num_deletes_total=7609561
sum_num_searches_by_thread=2872038 2831321 2884432 2847202 2833882 2844494 2806073 2866521 2849051 2892633 2844384 2869134 2844609 2895160 2866117 2845710 2859688 2853345 2825290 2872318 2832495 2839530 2879352 2829517 2859565 2849116 2845184 2852650 2888282 2851849 2808010 2838292 2868682 2914376 2879170 2854631 2881662 2847247 2857500 2890019 2877345 2835579 2851389 2844891 2823329 2863389 2865407 2815538
sum_num_searches_total=137047398
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3190889 3145726 3204770 3163283 3149061 3161217 3118019 3184444 3165200 3214500 3161384 3188901 3160945 3216097 3184258 3161671 3176560 3170798 3139355 3191286 3147282 3155483 3198734 3142861 3177313 3165104 3161340 3169218 3209006 3167897 3120750 3154082 3186282 3237690 3198656 3171616 3201100 3163627 3175602 3211461 3197374 3151225 3168048 3161064 3137069 3180853 3183448 3128191
average_num_operations_total=3172307
stdev_num_operations_total=3757
sum_num_operations_total=152270740
min_num_operations_total=3118019
max_num_operations_total=3237690
first_time_thread_terminate_by_thread=10000151 10000151 10000151 10000152 10000152 10000152 10000151 10000152 10000152 10000151 10000152 10000151 10000151 10000152 10000153 10000153 10000152 10000151 10000152 10000151 10000152 10000151 10000153 10000153 10000152 10000151 10000152 10000153 10000151 10000153 10000153 10000152 10000152 10000151 10000152 10000151 10000152 10000151 10000153 10000153 10000152 10000153 10000152 10000151 10000152 10000153 10000153 10000152
min_time_thread_terminate_total=10000151
max_time_thread_terminate_total=10000153
first_time_thread_start_by_thread=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=4
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=9970135699
threads_final_size=99963
final_keysum=9970135699
final_size=99963
validate_result=success
Validation OK.
Structural validation OK.

total_find=137047398
total_rq=0
total_inserts=7613781
total_deletes=7609561
total_updates=15223342
total_queries=137047398
total_ops=152270740
find_throughput=13704739
rq_throughput=0
update_throughput=1522334
query_throughput=13704739
total_throughput=15227074


total find                    : 137047398
total rq                      : 0
total inserts                 : 7613781
total deletes                 : 7609561
total updates                 : 15223342
total queries                 : 137047398
total ops                     : 152270740
find throughput               : 13704739
rq throughput                 : 0
update throughput             : 1522334
query throughput              : 13704739
total throughput              : 15227074

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.26641
PAPI_L3_TCM=0.000689128
PAPI_TOT_CYC=7151.09
PAPI_TOT_INS=5410.77
garbage=6849989155375
total_execution_walltime=11.597s
REALTIME_MAIN_END_PERF_FORMAT=7000037.635792178
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=11.73, faults_major=0, faults_minor=76808, mem_maxresident_kb=309180, user_cputime=530.81, sys_cputime=34.05, percent_cpu=4813%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.norec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2