__step=000193
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000193.txt
__path_data=data/data000193.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=222207.312018548
binary=./brown_int_bst_tm_auto.debra.norec
parsed custom binding: 0-63,128-191,64-127,192-255
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=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.02s
prefilling_size=98078 prefilling_elapsed_millis=1s
finished prefilling to size 98062 for expected size 100000 keysum=9784952195, performing 791303 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=98062
pref_millis=1101
prefill_elapsed_ms=1109
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=37

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=222208.459147450
REALTIME_END_PERF_FORMAT=222218.459245145

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

tree_stats_computeWalltime=0.082s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 123 234 418 715 1188 1871 2771 3771 4777 5732 6384 6611 6333 5818 5013 4095 3213 2296 1612 1048 660 385 201 104 47 25 4 3 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 3 7 25 67 135 278 515 991 1476 2061 2694 3269 3602 3689 3462 3123 2610 2181 1537 1129 726 479 295 149 81 33 26 3 2 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 241 443 782 1323 2149 3286 4762 6253 7793 9078 9880 9935 9507 8475 7218 5823 4477 3149 2177 1386 864 496 253 128 58 30 6 4 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 241 443 782 1323 2149 3286 4762 6253 7793 9078 9880 9935 9507 8475 7218 5823 4477 3149 2177 1386 864 496 253 128 58 30 6 4 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.93651 1.86722 1.82167 1.77749 1.72638 1.65845 1.6059 1.52121 1.48233 1.42936 1.38511 1.33644 1.31948 1.27948 1.26018 1.2394 1.21707 1.19053 1.17942 1.15526 1.14719 1.12847 1.10484 1.09486 1.08594 1.08621 1.06667 1.16667 1.25 1

tree_stats_height=37
tree_stats_numInternals=65580
tree_stats_numLeaves=34652
tree_stats_numNodes=100232
tree_stats_numKeys=100232

tree_stats_avgDegreeInternal=1.52839
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34572
tree_stats_avgKeyDepth=18.9447

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:34 2:899 4:29095 8:238701 16:72729 32:168 64:1
    [2^00, 2^01]: 34
    (2^01, 2^02]: 899
    (2^02, 2^03]: 29095
    (2^03, 2^04]: 238701
    (2^04, 2^05]: 72729
    (2^05, 2^06]: 168
    (2^06, 2^07]: 1
sum_limbo_reclamation_event_size_total=4282187
count_limbo_reclamation_event_size_by_thread=5338 5338 5338 5336 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5338 5337 5338 5338 5337 5338 5338 5338 5338 5338 5337 5338 5338 5338
count_limbo_reclamation_event_size_total=341627
sum_limbo_reclamation_event_count_total=341759
first_thread_announced_epoch_by_thread=10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754 10754
sum_commit_tx_reader_total=162756854
sum_commit_tx_reader_by_thread=0 2323417 2561296 2500033 2276207 3104294 2564164 3072195 2503067 2544500 2571971 2591589 3058499 2577274 2715636 2282335 2339504 2723637 2625537 2404693 2488877 2274855 2409119 2423149 3185822 2937537 2992500 3077291 2982114 3194737 3102547 3027700 2512228 2556782 3184286 2276674 2968703 2460660 2564051 2437103 2321295 2592049 3151344 2509789 2447142 2566024 2378568 2048756 2170168 2211869 2060016 2025460 2032798 3063683 2244222 2112921 2171545 2069129 2263388 2142631 2087957 2183500 2265204 2133371 3107442
sum_commit_tx_writer_total=8569890
sum_commit_tx_writer_by_thread=0 123042 134756 130982 120320 163598 135945 161215 131331 133677 135836 136785 160280 136178 143190 119897 123468 143547 138153 126753 131251 119691 126859 128124 166869 154058 157750 161630 156483 167533 163609 159722 132990 134342 168179 119867 156431 129381 135707 128341 122139 136899 165919 131858 129024 135115 125062 107607 113605 116683 108292 105966 107288 161349 118058 111959 114304 109680 118544 113527 109464 114895 118940 112617 163326
sum_abort_tx_total=27959
sum_abort_tx_by_thread=0 471 451 444 453 383 389 425 411 401 452 436 424 412 437 435 435 475 454 421 428 419 452 472 429 382 394 391 406 404 411 442 412 427 385 476 398 457 428 415 449 430 395 424 461 462 471 487 471 446 476 467 455 358 464 435 437 478 467 498 462 491 433 476 429
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 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=11.5:5 19:71 26.5:1117 34:5174 41.5:18371 49:22751 56.5:12750 64:3017 71.5:687 79:56
    [        4.00,        11.50]: 5
    (       11.50,        19.00]: 71
    (       19.00,        26.50]: 1117
    (       26.50,        34.00]: 5174
    (       34.00,        41.50]: 18371
    (       41.50,        49.00]: 22751
    (       49.00,        56.50]: 12750
    (       56.50,        64.00]: 3017
    (       64.00,        71.50]: 687
    (       71.50,        79.00]: 56

