__step=000281
__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=data000281.txt
__path_data=data/data000281.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982166.435070292
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.004s
prefilling_size=99628 prefilling_elapsed_millis=1.001s
finished prefilling to size 99647 for expected size 100000 keysum=9956473328, performing 68705514 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99647
pref_millis=1102
prefill_elapsed_ms=1116
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=3183

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982167.722500833
REALTIME_END_PERF_FORMAT=6982177.722647223

###############################################################################
################################## 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 1125 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 63 120 219 371 619 979 1475 2254 3128 4184 5279 6270 6827 6916 6487 5578 4500 3429 2448 1624 1023 631 371 220 107 43 16 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 8 42 71 146 261 373 736 1081 1674 2330 3078 3569 3937 3901 3486 2957 2342 1713 1153 729 462 274 166 81 34 15 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 122 227 413 690 1125 1736 2627 3864 5265 6953 8600 9905 10485 10424 9479 7986 6386 4790 3337 2176 1360 833 494 273 124 50 17 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 122 227 413 690 1125 1736 2627 3864 5265 6953 8600 9905 10485 10424 9479 7986 6386 4790 3337 2176 1360 833 494 273 124 50 17 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.93651 1.87705 1.85463 1.7724 1.73333 1.67289 1.66359 1.61287 1.55305 1.52593 1.47764 1.42267 1.36931 1.33457 1.28703 1.25404 1.23616 1.21312 1.18559 1.16542 1.15487 1.14853 1.14766 1.10729 1.06227 1.05645 1.02 1 1

tree_stats_height=35
tree_stats_numInternals=65246
tree_stats_numLeaves=34623
tree_stats_numNodes=99869
tree_stats_numKeys=99869

tree_stats_avgDegreeInternal=1.53065
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34668
tree_stats_avgKeyDepth=19.2553

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12096 23424 43584 79296 132480 216000 333312 504384 741888 1010880 1334976 1651200 1901760 2013120 2001408 1819968 1533312 1226112 919680 640704 417792 261120 159936 94848 52416 23808 9600 3264 384
tree_stats_sizeInBytes=19174848

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175228 2:139170 4:14252 8:38
    [2^00, 2^01]: 175228
    (2^01, 2^02]: 139170
    (2^02, 2^03]: 14252
    (2^03, 2^04]: 38
sum_limbo_reclamation_event_size_total=553270
count_limbo_reclamation_event_size_by_thread=6815 6766 6852 6790 6834 6821 6810 6844 6871 6903 6917 6756 6879 6908 6961 6907 6884 6884 6834 6806 6856 6885 6885 6854 6742 6804 6797 6903 6759 6847 6793 6849 6869 6897 6861 6798 6888 6865 6814 6812 6855 6905 6815 6892 6846 6879 6835 6841
count_limbo_reclamation_event_size_total=328688
sum_limbo_reclamation_event_count_total=2141422
first_thread_announced_epoch_by_thread=95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592 95592
sum_num_inserts_by_thread=102158 101805 104095 102288 101900 101742 102075 103910 104584 103704 104291 101539 103145 102609 105017 103733 104351 103304 102478 101540 103626 104414 102630 103580 101717 103565 102373 103444 102918 103186 103224 102532 103872 102997 102400 102340 102351 103254 103915 103160 102913 102209 102160 103908 104176 103214 102527 101535
sum_num_inserts_total=4944408
sum_num_deletes_by_thread=102551 101555 103740 102127 101503 102599 102275 104202 104199 103419 103248 101312 103866 102639 104905 103697 104185 103411 102345 101510 102795 104485 102460 103404 101172 102998 102845 103297 102513 103461 102855 103169 103487 103477 102561 101947 102121 104126 104031 103086 102671 102295 102011 103958 104273 102768 101972 101951
sum_num_deletes_total=4941477
sum_num_searches_by_thread=20290228 20150505 20543621 20273805 20225972 20318951 20187958 20588937 20664256 20482654 20520711 20153859 20429654 20310004 20768081 20494609 20710006 20524438 20199940 20098455 20452573 20667716 20284033 20474005 20079772 20472402 20365091 20451211 20358341 20448389 20475114 20344637 20468297 20470083 20294352 20187204 20263697 20577659 20494307 20416045 20376294 20240154 20097799 20529574 20638005 20415871 20210167 20170621
sum_num_searches_total=978660057
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=20494937 20353865 20751456 20478220 20429375 20523292 20392308 20797049 20873039 20689777 20728250 20356710 20636665 20515252 20978003 20702039 20918542 20731153 20404763 20301505 20658994 20876615 20489123 20680989 20282661 20678965 20570309 20657952 20563772 20655036 20681193 20550338 20675656 20676557 20499313 20391491 20468169 20785039 20702253 20622291 20581878 20444658 20301970 20737440 20846454 20621853 20414666 20374107
average_num_operations_total=20594707
stdev_num_operations_total=25362
sum_num_operations_total=988545942
min_num_operations_total=20282661
max_num_operations_total=20978003
first_time_thread_terminate_by_thread=10000144 10000145 10000144 10000144 10000145 10000145 10000144 10000144 10000144 10000144 10000144 10000145 10000145 10000144 10000145 10000145 10000145 10000145 10000145 10000145 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000144 10000145 10000145 10000144 10000144 10000144 10000144 10000144 10000145 10000145 10000144 10000145 10000145 10000145 10000145 10000145 10000145 10000144 10000144 10000144 10000144
min_time_thread_terminate_total=10000144
max_time_thread_terminate_total=10000145
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 2 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=9950629718
threads_final_size=99869
final_keysum=9950629718
final_size=99869
validate_result=success
Validation OK.
Structural validation OK.

total_find=978660057
total_rq=0
total_inserts=4944408
total_deletes=4941477
total_updates=9885885
total_queries=978660057
total_ops=988545942
find_throughput=97866005
rq_throughput=0
update_throughput=988588
query_throughput=97866005
total_throughput=98854594


total find                    : 978660057
total rq                      : 0
total inserts                 : 4944408
total deletes                 : 4941477
total updates                 : 9885885
total queries                 : 978660057
total ops                     : 988545942
find throughput               : 97866005
rq throughput                 : 0
update throughput             : 988588
query throughput              : 97866005
total throughput              : 98854594

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=3.90704
PAPI_L3_TCM=0.00109878
PAPI_TOT_CYC=1347.02
PAPI_TOT_INS=323.51
garbage=48920583521733
total_execution_walltime=11.418s
REALTIME_MAIN_END_PERF_FORMAT=6982177.854419299
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=80790, mem_maxresident_kb=325040, user_cputime=559.60, sys_cputime=2.18, percent_cpu=4866%
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