__step=000898 __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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000898.txt __path_data=data/data000898.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6989780.474971431 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=200000 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=100219 prefilling_elapsed_millis=1.001s finished prefilling to size 100196 for expected size 100000 keysum=9999790803, performing 76704552 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100196 pref_millis=1102 prefill_elapsed_ms=1124 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=4036 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6989781.763228037 REALTIME_END_PERF_FORMAT=6989791.763364093 ############################################################################### ################################## 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 3269 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.057s tree_stats_numInternalsAtDepth=1 1 8 58 429 3269 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19486 tree_stats_numNodesAtDepth=1 1 8 58 429 3269 19486 tree_stats_numKeysAtDepth=0 0 0 0 0 0 100397 tree_stats_avgDegreeAtDepth=1 8 7.25 7.39655 7.62005 5.96084 5.15226 tree_stats_height=7 tree_stats_numInternals=3766 tree_stats_numLeaves=19486 tree_stats_numNodes=23252 tree_stats_numKeys=100397 tree_stats_avgDegreeInternal=6.17419 tree_stats_avgDegreeLeaves=5.15226 tree_stats_avgDegree=5.31778 tree_stats_avgKeyDepth=6 tree_stats_bytesAtDepth=208 208 1664 12064 89232 679952 4053088 tree_stats_sizeInBytes=4836416 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=42388 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:79 2:4 4:7 8:7 16:17 32:35 64:939 128:473673 256:4954 512:85 [2^00, 2^01]: 79 (2^01, 2^02]: 4 (2^02, 2^03]: 7 (2^03, 2^04]: 7 (2^04, 2^05]: 17 (2^05, 2^06]: 35 (2^06, 2^07]: 939 (2^07, 2^08]: 473673 (2^08, 2^09]: 4954 (2^09, 2^10]: 85 sum_limbo_reclamation_event_size_total=99728590 count_limbo_reclamation_event_size_by_thread=9998 9995 9994 9996 9996 9995 9996 9994 9998 9995 9996 9994 9996 9997 9993 9997 9997 9996 9996 9993 9994 9997 9996 9995 9998 9996 9997 9997 9995 9995 9997 9993 9997 9996 9997 9994 9996 9996 9996 9995 9997 9997 9995 9996 9998 9997 9996 9995 count_limbo_reclamation_event_size_total=479800 sum_limbo_reclamation_event_count_total=1840785 first_thread_announced_epoch_by_thread=84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 84776 sum_num_inserts_by_thread=7598903 7617845 7635525 7590036 7590444 7575636 7571150 7589872 7670405 7682366 7612966 7623139 7524718 7635981 7614189 7595179 7613713 7622851 7576100 7600450 7649914 7702466 7626828 7596945 7585728 7614483 7662943 7621267 7604780 7440433 7552002 7587295 7629475 7632346 7585108 7601626 7573078 7602440 7617703 7654749 7608172 7593051 7576235 7572745 7643342 7648075 7599590 7580506 sum_num_inserts_total=365104793 sum_num_deletes_by_thread=7602211 7622446 7632473 7595180 7583276 7578055 7571403 7594652 7673118 7682045 7604431 7622259 7522870 7637529 7606459 7590503 7614869 7622807 7574552 7603065 7649426 7703025 7628680 7593623 7582169 7620892 7657645 7615825 7603250 7438133 7551383 7584165 7637182 7634181 7588467 7598269 7574077 7605400 7616156 7648540 7609271 7601034 7573864 7577788 7643995 7645776 7603713 7578320 sum_num_deletes_total=365098452 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=15201114 15240291 15267998 15185216 15173720 15153691 15142553 15184524 15343523 15364411 15217397 15245398 15047588 15273510 15220648 15185682 15228582 15245658 15150652 15203515 15299340 15405491 15255508 15190568 15167897 15235375 15320588 15237092 15208030 14878566 15103385 15171460 15266657 15266527 15173575 15199895 15147155 15207840 15233859 15303289 15217443 15194085 15150099 15150533 15287337 15293851 15203303 15158826 average_num_operations_total=15212567 stdev_num_operations_total=12120 sum_num_operations_total=730203245 min_num_operations_total=14878566 max_num_operations_total=15405491 first_time_thread_terminate_by_thread=10000135 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000135 10000135 10000136 10000135 10000136 10000135 10000136 10000135 10000135 10000135 10000135 10000135 10000137 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000135 10000136 10000135 10000135 10000136 10000135 10000136 10000135 10000136 min_time_thread_terminate_total=10000135 max_time_thread_terminate_total=10000137 first_time_thread_start_by_thread=4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 4 3 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 4 3 4 3 3 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=10066449475 threads_final_size=100397 final_keysum=10066449475 final_size=100397 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=365104793 total_deletes=365098452 total_updates=730203245 total_queries=0 total_ops=730203245 find_throughput=0 rq_throughput=0 update_throughput=73020324 query_throughput=0 total_throughput=73020324 total find : 0 total rq : 0 total inserts : 365104793 total deletes : 365098452 total updates : 730203245 total queries : 0 total ops : 730203245 find throughput : 0 rq throughput : 0 update throughput : 73020324 query throughput : 0 total throughput : 73020324 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=13.0139 PAPI_L3_TCM=0.00205896 PAPI_TOT_CYC=1749.51 PAPI_TOT_INS=715.638 garbage=0 total_execution_walltime=11.445s REALTIME_MAIN_END_PERF_FORMAT=6989791.921287159 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=79754, mem_maxresident_kb=320260, user_cputime=566.79, sys_cputime=2.83, percent_cpu=4920% 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=2