__step=000481
__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" ./ellen_ext_bst_lf.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000481.txt
__path_data=data/data000481.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212668.589678782
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=ellen_ext_bst_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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
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=40 descriptor=64
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.021s
prefilling_size=999385 prefilling_elapsed_millis=1s
finished prefilling to size 999390 for expected size 1000000 keysum=999676169540, performing 26613850 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999390
pref_millis=1101
prefill_elapsed_ms=1114
6node_tIxPvE_object_size=40
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=814
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=212669.742982219
REALTIME_END_PERF_FORMAT=212679.743052101
###############################################################################
################################## 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 1858 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.125s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 252 491 929 1714 3072 5235 8552 13221 19289 26869 35816 45665 55638 64996 72739 78291 80329 79549 75433 69052 60814 51759 42435 33556 25030 17680 12130 8023 5045 3017 1673 894 418 153 43 17 8 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 4 13 53 144 356 909 1918 3883 7153 11709 17922 25967 35692 46280 57253 67187 76253 81109 83665 81814 77290 69869 61083 51314 42082 32380 23230 16237 11001 7073 4361 2452 1370 683 263 69 26 14 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 504 982 1858 3428 6144 10470 17104 26442 38578 53738 71632 91330 111276 129992 145478 156582 160658 159098 150866 138104 121628 103518 84870 67112 50060 35360 24260 16046 10090 6034 3346 1788 836 306 86 34 16 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 4 13 53 144 356 909 1918 3883 7153 11709 17922 25967 35692 46280 57253 67187 76253 81109 83665 81814 77290 69869 61083 51314 42082 32380 23230 16237 11001 7073 4361 2452 1370 683 263 69 26 14 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.98438 1.97421 1.94603 1.9225 1.89615 1.85205 1.81681 1.77298 1.72948 1.69649 1.66649 1.63749 1.6092 1.5841 1.55957 1.53816 1.51302 1.49514 1.47413 1.4577 1.44035 1.42555 1.40993 1.39538 1.37296 1.35318 1.34304 1.33071 1.31441 1.29901 1.27726 1.26718 1.23378 1.18301 1.14052 1.19767 1.23529 1.125 1
tree_stats_height=49
tree_stats_numInternals=1000086
tree_stats_numLeaves=1000087
tree_stats_numNodes=2000173
tree_stats_numKeys=1000085
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999998
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=28.368
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20160 39280 74320 137120 245760 418800 684160 1057680 1543120 2149520 2865280 3653200 4451040 5199680 5819120 6263280 6426320 6363920 6034640 5524160 4865120 4140720 3394800 2684480 2002400 1414400 970400 641840 403600 241360 133840 71520 33440 12240 3440 1360 640 160
tree_stats_sizeInBytes=80006920
6node_tIxPvE_object_size=40
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=11788
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:3 4:2 8:386 16:198923 32:432623 64:7556 128:188 256:63
(2^01, 2^02]: 3
(2^02, 2^03]: 2
(2^03, 2^04]: 386
(2^04, 2^05]: 198923
(2^05, 2^06]: 432623
(2^06, 2^07]: 7556
(2^07, 2^08]: 188
(2^08, 2^09]: 63
sum_limbo_reclamation_event_size_total=24455655
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=639744
sum_limbo_reclamation_event_count_total=1404672
first_thread_announced_epoch_by_thread=23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576 23576
sum_num_inserts_by_thread=342237 342083 340056 337182 338213 338948 338807 336932 322487 326667 326550 325942 339099 338857 337140 337890 337866 335087 333898 335078 333643 333207 333416 338369 338259 336632 336338 335575 338203 337111 335375 333668 335779 336331 334271 333958 335108 333803 341144 340955 339649 339013 338079 338176 340229 337646 335610 333094 331060 332396 331196 330251 338772 337999 336535 336321 336016 336939 335571 334424 334882 334421 334236 335659
sum_num_inserts_total=21490338
sum_num_deletes_by_thread=342846 341596 340891 337620 339040 338726 339489 337642 323721 328456 325322 325045 338315 338464 337298 337276 337822 334221 334682 334195 334225 332669 332438 339033 338888 338790 337168 337391 338794 336547 336025 335568 335710 334813 333622 333343 334207 333856 341366 339283 339627 339224 338088 338627 340172 337908 334296 332270 331048 332662 331728 329776 338875 338011 337607 335756 337841 336661 335787 334139 334300 334803 334719 334157
sum_num_deletes_total=21494485
sum_num_searches_by_thread=6156190 6155981 6126485 6089919 6097176 6095792 6094020 6079841 5818552 5894736 5870100 5865573 6100856 6088498 6077177 6069870 6070924 6037645 6013620 6009547 6008259 5988416 5985912 6099491 6095184 6077992 6074377 6062865 6081228 6068624 6038768 6020942 6056398 6038028 6025407 5996747 6017594 6009038 6141093 6123180 6113470 6105755 6091592 6093951 6112371 6080825 6038177 5983158 5973676 5968815 5952578 5944789 6093433 6082137 6059951 6046166 6059035 6062972 6050423 6014702 6015299 6019259 6019768 6030069
sum_num_searches_total=386834416
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6841273 6839660 6807432 6764721 6774429 6773466 6772316 6754415 6464760 6549859 6521972 6516560 6778270 6765819 6751615 6745036 6746612 6706953 6682200 6678820 6676127 6654292 6651766 6776893 6772331 6753414 6747883 6735831 6758225 6742282 6710168 6690178 6727887 6709172 6693300 6664048 6686909 6676697 6823603 6803418 6792746 6783992 6767759 6770754 6792772 6756379 6708083 6648522 6635784 6633873 6615502 6604816 6771080 6758147 6734093 6718243 6732892 6736572 6721781 6683265 6684481 6688483 6688723 6699885
average_num_operations_total=6715925
stdev_num_operations_total=9448
sum_num_operations_total=429819239
min_num_operations_total=6464760
max_num_operations_total=6841273
first_time_thread_terminate_by_thread=10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000075 10000074 10000074 10000075 10000074 10000075 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000075 10000075 10000075 10000075 10000071 10000071 10000071 10000071 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000073 10000073 10000073 10000073 10000071 10000071 10000072 10000072 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000071
max_time_thread_terminate_total=10000075
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 5 5 5 5 5 5 5 5 7 7 7 7 7 7 7 7 4 4 4 4 4 4 4 4 6 6 6 6 4 5 5 4 6 6 6 6 6 6 6 6 4 4 4 4 3 3 3 3 5 5 6 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=1000388380493
threads_final_size=1000085
final_keysum=1000388380493
final_size=1000085
validate_result=success
Validation OK.
Structural validation OK.
total_find=386834416
total_rq=0
total_inserts=21490338
total_deletes=21494485
total_updates=42984823
total_queries=386834416
total_ops=429819239
find_throughput=38683441
rq_throughput=0
update_throughput=4298482
query_throughput=38683441
total_throughput=42981923
total find : 386834416
total rq : 0
total inserts : 21490338
total deletes : 21494485
total updates : 42984823
total queries : 386834416
total ops : 429819239
find throughput : 38683441
rq throughput : 0
update throughput : 4298482
query throughput : 38683441
total throughput : 42981923
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=178295499097196
total_execution_walltime=11.372s
REALTIME_MAIN_END_PERF_FORMAT=212679.962121891
[time_cmd_output] time_elapsed_sec=11.48, faults_major=0, faults_minor=101734, mem_maxresident_kb=403072, user_cputime=740.91, sys_cputime=6.17, percent_cpu=6507%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1