__step=000586 __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" ./wang_openbwtree -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=data000586.txt __path_data=data/data000586.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985931.331796612 binary=./wang_openbwtree parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=wang_openbwtree 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 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.004s prefilling_size=99671 prefilling_elapsed_millis=1.001s finished prefilling to size 99668 for expected size 100000 keysum=9978149309, performing 15704284 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99668 pref_millis=1102 prefill_elapsed_ms=1126 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985932.622921401 REALTIME_END_PERF_FORMAT=6985942.623048717 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10s PRODUCING OUTPUT Open BwTree: createTreeStats iterating over all kv-pairs... Open BwTree: createTreeStats finished iterating. tree_stats_computeWalltime=0.003s tree_stats_numInternalsAtDepth=0 tree_stats_numLeavesAtDepth=1 tree_stats_numNodesAtDepth=1 tree_stats_numKeysAtDepth=100260 tree_stats_avgDegreeAtDepth=100260 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=100260 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=100260 tree_stats_avgDegree=100261 tree_stats_avgKeyDepth=0 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= first_thread_announced_epoch_by_thread= sum_num_inserts_by_thread=652237 647696 661955 643661 655454 642975 654776 654834 656179 652105 648499 649123 660978 659458 664216 654131 643841 649965 653391 656624 666942 651063 650844 648409 652646 648498 661131 645313 654747 643706 656154 652946 655756 651241 647409 646835 661991 660963 664291 653458 644514 649157 654473 657392 666299 649798 648505 645648 sum_num_inserts_total=31352227 sum_num_deletes_by_thread=651686 648176 661746 644514 655825 642821 654575 655558 657785 651974 646757 648244 659083 659169 664447 654692 644700 649659 655307 656884 667394 652613 650995 648188 653777 646883 661286 645863 655631 643240 654347 653986 654826 651599 647719 647805 662671 661826 664375 655341 644653 648932 654141 656733 666594 650667 649694 646878 sum_num_deletes_total=31362259 sum_num_searches_by_thread=11738248 11651781 11914056 11616139 11803624 11588236 11785156 11787359 11823370 11748989 11658732 11674117 11906385 11868877 11988780 11758788 11592783 11693935 11770473 11847602 12009321 11723452 11702027 11663911 11743157 11662109 11914755 11618451 11798284 11581347 11787531 11751157 11797832 11744331 11646317 11664211 11894985 11905438 11973774 11778338 11590241 11689851 11774981 11838147 11998580 11723416 11700308 11634691 sum_num_searches_total=564528373 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=13042171 12947653 13237757 12904314 13114903 12874032 13094507 13097751 13137334 13053068 12953988 12971484 13226446 13187504 13317443 13067611 12881324 12993559 13079171 13161110 13343657 13027128 13003866 12960508 13049580 12957490 13237172 12909627 13108662 12868293 13098032 13058089 13108414 13047171 12941445 12958851 13219647 13228227 13302440 13087137 12879408 12987940 13083595 13152272 13331473 13023881 12998507 12927217 average_num_operations_total=13067559 stdev_num_operations_total=18691 sum_num_operations_total=627242859 min_num_operations_total=12868293 max_num_operations_total=13343657 first_time_thread_terminate_by_thread=10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000128 10000127 10000127 10000127 10000127 10000127 10000128 10000127 10000127 10000127 10000127 10000127 10000128 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000127 10000128 10000128 10000127 10000127 10000127 10000127 10000128 10000127 min_time_thread_terminate_total=10000127 max_time_thread_terminate_total=10000128 first_time_thread_start_by_thread=4 4 4 4 5 5 4 4 4 5 4 5 5 5 4 4 5 5 5 4 4 5 4 5 4 4 4 4 5 5 4 4 4 5 4 5 5 5 4 4 5 5 5 4 4 5 4 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=9997157823 threads_final_size=100260 final_keysum=9997157823 final_size=100260 validate_result=success Validation OK. Structural validation OK. total_find=564528373 total_rq=0 total_inserts=31352227 total_deletes=31362259 total_updates=62714486 total_queries=564528373 total_ops=627242859 find_throughput=56452837 rq_throughput=0 update_throughput=6271448 query_throughput=56452837 total_throughput=62724285 total find : 564528373 total rq : 0 total inserts : 31352227 total deletes : 31362259 total updates : 62714486 total queries : 564528373 total ops : 627242859 find throughput : 56452837 rq throughput : 0 update throughput : 6271448 query throughput : 56452837 total throughput : 62724285 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=14.7271 PAPI_L3_TCM=0.347346 PAPI_TOT_CYC=2125.95 PAPI_TOT_INS=676.096 garbage=28219050542693 total_execution_walltime=11.311s REALTIME_MAIN_END_PERF_FORMAT=6985942.652613948 [time_cmd_output] time_elapsed_sec=11.46, faults_major=0, faults_minor=113236, mem_maxresident_kb=441012, user_cputime=548.82, sys_cputime=2.59, percent_cpu=4809% timeout=false algorithm=wang_openbwtree thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2