__step=000481 __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.hybridnorec -nwork 48 -nprefill 48 -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=data000481.txt __path_data=data/data000481.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000596.820368472 binary=./brown_sigouin_int_avl_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_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=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 Hybrid noREC system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.023s prefilling_size=100096 prefilling_elapsed_millis=1.001s finished prefilling to size 100091 for expected size 100000 keysum=10004796720, performing 1692874 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100091 pref_millis=1102 prefill_elapsed_ms=1125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000598.161932939 REALTIME_END_PERF_FORMAT=7000608.162068111 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10s 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.038s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4095 8113 14574 16900 8410 1212 42 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 1 71 1458 10026 18785 10707 1536 52 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16032 26926 27195 11919 1578 52 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16032 26926 27195 11919 1578 52 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.96762 1.77046 1.38234 1.12903 1.03071 1.00634 1 tree_stats_height=20 tree_stats_numInternals=57441 tree_stats_numLeaves=42636 tree_stats_numNodes=100077 tree_stats_numKeys=100077 tree_stats_avgDegreeInternal=1.74226 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42603 tree_stats_avgKeyDepth=14.9083 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=554913 first_thread_announced_epoch_by_thread=23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 sum_num_inserts_by_thread=190329 185168 185455 185212 182288 176790 191664 186188 186998 185610 183723 183074 190729 187362 185429 186198 183446 182199 198469 191986 185693 185376 183603 183854 192105 187956 185945 185524 182895 178565 191693 188243 189016 187597 184626 184204 192012 187529 188021 185254 185214 182022 200317 192017 187075 185879 185559 184583 sum_num_inserts_total=8960694 sum_num_deletes_by_thread=189913 186296 185469 183890 182413 177696 191171 185369 186358 185655 182714 182095 190765 186838 185023 186226 184697 182232 198215 191465 184697 184899 184952 183738 191764 188212 185493 186056 183507 178626 191033 188421 188486 187612 184454 183710 192259 187560 186900 185429 185671 182219 199795 191296 187161 186510 184923 183618 sum_num_deletes_total=8953501 sum_num_searches_by_thread=3421070 3349413 3336181 3328926 3283301 3191258 3457340 3348359 3356839 3345752 3296575 3291237 3436230 3369045 3336945 3348748 3312920 3285908 3566659 3445531 3332629 3329783 3317198 3312284 3451388 3390747 3349053 3346039 3303819 3207867 3448269 3395130 3382625 3372762 3326973 3316213 3463328 3368739 3369696 3340987 3328678 3285429 3595703 3445896 3367366 3355104 3340501 3303253 sum_num_searches_total=161255696 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3801312 3720877 3707105 3698028 3648002 3545744 3840175 3719916 3730195 3717017 3663012 3656406 3817724 3743245 3707397 3721172 3681063 3650339 3963343 3828982 3703019 3700058 3685753 3679876 3835257 3766915 3720491 3717619 3670221 3565058 3830995 3771794 3760127 3747971 3696053 3684127 3847599 3743828 3744617 3711670 3699563 3649670 3995815 3829209 3741602 3727493 3710983 3671454 average_num_operations_total=3732706 stdev_num_operations_total=12095 sum_num_operations_total=179169891 min_num_operations_total=3545744 max_num_operations_total=3995815 first_time_thread_terminate_by_thread=10000133 10000167 10000164 10000133 10000160 10000133 10000133 10000133 10000133 10000133 10000141 10000161 10000159 10000133 10000147 10000133 10000133 10000135 10000133 10000140 10000163 10000133 10000133 10000165 10000143 10000140 10000133 10000163 10000139 10000156 10000133 10000147 10000137 10000145 10000141 10000157 10000133 10000161 10000134 10000161 10000142 10000136 10000164 10000164 10000163 10000157 10000133 10000133 min_time_thread_terminate_total=10000133 max_time_thread_terminate_total=10000167 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=10020394599 threads_final_size=100077 final_keysum=10020394599 final_size=100077 validate_result=success Validation OK. Structural validation OK. total_find=161255696 total_rq=0 total_inserts=8960694 total_deletes=8953501 total_updates=17914195 total_queries=161255696 total_ops=179169891 find_throughput=16125569 rq_throughput=0 update_throughput=1791419 query_throughput=16125569 total_throughput=17916989 total find : 161255696 total rq : 0 total inserts : 8960694 total deletes : 8953501 total updates : 17914195 total queries : 161255696 total ops : 179169891 find throughput : 16125569 rq throughput : 0 update throughput : 1791419 query throughput : 16125569 total throughput : 17916989 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=11.5967 PAPI_L3_TCM=0.0556321 PAPI_TOT_CYC=7425.66 PAPI_TOT_INS=2471.29 garbage=8066331225360 total_execution_walltime=11.453s REALTIME_MAIN_END_PERF_FORMAT=7000608.292801766 Hybrid noREC system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 177657193 [slow htm] [fallback] total fallback commit : 3205573 seconds global lock is held : 0.587473 [time_cmd_output] time_elapsed_sec=11.60, faults_major=0, faults_minor=134396, mem_maxresident_kb=539100, user_cputime=558.95, sys_cputime=3.32, percent_cpu=4843% timeout=false algorithm=brown_sigouin_int_avl_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=1