__step=000154
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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" ./brown_sigouin_abtree_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 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000154.txt
__path_data=data/data000154.txt
__hostname=nasus
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x557a73805440
addrof(kcasDescriptors[1])=0x557a73805bc0
addrof(rdcssDescriptors[0])=0x557a738f5440
addrof(rdcssDescriptors[1])=0x557a738f5500
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=221755.254118306
binary=./brown_sigouin_abtree_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_sigouin_abtree_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=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=40
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.013s
prefilling_size=1000144 prefilling_elapsed_millis=1s
finished prefilling to size 1000185 for expected size 1000000 keysum=1000605971713, performing 76132378 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000185
pref_millis=1101
prefill_elapsed_ms=1109
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=221756.402951813
REALTIME_END_PERF_FORMAT=221766.403049150
###############################################################################
################################## 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 (256 threads)...
partitioned into 3745 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.247s
tree_stats_numInternalsAtDepth=1 1 8 64 503 3745 28705 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195310
tree_stats_numNodesAtDepth=1 1 8 64 503 3745 28705 195310
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999672
tree_stats_avgDegreeAtDepth=1 8 8 7.85938 7.44533 7.66489 6.80404 5.11839
tree_stats_height=8
tree_stats_numInternals=33027
tree_stats_numLeaves=195310
tree_stats_numNodes=228337
tree_stats_numKeys=999672
tree_stats_avgDegreeInternal=6.91365
tree_stats_avgDegreeLeaves=5.11839
tree_stats_avgDegree=5.37806
tree_stats_avgKeyDepth=7
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:96142 2:126578 4:24629 8:490 16:50 32:1
[2^00, 2^01]: 96142
(2^01, 2^02]: 126578
(2^02, 2^03]: 24629
(2^03, 2^04]: 490
(2^04, 2^05]: 50
(2^05, 2^06]: 1
sum_limbo_reclamation_event_size_total=472582
count_limbo_reclamation_event_size_by_thread=4118 3936 3888 3858 3758 3980 3940 4010 4088 3832 3878 4146 3888 3766 3746 3902 3876 3866 3620 3896 3972 3712 3902 3898 3800 3876 3778 3844 3914 4140 3800 4058 3740 3804 3692 4110 3828 3756 3750 3878 3702 3838 3802 3982 3898 3932 3944 3898 3918 3876 3710 3698 3746 3886 3680 3878 3762 3894 3822 4126 3818 4096 3884 3856
count_limbo_reclamation_event_size_total=247890
sum_limbo_reclamation_event_count_total=3495808
first_thread_announced_epoch_by_thread=58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628 58628
sum_commit_tx_reader_total=
sum_commit_tx_reader_by_thread=
sum_commit_tx_writer_total=
sum_commit_tx_writer_by_thread=
sum_abort_tx_total=
sum_abort_tx_by_thread=
max_ht_capacity_by_thread=
linear_histogram_of_none_tx_rdset_size_full_data=
linear_histogram_of_none_tx_wrset_size_full_data=
sum_fasthtm_commit_total=
sum_fasthtm_abort_total=
sum_htmpostfix_commit_total=
sum_htmpostfix_abort_total=
sum_htmprefix_commit_total=
sum_htmprefix_abort_total=
sum_htmprefix_abort_explicit_total=
sum_htmprefix_abort_conflict_total=
sum_htmprefix_abort_capacity_total=
sum_htmprefix_abort_nesting_total=
sum_htmprefix_abort_illegal_total=
sum_htmprefix_abort_zero_total=
sum_stmprefix_abort_total=
sum_stmprefix_commit_total=
sum_slow_commit_total=
sum_abtree_insert_repeat_total=772
sum_abtree_erase_repeat_total=174
sum_abtree_search_repeat_total=48
sum_abtree_search_complete_total=102121606
sum_abtree_fix_weight_viol_attempt_total=96151
sum_abtree_fix_degree_viol_attempt_total=749924
sum_abtree_rebalancing_kcas_attempt_total=845972
sum_abtree_update_kcas_attempt_total=50637807
sum_abtree_internal_complex_search_while_iters_total=102121713
sum_abtree_internal_basic_search_while_iters_total=911630889
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=838354 813956 838707 795490 818226 831234 814175 821340 797404 815731 792837 805042 788516 804476 784196 833071 796775 808016 790053 805574 787423 802601 768579 777749 769172 777983 754477 771392 757191 817273 798006 807923 783656 802078 782385 797557 765252 774025 742394 765539 743611 766833 743598 815171 787757 807424 780389 803907 780910 804494 770094 778325 745706 771272 758485 769957 756296 820068 782183 811214 795473 817552 797543 828138
sum_num_inserts_total=50632228
sum_num_deletes_by_thread=838329 813339 839137 795460 819461 830700 813912 821197 799108 817255 793645 806910 786337 801912 782957 833563 799558 807881 788697 806113 787048 802528 769126 779170 768643 777159 753906 770366 756813 817595 798440 809454 784613 800337 782587 796236 766389 774158 743559 764629 744102 767517 744087 816547 788185 807203 780524 805824 779525 805547 770971 776667 744946 770318 759229 769370 757576 819822 782324 811533 794377 819978 799246 828497
sum_num_deletes_total=50642142
sum_num_searches_by_thread=15087284 14651588 15098381 14336125 14729125 14963975 14667359 14798533 14371806 14717316 14269649 14512124 14187594 14453668 14120320 15008398 14352295 14542374 14220556 14492289 14152892 14431272 13845605 14000937 13842109 14014575 13569662 13882768 13628445 14715518 14368133 14540870 14117466 14426989 14079010 14330605 13773678 13952235 13380433 13776646 13367053 13827374 13404027 14692377 14172709 14543330 14041660 14489582 14044479 14504534 13859908 13994865 13433186 13879391 13660690 13869121 13637467 14757577 14084120 14592445 14305493 14749208 14402360 14902827
sum_num_searches_total=911626390
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16763967 16278883 16776225 15927075 16366812 16625909 16295446 16441070 15968318 16350302 15856131 16124076 15762447 16060056 15687473 16675032 15948628 16158271 15799306 16103976 15727363 16036401 15383310 15557856 15379924 15569717 15078045 15424526 15142449 16350386 15964579 16158247 15685735 16029404 15643982 15924398 15305319 15500418 14866386 15306814 14854766 15361724 14891712 16324095 15748651 16157957 15602573 16099313 15604914 16114575 15400973 15549857 14923838 15420981 15178404 15408448 15151339 16397467 15648627 16215192 15895343 16386738 15999149 16559462
average_num_operations_total=15826574
stdev_num_operations_total=61680
sum_num_operations_total=1012900760
min_num_operations_total=14854766
max_num_operations_total=16776225
first_time_thread_terminate_by_thread=10000101 10000101 10000101 10002616 10000100 10000100 10000100 10000100 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000101 10000101 10000101 10000101 10000099 10000099 10000100 10000099 10000100 10000100 10000100 10000100 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000102 10000102 10000102 10000102 10000097 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000098
min_time_thread_terminate_total=10000097
max_time_thread_terminate_total=10002616
first_time_thread_start_by_thread=5 5 5 5 6 6 6 6 4 4 4 4 7 7 7 7 4 4 4 4 7 7 7 7 4 4 4 4 8 7 7 8 3 3 3 3 4 5 4 4 4 4 4 4 6 6 6 6 5 5 5 5 6 6 6 6 6 6 6 6 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=1000102737344
threads_final_size=999672
final_keysum=1000102737344
final_size=999672
validate_result=success
Validation OK.
Structural validation OK.
total_find=911626390
total_rq=0
total_inserts=50632228
total_deletes=50642142
total_updates=101274370
total_queries=911626390
total_ops=1012900760
find_throughput=91162639
rq_throughput=0
update_throughput=10127437
query_throughput=91162639
total_throughput=101290076
total find : 911626390
total rq : 0
total inserts : 50632228
total deletes : 50642142
total updates : 101274370
total queries : 911626390
total ops : 1012900760
find throughput : 91162639
rq throughput : 0
update throughput : 10127437
query throughput : 91162639
total throughput : 101290076
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=69675176175509
total_execution_walltime=11.574s
REALTIME_MAIN_END_PERF_FORMAT=221766.829410009
[time_cmd_output] time_elapsed_sec=11.68, faults_major=0, faults_minor=88627, mem_maxresident_kb=353488, user_cputime=769.48, sys_cputime=6.33, percent_cpu=6642%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2