__step=000585 __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=data000585.txt __path_data=data/data000585.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985919.811819899 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.019s prefilling_size=100211 prefilling_elapsed_millis=1.001s finished prefilling to size 100211 for expected size 100000 keysum=10031766538, performing 14979190 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100211 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985921.105933507 REALTIME_END_PERF_FORMAT=6985931.106096397 ############################################################################### ################################## 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=99922 tree_stats_avgDegreeAtDepth=99922 tree_stats_height=1 tree_stats_numInternals=0 tree_stats_numLeaves=1 tree_stats_numNodes=1 tree_stats_numKeys=99922 tree_stats_avgDegreeInternal=0 tree_stats_avgDegreeLeaves=99922 tree_stats_avgDegree=99923 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=606992 609023 614301 602318 600833 597770 611231 612612 615773 609713 606879 602895 613554 605422 616693 605643 607130 605033 613819 613392 620144 609460 608086 603593 605370 612546 614749 602674 600958 597225 611920 611920 615510 609064 607461 603891 614936 604199 618621 604875 607104 604660 614477 613353 620294 608337 607732 602496 sum_num_inserts_total=29226681 sum_num_deletes_by_thread=606478 609804 614826 601531 602084 596538 613038 613610 616720 610286 608129 602683 613760 606820 617750 606163 607367 604851 613984 614487 620098 609140 607510 603453 607352 612090 615799 602224 600054 597121 612799 610629 613901 608317 606139 602296 615024 605429 618003 607337 606507 604694 613280 612948 619665 608549 608898 601842 sum_num_deletes_total=29232007 sum_num_searches_by_thread=10920676 10960686 11069027 10842254 10827778 10757574 11028558 11027806 11092258 10971637 10937327 10845815 11053634 10894399 11119155 10900132 10921856 10896135 11035608 11028135 11165613 10958251 10946236 10833189 10927266 11012601 11079331 10837496 10816283 10750369 11026204 11011651 11070051 10963501 10908413 10868499 11063986 10910935 11122292 10893423 10925330 10894333 11030748 11027488 11157135 10958694 10933746 10835066 sum_num_searches_total=526058580 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=12134146 12179513 12298154 12046103 12030695 11951882 12252827 12254028 12324751 12191636 12152335 12051393 12280948 12106641 12353598 12111938 12136353 12106019 12263411 12256014 12405855 12176851 12161832 12040235 12139988 12237237 12309879 12042394 12017295 11944715 12250923 12234200 12299462 12180882 12122013 12074686 12293946 12120563 12358916 12105635 12138941 12103687 12258505 12253789 12397094 12175580 12150376 12039404 average_num_operations_total=12177443 stdev_num_operations_total=16462 sum_num_operations_total=584517268 min_num_operations_total=11944715 max_num_operations_total=12405855 first_time_thread_terminate_by_thread=10000161 10000162 10000162 10000161 10000162 10000161 10000162 10000162 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000161 10000161 10000162 10000162 10000162 10000161 10000162 10000161 10000162 10000161 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000161 10000161 10000162 10000161 10000162 10000161 10000162 10000161 10000162 min_time_thread_terminate_total=10000161 max_time_thread_terminate_total=10000162 first_time_thread_start_by_thread=5 6 6 6 6 6 6 5 5 5 5 5 6 5 5 5 5 5 6 5 6 5 5 5 5 6 6 6 6 6 6 5 5 5 5 5 6 5 5 5 5 5 6 5 6 5 5 5 min_time_thread_start_total=5 max_time_thread_start_total=6 sum_duration_all_ops_total= threads_final_keysum=9997166159 threads_final_size=99922 final_keysum=9997166159 final_size=99922 validate_result=success Validation OK. Structural validation OK. total_find=526058580 total_rq=0 total_inserts=29226681 total_deletes=29232007 total_updates=58458688 total_queries=526058580 total_ops=584517268 find_throughput=52605858 rq_throughput=0 update_throughput=5845868 query_throughput=52605858 total_throughput=58451726 total find : 526058580 total rq : 0 total inserts : 29226681 total deletes : 29232007 total updates : 58458688 total queries : 526058580 total ops : 584517268 find throughput : 52605858 rq throughput : 0 update throughput : 5845868 query throughput : 52605858 total throughput : 58451726 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=14.5831 PAPI_L3_TCM=0.368842 PAPI_TOT_CYC=2279.55 PAPI_TOT_INS=670.392 garbage=25756587052344 total_execution_walltime=11.323s REALTIME_MAIN_END_PERF_FORMAT=6985931.136628691 [time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=110227, mem_maxresident_kb=425056, user_cputime=547.71, sys_cputime=1.24, percent_cpu=4792% 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