__step=000746
__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" ./sigouin_int_bst_kcas_validate.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000746.txt
__path_data=data/data000746.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564c95bf4400
addrof(kcasDescriptors[1])=0x564c95bf4d00
addrof(rdcssDescriptors[0])=0x564c95d14400
addrof(rdcssDescriptors[1])=0x564c95d144c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6987928.968514128
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_bst_kcas_validate
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=20000000
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=56
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.009s
prefilling_size=6992928 prefilling_elapsed_millis=1.001s
prefilling_size=7283668 prefilling_elapsed_millis=1.101s
prefilling_size=7546531 prefilling_elapsed_millis=1.201s
prefilling_size=7782761 prefilling_elapsed_millis=1.301s
prefilling_size=7994072 prefilling_elapsed_millis=1.402s
prefilling_size=8183444 prefilling_elapsed_millis=1.502s
prefilling_size=8355894 prefilling_elapsed_millis=1.602s
prefilling_size=8511075 prefilling_elapsed_millis=1.702s
prefilling_size=8651069 prefilling_elapsed_millis=1.802s
prefilling_size=8777661 prefilling_elapsed_millis=1.902s
prefilling_size=8892713 prefilling_elapsed_millis=2.003s
prefilling_size=8997144 prefilling_elapsed_millis=2.103s
prefilling_size=9092473 prefilling_elapsed_millis=2.203s
prefilling_size=9175455 prefilling_elapsed_millis=2.303s
prefilling_size=9251854 prefilling_elapsed_millis=2.403s
prefilling_size=9322007 prefilling_elapsed_millis=2.504s
prefilling_size=9387537 prefilling_elapsed_millis=2.604s
prefilling_size=9444059 prefilling_elapsed_millis=2.704s
prefilling_size=9494547 prefilling_elapsed_millis=2.804s
prefilling_size=9541557 prefilling_elapsed_millis=2.904s
prefilling_size=9582695 prefilling_elapsed_millis=3.005s
prefilling_size=9621063 prefilling_elapsed_millis=3.105s
prefilling_size=9657310 prefilling_elapsed_millis=3.205s
prefilling_size=9689305 prefilling_elapsed_millis=3.305s
prefilling_size=9716706 prefilling_elapsed_millis=3.405s
prefilling_size=9741937 prefilling_elapsed_millis=3.506s
prefilling_size=9764694 prefilling_elapsed_millis=3.606s
prefilling_size=9786830 prefilling_elapsed_millis=3.706s
prefilling_size=9806934 prefilling_elapsed_millis=3.806s
finished prefilling to size 9806945 for expected size 10000000 keysum=98086190625035, performing 80188524 updates; total_prefilling_elapsed_ms=3907 ms)
pref_size=9806945
pref_millis=3907
prefill_elapsed_ms=3930
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987933.97673251
REALTIME_END_PERF_FORMAT=6987943.97816008

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

tree_stats_computeWalltime=0.099s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 506 991 1927 3657 6756 12111 20886 34649 55326 84378 122840 171274 227347 288663 351787 410750 462362 499201 519195 518438 497556 458679 406420 347210 284172 224238 169924 123983 87026 58798 38103 23536 14002 8012 4421 2386 1241 615 277 122 43 27 12 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 2 12 32 105 320 748 1860 3879 7630 14331 24942 40498 62202 88873 120640 156720 190928 226124 254044 275133 284794 282889 268712 244140 214926 179755 145124 112190 83699 60134 41127 27275 16972 10220 6000 3282 1800 943 493 223 104 29 20 9 4 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1003 1959 3762 7076 12859 22746 38528 62956 98709 147782 211772 289549 377536 472427 567470 653290 725325 773239 793571 782350 741568 675132 591350 499098 403993 315048 236173 170725 118932 79230 50811 30974 18232 10421 5668 3041 1558 770 345 147 56 32 13 5 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 508 1003 1959 3762 7076 12859 22746 38528 62956 98709 147782 211772 289549 377536 472427 567470 653290 725325 773239 793571 782350 741568 675132 591350 499098 403993 315048 236173 170725 118932 79230 50811 30974 18232 10421 5668 3041 1558 770 345 147 56 32 13 5 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98828 1.97835 1.9651 1.9367 1.90883 1.86249 1.82705 1.77561 1.73471 1.6891 1.64233 1.60178 1.5585 1.5187 1.48675 1.45654 1.42741 1.40252 1.37781 1.35484 1.33256 1.3119 1.29189 1.27392 1.25685 1.24008 1.22478 1.21028 1.19791 1.18689 1.1718 1.16039 1.14639 1.13657 1.13213 1.11966 1.11556 1.10424 1.09949 1.08831 1.07246 1.08844 1.08929 1.03125 1.07692 1 1

