__step=000522
__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 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000522.txt
__path_data=data/data000522.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564542469400
addrof(kcasDescriptors[1])=0x564542469d00
addrof(rdcssDescriptors[0])=0x564542589400
addrof(rdcssDescriptors[1])=0x5645425894c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6985180.768133068
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=5
DEL_FRAC=5
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=5.0 5.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.006s
prefilling_size=999181 prefilling_elapsed_millis=1.001s
finished prefilling to size 999235 for expected size 1000000 keysum=999407160849, performing 38123958 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999235
pref_millis=1102
prefill_elapsed_ms=1127
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6985182.45683039
REALTIME_END_PERF_FORMAT=6985192.45820190

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 253 491 929 1700 2965 4859 7687 11587 16588 22851 30030 37283 44190 50450 54763 56516 55837 52537 47629 41322 33754 26371 19429 13521 8779 5294 3057 1631 817 358 147 42 9 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 9 30 96 239 592 1109 2061 3568 5639 8452 12264 16346 20196 24453 28192 30180 31278 30259 28211 25685 21499 17500 13172 9413 6324 3913 2307 1227 672 292 130 38 7 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 500 959 1796 3204 5451 8796 13648 20156 28490 38482 49547 60536 70646 79216 84708 86017 83815 77888 69533 59439 47870 36929 26693 18192 11618 6970 3938 2044 1030 439 172 47 10 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 500 959 1796 3204 5451 8796 13648 20156 28490 38482 49547 60536 70646 79216 84708 86017 83815 77888 69533 59439 47870 36929 26693 18192 11618 6970 3938 2044 1030 439 172 47 10 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.96484 1.936 1.90407 1.83742 1.77591 1.72225 1.67769 1.62786 1.59049 1.54865 1.50717 1.46931 1.43703 1.40719 1.37802 1.34827 1.32526 1.30246 1.28122 1.26055 1.23749 1.22056 1.1967 1.17499 1.15606 1.14426 1.1264 1.10488 1.10421 1.07864 1.05695 1.02907 1.02128 1.1 1 1

tree_stats_height=44
tree_stats_numInternals=653935
tree_stats_numLeaves=345360
tree_stats_numNodes=999295
tree_stats_numKeys=999295

tree_stats_avgDegreeInternal=1.52813
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.3456
tree_stats_avgKeyDepth=23.8457


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:69 2:1487 4:52878 8:372381 16:53086
    [2^00, 2^01]: 69
    (2^01, 2^02]: 1487
    (2^02, 2^03]: 52878
    (2^03, 2^04]: 372381
    (2^04, 2^05]: 53086
sum_limbo_reclamation_event_size_total=5472996
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9997 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 9997 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=1009920
first_thread_announced_epoch_by_thread=45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624 45624
sum_num_inserts_by_thread=478561 476696 483262 480584 483040 474289 473533 480685 481999 488888 477904 476011 479815 483682 481391 482878 484536 475544 477489 480731 479898 486435 477143 477508 472882 476465 483775 485649 478127 474616 474144 481862 483007 483951 482816 475663 475443 483486 487216 482876 484971 481463 471853 475852 478730 480920 477409 478091
sum_num_inserts_total=23033769
sum_num_deletes_by_thread=478609 476367 485251 480317 481900 474066 474703 481999 482204 490532 478411 474397 481010 484355 481405 481663 484002 475876 476537 481493 480041 487711 477074 478215 471955 478419 483383 485390 477728 473401 474690 482745 481178 483492 483407 476839 475587 484332 486987 484339 483921 480402 473574 475870 479388 481707 477218 476731
sum_num_deletes_total=23040821
sum_num_searches_by_thread=8600995 8582603 8724719 8648105 8686891 8514255 8545709 8674487 8685176 8800887 8601238 8568430 8654815 8704472 8672262 8688493 8724894 8570362 8596334 8655630 8642080 8769970 8589154 8593725 8515312 8585756 8722461 8738437 8605456 8516683 8558192 8676219 8685812 8706340 8696629 8553098 8557155 8706094 8777155 8692999 8726147 8671466 8504879 8561157 8627230 8674401 8589930 8600991
sum_num_searches_total=414745685
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9558165 9535666 9693232 9609006 9651831 9462610 9493945 9637171 9649379 9780307 9557553 9518838 9615640 9672509 9635058 9653034 9693432 9521782 9550360 9617854 9602019 9744116 9543371 9549448 9460149 9540640 9689619 9709476 9561311 9464700 9507026 9640826 9649997 9673783 9662852 9505600 9508185 9673912 9751358 9660214 9695039 9633331 9450306 9512879 9585348 9637028 9544557 9555813
average_num_operations_total=9600422
stdev_num_operations_total=12168
sum_num_operations_total=460820275
min_num_operations_total=9450306
max_num_operations_total=9780307
first_time_thread_terminate_by_thread=10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000137
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 6 5 6 6 6 5 6 6 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 6 5 6 6 6 5 6 6 5
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=999585484755
threads_final_size=999295
final_keysum=999585484755
final_size=999295
validate_result=success
Validation OK.
Structural validation OK.

total_find=414745685
total_rq=0
total_inserts=23033769
total_deletes=23040821
total_updates=46074590
total_queries=414745685
total_ops=460820275
find_throughput=41474568
rq_throughput=0
update_throughput=4607459
query_throughput=41474568
total_throughput=46082027


total find                    : 414745685
total rq                      : 0
total inserts                 : 23033769
total deletes                 : 23040821
total updates                 : 46074590
total queries                 : 414745685
total ops                     : 460820275
find throughput               : 41474568
rq throughput                 : 0
update throughput             : 4607459
query throughput              : 41474568
total throughput              : 46082027

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.3049
PAPI_L3_TCM=2.18063
PAPI_TOT_CYC=2888.5
PAPI_TOT_INS=1336.59
garbage=207377989035988
total_execution_walltime=11.428s
REALTIME_MAIN_END_PERF_FORMAT=6985192.197635087
[time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=91643, mem_maxresident_kb=368492, user_cputime=562.23, sys_cputime=2.25, percent_cpu=4873%
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