__step=000170
__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 48 -nprefill 48 -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=data000170.txt
__path_data=data/data000170.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980865.796595452
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.003s
prefilling_size=1000340 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000336 for expected size 1000000 keysum=1000443910584, performing 35445808 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000336
pref_millis=1102
prefill_elapsed_ms=1122
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=1624

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980867.110075304
REALTIME_END_PERF_FORMAT=6980877.110215211

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

tree_stats_computeWalltime=0.038s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 241 459 815 1448 2482 4101 6329 9350 13250 18162 23733 29697 35811 41453 46548 50510 52637 53027 50854 46553 40702 33727 27035 20673 15191 10795 7265 4764 3041 1917 1185 692 381 196 92 34 9 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 7 7 63 98 226 474 1013 1809 2961 4520 6802 9437 12639 16074 19301 22630 25784 27649 29184 29124 27426 24950 21101 17344 13599 10205 7472 5022 3367 2156 1403 865 506 298 152 83 28 9 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 248 466 878 1546 2708 4575 7342 11159 16211 22682 30535 39134 48450 57527 65849 73140 78421 80676 80038 75677 68128 58677 48136 38017 28790 21000 14737 9786 6408 4073 2588 1557 887 494 244 117 37 10 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 248 466 878 1546 2708 4575 7342 11159 16211 22682 30535 39134 48450 57527 65849 73140 78421 80676 80038 75677 68128 58677 48136 38017 28790 21000 14737 9786 6408 4073 2588 1557 887 494 244 117 37 10 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.94531 1.90726 1.89914 1.83257 1.81501 1.7729 1.70842 1.65786 1.61484 1.58183 1.5455 1.50437 1.4792 1.44821 1.42408 1.40383 1.38161 1.35754 1.33481 1.31014 1.28509 1.26384 1.24556 1.22815 1.21351 1.20177 1.18771 1.17107 1.168 1.16105 1.16474 1.14374 1.12524 1.1274 1.09717 1.10246 1.02564 1.02703 1 1

tree_stats_height=47
tree_stats_numInternals=655414
tree_stats_numLeaves=345790
tree_stats_numNodes=1001204
tree_stats_numKeys=1001204

tree_stats_avgDegreeInternal=1.52759
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34537
tree_stats_avgKeyDepth=24.9383

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 47616 89472 168576 296832 519936 878400 1409664 2142528 3112512 4354944 5862720 7513728 9302400 11045184 12643008 14042880 15056832 15489792 15367296 14529984 13080576 11265984 9242112 7299264 5527680 4032000 2829504 1878912 1230336 782016 496896 298944 170304 94848 46848 22464 7104 1920 192
tree_stats_sizeInBytes=192231168

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175984 2:137427 4:13627 8:15
    [2^00, 2^01]: 175984
    (2^01, 2^02]: 137427
    (2^02, 2^03]: 13627
    (2^03, 2^04]: 15
sum_limbo_reclamation_event_size_total=546769
count_limbo_reclamation_event_size_by_thread=6719 6799 6861 6929 6858 6777 6773 6776 6809 6818 6887 6830 6747 6852 6843 6899 6852 6785 6811 6860 6827 6832 6821 6802 6853 6733 6809 6737 6795 6743 6728 6796 6884 6865 6852 6822 6754 6809 6923 6913 6794 6751 6724 6786 6816 6817 6778 6804
count_limbo_reclamation_event_size_total=327053
sum_limbo_reclamation_event_count_total=1022352
first_thread_announced_epoch_by_thread=45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846 45846
sum_num_inserts_by_thread=47857 48169 49315 48546 48737 47623 48665 48223 49035 49673 48903 48288 48507 48831 49367 49249 48885 48715 48072 48344 48940 48701 48658 48334 48077 48634 49052 48895 48655 48294 48014 48821 48796 48940 48756 48231 48897 48400 49170 49078 48588 48735 48404 48282 48409 48765 48286 48057
sum_num_inserts_total=2333873
sum_num_deletes_by_thread=47990 48477 49105 49315 48802 48108 48424 48620 49073 48946 48559 48427 48126 48762 49030 49073 48842 48597 48260 48334 48936 48751 48575 48326 48133 47802 48658 48806 48455 48176 48275 48660 49047 49003 48659 48568 48192 49002 49108 48879 48622 48238 47578 48307 48608 49079 48207 48225
sum_num_deletes_total=2331745
sum_num_searches_by_thread=9476688 9549642 9702528 9694903 9646097 9467747 9538172 9590198 9711099 9778945 9652874 9549909 9590343 9595823 9721846 9722234 9643245 9614633 9551656 9565215 9701490 9672476 9573081 9538596 9488506 9553057 9695615 9701460 9598685 9538537 9581597 9639071 9720074 9724479 9659340 9606072 9612473 9592176 9696702 9687526 9637875 9615502 9527394 9555264 9632102 9684938 9565815 9540468
sum_num_searches_total=461704168
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9572535 9646288 9800948 9792764 9743636 9563478 9635261 9687041 9809207 9877564 9750336 9646624 9686976 9693416 9820243 9820556 9740972 9711945 9647988 9661893 9799366 9769928 9670314 9635256 9584716 9649493 9793325 9799161 9695795 9635007 9677886 9736552 9817917 9822422 9756755 9702871 9709562 9689578 9794980 9785483 9735085 9712475 9623376 9651853 9729119 9782782 9662308 9636750
average_num_operations_total=9716037
stdev_num_operations_total=10976
sum_num_operations_total=466369786
min_num_operations_total=9563478
max_num_operations_total=9877564
first_time_thread_terminate_by_thread=10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141
min_time_thread_terminate_total=10000140
max_time_thread_terminate_total=10000141
first_time_thread_start_by_thread=3 3 2 3 2 2 3 3 3 3 3 2 2 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 2 2 3 3 3 3 3 2 2 3 3 3 3 3 3 3 2 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1001607477784
threads_final_size=1001204
final_keysum=1001607477784
final_size=1001204
validate_result=success
Validation OK.
Structural validation OK.

total_find=461704168
total_rq=0
total_inserts=2333873
total_deletes=2331745
total_updates=4665618
total_queries=461704168
total_ops=466369786
find_throughput=46170416
rq_throughput=0
update_throughput=466561
query_throughput=46170416
total_throughput=46636978


total find                    : 461704168
total rq                      : 0
total inserts                 : 2333873
total deletes                 : 2331745
total updates                 : 4665618
total queries                 : 461704168
total ops                     : 466369786
find throughput               : 46170416
rq throughput                 : 0
update throughput             : 466561
query throughput              : 46170416
total throughput              : 46636978

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.1898
PAPI_L3_TCM=1.69888
PAPI_TOT_CYC=2869.28
PAPI_TOT_INS=368.733
garbage=226181362493532
total_execution_walltime=11.432s
REALTIME_MAIN_END_PERF_FORMAT=6980877.237847527
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=124709, mem_maxresident_kb=500880, user_cputime=560.85, sys_cputime=2.67, percent_cpu=4861%
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