__step=000425
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000425.txt
__path_data=data/data000425.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=211993.556969858
binary=./bronson_pext_bst_occ.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=5
DEL_FRAC=5
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=5.0 5.0
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,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.017s
prefilling_size=7841180 prefilling_elapsed_millis=1s
prefilling_size=8119868 prefilling_elapsed_millis=1.101s
prefilling_size=8360298 prefilling_elapsed_millis=1.201s
prefilling_size=8567164 prefilling_elapsed_millis=1.301s
prefilling_size=8750142 prefilling_elapsed_millis=1.401s
prefilling_size=8907097 prefilling_elapsed_millis=1.501s
prefilling_size=9045741 prefilling_elapsed_millis=1.601s
prefilling_size=9167994 prefilling_elapsed_millis=1.701s
prefilling_size=9272289 prefilling_elapsed_millis=1.801s
prefilling_size=9362255 prefilling_elapsed_millis=1.902s
prefilling_size=9440598 prefilling_elapsed_millis=2.002s
prefilling_size=9510315 prefilling_elapsed_millis=2.102s
prefilling_size=9568370 prefilling_elapsed_millis=2.202s
prefilling_size=9621022 prefilling_elapsed_millis=2.302s
prefilling_size=9667390 prefilling_elapsed_millis=2.402s
prefilling_size=9709797 prefilling_elapsed_millis=2.502s
prefilling_size=9745238 prefilling_elapsed_millis=2.602s
prefilling_size=9777894 prefilling_elapsed_millis=2.703s
prefilling_size=9805608 prefilling_elapsed_millis=2.803s
finished prefilling to size 9805590 for expected size 10000000 keysum=98035239860489, performing 79469809 updates; total_prefilling_elapsed_ms=2903 ms)
pref_size=9805590
pref_millis=2903
prefill_elapsed_ms=2917
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=2025
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=211996.506980794
REALTIME_END_PERF_FORMAT=212006.507079732
###############################################################################
################################## 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 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.069s
tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262099 521609 992732 1585239 1733496 1082827 330127 37209 598 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 44 2388 44733 337971 1153896 1816281 1329133 429252 47975 724
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 523997 1037465 1923210 2887392 2899108 1659260 466461 48573 724
tree_stats_numKeysAtDepth=0 0 1 1 5 9 16 32 61 131 257 503 961 2037 4142 8247 16332 33077 66106 134555 283677 640217 1423918 2486093 2720192 1621878 463702 48553 724
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99999 1.99907 1.98446 1.89687 1.67706 1.40368 1.19881 1.08215 1.02434 1.00259 1
tree_stats_height=29
tree_stats_numInternals=6808080
tree_stats_numLeaves=5162397
tree_stats_numNodes=11970477
tree_stats_numKeys=9955427
tree_stats_avgDegreeInternal=1.75828
tree_stats_avgDegreeLeaves=0.999971
tree_stats_avgDegree=1.43125
tree_stats_avgKeyDepth=23.2681
tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680008 29343832 58098040 107699760 161693952 162350048 92918560 26121816 2720088 40544
tree_stats_sizeInBytes=670346712
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=9785
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:116 2:2429 4:55876 8:351073 16:86656 32:356
[2^00, 2^01]: 116
(2^01, 2^02]: 2429
(2^02, 2^03]: 55876
(2^03, 2^04]: 351073
(2^04, 2^05]: 86656
(2^05, 2^06]: 356
sum_limbo_reclamation_event_size_total=5940682
count_limbo_reclamation_event_size_by_thread=7758 7758 7758 7756 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7757 7758 7758 7758 7758 7758 7757 7758 7758 7758 7758 7758 7758 7758 7758 7758 7757 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7758 7757 7758 7758 7758 7758 7758 7758 7758 7758
count_limbo_reclamation_event_size_total=496506
sum_limbo_reclamation_event_count_total=496640
first_thread_announced_epoch_by_thread=19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570 19570
sum_num_inserts_by_thread=243226 243215 241038 239677 240686 240179 241331 241128 238139 237468 238501 235617 236677 236373 235849 239551 240823 241022 240669 239074 239719 240219 239142 239435 236563 237115 235299 237535 237255 240460 240369 238113 242532 241484 240746 240828 240517 237911 238382 238659 237964 236405 237374 242296 241213 241708 241469 241432 241030 240287 236743 237042 238045 237355 235280 236826 234973 241099 238829 239800 240557 240534 239296 239115
sum_num_inserts_total=15309198
sum_num_deletes_by_thread=243408 242712 241103 239342 240290 241572 241572 241349 238011 237011 237518 237458 236242 235960 235709 238481 240762 241357 241654 239637 240279 238686 238677 239143 236538 237498 235825 236912 237342 240285 240657 239307 242388 242093 241603 241015 241506 238881 238618 238817 238408 236503 237949 242081 242483 241612 240900 239868 240471 240050 236537 238827 237392 236408 235017 237619 234936 241285 239155 239844 241125 240976 238375 239072
sum_num_deletes_total=15314111
sum_num_searches_by_thread=4374405 4373003 4329147 4311570 4337464 4331573 4345614 4343909 4293253 4279898 4283356 4254355 4257851 4261126 4236615 4305567 4332840 4349970 4339267 4307434 4322832 4316999 4293960 4307191 4268762 4266338 4250736 4272750 4274226 4324058 4325610 4295278 4360182 4356356 4346816 4340788 4336183 4293622 4292746 4292074 4284132 4260405 4270566 4349610 4350015 4346139 4329650 4329270 4330611 4328264 4273683 4277251 4279448 4250823 4233767 4257673 4238073 4345873 4299775 4318752 4334218 4337728 4300882 4305981
sum_num_searches_total=275618313
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4861039 4858930 4811288 4790589 4818440 4813324 4828517 4826386 4769403 4754377 4759375 4727430 4730770 4733459 4708173 4783599 4814425 4832349 4821590 4786145 4802830 4795904 4771779 4785769 4741863 4740951 4721860 4747197 4748823 4804803 4806636 4772698 4845102 4839933 4829165 4822631 4818206 4770414 4769746 4769550 4760504 4733313 4745889 4833987 4833711 4829459 4812019 4810570 4812112 4808601 4746963 4753120 4754885 4724586 4704064 4732118 4707982 4828257 4777759 4798396 4815900 4819238 4778553 4784168
average_num_operations_total=4785025
stdev_num_operations_total=5102
sum_num_operations_total=306241622
min_num_operations_total=4704064
max_num_operations_total=4861039
first_time_thread_terminate_by_thread=10000104 10000104 10000104 10000104 10000101 10000100 10000100 10000100 10000104 10000104 10000104 10000104 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000102 10000105 10000105 10000106 10000106 10000102 10000102 10000102 10000102 10000103 10000103 10000103 10000103 10000105 10000105 10000105 10000105 10000101 10000101 10000101 10000101 10000100 10000101 10000100 10000101 10000104 10000104 10000104 10000104 10000104 10000103 10000104 10000104 10000101 10000102 10000101 10000101 10000105 10000105 10000105 10000105 10000100 10000100 10000100 10000100
min_time_thread_terminate_total=10000100
max_time_thread_terminate_total=10000106
first_time_thread_start_by_thread=6 6 6 6 4 4 4 4 3 3 3 3 5 5 5 5 4 4 4 4 7 7 7 7 5 5 4 4 6 6 6 6 5 5 5 5 8 8 8 8 5 5 5 5 7 7 7 7 8 8 8 8 8 8 8 8 7 7 7 7 9 9 9 9
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=99533758479227
threads_final_size=9955427
final_keysum=99533758479227
final_size=9955427
validate_result=success
Validation OK.
Structural validation OK.
total_find=275618313
total_rq=0
total_inserts=15309198
total_deletes=15314111
total_updates=30623309
total_queries=275618313
total_ops=306241622
find_throughput=27561831
rq_throughput=0
update_throughput=3062330
query_throughput=27561831
total_throughput=30624162
total find : 275618313
total rq : 0
total inserts : 15309198
total deletes : 15314111
total updates : 30623309
total queries : 275618313
total ops : 306241622
find throughput : 27561831
rq throughput : 0
update throughput : 3062330
query throughput : 27561831
total throughput : 30624162
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=639981776093277
total_execution_walltime=13.095s
REALTIME_MAIN_END_PERF_FORMAT=212006.652823330
[time_cmd_output] time_elapsed_sec=13.25, faults_major=0, faults_minor=268044, mem_maxresident_kb=1072708, user_cputime=842.07, sys_cputime=6.19, percent_cpu=6401%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1