__step=000300
__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.norec -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=data000300.txt
__path_data=data/data000300.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998306.34621023
binary=./brown_abtree_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_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=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=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,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


noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.019s
prefilling_size=341873 prefilling_elapsed_millis=1.001s
prefilling_size=368775 prefilling_elapsed_millis=1.101s
prefilling_size=394745 prefilling_elapsed_millis=1.201s
prefilling_size=419674 prefilling_elapsed_millis=1.301s
prefilling_size=443614 prefilling_elapsed_millis=1.402s
prefilling_size=466916 prefilling_elapsed_millis=1.502s
prefilling_size=488589 prefilling_elapsed_millis=1.602s
prefilling_size=509872 prefilling_elapsed_millis=1.702s
prefilling_size=530094 prefilling_elapsed_millis=1.802s
prefilling_size=549304 prefilling_elapsed_millis=1.903s
prefilling_size=567486 prefilling_elapsed_millis=2.003s
prefilling_size=585527 prefilling_elapsed_millis=2.103s
prefilling_size=602642 prefilling_elapsed_millis=2.203s
prefilling_size=619209 prefilling_elapsed_millis=2.303s
prefilling_size=635272 prefilling_elapsed_millis=2.404s
prefilling_size=650420 prefilling_elapsed_millis=2.504s
prefilling_size=665035 prefilling_elapsed_millis=2.604s
prefilling_size=678476 prefilling_elapsed_millis=2.704s
prefilling_size=691727 prefilling_elapsed_millis=2.804s
prefilling_size=704105 prefilling_elapsed_millis=2.905s
prefilling_size=716318 prefilling_elapsed_millis=3.005s
prefilling_size=728065 prefilling_elapsed_millis=3.105s
prefilling_size=738993 prefilling_elapsed_millis=3.205s
prefilling_size=749570 prefilling_elapsed_millis=3.305s
prefilling_size=759493 prefilling_elapsed_millis=3.406s
prefilling_size=769027 prefilling_elapsed_millis=3.506s
prefilling_size=778209 prefilling_elapsed_millis=3.606s
prefilling_size=787114 prefilling_elapsed_millis=3.706s
prefilling_size=795591 prefilling_elapsed_millis=3.806s
prefilling_size=803748 prefilling_elapsed_millis=3.907s
prefilling_size=811745 prefilling_elapsed_millis=4.007s
prefilling_size=819529 prefilling_elapsed_millis=4.107s
prefilling_size=826711 prefilling_elapsed_millis=4.207s
prefilling_size=833749 prefilling_elapsed_millis=4.307s
prefilling_size=840680 prefilling_elapsed_millis=4.408s
prefilling_size=847082 prefilling_elapsed_millis=4.508s
prefilling_size=852918 prefilling_elapsed_millis=4.608s
prefilling_size=858912 prefilling_elapsed_millis=4.708s
prefilling_size=864658 prefilling_elapsed_millis=4.808s
prefilling_size=870216 prefilling_elapsed_millis=4.909s
prefilling_size=875474 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 124502 keys with 96 threads...
tid=0 thread_prefill_amount=8332 percent_done_estimate=642.5 elapsed_s=5 est_remaining_s=-10 / -5
timing_elapsed 0.295737s
prefilling_size=1000000 prefilling_elapsed_millis=0.296s
finished prefilling to size 1000000 for expected size 1000000 keysum=1000109659931, performing 4413051 updates; total_prefilling_elapsed_ms=296 ms)
pref_size=1000000
pref_millis=296
prefill_elapsed_ms=296
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6998311.660167695
REALTIME_END_PERF_FORMAT=6998321.660255644

###############################################################################
################################## 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 (96 threads)...
partitioned into 408 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.01s

tree_stats_numInternalsAtDepth=1 1 8 53 408 3019 23678 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 184973
tree_stats_numNodesAtDepth=1 1 8 53 408 3019 23678 184973
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999679
tree_stats_avgDegreeAtDepth=1 8 6.625 7.69811 7.39951 7.84299 7.81202 5.40446

tree_stats_height=8
tree_stats_numInternals=27168
tree_stats_numLeaves=184973
tree_stats_numNodes=212141
tree_stats_numKeys=999679