linear_histogram_of_none_tx_wrset_size_full_data=1.4:20785 3.4:10750
    [        1.00,         1.40]: 20785
    (        3.00,         3.40]: 10750
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=168250 167612 165647 163410 161291 163763 167206 159693 157023 157680 162209 154100 162821 156374 160935 160878 131637 142892 143695 138212 134403 135810 135898 135472 133164 135077 136587 131819 131584 135005 136341 133499 122272 127827 126623 120089 120131 126835 129607 128261 120146 123739 131425 119405 122234 128326 134959 125074 108058 113737 116341 108141 106234 107220 118514 111698 109137 114135 118583 112935 109852 115542 119377 112702
sum_num_inserts_total=8569146
sum_num_deletes_by_thread=167417 168297 165987 163661 161582 163322 168897 160024 156560 157104 161517 154911 163985 157019 161723 160971 131281 143836 143282 138424 134418 135593 135956 135109 132503 135321 136457 132124 131438 135043 136741 134353 122488 127714 126443 120266 119872 126141 129624 128256 120539 122540 131055 119777 122215 129443 135158 125417 107886 113913 117137 108247 106010 106872 118073 111718 109110 114525 119272 113353 109799 114426 119081 112130
sum_num_deletes_total=8573356
sum_num_searches_by_thread=3017024 3026361 2985629 2940821 2902159 2939071 3016362 2867705 2825014 2835466 2915195 2782584 2943962 2811741 2910752 2896930 2368097 2580456 2571849 2487054 2422303 2428706 2441598 2437226 2379551 2429360 2455904 2377704 2371376 2426004 2455292 2410325 2201699 2295732 2282912 2156172 2156538 2278470 2330810 2308927 2161547 2216693 2357648 2155364 2198985 2318397 2431022 2253139 1940419 2056123 2095074 1951920 1919182 1925994 2125693 2001464 1960562 2057189 2144077 2029870 1977770 2068427 2145686 2021156
sum_num_searches_total=154184242
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3352691 3362270 3317263 3267892 3225032 3266156 3352465 3187422 3138597 3150250 3238921 3091595 3270768 3125134 3233410 3218779 2631015 2867184 2858826 2763690 2691124 2700109 2713452 2707807 2645218 2699758 2728948 2641647 2634398 2696052 2728374 2678177 2446459 2551273 2535978 2396527 2396541 2531446 2590041 2565444 2402232 2462972 2620128 2394546 2443434 2576166 2701139 2503630 2156363 2283773 2328552 2168308 2131426 2140086 2362280 2224880 2178809 2285849 2381932 2256158 2197421 2298395 2384144 2245988
average_num_operations_total=2676980
stdev_num_operations_total=47128
sum_num_operations_total=171326744
min_num_operations_total=2131426
max_num_operations_total=3362270
first_time_thread_terminate_by_thread=10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000101 10000101 10000101 10000101 10000098 10000098 10000098 10000099 10000098 10000103 10000098 10000098 10000098 10000098 10000098 10000098 10000101 10000101 10000101 10000102 10000099 10000099 10000104 10000099 10000100 10000100 10000100 10000100 10000101 10000101 10000101 10000101 10000102 10000102 10000102 10000102 10000099 10000099 10000104 10000099 10000100 10000104 10000099 10000099 10000101 10000101 10000101 10000101
min_time_thread_terminate_total=10000097
max_time_thread_terminate_total=10000104
first_time_thread_start_by_thread=3 3 3 3 2 2 2 2 4 3 4 4 3 3 3 3 6 6 6 5 5 5 5 5 4 4 4 4 6 6 6 6 5 4 4 5 4 4 4 4 5 5 5 5 3 3 3 3 4 4 4 4 6 6 6 6 3 3 3 3 5 5 5 5
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=10025782312
threads_final_size=100232
final_keysum=10025782312
final_size=100232
validate_result=success
Validation OK.
Structural validation OK.

total_find=154184242
total_rq=0
total_inserts=8569146
total_deletes=8573356
total_updates=17142502
total_queries=154184242
total_ops=171326744
find_throughput=15418424
rq_throughput=0
update_throughput=1714250
query_throughput=15418424
total_throughput=17132674


total find                    : 154184242
total rq                      : 0
total inserts                 : 8569146
total deletes                 : 8573356
total updates                 : 17142502
total queries                 : 154184242
total ops                     : 171326744
find throughput               : 15418424
rq throughput                 : 0
update throughput             : 1714250
query throughput              : 15418424
total throughput              : 17132674

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=547982335044
total_execution_walltime=11.401s
REALTIME_MAIN_END_PERF_FORMAT=222218.713712840
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=11.50, faults_major=0, faults_minor=77135, mem_maxresident_kb=308944, user_cputime=718.88, sys_cputime=17.41, percent_cpu=6401%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.norec
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1