__step=000339
__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" ./brown_ext_abtree_lf.debra -nwork 128 -nprefill 128 -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=data000339.txt
__path_data=data/data000339.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=210861.117368265
binary=./brown_ext_abtree_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_ext_abtree_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=20000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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
size_node=208
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.028s
prefilling_size=8298136 prefilling_elapsed_millis=1s
prefilling_size=8595495 prefilling_elapsed_millis=1.101s
prefilling_size=8840621 prefilling_elapsed_millis=1.201s
prefilling_size=9042438 prefilling_elapsed_millis=1.301s
prefilling_size=9209706 prefilling_elapsed_millis=1.401s
prefilling_size=9345307 prefilling_elapsed_millis=1.501s
prefilling_size=9455370 prefilling_elapsed_millis=1.601s
prefilling_size=9547145 prefilling_elapsed_millis=1.701s
prefilling_size=9624396 prefilling_elapsed_millis=1.802s
prefilling_size=9689283 prefilling_elapsed_millis=1.902s
prefilling_size=9745650 prefilling_elapsed_millis=2.002s
prefilling_size=9796498 prefilling_elapsed_millis=2.102s
prefilling_size=9834171 prefilling_elapsed_millis=2.202s
finished prefilling to size 9834186 for expected size 10000000 keysum=98349761292350, performing 88238467 updates; total_prefilling_elapsed_ms=2303 ms)
pref_size=9834186
pref_millis=2303
prefill_elapsed_ms=2318
N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 

global_epoch_counter=894

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=210863.486111002
REALTIME_END_PERF_FORMAT=210873.486205179

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

tree_stats_computeWalltime=0.142s

tree_stats_numInternalsAtDepth=1 1 9 71 531 4026 30292 236242 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1848902
tree_stats_numNodesAtDepth=1 1 9 71 531 4026 30292 236242 1848902
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9999816
tree_stats_avgDegreeAtDepth=1 9 7.88889 7.47887 7.58192 7.52409 7.79882 7.82631 5.40852

tree_stats_height=9
tree_stats_numInternals=271173
tree_stats_numLeaves=1848902
tree_stats_numNodes=2120075
tree_stats_numKeys=9999816

tree_stats_avgDegreeInternal=7.81816
tree_stats_avgDegreeLeaves=5.40852
tree_stats_avgDegree=5.71673
tree_stats_avgKeyDepth=8

tree_stats_bytesAtDepth=208 208 1872 14768 110448 837408 6300736 49138336 384571616
tree_stats_sizeInBytes=440975600

N9abtree_ns4NodeILi11ExEE_object_size=208
N9abtree_ns4NodeILi11ExEE_allocated_count=0
N9abtree_ns4NodeILi11ExEE_allocated_size=0MB
N9abtree_ns4NodeILi11ExEE_get_from_pool=0
N9abtree_ns4NodeILi11ExEE_deallocated=0
N9abtree_ns4NodeILi11ExEE_limbo_count=0
N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 

global_epoch_counter=7670


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:2 2:8 4:16 8:14 16:88 32:469681 64:396078 128:719 256:389 512:14
    [2^00, 2^01]: 2
    (2^01, 2^02]: 8
    (2^02, 2^03]: 16
    (2^03, 2^04]: 14
    (2^04, 2^05]: 88
    (2^05, 2^06]: 469681
    (2^06, 2^07]: 396078
    (2^07, 2^08]: 719
    (2^08, 2^09]: 389
    (2^09, 2^10]: 14
