__step=000602
__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=data000602.txt
__path_data=data/data000602.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986118.294632226
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.006s
prefilling_size=99626 prefilling_elapsed_millis=1.001s
finished prefilling to size 99663 for expected size 100000 keysum=9960586743, performing 66576906 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99663
pref_millis=1102
prefill_elapsed_ms=1123
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=3321

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6986119.578286533
REALTIME_END_PERF_FORMAT=6986129.578425899

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

tree_stats_computeWalltime=0.035s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 248 463 816 1420 2368 3714 5393 7041 8556 9830 10391 10358 9666 8203 6472 4902 3472 2427 1633 998 608 377 205 103 35 12 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 6 33 110 212 472 1022 2035 3745 5526 7282 9269 10424 11050 11129 9934 8042 6332 4517 3221 2268 1388 839 549 307 171 58 23 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 496 926 1632 2840 4736 7428 10786 14082 17112 19660 20782 20716 19332 16406 12944 9804 6944 4854 3266 1996 1216 754 410 206 70 24 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 6 33 110 212 472 1021 2035 3745 5526 7282 9269 10424 11050 11129 9934 8042 6332 4517 3221 2268 1388 839 549 307 171 58 23 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.97638 1.93347 1.88121 1.8701 1.8338 1.78399 1.72604 1.65279 1.60758 1.57445 1.52854 1.49841 1.4666 1.42432 1.39449 1.37871 1.35414 1.34951 1.33642 1.30557 1.30461 1.31003 1.27188 1.25122 1.1699 1.17143 1.04167 1

tree_stats_height=36
tree_stats_numInternals=99966
tree_stats_numLeaves=99967
tree_stats_numNodes=199933
tree_stats_numKeys=99966

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10160 19840 37040 65280 113600 189440 297120 431440 563280 684480 786400 831280 828640 773280 656240 517760 392160 277760 194160 130640 79840 48640 30160 16400 8240 2800 960 80
tree_stats_sizeInBytes=7997320

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:66 4:1444 8:50309 16:370438 32:57625 64:15
    (2^01, 2^02]: 66
    (2^02, 2^03]: 1444
    (2^03, 2^04]: 50309
    (2^04, 2^05]: 370438
    (2^05, 2^06]: 57625
    (2^06, 2^07]: 15
sum_limbo_reclamation_event_size_total=11070654
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9997 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998
count_limbo_reclamation_event_size_total=479897
sum_limbo_reclamation_event_count_total=2116655
first_thread_announced_epoch_by_thread=94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836 94836
sum_num_inserts_by_thread=1005734 1009720 1025607 1020343 1010490 999808 1009532 1016510 1030877 1034177 1017818 1018125 1013330 1019591 1026062 1029053 1022701 1015847 1004230 1018999 1025934 1031283 1015749 1006893 996873 1008256 1025246 1027275 1016458 1004786 1011040 1016364 1030764 1030958 1018297 1019104 1008316 1018753 1028563 1028794 1021180 1014198 1002193 1019051 1026988 1031702 1017606 1009760
sum_num_inserts_total=48860938
sum_num_deletes_by_thread=1004596 1009179 1023272 1022720 1011188 999560 1009529 1016654 1029447 1033635 1018042 1015829 1013464 1021920 1026738 1031710 1021546 1016754 1003678 1021579 1026033 1031827 1015824 1008506 998617 1007883 1024370 1026327 1017281 1005121 1012997 1017254 1029208 1031964 1014649 1017683 1010342 1021191 1028967 1031088 1023667 1014250 1003113 1018373 1026517 1033296 1016335 1009871
sum_num_deletes_total=48873594
sum_num_searches_by_thread=18095836 18160431 18438662 18397691 18177775 18018806 18170865 18295014 18556456 18613530 18335107 18302195 18232782 18363684 18467742 18542260 18398704 18296207 18058442 18368932 18443334 18577677 18291094 18130953 17974407 18127395 18445019 18484216 18309698 18071888 18210657 18299642 18530843 18571553 18322931 18317985 18147883 18398203 18501040 18562848 18392553 18245099 18042475 18332693 18493869 18610270 18304540 18202080
sum_num_searches_total=879633966
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=20106166 20179330 20487541 20440754 20199453 20018174 20189926 20328178 20616780 20681342 20370967 20336149 20259576 20405195 20520542 20603023 20442951 20328808 20066350 20409510 20495301 20640787 20322667 20146352 19969897 20143534 20494635 20537818 20343437 20081795 20234694 20333260 20590815 20634475 20355877 20354772 20166541 20438147 20558570 20622730 20437400 20273547 20047781 20370117 20547374 20675268 20338481 20221711
average_num_operations_total=20361843
stdev_num_operations_total=27647
sum_num_operations_total=977368498
min_num_operations_total=19969897
max_num_operations_total=20681342
first_time_thread_terminate_by_thread=10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000140
first_time_thread_start_by_thread=3 2 3 2 3 3 2 3 2 2 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 3 2 3 3 2 3 2 2 3 3 3 3 3 3 3 3 3 3 3 2 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=10003688836
threads_final_size=99966
final_keysum=10003688836
final_size=99966
validate_result=success
Validation OK.
Structural validation OK.

total_find=879633966
total_rq=0
total_inserts=48860938
total_deletes=48873594
total_updates=97734532
total_queries=879633966
total_ops=977368498
find_throughput=87963396
rq_throughput=0
update_throughput=9773453
query_throughput=87963396
total_throughput=97736849


total find                    : 879633966
total rq                      : 0
total inserts                 : 48860938
total deletes                 : 48873594
total updates                 : 97734532
total queries                 : 879633966
total ops                     : 977368498
find throughput               : 87963396
rq throughput                 : 0
update throughput             : 9773453
query throughput              : 87963396
total throughput              : 97736849

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.24664
PAPI_L3_TCM=0.000351964
PAPI_TOT_CYC=1364.7
PAPI_TOT_INS=305.286
garbage=43979881174082
total_execution_walltime=11.415s
REALTIME_MAIN_END_PERF_FORMAT=6986129.710825621
[time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=77731, mem_maxresident_kb=312808, user_cputime=561.22, sys_cputime=2.84, percent_cpu=4888%
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=2