__step=000633
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000633.txt
__path_data=data/data000633.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55b6573853c0
addrof(kcasDescriptors[1])=0x55b657385cc0
addrof(rdcssDescriptors[0])=0x55b6574a53c0
addrof(rdcssDescriptors[1])=0x55b6574a5480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=214433.514366851
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.016s
prefilling_size=99933 prefilling_elapsed_millis=1s
finished prefilling to size 99935 for expected size 100000 keysum=9988056038, performing 48840744 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99935
pref_millis=1101
prefill_elapsed_ms=1115
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=214434.662967919
REALTIME_END_PERF_FORMAT=214444.663018385
###############################################################################
################################## 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 (256 threads)...
partitioned into 1318 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.079s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 117 220 405 711 1205 1910 2872 4020 5202 6079 6475 6404 6122 5391 4709 3873 3013 2250 1522 1071 717 465 263 137 69 39 15 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 7 8 22 53 113 276 514 955 1536 2326 3042 3426 3435 3589 3161 2932 2451 1977 1571 1015 727 511 351 201 96 52 30 11 4 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 124 228 427 764 1318 2186 3386 4975 6738 8405 9517 9830 9557 8980 7870 6805 5464 4227 3093 2086 1444 976 614 338 165 91 45 15 5 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 124 228 427 764 1318 2186 3386 4975 6738 8405 9517 9830 9557 8980 7870 6805 5464 4227 3093 2086 1444 976 614 338 165 91 45 15 5 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.89516 1.90789 1.84075 1.7945 1.74431 1.67521 1.62109 1.54633 1.47536 1.40904 1.35253 1.32075 1.29905 1.27606 1.26633 1.2338 1.22218 1.19943 1.18235 1.17881 1.17936 1.15266 1.12215 1.08284 1.13333 1.06593 1 1.06667 1 1
tree_stats_height=37
tree_stats_numInternals=65407
tree_stats_numLeaves=34394
tree_stats_numNodes=99801
tree_stats_numKeys=99801
tree_stats_avgDegreeInternal=1.52585
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34463
tree_stats_avgKeyDepth=18.8659
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:13 2:277 4:17738 8:407157 16:214481 32:17 64:111 128:48 256:28
[2^00, 2^01]: 13
(2^01, 2^02]: 277
(2^02, 2^03]: 17738
(2^03, 2^04]: 407157
(2^04, 2^05]: 214481
(2^05, 2^06]: 17
(2^06, 2^07]: 111
(2^07, 2^08]: 48
(2^08, 2^09]: 28
sum_limbo_reclamation_event_size_total=9024420
count_limbo_reclamation_event_size_by_thread=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 9998 9997 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
count_limbo_reclamation_event_size_total=639870
sum_limbo_reclamation_event_count_total=1910592
first_thread_announced_epoch_by_thread=62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528 62528
sum_num_inserts_by_thread=802501 816039 817244 800630 817292 815611 814063 810733 809819 815185 806404 801645 792071 780371 785197 782600 779186 782645 775485 800233 797207 801043 802010 801324 882400 877743 859624 845473 844925 840314 837651 837321 824413 865117 952651 861223 871876 877873 882703 878320 831378 829636 823805 919467 849290 847763 843287 888033 882307 881328 885396 880894 886154 885438 876641 876693 885895 896590 896480 904886 822931 830104 832965 833879
sum_num_inserts_total=53837405
sum_num_deletes_by_thread=803339 816006 816580 801910 817260 816796 814102 811994 810541 814654 806252 802803 791730 780683 784026 781949 779792 782040 777258 799724 796169 802973 799951 799611 881152 875927 858961 846184 844776 840669 839633 838052 823618 866485 953227 860699 869061 876723 881775 880236 830884 830910 824347 920108 850394 847211 844095 886657 881092 880004 885903 880903 884250 884115 877186 874483 886962 896950 896623 903509 822333 828748 830903 833767
sum_num_deletes_total=53827658
sum_num_searches_by_thread=14446424 14683823 14701562 14425871 14717144 14697449 14660692 14602047 14591043 14663354 14509650 14437851 14260561 14055751 14106927 14066267 14040814 14076858 13974947 14412610 14371634 14437657 14423810 14392556 15909334 15778277 15453486 15244898 15210128 15133197 15093223 15097186 14843608 15567542 17141520 15485818 15687514 15811802 15853395 15819148 14972030 14946481 14843176 16559843 15286403 15245855 15187320 15969905 15868094 15852643 15945169 15861439 15939689 15942076 15790607 15757482 15956746 16110873 16135171 16264188 14816585 14926270 15006188 15017503
sum_num_searches_total=969089114
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16052264 16315868 16335386 16028411 16351696 16329856 16288857 16224774 16211403 16293193 16122306 16042299 15844362 15616805 15676150 15630816 15599792 15641543 15527690 16012567 15965010 16041673 16025771 15993491 17672886 17531947 17172071 16936555 16899829 16814180 16770507 16772559 16491639 17299144 19047398 17207740 17428451 17566398 17617873 17577704 16634292 16607027 16491328 18399418 16986087 16940829 16874702 17744595 17631493 17613975 17716468 17623236 17710093 17711629 17544434 17508658 17729603 17904413 17928274 18072583 16461849 16585122 16670056 16685149
average_num_operations_total=16824284
stdev_num_operations_total=100906
sum_num_operations_total=1076754177
min_num_operations_total=15527690
max_num_operations_total=19047398
first_time_thread_terminate_by_thread=10000047 10000047 10000047 10000047 10000047 10000048 10000048 10000048 10000049 10000049 10000049 10000049 10000048 10000048 10000048 10000048 10000046 10000046 10000046 10000046 10000047 10000047 10000047 10000047 10000049 10000049 10000049 10000049 10000048 10000048 10000048 10000048 10000046 10000046 10000046 10000046 10000048 10000047 10000048 10000048 10000049 10000049 10000049 10000049 10000048 10000048 10000048 10000048 10000047 10000048 10000048 10000048 10000046 10000046 10000046 10000046 10000048 10000048 10000048 10000048 10000046 10000046 10000046 10000046
min_time_thread_terminate_total=10000046
max_time_thread_terminate_total=10000049
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 3 3 3 3 6 6 6 6 3 3 3 3 3 3 3 3 7 7 7 7 5 5 5 5 5 5 5 5 4 4 4 4 6 6 6 6 5 6 5 5 6 6 6 6 6 6 6 6 4 4 4 4 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=9997664063
threads_final_size=99801
final_keysum=9997664063
final_size=99801
validate_result=success
Validation OK.
Structural validation OK.
total_find=969089114
total_rq=0
total_inserts=53837405
total_deletes=53827658
total_updates=107665063
total_queries=969089114
total_ops=1076754177
find_throughput=96908911
rq_throughput=0
update_throughput=10766506
query_throughput=96908911
total_throughput=107675417
total find : 969089114
total rq : 0
total inserts : 53837405
total deletes : 53827658
total updates : 107665063
total queries : 969089114
total ops : 1076754177
find throughput : 96908911
rq throughput : 0
update throughput : 10766506
query throughput : 96908911
total throughput : 107675417
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=11369591231941
total_execution_walltime=11.322s
REALTIME_MAIN_END_PERF_FORMAT=214444.837558311
[time_cmd_output] time_elapsed_sec=11.42, faults_major=0, faults_minor=77568, mem_maxresident_kb=310696, user_cputime=732.55, sys_cputime=5.15, percent_cpu=6458%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1