__step=000310
__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.hybridnorec -nwork 144 -nprefill 144 -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=data000310.txt
__path_data=data/data000310.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998470.984911892
binary=./brown_abtree_tm_auto.debra.hybridnorec
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=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167
Hybrid noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.036s
prefilling_size=219631 prefilling_elapsed_millis=1s
prefilling_size=238526 prefilling_elapsed_millis=1.101s
prefilling_size=257478 prefilling_elapsed_millis=1.201s
prefilling_size=275563 prefilling_elapsed_millis=1.301s
prefilling_size=293047 prefilling_elapsed_millis=1.401s
prefilling_size=310390 prefilling_elapsed_millis=1.501s
prefilling_size=327143 prefilling_elapsed_millis=1.602s
prefilling_size=343392 prefilling_elapsed_millis=1.702s
prefilling_size=359433 prefilling_elapsed_millis=1.802s
prefilling_size=375204 prefilling_elapsed_millis=1.902s
prefilling_size=390443 prefilling_elapsed_millis=2.003s
prefilling_size=405680 prefilling_elapsed_millis=2.103s
prefilling_size=420064 prefilling_elapsed_millis=2.203s
prefilling_size=434219 prefilling_elapsed_millis=2.303s
prefilling_size=447940 prefilling_elapsed_millis=2.403s
prefilling_size=461280 prefilling_elapsed_millis=2.504s
prefilling_size=474411 prefilling_elapsed_millis=2.604s
prefilling_size=487106 prefilling_elapsed_millis=2.704s
prefilling_size=499406 prefilling_elapsed_millis=2.804s
prefilling_size=511796 prefilling_elapsed_millis=2.904s
prefilling_size=523611 prefilling_elapsed_millis=3.005s
prefilling_size=535280 prefilling_elapsed_millis=3.105s
prefilling_size=546672 prefilling_elapsed_millis=3.205s
prefilling_size=557800 prefilling_elapsed_millis=3.305s
prefilling_size=568235 prefilling_elapsed_millis=3.406s
prefilling_size=578598 prefilling_elapsed_millis=3.506s
prefilling_size=588970 prefilling_elapsed_millis=3.606s
prefilling_size=598996 prefilling_elapsed_millis=3.706s
prefilling_size=608632 prefilling_elapsed_millis=3.807s
prefilling_size=617993 prefilling_elapsed_millis=3.907s
prefilling_size=627146 prefilling_elapsed_millis=4.007s
prefilling_size=635741 prefilling_elapsed_millis=4.107s
prefilling_size=644556 prefilling_elapsed_millis=4.207s
prefilling_size=652944 prefilling_elapsed_millis=4.308s
prefilling_size=661241 prefilling_elapsed_millis=4.408s
prefilling_size=669182 prefilling_elapsed_millis=4.508s
prefilling_size=677328 prefilling_elapsed_millis=4.608s
prefilling_size=685076 prefilling_elapsed_millis=4.709s
prefilling_size=692696 prefilling_elapsed_millis=4.809s
prefilling_size=700140 prefilling_elapsed_millis=4.909s
prefilling_size=707098 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 292812 keys with 144 threads...
tid=0 thread_prefill_amount=6940 percent_done_estimate=341.3 elapsed_s=6 est_remaining_s=-9 / -3
timing_elapsed 1.13463s
prefilling_size=1000000 prefilling_elapsed_millis=1.137s
finished prefilling to size 1000000 for expected size 1000000 keysum=999930808713, performing 2974798 updates; total_prefilling_elapsed_ms=1137 ms)
pref_size=1000000
pref_millis=1137
prefill_elapsed_ms=1137
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6998477.500162259
REALTIME_END_PERF_FORMAT=6998487.500281304
###############################################################################
################################## 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 (144 threads)...
partitioned into 2738 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.033s
tree_stats_numInternalsAtDepth=1 1 6 46 372 2738 21168 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 167079
tree_stats_numNodesAtDepth=1 1 6 46 372 2738 21168 167079
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1000750
tree_stats_avgDegreeAtDepth=1 6 7.66667 8.08696 7.36022 7.73119 7.893 5.98968
tree_stats_height=8
tree_stats_numInternals=24332
tree_stats_numLeaves=167079
tree_stats_numNodes=191411
tree_stats_numKeys=1000750
tree_stats_avgDegreeInternal=7.86664
tree_stats_avgDegreeLeaves=5.98968
tree_stats_avgDegree=6.22828
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=51648
first_thread_announced_epoch_by_thread=750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750 750
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=19638 19066 18832 18730 18889 18412 19661 19742 19032 19129 18971 18840 19947 19209 19021 18940 18545 18868 20145 19433 19548 19483 19233 19231 19510 18762 18879 18625 18388 18335 20081 19518 19170 19108 19019 18612 19739 19426 19138 18861 18739 18279 19921 19346 19687 19533 19309 19075 15763 15017 15046 15235 15066 15370 15933 15773 15319 15637 14883 14622 15754 15391 15422 15057 15180 15019 15685 15982 15598 15329 15339 15371 15908 14898 15288 15345 15310 14859 15786 15669 15435 15259 15078 15125 15744 14817 15268 15189 15378 14942 15604 15810 15421 15636 15653 15313 16959 15975 16236 16042 16743 16686 17125 16885 16504 16473 16181 16628 16976 16858 16434 16355 16488 16165 16964 16818 16819 16741 16424 16442 16615 15812 16071 16329 16953 16666 16643 16995 16379 16583 16120 16629 16940 16414 16545 16277 16321 16176 16889 16883 16907 16782 16634 16389
sum_num_inserts_total=2452004
sum_num_deletes_by_thread=19375 19111 18779 18505 18831 18720 19572 19937 18965 19263 19136 19026 20086 19377 18930 19014 18445 19027 19875 19310 19653 19470 18980 19028 19422 18468 18484 18620 18694 18502 20043 19301 19068 19433 19307 18817 19782 19339 19227 18897 18883 18275 19683 19441 19298 19307 19362 18922 15838 15038 14949 15424 15100 15480 15683 15702 15174 15506 14975 14740 16053 15356 15653 15162 15192 15128 15425 16014 15545 15335 15414 15615 15722 14655 15149 15250 15016 14916 16094 15216 15334 15301 15179 15112 16061 14650 15273 15092 15414 14926 15749 16027 15648 15679 15280 15452 16784 15961 16199 15984 16736 16671 17089 16978 16421 16237 16017 16589 17043 16813 16623 16122 16562 16154 16659 16956 16998 16607 16535 16478 17053 15797 15835 16375 16807 16798 16708 17082 16318 16648 15935 16458 16821 16367 16347 16150 16200 16236 17000 16847 16878 16742 16858 16233
sum_num_deletes_total=2450395
sum_num_searches_by_thread=353587 343202 335710 335001 340947 333945 355969 358296 342088 343553 341465 341281 360073 347925 343670 339833 331888 341317 361720 348421 354051 351012 347211 344955 349471 333670 339851 335923 335500 336325 360412 349899 344973 345724 344835 339466 356263 348947 350591 338049 336955 329176 356798 347060 349892 346920 344984 341259 285148 268738 270030 276562 273099 276393 284083 283070 275743 280581 266428 264548 287031 277652 279154 270909 274353 267994 281011 286844 279096 275354 276784 276035 283508 266139 274194 274478 272638 268156 288760 279378 276197 275591 273483 272182 287819 263871 270506 275844 278407 267977 280840 287431 280119 284767 274966 274639 302252 288745 290098 286910 304989 301325 304280 306229 296579 292097 288742 300656 309315 303394 296385 288715 299145 288346 305393 303019 304487 300197 298114 296208 304593 283829 286958 295339 305751 300505 300912 307053 295338 300509 291022 297208 304239 297087 298408 290872 293046 291785 303500 303864 305776 303217 302692 294331
sum_num_searches_total=44142047
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=392600 381379 373321 372236 378667 371077 395202 397975 380085 381945 379572 379147 400106 386511 381621 377787 368878 379212 401740 387164 393252 389965 385424 383214 388403 370900 377214 373168 372582 373162 400536 388718 383211 384265 383161 376895 395784 387712 388956 375807 374577 365730 396402 385847 388877 385760 383655 379256 316749 298793 300025 307221 303265 307243 315699 314545 306236 311724 296286 293910 318838 308399 310229 301128 304725 298141 312121 318840 310239 306018 307537 307021 315138 295692 304631 305073 302964 297931 320640 310263 306966 306151 303740 302419 319624 293338 301047 306125 309199 297845 312193 319268 311188 316082 305899 305404 335995 320681 322533 318936 338468 334682 338494 340092 329504 324807 320940 333873 343334 337065 329442 321192 332195 320665 339016 336793 338304 333545 331073 329128 338261 315438 318864 328043 339511 333969 334263 341130 328035 333740 323077 330295 338000 329868 331300 323299 325567 324197 337389 337594 339561 336741 336184 326953
average_num_operations_total=340586
stdev_num_operations_total=2743
sum_num_operations_total=49044446
min_num_operations_total=293338
max_num_operations_total=401740
first_time_thread_terminate_by_thread=10000215 10000414 10000408 10000178 10000118 10000435 10000270 10000366 10000167 10000364 10000419 10000443 10000277 10000436 10000338 10000446 10000450 10000446 10000118 10000431 10000176 10000429 10000125 10000406 10000413 10000417 10000228 10000179 10000397 10000240 10000398 10000210 10000395 10000360 10000434 10000163 10000449 10000433 10000280 10000445 10000400 10000444 10000242 10000119 10000272 10000325 10000214 10000404 10000332 10000121 10000437 10000388 10000422 10000259 10000122 10000340 10000202 10000343 10000390 10000391 10000438 10000373 10000394 10000410 10000283 10000425 10000182 10000351 10000193 10000424 10000389 10000300 10000329 10000257 10000226 10000207 10000347 10000182 10000439 10000330 10000285 10000401 10000296 10000316 10000441 10000186 10000298 10000356 10000448 10000336 10000423 10000355 10000440 10000442 10000370 10000334 10000117 10000128 10000119 10000263 10000385 10000117 10000220 10000190 10000302 10000379 10000143 10000250 10000136 10000310 10000197 10000133 10000383 10000121 10000260 10000117 10000289 10000156 10000139 10000375 10000158 10000223 10000244 10000234 10000304 10000312 10000169 10000218 10000376 10000378 10000247 10000427 10000231 10000318 10000292 10000266 10000381 10000123 10000308 10000322 10000199 10000371 10000149 10000145
min_time_thread_terminate_total=10000117
max_time_thread_terminate_total=10000450
first_time_thread_start_by_thread=8 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 5 5 5 4 4 4 5 4 5 4 4 4 4 4 4 4 4 4 4 5 5 5 4 5 5 5 5 5 4 4 5 4 5 4 4 4 4 4 4 4 4 4 4 5 5 5 4 5 5 5 5 5 4 4
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=1000744991301
threads_final_size=1000750
final_keysum=1000744991301
final_size=1000750
validate_result=success
Validation OK.
Structural validation OK.
total_find=44142047
total_rq=0
total_inserts=2452004
total_deletes=2450395
total_updates=4902399
total_queries=44142047
total_ops=49044446
find_throughput=4414204
rq_throughput=0
update_throughput=490239
query_throughput=4414204
total_throughput=4904444
total find : 44142047
total rq : 0
total inserts : 2452004
total deletes : 2450395
total updates : 4902399
total queries : 44142047
total ops : 49044446
find throughput : 4414204
rq throughput : 0
update throughput : 490239
query throughput : 4414204
total throughput : 4904444
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=25.9191
PAPI_L3_TCM=4.80282
PAPI_TOT_CYC=81518.9
PAPI_TOT_INS=7273.49
garbage=21775912273633
total_execution_walltime=16.672s
REALTIME_MAIN_END_PERF_FORMAT=6998487.657897505
Hybrid noREC system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 48562126
[slow htm]
[fallback]
total fallback commit : 3457119
seconds global lock is held : 0.403601
[time_cmd_output] time_elapsed_sec=16.81, faults_major=0, faults_minor=138218, mem_maxresident_kb=547740, user_cputime=2350.28, sys_cputime=6.72, percent_cpu=14018%
timeout=false
algorithm=brown_abtree_tm_auto.debra.hybridnorec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2