__step=000956
__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 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000956.txt
__path_data=data/data000956.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990459.913735397
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=200000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,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.019s
prefilling_size=99711 prefilling_elapsed_millis=1.001s
finished prefilling to size 99751 for expected size 100000 keysum=9976851085, performing 70814981 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=99751
pref_millis=1103
prefill_elapsed_ms=1125
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=889
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6990461.232295674
REALTIME_END_PERF_FORMAT=6990471.232431735
###############################################################################
################################## 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 812 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.033s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 59 113 218 418 769 1342 2199 3333 4676 6133 7203 7791 7583 6684 5444 4006 2787 1787 1138 697 395 236 136 78 46 34 22 17 16 15 8 9 10 9 13 15 22 19 16 10 10 6 4 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 2 2 6 9 43 116 265 597 1081 1720 2713 3555 4229 4491 4163 3576 2738 1955 1293 842 524 287 170 96 58 27 25 12 12 8 13 4 5 4 3 7 3 12 11 10 5 7 5 1 4 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 61 115 224 427 812 1458 2464 3930 5757 7853 9916 11346 11812 11175 9607 7582 5525 3742 2431 1539 919 523 306 174 104 61 47 29 28 23 21 13 15 13 16 22 25 31 27 20 15 13 9 5 6 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 61 115 224 427 812 1458 2464 3930 5757 7853 9916 11346 11812 11175 9607 7582 5525 3742 2431 1539 919 523 306 174 104 61 47 29 28 23 21 13 15 13 16 22 25 31 27 20 15 13 9 5 6 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.90625 1.91803 1.96522 1.93304 1.92272 1.84852 1.76955 1.70252 1.61679 1.55185 1.48173 1.41781 1.3544 1.3041 1.26157 1.22255 1.20034 1.17285 1.1721 1.16495 1.14425 1.13928 1.13384 1.12418 1.14943 1.14423 1.21311 1.14894 1.37931 1.25 1.26087 1.2381 1.46154 1.2 1.53846 1.5625 1.45455 1.36 1.25806 1.14815 1.25 1.2 1.23077 1.11111 1.4 1 1
tree_stats_height=52
tree_stats_numInternals=65595
tree_stats_numLeaves=34711
tree_stats_numNodes=100306
tree_stats_numKeys=100306
tree_stats_avgDegreeInternal=1.52917
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34605
tree_stats_avgKeyDepth=18.0858
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 11712 22080 43008 81984 155904 279936 473088 754560 1105344 1507776 1903872 2178432 2267904 2145600 1844544 1455744 1060800 718464 466752 295488 176448 100416 58752 33408 19968 11712 9024 5568 5376 4416 4032 2496 2880 2496 3072 4224 4800 5952 5184 3840 2880 2496 1728 960 1152 384
tree_stats_sizeInBytes=19258752
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=9802
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:14 2:0 4:2 8:0 16:1 32:1 64:750 128:850891 256:3760
[2^00, 2^01]: 14
(2^01, 2^02]: 0
(2^02, 2^03]: 2
(2^03, 2^04]: 0
(2^04, 2^05]: 1
(2^05, 2^06]: 1
(2^06, 2^07]: 750
(2^07, 2^08]: 850891
(2^08, 2^09]: 3760
sum_limbo_reclamation_event_size_total=176967679
count_limbo_reclamation_event_size_by_thread=8911 8911 8910 8911 8911 8910 8911 8911 8911 8910 8911 8906 8911 8911 8910 8910 8911 8910 8911 8910 8910 8911 8910 8911 8911 8911 8910 8911 8911 8910 8911 8911 8911 8911 8911 8911 8911 8911 8910 8910 8911 8910 8910 8911 8911 8911 8910 8911 8911 8911 8911 8910 8911 8910 8911 8911 8911 8911 8911 8911 8910 8911 8911 8910 8911 8911 8911 8911 8910 8911 8910 8910 8910 8911 8910 8911 8910 8911 8911 8910 8910 8911 8911 8911 8911 8911 8911 8910 8910 8910 8911 8910 8911 8911 8911 8911
count_limbo_reclamation_event_size_total=855419
sum_limbo_reclamation_event_count_total=855644
first_thread_announced_epoch_by_thread=19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604 19604
sum_num_inserts_by_thread=3754617 3659312 3665399 3664048 3660261 3633684 3772524 3780784 3680155 3673418 3658625 3629563 3772616 3657566 3658534 3658913 3654661 3636053 3620672 3646336 3668842 3794315 3639083 3701410 3745540 3718136 3655029 3650683 3726305 3627048 3764878 3783782 3757818 3672007 3735517 3632447 3771622 3737343 3671314 3673331 3743247 3644809 3632121 3718124 3734431 3795121 3635747 3629107 3704325 3764794 3739108 3643995 3708097 3607727 3617048 3628643 3753138 3792433 3779493 3759549 3612775 3733783 3743632 3638570 3625042 3710626 3605394 3720149 3662983 3797805 3637449 3614116 3605172 3767003 3637987 3732108 3614416 3613658 3618751 3631506 3664061 3807096 3785971 3774301 3630270 3643806 3654221 3648683 3628988 3620064 3608955 3634660 3756603 3797689 3735368 3628174
sum_num_inserts_total=354037083
sum_num_deletes_by_thread=3754302 3660865 3667900 3664061 3658175 3631216 3772521 3778712 3682244 3675440 3656596 3629368 3768216 3657881 3659505 3659840 3657717 3634547 3621847 3646387 3666661 3795938 3639327 3700159 3743456 3716561 3652340 3650775 3722837 3628677 3768833 3787432 3763258 3675527 3731730 3634051 3775331 3737907 3667585 3674420 3741690 3641115 3631380 3718813 3730452 3798334 3632374 3632543 3704287 3764879 3736830 3642935 3710406 3611705 3617608 3628086 3750385 3797498 3777841 3763210 3609487 3729219 3743341 3643237 3624719 3712469 3607274 3721280 3664204 3797983 3639475 3616923 3610138 3762196 3638698 3737378 3618685 3612264 3619794 3629491 3659386 3808431 3783034 3768440 3629398 3646605 3657661 3648819 3628068 3622303 3611756 3632899 3760340 3802962 3734357 3621217
sum_num_deletes_total=354056447
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7508919 7320177 7333299 7328109 7318436 7264900 7545045 7559496 7362399 7348858 7315221 7258931 7540832 7315447 7318039 7318753 7312378 7270600 7242519 7292723 7335503 7590253 7278410 7401569 7488996 7434697 7307369 7301458 7449142 7255725 7533711 7571214 7521076 7347534 7467247 7266498 7546953 7475250 7338899 7347751 7484937 7285924 7263501 7436937 7464883 7593455 7268121 7261650 7408612 7529673 7475938 7286930 7418503 7219432 7234656 7256729 7503523 7589931 7557334 7522759 7222262 7463002 7486973 7281807 7249761 7423095 7212668 7441429 7327187 7595788 7276924 7231039 7215310 7529199 7276685 7469486 7233101 7225922 7238545 7260997 7323447 7615527 7569005 7542741 7259668 7290411 7311882 7297502 7257056 7242367 7220711 7267559 7516943 7600651 7469725 7249391
average_num_operations_total=7375974
stdev_num_operations_total=12588
sum_num_operations_total=708093530
min_num_operations_total=7212668
max_num_operations_total=7615527
first_time_thread_terminate_by_thread=10000137 10000135 10000135 10000136 10000135 10000136 10000137 10000137 10000137 10000136 10000135 10000136 10000135 10000137 10000136 10000137 10000136 10000137 10000134 10000134 10000134 10000135 10000136 10000137 10000136 10000136 10000135 10000136 10000135 10000136 10000137 10000137 10000137 10000135 10000136 10000136 10000135 10000137 10000136 10000137 10000137 10000137 10000134 10000134 10000134 10000135 10000135 10000137 10000135 10000134 10000134 10000134 10000136 10000134 10000136 10000135 10000135 10000134 10000135 10000136 10000136 10000135 10000134 10000135 10000134 10000136 10000135 10000134 10000135 10000135 10000134 10000135 10000134 10000134 10000134 10000134 10000136 10000134 10000136 10000135 10000143 10000136 10000135 10000136 10000134 10000135 10000135 10000135 10000134 10000136 10000135 10000134 10000135 10000136 10000134 10000135
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000143
first_time_thread_start_by_thread=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 3 3 3 3 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 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 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=10026442622
threads_final_size=100306
final_keysum=10026442622
final_size=100306
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=354037083
total_deletes=354056447
total_updates=708093530
total_queries=0
total_ops=708093530
find_throughput=0
rq_throughput=0
update_throughput=70809353
query_throughput=0
total_throughput=70809353
total find : 0
total rq : 0
total inserts : 354037083
total deletes : 354056447
total updates : 708093530
total queries : 0
total ops : 708093530
find throughput : 0
rq throughput : 0
update throughput : 70809353
query throughput : 0
total throughput : 70809353
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=13.5206
PAPI_L3_TCM=4.83854
PAPI_TOT_CYC=3779.95
PAPI_TOT_INS=527.373
garbage=0
total_execution_walltime=11.479s
REALTIME_MAIN_END_PERF_FORMAT=6990471.394004346
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=86395, mem_maxresident_kb=343116, user_cputime=1092.22, sys_cputime=3.60, percent_cpu=9448%
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