__step=000601
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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" ./guerraoui_ext_bst_ticket.debra -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=data000601.txt
__path_data=data/data000601.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986106.710741816
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=guerraoui_ext_bst_ticket
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=40
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.004s
prefilling_size=100232 prefilling_elapsed_millis=1.001s
finished prefilling to size 100187 for expected size 100000 keysum=9995389616, performing 65768179 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100187
pref_millis=1102
prefill_elapsed_ms=1116
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=3270

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6986107.970714423
REALTIME_END_PERF_FORMAT=6986117.970862680

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 495 876 1417 2228 3236 4443 5625 6703 7829 8703 9447 9875 9525 8611 7144 5308 3510 2177 1190 644 322 130 51 16 5 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 13 114 335 606 1220 2029 3261 4547 5577 6955 7959 9019 10225 10439 10078 8980 7106 4843 3164 1736 966 514 209 86 27 9 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 990 1752 2834 4456 6472 8886 11250 13406 15658 17406 18894 19750 19050 17222 14288 10616 7020 4354 2380 1288 644 260 102 32 10 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 13 113 335 606 1220 2029 3261 4547 5577 6955 7959 9019 10225 10439 10078 8980 7106 4843 3164 1736 966 514 209 86 27 9 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.97441 1.88384 1.80879 1.78617 1.72621 1.6865 1.63302 1.59582 1.58399 1.55582 1.54274 1.52265 1.48228 1.45202 1.41482 1.3715 1.33063 1.31011 1.27331 1.27059 1.25 1.20186 1.19615 1.15686 1.15625 1.1 1.5 1

tree_stats_height=37
tree_stats_numInternals=100021
tree_stats_numLeaves=100022
tree_stats_numNodes=200043
tree_stats_numKeys=100021

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=21.1258

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20320 39600 70080 113360 178240 258880 355440 450000 536240 626320 696240 755760 790000 762000 688880 571520 424640 280800 174160 95200 51520 25760 10400 4080 1280 400 80 80
tree_stats_sizeInBytes=8001720

6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=47104


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:68 4:1545 8:50636 16:369987 32:57660 64:3
    (2^01, 2^02]: 68
    (2^02, 2^03]: 1545
    (2^03, 2^04]: 50636
    (2^04, 2^05]: 369987
    (2^05, 2^06]: 57660
    (2^06, 2^07]: 3
sum_limbo_reclamation_event_size_total=11066056
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 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 9997 9997 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479899
sum_limbo_reclamation_event_count_total=2103990
first_thread_announced_epoch_by_thread=94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208 94208
sum_num_inserts_by_thread=994274 1002190 1018485 1012557 1010609 997516 1006194 1010784 1015722 1026841 1014586 1009954 1006055 1014549 1021527 1026729 1017461 1013579 1000389 1015233 1022301 1028641 1014191 999821 989440 1003707 1018863 1020230 1013143 1001863 1005331 1011027 1023948 1027514 1011793 1008621 1002486 1017090 1025846 1028912 1016104 1008450 998554 1009480 1019739 1027774 1016436 1003557
sum_num_inserts_total=48610096
sum_num_deletes_by_thread=993642 1001820 1018152 1014225 1009267 995388 1005322 1012303 1017292 1026610 1015496 1008036 1005671 1013688 1020663 1027257 1018355 1014709 999929 1015106 1022046 1027890 1011731 1001753 991563 1004697 1018404 1020185 1012597 1001338 1005843 1012820 1025273 1028324 1011579 1007608 1003193 1017153 1022764 1026880 1016012 1008118 996746 1010878 1019842 1027555 1016044 1004153
sum_num_deletes_total=48605920
sum_num_searches_by_thread=17889815 18029867 18334073 18249748 18186702 17925698 18099131 18210472 18319369 18491857 18253142 18176156 18111967 18238977 18367583 18479927 18309717 18244885 18006133 18265918 18385822 18515911 18224118 18013363 17838020 18074695 18344042 18344831 18238264 18019688 18101895 18219142 18431008 18494401 18223826 18171599 18035484 18275696 18457465 18502036 18281591 18150973 17951360 18163812 18343441 18517657 18280384 18078478
sum_num_searches_total=874870139
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19877731 20033877 20370710 20276530 20206578 19918602 20110647 20233559 20352383 20545308 20283224 20194146 20123693 20267214 20409773 20533913 20345533 20273173 20006451 20296257 20430169 20572442 20250040 20014937 19819023 20083099 20381309 20385246 20264004 20022889 20113069 20242989 20480229 20550239 20247198 20187828 20041163 20309939 20506075 20557828 20313707 20167541 19946660 20184170 20383022 20572986 20312864 20086188
average_num_operations_total=20251794
stdev_num_operations_total=28171
sum_num_operations_total=972086155
min_num_operations_total=19819023
max_num_operations_total=20572986
first_time_thread_terminate_by_thread=10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000148 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000148 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000148
first_time_thread_start_by_thread=3 3 3 3 2 2 3 2 3 3 3 2 3 3 3 2 3 3 3 2 3 3 3 3 3 3 3 3 2 2 3 2 3 3 3 2 3 3 3 2 3 3 3 2 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=9990917013
threads_final_size=100021
final_keysum=9990917013
final_size=100021
validate_result=success
Validation OK.
Structural validation OK.

total_find=874870139
total_rq=0
total_inserts=48610096
total_deletes=48605920
total_updates=97216016
total_queries=874870139
total_ops=972086155
find_throughput=87487013
rq_throughput=0
update_throughput=9721601
query_throughput=87487013
total_throughput=97208615


total find                    : 874870139
total rq                      : 0
total inserts                 : 48610096
total deletes                 : 48605920
total updates                 : 97216016
total queries                 : 874870139
total ops                     : 972086155
find throughput               : 87487013
rq throughput                 : 0
update throughput             : 9721601
query throughput              : 87487013
total throughput              : 97208615

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.2397
PAPI_L3_TCM=0.000575349
PAPI_TOT_CYC=1373.41
PAPI_TOT_INS=309.475
garbage=43752325202117
total_execution_walltime=11.398s
REALTIME_MAIN_END_PERF_FORMAT=6986118.110575867
[time_cmd_output] time_elapsed_sec=11.51, faults_major=0, faults_minor=77698, mem_maxresident_kb=312816, user_cputime=560.53, sys_cputime=2.94, percent_cpu=4893%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1