__step=000492 __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.rhnorec_post -nwork 96 -nprefill 96 -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=data000492.txt __path_data=data/data000492.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000731.908764270 binary=./brown_sigouin_int_avl_tm_auto.debra.rhnorec_post 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=200000 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=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,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 RH noREC w/postfix htm system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.012s prefilling_size=81420 prefilling_elapsed_millis=1.001s prefilling_size=84814 prefilling_elapsed_millis=1.101s prefilling_size=87294 prefilling_elapsed_millis=1.201s prefilling_size=89324 prefilling_elapsed_millis=1.301s prefilling_size=91315 prefilling_elapsed_millis=1.402s prefilling_size=92788 prefilling_elapsed_millis=1.502s prefilling_size=94089 prefilling_elapsed_millis=1.602s prefilling_size=94972 prefilling_elapsed_millis=1.702s prefilling_size=95961 prefilling_elapsed_millis=1.802s prefilling_size=96561 prefilling_elapsed_millis=1.903s prefilling_size=97065 prefilling_elapsed_millis=2.003s prefilling_size=97607 prefilling_elapsed_millis=2.103s prefilling_size=98259 prefilling_elapsed_millis=2.203s finished prefilling to size 98263 for expected size 100000 keysum=9815913249, performing 784860 updates; total_prefilling_elapsed_ms=2304 ms) pref_size=98263 pref_millis=2304 prefill_elapsed_ms=2327 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000734.408677200 REALTIME_END_PERF_FORMAT=7000744.408808334 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.04s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4093 8062 14129 16731 8855 1291 15 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 3 118 1716 9299 18431 11261 1618 19 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8180 15845 26030 27286 12552 1633 19 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8180 15845 26030 27286 12552 1633 19 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.9978 1.95147 1.75109 1.40549 1.13549 1.02725 1.00245 1 tree_stats_height=20 tree_stats_numInternals=57271 tree_stats_numLeaves=42465 tree_stats_numNodes=99736 tree_stats_numKeys=99736 tree_stats_avgDegreeInternal=1.74147 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42577 tree_stats_avgKeyDepth=14.9239 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=52512 first_thread_announced_epoch_by_thread=1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 1112 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=32159058 sum_fasthtm_abort_total=68553090 sum_htmpostfix_commit_total=1656174 sum_htmpostfix_abort_total=8626997 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=52524630 sum_stmprefix_commit_total=690 sum_slow_commit_total=35482 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=16179 16571 16465 17197 16878 17152 16758 16828 17002 17877 17350 17855 16532 16960 16961 17148 16667 17429 16723 16593 16914 16429 17192 17879 16207 16693 16951 16978 17137 17343 16916 16884 16899 17845 17402 17806 16387 16590 16872 17129 17116 17688 16659 17046 16830 16664 17336 17679 17914 17807 17847 18084 18548 17721 18295 18347 18312 18573 18538 19088 18246 18403 17604 18224 18216 19114 17624 17171 18324 17634 18792 19236 17889 17690 17896 18220 18280 18144 18331 18412 18263 18619 18506 19136 18237 18126 17643 18285 18176 18884 17580 17667 18223 17940 18840 19217 sum_num_inserts_total=1692462 sum_num_deletes_by_thread=16263 16726 16746 17110 16955 17311 16422 16783 17181 17807 17377 17596 16656 16714 17042 17484 16767 17561 16684 16727 16846 16893 17482 17994 16425 16479 16771 17265 16926 17387 16663 16775 16700 17828 17498 18059 16546 16771 16740 17129 17342 17547 16864 16937 16838 16466 17276 17955 18117 17937 17849 17834 18422 18040 18147 18310 18502 18799 18380 19117 17832 18085 17862 18308 18206 18891 17620 17416 18030 18158 18566 19365 17856 17961 17876 18090 18508 18025 18112 18206 18323 18773 18535 19255 18153 18372 17646 18230 17971 18858 17534 17427 18419 17947 18671 19092 sum_num_deletes_total=1693947 sum_num_searches_by_thread=290682 298598 296496 308743 305817 307906 296361 302773 306285 325899 313351 319797 296830 303330 305034 310604 301152 317564 300964 301065 303160 303600 314904 322868 294679 299728 304893 307220 306942 311385 300681 301521 302719 321291 315525 323456 292940 298323 302750 310210 305777 316189 301431 306634 301971 300752 313130 321687 324556 317920 320178 322750 330989 321261 328097 329018 333050 335951 332347 341857 324050 328213 318314 328053 330733 339214 319368 311166 323830 322850 337261 345470 322987 323461 323619 329331 328045 326071 328158 328135 326839 335657 336471 345050 327047 328442 313905 329257 326570 339403 315187 313503 330912 321141 338717 344974 sum_num_searches_total=30464995 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=323124 331895 329707 343050 339650 342369 329541 336384 340468 361583 348078 355248 330018 337004 339037 345236 334586 352554 334371 334385 336920 336922 349578 358741 327311 332900 338615 341463 341005 346115 334260 335180 336318 356964 350425 359321 325873 331684 336362 344468 340235 351424 334954 340617 335639 333882 347742 357321 360587 353664 355874 358668 367959 357022 364539 365675 369864 373323 369265 380062 360128 364701 353780 364585 367155 377219 354612 345753 360184 358642 374619 384071 358732 359112 359391 365641 364833 362240 364601 364753 363425 373049 373512 383441 363437 364940 349194 365772 362717 377145 350301 348597 367554 357028 376228 383283 average_num_operations_total=352618 stdev_num_operations_total=1558 sum_num_operations_total=33851404 min_num_operations_total=323124 max_num_operations_total=384071 first_time_thread_terminate_by_thread=10000379 10000336 10000408 10000406 10000149 10000394 10000382 10000381 10000298 10000383 10000339 10000359 10000210 10000346 10000400 10000240 10000356 10000158 10000399 10000374 10000402 10000405 10000149 10000149 10000159 10000228 10000409 10000407 10000370 10000149 10000410 10000306 10000395 10000397 10000283 10000282 10000332 10000349 10000369 10000322 10000273 10000353 10000307 10000402 10000404 10000398 10000303 10000207 10000283 10000375 10000270 10000211 10000368 10000156 10000307 10000261 10000391 10000249 10000262 10000253 10000222 10000317 10000315 10000255 10000320 10000348 10000154 10000154 10000309 10000154 10000385 10000205 10000241 10000296 10000153 10000259 10000287 10000317 10000238 10000285 10000396 10000198 10000223 10000267 10000253 10000312 10000260 10000375 10000241 10000388 10000345 10000190 10000222 10000154 10000273 10000245 min_time_thread_terminate_total=10000149 max_time_thread_terminate_total=10000410 first_time_thread_start_by_thread=2 3 2 2 3 3 3 2 3 2 2 3 3 3 3 3 3 3 3 3 3 3 2 3 2 3 2 2 3 3 3 2 3 2 2 3 3 3 3 3 3 3 3 3 3 3 2 3 3 2 3 3 2 3 3 3 3 3 2 3 3 2 2 3 3 2 3 2 2 3 2 2 3 2 3 3 2 3 3 3 3 3 2 3 3 2 2 3 3 2 3 2 2 3 2 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9970898479 threads_final_size=99736 final_keysum=9970898479 final_size=99736 validate_result=success Validation OK. Structural validation OK. total_find=30464995 total_rq=0 total_inserts=1692462 total_deletes=1693947 total_updates=3386409 total_queries=30464995 total_ops=33851404 find_throughput=3046499 rq_throughput=0 update_throughput=338640 query_throughput=3046499 total_throughput=3385140 total find : 30464995 total rq : 0 total inserts : 1692462 total deletes : 1693947 total updates : 3386409 total queries : 30464995 total ops : 33851404 find throughput : 3046499 rq throughput : 0 update throughput : 338640 query throughput : 3046499 total throughput : 3385140 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=27.9887 PAPI_L3_TCM=6.29131 PAPI_TOT_CYC=70041.8 PAPI_TOT_INS=3688.65 garbage=1507416493437 total_execution_walltime=12.693s REALTIME_MAIN_END_PERF_FORMAT=7000744.603809097 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=12.83, faults_major=0, faults_minor=106693, mem_maxresident_kb=424360, user_cputime=1189.78, sys_cputime=19.05, percent_cpu=9418% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.rhnorec_post thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2