__step=000250
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000250.txt
__path_data=data/data000250.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997564.344014301
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=2000000
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


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.007s
prefilling_size=999764 prefilling_elapsed_millis=1.001s
finished prefilling to size 999752 for expected size 1000000 keysum=999116089893, performing 31767616 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999752
pref_millis=1102
prefill_elapsed_ms=1122
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=1477

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997565.658037996
REALTIME_END_PERF_FORMAT=6997575.658170840

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

tree_stats_computeWalltime=0.033s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 121 228 423 746 1306 2284 3776 6011 9128 13336 18723 25202 32043 38369 43789 47934 50489 50994 50019 47237 43370 38321 32420 26320 20685 15627 11389 8154 5583 3717 2478 1689 1042 617 339 165 80 48 23 19 11 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 7 15 56 101 175 411 837 1572 2662 4310 6651 9819 13781 17575 21019 24080 26469 27380 27886 26898 25518 23285 20183 16730 13505 10418 7564 5646 3857 2548 1660 1199 744 470 265 120 53 41 10 13 10 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 122 235 438 802 1407 2459 4187 6848 10700 15998 23033 31853 41862 52150 61364 68953 74569 77463 77399 75123 70268 63839 55705 46503 37415 29132 21807 15718 11229 7574 5026 3349 2241 1361 809 430 200 101 64 29 24 14 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 122 235 438 802 1407 2459 4187 6848 10700 15998 23033 31853 41862 52150 61364 68953 74569 77463 77399 75123 70268 63839 55705 46503 37415 29132 21807 15718 11229 7574 5026 3349 2241 1361 809 430 200 101 64 29 24 14 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.93651 1.93443 1.89362 1.8653 1.82419 1.81947 1.77389 1.7337 1.68473 1.64206 1.60614 1.57005 1.52303 1.48032 1.44094 1.41008 1.38628 1.36173 1.34087 1.32435 1.30658 1.2913 1.27231 1.25281 1.23859 1.22577 1.21214 1.19851 1.19564 1.17731 1.17283 1.1733 1.16483 1.14235 1.14107 1.11248 1.0814 1.105 1.15842 1.09375 1.17241 1.125 1 1

tree_stats_height=50
tree_stats_numInternals=654385
tree_stats_numLeaves=345548
tree_stats_numNodes=999933
tree_stats_numKeys=999933

tree_stats_avgDegreeInternal=1.52805
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34557
tree_stats_avgKeyDepth=24.9327

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:75 2:1753 4:57418 8:369725 16:50927
    [2^00, 2^01]: 75
    (2^01, 2^02]: 1753
    (2^02, 2^03]: 57418
    (2^03, 2^04]: 369725
    (2^04, 2^05]: 50927
sum_limbo_reclamation_event_size_total=5413476
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9996 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998
count_limbo_reclamation_event_size_total=479898
sum_limbo_reclamation_event_count_total=986640
first_thread_announced_epoch_by_thread=44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064 44064
sum_num_inserts_by_thread=464863 469216 470516 471341 456041 460144 463464 466527 471717 473562 455659 469561 441574 447354 430331 473035 474271 464003 460931 471002 460017 474145 467681 464711 470638 471263 452576 473365 440855 469209 443924 474873 458880 474663 468683 473071 461603 463038 468916 476833 471849 459254 452326 469238 438941 476763 451297 470739
sum_num_inserts_total=22254463
sum_num_deletes_by_thread=465571 468240 470001 473023 456574 462597 464399 467019 471866 473576 455278 469362 441872 447258 430921 472740 475100 465924 461503 469472 458960 474174 467314 464218 471169 471225 453374 473560 440835 470199 444788 475336 459382 476208 468996 470678 460679 462884 470428 477278 471044 458998 452145 470018 437607 475617 451896 469798
sum_num_deletes_total=22261104
sum_num_searches_by_thread=8382702 8436801 8466741 8506943 8224365 8302777 8345002 8415214 8484011 8528486 8192492 8466293 7936158 8037862 7739392 8518601 8553519 8344542 8285478 8474482 8271496 8530944 8401148 8356730 8486013 8475905 8152043 8531942 7933808 8455010 8008894 8543750 8265377 8557991 8448891 8478091 8292541 8332029 8455805 8608153 8484856 8272111 8131779 8459386 7889980 8571285 8115553 8451837
sum_num_searches_total=400605209
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9313136 9374257 9407258 9451307 9136980 9225518 9272865 9348760 9427594 9475624 9103429 9405216 8819604 8932474 8600644 9464376 9502890 9274469 9207912 9414956 9190473 9479263 9336143 9285659 9427820 9418393 9057993 9478867 8815498 9394418 8897606 9493959 9183639 9508862 9386570 9421840 9214823 9257951 9395149 9562264 9427749 9190363 9036250 9398642 8766528 9523665 9018746 9392374
average_num_operations_total=9273349
stdev_num_operations_total=32889
sum_num_operations_total=445120776
min_num_operations_total=8600644
max_num_operations_total=9562264
first_time_thread_terminate_by_thread=10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132
min_time_thread_terminate_total=10000132
max_time_thread_terminate_total=10000132
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 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=999453209038
threads_final_size=999933
final_keysum=999453209038
final_size=999933
validate_result=success
Validation OK.
Structural validation OK.

total_find=400605209
total_rq=0
total_inserts=22254463
total_deletes=22261104
total_updates=44515567
total_queries=400605209
total_ops=445120776
find_throughput=40060520
rq_throughput=0
update_throughput=4451556
query_throughput=40060520
total_throughput=44512077


total find                    : 400605209
total rq                      : 0
total inserts                 : 22254463
total deletes                 : 22261104
total updates                 : 44515567
total queries                 : 400605209
total ops                     : 445120776
find throughput               : 40060520
rq throughput                 : 0
update throughput             : 4451556
query throughput              : 40060520
total throughput              : 44512077

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=8.38417
PAPI_L3_TCM=0.248795
PAPI_TOT_CYC=2829.66
PAPI_TOT_INS=1488.13
garbage=200327782685439
total_execution_walltime=11.442s
REALTIME_MAIN_END_PERF_FORMAT=6997575.796980349
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 476857459
[slow htm]
[fallback]
total fallback commit         : 30934
seconds global lock is held   : 0.272727
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=93017, mem_maxresident_kb=342372, user_cputime=561.92, sys_cputime=1.79, percent_cpu=4870%
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