__step=000745
__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=data000745.txt
__path_data=data/data000745.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5566057ed400
addrof(kcasDescriptors[1])=0x5566057edd00
addrof(rdcssDescriptors[0])=0x55660590d400
addrof(rdcssDescriptors[1])=0x55660590d4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6987913.649339747
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.004s
prefilling_size=6844017 prefilling_elapsed_millis=1.001s
prefilling_size=7127821 prefilling_elapsed_millis=1.101s
prefilling_size=7379797 prefilling_elapsed_millis=1.201s
prefilling_size=7609138 prefilling_elapsed_millis=1.301s
prefilling_size=7812785 prefilling_elapsed_millis=1.402s
prefilling_size=7999511 prefilling_elapsed_millis=1.502s
prefilling_size=8166368 prefilling_elapsed_millis=1.602s
prefilling_size=8319150 prefilling_elapsed_millis=1.702s
prefilling_size=8458088 prefilling_elapsed_millis=1.802s
prefilling_size=8584360 prefilling_elapsed_millis=1.902s
prefilling_size=8697357 prefilling_elapsed_millis=2.003s
prefilling_size=8802373 prefilling_elapsed_millis=2.103s
prefilling_size=8897641 prefilling_elapsed_millis=2.203s
prefilling_size=8980805 prefilling_elapsed_millis=2.303s
prefilling_size=9061172 prefilling_elapsed_millis=2.404s
prefilling_size=9135671 prefilling_elapsed_millis=2.504s
prefilling_size=9202359 prefilling_elapsed_millis=2.604s
prefilling_size=9264053 prefilling_elapsed_millis=2.704s
prefilling_size=9320114 prefilling_elapsed_millis=2.804s
prefilling_size=9372774 prefilling_elapsed_millis=2.904s
prefilling_size=9420242 prefilling_elapsed_millis=3.005s
prefilling_size=9463014 prefilling_elapsed_millis=3.105s
prefilling_size=9502990 prefilling_elapsed_millis=3.205s
prefilling_size=9540700 prefilling_elapsed_millis=3.305s
prefilling_size=9572804 prefilling_elapsed_millis=3.405s
prefilling_size=9605585 prefilling_elapsed_millis=3.506s
prefilling_size=9633630 prefilling_elapsed_millis=3.606s
prefilling_size=9662425 prefilling_elapsed_millis=3.706s
prefilling_size=9687205 prefilling_elapsed_millis=3.806s
prefilling_size=9707889 prefilling_elapsed_millis=3.906s
prefilling_size=9729102 prefilling_elapsed_millis=4.007s
prefilling_size=9750188 prefilling_elapsed_millis=4.107s
prefilling_size=9769331 prefilling_elapsed_millis=4.207s
prefilling_size=9785671 prefilling_elapsed_millis=4.307s
prefilling_size=9801194 prefilling_elapsed_millis=4.408s
finished prefilling to size 9801191 for expected size 10000000 keysum=98012091199585, performing 92656057 updates; total_prefilling_elapsed_ms=4508 ms)
pref_size=9801191
pref_millis=4508
prefill_elapsed_ms=4529
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987918.338459684
REALTIME_END_PERF_FORMAT=6987928.338607595

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 1014 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.194s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 509 1009 1971 3762 7005 12547 21575 35726 56796 86519 126193 176005 233944 296849 359669 416775 461418 489247 497413 489135 464054 425887 380462 328965 276119 225733 179617 139078 104325 75949 53817 37278 24681 15839 9969 5970 3379 1862 932 458 202 106 36 11 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 1 5 23 106 285 818 1945 4111 8063 14973 25699 41780 64165 92610 126274 162566 199220 232074 256573 269093 272711 266476 249398 228397 201519 172165 142951 115977 91348 69630 51400 36782 25898 17461 11214 7274 4427 2524 1454 726 368 152 93 29 9 2 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1014 1994 3868 7290 13365 23520 39837 64859 101492 151892 217785 298109 389459 485943 579341 660638 721321 753986 758228 736765 692363 629860 557362 477638 397898 322568 255055 195673 145579 105217 74060 50579 33300 21183 13244 7806 4386 2386 1184 570 258 129 40 13 4 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 510 1014 1994 3868 7290 13365 23520 39837 64859 101492 151892 217785 298109 389459 485943 579341 660638 721321 753986 758228 736765 692363 629860 557362 477638 397898 322568 255055 195673 145579 105217 74060 50579 33300 21183 13244 7806 4386 2386 1184 570 258 129 40 13 4 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.9902 1.9714 1.95135 1.9121 1.87243 1.82103 1.77645 1.73131 1.68913 1.64412 1.60301 1.56066 1.52167 1.48553 1.45205 1.42093 1.39341 1.36702 1.34591 1.32659 1.30988 1.2946 1.28086 1.26674 1.25496 1.24337 1.23387 1.22189 1.21083 1.20105 1.19239 1.1796 1.17041 1.16048 1.15461 1.13863 1.129 1.11947 1.10562 1.09459 1.09825 1.08915 1.03101 1.05 1 1 1

