__step=000041
__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_abtree_tm_auto.debra.tl2 -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000041.txt
__path_data=data/data000041.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=220247.861016087
binary=./brown_abtree_tm_auto.debra.tl2
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_abtree_tm_auto
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=20000000
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=200
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
TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.023s
prefilling_size=4396979 prefilling_elapsed_millis=1s
prefilling_size=4746649 prefilling_elapsed_millis=1.101s
prefilling_size=5082108 prefilling_elapsed_millis=1.201s
prefilling_size=5400859 prefilling_elapsed_millis=1.301s
prefilling_size=5708130 prefilling_elapsed_millis=1.401s
prefilling_size=5998115 prefilling_elapsed_millis=1.502s
prefilling_size=6268687 prefilling_elapsed_millis=1.602s
prefilling_size=6524851 prefilling_elapsed_millis=1.702s
prefilling_size=6768806 prefilling_elapsed_millis=1.802s
prefilling_size=6996803 prefilling_elapsed_millis=1.903s
prefilling_size=7210167 prefilling_elapsed_millis=2.003s
prefilling_size=7410354 prefilling_elapsed_millis=2.103s
prefilling_size=7598888 prefilling_elapsed_millis=2.203s
prefilling_size=7774075 prefilling_elapsed_millis=2.304s
prefilling_size=7937107 prefilling_elapsed_millis=2.404s
prefilling_size=8089762 prefilling_elapsed_millis=2.504s
prefilling_size=8233462 prefilling_elapsed_millis=2.604s
prefilling_size=8365683 prefilling_elapsed_millis=2.705s
prefilling_size=8488560 prefilling_elapsed_millis=2.805s
prefilling_size=8604365 prefilling_elapsed_millis=2.905s
prefilling_size=8713269 prefilling_elapsed_millis=3.006s
prefilling_size=8811994 prefilling_elapsed_millis=3.106s
prefilling_size=8903977 prefilling_elapsed_millis=3.206s
prefilling_size=8989197 prefilling_elapsed_millis=3.307s
prefilling_size=9069201 prefilling_elapsed_millis=3.407s
prefilling_size=9142728 prefilling_elapsed_millis=3.507s
prefilling_size=9209975 prefilling_elapsed_millis=3.607s
prefilling_size=9273056 prefilling_elapsed_millis=3.708s
prefilling_size=9330800 prefilling_elapsed_millis=3.808s
prefilling_size=9384993 prefilling_elapsed_millis=3.908s
prefilling_size=9434182 prefilling_elapsed_millis=4.008s
prefilling_size=9480973 prefilling_elapsed_millis=4.109s
prefilling_size=9522859 prefilling_elapsed_millis=4.209s
prefilling_size=9562878 prefilling_elapsed_millis=4.309s
prefilling_size=9597747 prefilling_elapsed_millis=4.409s
prefilling_size=9630570 prefilling_elapsed_millis=4.51s
prefilling_size=9661154 prefilling_elapsed_millis=4.61s
prefilling_size=9688438 prefilling_elapsed_millis=4.71s
prefilling_size=9714315 prefilling_elapsed_millis=4.81s
prefilling_size=9737784 prefilling_elapsed_millis=4.911s
prefilling_size=9759622 prefilling_elapsed_millis=5.011s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 240332 keys with 64 threads...
tid=0 thread_prefill_amount=168750 percent_done_estimate=4493.8 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=171875 percent_done_estimate=4577.0 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0383108s
prefilling_size=10000000 prefilling_elapsed_millis=0.04s
finished prefilling to size 10000000 for expected size 10000000 keysum=99969378773436, performing 76219112 updates; total_prefilling_elapsed_ms=40 ms)
pref_size=10000000
pref_millis=40
prefill_elapsed_ms=40
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=220253.66883440
REALTIME_END_PERF_FORMAT=220263.66953168
###############################################################################
################################## 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 (64 threads)...
partitioned into 511 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.041s
tree_stats_numInternalsAtDepth=1 1 8 63 511 3720 28024 219658 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1729372
tree_stats_numNodesAtDepth=1 1 8 63 511 3720 28024 219658 1729372
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9995155
tree_stats_avgDegreeAtDepth=1 8 7.875 8.11111 7.27984 7.53333 7.83821 7.87302 5.77964
tree_stats_height=9
tree_stats_numInternals=251986
tree_stats_numLeaves=1729372
tree_stats_numNodes=1981358
tree_stats_numKeys=9995155
tree_stats_avgDegreeInternal=7.86297
tree_stats_avgDegreeLeaves=5.77964
tree_stats_avgDegree=6.0446
tree_stats_avgKeyDepth=8
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
[2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=708095
first_thread_announced_epoch_by_thread=26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344 26344
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=
sum_abtree_erase_repeat_total=
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=
sum_abtree_fix_weight_viol_attempt_total=
sum_abtree_fix_degree_viol_attempt_total=
sum_abtree_rebalancing_kcas_attempt_total=
sum_abtree_update_kcas_attempt_total=
sum_abtree_internal_complex_search_while_iters_total=
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=341041 340878 339992 338156 339755 341151 338312 336835 336502 334857 334616 334525 335432 339359 338754 338132 337302 337033 336159 337062 336286 332692 332864 332855 332966 332453 332181 337289 338238 337460 337602 337888 338213 339554 337148 334929 335903 335073 334372 333966 333854 339940 338386 338398 338366 338654 337595 337940 333943 333728 331667 330879 333631 332436 333540 336581 337556 337155 338333 336425 339345 338219 340148 340415
sum_num_inserts_total=21542919
sum_num_deletes_by_thread=342709 340582 340653 338502 340047 339307 337947 336474 336180 336162 334208 333329 335059 339420 338146 338826 339200 336880 336426 337939 336047 333460 332743 333410 332876 332694 331483 336867 338657 336867 337388 336143 338634 339562 336713 334871 336128 334993 333996 333170 334864 338224 338826 338638 337076 338101 338055 339779 335922 333921 332775 331833 331092 332339 331282 336241 337198 336246 337569 336333 339345 339098 339168 340550
sum_num_deletes_total=21539173
sum_num_searches_by_thread=6140406 6135106 6122555 6102923 6125277 6111264 6081696 6047187 6049669 6026854 6021408 6008315 6040022 6095263 6090470 6080350 6093650 6060470 6064038 6076050 6050112 5992173 6005791 5990973 5991841 5990244 5988347 6067508 6086452 6058777 6068469 6056289 6104943 6101232 6055108 6033197 6038612 6035471 6013827 6008950 6036702 6105875 6087819 6099550 6085992 6101182 6083804 6086407 6033079 5991264 5987007 5968779 5990396 5969625 5981758 6059536 6060002 6074173 6067618 6069760 6106964 6097965 6114610 6123650
sum_num_searches_total=387694806
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6824156 6816566 6803200 6779581 6805079 6791722 6757955 6720496 6722351 6697873 6690232 6676169 6710513 6774042 6767370 6757308 6770152 6734383 6736623 6751051 6722445 6658325 6671398 6657238 6657683 6655391 6652011 6741664 6763347 6733104 6743459 6730320 6781790 6780348 6728969 6702997 6710643 6705537 6682195 6676086 6705420 6784039 6765031 6776586 6761434 6777937 6759454 6764126 6702944 6658913 6651449 6631491 6655119 6634400 6646580 6732358 6734756 6747574 6743520 6742518 6785654 6775282 6793926 6804615
average_num_operations_total=6730889
stdev_num_operations_total=6389
sum_num_operations_total=430776898
min_num_operations_total=6631491
max_num_operations_total=6824156
first_time_thread_terminate_by_thread=10000113 10000069 10000069 10000071 10000071 10000071 10000071 10000071 10000071 10000071 10000071 10000071 10000069 10000069 10000069 10000069 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000073 10000074 10000074 10000074 10000074 10000071 10000071 10000071 10000071 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000069 10000069 10000069 10000069 10000070 10000070 10000070 10000070 10000073 10000073 10000073 10000073 10000071 10000071 10000071 10000071 10000070 10000070 10000070 10000071 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000069
max_time_thread_terminate_total=10000113
first_time_thread_start_by_thread=6 2 2 2 5 5 5 5 4 4 4 4 4 4 4 4 5 5 5 5 6 6 6 6 7 7 7 7 3 3 3 3 4 4 4 4 3 3 3 3 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 4 4 4 4 5 5 5 5
min_time_thread_start_total=2
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=99944832227884
threads_final_size=9995155
final_keysum=99944832227884
final_size=9995155
validate_result=success
Validation OK.
Structural validation OK.
total_find=387694806
total_rq=0
total_inserts=21542919
total_deletes=21539173
total_updates=43082092
total_queries=387694806
total_ops=430776898
find_throughput=38769480
rq_throughput=0
update_throughput=4308209
query_throughput=38769480
total_throughput=43077689
total find : 387694806
total rq : 0
total inserts : 21542919
total deletes : 21539173
total updates : 43082092
total queries : 387694806
total ops : 430776898
find throughput : 38769480
rq throughput : 0
update throughput : 4308209
query throughput : 38769480
total throughput : 43077689
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=1273803869309014
total_execution_walltime=15.409s
REALTIME_MAIN_END_PERF_FORMAT=220263.271697572
TL2 system shutdown:
GCLOCK=0x320D898 Starts=517105958 Aborts=10578576
Overflows: R=0 W=5858 L=0
[time_cmd_output] time_elapsed_sec=15.65, faults_major=1, faults_minor=852120, mem_maxresident_kb=2275472, user_cputime=918.82, sys_cputime=58.64, percent_cpu=6243%
timeout=false
algorithm=brown_abtree_tm_auto.debra.tl2
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1