__step=000258
__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 0.5 0.5 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000258.txt
__path_data=data/data000258.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209919.235896044
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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.02s
prefilling_size=100191 prefilling_elapsed_millis=1s
finished prefilling to size 100133 for expected size 100000 keysum=10001367748, performing 32499692 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100133
pref_millis=1101
prefill_elapsed_ms=1109
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=1125

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=209920.382988378
REALTIME_END_PERF_FORMAT=209930.383089174

###############################################################################
################################## 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 1596 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.132s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 249 459 798 1309 2042 3128 4508 6137 7684 8788 9453 9563 9142 8376 7429 6197 4828 3565 2546 1639 923 515 291 182 101 55 10 5 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 7 39 120 287 576 956 1748 2879 4590 6580 8123 9343 9984 9908 9323 8661 7566 6091 4584 3453 2355 1331 739 400 263 147 100 15 8 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 498 918 1596 2618 4084 6256 9016 12274 15368 17576 18906 19126 18284 16752 14858 12394 9656 7130 5092 3278 1846 1030 582 364 202 110 20 10 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 7 39 120 287 576 956 1748 2879 4590 6580 8123 9343 9984 9908 9323 8661 7566 6091 4584 3453 2355 1331 739 400 263 147 100 15 8 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.97266 1.92169 1.86928 1.82018 1.77998 1.76592 1.72059 1.68068 1.62604 1.57184 1.53784 1.50582 1.47799 1.45811 1.44347 1.41708 1.38954 1.3692 1.35708 1.32188 1.28157 1.27898 1.28252 1.31271 1.27747 1.27228 1.09091 1.25 1.2 1

tree_stats_height=40
tree_stats_numInternals=100181
tree_stats_numLeaves=100182
tree_stats_numNodes=200363
tree_stats_numKeys=100180

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=23.1206

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 19920 36720 63840 104720 163360 250240 360640 490960 614720 703040 756240 765040 731360 670080 594320 495760 386240 285200 203680 131120 73840 41200 23280 14560 8080 4400 800 400 160
tree_stats_sizeInBytes=8014520

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=37181

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:77462 2:236527 4:247802 8:42208 16:200 32:191 64:26
    [2^00, 2^01]: 77462
    (2^01, 2^02]: 236527
    (2^02, 2^03]: 247802
    (2^03, 2^04]: 42208
    (2^04, 2^05]: 200
    (2^05, 2^06]: 191
    (2^06, 2^07]: 26
sum_limbo_reclamation_event_size_total=2314998
count_limbo_reclamation_event_size_by_thread=9492 9564 9536 9576 9544 9560 9556 9536 9536 9456 9482 9384 9448 9484 9498 9442 9540 9486 9532 9552 9500 9516 9548 9382 9370 9300 9368 9374 9522 9528 9466 9442 9430 9376 9442 9364 9334 9336 9306 9286 9318 9326 9458 9376 9416 9512 9418 9478 9446 9356 9260 9294 9296 9440 9418 9216 9492 9550 9466 9532 9502 9464 9486 9502
count_limbo_reclamation_event_size_total=604416
sum_limbo_reclamation_event_count_total=4615166
first_thread_announced_epoch_by_thread=74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362 74362
sum_num_inserts_by_thread=111444 112261 112919 112025 113310 113288 110986 110814 110387 108974 106948 107033 102777 106836 106513 105104 108952 108933 108639 107793 108956 107459 106221 98659 100110 99758 99776 99319 111351 109148 108448 100933 103106 103712 102581 101129 99106 98768 98477 97599 97794 97468 105266 103571 106634 107018 106676 106404 102670 100325 97255 97670 95629 103994 104015 96498 110628 109696 109585 110498 105874 106840 105835 107910
sum_num_inserts_total=6736305
sum_num_deletes_by_thread=111397 112465 113385 111033 113413 113334 111767 111002 110765 108816 106763 106712 102285 107220 105491 105780 108669 109009 108773 108212 108254 107234 105621 98284 100533 100182 99246 98614 110988 109355 108544 101296 102993 103533 103111 101958 99702 98951 98496 98000 97626 97245 105117 103623 107331 107487 106474 106806 102676 100198 97976 97270 95936 103891 103962 95811 110708 109546 109379 110387 106305 107211 106567 108134
sum_num_deletes_total=6738852
sum_num_searches_by_thread=22103923 22294906 22313606 22022003 22481152 22437845 22095841 21889897 21846679 21594596 21216174 21099472 20288755 21235951 21005558 20854575 21508947 21592989 21556284 21376545 21510741 21242345 20965813 19418226 19854927 19811760 19618298 19613572 22008519 21639184 21535660 19994202 20489897 20510828 20340904 20011123 19704237 19551222 19533671 19418062 19373000 19263878 20734160 20509819 21225860 21228431 21149582 21108060 20253119 19823091 19373436 19248087 19002442 20510144 20630077 19008550 21932292 21727086 21710171 21867179 20988860 21125359 21123292 21432259
sum_num_searches_total=1333937123
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=22326764 22519632 22539910 22245061 22707875 22664467 22318594 22111713 22067831 21812386 21429885 21313217 20493817 21450007 21217562 21065459 21726568 21810931 21773696 21592550 21727951 21457038 21177655 19615169 20055570 20011700 19817320 19811505 22230858 21857687 21752652 20196431 20695996 20718073 20546596 20214210 19903045 19748941 19730644 19613661 19568420 19458591 20944543 20717013 21439825 21442936 21362732 21321270 20458465 20023614 19568667 19443027 19194007 20718029 20838054 19200859 22153628 21946328 21929135 22088064 21201039 21339410 21335694 21648303
average_num_operations_total=21053316
stdev_num_operations_total=124728
sum_num_operations_total=1347412280
min_num_operations_total=19194007
max_num_operations_total=22707875
first_time_thread_terminate_by_thread=10000103 10000103 10000103 10000103 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000102 10000102 10000102 10000102 10000104 10000104 10000104 10000104 10000105 10000105 10000105 10000105 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000105 10000105 10000105 10000105 10000103 10000103 10000103 10000103 10000104 10000104 10000104 10000104 10000102 10000102 10000102 10000102
min_time_thread_terminate_total=10000101
max_time_thread_terminate_total=10000105
first_time_thread_start_by_thread=5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 7 7 7 7 4 4 4 4 8 8 8 8 4 4 4 4 6 6 6 6 5 5 5 5 6 6 6 6 9 9 9 8 6 6 6 6 7 7 7 7 8 8 8 8 7 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=10031926834
threads_final_size=100180
final_keysum=10031926834
final_size=100180
validate_result=success
Validation OK.
Structural validation OK.

total_find=1333937123
total_rq=0
total_inserts=6736305
total_deletes=6738852
total_updates=13475157
total_queries=1333937123
total_ops=1347412280
find_throughput=133393712
rq_throughput=0
update_throughput=1347515
query_throughput=133393712
total_throughput=134741228


total find                    : 1333937123
total rq                      : 0
total inserts                 : 6736305
total deletes                 : 6738852
total updates                 : 13475157
total queries                 : 1333937123
total ops                     : 1347412280
find throughput               : 133393712
rq throughput                 : 0
update throughput             : 1347515
query throughput              : 133393712
total throughput              : 134741228

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=13379467851375
total_execution_walltime=11.371s
REALTIME_MAIN_END_PERF_FORMAT=209930.607324608
[time_cmd_output] time_elapsed_sec=11.47, faults_major=0, faults_minor=82942, mem_maxresident_kb=322992, user_cputime=739.17, sys_cputime=6.13, percent_cpu=6494%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2