__step=000761
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000761.txt
__path_data=data/data000761.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=216055.710251529
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=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
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.02s
prefilling_size=7984238 prefilling_elapsed_millis=1s
prefilling_size=8249257 prefilling_elapsed_millis=1.101s
prefilling_size=8476272 prefilling_elapsed_millis=1.201s
prefilling_size=8673999 prefilling_elapsed_millis=1.301s
prefilling_size=8846215 prefilling_elapsed_millis=1.401s
prefilling_size=8993903 prefilling_elapsed_millis=1.501s
prefilling_size=9124798 prefilling_elapsed_millis=1.601s
prefilling_size=9236587 prefilling_elapsed_millis=1.701s
prefilling_size=9335130 prefilling_elapsed_millis=1.801s
prefilling_size=9420066 prefilling_elapsed_millis=1.901s
prefilling_size=9492897 prefilling_elapsed_millis=2.002s
prefilling_size=9557510 prefilling_elapsed_millis=2.102s
prefilling_size=9613970 prefilling_elapsed_millis=2.202s
prefilling_size=9662173 prefilling_elapsed_millis=2.302s
prefilling_size=9703765 prefilling_elapsed_millis=2.402s
prefilling_size=9742109 prefilling_elapsed_millis=2.502s
prefilling_size=9773856 prefilling_elapsed_millis=2.602s
prefilling_size=9803994 prefilling_elapsed_millis=2.702s
finished prefilling to size 9804004 for expected size 10000000 keysum=98039770434857, performing 78842429 updates; total_prefilling_elapsed_ms=2803 ms)
pref_size=9804004
pref_millis=2803
prefill_elapsed_ms=2823
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=2009
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=216058.566981459
REALTIME_END_PERF_FORMAT=216068.567075472
###############################################################################
################################## 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.072s
tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131068 261922 519655 985683 1582256 1764483 1107075 332198 40881 1331 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 4 197 3773 47101 328763 1128519 1851232 1359681 429004 52720 1645
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262119 523428 1032784 1911019 2893002 2958307 1691879 469885 54051 1645
tree_stats_numKeysAtDepth=0 0 0 2 2 10 18 36 70 130 262 511 1013 2045 4115 8246 16395 32779 66022 134037 282059 630905 1398771 2474184 2773449 1652956 466673 53984 1644
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99984 1.99766 1.98032 1.89596 1.68588 1.41264 1.19765 1.08136 1.02801 1.00581 0.999392
tree_stats_height=29
tree_stats_numInternals=6857624
tree_stats_numLeaves=5202639
tree_stats_numNodes=12060263
tree_stats_numKeys=10000318
tree_stats_avgDegreeInternal=1.75866
tree_stats_avgDegreeLeaves=0.999958
tree_stats_avgDegree=1.43137
tree_stats_avgKeyDepth=23.2871
tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14678664 29311968 57835904 107017064 162008112 165665192 94745224 26313560 3026856 92120
tree_stats_sizeInBytes=675374728
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=9021
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:1 16:1 32:11 64:337221 128:110988 256:417 512:1
(2^03, 2^04]: 1
(2^04, 2^05]: 1
(2^05, 2^06]: 11
(2^06, 2^07]: 337221
(2^07, 2^08]: 110988
(2^08, 2^09]: 417
(2^09, 2^10]: 1
sum_limbo_reclamation_event_size_total=53878497
count_limbo_reclamation_event_size_by_thread=7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010 7010
count_limbo_reclamation_event_size_total=448640
sum_limbo_reclamation_event_count_total=448768
first_thread_announced_epoch_by_thread=18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042 18042
sum_num_inserts_by_thread=2146488 2151323 2147251 2126735 2150232 2148034 2135720 2153853 2161035 2152396 2145170 2142027 2150851 2162313 2138537 2145494 2125183 2125393 2120268 2119789 2109071 2139460 2130111 2120781 2123575 2131456 2121621 2132515 2116971 2110785 2114473 2105483 2117464 2110041 2104309 2126905 2138768 2132366 2123191 2123250 2125094 2129576 2124206 2104089 2109571 2121349 2105958 2118103 2118495 2140564 2119202 2130796 2126416 2136761 2128622 2119562 2132740 2113361 2107047 2116310 2114534 2134335 2128605 2138415
sum_num_inserts_total=136224399
sum_num_deletes_by_thread=2146226 2153408 2145875 2127654 2146115 2146220 2137237 2154517 2160617 2151737 2144420 2144361 2148654 2162963 2137916 2144769 2124122 2125150 2118903 2118764 2110052 2141596 2133185 2121483 2123037 2134240 2120296 2131054 2115384 2112517 2114459 2103495 2118744 2109629 2104582 2125169 2139756 2131563 2122840 2125368 2126191 2127029 2122324 2107743 2113781 2121468 2105904 2115974 2112244 2140221 2117492 2133832 2128131 2139170 2130802 2119259 2133411 2113538 2111185 2117310 2118475 2135598 2130793 2135727
sum_num_deletes_total=136235679
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4292714 4304731 4293126 4254389 4296347 4294254 4272957 4308370 4321652 4304133 4289590 4286388 4299505 4325276 4276453 4290263 4249305 4250543 4239171 4238553 4219123 4281056 4263296 4242264 4246612 4265696 4241917 4263569 4232355 4223302 4228932 4208978 4236208 4219670 4208891 4252074 4278524 4263929 4246031 4248618 4251285 4256605 4246530 4211832 4223352 4242817 4211862 4234077 4230739 4280785 4236694 4264628 4254547 4275931 4259424 4238821 4266151 4226899 4218232 4233620 4233009 4269933 4259398 4274142
average_num_operations_total=4257188
stdev_num_operations_total=3645
sum_num_operations_total=272460078
min_num_operations_total=4208891
max_num_operations_total=4325276
first_time_thread_terminate_by_thread=10000095 10000095 10000095 10000096 10000095 10000094 10000095 10000094 10000095 10000095 10000095 10000095 10000095 10000093 10000095 10000095 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000093 10000093 10000093 10000095 10000094 10000094 10000094 10000094 10000096 10000096 10000096 10000096 10000095 10000095 10000094 10000095 10000096 10000096 10000096 10000096 10000097 10000097 10000097 10000097 10000095 10000095 10000095 10000095 10000095 10000093 10000093 10000095 10000095 10000095 10000095 10000095 10000096 10000096 10000096 10000096
min_time_thread_terminate_total=10000093
max_time_thread_terminate_total=10000097
first_time_thread_start_by_thread=6 5 6 6 5 6 5 5 6 6 7 7 6 6 6 6 7 7 7 7 5 5 5 5 7 7 7 7 8 8 8 8 9 9 9 9 5 5 5 5 8 8 8 8 7 7 7 7 6 6 6 6 9 9 9 9 6 6 6 6 5 5 5 5
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=100020795114568
threads_final_size=10000318
final_keysum=100020795114568
final_size=10000318
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=136224399
total_deletes=136235679
total_updates=272460078
total_queries=0
total_ops=272460078
find_throughput=0
rq_throughput=0
update_throughput=27246007
query_throughput=0
total_throughput=27246007
total find : 0
total rq : 0
total inserts : 136224399
total deletes : 136235679
total updates : 272460078
total queries : 0
total ops : 272460078
find throughput : 0
rq throughput : 0
update throughput : 27246007
query throughput : 0
total throughput : 27246007
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=13.006s
REALTIME_MAIN_END_PERF_FORMAT=216068.716739490
[time_cmd_output] time_elapsed_sec=13.16, faults_major=0, faults_minor=271923, mem_maxresident_kb=1088124, user_cputime=835.42, sys_cputime=5.20, percent_cpu=6383%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1