__step=000395
__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" ./drachsler_pext_bst_lock.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000395.txt
__path_data=data/data000395.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983604.592087920
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=drachsler_pext_bst_lock
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=192
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.033s
prefilling_size=8691452 prefilling_elapsed_millis=1s
prefilling_size=8904399 prefilling_elapsed_millis=1.1s
prefilling_size=9079418 prefilling_elapsed_millis=1.201s
prefilling_size=9225979 prefilling_elapsed_millis=1.301s
prefilling_size=9347280 prefilling_elapsed_millis=1.401s
prefilling_size=9448180 prefilling_elapsed_millis=1.501s
prefilling_size=9535239 prefilling_elapsed_millis=1.601s
prefilling_size=9604810 prefilling_elapsed_millis=1.701s
prefilling_size=9666125 prefilling_elapsed_millis=1.802s
prefilling_size=9717627 prefilling_elapsed_millis=1.902s
prefilling_size=9762643 prefilling_elapsed_millis=2.002s
prefilling_size=9800648 prefilling_elapsed_millis=2.102s
finished prefilling to size 9800738 for expected size 10000000 keysum=98016299668855, performing 80130289 updates; total_prefilling_elapsed_ms=2204 ms)
pref_size=9800738
pref_millis=2204
prefill_elapsed_ms=2224
6node_tIxPvE_object_size=192
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=925

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983607.8295028
REALTIME_END_PERF_FORMAT=6983617.8429570

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

tree_stats_computeWalltime=0.094s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 238 456 864 1593 2910 5137 8841 14894 24309 38327 58391 85732 121921 167246 221739 282028 345781 406654 459543 496626 513930 510001 487439 445925 394288 337072 278963 223176 173418 130260 95110 67550 46044 30601 19855 12440 7504 4521 2626 1530 864 435 232 121 60 38 19 8 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 13 10 28 74 151 388 781 1498 2973 5680 9837 16849 26767 41421 60584 86903 116652 152233 188556 224473 253830 273773 281118 278808 261227 236987 207304 175297 142379 112987 86076 63642 46303 31777 21419 14208 8994 5410 3289 1931 1127 687 312 172 94 38 26 14 5 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 251 466 892 1667 3061 5525 9622 16392 27282 44007 68228 102581 148688 208667 282323 368931 462433 558887 648099 721099 767760 783774 768557 724733 655515 574059 486267 398473 315797 243247 181186 131192 92347 62378 41274 26648 16498 9931 5915 3461 1991 1122 544 293 154 76 45 22 9 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 251 466 892 1667 3061 5525 9622 16392 27282 44007 68228 102581 148688 208667 282323 368931 462433 558887 648099 721099 767760 783774 768557 724733 655515 574059 486267 398473 315797 243247 181186 131192 92347 62378 41274 26648 16498 9931 5915 3461 1991 1122 544 293 154 76 45 22 9 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.97638 1.90837 1.93562 1.90022 1.88062 1.8543 1.81176 1.78476 1.75573 1.72201 1.67946 1.64768 1.61372 1.58341 1.55149 1.52136 1.48899 1.46084 1.43201 1.40357 1.376 1.35147 1.32989 1.30875 1.2892 1.27424 1.25989 1.24577 1.23244 1.22112 1.20936 1.19914 1.18901 1.17688 1.1711 1.16458 1.15228 1.14711 1.14037 1.14117 1.1332 1.12958 1.09715 1.11213 1.11263 1.1039 1.09211 1.06667 1.04545 1 1

tree_stats_height=58
tree_stats_numInternals=6527518
tree_stats_numLeaves=3445109
tree_stats_numNodes=9972627
tree_stats_numKeys=9972627

tree_stats_avgDegreeInternal=1.52778
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34546
tree_stats_avgKeyDepth=29.2598

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 48192 89472 171264 320064 587712 1060800 1847424 3147264 5238144 8449344 13099776 19695552 28548096 40064064 54206016 70834752 88787136 107306304 124435008 138451008 147409920 150484608 147562944 139148736 125858880 110219328 93363264 76506816 60633024 46703424 34787712 25188864 17730624 11976576 7924608 5116416 3167616 1906752 1135680 664512 382272 215424 104448 56256 29568 14592 8640 4224 1728 768
tree_stats_sizeInBytes=1914744384

6node_tIxPvE_object_size=192
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=5808


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:39 8:23360 16:425872 32:19289 64:14
    (2^01, 2^02]: 2
    (2^02, 2^03]: 39
    (2^03, 2^04]: 23360
    (2^04, 2^05]: 425872
    (2^05, 2^06]: 19289
    (2^06, 2^07]: 14
