__step=000172
__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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000172.txt
__path_data=data/data000172.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980889.131197551
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=2000000
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.022s
prefilling_size=998753 prefilling_elapsed_millis=1.001s
finished prefilling to size 998768 for expected size 1000000 keysum=998511102794, performing 54827998 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=998768
pref_millis=1102
prefill_elapsed_ms=1119
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=654

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980890.451742644
REALTIME_END_PERF_FORMAT=6980900.451881299

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

tree_stats_computeWalltime=0.036s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 253 486 920 1678 2909 4817 7747 11883 17235 23788 31199 38860 45531 50943 54195 54988 53164 49685 44260 37803 30935 24457 18993 14404 10559 7656 5447 3729 2421 1566 1008 609 344 198 92 48 15 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 13 29 87 258 548 1034 1967 3534 5789 8854 12583 17251 21376 25176 28246 29992 29799 29008 26648 23314 19535 15633 12202 9599 6994 5061 3689 2605 1701 1072 735 459 246 161 76 42 12 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 499 949 1765 3167 5365 8781 13850 20769 29577 40053 51443 62782 72319 79371 83234 83156 79484 73268 64451 54249 43992 34626 26606 20158 14650 10508 7418 5026 3267 2080 1344 803 444 253 124 57 16 4 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 499 949 1765 3167 5365 8781 13850 20769 29577 40053 51443 62782 72319 79371 83234 83156 79484 73268 64451 54249 43992 34626 26606 20158 14650 10508 7418 5026 3267 2080 1344 803 444 253 124 57 16 4 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.9685 1.92786 1.89041 1.84363 1.7755 1.73886 1.69502 1.64159 1.59425 1.54992 1.50543 1.46502 1.42668 1.39309 1.36586 1.33842 1.31651 1.2967 1.27558 1.25517 1.24069 1.23116 1.21986 1.21627 1.20295 1.19468 1.18757 1.17484 1.16832 1.15733 1.16154 1.14435 1.12453 1.12387 1.12648 1.07258 1.01754 1 1.25 1

tree_stats_height=48
tree_stats_numInternals=655085
tree_stats_numLeaves=345334
tree_stats_numNodes=1000419
tree_stats_numKeys=1000419

tree_stats_avgDegreeInternal=1.52716
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34519
tree_stats_avgKeyDepth=23.9685

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48768 95808 182208 338880 608064 1030080 1685952 2659200 3987648 5678784 7690176 9877056 12054144 13885248 15239232 15980928 15965952 15260928 14067456 12374592 10415808 8446464 6648192 5108352 3870336 2812800 2017536 1424256 964992 627264 399360 258048 154176 85248 48576 23808 10944 3072 768 384
tree_stats_sizeInBytes=192080448

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:218451 2:451855 4:191966 8:2564 16:28
    [2^00, 2^01]: 218451
    (2^01, 2^02]: 451855
    (2^02, 2^03]: 191966
    (2^03, 2^04]: 2564
    (2^04, 2^05]: 28
