__step=000033
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000033.txt
__path_data=data/data000033.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979121.480630211
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=20000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,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.006s
prefilling_size=6206402 prefilling_elapsed_millis=1.001s
prefilling_size=6501134 prefilling_elapsed_millis=1.101s
prefilling_size=6772540 prefilling_elapsed_millis=1.201s
prefilling_size=7018844 prefilling_elapsed_millis=1.301s
prefilling_size=7244321 prefilling_elapsed_millis=1.402s
prefilling_size=7452142 prefilling_elapsed_millis=1.502s
prefilling_size=7643447 prefilling_elapsed_millis=1.602s
prefilling_size=7818941 prefilling_elapsed_millis=1.702s
prefilling_size=7981447 prefilling_elapsed_millis=1.803s
prefilling_size=8131416 prefilling_elapsed_millis=1.903s
prefilling_size=8269098 prefilling_elapsed_millis=2.003s
prefilling_size=8395580 prefilling_elapsed_millis=2.103s
prefilling_size=8512596 prefilling_elapsed_millis=2.203s
prefilling_size=8620273 prefilling_elapsed_millis=2.303s
prefilling_size=8722576 prefilling_elapsed_millis=2.404s
prefilling_size=8816074 prefilling_elapsed_millis=2.504s
prefilling_size=8902540 prefilling_elapsed_millis=2.604s
prefilling_size=8982068 prefilling_elapsed_millis=2.704s
prefilling_size=9055181 prefilling_elapsed_millis=2.805s
prefilling_size=9123787 prefilling_elapsed_millis=2.905s
prefilling_size=9186522 prefilling_elapsed_millis=3.005s
prefilling_size=9243905 prefilling_elapsed_millis=3.105s
prefilling_size=9298214 prefilling_elapsed_millis=3.205s
prefilling_size=9347555 prefilling_elapsed_millis=3.306s
prefilling_size=9394285 prefilling_elapsed_millis=3.406s
prefilling_size=9437681 prefilling_elapsed_millis=3.506s
prefilling_size=9478635 prefilling_elapsed_millis=3.606s
prefilling_size=9514479 prefilling_elapsed_millis=3.706s
prefilling_size=9549184 prefilling_elapsed_millis=3.807s
prefilling_size=9580606 prefilling_elapsed_millis=3.907s
prefilling_size=9609621 prefilling_elapsed_millis=4.007s
prefilling_size=9636186 prefilling_elapsed_millis=4.107s
prefilling_size=9662236 prefilling_elapsed_millis=4.208s
prefilling_size=9685171 prefilling_elapsed_millis=4.308s
prefilling_size=9707837 prefilling_elapsed_millis=4.408s
prefilling_size=9728354 prefilling_elapsed_millis=4.508s
prefilling_size=9746888 prefilling_elapsed_millis=4.608s
prefilling_size=9765015 prefilling_elapsed_millis=4.709s
prefilling_size=9781912 prefilling_elapsed_millis=4.809s
prefilling_size=9796798 prefilling_elapsed_millis=4.909s
prefilling_size=9811445 prefilling_elapsed_millis=5.009s
finished prefilling to size 9811469 for expected size 10000000 keysum=98114769736901, performing 79696792 updates; total_prefilling_elapsed_ms=5110 ms)
pref_size=9811469
pref_millis=5110
prefill_elapsed_ms=5133
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=3694

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=6979126.770426206
REALTIME_END_PERF_FORMAT=6979136.770567099

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

tree_stats_computeWalltime=0.152s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 248 469 900 1712 3159 5813 10295 17621 29218 46776 72232 107801 155099 215351 287609 369179 456256 543026 621571 684743 727380 744068 733173 697317 640099 567445 488139 406899 327904 254950 191234 138879 98148 67225 44711 28693 17865 10557 6258 3550 1913 1057 569 286 113 45 15 4 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 8 27 38 88 265 505 1331 2969 6024 11660 21320 36663 60503 94847 143093 206039 282102 369486 464481 558399 642106 710692 754963 769029 754535 712753 646751 569379 485894 400858 318666 243589 179610 129071 89739 60729 39521 25173 14856 8966 5187 2769 1545 852 459 181 75 26 8
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 496 938 1800 3424 6318 11626 20590 35242 58436 93552 144464 215602 310198 430702 575218 738358 912512 1086052 1243142 1369486 1454760 1488136 1466346 1394634 1280198 1134890 976278 813798 655808 509900 382468 277758 196296 134450 89422 57386 35730 21114 12516 7100 3826 2114 1138 572 226 90 30 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 8 27 38 88 265 505 1331 2969 6024 11660 21320 36663 60503 94847 143093 206039 282102 369486 464481 558399 642106 710692 754963 769029 754535 712753 646751 569379 485894 400858 318666 243589 179610 129071 89739 60729 39521 25173 14856 8966 5187 2769 1545 852 459 181 75 26 8
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.96875 1.94556 1.95949 1.95111 1.92261 1.92007 1.88552 1.8558 1.82907 1.80047 1.77211 1.74621 1.71938 1.69424 1.66777 1.64181 1.61793 1.59509 1.57232 1.55082 1.53113 1.51147 1.49268 1.47555 1.45897 1.44325 1.43012 1.41679 1.40293 1.38876 1.37504 1.36311 1.35336 1.34247 1.33255 1.32087 1.31131 1.29547 1.29639 1.28364 1.26944 1.27627 1.26916 1.25132 1.19755 1.19912 1.16667 1.13333 1

