__step=000257
__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_int_avl_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=data000257.txt
__path_data=data/data000257.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997647.228133413
binary=./brown_sigouin_int_avl_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_sigouin_int_avl_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=48
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.005s
prefilling_size=611342 prefilling_elapsed_millis=1.001s
prefilling_size=646355 prefilling_elapsed_millis=1.101s
prefilling_size=678094 prefilling_elapsed_millis=1.201s
prefilling_size=707750 prefilling_elapsed_millis=1.301s
prefilling_size=733839 prefilling_elapsed_millis=1.402s
prefilling_size=758291 prefilling_elapsed_millis=1.502s
prefilling_size=780719 prefilling_elapsed_millis=1.602s
prefilling_size=800514 prefilling_elapsed_millis=1.702s
prefilling_size=819031 prefilling_elapsed_millis=1.802s
prefilling_size=835745 prefilling_elapsed_millis=1.903s
prefilling_size=850494 prefilling_elapsed_millis=2.003s
prefilling_size=864221 prefilling_elapsed_millis=2.103s
prefilling_size=876547 prefilling_elapsed_millis=2.203s
prefilling_size=888735 prefilling_elapsed_millis=2.303s
prefilling_size=899016 prefilling_elapsed_millis=2.404s
prefilling_size=908431 prefilling_elapsed_millis=2.504s
prefilling_size=917105 prefilling_elapsed_millis=2.604s
prefilling_size=924446 prefilling_elapsed_millis=2.704s
prefilling_size=931769 prefilling_elapsed_millis=2.804s
prefilling_size=937620 prefilling_elapsed_millis=2.905s
prefilling_size=943605 prefilling_elapsed_millis=3.005s
prefilling_size=949043 prefilling_elapsed_millis=3.105s
prefilling_size=953650 prefilling_elapsed_millis=3.205s
prefilling_size=957874 prefilling_elapsed_millis=3.305s
prefilling_size=961366 prefilling_elapsed_millis=3.406s
prefilling_size=964623 prefilling_elapsed_millis=3.506s
prefilling_size=967904 prefilling_elapsed_millis=3.606s
prefilling_size=970629 prefilling_elapsed_millis=3.706s
prefilling_size=972784 prefilling_elapsed_millis=3.806s
prefilling_size=975341 prefilling_elapsed_millis=3.907s
prefilling_size=977560 prefilling_elapsed_millis=4.007s
prefilling_size=980487 prefilling_elapsed_millis=4.107s
finished prefilling to size 980473 for expected size 1000000 keysum=980507183711, performing 7942558 updates; total_prefilling_elapsed_ms=4208 ms)
pref_size=980473
pref_millis=4208
prefill_elapsed_ms=4232
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6997651.602361993
REALTIME_END_PERF_FORMAT=6997661.602508391
###############################################################################
################################## 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 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.039s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32761 64915 117944 158498 120771 42133 5098 87 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 7 548 10309 63256 149825 143097 53341 6437 109
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65463 128253 221754 270596 185230 58439 6524 109
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65463 128253 221754 270596 185230 58439 6524 109
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99799 1.96754 1.80942 1.50551 1.23821 1.08803 1.0244 1.00337 1
tree_stats_height=24
tree_stats_numInternals=574974
tree_stats_numLeaves=426929
tree_stats_numNodes=1001903
tree_stats_numKeys=1001903
tree_stats_avgDegreeInternal=1.74252
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42612
tree_stats_avgKeyDepth=18.3211
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=282336
first_thread_announced_epoch_by_thread=12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510 12510
sum_commit_tx_reader_total=122354061
sum_commit_tx_reader_by_thread=0 2539582 2527838 2507440 2532777 2588556 2551162 2584294 2547933 2545812 2550870 2532103 2556808 2496386 2539948 2536088 2563831 2543227 2588296 2585963 2533917 2522001 2581074 2530765 2563684 2553484 2517025 2648946 2526572 2564609 2538597 2554492 2567035 2540653 2507327 2531150 2541601 2499193 2555024 2561420 2601545 2558817 2542199 2520853 2541328 2545972 2579500 2525451 2580913
sum_commit_tx_writer_total=6434038
sum_commit_tx_writer_by_thread=0 133466 133182 132324 133679 135516 134394 135468 133920 133694 134484 133595 134750 131118 133987 133468 135092 133449 135967 135238 132952 132477 135701 133307 134803 134970 132991 139174 132723 133819 133498 134470 134869 133053 131784 133191 133829 131446 134309 134333 137333 134207 133317 133415 133099 134409 135824 132860 135084
sum_abort_tx_total=1477
sum_abort_tx_by_thread=0 34 30 21 35 25 32 24 32 26 27 38 26 33 27 23 34 28 24 29 35 32 27 28 39 35 42 20 30 29 42 37 26 39 25 28 38 24 28 31 23 36 29 41 32 32 29 32 40
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=18.3:7 26.6:92 34.9:1413 43.2:29771 51.5:15360 59.8:1057 68.1:257 76.4:39 84.7:3
[ 10.00, 18.30]: 7
( 18.30, 26.60]: 92
( 26.60, 34.90]: 1413
( 34.90, 43.20]: 29771
( 43.20, 51.50]: 15360
( 51.50, 59.80]: 1057
( 59.80, 68.10]: 257
( 68.10, 76.40]: 39
( 76.40, 84.70]: 3
linear_histogram_of_none_tx_wrset_size_full_data=3.7:14038 6.4:3383 9.1:12287 11.8:4929 14.5:9097 17.2:3147 19.9:377 22.6:632 25.3:107 28:2
[ 1.00, 3.70]: 14038
( 3.70, 6.40]: 3383
( 6.40, 9.10]: 12287
( 9.10, 11.80]: 4929
( 11.80, 14.50]: 9097
( 14.50, 17.20]: 3147
( 17.20, 19.90]: 377
( 19.90, 22.60]: 632
( 22.60, 25.30]: 107
( 25.30, 28.00]: 2
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=135036 134356 134146 132852 133661 133252 133453 134267 136021 134854 133360 133047 133189 135572 134534 135333 134168 134838 135442 133920 133903 135176 133290 131745 133708 133916 133756 139423 133770 132531 132199 133867 136046 135537 133236 134045 133565 134008 134568 134758 137131 133404 131763 133484 134733 136952 131336 133245
sum_num_inserts_total=6440396
sum_num_deletes_by_thread=134282 134811 134499 132692 133259 133444 132891 134553 135673 135447 132924 133086 132857 135196 134479 134822 134398 134481 136615 133341 134204 136151 133645 131023 134182 133515 133676 139471 133148 132619 131909 134653 135264 135829 132343 133517 133363 134419 134186 134552 136939 133466 131381 133524 134107 135207 132085 132673
sum_num_deletes_total=6434801
sum_num_searches_by_thread=2429110 2419795 2411736 2393751 2406128 2399002 2391967 2422738 2449507 2431603 2400585 2397939 2388222 2445229 2416341 2428768 2413287 2419135 2452206 2408255 2411399 2448435 2397406 2364736 2406045 2409245 2406274 2509226 2402638 2384866 2375656 2427233 2444014 2445409 2388899 2407868 2399528 2424597 2416802 2429177 2464808 2407557 2367495 2405087 2420493 2451913 2375690 2395102
sum_num_searches_total=115912902
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2698428 2688962 2680381 2659295 2673048 2665698 2658311 2691558 2721201 2701904 2666869 2664072 2654268 2715997 2685354 2698923 2681853 2688454 2724263 2675516 2679506 2719762 2664341 2627504 2673935 2676676 2673706 2788120 2669556 2650016 2639764 2695753 2715324 2716775 2654478 2675430 2666456 2693024 2685556 2698487 2738878 2674427 2630639 2672095 2689333 2724072 2639111 2661020
average_num_operations_total=2683085
stdev_num_operations_total=4336
sum_num_operations_total=128788099
min_num_operations_total=2627504
max_num_operations_total=2788120
first_time_thread_terminate_by_thread=10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000146 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000146 10000147 10000147 10000147 10000147 10000147
min_time_thread_terminate_total=10000146
max_time_thread_terminate_total=10000148
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=1002735912000
threads_final_size=1001903
final_keysum=1002735912000
final_size=1001903
validate_result=success
Validation OK.
Structural validation OK.
total_find=115912902
total_rq=0
total_inserts=6440396
total_deletes=6434801
total_updates=12875197
total_queries=115912902
total_ops=128788099
find_throughput=11591290
rq_throughput=0
update_throughput=1287519
query_throughput=11591290
total_throughput=12878809
total find : 115912902
total rq : 0
total inserts : 6440396
total deletes : 6434801
total updates : 12875197
total queries : 115912902
total ops : 128788099
find throughput : 11591290
rq throughput : 0
update throughput : 1287519
query throughput : 11591290
total throughput : 12878809
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=16.9725
PAPI_L3_TCM=1.58351
PAPI_TOT_CYC=8755.58
PAPI_TOT_INS=5879.03
garbage=57806702122064
total_execution_walltime=14.665s
REALTIME_MAIN_END_PERF_FORMAT=6997661.894041208
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=14.83, faults_major=0, faults_minor=143873, mem_maxresident_kb=577072, user_cputime=684.30, sys_cputime=29.79, percent_cpu=4814%
timeout=false
algorithm=brown_sigouin_int_avl_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