__step=000035
__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 96 -nprefill 96 -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=data000035.txt
__path_data=data/data000035.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979153.390481005
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.011s
prefilling_size=7391141 prefilling_elapsed_millis=1.001s
prefilling_size=7673961 prefilling_elapsed_millis=1.101s
prefilling_size=7922934 prefilling_elapsed_millis=1.201s
prefilling_size=8143600 prefilling_elapsed_millis=1.301s
prefilling_size=8335275 prefilling_elapsed_millis=1.402s
prefilling_size=8506615 prefilling_elapsed_millis=1.502s
prefilling_size=8662517 prefilling_elapsed_millis=1.602s
prefilling_size=8800080 prefilling_elapsed_millis=1.702s
prefilling_size=8922486 prefilling_elapsed_millis=1.802s
prefilling_size=9033050 prefilling_elapsed_millis=1.903s
prefilling_size=9131488 prefilling_elapsed_millis=2.003s
prefilling_size=9220014 prefilling_elapsed_millis=2.103s
prefilling_size=9296807 prefilling_elapsed_millis=2.203s
prefilling_size=9366454 prefilling_elapsed_millis=2.303s
prefilling_size=9429184 prefilling_elapsed_millis=2.404s
prefilling_size=9487445 prefilling_elapsed_millis=2.504s
prefilling_size=9537138 prefilling_elapsed_millis=2.604s
prefilling_size=9583566 prefilling_elapsed_millis=2.704s
prefilling_size=9624509 prefilling_elapsed_millis=2.804s
prefilling_size=9660922 prefilling_elapsed_millis=2.905s
prefilling_size=9693663 prefilling_elapsed_millis=3.005s
prefilling_size=9723332 prefilling_elapsed_millis=3.105s
prefilling_size=9750097 prefilling_elapsed_millis=3.205s
prefilling_size=9773708 prefilling_elapsed_millis=3.305s
prefilling_size=9796706 prefilling_elapsed_millis=3.406s
prefilling_size=9815734 prefilling_elapsed_millis=3.506s
finished prefilling to size 9815773 for expected size 10000000 keysum=98144060644650, performing 83626736 updates; total_prefilling_elapsed_ms=3607 ms)
pref_size=9815773
pref_millis=3607
prefill_elapsed_ms=3629
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=1259

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=6979157.217256336
REALTIME_END_PERF_FORMAT=6979167.217404456

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

tree_stats_computeWalltime=0.156s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 510 998 1944 3715 6952 12585 22005 36829 58947 90961 133668 188818 254816 329166 408422 488018 561776 625296 672686 701324 707290 691348 655291 600600 533716 460331 385206 313117 248054 191567 143203 104627 74417 51485 34240 22065 13754 8181 4888 2853 1513 788 408 173 66 28 11 8 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 2 22 52 173 478 1319 3165 7181 14711 26933 48254 78518 122820 180466 249910 328826 414260 498256 577906 644048 695358 723232 727405 709982 667484 607101 535456 457295 378180 304541 239931 181779 134837 97349 68730 46415 30376 19327 11474 6923 4193 2238 1168 643 280 104 45 14 14 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1020 1996 3888 7430 13904 25170 44010 73658 117894 181922 267336 377636 509632 658332 816844 976036 1123552 1250592 1345372 1402648 1414580 1382696 1310582 1201200 1067432 920662 770412 626234 496108 383134 286406 209254 148834 102970 68480 44130 27508 16362 9776 5706 3026 1576 816 346 132 56 22 16 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 2 22 52 173 478 1319 3165 7181 14711 26933 48254 78518 122820 180466 249910 328826 414260 498256 577906 644048 695358 723232 727405 709982 667484 607101 535456 457295 378180 304541 239931 181779 134837 97349 68730 46415 30376 19327 11474 6923 4193 2238 1168 643 280 104 45 14 14 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.99609 1.97843 1.97395 1.9555 1.93567 1.90514 1.87426 1.83683 1.80028 1.77155 1.73475 1.70629 1.67477 1.64589 1.62039 1.59744 1.57557 1.55653 1.53789 1.52129 1.50425 1.48873 1.47392 1.45827 1.44432 1.43125 1.4184 1.40643 1.3961 1.38614 1.37377 1.36531 1.35563 1.34592 1.33252 1.32221 1.31167 1.2974 1.29874 1.29184 1.26516 1.26041 1.25888 1.21201 1.19075 1.21212 1.19643 1.36364 1.125 1

