__step=000842
__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 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000842.txt
__path_data=data/data000842.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989124.387336391
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=50
DEL_FRAC=50
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=50.0 50.0
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.014s
prefilling_size=999579 prefilling_elapsed_millis=1.001s
finished prefilling to size 999598 for expected size 1000000 keysum=999156800699, performing 35629323 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999598
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=1637
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6989125.693999414
REALTIME_END_PERF_FORMAT=6989135.694154855
###############################################################################
################################## 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 915 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.032s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 243 466 879 1592 2753 4525 7176 10914 15679 21505 28461 35626 42790 49621 55115 58109 57856 54651 49194 41740 33880 26082 19317 13618 9172 5770 3407 1918 934 464 213 104 49 22 12 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 6 17 36 104 253 533 1002 1912 3354 5364 7850 11390 15294 19118 23462 27641 30914 32179 31672 29677 26040 21723 17025 12983 9339 6430 4201 2532 1504 709 363 157 75 34 15 11 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 249 483 915 1696 3006 5058 8178 12826 19033 26869 36311 47016 58084 68739 78577 85750 88770 86830 80866 71417 59920 47805 36342 26601 18511 12200 7608 4450 2438 1173 576 261 124 56 27 14 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 249 483 915 1696 3006 5058 8178 12826 19033 26869 36311 47016 58084 68739 78577 85750 88770 86830 80866 71417 59920 47805 36342 26601 18511 12200 7608 4450 2438 1173 576 261 124 56 27 14 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.96063 1.96386 1.92961 1.8929 1.83373 1.7668 1.72222 1.69088 1.63301 1.58793 1.55104 1.511 1.47767 1.44675 1.42125 1.38987 1.35756 1.32639 1.30191 1.27481 1.25456 1.23239 1.21462 1.20043 1.18394 1.16358 1.15066 1.13709 1.11685 1.09803 1.09548 1.08333 1.07663 1.05645 1.08929 1.07407 1.07143 1
tree_stats_height=45
tree_stats_numInternals=654114
tree_stats_numLeaves=344923
tree_stats_numNodes=999037
tree_stats_numKeys=999037
tree_stats_avgDegreeInternal=1.52731
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34526
tree_stats_avgKeyDepth=23.9746
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 47808 92736 175680 325632 577152 971136 1570176 2462592 3654336 5158848 6971712 9027072 11152128 13197888 15086784 16464000 17043840 16671360 15526272 13712064 11504640 9178560 6977664 5107392 3554112 2342400 1460736 854400 468096 225216 110592 50112 23808 10752 5184 2688 768
tree_stats_sizeInBytes=191815104
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=17715
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:1 32:55 64:448751 128:31097
(2^04, 2^05]: 1
(2^05, 2^06]: 55
(2^06, 2^07]: 448751
(2^07, 2^08]: 31097
sum_limbo_reclamation_event_size_total=54336802
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479904
sum_limbo_reclamation_event_count_total=771744
first_thread_announced_epoch_by_thread=35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430 35430
sum_num_inserts_by_thread=3608306 3632870 3656233 3641325 3643743 3604067 3621433 3640916 3675381 3681205 3636225 3617872 3628343 3646928 3667905 3668545 3656679 3634979 3613106 3629527 3657459 3671449 3633811 3607010 3608515 3631909 3659867 3658472 3649221 3611562 3624548 3641957 3680603 3680108 3640627 3623398 3630569 3642475 3673395 3673730 3651769 3636934 3610465 3626678 3656002 3671771 3635069 3609042
sum_num_inserts_total=174804003
sum_num_deletes_by_thread=3608306 3627738 3659240 3643620 3646591 3603063 3624597 3641117 3675124 3681788 3637777 3621879 3630386 3644470 3667089 3666058 3651894 3634561 3615315 3631241 3659296 3671643 3636373 3606307 3607786 3633676 3658763 3661079 3648010 3604784 3621787 3644210 3678214 3681451 3643306 3618115 3630035 3643211 3674460 3673218 3658236 3635476 3609146 3628619 3653018 3668521 3633737 3606466
sum_num_deletes_total=174800797
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7216612 7260608 7315473 7284945 7290334 7207130 7246030 7282033 7350505 7362993 7274002 7239751 7258729 7291398 7334994 7334603 7308573 7269540 7228421 7260768 7316755 7343092 7270184 7213317 7216301 7265585 7318630 7319551 7297231 7216346 7246335 7286167 7358817 7361559 7283933 7241513 7260604 7285686 7347855 7346948 7310005 7272410 7219611 7255297 7309020 7340292 7268806 7215508
average_num_operations_total=7283433
stdev_num_operations_total=6602
sum_num_operations_total=349604800
min_num_operations_total=7207130
max_num_operations_total=7362993
first_time_thread_terminate_by_thread=10000155 10000154 10000154 10000154 10000154 10000154 10000155 10000154 10000154 10000154 10000155 10000155 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000155 10000155 10000154 10000154 10000154 10000154 10000155 10000154 10000154 10000155 10000155 10000154 10000154 10000154 10000155 10000154 10000154 10000154 10000154 10000154 10000154 10000155 10000154 10000154 10000155 10000155 10000154
min_time_thread_terminate_total=10000154
max_time_thread_terminate_total=10000155
first_time_thread_start_by_thread=8 7 7 7 7 7 7 7 7 8 7 8 7 7 7 7 7 7 7 7 7 7 7 8 8 7 7 7 7 7 7 7 7 8 7 8 7 7 7 7 7 7 7 7 7 7 7 8
min_time_thread_start_total=7
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=999067755463
threads_final_size=999037
final_keysum=999067755463
final_size=999037
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=174804003
total_deletes=174800797
total_updates=349604800
total_queries=0
total_ops=349604800
find_throughput=0
rq_throughput=0
update_throughput=34960480
query_throughput=0
total_throughput=34960480
total find : 0
total rq : 0
total inserts : 174804003
total deletes : 174800797
total updates : 349604800
total queries : 0
total ops : 349604800
find throughput : 0
rq throughput : 0
update throughput : 34960480
query throughput : 0
total throughput : 34960480
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=17.5833
PAPI_L3_TCM=4.50249
PAPI_TOT_CYC=3827.18
PAPI_TOT_INS=534.237
garbage=0
total_execution_walltime=11.451s
REALTIME_MAIN_END_PERF_FORMAT=6989135.839190232
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=125843, mem_maxresident_kb=504940, user_cputime=561.13, sys_cputime=3.06, percent_cpu=4867%
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