__step=000526
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000526.txt
__path_data=data/data000526.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7001147.464133342
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=200000
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.048s
prefilling_size=91289 prefilling_elapsed_millis=1s
prefilling_size=93278 prefilling_elapsed_millis=1.101s
prefilling_size=94765 prefilling_elapsed_millis=1.201s
prefilling_size=96011 prefilling_elapsed_millis=1.301s
prefilling_size=97016 prefilling_elapsed_millis=1.401s
prefilling_size=97660 prefilling_elapsed_millis=1.501s
prefilling_size=98167 prefilling_elapsed_millis=1.601s
finished prefilling to size 98182 for expected size 100000 keysum=9803921184, performing 772292 updates; total_prefilling_elapsed_ms=1704 ms)
pref_size=98182
pref_millis=1704
prefill_elapsed_ms=1724
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7001149.466320554
REALTIME_END_PERF_FORMAT=7001159.466456815

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

tree_stats_computeWalltime=0.052s

tree_stats_numInternalsAtDepth=1 1 6 45 343 2683 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19645
tree_stats_numNodesAtDepth=1 1 6 45 343 2683 19645
tree_stats_numKeysAtDepth=0 0 0 0 0 0 100137
tree_stats_avgDegreeAtDepth=1 6 7.5 7.62222 7.82216 7.32203 5.09733

tree_stats_height=7
tree_stats_numInternals=3079
tree_stats_numLeaves=19645
tree_stats_numNodes=22724
tree_stats_numKeys=100137