tree_stats_height=61
tree_stats_numInternals=9849179
tree_stats_numLeaves=9849180
tree_stats_numNodes=19698359
tree_stats_numKeys=9849178

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40800 79840 155520 297200 556160 1006800 1760400 2946320 4715760 7276880 10693440 15105440 20385280 26333280 32673760 39041440 44942080 50023680 53814880 56105920 56583200 55307840 52423280 48048000 42697280 36826480 30816480 25049360 19844320 15325360 11456240 8370160 5953360 4118800 2739200 1765200 1100320 654480 391040 228240 121040 63040 32640 13840 5280 2240 880 640 160
tree_stats_sizeInBytes=787934360

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

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:30455 2:176546 4:475520 8:225617 16:6198 32:2
    [2^00, 2^01]: 30455
    (2^01, 2^02]: 176546
    (2^02, 2^03]: 475520
    (2^03, 2^04]: 225617
    (2^04, 2^05]: 6198
    (2^05, 2^06]: 2
sum_limbo_reclamation_event_size_total=5357115
count_limbo_reclamation_event_size_by_thread=9522 9514 9534 9516 9510 9522 9536 9506 9518 9510 9552 9536 9546 9544 9534 9542 9542 9504 9538 9520 9506 9530 9522 9508 9512 9528 9524 9508 9522 9528 9512 9532 9512 9520 9526 9518 9516 9498 9534 9560 9524 9512 9546 9522 9544 9536 9530 9530 9526 9520 9528 9532 9518 9520 9510 9524 9516 9526 9518 9510 9522 9554 9532 9528 9534 9512 9528 9538 9514 9540 9548 9516 9532 9524 9518 9524 9498 9514 9524 9532 9516 9526 9530 9506 9520 9528 9524 9524 9516 9536 9514 9524 9534 9534 9504 9516
count_limbo_reclamation_event_size_total=914338
sum_limbo_reclamation_event_count_total=923328
first_thread_announced_epoch_by_thread=12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136 12136
sum_num_inserts_by_thread=22397 22432 22715 22686 22496 22161 22259 22777 22721 22676 22673 22333 22239 22526 22770 22519 22550 22323 22145 22510 22313 22614 22586 22162 22258 22207 22593 22711 22405 21993 22097 22514 22799 22761 22379 22240 22302 22525 22846 22867 22570 22345 22240 22297 22259 22593 22459 22017 22127 22388 22448 22479 22082 22260 22059 22622 22667 22720 22253 22233 22226 22535 22684 22581 22253 22106 22259 22263 22364 22310 22065 21968 22422 22391 22588 22389 22173 22122 22336 22360 22708 22698 22447 22316 22408 22297 22752 22773 22662 22191 22121 22253 22521 22631 22315 22017
sum_num_inserts_total=2151703
sum_num_deletes_by_thread=22240 22147 22520 22793 22365 22019 22259 22191 22705 22493 22451 22442 22189 22522 22305 22800 22634 22374 22403 22377 22339 22325 22107 22046 22288 22569 22285 22499 22308 22293 22266 22248 22752 22507 22487 22434 22009 22527 22961 22731 22483 22191 22054 22186 22511 22545 22122 22283 22289 22619 22687 22441 22473 22131 22416 22520 22699 22455 22499 22326 22215 22406 22380 22786 22302 22274 22083 22379 22723 22356 22300 22285 22153 22365 22434 22656 22321 22075 22249 22210 22329 22580 22098 22169 22448 22183 22727 22875 22299 22262 22141 22238 22576 22341 22634 22377
sum_num_deletes_total=2149369
sum_num_searches_by_thread=4402236 4425040 4462220 4467702 4441091 4387861 4420628 4433346 4475040 4483894 4428321 4399551 4419109 4454961 4482839 4479864 4440780 4422325 4388536 4424028 4444084 4466334 4418392 4372432 4407951 4424613 4463276 4463281 4442213 4393611 4413579 4439011 4478674 4480609 4433692 4406078 4427759 4454650 4473709 4482974 4440302 4416427 4378482 4417112 4441752 4458275 4410281 4382820 4405644 4439393 4476813 4475566 4423159 4411401 4417471 4435621 4485720 4486420 4449769 4421167 4415489 4450929 4480982 4476516 4439310 4386758 4384109 4400230 4453839 4453801 4417646 4390065 4405220 4431590 4466242 4464268 4424520 4406166 4405053 4434511 4486165 4490991 4444145 4413934 4433233 4449349 4482553 4473052 4439638 4379611 4371389 4399517 4457754 4464102 4421282 4403948
sum_num_searches_total=425797796
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4446873 4469619 4507455 4513181 4485952 4432041 4465146 4478314 4520466 4529063 4473445 4444326 4463537 4500009 4527914 4525183 4485964 4467022 4433084 4468915 4488736 4511273 4463085 4416640 4452497 4469389 4508154 4508491 4486926 4437897 4457942 4483773 4524225 4525877 4478558 4450752 4472070 4499702 4519516 4528572 4485355 4460963 4422776 4461595 4486522 4503413 4454862 4427120 4450060 4484400 4521948 4520486 4467714 4455792 4461946 4480763 4531086 4531595 4494521 4465726 4459930 4495870 4526046 4521883 4483865 4431138 4428451 4444872 4498926 4498467 4462011 4434318 4449795 4476346 4511264 4509313 4469014 4450363 4449638 4479081 4531202 4536269 4488690 4458419 4478089 4493829 4528032 4518700 4484599 4424064 4415651 4444008 4502851 4509074 4466231 4448342
average_num_operations_total=4480196
stdev_num_operations_total=3280
sum_num_operations_total=430098868
min_num_operations_total=4415651
max_num_operations_total=4536269
first_time_thread_terminate_by_thread=10000149 10000148 10000148 10000148 10000149 10000148 10000147 10000148 10000150 10000150 10000149 10000148 10000148 10000149 10000148 10000150 10000148 10000147 10000147 10000148 10000149 10000147 10000148 10000149 10000149 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000150 10000150 10000149 10000149 10000150 10000148 10000148 10000150 10000148 10000147 10000147 10000150 10000149 10000147 10000148 10000147 10000150 10000149 10000147 10000147 10000148 10000147 10000147 10000149 10000147 10000147 10000149 10000148 10000147 10000147 10000148 10000149 10000148 10000147 10000147 10000147 10000148 10000147 10000147 10000149 10000150 10000149 10000148 10000148 10000147 10000149 10000147 10000147 10000147 10000147 10000147 10000148 10000149 10000148 10000148 10000147 10000148 10000148 10000147 10000147 10000148 10000147 10000147 10000147
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000150
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 3 4 3 3 3 4 4 4 4 4 3 3 3 4 3 4 4 3 4 4 3 4 4 3 3 4 3 3 3 4 4 4 4 4 3 3 3 4 3 4 4 3 4 4 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98490253607875
threads_final_size=9849178
final_keysum=98490253607875
final_size=9849178
validate_result=success
Validation OK.
Structural validation OK.

total_find=425797796
total_rq=0
total_inserts=2151703
total_deletes=2149369
total_updates=4301072
total_queries=425797796
total_ops=430098868
find_throughput=42579779
rq_throughput=0
update_throughput=430107
query_throughput=42579779
total_throughput=43009886


total find                    : 425797796
total rq                      : 0
total inserts                 : 2151703
total deletes                 : 2149369
total updates                 : 4301072
total queries                 : 425797796
total ops                     : 430098868
find throughput               : 42579779
rq throughput                 : 0
update throughput             : 430107
query throughput              : 42579779
total throughput              : 43009886

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=37.2679
PAPI_L3_TCM=14.3681
PAPI_TOT_CYC=6213.27
PAPI_TOT_INS=373.745
garbage=2096129022239617
total_execution_walltime=14.118s
REALTIME_MAIN_END_PERF_FORMAT=6979167.509383840
[time_cmd_output] time_elapsed_sec=14.34, faults_major=0, faults_minor=314227, mem_maxresident_kb=1254460, user_cputime=1333.66, sys_cputime=5.29, percent_cpu=9331%
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