sum_limbo_reclamation_event_size_total=10774550
count_limbo_reclamation_event_size_by_thread=4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881 4881
count_limbo_reclamation_event_size_total=468576
sum_limbo_reclamation_event_count_total=468768
first_thread_announced_epoch_by_thread=11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616 11616
sum_num_inserts_by_thread=224844 225495 229257 229021 227279 222502 224063 226650 229764 228827 225288 224924 226655 226303 227778 229328 227463 226649 223693 226696 226519 226955 224738 223691 223938 224299 227778 227622 227787 223111 223699 225382 229299 228571 224198 225581 225449 225430 227861 229472 226425 224177 223930 224322 226769 229083 225978 221861 223863 224751 227243 229158 225127 224320 225231 225864 229096 230442 226430 225542 225803 227970 229161 228758 228432 223268 223615 225413 229718 228752 225462 224685 224845 226724 229051 226829 226295 225329 223549 227804 230638 228974 226946 224312 225310 226969 229474 229892 226650 224996 224746 225524 227985 228758 227001 225706
sum_num_inserts_total=21738815
sum_num_deletes_by_thread=224442 226618 228760 228792 228007 222288 223901 227312 231551 228490 224962 225698 226258 225201 228331 229271 226366 226086 223849 226789 226412 227682 223419 223870 223279 225102 227509 228127 228153 222145 224755 225029 228303 228664 225164 225766 225313 226082 227703 229072 227037 224530 223403 223551 225869 228957 225647 222025 223356 225389 226969 228267 225293 223980 224040 225896 228328 229292 227008 224598 225913 227901 228065 228943 227935 223195 223685 225970 229082 228939 225729 224468 225146 225673 228975 227473 226579 225384 223224 227065 231019 228839 226510 225419 225238 226105 227361 230114 225910 224768 222752 225277 227882 229245 227633 224922
sum_num_deletes_total=21726294
sum_num_searches_by_thread=4041120 4073764 4117539 4116042 4093220 4003754 4033806 4089109 4144860 4123140 4059988 4060651 4071008 4065999 4104607 4132760 4074363 4067519 4033497 4063070 4075866 4095806 4039747 4031498 4016189 4047690 4092200 4092153 4095688 4008486 4033221 4059231 4116487 4122838 4060510 4057450 4042980 4066933 4106323 4132348 4074768 4036188 4032297 4033526 4076098 4124285 4063336 3998708 4020445 4047653 4093726 4123122 4056765 4035074 4038599 4065543 4125776 4122918 4075069 4043832 4053093 4110509 4110715 4110693 4101617 4017953 4025353 4056119 4129789 4121477 4053637 4050320 4048127 4075263 4122677 4093462 4080686 4058305 4033682 4086618 4152444 4129861 4078753 4041925 4052336 4075837 4101088 4140892 4072053 4044951 4032926 4064076 4106682 4128722 4089007 4057404
sum_num_searches_total=391160240
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4490406 4525877 4575556 4573855 4548506 4448544 4481770 4543071 4606175 4580457 4510238 4511273 4523921 4517503 4560716 4591359 4528192 4520254 4481039 4516555 4528797 4550443 4487904 4479059 4463406 4497091 4547487 4547902 4551628 4453742 4481675 4509642 4574089 4580073 4509872 4508797 4493742 4518445 4561887 4590892 4528230 4484895 4479630 4481399 4528736 4582325 4514961 4442594 4467664 4497793 4547938 4580547 4507185 4483374 4487870 4517303 4583200 4582652 4528507 4493972 4504809 4566380 4567941 4568394 4557984 4464416 4472653 4507502 4588589 4579168 4504828 4499473 4498118 4527660 4580703 4547764 4533560 4509018 4480455 4541487 4614101 4587674 4532209 4491656 4502884 4528911 4557923 4600898 4524613 4494715 4480424 4514877 4562549 4586725 4543641 4508032
average_num_operations_total=4527347
stdev_num_operations_total=4141
sum_num_operations_total=434625349
min_num_operations_total=4442594
max_num_operations_total=4614101
first_time_thread_terminate_by_thread=10000137 10000136 10000135 10000136 10000137 10000135 10000135 10000136 10000135 10000134 10000134 10000136 10000134 10000135 10000134 10000134 10000136 10000134 10000134 10000134 10000135 10000136 10000135 10000134 10000137 10000136 10000134 10000136 10000137 10000135 10000136 10000136 10000135 10000134 10000134 10000134 10000134 10000135 10000134 10000134 10000135 10000134 10000135 10000134 10000136 10000136 10000134 10000135 10000134 10000134 10000136 10000134 10000137 10000135 10000136 10000134 10000135 10000134 10000137 10000134 10000135 10000134 10000137 10000134 10000134 10000136 10000134 10000134 10000134 10000134 10000137 10000136 10000136 10000136 10000137 10000136 10000134 10000135 10000134 10000133 10000135 10000134 10000134 10000135 10000135 10000134 10000137 10000134 10000134 10000135 10000134 10000137 10000135 10000135 10000137 10000134
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000137
first_time_thread_start_by_thread=7 7 7 7 7 7 7 7 7 7 7 7 7 8 7 7 7 7 8 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 7 8 7 7 7 7 8 7 7 7 7 7 7 7 7 7 7 7 7 7 6 7 7 7 6 6 7 7 6 7 7 7 6 7 7 7 7 7 7 7 7 7 7 7 6 7 7 7 6 6 7 7 6 7 7 7 6 7 7 7
min_time_thread_start_total=6
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=99728265985119
threads_final_size=9972627
final_keysum=99728265985119
final_size=9972627
validate_result=success
Validation OK.
Structural validation OK.

total_find=391160240
total_rq=0
total_inserts=21738815
total_deletes=21726294
total_updates=43465109
total_queries=391160240
total_ops=434625349
find_throughput=39116024
rq_throughput=0
update_throughput=4346510
query_throughput=39116024
total_throughput=43462534


total find                    : 391160240
total rq                      : 0
total inserts                 : 21738815
total deletes                 : 21726294
total updates                 : 43465109
total queries                 : 391160240
total ops                     : 434625349
find throughput               : 39116024
rq throughput                 : 0
update throughput             : 4346510
query throughput              : 39116024
total throughput              : 43462534

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=32.9487
PAPI_L3_TCM=8.77463
PAPI_TOT_CYC=6154.97
PAPI_TOT_INS=415.26
garbage=1920155931291379
total_execution_walltime=12.593s
REALTIME_MAIN_END_PERF_FORMAT=6983617.186288584
[time_cmd_output] time_elapsed_sec=12.86, faults_major=0, faults_minor=550633, mem_maxresident_kb=2200288, user_cputime=1196.48, sys_cputime=5.77, percent_cpu=9345%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1