__step=000059
__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 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=data000059.txt
__path_data=data/data000059.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979479.323150592
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=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=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.01s
prefilling_size=8710678 prefilling_elapsed_millis=1.001s
prefilling_size=8923533 prefilling_elapsed_millis=1.101s
prefilling_size=9100230 prefilling_elapsed_millis=1.201s
prefilling_size=9245554 prefilling_elapsed_millis=1.302s
prefilling_size=9371528 prefilling_elapsed_millis=1.402s
prefilling_size=9471143 prefilling_elapsed_millis=1.502s
prefilling_size=9555640 prefilling_elapsed_millis=1.602s
prefilling_size=9624941 prefilling_elapsed_millis=1.702s
prefilling_size=9683559 prefilling_elapsed_millis=1.803s
prefilling_size=9732598 prefilling_elapsed_millis=1.903s
prefilling_size=9775020 prefilling_elapsed_millis=2.003s
prefilling_size=9811111 prefilling_elapsed_millis=2.103s
finished prefilling to size 9811144 for expected size 10000000 keysum=98110272873966, performing 79854213 updates; total_prefilling_elapsed_ms=2205 ms)
pref_size=9811144
pref_millis=2205
prefill_elapsed_ms=2223
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=923

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979481.735623856
REALTIME_END_PERF_FORMAT=6979491.735759199

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

tree_stats_computeWalltime=0.077s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 510 1011 1950 3690 6730 11770 19935 32423 50550 75533 108551 149931 199048 253996 311327 367115 417664 458080 483080 490753 480639 454228 414882 365942 311680 257037 205404 158716 118483 85210 59585 40344 26412 16245 9996 5894 3260 1760 914 446 197 102 42 12 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 2 4 40 130 364 922 1968 4034 7718 13799 22820 35959 53910 76757 104403 135630 167081 199107 228342 250163 262852 265885 258083 242493 219001 190831 160717 130819 103302 78588 57259 40835 28077 18792 11553 7218 4414 2416 1340 704 357 142 80 37 10 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1015 1990 3820 7094 12692 21903 36457 58268 89332 131371 185890 252958 330753 415730 502745 584745 657187 711422 740916 743491 720113 672965 608435 530681 447868 366121 289535 221785 163798 116844 81179 54489 35037 21549 13112 7674 4176 2254 1150 554 244 122 49 13 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1015 1990 3820 7094 12692 21903 36457 58268 89332 131371 185890 252958 330753 415730 502745 584745 657187 711422 740916 743491 720113 672965 608435 530681 447868 366121 289535 221785 163798 116844 81179 54489 35037 21549 13112 7674 4176 2254 1150 554 244 122 49 13 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.98633 1.96453 1.9397 1.8911 1.84043 1.79838 1.75433 1.70892 1.66558 1.62506 1.58871 1.55424 1.52066 1.48899 1.46044 1.43288 1.40962 1.38549 1.36242 1.34112 1.32209 1.30375 1.28761 1.27076 1.25663 1.24356 1.22979 1.21783 1.20432 1.19313 1.18481 1.17424 1.15829 1.15138 1.1446 1.13575 1.11936 1.1183 1.1047 1.09391 1.08484 1.08197 1.05738 1.02041 1.07692 1

tree_stats_height=55
tree_stats_numInternals=6461591
tree_stats_numLeaves=3388962
tree_stats_numNodes=9850553
tree_stats_numKeys=9850553

tree_stats_avgDegreeInternal=1.52448
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34404
tree_stats_avgKeyDepth=28.7924

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 98304 194880 382080 733440 1362048 2436864 4205376 6999744 11187456 17151744 25223232 35690880 48567936 63504576 79820160 96527040 112271040 126179904 136593024 142255872 142750272 138261696 129209280 116819520 101890752 85990656 70295232 55590720 42582720 31449216 22434048 15586368 10461888 6727104 4137408 2517504 1473408 801792 432768 220800 106368 46848 23424 9408 2496 768
tree_stats_sizeInBytes=1891306176

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:112398 2:225871 4:93089 8:1231
    [2^00, 2^01]: 112398
    (2^01, 2^02]: 225871
    (2^02, 2^03]: 93089
    (2^03, 2^04]: 1231