tree_stats_avgDegreeInternal=7.80849
tree_stats_avgDegreeLeaves=5.40446
tree_stats_avgDegree=5.71233
tree_stats_avgKeyDepth=7


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=145829
first_thread_announced_epoch_by_thread=3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154 3154
sum_commit_tx_reader_total=126507436
sum_commit_tx_reader_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1286729 1291901 1298791 1286961 1318903 1326501 1315061 1318950 1295736 1288495 1295603 1294460 1296950 1285557 1296734 1298143 1290007 1290204 1284366 1290000 1287362 1286396 1314858 1291903 1337991 1297371 1296369 1329818 1300471 1284080 1287097 1301628 1346661 1296184 1322889 1331528 1337139 1335582 1340392 1297501 1303212 1314318 1285993 1285506 1359460 1346833 1337554 1346682 1343445 1338660 1338369 1329681 1343015 1338192 1338217 1309143 1309678 1345767 1334998 1340158 1331631 1332256 1345350 1343646 1307047 1322625 1330770 1339881 1345621 1305472 1293792 1297615 1290741 1320809 1286409 1328858 1299989 1297795 1298013 1330099 1344980 1343653 1331751 1349617 1320942 1326228 1341414 1346698 1368281 1370450 1336871 1338749 1356927 1356593 1281950 1281760
sum_commit_tx_writer_total=6656591
sum_commit_tx_writer_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 67562 68225 68160 67463 69836 70034 68728 69391 68094 67227 68283 68385 68444 68164 68317 68610 67588 68186 68134 68631 67597 67504 69160 68356 70613 68204 67750 69836 68475 67992 67059 68386 71028 67949 69650 69740 70642 70384 70704 67845 68512 69447 68055 67676 71420 70591 71094 71136 70919 70755 70429 70193 70501 70254 70249 68438 68873 70621 70103 71011 70020 70446 70692 70499 69139 69946 70392 70487 70848 68492 67755 68577 67687 69615 67972 69503 68152 68321 68221 70088 70459 70732 69494 70609 69460 69490 70133 71123 71878 71928 70237 70805 71389 71102 67379 66908
sum_abort_tx_total=1292
sum_abort_tx_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 18 9 10 12 9 12 12 14 15 16 11 21 16 16 20 16 9 13 12 13 15 16 13 19 23 14 11 15 12 11 9 18 19 15 15 12 16 6 15 18 12 15 10 10 13 9 12 15 16 16 11 15 11 13 11 10 12 13 7 11 11 12 9 22 14 16 16 11 15 11 14 11 6 15 11 21 11 14 13 15 11 18 10 16 9 13 18 12 12 17 7 14 14 13 17 15
max_ht_capacity_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 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 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=32.7:1338 41.4:19629 50.1:47194 58.8:23875 67.5:3767 76.2:131 84.9:50 93.6:14 111:1
    [       24.00,        32.70]: 1338
    (       32.70,        41.40]: 19629
    (       41.40,        50.10]: 47194
    (       50.10,        58.80]: 23875
    (       58.80,        67.50]: 3767
    (       67.50,        76.20]: 131
    (       76.20,        84.90]: 50
    (       84.90,        93.60]: 14
    (      102.30,       111.00]: 1