tree_stats_height=59
tree_stats_numInternals=9827831
tree_stats_numLeaves=9827832
tree_stats_numNodes=19655663
tree_stats_numKeys=9827830

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=33.3062

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 19840 37520 72000 136960 252720 465040 823600 1409680 2337440 3742080 5778560 8624080 12407920 17228080 23008720 29534320 36500480 43442080 49725680 54779440 58190400 59525440 58653840 55785360 51207920 45395600 39051120 32551920 26232320 20396000 15298720 11110320 7851840 5378000 3576880 2295440 1429200 844560 500640 284000 153040 84560 45520 22880 9040 3600 1200 320
tree_stats_sizeInBytes=786226520

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

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:83178 2:194388 4:139537 8:14907 16:36
    [2^00, 2^01]: 83178
    (2^01, 2^02]: 194388
    (2^02, 2^03]: 139537
    (2^03, 2^04]: 14907
    (2^04, 2^05]: 36
sum_limbo_reclamation_event_size_total=1376870
count_limbo_reclamation_event_size_by_thread=9002 9024 8992 8946 9066 8954 9016 8946 8970 9040 8914 9012 9022 8940 8988 9002 8982 9058 8932 9004 9112 9046 9088 9000 8984 9048 9048 8924 8972 9016 8988 8944 9020 9020 9034 8934 8968 9006 9012 9000 9052 9024 8938 8916 9022 9106 9050 8964
count_limbo_reclamation_event_size_total=432046
sum_limbo_reclamation_event_count_total=849120
first_thread_announced_epoch_by_thread=25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078 25078
sum_num_inserts_by_thread=20189 20392 20386 20213 20389 20071 20109 20072 20527 20419 19972 20279 20268 20293 20473 20229 20149 20439 20280 20371 20193 20499 20233 20255 20392 20000 20572 20620 20143 20108 20331 20148 20548 20589 20540 20119 20186 20356 20456 20427 20530 20376 20267 20193 20628 20995 20239 20138
sum_num_inserts_total=975601
sum_num_deletes_by_thread=20270 20313 20205 20334 20573 20316 20281 20447 20350 20670 20210 20448 20383 20236 20533 20633 20839 20427 20169 20369 20722 20462 20374 20230 20645 20592 20818 20479 20442 20189 20454 20125 20629 20396 20609 19980 20226 20666 20232 20431 20286 20039 19921 20037 20715 20585 20563 20104
sum_num_deletes_total=978957
sum_num_searches_by_thread=4004775 4026194 4055134 4050350 4032430 3994083 4012120 4030489 4065560 4074422 4028278 4007543 4022303 4042594 4065209 4066278 4043425 4017354 3995836 4014819 4039170 4057394 4012795 3986370 4002615 4025108 4055988 4053308 4036011 3996495 4014733 4032278 4069110 4074510 4027975 4007540 4023549 4043242 4068500 4062540 4037458 4016417 3995395 4016036 4040688 4057005 4013581 3982249
sum_num_searches_total=193497256
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4045234 4066899 4095725 4090897 4073392 4034470 4052510 4071008 4106437 4115511 4068460 4048270 4062954 4083123 4106215 4107140 4084413 4058220 4036285 4055559 4080085 4098355 4053402 4026855 4043652 4065700 4097378 4094407 4076596 4036792 4055518 4072551 4110287 4115495 4069124 4047639 4063961 4084264 4109188 4103398 4078274 4056832 4035583 4056266 4082031 4098585 4054383 4022491
average_num_operations_total=4071912
stdev_num_operations_total=3699
sum_num_operations_total=195451814
min_num_operations_total=4022491
max_num_operations_total=4115511
first_time_thread_terminate_by_thread=10000141 10000142 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000142 10000141 10000140 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000142 10000141 10000140 10000141 10000141 10000141 10000141 10000142 10000141 10000141 10000141 10000141 10000141
min_time_thread_terminate_total=10000140
max_time_thread_terminate_total=10000142
first_time_thread_start_by_thread=3 3 2 3 2 3 2 3 3 3 3 2 3 3 2 3 3 3 2 3 3 3 3 3 3 3 2 3 2 3 2 3 3 3 3 2 3 3 2 3 3 3 2 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=98277292761558
threads_final_size=9827830
final_keysum=98277292761558
final_size=9827830
validate_result=success
Validation OK.
Structural validation OK.

total_find=193497256
total_rq=0
total_inserts=975601
total_deletes=978957
total_updates=1954558
total_queries=193497256
total_ops=195451814
find_throughput=19349725
rq_throughput=0
update_throughput=195455
query_throughput=19349725
total_throughput=19545181


total find                    : 193497256
total rq                      : 0
total inserts                 : 975601
total deletes                 : 978957
total updates                 : 1954558
total queries                 : 193497256
total ops                     : 195451814
find throughput               : 19349725
rq throughput                 : 0
update throughput             : 195455
query throughput              : 19349725
total throughput              : 19545181

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=36.2069
PAPI_L3_TCM=12.5393
PAPI_TOT_CYC=6847.33
PAPI_TOT_INS=375.402
garbage=910340350206613
total_execution_walltime=15.562s
REALTIME_MAIN_END_PERF_FORMAT=6979137.44121787
[time_cmd_output] time_elapsed_sec=15.77, faults_major=0, faults_minor=308393, mem_maxresident_kb=1235608, user_cputime=758.81, sys_cputime=3.35, percent_cpu=4832%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1