__step=000689
__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" ./brown_sigouin_abtree_kcas_validate.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000689.txt
__path_data=data/data000689.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x56065bcba480
addrof(kcasDescriptors[1])=0x56065bcbac00
addrof(rdcssDescriptors[0])=0x56065bdaa480
addrof(rdcssDescriptors[1])=0x56065bdaa540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6987147.916131197
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=8795389 prefilling_elapsed_millis=1.001s
prefilling_size=9009978 prefilling_elapsed_millis=1.101s
prefilling_size=9182904 prefilling_elapsed_millis=1.201s
prefilling_size=9326875 prefilling_elapsed_millis=1.301s
prefilling_size=9443480 prefilling_elapsed_millis=1.402s
prefilling_size=9535788 prefilling_elapsed_millis=1.502s
prefilling_size=9611733 prefilling_elapsed_millis=1.602s
prefilling_size=9674207 prefilling_elapsed_millis=1.702s
prefilling_size=9726665 prefilling_elapsed_millis=1.802s
prefilling_size=9772732 prefilling_elapsed_millis=1.903s
prefilling_size=9808841 prefilling_elapsed_millis=2.003s
finished prefilling to size 9808887 for expected size 10000000 keysum=98064928720625, performing 86760818 updates; total_prefilling_elapsed_ms=2104 ms)
pref_size=9808887
pref_millis=2104
prefill_elapsed_ms=2128
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6987150.202570356
REALTIME_END_PERF_FORMAT=6987160.202699358
###############################################################################
################################## 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 4437 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.07s
tree_stats_numInternalsAtDepth=1 1 10 80 594 4437 33596 262948 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1962309
tree_stats_numNodesAtDepth=1 1 10 80 594 4437 33596 262948 1962309
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9999628
tree_stats_avgDegreeAtDepth=1 10 8 7.425 7.4697 7.57178 7.82677 7.46273 5.09585
tree_stats_height=9
tree_stats_numInternals=301667
tree_stats_numLeaves=1962309
tree_stats_numNodes=2263976
tree_stats_numKeys=9999628
tree_stats_avgDegreeInternal=7.50488
tree_stats_avgDegreeLeaves=5.09585
tree_stats_avgDegree=5.41684
tree_stats_avgKeyDepth=8
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:41818 2:138913 4:207111 8:61579 16:811
[2^00, 2^01]: 41818
(2^01, 2^02]: 138913
(2^02, 2^03]: 207111
(2^03, 2^04]: 61579
(2^04, 2^05]: 811
sum_limbo_reclamation_event_size_total=2054853
count_limbo_reclamation_event_size_by_thread=9390 9332 9310 9344 9474 9534 9352 9370 9452 9286 9500 9302 9462 9288 9520 9326 9394 9344 9330 9464 9354 9380 9344 9286 9302 9490 9286 9270 9488 9236 9280 9480 9502 9312 9490 9458 9286 9358 9332 9288 9506 9264 9476 9472 9528 9306 9354 9330
count_limbo_reclamation_event_size_total=450232
sum_limbo_reclamation_event_count_total=1756032
first_thread_announced_epoch_by_thread=44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598 44598
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=2378
sum_abtree_erase_repeat_total=365
sum_abtree_search_repeat_total=47
sum_abtree_search_complete_total=405995447
sum_abtree_fix_weight_viol_attempt_total=672007
sum_abtree_fix_degree_viol_attempt_total=2302762
sum_abtree_rebalancing_kcas_attempt_total=2974605
sum_abtree_update_kcas_attempt_total=201503430
sum_abtree_internal_complex_search_while_iters_total=405995768
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=4167611 4207764 4224270 4214587 4190262 4156796 4187423 4200891 4224393 4248772 4183619 4177577 4176813 4218133 4227915 4233063 4195962 4195322 4171013 4179916 4214579 4232937 4184767 4151253 4190272 4194407 4232269 4227139 4177806 4174498 4189710 4185319 4219954 4244326 4189436 4164827 4193011 4218321 4242825 4230912 4185807 4184397 4152575 4176980 4187144 4233192 4183800 4155416
sum_num_inserts_total=201499981
sum_num_deletes_by_thread=4169410 4206524 4225383 4220756 4184365 4161556 4192154 4201105 4223767 4249072 4187061 4178669 4178334 4214858 4225814 4234295 4195403 4190876 4173472 4176753 4212662 4239155 4186597 4150027 4189695 4190132 4229401 4225193 4182038 4170770 4190435 4187309 4218588 4246602 4182635 4160938 4192925 4216686 4242603 4232690 4192332 4184738 4152912 4179421 4187722 4234233 4190708 4157639
sum_num_deletes_total=201516413
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8337021 8414288 8449653 8435343 8374627 8318352 8379577 8401996 8448160 8497844 8370680 8356246 8355147 8432991 8453729 8467358 8391365 8386198 8344485 8356669 8427241 8472092 8371364 8301280 8379967 8384539 8461670 8452332 8359844 8345268 8380145 8372628 8438542 8490928 8372071 8325765 8385936 8435007 8485428 8463602 8378139 8369135 8305487 8356401 8374866 8467425 8374508 8313055
average_num_operations_total=8396174
stdev_num_operations_total=7648
sum_num_operations_total=403016394
min_num_operations_total=8301280
max_num_operations_total=8497844
first_time_thread_terminate_by_thread=10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129 10000129
min_time_thread_terminate_total=10000129
max_time_thread_terminate_total=10000129
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
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=100006939906723
threads_final_size=9999628
final_keysum=100006939906723
final_size=9999628
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=201499981
total_deletes=201516413
total_updates=403016394
total_queries=0
total_ops=403016394
find_throughput=0
rq_throughput=0
update_throughput=40301639
query_throughput=0
total_throughput=40301639
total find : 0
total rq : 0
total inserts : 201499981
total deletes : 201516413
total updates : 403016394
total queries : 0
total ops : 403016394
find throughput : 0
rq throughput : 0
update throughput : 40301639
query throughput : 0
total throughput : 40301639
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=19.4613
PAPI_L3_TCM=6.85004
PAPI_TOT_CYC=3301.24
PAPI_TOT_INS=1416.3
garbage=0
total_execution_walltime=12.461s
REALTIME_MAIN_END_PERF_FORMAT=6987160.381519818
[time_cmd_output] time_elapsed_sec=12.63, faults_major=0, faults_minor=199929, mem_maxresident_kb=800204, user_cputime=613.50, sys_cputime=1.88, percent_cpu=4869%
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=1