__step=000138 __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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000138.txt __path_data=data/data000138.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6980491.670153984 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=2000000 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.02s prefilling_size=999594 prefilling_elapsed_millis=1.001s finished prefilling to size 999593 for expected size 1000000 keysum=1000115600710, performing 15392257 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999593 pref_millis=1102 prefill_elapsed_ms=1115 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6980492.954342218 REALTIME_END_PERF_FORMAT=6980502.954502485 ############################################################################### ################################## 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.028s tree_stats_numInternalsAtDepth=0 tree_stats_numLeavesAtDepth=1 tree_stats_numNodesAtDepth=1 tree_stats_numKeysAtDepth=1000738 tree_stats_avgDegreeAtDepth=1.00074e+06 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=1000738 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=1.00074e+06 tree_stats_avgDegree=1.00074e+06 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=84810 85049 86150 86190 85833 85179 84901 85200 86201 86815 85775 84901 85121 85373 86387 86528 85956 85403 83993 84952 86028 86586 85481 84888 84241 85126 85925 85807 85575 84283 84669 84886 86233 86966 85313 85293 85049 85452 86580 85892 85803 85618 84075 85003 85698 86729 85438 84845 sum_num_inserts_total=4104199 sum_num_deletes_by_thread=84698 84992 86173 85866 85120 84930 85240 85281 86623 86491 86393 85854 84597 85631 86242 86383 85524 84981 84364 85122 86568 86800 85198 84838 84140 85134 85819 85754 85202 84375 84215 85091 86065 86515 85604 85555 85402 85059 86409 86339 85717 86017 84453 85295 85944 86994 85344 84548 sum_num_deletes_total=4104899 sum_num_searches_by_thread=16722805 16810166 17015070 16972268 16999021 16747187 16794052 16890696 17153444 17150420 16968229 16913779 16852314 16901467 17103059 17132032 17000683 16942608 16695177 16874569 17067032 17158778 16907520 16809867 16716988 16817208 17004140 16952596 16953252 16735828 16764831 16865607 17106970 17124484 16952017 16889320 16846425 16910663 17080187 17092991 16968321 16918294 16697579 16865943 17048426 17145159 16891102 16792847 sum_num_searches_total=812723421 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16892313 16980207 17187393 17144324 17169974 16917296 16964193 17061177 17326268 17323726 17140397 17084534 17022032 17072471 17275688 17304943 17172163 17112992 16863534 17044643 17239628 17332164 17078199 16979593 16885369 16987468 17175884 17124157 17124029 16904486 16933715 17035584 17279268 17297965 17122934 17060168 17016876 17081174 17253176 17265222 17139841 17089929 16866107 17036241 17220068 17318882 17061884 16962240 average_num_operations_total=17102760 stdev_num_operations_total=19855 sum_num_operations_total=820932519 min_num_operations_total=16863534 max_num_operations_total=17332164 first_time_thread_terminate_by_thread=10000159 10000158 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000158 10000159 10000159 10000159 10000158 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000159 10000159 10000159 min_time_thread_terminate_total=10000158 max_time_thread_terminate_total=10000159 first_time_thread_start_by_thread=3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 min_time_thread_start_total=3 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=1001006620020 threads_final_size=1000738 final_keysum=1001006620020 final_size=1000738 validate_result=success Validation OK. Structural validation OK. total_find=812723421 total_rq=0 total_inserts=4104199 total_deletes=4104899 total_updates=8209098 total_queries=812723421 total_ops=820932519 find_throughput=81272342 rq_throughput=0 update_throughput=820909 query_throughput=81272342 total_throughput=82093251 total find : 812723421 total rq : 0 total inserts : 4104199 total deletes : 4104899 total updates : 8209098 total queries : 812723421 total ops : 820932519 find throughput : 81272342 rq throughput : 0 update throughput : 820909 query throughput : 81272342 total throughput : 82093251 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=19.3044 PAPI_L3_TCM=0.444069 PAPI_TOT_CYC=1540.04 PAPI_TOT_INS=715.971 garbage=406333635185001 total_execution_walltime=11.336s REALTIME_MAIN_END_PERF_FORMAT=6980503.7942764 [time_cmd_output] time_elapsed_sec=11.47, faults_major=0, faults_minor=119037, mem_maxresident_kb=417528, user_cputime=549.05, sys_cputime=3.92, percent_cpu=4818% 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