__step=000185
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000185.txt
__path_data=data/data000185.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x562f1dd1e3c0
addrof(kcasDescriptors[1])=0x562f1dd1ecc0
addrof(rdcssDescriptors[0])=0x562f1de3e3c0
addrof(rdcssDescriptors[1])=0x562f1de3e480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=209072.944641995
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,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.017s
prefilling_size=1000271 prefilling_elapsed_millis=1s
finished prefilling to size 1000234 for expected size 1000000 keysum=1000491608673, performing 38950891 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000234
pref_millis=1101
prefill_elapsed_ms=1111
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=209074.90993269
REALTIME_END_PERF_FORMAT=209084.91052169
###############################################################################
################################## 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 1643 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.107s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 246 466 865 1541 2645 4329 6815 10186 14453 19632 25490 31971 38524 44444 48796 51401 51466 49921 46131 41390 36127 30536 24916 19916 15190 11317 8142 5703 3930 2516 1595 940 523 312 165 72 25 12 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 4 16 32 102 236 524 1004 1906 3203 5002 7441 10128 13612 17387 21434 24510 27309 28007 28311 26742 24517 21838 18903 15699 12969 9957 7542 5458 3888 2804 1772 1170 709 373 230 138 62 18 11 5
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 250 482 897 1643 2881 4853 7819 12092 17656 24634 32931 42099 52136 61831 70230 75911 78775 77928 74442 68132 60644 52374 43819 35615 28159 21274 15684 11161 7818 5320 3367 2110 1232 685 395 210 87 30 15 5
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 250 482 897 1643 2881 4853 7819 12092 17656 24634 32931 42099 52136 61831 70230 75911 78775 77928 74442 68132 60644 52374 43819 35615 28159 21274 15684 11161 7818 5320 3367 2110 1232 685 395 210 87 30 15 5
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.95312 1.944 1.89419 1.86734 1.81558 1.7664 1.71914 1.67489 1.61776 1.57663 1.53986 1.50436 1.47899 1.44704 1.41704 1.38609 1.36061 1.33592 1.31466 1.29555 1.2826 1.26791 1.25362 1.24416 1.23145 1.21606 1.20527 1.19249 1.1895 1.17779 1.15996 1.15296 1.13839 1.13149 1.12117 1.11392 1.07143 1.05747 1.1 1.06667 1
tree_stats_height=48
tree_stats_numInternals=652908
tree_stats_numLeaves=344973
tree_stats_numNodes=997881
tree_stats_numKeys=997881
tree_stats_avgDegreeInternal=1.52836
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34571
tree_stats_avgKeyDepth=24.776
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:212646 2:244822 4:43237 8:273 16:86
[2^00, 2^01]: 212646
(2^01, 2^02]: 244822
(2^02, 2^03]: 43237
(2^03, 2^04]: 273
(2^04, 2^05]: 86
sum_limbo_reclamation_event_size_total=977794
count_limbo_reclamation_event_size_by_thread=7852 7887 7836 7832 7840 7842 7811 7908 7880 7903 7822 7798 7792 7849 7853 7757 7870 7862 7835 7799 7898 7833 7772 7805 7883 7874 7755 7893 7832 7847 7752 7792 7832 7837 7793 7791 7863 7837 7835 7844 7867 7830 7838 7805 7812 7763 7734 7792 7792 7857 7774 7819 7850 7786 7757 7840 7774 7871 7833 7775 7835 7919 7921 7824
count_limbo_reclamation_event_size_total=501064
sum_limbo_reclamation_event_count_total=929084
first_thread_announced_epoch_by_thread=31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116 31116
sum_num_inserts_by_thread=44408 44847 44825 44704 44467 44371 44784 45079 44349 44765 44631 44615 44901 44541 44225 44028 43905 43448 44332 44044 44833 44578 44137 44101 44422 44542 44159 44102 44143 43888 43682 43657 44047 43951 44442 44482 44791 45146 44314 44383 44832 44520 43698 44065 43893 44298 43853 43906 44359 44372 44201 44318 44268 44398 44098 44505 44211 43982 43660 43744 44365 43883 44393 44751
sum_num_inserts_total=2835642
sum_num_deletes_by_thread=44360 44888 44998 44338 44780 44615 44769 44875 44921 44917 44487 44430 44503 44935 44247 44031 44097 43796 43672 43555 44860 44824 44114 44664 44539 44357 44521 44101 44174 43950 43617 43882 44188 44308 44484 44484 44686 44654 44275 44508 45037 44156 43999 44065 43965 43931 43425 43930 44436 44188 43929 44161 44341 44276 44213 44239 44181 44037 43635 44051 44402 44597 44730 44279
sum_num_deletes_total=2836607
sum_num_searches_by_thread=8828204 8898864 8845202 8796410 8834734 8813857 8886483 8858532 8870334 8856938 8825297 8836521 8845855 8805016 8741268 8721884 8693147 8688538 8676957 8656938 8819107 8800586 8773844 8770593 8793442 8795345 8773448 8706620 8705097 8686321 8667917 8663725 8723468 8728863 8854804 8818537 8841372 8844266 8812397 8809599 8848568 8772465 8709018 8705418 8740053 8734511 8700023 8707325 8811819 8791434 8760861 8777817 8789560 8794038 8765291 8771570 8738217 8693689 8660484 8672347 8741994 8778483 8804937 8894926
sum_num_searches_total=561535178
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8916972 8988599 8935025 8885452 8923981 8902843 8976036 8948486 8959604 8946620 8914415 8925566 8935259 8894492 8829740 8809943 8781149 8775782 8764961 8744537 8908800 8889988 8862095 8859358 8882403 8884244 8862128 8794823 8793414 8774159 8755216 8751264 8811703 8817122 8943730 8907503 8930849 8934066 8900986 8898490 8938437 8861141 8796715 8793548 8827911 8822740 8787301 8795161 8900614 8879994 8848991 8866296 8878169 8882712 8853602 8860314 8826609 8781708 8747779 8760142 8830761 8866963 8894060 8983956
average_num_operations_total=8862616
stdev_num_operations_total=8257
sum_num_operations_total=567207427
min_num_operations_total=8744537
max_num_operations_total=8988599
first_time_thread_terminate_by_thread=10000061 10000061 10000061 10000061 10000062 10000062 10000062 10000062 10000061 10000061 10000061 10000061 10000064 10000064 10000064 10000064 10000063 10000063 10000063 10000063 10000062 10000062 10000062 10000062 10000061 10000061 10000061 10000061 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000063 10000063 10000063 10000063 10000061 10000061 10000061 10000061 10000065 10000065 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000062 10000062 10000062 10000062 10000063 10000063 10000063 10000063
min_time_thread_terminate_total=10000061
max_time_thread_terminate_total=10000065
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 4 4 4 4 5 5 5 3964 5 5 5 5 5 6 6 5 4 4 4 4 5 5 5 5 6 6 6 7 4 4 4 4 6 6 6 6 4 4 4 4 7 7 7 7 6 6 6 6 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=3964
sum_duration_all_ops_total=
threads_final_keysum=998415463812
threads_final_size=997881
final_keysum=998415463812
final_size=997881
validate_result=success
Validation OK.
Structural validation OK.
total_find=561535178
total_rq=0
total_inserts=2835642
total_deletes=2836607
total_updates=5672249
total_queries=561535178
total_ops=567207427
find_throughput=56153517
rq_throughput=0
update_throughput=567224
query_throughput=56153517
total_throughput=56720742
total find : 561535178
total rq : 0
total inserts : 2835642
total deletes : 2836607
total updates : 5672249
total queries : 561535178
total ops : 567207427
find throughput : 56153517
rq throughput : 0
update throughput : 567224
query throughput : 56153517
total throughput : 56720742
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=70357834152615
total_execution_walltime=11.338s
REALTIME_MAIN_END_PERF_FORMAT=209084.283339638
[time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=92133, mem_maxresident_kb=369416, user_cputime=739.28, sys_cputime=4.48, percent_cpu=6497%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1