__step=000282
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000282.txt
__path_data=data/data000282.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982178.38861017
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=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.006s
prefilling_size=99867 prefilling_elapsed_millis=1.001s
finished prefilling to size 99800 for expected size 100000 keysum=9981851889, performing 68492249 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99800
pref_millis=1102
prefill_elapsed_ms=1123
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=3178

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982179.326175493
REALTIME_END_PERF_FORMAT=6982189.326320964

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 62 121 215 386 666 1102 1766 2703 3785 4978 6055 6796 6962 6525 5704 4635 3630 2759 2051 1459 993 717 502 335 191 91 33 18 5 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 2 15 26 58 119 241 442 874 1403 2124 2897 3550 3935 3814 3534 2956 2332 1839 1372 990 661 489 353 261 154 69 23 15 4 1 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 123 230 412 724 1221 2007 3145 4659 6381 8179 9693 10512 10460 9518 8169 6586 5091 3890 2831 1983 1378 991 688 452 245 102 41 20 6 2 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 123 230 412 724 1221 2007 3145 4659 6381 8179 9693 10512 10460 9518 8169 6586 5091 3890 2831 1983 1378 991 688 452 245 102 41 20 6 2 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.96825 1.88618 1.85652 1.82039 1.76657 1.7412 1.6871 1.62194 1.5572 1.50165 1.4448 1.38337 1.33276 1.28614 1.25898 1.23883 1.22183 1.22216 1.20051 1.18509 1.19415 1.19884 1.18769 1.17006 1.11947 1.0449 1.07843 1.04878 1.05 1 1 1

tree_stats_height=38
tree_stats_numInternals=65311
tree_stats_numLeaves=34555
tree_stats_numNodes=99866
tree_stats_numKeys=99866

tree_stats_avgDegreeInternal=1.52908
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34601
tree_stats_avgKeyDepth=18.9102

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12096 23616 44160 79104 139008 234432 385344 603840 894528 1225152 1570368 1861056 2018304 2008320 1827456 1568448 1264512 977472 746880 543552 380736 264576 190272 132096 86784 47040 19584 7872 3840 1152 384 192
tree_stats_sizeInBytes=19174272

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175122 2:139198 4:14007 8:16
    [2^00, 2^01]: 175122
    (2^01, 2^02]: 139198
    (2^02, 2^03]: 14007
    (2^03, 2^04]: 16
sum_limbo_reclamation_event_size_total=551854
count_limbo_reclamation_event_size_by_thread=6804 6858 6818 6839 6846 6840 6771 6914 6898 6857 6943 6840 6810 6905 6834 6848 6872 6952 6895 6867 6889 6878 6795 6827 6860 6875 6799 6813 6800 6800 6788 6880 6872 6794 6840 6834 6755 6826 6911 6838 6815 6827 6807 6760 6817 6753 6840 6839
count_limbo_reclamation_event_size_total=328343
sum_limbo_reclamation_event_count_total=2138687
first_thread_announced_epoch_by_thread=95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468 95468
sum_num_inserts_by_thread=101214 101933 102644 102907 103313 101921 102088 102463 103672 103638 103633 102094 102993 103983 103978 104853 104001 103235 103150 102138 103313 104724 102576 101439 102001 103055 102661 103891 101787 101712 101727 103828 103717 102361 103382 101209 101886 102922 104154 103651 102015 103285 101794 101149 102566 103992 101867 101527
sum_num_inserts_total=4934042
sum_num_deletes_by_thread=101459 101698 102841 102223 103430 102191 101558 102436 103127 103055 103620 101799 102632 103370 103572 104604 103730 103915 103029 102217 102889 104589 101972 101332 101469 103527 102792 103165 102772 101696 101785 103214 103204 102361 102801 101819 101749 102130 104346 103140 102165 102891 102276 101055 102384 103896 102101 101592
sum_num_deletes_total=4927618
sum_num_searches_by_thread=20031291 20214779 20321148 20368517 20474257 20216780 20160994 20276805 20422582 20448519 20501192 20175425 20346596 20527346 20571414 20718037 20613752 20506617 20390640 20223079 20408400 20695119 20287416 20129147 20200429 20445976 20303375 20535305 20266796 20107118 20216315 20465621 20429464 20350784 20416201 20146837 20130533 20279673 20635045 20482418 20236539 20447942 20250314 20082763 20261277 20561338 20210206 20114171
sum_num_searches_total=976606292
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=20233964 20418410 20526633 20573647 20681000 20420892 20364640 20481704 20629381 20655212 20708445 20379318 20552221 20734699 20778964 20927494 20821483 20713767 20596819 20427434 20614602 20904432 20491964 20331918 20403899 20652558 20508828 20742361 20471355 20310526 20419827 20672663 20636385 20555506 20622384 20349865 20334168 20484725 20843545 20689209 20440719 20654118 20454384 20284967 20466227 20769226 20414174 20317290
average_num_operations_total=20551415
stdev_num_operations_total=25132
sum_num_operations_total=986467952
min_num_operations_total=20233964
max_num_operations_total=20927494
first_time_thread_terminate_by_thread=10000144 10000144 10000143 10000144 10000144 10000143 10000143 10000143 10000144 10000143 10000143 10000144 10000144 10000144 10000143 10000143 10000144 10000143 10000144 10000144 10000144 10000143 10000144 10000144 10000144 10000144 10000143 10000144 10000144 10000143 10000144 10000143 10000144 10000143 10000143 10000144 10000144 10000144 10000143 10000143 10000144 10000143 10000144 10000144 10000144 10000143 10000144 10000144
min_time_thread_terminate_total=10000143
max_time_thread_terminate_total=10000144
first_time_thread_start_by_thread=4 3 4 4 4 4 3 3 3 4 4 3 4 4 4 4 4 4 4 4 4 4 4 3 4 3 4 4 4 4 3 3 3 4 4 3 4 4 4 4 4 4 4 4 4 4 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=9977934174
threads_final_size=99866
final_keysum=9977934174
final_size=99866
validate_result=success
Validation OK.
Structural validation OK.

total_find=976606292
total_rq=0
total_inserts=4934042
total_deletes=4927618
total_updates=9861660
total_queries=976606292
total_ops=986467952
find_throughput=97660629
rq_throughput=0
update_throughput=986166
query_throughput=97660629
total_throughput=98646795


total find                    : 976606292
total rq                      : 0
total inserts                 : 4934042
total deletes                 : 4927618
total updates                 : 9861660
total queries                 : 976606292
total ops                     : 986467952
find throughput               : 97660629
rq throughput                 : 0
update throughput             : 986166
query throughput              : 97660629
total throughput              : 98646795

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=3.90537
PAPI_L3_TCM=0.00104956
PAPI_TOT_CYC=1350.95
PAPI_TOT_INS=320.779
garbage=48865070205108
total_execution_walltime=11.417s
REALTIME_MAIN_END_PERF_FORMAT=6982189.457474957
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=80913, mem_maxresident_kb=325696, user_cputime=562.88, sys_cputime=2.74, percent_cpu=4899%
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