__step=000481
__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" ./ellen_ext_bst_lf.debra -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=data000481.txt
__path_data=data/data000481.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984700.468742433
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=ellen_ext_bst_lf
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=40 descriptor=64
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.003s
prefilling_size=1000561 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000651 for expected size 1000000 keysum=1000172823756, performing 26357034 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000651
pref_millis=1102
prefill_elapsed_ms=1121
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=1269

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984701.745378911
REALTIME_END_PERF_FORMAT=6984711.745545123

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 63 113 207 368 657 1155 2012 3477 5822 9452 14702 22157 31580 42862 54748 65899 75943 83521 87821 87791 83005 74640 63604 52002 40934 30895 22299 15364 10263 6572 4180 2439 1374 778 392 159 55 28 2 1 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 1 13 19 46 79 159 298 547 1132 2192 4202 7247 12734 20298 30976 43597 55855 68365 79221 87851 92577 91370 85676 75206 63070 50973 39491 29234 20465 13954 8964 5921 3504 1970 1164 625 263 82 54 3 1 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 126 226 414 736 1314 2310 4024 6954 11644 18904 29404 44314 63160 85724 109496 131798 151886 167042 175642 175582 166010 149280 127208 104004 81868 61790 44598 30728 20526 13144 8360 4878 2748 1556 784 318 110 56 4 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 13 19 46 79 159 298 547 1132 2192 4202 7247 12734 20298 30976 43597 55855 68365 79221 87851 92577 91370 85676 75206 63070 50973 39491 29234 20465 13954 8964 5921 3504 1970 1164 625 263 82 54 3 1 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 1.98438 1.89683 1.91593 1.88889 1.89266 1.879 1.871 1.86407 1.83722 1.81175 1.77772 1.75354 1.71264 1.67863 1.63865 1.60184 1.57621 1.54989 1.52574 1.49983 1.47274 1.44961 1.42607 1.4088 1.39358 1.37738 1.36088 1.3445 1.334 1.32018 1.31802 1.29175 1.28167 1.28311 1.25193 1.20281 1.17296 1.25455 1.03571 1.25 1.5 1

tree_stats_height=50
tree_stats_numInternals=999402
tree_stats_numLeaves=999403
tree_stats_numNodes=1998805
tree_stats_numKeys=999401

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999998
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=28.4976

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5040 9040 16560 29440 52560 92400 160960 278160 465760 756160 1176160 1772560 2526400 3428960 4379840 5271920 6075440 6681680 7025680 7023280 6640400 5971200 5088320 4160160 3274720 2471600 1783920 1229120 821040 525760 334400 195120 109920 62240 31360 12720 4400 2240 160 80 80
tree_stats_sizeInBytes=79952200

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

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:20 8:11868 16:305387 32:162473 64:60
    (2^02, 2^03]: 20
    (2^03, 2^04]: 11868
    (2^04, 2^05]: 305387
    (2^05, 2^06]: 162473
    (2^06, 2^07]: 60
sum_limbo_reclamation_event_size_total=13751816
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=479808
sum_limbo_reclamation_event_count_total=1612608
first_thread_announced_epoch_by_thread=36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134 36134
sum_num_inserts_by_thread=381839 384259 388238 387360 385810 381648 383115 385547 387925 389802 386090 382671 385000 384822 388908 387971 386410 382819 381857 383810 385837 388951 383102 380182 380626 383679 387742 387145 386287 382123 383575 384817 390008 389013 385279 382070 383409 385746 387781 388406 385495 382550 380046 383319 386768 387854 384804 380986
sum_num_inserts_total=18483501
sum_num_deletes_by_thread=381738 384060 387866 386729 384369 383329 383347 385548 390408 389555 385863 383181 385475 385061 388662 387460 387330 382488 380583 383257 387261 388118 383095 380220 380486 383391 387184 386574 384931 381112 383032 385172 390380 389371 386316 382955 382613 385637 388466 389186 385757 382696 381376 383688 387449 388264 383049 380286
sum_num_deletes_total=18484374
sum_num_searches_by_thread=6881964 6909837 6979667 6962143 6934636 6868739 6889437 6933530 7002024 7025049 6943630 6894393 6909329 6929233 7000107 6995557 6949900 6903438 6861159 6911343 6964284 6991953 6904873 6846273 6860168 6902036 6970050 6968668 6950400 6868241 6898832 6924873 7009691 7010529 6952704 6890784 6916626 6940473 7000017 6999109 6946786 6896699 6858024 6893767 6957382 6986810 6907020 6856500
sum_num_searches_total=332758687
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7645541 7678156 7755771 7736232 7704815 7633716 7655899 7704625 7780357 7804406 7715583 7660245 7679804 7699116 7777677 7770988 7723640 7668745 7623599 7678410 7737382 7769022 7671070 7606675 7621280 7669106 7744976 7742387 7721618 7631476 7665439 7694862 7790079 7788913 7724299 7655809 7682648 7711856 7776264 7776701 7718038 7661945 7619446 7660774 7731599 7762928 7674873 7617772
average_num_operations_total=7702636
stdev_num_operations_total=7913
sum_num_operations_total=369726562
min_num_operations_total=7606675
max_num_operations_total=7804406
first_time_thread_terminate_by_thread=10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000164 10000165 10000164 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000165 10000164 10000165 10000164 10000165 10000165 10000165 10000165 10000165
min_time_thread_terminate_total=10000164
max_time_thread_terminate_total=10000165
first_time_thread_start_by_thread=3 3 3 3 3 3 3 2 3 3 3 3 3 2 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 2 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=999176482292
threads_final_size=999401
final_keysum=999176482292
final_size=999401
validate_result=success
Validation OK.
Structural validation OK.

total_find=332758687
total_rq=0
total_inserts=18483501
total_deletes=18484374
total_updates=36967875
total_queries=332758687
total_ops=369726562
find_throughput=33275868
rq_throughput=0
update_throughput=3696787
query_throughput=33275868
total_throughput=36972656


total find                    : 332758687
total rq                      : 0
total inserts                 : 18483501
total deletes                 : 18484374
total updates                 : 36967875
total queries                 : 332758687
total ops                     : 369726562
find throughput               : 33275868
rq throughput                 : 0
update throughput             : 3696787
query throughput              : 33275868
total throughput              : 36972656

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=22.3937
PAPI_L3_TCM=4.61946
PAPI_TOT_CYC=3617.37
PAPI_TOT_INS=379.317
garbage=166397789140603
total_execution_walltime=11.414s
REALTIME_MAIN_END_PERF_FORMAT=6984711.884229002
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=102255, mem_maxresident_kb=402764, user_cputime=560.73, sys_cputime=2.40, percent_cpu=4879%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1