tree_stats_height=55
tree_stats_numInternals=6544362
tree_stats_numLeaves=3453889
tree_stats_numNodes=9998251
tree_stats_numKeys=9998251

tree_stats_avgDegreeInternal=1.52777
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34545
tree_stats_avgKeyDepth=28.1902


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:41 64:408733 128:28506
    (2^05, 2^06]: 41
    (2^06, 2^07]: 408733
    (2^07, 2^08]: 28506
sum_limbo_reclamation_event_size_total=49548586
count_limbo_reclamation_event_size_by_thread=9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110 9110
count_limbo_reclamation_event_size_total=437280
sum_limbo_reclamation_event_count_total=437376
first_thread_announced_epoch_by_thread=25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538 25538
sum_num_inserts_by_thread=2058546 2066520 2080242 2072066 2068125 2049912 2058076 2069862 2087912 2085786 2065872 2058955 2060199 2073595 2085188 2085261 2076563 2064023 2054064 2064182 2074792 2081633 2059557 2050717 2054890 2065584 2081328 2075876 2067692 2054820 2063815 2068944 2086021 2086756 2065976 2058732 2065188 2073368 2082490 2085604 2072407 2060460 2051526 2062722 2073517 2082958 2061625 2049855
sum_num_inserts_total=99303802
sum_num_deletes_by_thread=2054539 2063949 2082790 2074680 2068428 2053362 2059971 2069667 2086387 2086835 2066601 2057207 2062667 2072765 2084044 2084178 2075627 2061690 2052492 2064269 2075416 2080983 2060257 2049826 2056096 2066764 2080382 2073749 2068604 2051663 2060841 2069962 2085841 2087503 2064905 2057108 2064123 2073962 2082762 2085971 2072819 2062134 2052116 2062196 2070276 2082997 2061582 2050541
sum_num_deletes_total=99293527
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4113085 4130469 4163032 4146746 4136553 4103274 4118047 4139529 4174299 4172621 4132473 4116162 4122866 4146360 4169232 4169439 4152190 4125713 4106556 4128451 4150208 4162616 4119814 4100543 4110986 4132348 4161710 4149625 4136296 4106483 4124656 4138906 4171862 4174259 4130881 4115840 4129311 4147330 4165252 4171575 4145226 4122594 4103642 4124918 4143793 4165955 4123207 4100396
average_num_operations_total=4137444
stdev_num_operations_total=3292
sum_num_operations_total=198597329
min_num_operations_total=4100396
max_num_operations_total=4174299
first_time_thread_terminate_by_thread=10000142 10000142 10000143 10000144 10000142 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000142 10000142 10000142 10000142 10000142 10000142 10000144 10000142 10000142 10000143 10000142 10000143 10000143 10000142 10000143 10000142 10000143 10000142 10000143 10000144 10000142 10000142 10000143 10000142 10000142 10000143 10000142 10000142 10000142 10000142 10000143 10000143 10000142 10000142 10000142 10000142
min_time_thread_terminate_total=10000142
max_time_thread_terminate_total=10000144
first_time_thread_start_by_thread=2 2 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 2 3 3 3 3 3 3 2 3 3 3 3 3 3 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=99978915624364
threads_final_size=9998251
final_keysum=99978915624364
final_size=9998251
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=99303802
total_deletes=99293527
total_updates=198597329
total_queries=0
total_ops=198597329
find_throughput=0
rq_throughput=0
update_throughput=19859732
query_throughput=0
total_throughput=19859732


total find                    : 0
total rq                      : 0
total inserts                 : 99303802
total deletes                 : 99293527
total updates                 : 198597329
total queries                 : 0
total ops                     : 198597329
find throughput               : 0
rq throughput                 : 0
update throughput             : 19859732
query throughput              : 0
total throughput              : 19859732

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=28.0066
PAPI_L3_TCM=9.20977
PAPI_TOT_CYC=6738.36
PAPI_TOT_INS=2181.13
garbage=0
total_execution_walltime=14.34s
REALTIME_MAIN_END_PERF_FORMAT=6987943.309913071
[time_cmd_output] time_elapsed_sec=14.52, faults_major=0, faults_minor=239005, mem_maxresident_kb=957876, user_cputime=700.88, sys_cputime=3.24, percent_cpu=4848%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2