__step=000921 __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 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=data000921.txt __path_data=data/data000921.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6990050.370926687 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=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 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=99933 prefilling_elapsed_millis=1.001s finished prefilling to size 99946 for expected size 100000 keysum=9988465653, performing 14963436 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99946 pref_millis=1102 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990051.658355431 REALTIME_END_PERF_FORMAT=6990061.658502587 ############################################################################### ################################## 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=99982 tree_stats_avgDegreeAtDepth=99982 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=99982 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=99982 tree_stats_avgDegree=99983 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=1564841 1562648 1580191 1562681 1562543 1559101 1568447 1569412 1586533 1571413 1567370 1567161 1584211 1562430 1580059 1564778 1573306 1573127 1565845 1571151 1589320 1570437 1568610 1562689 1569632 1562720 1580040 1560846 1562772 1557158 1570138 1571456 1591575 1572230 1569109 1566598 1580779 1565506 1583138 1560721 1571687 1570938 1565663 1569956 1588938 1571918 1567893 1561755 sum_num_inserts_total=75381470 sum_num_deletes_by_thread=1564345 1564508 1580013 1562833 1561919 1560739 1566770 1569442 1587157 1573596 1567352 1565632 1580397 1567944 1580961 1562137 1573814 1573164 1565955 1571324 1590855 1568798 1568356 1562742 1567983 1561000 1581228 1561466 1563172 1559197 1569027 1570284 1592308 1574177 1567660 1568725 1582242 1565591 1583234 1564381 1571845 1569875 1565844 1570712 1590150 1571255 1564424 1561770 sum_num_deletes_total=75388303 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3129186 3127156 3160204 3125514 3124462 3119840 3135217 3138854 3173690 3145009 3134722 3132793 3164608 3130374 3161020 3126915 3147120 3146291 3131800 3142475 3180175 3139235 3136966 3125431 3137615 3123720 3161268 3122312 3125944 3116355 3139165 3141740 3183883 3146407 3136769 3135323 3163021 3131097 3166372 3125102 3143532 3140813 3131507 3140668 3179088 3143173 3132317 3123525 average_num_operations_total=3141036 stdev_num_operations_total=2458 sum_num_operations_total=150769773 min_num_operations_total=3116355 max_num_operations_total=3183883 first_time_thread_terminate_by_thread=10000146 10000147 10000146 10000147 10000147 10000146 10000145 10000147 10000147 10000146 10000146 10000147 10000147 10000146 10000147 10000147 10000146 10000146 10000145 10000146 10000147 10000146 10000147 10000147 10000147 10000146 10000147 10000147 10000147 10000146 10000147 10000146 10000147 10000146 10000146 10000147 10000146 10000146 10000147 10000146 10000147 10000147 10000147 10000146 10000146 10000147 10000146 10000147 min_time_thread_terminate_total=10000145 max_time_thread_terminate_total=10000147 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 2 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9999595509 threads_final_size=99982 final_keysum=9999595509 final_size=99982 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=75381470 total_deletes=75388303 total_updates=150769773 total_queries=0 total_ops=150769773 find_throughput=0 rq_throughput=0 update_throughput=15076977 query_throughput=0 total_throughput=15076977 total find : 0 total rq : 0 total inserts : 75381470 total deletes : 75388303 total updates : 150769773 total queries : 0 total ops : 150769773 find throughput : 0 rq throughput : 0 update throughput : 15076977 query throughput : 0 total throughput : 15076977 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=42.9974 PAPI_L3_TCM=2.92751 PAPI_TOT_CYC=8875.85 PAPI_TOT_INS=1057.92 garbage=0 total_execution_walltime=11.308s REALTIME_MAIN_END_PERF_FORMAT=6990061.692607780 [time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=111252, mem_maxresident_kb=437160, user_cputime=548.97, sys_cputime=2.70, percent_cpu=4819% 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=1