__step=000186
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000186.txt
__path_data=data/data000186.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x563db62a1400
addrof(kcasDescriptors[1])=0x563db62a1d00
addrof(rdcssDescriptors[0])=0x563db63c1400
addrof(rdcssDescriptors[1])=0x563db63c14c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6981053.160757282
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.018s
prefilling_size=1000790 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000811 for expected size 1000000 keysum=1000355482731, performing 38355514 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000811
pref_millis=1102
prefill_elapsed_ms=1118
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6981054.486137000
REALTIME_END_PERF_FORMAT=6981064.486268397

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

tree_stats_computeWalltime=0.036s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 253 496 952 1772 3157 5274 8318 12559 18047 24521 31842 39377 46606 52304 56042 57249 55576 51469 45620 38504 30963 23544 16973 11708 7959 5279 3353 2075 1230 698 399 211 92 44 21 7 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 1 7 21 68 204 565 1269 2240 3821 6218 9318 13086 17118 21733 25769 29061 31190 31410 30256 27691 23927 20045 15686 11610 8043 5514 3752 2434 1497 911 510 313 179 75 34 20 5 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 503 973 1840 3361 5839 9587 14799 21868 30739 41160 52463 63724 74037 81811 86310 86766 82879 75876 66195 54890 43589 32659 23318 16002 10793 7105 4509 2727 1609 909 524 271 119 55 27 8 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 503 973 1840 3361 5839 9587 14799 21868 30739 41160 52463 63724 74037 81811 86310 86766 82879 75876 66195 54890 43589 32659 23318 16002 10793 7105 4509 2727 1609 909 524 271 119 55 27 8 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.98425 1.94831 1.91264 1.86359 1.79798 1.73865 1.67602 1.62903 1.58039 1.5413 1.501 1.46408 1.43047 1.39854 1.36997 1.34199 1.31467 1.29449 1.27117 1.24754 1.23002 1.20911 1.19428 1.18415 1.1771 1.16918 1.1627 1.1446 1.13898 1.13114 1.13751 1.1145 1.09963 1.09244 1.10909 1.03704 1.125 1

tree_stats_height=46
tree_stats_numInternals=654751
tree_stats_numLeaves=345606
tree_stats_numNodes=1000357
tree_stats_numKeys=1000357

tree_stats_avgDegreeInternal=1.52784
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34548
tree_stats_avgKeyDepth=23.6445


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:174721 2:138978 4:13831 8:12
    [2^00, 2^01]: 174721
    (2^01, 2^02]: 138978
    (2^02, 2^03]: 13831
    (2^03, 2^04]: 12
sum_limbo_reclamation_event_size_total=549718
count_limbo_reclamation_event_size_by_thread=6722 6777 6819 6844 6821 6738 6816 6834 6802 6830 6894 6863 6801 6846 6823 6800 6915 6797 6807 6829 6811 6770 6801 6803 6856 6795 6931 6937 6781 6778 6853 6879 6824 6881 6854 6744 6768 6872 6831 6844 6734 6855 6776 6816 6828 6888 6882 6772
count_limbo_reclamation_event_size_total=327542
sum_limbo_reclamation_event_count_total=1042464
first_thread_announced_epoch_by_thread=46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972 46972
sum_num_inserts_by_thread=49270 49423 49619 49714 49950 49228 49256 49620 49739 50797 49560 49630 49516 49602 50368 49923 49942 49520 49067 49536 50276 50143 49394 49419 49432 49435 49905 49983 50104 49416 49585 50096 50848 49920 49633 49443 49585 49744 49770 50506 50023 49457 48906 49594 50061 50084 49558 49110
sum_num_inserts_total=2386710
sum_num_deletes_by_thread=48868 49342 49710 50134 49867 49093 49229 49371 49872 50353 49915 49508 49239 49894 50351 50078 49867 49457 49121 49574 50422 50289 49476 49308 49636 49421 50098 50344 50033 49274 49905 49692 50315 49970 49607 49464 49520 50409 50265 50286 49827 49256 49426 49701 49940 50174 49860 49281
sum_num_deletes_total=2388042
sum_num_searches_by_thread=9682279 9792090 9882538 9886556 9859395 9748515 9743629 9816220 9916019 9999779 9839532 9813351 9805350 9894089 9928979 9915106 9868284 9814878 9748141 9845420 9916986 9950274 9806103 9750215 9771203 9782875 9904286 9915514 9885064 9786219 9808823 9877812 9993019 9949022 9849961 9820571 9813502 9858064 9911603 9955668 9870491 9821779 9706961 9850157 9897133 9939861 9821745 9775462
sum_num_searches_total=472790523
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9780417 9890855 9981867 9986404 9959212 9846836 9842114 9915211 10015630 10100929 9939007 9912489 9904105 9993585 10029698 10015107 9968093 9913855 9846329 9944530 10017684 10050706 9904973 9848942 9870271 9881731 10004289 10015841 9985201 9884909 9908313 9977600 10094182 10048912 9949201 9919478 9912607 9958217 10011638 10056460 9970341 9920492 9805293 9949452 9997134 10040119 9921163 9873853
average_num_operations_total=9949276
stdev_num_operations_total=10729
sum_num_operations_total=477565275
min_num_operations_total=9780417
max_num_operations_total=10100929
first_time_thread_terminate_by_thread=10000131 10000131 10000131 10000131 10000132 10000131 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000132 10000131 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000131 10000131
min_time_thread_terminate_total=10000131
max_time_thread_terminate_total=10000132
first_time_thread_start_by_thread=5 5 4 5 4 5 4 4 5 5 5 4 5 5 4 5 4 5 4 5 5 5 4 5 5 5 4 5 4 5 4 4 5 5 5 4 5 5 4 5 4 5 4 5 5 5 4 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=1000336400553
threads_final_size=1000357
final_keysum=1000336400553
final_size=1000357
validate_result=success
Validation OK.
Structural validation OK.

total_find=472790523
total_rq=0
total_inserts=2386710
total_deletes=2388042
total_updates=4774752
total_queries=472790523
total_ops=477565275
find_throughput=47279052
rq_throughput=0
update_throughput=477475
query_throughput=47279052
total_throughput=47756527


total find                    : 472790523
total rq                      : 0
total inserts                 : 2386710
total deletes                 : 2388042
total updates                 : 4774752
total queries                 : 472790523
total ops                     : 477565275
find throughput               : 47279052
rq throughput                 : 0
update throughput             : 477475
query throughput              : 47279052
total throughput              : 47756527

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.2872
PAPI_L3_TCM=2.10807
PAPI_TOT_CYC=2787.24
PAPI_TOT_INS=1268.22
garbage=236422060037799
total_execution_walltime=11.455s
REALTIME_MAIN_END_PERF_FORMAT=6981064.616866622
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=91452, mem_maxresident_kb=367860, user_cputime=563.38, sys_cputime=2.64, percent_cpu=4881%
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