__step=000314
__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=data000314.txt
__path_data=data/data000314.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982553.296136442
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=99830 prefilling_elapsed_millis=1.001s
finished prefilling to size 99795 for expected size 100000 keysum=9978414533, performing 64034774 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99795
pref_millis=1102
prefill_elapsed_ms=1125
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=2945

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982554.570362792
REALTIME_END_PERF_FORMAT=6982564.570503932

###############################################################################
################################## 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.034s

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8186 15720 21893 12571 2057 73 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 6 608 8255 24267 16320 2640 87
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16328 30148 36838 18377 2713 87
tree_stats_numKeysAtDepth=0 1 1 2 4 11 12 36 63 141 255 532 1024 2080 4428 10461 24886 35136 18210 2711 87
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 1.9939 1.88364 1.49572 1.15753 1.0357 1.00516 1

tree_stats_height=21
tree_stats_numInternals=68692
tree_stats_numLeaves=52183
tree_stats_numNodes=120875
tree_stats_numKeys=100081

tree_stats_avgDegreeInternal=1.75967
tree_stats_avgDegreeLeaves=0.999943
tree_stats_avgDegree=1.43169
tree_stats_avgKeyDepth=16.44

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 914368 1688288 2062928 1029112 151928 4872
tree_stats_sizeInBytes=6769000

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:145786 2:103582 4:12782 8:26
    [2^00, 2^01]: 145786
    (2^01, 2^02]: 103582
    (2^02, 2^03]: 12782
    (2^03, 2^04]: 26
sum_limbo_reclamation_event_size_total=437158
count_limbo_reclamation_event_size_by_thread=5495 5403 5556 5594 5587 5323 5402 5418 5678 5396 5526 5399 5310 5380 5636 5403 5539 5579 5329 5436 5456 5389 5313 5311 5423 5418 5522 5439 5459 5387 5322 5547 5369 5711 5591 5378 5449 5600 5392 5359 5573 5434 5568 5527 5374 5409 5583 5484
count_limbo_reclamation_event_size_total=262176
sum_limbo_reclamation_event_count_total=2041006
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=96198 97816 98933 98192 97806 97890 97919 98402 99387 100322 97797 98074 97908 98531 98461 99491 97859 97972 97803 98423 99004 99541 98828 96420 97384 98583 98383 99547 98406 97253 97714 97352 99857 98940 97902 98059 97263 97313 98415 100323 97882 98439 96024 96938 98146 99016 97139 96342
sum_num_inserts_total=4711597
sum_num_deletes_by_thread=96570 98676 98595 98831 98001 97775 97850 99105 99133 100252 98218 98932 98527 98623 98582 99679 98220 97789 97880 98734 99244 99500 97942 96764 97247 98470 97981 100143 98882 97387 96739 97540 99915 98875 97764 98570 96592 97888 98708 98977 98164 98246 96351 97274 98605 99382 97256 96129
sum_num_deletes_total=4716507
sum_num_searches_by_thread=19125848 19522208 19494393 19530478 19407925 19312294 19334573 19478777 19652488 19843852 19376201 19447646 19397448 19475113 19482891 19722346 19439291 19323635 19346470 19488009 19612799 19672770 19430784 19141786 19342543 19489050 19512772 19685174 19582329 19284695 19307684 19280941 19777442 19653251 19385049 19430506 19175955 19266769 19590003 19685368 19452446 19475693 19054867 19195769 19452390 19603262 19241141 19009279
sum_num_searches_total=932994403
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19318616 19718700 19691921 19727501 19603732 19507959 19530342 19676284 19851008 20044426 19572216 19644652 19593883 19672267 19679934 19921516 19635370 19519396 19542153 19685166 19811047 19871811 19627554 19334970 19537174 19686103 19709136 19884864 19779617 19479335 19502137 19475833 19977214 19851066 19580715 19627135 19369810 19461970 19787126 19884668 19648492 19672378 19247242 19389981 19649141 19801660 19435536 19201750
average_num_operations_total=19633802
stdev_num_operations_total=27280
sum_num_operations_total=942422507
min_num_operations_total=19201750
max_num_operations_total=20044426
first_time_thread_terminate_by_thread=10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000140 10000139 10000140
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000140
first_time_thread_start_by_thread=4 4 4 3 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 3 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 3 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10014971504
threads_final_size=100081
final_keysum=10014971504
final_size=100081
validate_result=success
Validation OK.
Structural validation OK.

total_find=932994403
total_rq=0
total_inserts=4711597
total_deletes=4716507
total_updates=9428104
total_queries=932994403
total_ops=942422507
find_throughput=93299440
rq_throughput=0
update_throughput=942810
query_throughput=93299440
total_throughput=94242250


total find                    : 932994403
total rq                      : 0
total inserts                 : 4711597
total deletes                 : 4716507
total updates                 : 9428104
total queries                 : 932994403
total ops                     : 942422507
find throughput               : 93299440
rq throughput                 : 0
update throughput             : 942810
query throughput              : 93299440
total throughput              : 94242250

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=7.41325
PAPI_L3_TCM=0.000187717
PAPI_TOT_CYC=1357.22
PAPI_TOT_INS=902.614
garbage=46645180977367
total_execution_walltime=11.398s
REALTIME_MAIN_END_PERF_FORMAT=6982564.695058608
[time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=76708, mem_maxresident_kb=308632, user_cputime=561.53, sys_cputime=3.37, percent_cpu=4896%
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=2