tree_stats_height=56
tree_stats_numInternals=6529313
tree_stats_numLeaves=3470771
tree_stats_numNodes=10000084
tree_stats_numKeys=10000084

tree_stats_avgDegreeInternal=1.53157
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34707
tree_stats_avgKeyDepth=28.3132


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:12 2:3 4:5 8:9 16:22 32:61 64:405442 128:28865 256:47 512:75 1024:19
    [2^00, 2^01]: 12
    (2^01, 2^02]: 3
    (2^02, 2^03]: 5
    (2^03, 2^04]: 9
    (2^04, 2^05]: 22
    (2^05, 2^06]: 61
    (2^06, 2^07]: 405442
    (2^07, 2^08]: 28865
    (2^08, 2^09]: 47
    (2^09, 2^10]: 75
    (2^10, 2^11]: 19
sum_limbo_reclamation_event_size_total=49314240
count_limbo_reclamation_event_size_by_thread=9053 9054 9054 9053 9053 9054 9053 9053 9054 9053 9053 9054 9054 9054 9053 9053 9054 9052 9053 9054 9054 9053 9053 9053 9053 9053 9054 9054 9053 9054 9053 9054 9053 9053 9053 9053 9053 9053 9054 9053 9054 9053 9053 9053 9054 9053 9053 9053
count_limbo_reclamation_event_size_total=434560
sum_limbo_reclamation_event_count_total=434687
first_thread_announced_epoch_by_thread=26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26544 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546 26546
sum_num_inserts_by_thread=2044405 2054016 2065977 2072170 2058318 2047304 2047747 2055226 2070174 2079578 2056575 2046768 2055097 2059211 2079293 2071294 2064397 2051173 2044011 2053338 2068940 2073393 2048409 2037307 2045440 2052988 2073583 2069756 2060694 2046687 2049826 2061561 2075873 2080008 2054986 2044957 2050193 2062725 2079753 2073281 2065623 2056422 2045315 2051173 2064112 2071974 2052326 2038202
sum_num_inserts_total=98831579
sum_num_deletes_by_thread=2043378 2053404 2065244 2075918 2055486 2046025 2047428 2055681 2073370 2081234 2057062 2048004 2055545 2061357 2080657 2068791 2062646 2051147 2044026 2054310 2066204 2070505 2052671 2037464 2044508 2056402 2073087 2072896 2061709 2044353 2048400 2059986 2075645 2079703 2056722 2046801 2055096 2062707 2076823 2072858 2066651 2056732 2044522 2052120 2064824 2071694 2053042 2041448
sum_num_deletes_total=98846286
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4087783 4107420 4131221 4148088 4113804 4093329 4095175 4110907 4143544 4160812 4113637 4094772 4110642 4120568 4159950 4140085 4127043 4102320 4088037 4107648 4135144 4143898 4101080 4074771 4089948 4109390 4146670 4142652 4122403 4091040 4098226 4121547 4151518 4159711 4111708 4091758 4105289 4125432 4156576 4146139 4132274 4113154 4089837 4103293 4128936 4143668 4105368 4079650
average_num_operations_total=4118288
stdev_num_operations_total=3448
sum_num_operations_total=197677865
min_num_operations_total=4074771
max_num_operations_total=4160812
first_time_thread_terminate_by_thread=10000148 10000148 10000164 10000148 10000162 10000148 10000165 10000174 10000160 10000153 10000171 10000178 10000168 10000148 10000149 10000175 10000163 10000149 10000155 10000168 10000148 10000153 10000167 10000172 10000165 10000149 10000149 10000148 10000148 10000148 10000166 10000169 10000156 10000163 10000171 10000168 10000167 10000154 10000170 10000148 10000165 10000165 10000154 10000154 10000161 10000155 10000167 10000160
min_time_thread_terminate_total=10000148
max_time_thread_terminate_total=10000178
first_time_thread_start_by_thread=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 4 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=99992213303989
threads_final_size=10000084
final_keysum=99992213303989
final_size=10000084
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=98831579
total_deletes=98846286
total_updates=197677865
total_queries=0
total_ops=197677865
find_throughput=0
rq_throughput=0
update_throughput=19767786
query_throughput=0
total_throughput=19767786


total find                    : 0
total rq                      : 0
total inserts                 : 98831579
total deletes                 : 98846286
total updates                 : 197677865
total queries                 : 0
total ops                     : 197677865
find throughput               : 0
rq throughput                 : 0
update throughput             : 19767786
query throughput              : 0
total throughput              : 19767786

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=28.0859
PAPI_L3_TCM=9.19814
PAPI_TOT_CYC=6767.46
PAPI_TOT_INS=2180.97
garbage=0
total_execution_walltime=15.072s
REALTIME_MAIN_END_PERF_FORMAT=6987928.723381638
[time_cmd_output] time_elapsed_sec=15.24, faults_major=0, faults_minor=244567, mem_maxresident_kb=980320, user_cputime=721.91, sys_cputime=3.66, percent_cpu=4761%
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=1