__step=000217
__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_int_bst_tm_auto.debra.norec -nwork 48 -nprefill 48 -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=data000217.txt
__path_data=data/data000217.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997056.581296095
binary=./brown_int_bst_tm_auto.debra.norec
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_int_bst_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=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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=32
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
noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.008s
prefilling_size=606506 prefilling_elapsed_millis=1.001s
prefilling_size=641925 prefilling_elapsed_millis=1.101s
prefilling_size=674021 prefilling_elapsed_millis=1.201s
prefilling_size=703464 prefilling_elapsed_millis=1.301s
prefilling_size=729844 prefilling_elapsed_millis=1.402s
prefilling_size=753894 prefilling_elapsed_millis=1.502s
prefilling_size=775738 prefilling_elapsed_millis=1.602s
prefilling_size=796008 prefilling_elapsed_millis=1.702s
prefilling_size=814134 prefilling_elapsed_millis=1.802s
prefilling_size=830943 prefilling_elapsed_millis=1.903s
prefilling_size=846139 prefilling_elapsed_millis=2.003s
prefilling_size=860451 prefilling_elapsed_millis=2.103s
prefilling_size=873240 prefilling_elapsed_millis=2.203s
prefilling_size=884476 prefilling_elapsed_millis=2.303s
prefilling_size=894645 prefilling_elapsed_millis=2.404s
prefilling_size=903458 prefilling_elapsed_millis=2.504s
prefilling_size=911724 prefilling_elapsed_millis=2.604s
prefilling_size=919949 prefilling_elapsed_millis=2.704s
prefilling_size=927451 prefilling_elapsed_millis=2.804s
prefilling_size=934028 prefilling_elapsed_millis=2.904s
prefilling_size=939980 prefilling_elapsed_millis=3.005s
prefilling_size=945243 prefilling_elapsed_millis=3.105s
prefilling_size=950105 prefilling_elapsed_millis=3.205s
prefilling_size=954574 prefilling_elapsed_millis=3.305s
prefilling_size=958840 prefilling_elapsed_millis=3.405s
prefilling_size=962733 prefilling_elapsed_millis=3.506s
prefilling_size=966228 prefilling_elapsed_millis=3.606s
prefilling_size=969292 prefilling_elapsed_millis=3.706s
prefilling_size=972378 prefilling_elapsed_millis=3.806s
prefilling_size=974527 prefilling_elapsed_millis=3.907s
prefilling_size=976605 prefilling_elapsed_millis=4.007s
prefilling_size=978787 prefilling_elapsed_millis=4.107s
prefilling_size=980710 prefilling_elapsed_millis=4.207s
finished prefilling to size 980713 for expected size 1000000 keysum=979888758047, performing 7958475 updates; total_prefilling_elapsed_ms=4308 ms)
pref_size=980713
pref_millis=4308
prefill_elapsed_ms=4326
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=368
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6997061.84338950
REALTIME_END_PERF_FORMAT=6997071.84477456
###############################################################################
################################## 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 963 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.03s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 253 494 935 1687 2963 5052 8091 12235 17731 24417 31659 39296 46976 53219 57006 57666 55819 51456 45028 37718 30266 23289 17177 12251 8410 5567 3545 2156 1206 618 294 118 42 22 10 4 3 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 9 28 107 215 469 1096 2163 3682 5934 9280 12934 17053 21793 26377 29812 31560 31689 30296 27455 23521 19424 15326 11605 8335 5835 3930 2588 1571 929 492 249 97 29 16 7 3 2 0 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 254 503 963 1794 3178 5521 9187 14398 21413 30351 40939 52230 64029 75012 83383 87478 87379 83145 75324 65173 53787 42713 32503 23856 16745 11402 7475 4744 2777 1547 786 367 139 51 26 11 6 3 1 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 254 503 963 1794 3178 5521 9187 14398 21413 30351 40939 52230 64029 75012 83383 87478 87379 83145 75324 65173 53787 42713 32503 23856 16745 11402 7475 4744 2777 1547 786 367 139 51 26 11 6 3 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 2 1.98425 1.93241 1.892 1.8311 1.80491 1.74896 1.68651 1.63745 1.58936 1.54436 1.50248 1.47354 1.43786 1.40212 1.36545 1.33966 1.31273 1.28706 1.26744 1.24656 1.23141 1.21572 1.20549 1.18838 1.17868 1.16734 1.1604 1.1309 1.12279 1.1086 1.09288 1.05722 1.06475 1.07843 1.03846 1.18182 1 1 2 1
tree_stats_height=48
tree_stats_numInternals=654935
tree_stats_numLeaves=345914
tree_stats_numNodes=1000849
tree_stats_numKeys=1000849
tree_stats_avgDegreeInternal=1.52817
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34562
tree_stats_avgKeyDepth=23.6586
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=6365
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:32 2:929 4:31257 8:221882 16:33655
[2^00, 2^01]: 32
(2^01, 2^02]: 929
(2^02, 2^03]: 31257
(2^03, 2^04]: 221882
(2^04, 2^05]: 33655
sum_limbo_reclamation_event_size_total=3299024
count_limbo_reclamation_event_size_by_thread=5995 5995 5994 5995 5994 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5994 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5994 5995 5994 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995 5995
count_limbo_reclamation_event_size_total=287755
sum_limbo_reclamation_event_count_total=287856
first_thread_announced_epoch_by_thread=12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730 12730
sum_commit_tx_reader_total=125945007
sum_commit_tx_reader_by_thread=0 2603951 2625438 2625845 2587116 2616261 2620898 2615052 2611820 2620425 2640278 2630014 2639554 2571979 2630394 2602369 2649870 2626565 2627554 2614334 2583991 2639889 2637630 2602808 2655385 2660519 2626393 2624347 2659128 2608824 2651060 2599637 2628609 2630356 2624427 2617471 2637707 2615662 2623741 2624952 2631783 2626773 2615934 2633333 2625707 2597226 2650404 2584889 2666705
sum_commit_tx_writer_total=6621150
sum_commit_tx_writer_by_thread=0 137440 138002 137653 135848 137584 138001 137450 137001 137621 138754 137932 138650 135195 138557 137001 139179 138490 138443 137641 135286 138902 138263 136277 138999 139957 137999 137863 139307 137431 139480 136555 138263 137806 138003 137405 138853 137966 137465 138497 138470 138190 137817 138314 138553 136889 139864 135873 140161
sum_abort_tx_total=1732
sum_abort_tx_by_thread=0 44 43 48 43 42 34 32 37 32 42 42 34 32 41 37 39 48 42 44 33 23 37 34 30 40 36 29 31 33 30 29 33 28 41 34 28 32 43 34 31 29 33 49 37 34 33 31 41
max_ht_capacity_by_thread=0 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048
linear_histogram_of_none_tx_rdset_size_full_data=21.4:10 28.8:176 36.2:1835 43.6:5216 51:13892 58.4:15684 65.8:7215 73.2:3325 80.6:601 88:43
[ 14.00, 21.40]: 10
( 21.40, 28.80]: 176
( 28.80, 36.20]: 1835
( 36.20, 43.60]: 5216
( 43.60, 51.00]: 13892
( 51.00, 58.40]: 15684
( 58.40, 65.80]: 7215
( 65.80, 73.20]: 3325
( 73.20, 80.60]: 601
( 80.60, 88.00]: 43
linear_histogram_of_none_tx_wrset_size_full_data=1.4:15461 3.4:8194
[ 1.00, 1.40]: 15461
( 3.00, 3.40]: 8194
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=137935 136889 138228 138339 139288 136988 138883 138275 138306 138824 138119 138126 137544 140613 138315 140089 138969 135978 137080 139281 139043 137594 137341 135559 136657 137263 137607 137779 139412 136220 137409 137789 138551 139547 137815 138292 137802 138072 138892 138369 137822 137660 135489 136685 138671 138716 137583 136386
sum_num_inserts_total=6622094
sum_num_deletes_by_thread=138392 136924 138836 138396 140156 136713 138399 138202 138359 139104 137649 138168 137784 140294 138503 138888 140018 136017 136814 138978 140217 138032 137093 135463 137462 138145 138352 137875 138997 136336 137839 137890 139150 139866 138124 138279 137311 138164 138402 138549 138195 137706 135405 136779 138589 138181 137861 137007
sum_num_deletes_total=6627863
sum_num_searches_by_thread=2490545 2462379 2491098 2501469 2518991 2465669 2491669 2487915 2488390 2516456 2483131 2487155 2488170 2525959 2488145 2510072 2511553 2448767 2472361 2500532 2511008 2478125 2466957 2448255 2474702 2477094 2482087 2492292 2500623 2450408 2478597 2486531 2498859 2521063 2477689 2489426 2476862 2487204 2494353 2487342 2486413 2479510 2436280 2465621 2498633 2493356 2485762 2460722
sum_num_searches_total=119316200
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2766872 2736192 2768162 2778204 2798435 2739370 2768951 2764392 2765055 2794384 2758899 2763449 2763498 2806866 2764963 2789049 2790540 2720762 2746255 2778791 2790268 2753751 2741391 2719277 2748821 2752502 2758046 2767946 2779032 2722964 2753845 2762210 2776560 2800476 2753628 2765997 2751975 2763440 2771647 2764260 2762430 2754876 2707174 2739085 2775893 2770253 2761206 2734115
average_num_operations_total=2761794
stdev_num_operations_total=3131
sum_num_operations_total=132566157
min_num_operations_total=2707174
max_num_operations_total=2806866
first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000139 10000138 10000138 10000138
min_time_thread_terminate_total=10000138
max_time_thread_terminate_total=10000139
first_time_thread_start_by_thread=7 7 6 7 7 6 7 7 7 6 6 6 6 6 6 7 6 6 7 7 6 6 6 7 7 7 6 7 7 6 7 7 7 6 6 6 6 6 6 7 6 6 7 7 6 6 6 7
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=1001136727886
threads_final_size=1000849
final_keysum=1001136727886
final_size=1000849
validate_result=success
Validation OK.
Structural validation OK.
total_find=119316200
total_rq=0
total_inserts=6622094
total_deletes=6627863
total_updates=13249957
total_queries=119316200
total_ops=132566157
find_throughput=11931620
rq_throughput=0
update_throughput=1324995
query_throughput=11931620
total_throughput=13256615
total find : 119316200
total rq : 0
total inserts : 6622094
total deletes : 6627863
total updates : 13249957
total queries : 119316200
total ops : 132566157
find throughput : 11931620
rq throughput : 0
update throughput : 1324995
query throughput : 11931620
total throughput : 13256615
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=13.6013
PAPI_L3_TCM=0.235177
PAPI_TOT_CYC=8458.7
PAPI_TOT_INS=6527.56
garbage=59472141147599
total_execution_walltime=14.819s
REALTIME_MAIN_END_PERF_FORMAT=6997071.401267884
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=14.95, faults_major=0, faults_minor=84685, mem_maxresident_kb=340684, user_cputime=686.74, sys_cputime=30.08, percent_cpu=4794%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.norec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1