__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000425.txt
__path_data=data/data000425.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984010.112829240
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,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.005s
prefilling_size=7346477 prefilling_elapsed_millis=1.001s
prefilling_size=7629918 prefilling_elapsed_millis=1.101s
prefilling_size=7882151 prefilling_elapsed_millis=1.201s
prefilling_size=8107085 prefilling_elapsed_millis=1.301s
prefilling_size=8305393 prefilling_elapsed_millis=1.402s
prefilling_size=8480688 prefilling_elapsed_millis=1.502s
prefilling_size=8638283 prefilling_elapsed_millis=1.602s
prefilling_size=8777624 prefilling_elapsed_millis=1.702s
prefilling_size=8902503 prefilling_elapsed_millis=1.802s
prefilling_size=9016134 prefilling_elapsed_millis=1.903s
prefilling_size=9115489 prefilling_elapsed_millis=2.003s
prefilling_size=9205237 prefilling_elapsed_millis=2.103s
prefilling_size=9285177 prefilling_elapsed_millis=2.203s
prefilling_size=9356769 prefilling_elapsed_millis=2.303s
prefilling_size=9420413 prefilling_elapsed_millis=2.404s
prefilling_size=9477623 prefilling_elapsed_millis=2.504s
prefilling_size=9529990 prefilling_elapsed_millis=2.604s
prefilling_size=9577950 prefilling_elapsed_millis=2.704s
prefilling_size=9620277 prefilling_elapsed_millis=2.804s
prefilling_size=9657155 prefilling_elapsed_millis=2.905s
prefilling_size=9691129 prefilling_elapsed_millis=3.005s
prefilling_size=9719660 prefilling_elapsed_millis=3.105s
prefilling_size=9747772 prefilling_elapsed_millis=3.205s
prefilling_size=9772579 prefilling_elapsed_millis=3.305s
prefilling_size=9794125 prefilling_elapsed_millis=3.406s
prefilling_size=9812929 prefilling_elapsed_millis=3.506s
finished prefilling to size 9812931 for expected size 10000000 keysum=98148929954054, performing 84823533 updates; total_prefilling_elapsed_ms=3607 ms)
pref_size=9812931
pref_millis=3607
prefill_elapsed_ms=3631
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=3869
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6984013.930306542
REALTIME_END_PERF_FORMAT=6984023.930443977
###############################################################################
################################## 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.05s
tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262123 522463 1002137 1615334 1758494 1055175 290209 28481 605 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 21 1661 38230 331055 1185356 1873686 1312756 377688 36731 752
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524124 1040367 1946389 2943850 2928861 1602965 406169 37336 752
tree_stats_numKeysAtDepth=0 1 1 3 6 5 15 38 79 144 272 501 1065 2107 4125 8245 16435 33097 66298 134583 283256 638031 1438288 2543673 2760197 1571220 404044 37306 752
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99945 1.98813 1.90761 1.68255 1.39755 1.18701 1.07233 1.02177 1.00394 1
tree_stats_height=29
tree_stats_numInternals=6797165
tree_stats_numLeaves=5157936
tree_stats_numNodes=11955101
tree_stats_numKeys=9943787
tree_stats_avgDegreeInternal=1.75884
tree_stats_avgDegreeLeaves=0.999971
tree_stats_avgDegree=1.43143
tree_stats_avgKeyDepth=23.2384
tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14680064 29350944 58260552 108997784 164855600 164016216 89766040 22745464 2090816 42112
tree_stats_sizeInBytes=669485656
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=15692
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1355 2:16501 4:157732 8:288874 16:15249
[2^00, 2^01]: 1355
(2^01, 2^02]: 16501
(2^02, 2^03]: 157732
(2^03, 2^04]: 288874
(2^04, 2^05]: 15249
sum_limbo_reclamation_event_size_total=4241299
count_limbo_reclamation_event_size_by_thread=9997 9994 9995 9995 9994 9993 9995 9995 9995 9992 9995 9993 9994 9994 9994 9995 9992 9995 9991 9996 9997 9997 9992 9993 9992 9996 9996 9995 9994 9994 9993 9994 9993 9995 9991 9995 9990 9996 9991 9995 9993 9996 9998 9992 9991 9993 9992 9993
count_limbo_reclamation_event_size_total=479711
sum_limbo_reclamation_event_count_total=567504
first_thread_announced_epoch_by_thread=31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384 31384
sum_num_inserts_by_thread=272167 268258 271286 271294 272854 270646 272570 273948 270241 276321 267764 271779 268317 273501 270857 270502 275245 267431 271475 272195 269689 275928 271698 269671 272263 272984 269858 270509 268943 266518 266379 272858 276098 270953 273038 266544 272295 269449 275370 270322 274504 267444 269455 272277 274859 275544 272713 269745
sum_num_inserts_total=13026559
sum_num_deletes_by_thread=271970 268553 270116 270161 273276 270292 271125 273405 271748 277158 267645 271422 267793 273623 270808 270916 274527 266922 270722 271280 268869 275228 271744 269087 272025 273462 270636 269599 267582 265600 267100 272821 275794 271501 272525 267635 272404 269040 276043 269637 273289 267574 269570 272273 273559 274826 271727 269537
sum_num_deletes_total=13014149
sum_num_searches_by_thread=4892427 4830108 4860842 4865448 4926167 4877585 4899248 4921027 4881681 4973443 4822720 4885027 4820425 4933196 4875927 4869119 4934819 4811624 4874575 4902221 4841283 4947039 4897722 4864769 4901152 4915710 4862889 4859648 4835223 4791345 4810287 4919394 4968686 4881769 4912926 4796561 4913850 4846152 4958735 4866437 4928055 4808162 4867937 4899474 4921218 4951973 4889176 4854560
sum_num_searches_total=234369761
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5436564 5366919 5402244 5406903 5472297 5418523 5442943 5468380 5423670 5526922 5358129 5428228 5356535 5480320 5417592 5410537 5484591 5345977 5416772 5445696 5379841 5498195 5441164 5403527 5445440 5462156 5403383 5399756 5371748 5323463 5343766 5465073 5520578 5424223 5458489 5330740 5458549 5384641 5510148 5406396 5475848 5343180 5406962 5444024 5469636 5502343 5433616 5393842
average_num_operations_total=5425218
stdev_num_operations_total=7457
sum_num_operations_total=260410469
min_num_operations_total=5323463
max_num_operations_total=5526922
first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000137 10000138 10000138 10000137 10000137 10000138 10000138 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000137 10000137 10000138 10000138 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000138 10000138 10000138 10000137
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=99459282628768
threads_final_size=9943787
final_keysum=99459282628768
final_size=9943787
validate_result=success
Validation OK.
Structural validation OK.
total_find=234369761
total_rq=0
total_inserts=13026559
total_deletes=13014149
total_updates=26040708
total_queries=234369761
total_ops=260410469
find_throughput=23436976
rq_throughput=0
update_throughput=2604070
query_throughput=23436976
total_throughput=26041046
total find : 234369761
total rq : 0
total inserts : 13026559
total deletes : 13014149
total updates : 26040708
total queries : 234369761
total ops : 260410469
find throughput : 23436976
rq throughput : 0
update throughput : 2604070
query throughput : 23436976
total throughput : 26041046
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=29.4708
PAPI_L3_TCM=9.92996
PAPI_TOT_CYC=5138.28
PAPI_TOT_INS=1293.88
garbage=1160533658122742
total_execution_walltime=13.954s
REALTIME_MAIN_END_PERF_FORMAT=6984024.68298165
[time_cmd_output] time_elapsed_sec=14.14, faults_major=0, faults_minor=267284, mem_maxresident_kb=1071044, user_cputime=681.58, sys_cputime=2.45, percent_cpu=4836%
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