tree_stats_avgDegreeInternal=7.38032
tree_stats_avgDegreeLeaves=5.09733
tree_stats_avgDegree=5.40666
tree_stats_avgKeyDepth=6


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=60336
first_thread_announced_epoch_by_thread=848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848 848
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=15894 15126 14652 14879 14563 14551 16298 15701 14882 14868 15210 14939 16578 15121 15243 15006 14567 14938 16555 15426 14907 15331 14757 14865 16074 15332 14912 14819 14526 14249 16329 15488 15089 15011 15016 14895 16479 15346 15012 14913 14271 14876 16534 15527 15213 15470 14991 14908 24474 22332 21896 22066 21477 21903 24495 22616 22357 22001 21862 22061 24777 22537 22382 22350 21825 21847 24871 22792 22543 22654 22140 22097 24308 22438 21609 22008 21503 22035 24269 23084 22473 21860 21933 21654 24751 22288 22323 22254 21522 21809 24993 22722 22614 22314 21858 22356 12824 11869 11820 11633 11731 11746 13196 12208 11733 11654 11430 11651 12866 11910 11803 11817 11681 11645 13294 11911 11936 12099 11543 11396 12626 11487 11772 11819 11703 11561 12847 12157 11805 11728 11448 11652 13051 11844 12067 11641 11501 11608 12989 11748 12100 12080 11760 11609
sum_num_inserts_total=2387469
sum_num_deletes_by_thread=16380 15272 14776 14706 14617 14577 16425 15778 14908 15378 15212 14897 16633 15217 15263 15093 14675 14779 16546 15576 14941 15547 14874 14860 16509 15009 14751 15020 14622 14538 16481 15254 14823 15209 15250 15246 16468 15271 14943 14546 14403 14768 16690 15448 15125 15136 15076 15095 24198 22014 22114 22088 21291 21778 24453 22803 22418 22147 21968 22079 24795 22280 22396 22082 21714 21945 25056 23176 22363 22679 22115 21834 24070 22266 21866 22060 21461 21909 24389 23042 22509 21971 21960 22016 24987 22251 22454 21782 21576 21737 24594 22614 22609 22567 21837 22114 12791 11907 11924 11879 11927 11734 13150 11855 11878 11755 11604 11397 12788 11991 11722 11939 11564 11769 12990 11802 11909 11975 11516 11540 12620 11711 11547 11974 11689 11829 13202 12237 11686 11793 11553 11642 12812 11830 11825 11878 11540 11469 13157 11652 11980 11873 11607 11590
sum_num_deletes_total=2389040
sum_num_searches_by_thread=291366 271630 263094 267413 262464 261279 295217 284063 267771 274360 273522 269859 299670 273912 271122 268948 263184 269406 297779 278591 265968 277686 267442 268716 291096 273347 269011 266182 267005 261314 294887 275716 267422 273861 275568 270019 295630 273778 269748 268708 258515 266563 298656 278194 275126 276645 271610 271209 438852 398144 398499 398950 384875 391345 442877 408084 400528 395335 394129 396816 446202 405007 399877 399572 392543 394180 448818 412679 405021 403720 397438 393737 437593 405727 392602 397498 388624 394310 437207 412118 404240 396830 396816 392391 443876 400185 402872 398095 389856 393295 444665 407647 409316 404991 391569 402303 233402 213750 211707 211173 214095 211378 239289 216421 211516 210621 207642 204148 231729 214982 211983 214771 210917 210041 233575 210762 215543 217612 208082 204930 228920 208135 208789 214594 211812 208951 236259 220187 211121 210464 206446 209067 233375 216159 216588 211482 206910 209036 234740 208615 215659 214644 211939 209929
sum_num_searches_total=43000016
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=323640 302028 292522 296998 291644 290407 327940 315542 297561 304606 303944 299695 332881 304250 301628 299047 292426 299123 330880 309593 295816 308564 297073 298441 323679 303688 298674 296021 296153 290101 327697 306458 297334 304081 305834 300160 328577 304395 299703 298167 287189 296207 331880 309169 305464 307251 301677 301212 487524 442490 442509 443104 427643 435026 491825 453503 445303 439483 437959 440956 495774 449824 444655 444004 436082 437972 498745 458647 449927 449053 441693 437668 485971 450431 436077 441566 431588 438254 485865 458244 449222 440661 440709 436061 493614 444724 447649 442131 432954 436841 494252 452983 454539 449872 435264 446773 259017 237526 235451 234685 237753 234858 265635 240484 235127 234030 230676 227196 257383 238883 235508 238527 234162 233455 259859 234475 239388 241686 231141 227866 254166 231333 232108 238387 235204 232341 262308 244581 234612 233985 229447 232361 259238 239833 240480 235001 229951 232113 260886 232015 239739 238597 235306 233128
average_num_operations_total=331781
stdev_num_operations_total=7531
sum_num_operations_total=47776525
min_num_operations_total=227196
max_num_operations_total=498745
first_time_thread_terminate_by_thread=10000224 10000459 10000517 10000430 10000216 10000482 10000464 10000421 10000468 10000470 10000520 10000465 10000341 10000407 10000136 10000475 10000384 10000365 10000209 10000515 10000145 10000302 10000458 10000309 10000222 10000326 10000415 10000433 10000473 10000519 10000486 10000484 10000232 10000488 10000460 10000404 10000145 10000358 10000521 10000419 10000229 10000213 10000208 10000516 10000363 10000304 10000522 10000227 10000345 10000378 10000247 10000454 10000182 10000240 10000253 10000177 10000535 10000160 10000330 10000436 10000316 10000438 10000237 10000451 10000334 10000375 10000539 10000251 10000540 10000409 10000533 10000135 10000184 10000543 10000332 10000529 10000235 10000196 10000435 10000367 10000338 10000370 10000174 10000320 10000449 10000442 10000191 10000512 10000314 10000203 10000532 10000337 10000322 10000400 10000324 10000531 10000356 10000154 10000444 10000394 10000275 10000263 10000478 10000388 10000494 10000286 10000280 10000504 10000167 10000525 10000392 10000403 10000479 10000527 10000134 10000507 10000272 10000510 10000427 10000267 10000354 10000199 10000444 10000258 10000528 10000429 10000509 10000491 10000540 10000523 10000541 10000514 10000499 10000351 10000536 10000502 10000292 10000526 10000497 10000297 10000524 10000501 10000140 10000135
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000543
first_time_thread_start_by_thread=4 5 5 4 4 5 5 4 4 5 4 4 4 4 5 4 4 5 4 4 4 5 4 4 4 5 5 4 4 5 5 4 4 5 4 4 4 4 5 4 4 5 4 4 4 5 4 4 4 5 5 5 5 4 5 4 4 5 5 5 5 4 4 4 4 4 4 5 4 5 5 5 4 5 5 5 5 4 5 4 4 5 5 5 5 4 4 4 4 4 4 5 4 5 5 5 5 4 5 4 4 5 5 5 5 5 5 4 4 4 5 4 5 4 5 5 4 5 5 4 5 4 5 4 4 5 5 5 5 5 5 4 4 4 5 4 5 4 5 5 4 5 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=10022703897
threads_final_size=100137
final_keysum=10022703897
final_size=100137
validate_result=success
Validation OK.
Structural validation OK.

total_find=43000016
total_rq=0
total_inserts=2387469
total_deletes=2389040
total_updates=4776509
total_queries=43000016
total_ops=47776525
find_throughput=4300001
rq_throughput=0
update_throughput=477650
query_throughput=4300001
total_throughput=4777652


total find                    : 43000016
total rq                      : 0
total inserts                 : 2387469
total deletes                 : 2389040
total updates                 : 4776509
total queries                 : 43000016
total ops                     : 47776525
find throughput               : 4300001
rq throughput                 : 0
update throughput             : 477650
query throughput              : 4300001
total throughput              : 4777652

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=21.4141
PAPI_L3_TCM=3.80568
PAPI_TOT_CYC=83699.1
PAPI_TOT_INS=7014.37
garbage=2144955561819
total_execution_walltime=12.203s
REALTIME_MAIN_END_PERF_FORMAT=7001159.667965939
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 46073802
[slow htm]
[fallback]
total fallback commit         : 2475016
seconds global lock is held   : 0.202264
[time_cmd_output] time_elapsed_sec=12.34, faults_major=0, faults_minor=97379, mem_maxresident_kb=381840, user_cputime=1712.26, sys_cputime=5.05, percent_cpu=13912%
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