__step=000955
__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=data000955.txt
__path_data=data/data000955.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990448.267610908
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.028s
prefilling_size=100065 prefilling_elapsed_millis=1.001s
finished prefilling to size 99971 for expected size 100000 keysum=9998158751, performing 70539734 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=99971
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=6990449.573020086
REALTIME_END_PERF_FORMAT=6990459.573225069

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

tree_stats_computeWalltime=0.03s

tree_stats_numInternalsAtDepth=1 2 4 8 16 31 62 124 243 468 853 1467 2336 3353 4460 5556 6411 6909 6978 6508 5609 4412 3229 2207 1520 969 585 373 220 121 72 48 33 25 23 22 22 25 26 26 18 12 7 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 4 7 49 126 323 717 1240 1800 2523 3142 3601 3938 3890 3605 2948 2227 1498 1079 704 405 261 161 88 52 34 22 12 12 8 9 17 11 19 12 10 4 4
tree_stats_numNodesAtDepth=1 2 4 8 16 31 62 124 247 475 902 1593 2659 4070 5700 7356 8934 10051 10579 10446 9499 8017 6177 4434 3018 2048 1289 778 481 282 160 100 67 47 35 34 30 34 43 37 37 24 17 8 4
tree_stats_numKeysAtDepth=1 2 4 8 16 31 62 124 247 475 902 1593 2659 4070 5700 7356 8934 10051 10579 10446 9499 8017 6177 4434 3018 2048 1289 778 481 282 160 100 67 47 35 34 30 34 43 37 37 24 17 8 4
tree_stats_avgDegreeAtDepth=2 2 2 2 1.9375 2 2 1.99194 1.93927 1.91368 1.8204 1.74827 1.65212 1.57666 1.50807 1.45922 1.40743 1.36514 1.32782 1.28633 1.2535 1.22016 1.19508 1.1829 1.17495 1.15625 1.14973 1.13882 1.1289 1.1383 1.175 1.19 1.20896 1.21277 1.31429 1.23529 1.4 1.52941 1.25581 1.2973 1.16216 1.20833 1.05882 1 1

tree_stats_height=45
tree_stats_numInternals=65398
tree_stats_numLeaves=34562
tree_stats_numNodes=99960
tree_stats_numKeys=99960

tree_stats_avgDegreeInternal=1.52849
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34576
tree_stats_avgKeyDepth=18.3178

tree_stats_bytesAtDepth=192 384 768 1536 3072 5952 11904 23808 47424 91200 173184 305856 510528 781440 1094400 1412352 1715328 1929792 2031168 2005632 1823808 1539264 1185984 851328 579456 393216 247488 149376 92352 54144 30720 19200 12864 9024 6720 6528 5760 6528 8256 7104 7104 4608 3264 1536 768
tree_stats_sizeInBytes=19192320

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:0 64:469 128:854260 256:3607
    (2^06, 2^07]: 469
    (2^07, 2^08]: 854260
    (2^08, 2^09]: 3607
