__step=000313
__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" ./bronson_pext_bst_occ.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000313.txt
__path_data=data/data000313.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982541.674840878
binary=./bronson_pext_bst_occ.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=bronson_pext_bst_occ
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=0.5
DEL_FRAC=0.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=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
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=100251 prefilling_elapsed_millis=1.001s
finished prefilling to size 100206 for expected size 100000 keysum=10023924161, performing 64507598 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100206
pref_millis=1102
prefill_elapsed_ms=1119
6node_tIxPvE_object_size=56
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=2961

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982542.962380771
REALTIME_END_PERF_FORMAT=6982552.962522976

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

tree_stats_computeWalltime=0.033s

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8177 15380 20020 13037 3290 183 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 15 910 9027 20911 16511 4259 221
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16290 29047 33948 19801 4442 221
tree_stats_numKeysAtDepth=0 1 1 2 4 8 18 28 66 130 271 490 1022 2095 4497 10719 24157 31921 19471 4428 221
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99036 1.83898 1.4795 1.19925 1.05818 1.00855 1

tree_stats_height=21
tree_stats_numInternals=68279
tree_stats_numLeaves=51854
tree_stats_numNodes=120133
tree_stats_numKeys=99550

tree_stats_avgDegreeInternal=1.75944
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.43164
tree_stats_avgKeyDepth=16.4903

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 912240 1626632 1901088 1108856 248752 12376
tree_stats_sizeInBytes=6727448

6node_tIxPvE_object_size=56
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=45466


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:146284 2:103051 4:12778 8:71 16:34 32:14
    [2^00, 2^01]: 146284
    (2^01, 2^02]: 103051
    (2^02, 2^03]: 12778
    (2^03, 2^04]: 71
    (2^04, 2^05]: 34
    (2^05, 2^06]: 14
sum_limbo_reclamation_event_size_total=438466
count_limbo_reclamation_event_size_by_thread=5532 5380 5689 5432 5378 5381 5413 5357 5599 5497 5528 5321 5408 5376 5484 5598 5594 5371 5456 5570 5603 5449 5554 5338 5534 5341 5589 5304 5575 5521 5398 5550 5444 5470 5418 5542 5347 5498 5482 5422 5551 5567 5334 5335 5388 5568 5414 5332
count_limbo_reclamation_event_size_total=262232
sum_limbo_reclamation_event_count_total=2040240
first_thread_announced_epoch_by_thread=90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932 90932
sum_num_inserts_by_thread=96861 97597 98315 99589 98896 97497 98521 97687 99077 99894 97786 97753 97220 98375 99262 98775 97914 98115 96754 96698 98477 99371 96726 96858 96678 98334 98189 98753 97909 97086 98613 97462 100062 100521 98783 97170 97538 97583 99693 99157 97818 97640 96500 97895 97991 98484 98348 96985
sum_num_inserts_total=4709210
sum_num_deletes_by_thread=97002 98290 98713 98648 99342 97327 98641 98091 98586 100720 98264 97702 98189 97761 99251 98198 98380 98230 96623 97509 98371 98656 97082 96892 96310 97560 98351 99285 97817 96886 98545 97688 100045 100440 98641 97191 98199 98027 99013 99214 97558 96922 96602 97846 98146 97965 98390 96936
sum_num_deletes_total=4710045
sum_num_searches_by_thread=19141836 19464133 19465792 19646056 19621668 19281990 19483826 19419201 19588174 19867868 19402364 19419544 19398829 19507329 19628039 19491205 19440313 19448664 19122912 19250657 19451984 19603966 19270581 19155992 19133150 19399765 19452820 19633670 19387648 19161438 19379358 19317797 19814667 19832878 19582141 19228434 19408606 19372984 19683374 19670497 19366526 19276055 19163495 19388631 19424676 19469067 19447514 19238655
sum_num_searches_total=932806769
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19335699 19660020 19662820 19844293 19819906 19476814 19680988 19614979 19785837 20068482 19598414 19614999 19594238 19703465 19826552 19688178 19636607 19645009 19316289 19444864 19648832 19801993 19464389 19349742 19326138 19595659 19649360 19831708 19583374 19355410 19576516 19512947 20014774 20033839 19779565 19422795 19604343 19568594 19882080 19868868 19561902 19470617 19356597 19584372 19620813 19665516 19644252 19432576
average_num_operations_total=19629708
stdev_num_operations_total=26995
sum_num_operations_total=942226024
min_num_operations_total=19316289
max_num_operations_total=20068482
first_time_thread_terminate_by_thread=10000140 10000140 10000140 10000141 10000141 10000141 10000140 10000141 10000140 10000140 10000141 10000140 10000140 10000141 10000140 10000140 10000141 10000140 10000141 10000140 10000141 10000140 10000140 10000141 10000140 10000140 10000140 10000141 10000141 10000141 10000140 10000141 10000140 10000140 10000141 10000140 10000140 10000141 10000140 10000140 10000141 10000140 10000141 10000140 10000141 10000140 10000140 10000141
min_time_thread_terminate_total=10000140
max_time_thread_terminate_total=10000141
first_time_thread_start_by_thread=4 4 3 4 3 3 4 3 4 4 4 4 4 4 4 3 4 4 4 3 3 3 4 4 4 4 3 4 3 3 4 3 4 4 4 4 4 4 4 3 4 4 4 3 3 3 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=9952351403
threads_final_size=99550
final_keysum=9952351403
final_size=99550
validate_result=success
Validation OK.
Structural validation OK.

total_find=932806769
total_rq=0
total_inserts=4709210
total_deletes=4710045
total_updates=9419255
total_queries=932806769
total_ops=942226024
find_throughput=93280676
rq_throughput=0
update_throughput=941925
query_throughput=93280676
total_throughput=94222602


total find                    : 932806769
total rq                      : 0
total inserts                 : 4709210
total deletes                 : 4710045
total updates                 : 9419255
total queries                 : 932806769
total ops                     : 942226024
find throughput               : 93280676
rq throughput                 : 0
update throughput             : 941925
query throughput              : 93280676
total throughput              : 94222602

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=7.41789
PAPI_L3_TCM=0.000149515
PAPI_TOT_CYC=1358.61
PAPI_TOT_INS=905.744
garbage=45668358312995
total_execution_walltime=11.419s
REALTIME_MAIN_END_PERF_FORMAT=6982553.95276105
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=76833, mem_maxresident_kb=309412, user_cputime=558.98, sys_cputime=2.29, percent_cpu=4863%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1