sum_limbo_reclamation_event_size_total=2220903
count_limbo_reclamation_event_size_by_thread=9009 8965 9019 8984 8995 8970 9010 9029 9021 9048 9039 8996 9042 8988 8990 9067 9014 8952 8983 9052 9018 9058 9016 8985 8982 8965 9001 9054 9025 9019 9016 9034 9012 9033 8986 9062 9004 9008 9019 9052 8966 9025 8967 8986 9020 9049 9012 8989 9002 8997 9059 9019 8990 8951 8985 9022 9043 9020 9064 8986 9010 9039 9045 9036 8968 8944 9020 9006 9005 8977 8989 9002 8976 8991 8973 8984 9020 8963 8984 8999 9010 9107 9056 9036 9001 9016 9025 8988 9012 9000 8948 8993 9009 9058 8998 9002
count_limbo_reclamation_event_size_total=864864
sum_limbo_reclamation_event_count_total=1073280
first_thread_announced_epoch_by_thread=23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668 23668
sum_num_inserts_by_thread=50734 51622 52258 51546 51784 50874 51297 51844 52544 52245 52186 51170 51697 52348 51913 52513 51975 51561 51383 51923 52128 52086 51882 51456 50803 51171 51990 51462 51689 51169 52064 51844 52334 52428 52247 51575 50911 51773 51960 52339 52006 52053 50580 51102 51555 52634 51726 50734 51562 51712 52075 51695 51933 51180 51146 51413 52871 53054 52660 51994 51824 51506 52510 52507 51615 50828 51313 51476 51920 52027 51294 51786 51483 51916 51899 51946 51472 50954 51095 51731 52753 52538 52739 52025 51935 51943 51928 52183 51877 51345 50866 51588 52374 52445 51978 52031
sum_num_inserts_total=4972063
sum_num_deletes_by_thread=51404 51328 51567 51752 51612 50929 51844 52040 52641 52658 51860 50974 51877 51395 52054 52118 51969 51549 51189 51711 51778 52014 51486 51752 51076 51079 51833 52123 51901 51074 51744 51921 52003 52552 51759 51669 51218 52139 52146 51998 51433 51358 50997 51246 51814 52458 51705 50673 51320 51623 51737 52151 51512 51593 51409 51750 52665 53054 51952 51653 51899 52189 52422 52495 51650 51061 51551 51673 51632 51625 51193 51198 51277 51871 51660 51737 51477 50907 51478 51344 52706 53277 52165 52172 51938 51985 51878 51683 52425 51428 50969 51671 52403 52262 51876 51982
sum_num_deletes_total=4968998
sum_num_searches_by_thread=10079036 10159396 10266484 10253505 10223732 10065645 10240493 10300420 10429859 10362124 10300159 10133244 10227498 10307901 10298048 10318444 10265466 10183270 10190035 10263459 10282444 10322704 10282207 10181347 10088386 10165479 10272749 10279049 10234060 10187989 10252341 10302926 10346697 10428006 10293384 10220553 10163306 10309517 10308480 10317650 10249053 10166352 10077910 10160026 10255087 10373520 10249405 10069448 10196245 10259164 10276266 10251899 10244098 10165949 10166567 10244545 10369408 10444196 10365904 10241886 10275126 10257351 10329710 10332868 10238277 10099609 10170576 10215543 10270220 10270148 10181558 10198411 10183312 10251019 10269216 10347507 10144021 10120666 10122490 10179764 10438137 10457309 10360643 10265095 10274229 10240581 10300421 10292703 10325338 10197969 10079735 10261599 10324304 10431911 10332664 10259715
sum_num_searches_total=984234165
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10181174 10262346 10370309 10356803 10327128 10167448 10343634 10404304 10535044 10467027 10404205 10235388 10331072 10411644 10402015 10423075 10369410 10286380 10292607 10367093 10386350 10426804 10385575 10284555 10190265 10267729 10376572 10382634 10337650 10290232 10356149 10406691 10451034 10532986 10397390 10323797 10265435 10413429 10412586 10421987 10352492 10269763 10179487 10262374 10358456 10478612 10352836 10170855 10299127 10362499 10380078 10355745 10347543 10268722 10269122 10347708 10474944 10550304 10470516 10345533 10378849 10361046 10434642 10437870 10341542 10201498 10273440 10318692 10373772 10373800 10284045 10301395 10286072 10354806 10372775 10451190 10246970 10222527 10225063 10282839 10543596 10563124 10465547 10369292 10378102 10344509 10404227 10396569 10429640 10300742 10181570 10364858 10429081 10536618 10436518 10363728
average_num_operations_total=10355991
stdev_num_operations_total=9159
sum_num_operations_total=994175226
min_num_operations_total=10167448
max_num_operations_total=10563124
first_time_thread_terminate_by_thread=10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000138 10000139 10000138 10000140 10000138 10000138 10000139 10000138 10000140 10000140 10000138 10000138 10000138 10000138 10000138 10000139 10000139 10000138 10000138 10000139 10000139 10000138 10000138 10000138 10000138 10000139 10000138 10000140 10000140 10000138 10000139 10000138 10000140 10000140 10000138 10000138 10000138 10000138 10000138 10000139 10000139 10000138 10000138 10000140 10000138 10000138 10000138 10000140 10000138 10000139 10000139 10000138 10000140 10000140 10000139 10000138 10000139 10000138 10000140 10000138 10000137 10000138 10000138 10000138 10000139 10000138 10000140 10000140 10000138 10000138 10000138 10000140 10000138 10000139 10000139 10000138 10000138 10000140 10000139 10000138 10000139 10000138 10000140 10000138 10000137 10000138 10000138 10000138 10000138
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000140
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 4 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 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3
min_time_thread_start_total=2
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=1000884385285
threads_final_size=1000419
final_keysum=1000884385285
final_size=1000419
validate_result=success
Validation OK.
Structural validation OK.

total_find=984234165
total_rq=0
total_inserts=4972063
total_deletes=4968998
total_updates=9941061
total_queries=984234165
total_ops=994175226
find_throughput=98423416
rq_throughput=0
update_throughput=994106
query_throughput=98423416
total_throughput=99417522


total find                    : 984234165
total rq                      : 0
total inserts                 : 4972063
total deletes                 : 4968998
total updates                 : 9941061
total queries                 : 984234165
total ops                     : 994175226
find throughput               : 98423416
rq throughput                 : 0
update throughput             : 994106
query throughput              : 98423416
total throughput              : 99417522

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.3564
PAPI_L3_TCM=1.97028
PAPI_TOT_CYC=2690.19
PAPI_TOT_INS=360.981
garbage=487147459599971
total_execution_walltime=11.471s
REALTIME_MAIN_END_PERF_FORMAT=6980900.604141008
[time_cmd_output] time_elapsed_sec=11.61, faults_major=0, faults_minor=128327, mem_maxresident_kb=510856, user_cputime=1093.38, sys_cputime=3.94, percent_cpu=9450%
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=2