__step=000275 __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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000275.txt __path_data=data/data000275.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6997943.124137333 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=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=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=145255 prefilling_elapsed_millis=1.001s prefilling_size=159349 prefilling_elapsed_millis=1.101s prefilling_size=173185 prefilling_elapsed_millis=1.201s prefilling_size=186911 prefilling_elapsed_millis=1.301s prefilling_size=200338 prefilling_elapsed_millis=1.402s prefilling_size=213619 prefilling_elapsed_millis=1.502s prefilling_size=226473 prefilling_elapsed_millis=1.602s prefilling_size=239387 prefilling_elapsed_millis=1.702s prefilling_size=251973 prefilling_elapsed_millis=1.802s prefilling_size=264319 prefilling_elapsed_millis=1.903s prefilling_size=276558 prefilling_elapsed_millis=2.003s prefilling_size=288413 prefilling_elapsed_millis=2.103s prefilling_size=300406 prefilling_elapsed_millis=2.203s prefilling_size=311944 prefilling_elapsed_millis=2.303s prefilling_size=323301 prefilling_elapsed_millis=2.404s prefilling_size=334489 prefilling_elapsed_millis=2.504s prefilling_size=345577 prefilling_elapsed_millis=2.604s prefilling_size=356493 prefilling_elapsed_millis=2.704s prefilling_size=367223 prefilling_elapsed_millis=2.804s prefilling_size=377961 prefilling_elapsed_millis=2.905s prefilling_size=388440 prefilling_elapsed_millis=3.005s prefilling_size=398848 prefilling_elapsed_millis=3.105s prefilling_size=408833 prefilling_elapsed_millis=3.205s prefilling_size=418663 prefilling_elapsed_millis=3.305s prefilling_size=428651 prefilling_elapsed_millis=3.406s prefilling_size=438286 prefilling_elapsed_millis=3.506s prefilling_size=447730 prefilling_elapsed_millis=3.606s prefilling_size=457097 prefilling_elapsed_millis=3.706s prefilling_size=466311 prefilling_elapsed_millis=3.806s prefilling_size=475383 prefilling_elapsed_millis=3.907s prefilling_size=484169 prefilling_elapsed_millis=4.007s prefilling_size=492811 prefilling_elapsed_millis=4.107s prefilling_size=501316 prefilling_elapsed_millis=4.207s prefilling_size=509753 prefilling_elapsed_millis=4.307s prefilling_size=517948 prefilling_elapsed_millis=4.408s prefilling_size=526284 prefilling_elapsed_millis=4.508s prefilling_size=534202 prefilling_elapsed_millis=4.608s prefilling_size=542012 prefilling_elapsed_millis=4.708s prefilling_size=549692 prefilling_elapsed_millis=4.808s prefilling_size=557230 prefilling_elapsed_millis=4.909s prefilling_size=564693 prefilling_elapsed_millis=5.009s Info: prefilling requires an additional insert phase to complete. Info: prefilling using INSERTION ONLY. timing_start inserting 435270 keys with 96 threads... tid=0 thread_prefill_amount=8332 percent_done_estimate=183.8 elapsed_s=6 est_remaining_s=-6 / -0 tid=0 thread_prefill_amount=10415 percent_done_estimate=229.7 elapsed_s=8 est_remaining_s=-10 / -2 timing_elapsed 2.55243s prefilling_size=1000000 prefilling_elapsed_millis=2.558s finished prefilling to size 1000000 for expected size 1000000 keysum=1000557924000, performing 2404322 updates; total_prefilling_elapsed_ms=2558 ms) pref_size=1000000 pref_millis=2558 prefill_elapsed_ms=2558 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6997950.992163586 REALTIME_END_PERF_FORMAT=6997960.992346549 ############################################################################### ################################## 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 512 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.01s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32759 65010 118935 161093 120319 38032 3980 48 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 8 460 9675 62824 154669 144351 48229 4991 56 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65470 128610 223917 274988 182383 52209 5039 56 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65470 128610 223917 274988 182383 52209 5039 56 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99994 1.99829 1.97144 1.81628 1.50865 1.2257 1.07773 1.02028 1.00159 1 tree_stats_height=24 tree_stats_numInternals=572943 tree_stats_numLeaves=425263 tree_stats_numNodes=998206 tree_stats_numKeys=998206 tree_stats_avgDegreeInternal=1.74224 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42603 tree_stats_avgKeyDepth=18.2957 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=59032 first_thread_announced_epoch_by_thread=1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 1298 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=36599703 sum_fasthtm_abort_total=78284711 sum_htmpostfix_commit_total=1899464 sum_htmpostfix_abort_total=7000155 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=45409697 sum_stmprefix_commit_total=95 sum_slow_commit_total=25268 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=21234 20894 21329 21588 19384 21992 21171 20867 21094 21356 18887 22048 20912 21373 21228 21506 19002 22346 20768 21065 20985 21061 18815 21700 21084 20897 21295 21680 19263 21783 21129 20877 21131 21570 19001 22263 20891 21125 21492 21523 19092 22160 20754 20998 20808 21166 18857 21707 19677 19720 19791 20063 17108 17403 19434 19392 19702 19689 17628 19976 19483 19282 19617 19912 18070 20133 19351 19285 19724 19722 17189 20023 19297 19616 19747 19976 17176 17457 19380 19270 19436 19650 17671 20315 19557 19335 19623 20116 17923 20265 19538 18775 19602 19632 16984 20273 sum_num_inserts_total=1927139 sum_num_deletes_by_thread=20867 21043 21031 21448 19365 22246 21253 20888 21046 21391 18843 22222 21257 21255 21413 21832 18814 22019 20966 20516 20938 21346 19021 21870 21116 21330 21351 21335 19210 21830 20823 20796 21387 21258 18728 21985 20980 21220 21273 21539 18701 21996 21080 20949 20935 21235 18901 21646 19534 19678 19839 19905 17466 17486 19578 19411 19704 19848 17667 20099 19717 19702 19657 19752 17811 20550 19252 18983 19627 19784 16969 20123 19293 19472 19782 19893 17214 17315 19546 19452 19595 19664 17587 20235 19300 19270 19436 19682 17752 20407 19674 19063 19599 19523 17123 20292 sum_num_deletes_total=1926805 sum_num_searches_by_thread=381663 381261 382843 390899 349595 396962 382799 373795 381595 383245 338977 400223 379272 381867 385502 389829 339576 401334 373384 373525 375557 383004 337796 390164 379274 381065 381833 390321 346954 392834 373927 372985 382731 389955 340797 400611 376169 381693 387926 384318 337814 395122 374678 378031 377720 378478 339312 393184 351171 356687 352997 360159 312865 315127 350864 346799 352295 355730 317585 359424 353895 349502 355364 355779 323398 364147 347619 343036 352464 357139 304962 361604 349354 354984 356969 358881 307591 314687 353468 348909 351423 352582 319057 363750 347424 347202 348740 352814 322703 365885 349901 339878 353636 348561 306662 362514 sum_num_searches_total=34670586 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=423764 423198 425203 433935 388344 441200 425223 415550 423735 425992 376707 444493 421441 424495 428143 433167 377392 445699 415118 415106 417480 425411 375632 433734 421474 423292 424479 433336 385427 436447 415879 414658 425249 432783 378526 444859 418040 424038 430691 427380 375607 439278 416512 419978 419463 420879 377070 436537 390382 396085 392627 400127 347439 350016 389876 385602 391701 395267 352880 399499 393095 388486 394638 395443 359279 404830 386222 381304 391815 396645 339120 401750 387944 394072 396498 398750 341981 349459 392394 387631 390454 391896 354315 404300 386281 385807 387799 392612 358378 406557 389113 377716 392837 387716 340769 403079 average_num_operations_total=401297 stdev_num_operations_total=2672 sum_num_operations_total=38524530 min_num_operations_total=339120 max_num_operations_total=445699 first_time_thread_terminate_by_thread=10000557 10000194 10000183 10000221 10000549 10000222 10000240 10000252 10000184 10000183 10000308 10000251 10000224 10000201 10000300 10000303 10000558 10000549 10000312 10000201 10000202 10000266 10000313 10000583 10000291 10000183 10000309 10000561 10000194 10000548 10000291 10000230 10000292 10000183 10000568 10000286 10000560 10000295 10000181 10000312 10000199 10000183 10000224 10000296 10000266 10000558 10000183 10000315 10000316 10000185 10000563 10000596 10000599 10000600 10000591 10000240 10000580 10000270 10000230 10000568 10000597 10000274 10000219 10000241 10000602 10000585 10000563 10000594 10000576 10000584 10000593 10000596 10000185 10000289 10000283 10000574 10000287 10000588 10000280 10000185 10000575 10000590 10000589 10000571 10000573 10000581 10000265 10000577 10000603 10000594 10000185 10000598 10000553 10000551 10000185 10000244 min_time_thread_terminate_total=10000181 max_time_thread_terminate_total=10000603 first_time_thread_start_by_thread=9 5 5 5 5 5 5 5 4 4 4 4 5 4 5 4 5 4 4 4 5 5 4 5 4 5 5 5 5 5 5 5 4 4 4 4 5 4 5 4 5 4 4 4 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 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 min_time_thread_start_total=4 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=998468684781 threads_final_size=998206 final_keysum=998468684781 final_size=998206 validate_result=success Validation OK. Structural validation OK. total_find=34670586 total_rq=0 total_inserts=1927139 total_deletes=1926805 total_updates=3853944 total_queries=34670586 total_ops=38524530 find_throughput=3467058 rq_throughput=0 update_throughput=385394 query_throughput=3467058 total_throughput=3852453 total find : 34670586 total rq : 0 total inserts : 1927139 total deletes : 1926805 total updates : 3853944 total queries : 34670586 total ops : 38524530 find throughput : 3467058 rq throughput : 0 update throughput : 385394 query throughput : 3467058 total throughput : 3852453 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=31.8333 PAPI_L3_TCM=8.17946 PAPI_TOT_CYC=63381.6 PAPI_TOT_INS=3958.65 garbage=17202838880268 total_execution_walltime=17.995s REALTIME_MAIN_END_PERF_FORMAT=6997961.120266018 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=18.15, faults_major=0, faults_minor=132635, mem_maxresident_kb=528984, user_cputime=1677.87, sys_cputime=23.45, percent_cpu=9371% 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=1