sum_limbo_reclamation_event_size_total=54619722
count_limbo_reclamation_event_size_by_thread=6774 6774 6774 6769 6774 6774 6774 6774 6773 6773 6774 6773 6774 6774 6774 6774 6773 6774 6773 6773 6774 6774 6773 6773 6774 6774 6773 6774 6773 6773 6773 6773 6774 6773 6773 6774 6773 6774 6773 6773 6774 6773 6773 6774 6774 6773 6774 6773 6774 6774 6773 6774 6774 6774 6774 6774 6773 6774 6774 6774 6773 6773 6773 6774 6774 6774 6774 6774 6774 6774 6774 6774 6773 6773 6773 6773 6774 6773 6774 6774 6773 6773 6774 6774 6774 6773 6773 6773 6774 6774 6774 6774 6773 6774 6773 6773 6773 6774 6773 6773 6773 6773 6774 6773 6774 6774 6774 6773 6773 6773 6773 6774 6773 6774 6773 6774 6774 6774 6774 6774 6774 6773 6773 6774 6773 6773 6773 6773
count_limbo_reclamation_event_size_total=867009
sum_limbo_reclamation_event_count_total=867323
first_thread_announced_epoch_by_thread=15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340 15340
sum_num_inserts_by_thread=416395 416885 410421 417567 418730 412125 424699 420291 423890 420167 422339 417251 413664 402384 409833 407811 421197 412704 416027 423380 427423 421966 425019 421383 425438 421067 418996 414054 417006 412949 415332 408818 416994 421078 423747 419140 426298 420809 423083 415711 417984 413108 413904 410501 418097 412259 414464 417760 422075 415952 419475 414060 421607 414805 414658 405057 377580 373512 376646 373114 411569 406729 420496 412619 416969 408669 417588 411772 418427 408831 413176 403655 413084 407168 412159 406648 414388 404928 414041 404239 423791 418208 422050 409222 413848 403256 412757 404568 414266 410849 422064 417268 423408 418796 421584 416118 425802 411215 416828 410864 416581 405374 414256 410074 422159 413337 423051 414121 424860 419996 422039 413183 414151 410791 412175 409910 411853 408628 421332 415563 384201 382711 387083 380035 422833 416250 420237 414719
sum_num_inserts_total=52926109
sum_num_deletes_by_thread=415699 417982 410745 416846 420617 410770 424233 420468 424145 419026 423699 417641 413268 402486 409793 406768 420409 412839 414763 422525 426296 421274 425216 421510 425919 420829 419762 414016 416288 413819 415197 408626 417146 420025 424620 418793 425675 421254 422923 416045 418326 413263 413563 411431 416428 412909 415912 419428 421231 416627 421095 414585 422412 413025 416007 406477 379257 373768 378258 374055 411757 406917 419217 413484 416079 408362 416842 411661 417969 408818 412388 404235 413449 406719 412352 406644 414687 403932 413296 406528 422237 418102 422140 410324 414115 403149 411422 403233 413781 408589 424137 416355 423647 418286 421658 415316 426046 411767 415627 411970 416193 405640 415379 410360 422675 414757 422614 412740 424853 419906 423605 412987 414191 409916 412682 409445 412666 408134 421955 415316 383896 382896 386726 381553 423303 414519 420027 414016
sum_num_deletes_total=52928199
sum_num_searches_by_thread=7488825 7528531 7392870 7504768 7553153 7408709 7628589 7570413 7643877 7560467 7619513 7522760 7436328 7241201 7378218 7339429 7560912 7433921 7486276 7605515 7669879 7600165 7651221 7585913 7654811 7578908 7552806 7443022 7479377 7437849 7471074 7362886 7512089 7552446 7640704 7520826 7663625 7582457 7615381 7486738 7530918 7440360 7463563 7403097 7507302 7414149 7479107 7553069 7584463 7482345 7576435 7468117 7593647 7455439 7477240 7308433 6813934 6729129 6790646 6711897 7400027 7322913 7550622 7431804 7497502 7349830 7513621 7407500 7529196 7367612 7417048 7273994 7438786 7318687 7418131 7328914 7447283 7275552 7445246 7298158 7619453 7515897 7587469 7379601 7443563 7261410 7411454 7274766 7452289 7369838 7605212 7513830 7630993 7529747 7579653 7503123 7657700 7422481 7479845 7416458 7499163 7306054 7463220 7392541 7600696 7451981 7607598 7454787 7647417 7560135 7600126 7443437 7436267 7382316 7422727 7370949 7419400 7354874 7585203 7480369 6916336 6884504 6954075 6853543 7616959 7489726 7559792 7457136
sum_num_searches_total=952648281
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8320919 8363398 8214036 8339181 8392500 8231604 8477521 8411172 8491912 8399660 8465551 8357652 8263260 8046071 8197844 8154008 8402518 8259464 8317066 8451420 8523598 8443405 8501456 8428806 8506168 8420804 8391564 8271092 8312671 8264617 8301603 8180330 8346229 8393549 8489071 8358759 8515598 8424520 8461387 8318494 8367228 8266731 8291030 8225029 8341827 8239317 8309483 8390257 8427769 8314924 8417005 8296762 8437666 8283269 8307905 8119967 7570771 7476409 7545550 7459066 8223353 8136559 8390335 8257907 8330550 8166861 8348051 8230933 8365592 8185261 8242612 8081884 8265319 8132574 8242642 8142206 8276358 8084412 8272583 8108925 8465481 8352207 8431659 8199147 8271526 8067815 8235633 8082567 8280336 8189276 8451413 8347453 8478048 8366829 8422895 8334557 8509548 8245463 8312300 8239292 8331937 8117068 8292855 8212975 8445530 8280075 8453263 8281648 8497130 8400037 8445770 8269607 8264609 8203023 8247584 8190304 8243919 8171636 8428490 8311248 7684433 7650111 7727884 7615131 8463095 8320495 8400056 8285871
average_num_operations_total=8269551
stdev_num_operations_total=18536
sum_num_operations_total=1058502589
min_num_operations_total=7459066
max_num_operations_total=8523598
first_time_thread_terminate_by_thread=10000099 10000099 10000099 10000099 10000095 10000095 10000096 10000095 10000097 10000097 10000096 10000097 10000096 10000096 10000096 10000096 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000099 10000099 10000100 10000100 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000097 10000095 10000095 10000095 10000096 10000098 10000098 10000097 10000098 10000096 10000096 10000096 10000096 10000099 10000099 10000099 10000099 10000099 10000099 10000099 10000099 10000095 10000095 10000095 10000095 10000097 10000097 10000096 10000097 10000096 10000096 10000096 10000096 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000099 10000099 10000100 10000100 10000099 10000099 10000099 10000099 10000097 10000097 10000097 10000097 10000095 10000095 10000095 10000096 10000098 10000098 10000097 10000098 10000096 10000096 10000096 10000096 10000099 10000099 10000099 10000099
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000100
first_time_thread_start_by_thread=8 8 8 8 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 7 7 7 7 9 9 8 9 5 5 5 5 8 8 8 8 4 4 4 4 7 7 7 7 5 5 5 5 5 5 5 5 8 8 8 8 8 8 8 8 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 7 7 7 7 9 9 8 9 5 5 5 5 8 8 8 8 4 4 4 4 7 7 7 7 5 5 5 5 5 5 5 5 8 8 8 8
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99980872412376
threads_final_size=9999816
final_keysum=99980872412376
final_size=9999816
validate_result=success
Validation OK.
Structural validation OK.

total_find=952648281
total_rq=0
total_inserts=52926109
total_deletes=52928199
total_updates=105854308
total_queries=952648281
total_ops=1058502589
find_throughput=95264828
rq_throughput=0
update_throughput=10585430
query_throughput=95264828
total_throughput=105850258


total find                    : 952648281
total rq                      : 0
total inserts                 : 52926109
total deletes                 : 52928199
total updates                 : 105854308
total queries                 : 952648281
total ops                     : 1058502589
find throughput               : 95264828
rq throughput                 : 0
update throughput             : 10585430
query throughput              : 95264828
total throughput              : 105850258

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=4747956211890057
total_execution_walltime=12.593s
REALTIME_MAIN_END_PERF_FORMAT=210873.711705781
[time_cmd_output] time_elapsed_sec=12.73, faults_major=0, faults_minor=195474, mem_maxresident_kb=778544, user_cputime=1586.08, sys_cputime=14.89, percent_cpu=12573%
timeout=false
algorithm=brown_ext_abtree_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1