linear_histogram_of_none_tx_wrset_size_full_data=24.6:92383 69.8:20 92.4:3133 137.6:407 182.8:52 228:4
    [        2.00,        24.60]: 92383
    (       47.20,        69.80]: 20
    (       69.80,        92.40]: 3133
    (      115.00,       137.60]: 407
    (      160.20,       182.80]: 52
    (      205.40,       228.00]: 4
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=67247 67003 67406 67475 68518 69558 68368 68195 68224 68160 67865 69840 67361 67596 68218 67450 67960 69699 67956 68039 68751 68244 68337 69156 67936 68170 67841 67630 68333 69182 68308 68249 67998 68190 67237 69813 68199 67345 68472 67811 68264 69394 68058 67838 68248 68517 68326 69576 69723 69012 70347 70500 70033 70877 70107 68975 70768 70444 70412 72010 70562 70518 70019 69649 70592 71022 70331 69153 70538 70944 70906 71440 69772 69589 70265 70266 70717 71111 70431 68665 70777 70690 70802 72228 70300 69953 70462 70462 70502 71530 70040 69643 70726 70791 70474 71248
sum_num_inserts_total=6655887
sum_num_deletes_by_thread=67106 67534 67656 67486 68302 69328 68135 67945 68477 68022 68102 69903 67520 67798 67874 67363 67752 69916 68130 67452 67334 68532 68608 69129 67473 68357 67779 67966 68672 68882 67821 67802 68473 68316 67650 69735 68053 68199 68288 67903 68784 69559 67931 68481 68121 68821 67729 69466 69536 68672 70437 70609 70440 70682 70433 68636 70624 70863 70531 72079 70100 70423 70006 70058 70516 70954 69710 69995 70536 71254 70706 71654 69390 69605 70292 70479 70368 70518 69966 68777 70827 70970 71500 71613 70312 70191 70206 70599 71024 71765 69988 69752 70907 70810 70313 71534
sum_num_deletes_total=6656825
sum_num_searches_by_thread=1214315 1214792 1219094 1218939 1229933 1249455 1227616 1232001 1229415 1230052 1218081 1256792 1222714 1217106 1224034 1219611 1229634 1249124 1215986 1220231 1227745 1232170 1228449 1245733 1218882 1223732 1218101 1219363 1229187 1245725 1228922 1228082 1222160 1229069 1218295 1258813 1222138 1218837 1233254 1222714 1234676 1251471 1225558 1227567 1230582 1236626 1226790 1244723 1256459 1238502 1266997 1272407 1260689 1278667 1267906 1239970 1274047 1274735 1270604 1298289 1259212 1268613 1259629 1261538 1267496 1275448 1261610 1253391 1275314 1275620 1272752 1285222 1251240 1253377 1265409 1267721 1269283 1276060 1264704 1241109 1272781 1272485 1275519 1296318 1268186 1266964 1259519 1270035 1274943 1287585 1262674 1261873 1269536 1267047 1268628 1284913
sum_num_searches_total=119851315
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1348668 1349329 1354156 1353900 1366753 1388341 1364119 1368141 1366116 1366234 1354048 1396535 1357595 1352500 1360126 1354424 1365346 1388739 1352072 1355722 1363830 1368946 1365394 1384018 1354291 1360259 1353721 1354959 1366192 1383789 1365051 1364133 1358631 1365575 1353182 1398361 1358390 1354381 1370014 1358428 1371724 1390424 1361547 1363886 1366951 1373964 1362845 1383765 1395718 1376186 1407781 1413516 1401162 1420226 1408446 1377581 1415439 1416042 1411547 1442378 1399874 1409554 1399654 1401245 1408604 1417424 1401651 1392539 1416388 1417818 1414364 1428316 1390402 1392571 1405966 1408466 1410368 1417689 1405101 1378551 1414385 1414145 1417821 1440159 1408798 1407108 1400187 1411096 1416469 1430880 1402702 1401268 1411169 1408648 1409415 1427695
average_num_operations_total=1387125
stdev_num_operations_total=2605
sum_num_operations_total=133164027
min_num_operations_total=1348668
max_num_operations_total=1442378
first_time_thread_terminate_by_thread=10000152 10000095 10000088 10000093 10000095 10000095 10000095 10000090 10000094 10000088 10000092 10000095 10000096 10000096 10000093 10000091 10000087 10000128 10000095 10000093 10000093 10000094 10000094 10000094 10000095 10000095 10000095 10000093 10000095 10000090 10000095 10000090 10000094 10000092 10000093 10000095 10000096 10000096 10000093 10000093 10000087 10000095 10000095 10000095 10000095 10000093 10000095 10000093 10000092 10000092 10000093 10000089 10000090 10000092 10000093 10000093 10000088 10000091 10000093 10000093 10000091 10000088 10000087 10000088 10000089 10000092 10000095 10000088 10000094 10000092 10000092 10000092 10000092 10000092 10000093 10000088 10000090 10000092 10000088 10000093 10000093 10000089 10000092 10000093 10000088 10000094 10000092 10000092 10000089 10000093 10000095 10000088 10000092 10000092 10000089 10000092
min_time_thread_terminate_total=10000087
max_time_thread_terminate_total=10000152
first_time_thread_start_by_thread=10 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 5 6 5 6 6 6 6 5 6 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 5 6 5 6 6 6 6 5 6 5 5 5 6 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=999580896109
threads_final_size=999679
final_keysum=999580896109
final_size=999679
validate_result=success
Validation OK.
Structural validation OK.

total_find=119851315
total_rq=0
total_inserts=6655887
total_deletes=6656825
total_updates=13312712
total_queries=119851315
total_ops=133164027
find_throughput=11985131
rq_throughput=0
update_throughput=1331271
query_throughput=11985131
total_throughput=13316402


total find                    : 119851315
total rq                      : 0
total inserts                 : 6655887
total deletes                 : 6656825
total updates                 : 13312712
total queries                 : 119851315
total ops                     : 133164027
find throughput               : 11985131
rq throughput                 : 0
update throughput             : 1331271
query throughput              : 11985131
total throughput              : 13316402

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=18.4155
PAPI_L3_TCM=2.36021
PAPI_TOT_CYC=17828
PAPI_TOT_INS=6774.2
garbage=58649683998660
total_execution_walltime=16.097s
REALTIME_MAIN_END_PERF_FORMAT=6998322.133404073
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=16.25, faults_major=0, faults_minor=137645, mem_maxresident_kb=548100, user_cputime=1461.18, sys_cputime=30.74, percent_cpu=9176%
timeout=false
algorithm=brown_abtree_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=2