sum_limbo_reclamation_event_size_total=177099562
count_limbo_reclamation_event_size_by_thread=8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941 8941
count_limbo_reclamation_event_size_total=858336
sum_limbo_reclamation_event_count_total=858528
first_thread_announced_epoch_by_thread=19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664 19664
sum_num_inserts_by_thread=3674937 3665101 3721257 3720039 3707068 3655553 3662589 3677942 3723392 3728408 3703629 3678777 3688473 3708639 3721029 3712367 3700835 3699068 3672872 3688320 3703723 3719029 3658743 3665170 3664641 3675384 3704787 3708428 3695687 3668572 3690006 3697253 3698088 3732851 3706825 3682491 3691105 3709904 3724546 3719888 3680957 3706262 3678330 3686123 3669224 3689299 3676866 3641248 3681999 3717007 3711321 3722288 3702631 3638709 3690230 3650953 3657868 3738150 3642425 3709637 3712594 3654308 3735346 3651805 3697786 3707622 3688694 3721162 3655337 3673987 3703529 3645994 3609655 3718097 3646125 3728319 3710674 3643786 3628972 3660149 3738408 3756008 3720276 3723956 3727398 3670463 3748960 3733240 3635799 3706898 3620905 3719613 3735566 3678853 3642669 3652803
sum_num_inserts_total=354324699
sum_num_deletes_by_thread=3673138 3669674 3718645 3717624 3705675 3656170 3663436 3676633 3720701 3729539 3700415 3679703 3691674 3708853 3722425 3713881 3698567 3701215 3675266 3685872 3704629 3718291 3657702 3667068 3661137 3681334 3706428 3704178 3693807 3663933 3687278 3698407 3701065 3731958 3706328 3683250 3692377 3706464 3724613 3723028 3680438 3705948 3680549 3685481 3669098 3683141 3680831 3646112 3687465 3714710 3714256 3723213 3702998 3636238 3691683 3648665 3658815 3740128 3637457 3704990 3715256 3661573 3733458 3652316 3697892 3706194 3686002 3717719 3654833 3675603 3702920 3650673 3612474 3715840 3642702 3731247 3708651 3644289 3627868 3662595 3740717 3758977 3718633 3723018 3726327 3671492 3746638 3727490 3633460 3707808 3619907 3721271 3733480 3682607 3642214 3655023
sum_num_deletes_total=354323764
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7348075 7334775 7439902 7437663 7412743 7311723 7326025 7354575 7444093 7457947 7404044 7358480 7380147 7417492 7443454 7426248 7399402 7400283 7348138 7374192 7408352 7437320 7316445 7332238 7325778 7356718 7411215 7412606 7389494 7332505 7377284 7395660 7399153 7464809 7413153 7365741 7383482 7416368 7449159 7442916 7361395 7412210 7358879 7371604 7338322 7372440 7357697 7287360 7369464 7431717 7425577 7445501 7405629 7274947 7381913 7299618 7316683 7478278 7279882 7414627 7427850 7315881 7468804 7304121 7395678 7413816 7374696 7438881 7310170 7349590 7406449 7296667 7222129 7433937 7288827 7459566 7419325 7288075 7256840 7322744 7479125 7514985 7438909 7446974 7453725 7341955 7495598 7460730 7269259 7414706 7240812 7440884 7469046 7361460 7284883 7307826
average_num_operations_total=7381754
stdev_num_operations_total=6430
sum_num_operations_total=708648463
min_num_operations_total=7222129
max_num_operations_total=7514985
first_time_thread_terminate_by_thread=10000204 10000204 10000205 10000205 10000206 10000205 10000204 10000205 10000205 10000204 10000205 10000206 10000206 10000206 10000204 10000204 10000206 10000206 10000204 10000204 10000206 10000206 10000204 10000206 10000205 10000204 10000205 10000206 10000206 10000206 10000204 10000205 10000205 10000204 10000205 10000205 10000204 10000207 10000204 10000205 10000206 10000206 10000204 10000205 10000206 10000204 10000204 10000205 10000205 10000203 10000203 10000202 10000203 10000203 10000203 10000202 10000203 10000203 10000203 10000203 10000203 10000204 10000205 10000205 10000203 10000207 10000204 10000203 10000204 10000203 10000203 10000204 10000206 10000203 10000203 10000202 10000203 10000203 10000203 10000202 10000203 10000206 10000203 10000204 10000203 10000204 10000205 10000205 10000203 10000206 10000203 10000203 10000205 10000203 10000203 10000204
min_time_thread_terminate_total=10000202
max_time_thread_terminate_total=10000207
first_time_thread_start_by_thread=3 4 3 3 4 3 4 4 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 4 3 4 4 3 3 3 3 3 3 4 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 4 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10000274193
threads_final_size=99960
final_keysum=10000274193
final_size=99960
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=354324699
total_deletes=354323764
total_updates=708648463
total_queries=0
total_ops=708648463
find_throughput=0
rq_throughput=0
update_throughput=70864846
query_throughput=0
total_throughput=70864846


total find                    : 0
total rq                      : 0
total inserts                 : 354324699
total deletes                 : 354323764
total updates                 : 708648463
total queries                 : 0
total ops                     : 708648463
find throughput               : 0
rq throughput                 : 0
update throughput             : 70864846
query throughput              : 0
total throughput              : 70864846

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=13.5315
PAPI_L3_TCM=4.78503
PAPI_TOT_CYC=3777.28
PAPI_TOT_INS=528.74
garbage=0
total_execution_walltime=11.469s
REALTIME_MAIN_END_PERF_FORMAT=6990459.739239124
[time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=86222, mem_maxresident_kb=342556, user_cputime=1093.45, sys_cputime=5.33, percent_cpu=9481%
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