__step=000673 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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_ext_abtree_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000673.txt __path_data=data/data000673.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6986949.644132500 binary=./brown_ext_abtree_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_abtree_lf 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=50 DEL_FRAC=50 RQ=0 RQSIZE=0 MAXKEY=20000000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 RQ_THREADS=0 distribution=0 INS_DEL_FRAC=50.0 50.0 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 size_node=208 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=8735089 prefilling_elapsed_millis=1.001s prefilling_size=8954859 prefilling_elapsed_millis=1.101s prefilling_size=9138527 prefilling_elapsed_millis=1.201s prefilling_size=9289667 prefilling_elapsed_millis=1.301s prefilling_size=9413287 prefilling_elapsed_millis=1.402s prefilling_size=9513619 prefilling_elapsed_millis=1.502s prefilling_size=9594711 prefilling_elapsed_millis=1.602s prefilling_size=9662002 prefilling_elapsed_millis=1.702s prefilling_size=9718218 prefilling_elapsed_millis=1.802s prefilling_size=9764534 prefilling_elapsed_millis=1.903s prefilling_size=9804806 prefilling_elapsed_millis=2.003s finished prefilling to size 9804790 for expected size 10000000 keysum=98060908338033, performing 79870870 updates; total_prefilling_elapsed_ms=2104 ms) pref_size=9804790 pref_millis=2104 prefill_elapsed_ms=2127 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=3876 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6986951.930327094 REALTIME_END_PERF_FORMAT=6986961.930461209 ############################################################################### ################################## 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 4431 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.075s tree_stats_numInternalsAtDepth=1 1 11 80 603 4431 33473 261452 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1960327 tree_stats_numNodesAtDepth=1 1 11 80 603 4431 33473 261452 1960327 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9996166 tree_stats_avgDegreeAtDepth=1 11 7.27273 7.5375 7.34826 7.55428 7.81083 7.49785 5.09923 tree_stats_height=9 tree_stats_numInternals=300052 tree_stats_numLeaves=1960327 tree_stats_numNodes=2260379 tree_stats_numKeys=9996166 tree_stats_avgDegreeInternal=7.53329 tree_stats_avgDegreeLeaves=5.09923 tree_stats_avgDegree=5.42234 tree_stats_avgKeyDepth=8 tree_stats_bytesAtDepth=208 208 2288 16640 125424 921648 6962384 54382016 407748016 tree_stats_sizeInBytes=470158832 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=21261 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1 2:0 4:0 8:1 16:2 32:2 64:70 128:472191 256:7637 [2^00, 2^01]: 1 (2^01, 2^02]: 0 (2^02, 2^03]: 0 (2^03, 2^04]: 1 (2^04, 2^05]: 2 (2^05, 2^06]: 2 (2^06, 2^07]: 70 (2^07, 2^08]: 472191 (2^08, 2^09]: 7637 sum_limbo_reclamation_event_size_total=109445892 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479904 sum_limbo_reclamation_event_count_total=834480 first_thread_announced_epoch_by_thread=42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 42522 sum_num_inserts_by_thread=3807463 3820873 3835383 3850872 3838843 3805025 3805998 3827375 3855360 3851147 3826611 3814267 3821540 3829871 3845055 3850796 3835525 3808103 3794681 3802593 3847925 3853775 3817030 3801214 3805143 3811732 3832998 3838115 3837608 3800469 3805913 3826641 3859096 3857802 3820094 3802221 3820024 3819865 3850959 3850018 3835271 3816211 3794673 3820298 3829511 3844873 3814089 3798310 sum_num_inserts_total=183639259 sum_num_deletes_by_thread=3809292 3820581 3835373 3846943 3836842 3805243 3807522 3827931 3853944 3854117 3823115 3813083 3820279 3830392 3847998 3851698 3835599 3810604 3800530 3800311 3846606 3851644 3813454 3801515 3803248 3811957 3832471 3837251 3837482 3802237 3808777 3828729 3857623 3856669 3820477 3801957 3818087 3822788 3849254 3849636 3837679 3813414 3796350 3816368 3833758 3844629 3815453 3800100 sum_num_deletes_total=183641010 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=7616755 7641454 7670756 7697815 7675685 7610268 7613520 7655306 7709304 7705264 7649726 7627350 7641819 7660263 7693053 7702494 7671124 7618707 7595211 7602904 7694531 7705419 7630484 7602729 7608391 7623689 7665469 7675366 7675090 7602706 7614690 7655370 7716719 7714471 7640571 7604178 7638111 7642653 7700213 7699654 7672950 7629625 7591023 7636666 7663269 7689502 7629542 7598410 average_num_operations_total=7651672 stdev_num_operations_total=5481 sum_num_operations_total=367280269 min_num_operations_total=7591023 max_num_operations_total=7716719 first_time_thread_terminate_by_thread=10000133 10000133 10000133 10000134 10000135 10000133 10000134 10000133 10000134 10000133 10000134 10000134 10000134 10000133 10000133 10000134 10000133 10000133 10000134 10000133 10000133 10000133 10000134 10000133 10000133 10000133 10000133 10000134 10000135 10000133 10000133 10000133 10000134 10000133 10000134 10000134 10000134 10000133 10000134 10000134 10000133 10000134 10000134 10000133 10000133 10000133 10000134 10000133 min_time_thread_terminate_total=10000133 max_time_thread_terminate_total=10000135 first_time_thread_start_by_thread=3 3 3 3 4 3 3 4 4 3 3 3 3 3 4 3 3 3 4 3 3 3 3 3 3 3 3 3 4 3 3 4 4 3 3 3 3 3 4 3 3 3 4 3 3 3 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99970490877349 threads_final_size=9996166 final_keysum=99970490877349 final_size=9996166 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=183639259 total_deletes=183641010 total_updates=367280269 total_queries=0 total_ops=367280269 find_throughput=0 rq_throughput=0 update_throughput=36728026 query_throughput=0 total_throughput=36728026 total find : 0 total rq : 0 total inserts : 183639259 total deletes : 183641010 total updates : 367280269 total queries : 0 total ops : 367280269 find throughput : 0 rq throughput : 0 update throughput : 36728026 query throughput : 0 total throughput : 36728026 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=26.3213 PAPI_L3_TCM=8.21735 PAPI_TOT_CYC=3622 PAPI_TOT_INS=854.275 garbage=0 total_execution_walltime=12.445s REALTIME_MAIN_END_PERF_FORMAT=6986962.90122209 [time_cmd_output] time_elapsed_sec=12.61, faults_major=0, faults_minor=209717, mem_maxresident_kb=840396, user_cputime=611.11, sys_cputime=2.37, percent_cpu=4864% timeout=false algorithm=brown_ext_abtree_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1