__step=000250 __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 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000250.txt __path_data=data/data000250.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6981803.72507789 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=0.5 DEL_FRAC=0.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=0.5 0.5 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=100019 prefilling_elapsed_millis=1.001s finished prefilling to size 100023 for expected size 100000 keysum=10020876492, performing 15488884 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100023 pref_millis=1102 prefill_elapsed_ms=1117 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6981804.341865110 REALTIME_END_PERF_FORMAT=6981814.342016426 ############################################################################### ################################## 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=99662 tree_stats_avgDegreeAtDepth=99662 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=99662 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=99662 tree_stats_avgDegree=99663 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=111415 111183 112858 112591 112593 111012 111309 112087 113055 112853 112065 112125 111810 111908 113055 112452 112229 112019 111404 111131 112350 112502 111841 110622 111374 111932 111734 112037 112050 110381 111425 111497 113252 112728 111271 111036 111716 111192 112843 112625 113149 111632 110890 112227 112750 112514 111697 110817 sum_num_inserts_total=5373238 sum_num_deletes_by_thread=111135 111069 112747 112782 112047 110517 111390 111789 112961 113225 111905 111195 111521 111946 112924 112279 112695 112004 110587 112454 112906 112701 112295 110872 111886 111320 113174 112116 111597 109893 110978 111527 113428 112193 111738 111946 112062 112047 112565 112462 112645 111949 110817 112129 111783 112397 111610 110563 sum_num_deletes_total=5372771 sum_num_searches_by_thread=22037098 22047152 22379116 22253483 22263178 21910456 22105575 22090333 22393203 22354133 22157195 22100076 22165816 22124180 22376851 22323071 22292431 22138400 22028110 22208383 22332703 22336402 22205090 21995304 22041166 22045098 22286427 22182951 22217630 21854303 22007000 22024323 22373013 22319966 22096463 22065300 22103638 22042039 22314028 22264740 22255962 22138992 22036253 22183018 22248230 22277618 22191526 21926594 sum_num_searches_total=1064114017 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=22259648 22269404 22604721 22478856 22487818 22131985 22328274 22314209 22619219 22580211 22381165 22323396 22389147 22348034 22602830 22547802 22517355 22362423 22250101 22431968 22557959 22561605 22429226 22216798 22264426 22268350 22511335 22407104 22441277 22074577 22229403 22247347 22599693 22544887 22319472 22288282 22327416 22265278 22539436 22489827 22481756 22362573 22257960 22407374 22472763 22502529 22414833 22147974 average_num_operations_total=22392917 stdev_num_operations_total=20162 sum_num_operations_total=1074860026 min_num_operations_total=22074577 max_num_operations_total=22619219 first_time_thread_terminate_by_thread=10000150 10000149 10000150 10000149 10000148 10000150 10000149 10000149 10000149 10000149 10000149 10000150 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000150 10000149 10000150 10000149 10000150 10000149 10000148 10000150 10000149 10000149 10000149 10000149 10000149 10000150 10000150 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000150 10000149 min_time_thread_terminate_total=10000148 max_time_thread_terminate_total=10000150 first_time_thread_start_by_thread=3 3 4 3 3 3 4 3 3 4 4 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 4 3 3 4 4 3 3 3 3 4 3 3 3 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=9974361718 threads_final_size=99662 final_keysum=9974361718 final_size=99662 validate_result=success Validation OK. Structural validation OK. total_find=1064114017 total_rq=0 total_inserts=5373238 total_deletes=5372771 total_updates=10746009 total_queries=1064114017 total_ops=1074860026 find_throughput=106411401 rq_throughput=0 update_throughput=1074600 query_throughput=106411401 total_throughput=107486002 total find : 1064114017 total rq : 0 total inserts : 5373238 total deletes : 5372771 total updates : 10746009 total queries : 1064114017 total ops : 1074860026 find throughput : 106411401 rq throughput : 0 update throughput : 1074600 query throughput : 106411401 total throughput : 107486002 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=7.95221 PAPI_L3_TCM=0.0411106 PAPI_TOT_CYC=1219.31 PAPI_TOT_INS=638.027 garbage=53213076221100 total_execution_walltime=11.295s REALTIME_MAIN_END_PERF_FORMAT=6981814.369226359 [time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=115144, mem_maxresident_kb=404932, user_cputime=549.38, sys_cputime=3.85, percent_cpu=4835% 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