__step=000922 __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=data000922.txt __path_data=data/data000922.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6990061.896984911 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.004s prefilling_size=100253 prefilling_elapsed_millis=1.001s finished prefilling to size 100255 for expected size 100000 keysum=10008244426, performing 15340739 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100255 pref_millis=1102 prefill_elapsed_ms=1131 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990063.165787886 REALTIME_END_PERF_FORMAT=6990073.165931581 ############################################################################### ################################## 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=100145 tree_stats_avgDegreeAtDepth=100145 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=100145 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=100145 tree_stats_avgDegree=100146 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=1614256 1609614 1617261 1609376 1609562 1611223 1618972 1609624 1615950 1616686 1613847 1610989 1620324 1605683 1611673 1612042 1615085 1608875 1606309 1611085 1614832 1615069 1602370 1601810 1617163 1612995 1619825 1614527 1607742 1610468 1619604 1613065 1623638 1615304 1618228 1611993 1622975 1608520 1613576 1612059 1612608 1615472 1611725 1613968 1614832 1618063 1602910 1605471 sum_num_inserts_total=77419248 sum_num_deletes_by_thread=1615124 1610583 1619695 1609394 1610065 1611983 1617926 1610417 1615883 1615657 1611159 1612099 1621558 1608395 1610614 1609440 1613406 1609592 1607005 1610977 1614217 1615712 1602477 1603659 1618563 1613290 1619799 1610192 1610388 1612149 1618881 1611109 1621998 1615340 1615136 1615459 1624948 1610019 1616348 1614973 1612531 1616016 1612349 1613451 1613907 1617008 1605040 1607857 sum_num_deletes_total=77433788 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3229380 3220197 3236956 3218770 3219627 3223206 3236898 3220041 3231833 3232343 3225006 3223088 3241882 3214078 3222287 3221482 3228491 3218467 3213314 3222062 3229049 3230781 3204847 3205469 3235726 3226285 3239624 3224719 3218130 3222617 3238485 3224174 3245636 3230644 3233364 3227452 3247923 3218539 3229924 3227032 3225139 3231488 3224074 3227419 3228739 3235071 3207950 3213328 average_num_operations_total=3226104 stdev_num_operations_total=1381 sum_num_operations_total=154853036 min_num_operations_total=3204847 max_num_operations_total=3247923 first_time_thread_terminate_by_thread=10000143 10000142 10000142 10000143 10000143 10000144 10000142 10000143 10000143 10000143 10000142 10000142 10000144 10000143 10000143 10000144 10000144 10000144 10000142 10000144 10000144 10000144 10000144 10000144 10000143 10000142 10000142 10000142 10000144 10000144 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000144 10000144 10000142 10000144 10000144 10000144 10000144 10000144 min_time_thread_terminate_total=10000142 max_time_thread_terminate_total=10000144 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 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=4 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=10024747907 threads_final_size=100145 final_keysum=10024747907 final_size=100145 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=77419248 total_deletes=77433788 total_updates=154853036 total_queries=0 total_ops=154853036 find_throughput=0 rq_throughput=0 update_throughput=15485303 query_throughput=0 total_throughput=15485303 total find : 0 total rq : 0 total inserts : 77419248 total deletes : 77433788 total updates : 154853036 total queries : 0 total ops : 154853036 find throughput : 0 rq throughput : 0 update throughput : 15485303 query throughput : 0 total throughput : 15485303 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=51.4091 PAPI_L3_TCM=2.90459 PAPI_TOT_CYC=8641.17 PAPI_TOT_INS=1057.22 garbage=0 total_execution_walltime=11.299s REALTIME_MAIN_END_PERF_FORMAT=6990073.196571170 [time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=112175, mem_maxresident_kb=439968, user_cputime=550.18, sys_cputime=4.10, percent_cpu=4843% 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