__step=000284 __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.tl2 -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=data000284.txt __path_data=data/data000284.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6998096.402365939 binary=./brown_sigouin_int_avl_tm_auto.debra.tl2 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 TL2 system ready: GV=GV4 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.015s prefilling_size=993907 prefilling_elapsed_millis=1.001s finished prefilling to size 993957 for expected size 1000000 keysum=993874998888, performing 10436623 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=993957 pref_millis=1103 prefill_elapsed_ms=1137 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6998097.743614061 REALTIME_END_PERF_FORMAT=6998107.743752964 ############################################################################### ################################## 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.031s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32744 64511 115006 154593 124414 45130 5085 66 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 23 886 11981 60997 141688 146665 57375 6379 85 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65397 126987 215590 266102 191795 62460 6445 85 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65397 126987 215590 266102 191795 62460 6445 85 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99994 1.99652 1.95533 1.79208 1.51723 1.25321 1.09036 1.02177 1.00295 1 tree_stats_height=24 tree_stats_numInternals=574316 tree_stats_numLeaves=426079 tree_stats_numNodes=1000395 tree_stats_numKeys=1000395 tree_stats_avgDegreeInternal=1.74189 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42591 tree_stats_avgKeyDepth=18.3432 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=384480 first_thread_announced_epoch_by_thread=8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 8250 sum_num_inserts_by_thread=181798 182200 184105 184244 183706 181023 182022 183154 184568 184680 182479 182937 182309 182924 185274 184547 183083 182400 181199 181793 183062 184113 184124 180492 181605 181520 183946 183763 182737 181465 182050 182955 183507 184432 184437 182849 181660 181930 183779 184894 183892 181155 181165 181622 184333 184288 183824 181063 179520 178715 180050 181020 178706 179627 179294 179341 181068 181928 181378 178683 178498 179599 181572 181233 180159 178245 177666 179597 181535 181494 179264 179080 178576 178099 180073 180580 179864 178018 178557 179558 181034 180221 180634 178342 177651 180083 180062 180660 179903 178123 177382 180217 180994 181788 179988 180275 sum_num_inserts_total=17409061 sum_num_deletes_by_thread=181753 182403 184319 184204 183970 181319 183289 183509 185647 184766 183244 182940 182447 183554 183768 184298 182629 183351 181405 182283 183105 184101 183455 180965 182148 181091 183946 183492 182925 180031 182062 183695 184093 184372 183971 182412 182469 182749 183789 185090 183953 181577 180483 182289 184250 184067 183783 181072 177901 178400 179120 180529 179564 179401 178716 178719 180081 181611 180515 178917 178405 179456 180463 180694 180161 179572 177179 179214 181351 181309 180526 178200 178015 178275 180501 180699 179995 178665 177659 179666 180910 181766 179822 178586 178451 179333 180318 180377 178925 177813 177116 179303 181095 181048 180939 179199 sum_num_deletes_total=17405013 sum_num_searches_by_thread=3260454 3279791 3316848 3311241 3309548 3270586 3288618 3307110 3333232 3319051 3296368 3291630 3291641 3300847 3321459 3328413 3301013 3291405 3257185 3277589 3295070 3311836 3302914 3262283 3264809 3274392 3310104 3305735 3289856 3252614 3280556 3294789 3307705 3317415 3307763 3286161 3271138 3288093 3304365 3330255 3316408 3272652 3262580 3274189 3313278 3312509 3303119 3260339 3202915 3215279 3243466 3257042 3224832 3234687 3218195 3223081 3254298 3265838 3254328 3216306 3213041 3233865 3250130 3256475 3251810 3214248 3193340 3225398 3266037 3259143 3237560 3213060 3209530 3222312 3245900 3252857 3229390 3222090 3202299 3237873 3256860 3261578 3239523 3211683 3208764 3229705 3242840 3248675 3236036 3206505 3192947 3228712 3253715 3261663 3252971 3234292 sum_num_searches_total=313340050 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3624005 3644394 3685272 3679689 3677224 3632928 3653929 3673773 3703447 3688497 3662091 3657507 3656397 3667325 3690501 3697258 3666725 3657156 3619789 3641665 3661237 3680050 3670493 3623740 3628562 3637003 3677996 3672990 3655518 3614110 3644668 3661439 3675305 3686219 3676171 3651422 3635267 3652772 3671933 3700239 3684253 3635384 3624228 3638100 3681861 3680864 3670726 3622474 3560336 3572394 3602636 3618591 3583102 3593715 3576205 3581141 3615447 3629377 3616221 3573906 3569944 3592920 3612165 3618402 3612130 3572065 3548185 3584209 3628923 3621946 3597350 3570340 3566121 3578686 3606474 3614136 3589249 3578773 3558515 3597097 3618804 3623565 3599979 3568611 3564866 3589121 3603220 3609712 3594864 3562441 3547445 3588232 3615804 3624499 3613898 3593766 average_num_operations_total=3626605 stdev_num_operations_total=4199 sum_num_operations_total=348154124 min_num_operations_total=3547445 max_num_operations_total=3703447 first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000140 10000138 10000139 10000139 10000139 10000138 10000142 10000146 10000138 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000138 10000140 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000142 10000138 10000138 10000139 10000138 10000138 10000138 10000138 10000138 10000140 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000139 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000140 10000138 10000140 10000138 10000138 10000138 10000138 10000139 10000138 10000137 10000139 10000137 10000138 10000139 10000139 10000139 10000139 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000137 10000138 10000139 10000138 10000138 10000138 10000139 10000139 10000138 10000137 10000139 10000137 min_time_thread_terminate_total=10000137 max_time_thread_terminate_total=10000146 first_time_thread_start_by_thread=4 4 4 5 4 5 5 4 4 5 5 5 4 4 5 5 4 4 4 4 4 4 4 4 4 4 4 5 4 5 5 4 4 5 5 5 4 4 5 5 4 4 4 4 4 4 4 4 4 5 4 5 5 5 5 5 5 5 5 5 4 5 4 5 4 5 4 5 4 5 5 5 4 5 4 5 5 5 5 5 5 5 5 5 4 5 4 5 4 5 4 5 4 5 5 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=1000772233008 threads_final_size=1000395 final_keysum=1000772233008 final_size=1000395 validate_result=success Validation OK. Structural validation OK. total_find=313340050 total_rq=0 total_inserts=17409061 total_deletes=17405013 total_updates=34814074 total_queries=313340050 total_ops=348154124 find_throughput=31334005 rq_throughput=0 update_throughput=3481407 query_throughput=31334005 total_throughput=34815412 total find : 313340050 total rq : 0 total inserts : 17409061 total deletes : 17405013 total updates : 34814074 total queries : 313340050 total ops : 348154124 find throughput : 31334005 rq throughput : 0 update throughput : 3481407 query throughput : 31334005 total throughput : 34815412 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=32.3827 PAPI_L3_TCM=3.51864 PAPI_TOT_CYC=5748.33 PAPI_TOT_INS=2146.25 garbage=153419708037502 total_execution_walltime=11.43s REALTIME_MAIN_END_PERF_FORMAT=6998107.838101627 TL2 system shutdown: GCLOCK=0x16B818E Starts=361700795 Aborts=3110047 Overflows: R=0 W=0 L=0 [time_cmd_output] time_elapsed_sec=11.61, faults_major=0, faults_minor=365923, mem_maxresident_kb=893272, user_cputime=1011.99, sys_cputime=80.50, percent_cpu=9410% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.tl2 thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2