__step=000333 __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.hytm1 -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=data000333.txt __path_data=data/data000333.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6998834.744134208 binary=./brown_abtree_tm_auto.debra.hytm1 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 HyTM1 system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.022s prefilling_size=515958 prefilling_elapsed_millis=1.001s prefilling_size=589105 prefilling_elapsed_millis=1.101s prefilling_size=659578 prefilling_elapsed_millis=1.201s prefilling_size=719843 prefilling_elapsed_millis=1.302s prefilling_size=754054 prefilling_elapsed_millis=1.402s prefilling_size=780429 prefilling_elapsed_millis=1.502s prefilling_size=801261 prefilling_elapsed_millis=1.602s prefilling_size=817237 prefilling_elapsed_millis=1.702s prefilling_size=832233 prefilling_elapsed_millis=1.802s prefilling_size=851488 prefilling_elapsed_millis=1.903s prefilling_size=883013 prefilling_elapsed_millis=2.003s prefilling_size=916521 prefilling_elapsed_millis=2.103s prefilling_size=943758 prefilling_elapsed_millis=2.203s prefilling_size=965231 prefilling_elapsed_millis=2.303s prefilling_size=979338 prefilling_elapsed_millis=2.404s prefilling_size=988360 prefilling_elapsed_millis=2.504s finished prefilling to size 988344 for expected size 1000000 keysum=988107540761, performing 9114882 updates; total_prefilling_elapsed_ms=2606 ms) pref_size=988344 pref_millis=2606 prefill_elapsed_ms=2632 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6998837.610105340 REALTIME_END_PERF_FORMAT=6998847.610268168 ############################################################################### ################################## 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 3477 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.06s tree_stats_numInternalsAtDepth=1 1 9 64 469 3477 27052 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 196734 tree_stats_numNodesAtDepth=1 1 9 64 469 3477 27052 196734 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 998316 tree_stats_avgDegreeAtDepth=1 9 7.11111 7.32812 7.41365 7.78027 7.27244 5.07445 tree_stats_height=8 tree_stats_numInternals=31073 tree_stats_numLeaves=196734 tree_stats_numNodes=227807 tree_stats_numKeys=998316 tree_stats_avgDegreeInternal=7.33135 tree_stats_avgDegreeLeaves=5.07445 tree_stats_avgDegree=5.38229 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=427824 first_thread_announced_epoch_by_thread=6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 6038 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=200300 201476 202900 203668 202711 201651 201207 200871 203937 204073 202087 202591 201517 202429 203121 203130 203190 202376 200835 202215 203941 203898 201187 201687 200002 201053 202021 202324 201863 200987 201881 202387 203226 205125 203335 201573 201418 202356 203238 203038 202660 202309 200436 201748 203014 203210 200575 201188 202923 204818 204297 204732 204139 203165 204389 203678 205849 207117 204697 204697 204257 205618 205583 206550 205970 204224 201971 204544 205444 205928 205371 204222 201680 203573 204288 206207 203705 204034 201829 202726 205452 206341 204090 203663 203489 205671 206403 204649 202869 202782 200048 203432 206435 205403 204401 205117 196732 198046 199420 200168 200258 199036 198432 200891 199768 201198 199562 197206 198159 200181 200094 201182 197425 197526 197212 199070 198938 200211 199282 197568 198899 199132 198383 200447 199234 198222 198060 200051 200925 202540 200422 198990 200008 201168 200982 200436 199939 198811 199390 201278 202233 202642 200652 199885 sum_num_inserts_total=29100729 sum_num_deletes_by_thread=200558 201435 203849 202589 203486 202338 201586 201398 203683 204174 202401 202152 200774 202738 202356 202854 202896 202519 200860 202343 203200 202892 200645 202026 200386 200005 202787 202174 202513 201703 201754 202514 203080 204365 202432 201925 201191 202745 203064 203284 202295 202117 199656 201993 202990 203012 200493 201224 203389 204692 204926 204191 203861 202834 202164 202867 206281 206790 205064 204202 203932 205500 204911 206228 205268 204627 202877 204682 206396 206353 206335 204321 202381 203394 204388 205181 203409 202856 202110 203434 204966 206142 204430 202938 203385 205147 204829 206047 203609 201952 200552 202693 205989 206844 204656 205433 197294 199441 200443 199273 200581 199851 199212 200185 200294 201418 198399 196997 198674 199811 200120 199790 198185 197649 197983 199215 199631 200588 199290 197687 197780 198704 199359 200392 199209 198425 197268 200461 201378 202670 200973 200090 199180 200838 201277 200783 199749 199278 199079 201615 201423 202818 200880 199992 sum_num_deletes_total=29100542 sum_num_searches_by_thread=3614240 3636166 3657065 3654875 3648808 3632030 3622190 3611932 3663277 3680840 3639339 3647163 3618676 3649001 3639650 3657945 3655160 3651365 3617949 3643324 3665253 3662587 3614541 3625520 3596184 3617777 3639719 3638610 3631900 3618201 3624801 3644912 3650642 3678770 3654998 3638582 3619978 3649384 3660211 3659540 3640259 3637788 3597063 3624161 3647433 3657686 3615254 3612306 3650318 3671129 3686504 3690918 3668130 3663142 3656292 3659374 3704569 3717450 3692715 3678354 3671314 3694516 3706914 3709686 3701381 3682865 3640249 3687367 3709729 3722022 3697154 3675206 3648471 3676632 3683283 3699990 3671330 3659979 3636431 3668555 3695330 3714337 3678455 3660975 3650521 3698416 3700774 3693205 3667075 3641195 3620608 3655723 3708547 3707946 3682278 3687274 3547129 3570075 3612205 3604919 3600940 3591252 3570326 3614046 3610235 3618088 3582004 3548597 3560753 3593248 3602855 3603168 3564779 3542548 3551896 3578921 3606011 3608910 3587453 3556147 3561829 3578351 3586749 3611531 3582749 3567786 3561853 3595889 3620771 3636240 3611046 3590782 3594146 3609093 3622728 3618626 3589863 3576002 3583108 3613997 3642561 3650443 3617268 3593416 sum_num_searches_total=523753015 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=4015098 4039077 4063814 4061132 4055005 4036019 4024983 4014201 4070897 4089087 4043827 4051906 4020967 4054168 4045127 4063929 4061246 4056260 4019644 4047882 4072394 4069377 4016373 4029233 3996572 4018835 4044527 4043108 4036276 4020891 4028436 4049813 4056948 4088260 4060765 4042080 4022587 4054485 4066513 4065862 4045214 4042214 3997155 4027902 4053437 4063908 4016322 4014718 4056630 4080639 4095727 4099841 4076130 4069141 4062845 4065919 4116699 4131357 4102476 4087253 4079503 4105634 4117408 4122464 4112619 4091716 4045097 4096593 4121569 4134303 4108860 4083749 4052532 4083599 4091959 4111378 4078444 4066869 4040370 4074715 4105748 4126820 4086975 4067576 4057395 4109234 4112006 4103901 4073553 4045929 4021208 4061848 4120971 4120193 4091335 4097824 3941155 3967562 4012068 4004360 4001779 3990139 3967970 4015122 4010297 4020704 3979965 3942800 3957586 3993240 4003069 4004140 3960389 3937723 3947091 3977206 4004580 4009709 3986025 3951402 3958508 3976187 3984491 4012370 3981192 3964433 3957181 3996401 4023074 4041450 4012441 3989862 3993334 4011099 4024987 4019845 3989551 3974091 3981577 4016890 4046217 4055903 4018800 3993293 average_num_operations_total=4041349 stdev_num_operations_total=3950 sum_num_operations_total=581954286 min_num_operations_total=3937723 max_num_operations_total=4134303 first_time_thread_terminate_by_thread=10000163 10000163 10000165 10000165 10000162 10000165 10000166 10000163 10000162 10000164 10000165 10000165 10000165 10000162 10000163 10000162 10000165 10000163 10000165 10000165 10000166 10000163 10000166 10000163 10000163 10000163 10000165 10000165 10000162 10000165 10000166 10000163 10000162 10000164 10000165 10000165 10000165 10000162 10000163 10000162 10000165 10000163 10000165 10000165 10000166 10000163 10000166 10000163 10000163 10000161 10000164 10000163 10000164 10000160 10000166 10000166 10000163 10000163 10000163 10000163 10000163 10000163 10000164 10000164 10000165 10000231 10000163 10000166 10000164 10000199 10000163 10000166 10000163 10000161 10000164 10000163 10000164 10000160 10000166 10000166 10000163 10000163 10000163 10000163 10000163 10000163 10000163 10000163 10000164 10000164 10000163 10000166 10000164 10000162 10000163 10000163 10000162 10000161 10000164 10000163 10000162 10000162 10000162 10000161 10000163 10000162 10000161 10000162 10000164 10000161 10000162 10000165 10000161 10000161 10000162 10000162 10000162 10000164 10000162 10000162 10000162 10000161 10000164 10000163 10000162 10000162 10000162 10000161 10000163 10000163 10000161 10000162 10000161 10000161 10000162 10000161 10000161 10000161 10000162 10000162 10000162 10000164 10000162 10000162 min_time_thread_terminate_total=10000160 max_time_thread_terminate_total=10000231 first_time_thread_start_by_thread=4 4 4 5 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 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 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 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 3 4 4 4 4 min_time_thread_start_total=3 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=998130409970 threads_final_size=998316 final_keysum=998130409970 final_size=998316 validate_result=success Validation OK. Structural validation OK. total_find=523753015 total_rq=0 total_inserts=29100729 total_deletes=29100542 total_updates=58201271 total_queries=523753015 total_ops=581954286 find_throughput=52375301 rq_throughput=0 update_throughput=5820127 query_throughput=52375301 total_throughput=58195428 total find : 523753015 total rq : 0 total inserts : 29100729 total deletes : 29100542 total updates : 58201271 total queries : 523753015 total ops : 581954286 find throughput : 52375301 rq throughput : 0 update throughput : 5820127 query throughput : 52375301 total throughput : 58195428 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=11.7183 PAPI_L3_TCM=2.00045 PAPI_TOT_CYC=6821.55 PAPI_TOT_INS=5206.91 garbage=259925697831491 total_execution_walltime=13.098s REALTIME_MAIN_END_PERF_FORMAT=6998847.842948550 HyTM1 system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 590486057 [slow htm] [fallback] total fallback commit : 583112 seconds global lock is held : 8.50117 [time_cmd_output] time_elapsed_sec=13.28, faults_major=0, faults_minor=331549, mem_maxresident_kb=1241032, user_cputime=1842.67, sys_cputime=5.63, percent_cpu=13909% timeout=false algorithm=brown_abtree_tm_auto.debra.hytm1 thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1