__step=000673
__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" ./brown_ext_abtree_lf.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000673.txt
__path_data=data/data000673.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=214896.630331886
binary=./brown_ext_abtree_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_ext_abtree_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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
size_node=208
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.018s
prefilling_size=8534753 prefilling_elapsed_millis=1s
prefilling_size=8792718 prefilling_elapsed_millis=1.101s
prefilling_size=9002612 prefilling_elapsed_millis=1.201s
prefilling_size=9172256 prefilling_elapsed_millis=1.301s
prefilling_size=9318240 prefilling_elapsed_millis=1.401s
prefilling_size=9443061 prefilling_elapsed_millis=1.502s
prefilling_size=9545474 prefilling_elapsed_millis=1.602s
prefilling_size=9627905 prefilling_elapsed_millis=1.702s
prefilling_size=9695088 prefilling_elapsed_millis=1.802s
prefilling_size=9752524 prefilling_elapsed_millis=1.903s
prefilling_size=9799079 prefilling_elapsed_millis=2.003s
prefilling_size=9835411 prefilling_elapsed_millis=2.103s
finished prefilling to size 9835404 for expected size 10000000 keysum=98359733737064, performing 84908466 updates; total_prefilling_elapsed_ms=2204 ms)
pref_size=9835404
pref_millis=2204
prefill_elapsed_ms=2218
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=2618
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=214898.891525341
REALTIME_END_PERF_FORMAT=214908.891613925
###############################################################################
################################## 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 (256 threads)...
partitioned into 4484 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.162s
tree_stats_numInternalsAtDepth=1 1 10 79 597 4484 33796 264340 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1964523
tree_stats_numNodesAtDepth=1 1 10 79 597 4484 33796 264340 1964523
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9998292
tree_stats_avgDegreeAtDepth=1 10 7.9 7.55696 7.51089 7.53702 7.82164 7.4318 5.08942
tree_stats_height=9
tree_stats_numInternals=303308
tree_stats_numLeaves=1964523
tree_stats_numNodes=2267831
tree_stats_numKeys=9998292
tree_stats_avgDegreeInternal=7.47699
tree_stats_avgDegreeLeaves=5.08942
tree_stats_avgDegree=5.40875
tree_stats_avgKeyDepth=8
tree_stats_bytesAtDepth=208 208 2080 16432 124176 932672 7029568 54982720 408620784
tree_stats_sizeInBytes=471708848
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0
global_epoch_counter=15236
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:79 2:2 4:1 8:2 16:11 32:34 64:704 128:172339 256:466564 512:0 1024:0 2048:63
[2^00, 2^01]: 79
(2^01, 2^02]: 2
(2^02, 2^03]: 1
(2^03, 2^04]: 2
(2^04, 2^05]: 11
(2^05, 2^06]: 34
(2^06, 2^07]: 704
(2^07, 2^08]: 172339
(2^08, 2^09]: 466564
(2^09, 2^10]: 0
(2^10, 2^11]: 0
(2^11, 2^12]: 63
sum_limbo_reclamation_event_size_total=174997089
count_limbo_reclamation_event_size_by_thread=9997 9997 9997 9996 9998 9998 9997 9996 9996 9995 9998 9998 9996 9997 9996 9997 9998 9996 9997 9997 9996 9997 9997 9997 9996 9998 9997 9998 9998 9996 9996 9998 9998 9997 9996 9996 9996 9997 9996 9997 9998 9996 9997 9998 9997 9997 9996 9996 9997 9995 9996 9997 9997 9997 9997 9997 9997 9996 9998 9997 9998 9998 9997 9996
count_limbo_reclamation_event_size_total=639799
sum_limbo_reclamation_event_count_total=807035
first_thread_announced_epoch_by_thread=30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472 30472
sum_num_inserts_by_thread=3299938 3401722 3350993 3380769 3371424 3300001 3339357 3271282 3340815 3269816 3316217 3324800 3382894 3328981 3367267 3321634 3396685 3357210 3294613 3240736 3287113 3237376 3256899 3215561 3273897 3229144 3299627 3275906 3330851 3302001 3303863 3283448 3337465 3279653 3247387 3302257 3335330 3302839 3303991 3277062 3383397 3327517 3370637 3332735 3375619 3351301 3371012 3295299 3351659 3306582 3320571 3278496 3303084 3262973 3320445 3293280 3344688 3297506 3328967 3314579 3358741 3308259 3323113 3324672
sum_num_inserts_total=212183956
sum_num_deletes_by_thread=3297537 3399391 3353328 3383458 3375100 3298867 3343349 3271359 3341419 3271210 3316438 3327270 3382258 3327517 3365375 3324519 3396463 3358029 3297319 3242699 3290468 3235739 3253919 3218151 3271671 3229716 3300220 3278433 3333726 3305599 3303319 3281934 3340737 3277004 3244344 3301211 3334952 3304054 3302960 3275888 3379064 3333392 3369894 3331812 3380267 3352225 3373416 3298332 3349499 3306351 3321670 3276910 3305191 3258648 3320299 3295951 3346052 3293495 3333626 3311997 3360290 3306810 3324803 3323623
sum_num_deletes_total=212210567
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6597475 6801113 6704321 6764227 6746524 6598868 6682706 6542641 6682234 6541026 6632655 6652070 6765152 6656498 6732642 6646153 6793148 6715239 6591932 6483435 6577581 6473115 6510818 6433712 6545568 6458860 6599847 6554339 6664577 6607600 6607182 6565382 6678202 6556657 6491731 6603468 6670282 6606893 6606951 6552950 6762461 6660909 6740531 6664547 6755886 6703526 6744428 6593631 6701158 6612933 6642241 6555406 6608275 6521621 6640744 6589231 6690740 6591001 6662593 6626576 6719031 6615069 6647916 6648295
average_num_operations_total=6631164
stdev_num_operations_total=10646
sum_num_operations_total=424394523
min_num_operations_total=6433712
max_num_operations_total=6801113
first_time_thread_terminate_by_thread=10000091 10000091 10000091 10000091 10000090 10000090 10000090 10000090 10000088 10000088 10000088 10000088 10000091 10000091 10000091 10000091 10000090 10000090 10000090 10000090 10000087 10000088 10000088 10000088 10000090 10000090 10000090 10000090 10000089 10000089 10000088 10000088 10000090 10000090 10000090 10000090 10000091 10000091 10000090 10000091 10000088 10000088 10000088 10000096 10000089 10000089 10000089 10000089 10000089 10000090 10000089 10000104 10000089 10000089 10000108 10000089 10000109 10000088 10000088 10000088 10000094 10000091 10000091 10000091
min_time_thread_terminate_total=10000087
max_time_thread_terminate_total=10000109
first_time_thread_start_by_thread=6 6 6 6 9 9 9 9 8 8 8 8 9 9 9 9 8 8 8 8 10 10 10 10 7 7 7 7 11 11 11 11 9 9 9 9 7 7 7 7 11 11 11 11 12 12 12 12 8 8 8 8 10 10 10 10 5 5 5 5 7 6 7 7
min_time_thread_start_total=5
max_time_thread_start_total=12
sum_duration_all_ops_total=
threads_final_keysum=99981016525812
threads_final_size=9998292
final_keysum=99981016525812
final_size=9998292
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=212183956
total_deletes=212210567
total_updates=424394523
total_queries=0
total_ops=424394523
find_throughput=0
rq_throughput=0
update_throughput=42439452
query_throughput=0
total_throughput=42439452
total find : 0
total rq : 0
total inserts : 212183956
total deletes : 212210567
total updates : 424394523
total queries : 0
total ops : 424394523
find throughput : 0
rq throughput : 0
update throughput : 42439452
query throughput : 0
total throughput : 42439452
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=12.505s
REALTIME_MAIN_END_PERF_FORMAT=214909.136726699
[time_cmd_output] time_elapsed_sec=12.64, faults_major=0, faults_minor=212441, mem_maxresident_kb=849700, user_cputime=817.79, sys_cputime=8.81, percent_cpu=6535%
timeout=false
algorithm=brown_ext_abtree_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1