__step=000284
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000284.txt
__path_data=data/data000284.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982201.277836560
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=200000
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.011s
prefilling_size=99843 prefilling_elapsed_millis=1.001s
finished prefilling to size 99820 for expected size 100000 keysum=9984900045, performing 69520890 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99820
pref_millis=1102
prefill_elapsed_ms=1132
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=871
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6982202.619904228
REALTIME_END_PERF_FORMAT=6982212.620034093
###############################################################################
################################## 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 837 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.034s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 249 454 763 1166 1631 2143 2711 3209 3544 3864 3968 4015 3998 3915 3817 3726 3630 3391 3177 2751 2303 1859 1489 1065 765 472 302 191 132 84 49 31 15 9 6 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 22 74 203 390 614 841 1196 1565 1710 1974 2074 2116 2150 2147 2065 2017 2114 1897 1913 1709 1431 1177 981 702 550 339 212 122 89 60 34 22 10 5 9
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 476 837 1369 2021 2757 3552 4405 5109 5574 5942 6089 6114 6065 5964 5791 5647 5505 5074 4664 4012 3290 2666 2046 1467 1022 641 403 254 173 109 65 37 19 11 9
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 252 476 837 1369 2021 2757 3552 4405 5109 5574 5942 6089 6114 6065 5964 5791 5647 5505 5074 4664 4012 3290 2666 2046 1467 1022 641 403 254 173 109 65 37 19 11 9
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96875 1.90079 1.80462 1.72401 1.62454 1.55715 1.51106 1.47691 1.43133 1.39734 1.3728 1.35695 1.34472 1.33808 1.33784 1.33099 1.33172 1.33203 1.30572 1.29306 1.27037 1.24601 1.24529 1.20893 1.19648 1.17519 1.16536 1.15757 1.15633 1.16142 1.14451 1.14679 1.09231 1.10811 1.10526 1.27273 1
tree_stats_height=44
tree_stats_numInternals=65149
tree_stats_numLeaves=34537
tree_stats_numNodes=99686
tree_stats_numKeys=99686
tree_stats_avgDegreeInternal=1.53012
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34646
tree_stats_avgKeyDepth=21.5117
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48384 91392 160704 262848 388032 529344 681984 845760 980928 1070208 1140864 1169088 1173888 1164480 1145088 1111872 1084224 1056960 974208 895488 770304 631680 511872 392832 281664 196224 123072 77376 48768 33216 20928 12480 7104 3648 2112 1728
tree_stats_sizeInBytes=19139712
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=21201
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:217415 2:453086 4:194177 8:2503
[2^00, 2^01]: 217415
(2^01, 2^02]: 453086
(2^02, 2^03]: 194177
(2^03, 2^04]: 2503
sum_limbo_reclamation_event_size_total=2232136
count_limbo_reclamation_event_size_by_thread=9008 9073 9005 9013 9029 9030 9024 9066 9081 9051 9076 9011 9051 9015 9018 9063 9060 9003 9002 9062 9021 9031 9034 9025 8993 8979 8957 9052 9018 8991 8959 8997 9049 9067 9065 9065 9036 8963 9040 9049 9035 8992 8967 9025 9041 9088 9057 9020 9033 9079 9056 9064 9007 9000 9035 9053 9076 9065 9043 9077 9003 9138 9092 9006 9083 9034 9030 9029 9040 9035 9057 8994 8993 9005 9006 9036 8987 9001 9073 9036 9047 9002 9018 9035 9018 9050 9062 9015 9029 9015 9025 9022 9063 9034 9099 9024
count_limbo_reclamation_event_size_total=867181
sum_limbo_reclamation_event_count_total=1951680
first_thread_announced_epoch_by_thread=42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402 42402
sum_num_inserts_by_thread=93944 93912 94609 94669 94593 93783 94210 93977 95053 95508 95142 94347 94473 93943 94494 95272 94355 93563 93034 94699 94424 94506 93635 93632 92789 93756 94330 94085 94574 94122 94382 94275 95302 94679 94063 94046 94171 94428 95461 95143 94785 94181 93683 94054 94511 94268 94299 93282 94542 94387 96204 94666 93720 94165 94515 95414 95475 95169 94374 94662 93648 94754 95827 96048 95518 93936 93829 93944 94082 94165 94792 94201 93643 94461 94648 94456 94190 93647 93863 93842 95931 95000 94943 94872 94101 94311 95340 94766 93680 93662 94062 94388 95258 95290 95569 94260
sum_num_inserts_total=9066666
sum_num_deletes_by_thread=94062 93897 94536 94763 94530 93496 94216 94140 95495 94841 94731 94465 94138 94156 94518 95093 94461 93922 93146 94465 94403 94450 93930 93248 93729 93576 94265 93942 94716 93549 94266 94355 95663 95276 94596 94266 93941 93858 95047 94645 93541 94365 93153 93669 94915 94841 94251 93068 93830 94543 95197 95256 94170 94325 94211 95192 94937 95146 94258 94838 93398 95423 95523 95626 95345 94007 93485 94301 93965 94559 94749 93486 93937 94050 94353 94640 93716 94016 93659 93703 96063 95060 94220 94640 94261 95056 95284 94996 94129 94521 94342 93990 95625 95642 95036 94451
sum_num_deletes_total=9063755
sum_num_searches_by_thread=18606951 18599525 18729680 18783463 18719143 18558378 18643572 18622489 18865509 18892848 18712246 18652381 18646147 18612574 18731718 18806362 18777600 18558745 18498786 18721074 18736590 18778365 18637914 18480905 18485704 18571008 18703319 18752366 18704969 18625748 18731860 18648746 18886011 18791156 18734743 18637619 18681987 18662920 18843120 18743748 18730981 18641052 18409685 18557673 18736173 18694858 18608940 18397451 18661908 18753705 18885087 18856405 18665535 18636023 18695130 18815010 18870941 18850237 18774064 18771067 18520640 18866220 18965135 18952414 18857886 18597094 18548183 18622067 18717452 18774234 18744477 18564023 18573198 18646846 18697016 18735682 18672042 18584731 18608251 18643071 18977902 18865873 18769079 18785529 18593450 18713530 18888309 18788487 18655063 18663116 18646712 18674877 18916364 18969684 18864935 18756042
sum_num_searches_total=1796009528
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=18794957 18787334 18918825 18972895 18908266 18745657 18831998 18810606 19056057 19083197 18902119 18841193 18834758 18800673 18920730 18996727 18966416 18746230 18684966 18910238 18925417 18967321 18825479 18667785 18672222 18758340 18891914 18940393 18894259 18813419 18920508 18837376 19076976 18981111 18923402 18825931 18870099 18851206 19033628 18933536 18919307 18829598 18596521 18745396 18925599 18883967 18797490 18583801 18850280 18942635 19076488 19046327 18853425 18824513 18883856 19005616 19061353 19040552 18962696 18960567 18707686 19056397 19156485 19144088 19048749 18785037 18735497 18810312 18905499 18962958 18934018 18751710 18760778 18835357 18886017 18924778 18859948 18772394 18795773 18830616 19169896 19055933 18958242 18975041 18781812 18902897 19078933 18978249 18842872 18851299 18835116 18863255 19107247 19160616 19055540 18944753
average_num_operations_total=18897291
stdev_num_operations_total=12685
sum_num_operations_total=1814139949
min_num_operations_total=18583801
max_num_operations_total=19169896
first_time_thread_terminate_by_thread=10000131 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000130 10000130 10000130 10000130 10000132 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000132 10000131 10000130 10000130 10000131 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000130 10000130 10000130 10000130 10000132 10000130 10000130 10000130 10000130 10000131 10000130 10000130 10000131 10000131 10000130 10000130 10000129 10000131 10000131 10000129 10000129 10000129 10000129 10000130 10000130 10000130 10000129 10000129 10000129 10000129 10000130 10000129 10000129 10000129 10000131 10000129 10000129 10000129 10000131 10000129 10000130 10000131 10000131 10000129 10000131 10000129 10000129 10000131 10000130 10000130 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000131 10000129 10000129 10000129 10000131 10000129
min_time_thread_terminate_total=10000129
max_time_thread_terminate_total=10000132
first_time_thread_start_by_thread=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 3 3 4 3 3 3 3 3 3 3 3 3 3 4 4 4 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 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=9961168603
threads_final_size=99686
final_keysum=9961168603
final_size=99686
validate_result=success
Validation OK.
Structural validation OK.
total_find=1796009528
total_rq=0
total_inserts=9066666
total_deletes=9063755
total_updates=18130421
total_queries=1796009528
total_ops=1814139949
find_throughput=179600952
rq_throughput=0
update_throughput=1813042
query_throughput=179600952
total_throughput=181413994
total find : 1796009528
total rq : 0
total inserts : 9066666
total deletes : 9063755
total updates : 18130421
total queries : 1796009528
total ops : 1814139949
find throughput : 179600952
rq throughput : 0
update throughput : 1813042
query throughput : 179600952
total throughput : 181413994
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=3.99794
PAPI_L3_TCM=0.0901035
PAPI_TOT_CYC=1472.66
PAPI_TOT_INS=341.278
garbage=89825108424849
total_execution_walltime=11.489s
REALTIME_MAIN_END_PERF_FORMAT=6982212.782326186
[time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=84856, mem_maxresident_kb=337236, user_cputime=1092.01, sys_cputime=3.05, percent_cpu=9411%
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