sum_limbo_reclamation_event_size_total=1098167
count_limbo_reclamation_event_size_by_thread=4476 4536 4481 4503 4522 4490 4499 4542 4538 4511 4489 4502 4521 4539 4516 4541 4528 4498 4495 4514 4502 4511 4503 4478 4508 4484 4505 4522 4523 4499 4452 4539 4517 4520 4523 4489 4486 4529 4520 4525 4506 4521 4523 4466 4465 4529 4485 4486 4476 4496 4545 4501 4504 4516 4481 4486 4540 4540 4525 4538 4519 4504 4548 4530 4476 4428 4500 4490 4554 4484 4501 4488 4483 4512 4521 4498 4481 4518 4510 4521 4508 4506 4509 4519 4492 4506 4525 4501 4486 4486 4477 4485 4503 4558 4485 4472
count_limbo_reclamation_event_size_total=432589
sum_limbo_reclamation_event_count_total=482208
first_thread_announced_epoch_by_thread=11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892 11892
sum_num_inserts_by_thread=22923 23071 23403 23330 23559 23148 22895 23245 23744 23614 23088 23017 23226 23566 23792 23442 23383 23028 23003 23297 23540 23485 23043 23006 22979 23015 23178 23487 23355 22992 23201 23270 23498 23487 23274 22977 22773 23214 23881 23493 23550 23162 22802 23240 23487 23540 23221 23010 23055 23043 23618 23348 23245 23147 23136 23369 23737 23741 23312 22878 23353 23526 23550 23394 23503 23383 23210 23337 23611 23458 23336 23450 23108 23008 23761 23555 23023 23372 23270 23451 23776 23658 23604 23104 23328 23419 23534 23508 23345 22980 22933 23094 23806 23708 23538 23161
sum_num_inserts_total=2238718
sum_num_deletes_by_thread=22823 23215 23349 23206 23577 22935 23217 23261 23722 23483 23404 23188 23369 23605 23828 23482 23250 23222 22860 23005 23306 23611 23127 22924 22893 23311 23341 23352 23161 23118 23041 23079 23745 23571 23458 23321 23076 23439 23349 23421 23361 23498 22978 22970 23189 23830 22970 23197 23014 23369 23709 23261 23360 22855 23124 23298 23749 23604 23368 23223 23470 23327 23598 23485 23090 22729 22799 23008 23811 23259 23202 22902 23129 23146 23432 23552 23421 23049 23110 23154 23508 23826 23602 23272 23117 23431 23555 23614 23260 23192 22919 22864 23810 23536 23226 23068
sum_num_deletes_total=2236045
sum_num_searches_by_thread=4549239 4592396 4638989 4636118 4626996 4549957 4591025 4609107 4673265 4677460 4615879 4571701 4589446 4625843 4671877 4663048 4634943 4584962 4553683 4589716 4634827 4644082 4585198 4547764 4563886 4596817 4641379 4646281 4615213 4554597 4586803 4613365 4676461 4686918 4607454 4582909 4594708 4630866 4665914 4673465 4626266 4585732 4546091 4590658 4629252 4659098 4595111 4535013 4567911 4606190 4659770 4646046 4599864 4577699 4590267 4617840 4687317 4676237 4638566 4587146 4599948 4632969 4666025 4668335 4622842 4566624 4540020 4579987 4669321 4657199 4618476 4579020 4577977 4600174 4663453 4653167 4596775 4584842 4577867 4615916 4682197 4682294 4641817 4595602 4598090 4638191 4670121 4661205 4610899 4552533 4548683 4575172 4665854 4655890 4611673 4571587
sum_num_searches_total=443049376
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4594985 4638682 4685741 4682654 4674132 4596040 4637137 4655613 4720731 4724557 4662371 4617906 4636041 4673014 4719497 4709972 4681576 4631212 4599546 4636018 4681673 4691178 4631368 4593694 4609758 4643143 4687898 4693120 4661729 4600707 4633045 4659714 4723704 4733976 4654186 4629207 4640557 4677519 4713144 4720379 4673177 4632392 4591871 4636868 4675928 4706468 4641302 4581220 4613980 4652602 4707097 4692655 4646469 4623701 4636527 4664507 4734803 4723582 4685246 4633247 4646771 4679822 4713173 4715214 4669435 4612736 4586029 4626332 4716743 4703916 4665014 4625372 4624214 4646328 4710646 4700274 4643219 4631263 4624247 4662521 4729481 4729778 4689023 4641978 4644535 4685041 4717210 4708327 4657504 4598705 4594535 4621130 4713470 4703134 4658437 4617816
average_num_operations_total=4661709
stdev_num_operations_total=4241
sum_num_operations_total=447524139
min_num_operations_total=4581220
max_num_operations_total=4734803
first_time_thread_terminate_by_thread=10000136 10000135 10000136 10000135 10000135 10000136 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000136 10000136 10000135 10000136 10000135 10000136 10000136 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000136 10000136 10000135 10000136 10000135 10000136 10000136 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000136 10000135 10000135 10000137 10000135 10000135 10000137 10000135 10000135 10000135 10000136 10000135 10000135 10000135 10000135 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000135 10000136 10000136 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000136
min_time_thread_terminate_total=10000135
max_time_thread_terminate_total=10000137
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 4 4 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98513130643738
threads_final_size=9850553
final_keysum=98513130643738
final_size=9850553
validate_result=success
Validation OK.
Structural validation OK.

total_find=443049376
total_rq=0
total_inserts=2238718
total_deletes=2236045
total_updates=4474763
total_queries=443049376
total_ops=447524139
find_throughput=44304937
rq_throughput=0
update_throughput=447476
query_throughput=44304937
total_throughput=44752413


total find                    : 443049376
total rq                      : 0
total inserts                 : 2238718
total deletes                 : 2236045
total updates                 : 4474763
total queries                 : 443049376
total ops                     : 447524139
find throughput               : 44304937
rq throughput                 : 0
update throughput             : 447476
query throughput              : 44304937
total throughput              : 44752413

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=32.3952
PAPI_L3_TCM=8.98446
PAPI_TOT_CYC=5976.66
PAPI_TOT_INS=399.705
garbage=2178115079386220
total_execution_walltime=12.562s
REALTIME_MAIN_END_PERF_FORMAT=6979491.886713264
[time_cmd_output] time_elapsed_sec=12.85, faults_major=0, faults_minor=545218, mem_maxresident_kb=2178412, user_cputime=1192.27, sys_cputime=6.39, percent_cpu=9322%
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