__step=000356
__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 96 -nprefill 96 -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=data000356.txt
__path_data=data/data000356.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55bb34383480
addrof(kcasDescriptors[1])=0x55bb34383c00
addrof(rdcssDescriptors[0])=0x55bb34473480
addrof(rdcssDescriptors[1])=0x55bb34473540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6999111.788669821
binary=./brown_sigouin_abtree_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.013s
prefilling_size=999993 prefilling_elapsed_millis=1.001s
finished prefilling to size 999934 for expected size 1000000 keysum=999951760937, performing 94132010 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=999934
pref_millis=1103
prefill_elapsed_ms=1124
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6999113.100748558
REALTIME_END_PERF_FORMAT=6999123.100906701
###############################################################################
################################## 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 3739 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.057s
tree_stats_numInternalsAtDepth=1 1 8 67 498 3739 29221 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 195031
tree_stats_numNodesAtDepth=1 1 8 67 498 3739 29221 195031
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000428
tree_stats_avgDegreeAtDepth=1 8 8.375 7.43284 7.50803 7.81519 6.67434 5.12958
tree_stats_height=8
tree_stats_numInternals=33535
tree_stats_numLeaves=195031
tree_stats_numNodes=228566
tree_stats_numKeys=1000428
tree_stats_avgDegreeInternal=6.81574
tree_stats_avgDegreeLeaves=5.12958
tree_stats_avgDegree=5.37698
tree_stats_avgKeyDepth=7
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:171760 2:260798 4:78836 8:2388 16:182 32:194 64:2
[2^00, 2^01]: 171760
(2^01, 2^02]: 260798
(2^02, 2^03]: 78836
(2^03, 2^04]: 2388
(2^04, 2^05]: 182
(2^05, 2^06]: 194
(2^06, 2^07]: 2
sum_limbo_reclamation_event_size_total=1111770
count_limbo_reclamation_event_size_by_thread=5580 5498 5356 5310 5516 5474 5196 5444 5296 5586 5416 5474 5382 5290 5224 5484 5392 5166 5042 5358 5216 5276 5328 5168 5480 5232 5190 5180 5576 5364 5296 5164 5414 5458 5236 5244 5140 5452 5500 5260 5268 5226 5274 5430 5366 5194 5192 5446 5196 5304 5538 5350 5476 5428 5320 5322 5562 5304 5288 5228 5148 5326 5600 5572 5452 5460 5504 5490 5162 5342 5316 5134 5218 5334 5528 5570 5366 5160 5186 5238 5314 5426 5428 5550 5386 5346 5496 5566 5298 5250 5266 5464 5384 5572 5492 5446
count_limbo_reclamation_event_size_total=514160
sum_limbo_reclamation_event_count_total=3279936
first_thread_announced_epoch_by_thread=36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334 36334
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=2117
sum_abtree_erase_repeat_total=300
sum_abtree_search_repeat_total=178
sum_abtree_search_complete_total=151677894
sum_abtree_fix_weight_viol_attempt_total=141753
sum_abtree_fix_degree_viol_attempt_total=1104976
sum_abtree_rebalancing_kcas_attempt_total=1246373
sum_abtree_update_kcas_attempt_total=75214133
sum_abtree_internal_complex_search_while_iters_total=151678264
sum_abtree_internal_basic_search_while_iters_total=1353863003
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=775538 776306 780134 789092 781214 772437 775247 779622 791885 785283 776749 777318 778548 777950 785438 784414 781076 775230 773863 779493 787894 783373 778674 775161 773506 775161 786094 786190 782903 771016 778651 780940 785067 782545 777513 775791 783612 775548 782900 788683 783622 777691 771445 776642 787510 781899 777501 771529 785333 786581 790877 790308 780189 775931 777154 792769 793695 786478 789001 787866 786489 783847 792855 798502 791393 775436 780621 789331 791966 785117 783322 786774 784612 789287 786508 791359 783427 775092 780738 784013 795126 788859 781377 785598 786395 781483 787058 794642 791496 781125 786142 792566 798993 790094 790507 795648
sum_num_inserts_total=75219878
sum_num_deletes_by_thread=775432 776557 778120 788715 781889 770487 776593 779630 791829 785345 775206 775700 779502 777002 785880 782820 782182 775042 774701 779078 787755 783969 778871 773724 772175 774535 785160 784125 781589 772919 777669 782241 784448 782476 778720 775814 781320 773671 780923 788007 783891 775846 772217 775609 788681 780332 779588 771665 784222 784870 791305 789814 781126 777111 776254 791036 792967 786193 787940 787959 785647 783317 791118 799106 790964 775906 782286 790761 791472 787722 783704 788118 786286 784636 786039 789946 781387 776114 781612 783261 795903 787572 781846 787729 788403 780835 787651 793824 793165 785059 786094 791866 799628 791161 790869 796772
sum_num_deletes_total=75208226
sum_num_searches_by_thread=13967134 13966703 14032249 14192275 14068612 13894089 13972552 14052854 14253388 14125395 13991890 13980877 14018271 13986561 14129348 14110275 14071666 13966338 13941687 14031734 14163661 14114404 14009017 13951781 13926452 13940260 14129991 14137199 14070260 13909945 14002255 14058143 14120125 14082363 14028918 13959860 14077137 13958767 14077658 14193188 14098161 13977717 13873535 13989982 14173017 14055401 14012251 13900994 14125240 14155217 14231345 14223741 14056140 13970186 14006409 14245920 14271167 14150729 14179809 14186587 14146191 14098817 14273697 14387157 14255475 13956641 14053999 14202771 14268538 14150946 14108382 14177022 14142193 14162793 14161121 14230338 14089101 13965657 14033167 14099879 14323423 14178540 14060451 14162765 14164615 14058264 14175570 14300608 14263590 14096171 14141005 14266938 14380994 14220662 14234423 14311053
sum_num_searches_total=1353851787
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15518104 15519566 15590503 15770082 15631715 15437013 15524392 15612106 15837102 15696023 15543845 15533895 15576321 15541513 15700666 15677509 15634924 15516610 15490251 15590305 15739310 15681746 15566562 15500666 15472133 15489956 15701245 15707514 15634752 15453880 15558575 15621324 15689640 15647384 15585151 15511465 15642069 15507986 15641481 15769878 15665674 15531254 15417197 15542233 15749208 15617632 15569340 15444188 15694795 15726668 15813527 15803863 15617455 15523228 15559817 15829725 15857829 15723400 15756750 15762412 15718327 15665981 15857670 15984765 15837832 15507983 15616906 15782863 15851976 15723785 15675408 15751914 15713091 15736716 15733668 15811643 15653915 15516863 15595517 15667153 15914452 15754971 15623674 15736092 15739413 15620582 15750279 15889074 15848251 15662355 15713241 15851370 15979615 15801917 15815799 15903473
average_num_operations_total=15669582
stdev_num_operations_total=13210
sum_num_operations_total=1504279891
min_num_operations_total=15417197
max_num_operations_total=15984765
first_time_thread_terminate_by_thread=10000160 10000161 10000160 10000160 10000161 10000158 10000158 10000159 10000159 10000160 10000160 10000159 10000158 10000161 10000160 10000159 10000159 10000160 10000160 10000158 10000158 10000158 10000158 10000160 10000160 10000161 10000160 10000160 10000161 10000158 10000158 10000159 10000159 10000160 10000160 10000159 10000158 10000161 10000160 10000159 10000159 10000160 10000160 10000158 10000158 10000158 10000158 10000160 10000159 10000158 10000159 10000158 10000158 10000158 10000158 10000158 10000158 10000159 10000159 10000158 10000158 10000159 10000158 10000158 10000159 10000158 10000158 10000158 10000159 10000159 10000158 10000159 10000159 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000159 10000159 10000158 10000158 10000159 10000158 10000158 10000159 10000159 10000158 10000158 10000159 10000159 10000158 10000160
min_time_thread_terminate_total=10000158
max_time_thread_terminate_total=10000161
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=1000477936840
threads_final_size=1000428
final_keysum=1000477936840
final_size=1000428
validate_result=success
Validation OK.
Structural validation OK.
total_find=1353851787
total_rq=0
total_inserts=75219878
total_deletes=75208226
total_updates=150428104
total_queries=1353851787
total_ops=1504279891
find_throughput=135385178
rq_throughput=0
update_throughput=15042810
query_throughput=135385178
total_throughput=150427989
total find : 1353851787
total rq : 0
total inserts : 75219878
total deletes : 75208226
total updates : 150428104
total queries : 1353851787
total ops : 1504279891
find throughput : 135385178
rq throughput : 0
update throughput : 15042810
query throughput : 135385178
total throughput : 150427989
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=11.6251
PAPI_L3_TCM=1.6158
PAPI_TOT_CYC=1689.65
PAPI_TOT_INS=890.278
garbage=669954092352885
total_execution_walltime=11.478s
REALTIME_MAIN_END_PERF_FORMAT=6999123.267682696
[time_cmd_output] time_elapsed_sec=11.60, faults_major=0, faults_minor=90848, mem_maxresident_kb=359040, user_cputime=1096.56, sys_cputime=2.95, percent_cpu=9472%
timeout=false
algorithm=brown_sigouin_abtree_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