__step=000201 __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" ./bronson_pext_bst_occ.debra -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=data000201.txt __path_data=data/data000201.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6981229.463533264 binary=./bronson_pext_bst_occ.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=bronson_pext_bst_occ 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 sizes: node=56 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.006s prefilling_size=999587 prefilling_elapsed_millis=1.001s finished prefilling to size 999581 for expected size 1000000 keysum=999859807470, performing 42674355 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999581 pref_millis=1102 prefill_elapsed_ms=1122 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=1969 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6981230.730718119 REALTIME_END_PERF_FORMAT=6981240.730864985 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10s PRODUCING OUTPUT computing tree_stats in PARALLEL... bounded depth BFS to partition into subtrees for parallel computation (192 threads)... partitioned into 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.036s tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65432 125747 192280 167993 62044 6775 89 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 103 4675 50672 172463 203003 80927 8632 104 tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65535 130422 242952 340456 265047 87702 8721 104 tree_stats_numKeysAtDepth=0 1 0 4 1 6 17 35 57 116 253 526 1032 2047 4038 8143 16650 35213 81050 188143 308781 257825 87226 8717 104 tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99997 1.99168 1.89866 1.60989 1.28506 1.09677 1.02213 1.00172 1 tree_stats_height=25 tree_stats_numInternals=685896 tree_stats_numLeaves=520579 tree_stats_numNodes=1206475 tree_stats_numKeys=999985 tree_stats_avgDegreeInternal=1.75898 tree_stats_avgDegreeLeaves=0.99996 tree_stats_avgDegree=1.43147 tree_stats_avgKeyDepth=19.8387 tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3669960 7303632 13605312 19065536 14842632 4911312 488376 5824 tree_stats_sizeInBytes=67562600 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=24954 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:145947 2:103249 4:12649 8:40 [2^00, 2^01]: 145947 (2^01, 2^02]: 103249 (2^02, 2^03]: 12649 (2^03, 2^04]: 40 sum_limbo_reclamation_event_size_total=436020 count_limbo_reclamation_event_size_by_thread=5390 5420 5412 5485 5415 5456 5464 5461 5556 5491 5389 5446 5466 5443 5577 5522 5444 5570 5433 5411 5517 5429 5591 5352 5474 5572 5450 5480 5333 5340 5527 5475 5429 5526 5361 5341 5578 5376 5461 5581 5460 5527 5423 5456 5408 5449 5372 5346 count_limbo_reclamation_event_size_total=261885 sum_limbo_reclamation_event_count_total=1103282 first_thread_announced_epoch_by_thread=49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 49908 sum_num_inserts_by_thread=52758 52652 53265 52840 52908 51801 52546 52800 52876 53648 51949 52454 52156 52266 52659 53035 53359 52171 52637 52597 52660 52911 51720 51962 51888 52291 53324 53858 52926 52316 52024 52146 53557 53276 53024 52795 52524 53121 53775 52817 52660 52827 51723 52823 53135 53139 53016 52187 sum_num_inserts_total=2529802 sum_num_deletes_by_thread=52743 52251 53152 52645 52971 51833 52372 53071 53721 54057 52253 52881 51866 52333 52872 52928 53082 52367 52239 52947 52313 52662 52521 52316 52273 52226 53153 53197 52533 52264 52344 52158 52874 53762 52779 52849 52470 53312 53394 52608 52483 52905 52243 52775 53025 53177 52665 52506 sum_num_deletes_total=2530371 sum_num_searches_by_thread=10386099 10367631 10548135 10449852 10498728 10266234 10335503 10463001 10517052 10602962 10379854 10416922 10343642 10386085 10449901 10464038 10513448 10330782 10367242 10442354 10404383 10454287 10346300 10330556 10304306 10337899 10550945 10544876 10499165 10376400 10333927 10372789 10515703 10607324 10488284 10425545 10347381 10493029 10577707 10459408 10416258 10430127 10350438 10417149 10470876 10553004 10425918 10332411 sum_num_searches_total=500695860 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10491600 10472534 10654552 10555337 10604607 10369868 10440421 10568872 10623649 10710667 10484056 10522257 10447664 10490684 10555432 10570001 10619889 10435320 10472118 10547898 10509356 10559860 10450541 10434834 10408467 10442416 10657422 10651931 10604624 10480980 10438295 10477093 10622134 10714362 10594087 10531189 10452375 10599462 10684876 10564833 10521401 10535859 10454404 10522747 10577036 10659320 10531599 10437104 average_num_operations_total=10536584 stdev_num_operations_total=12405 sum_num_operations_total=505756033 min_num_operations_total=10369868 max_num_operations_total=10714362 first_time_thread_terminate_by_thread=10000145 10000146 10000145 10000146 10000146 10000146 10000145 10000146 10000146 10000145 10000146 10000145 10000146 10000146 10000146 10000146 10000146 10000145 10000146 10000146 10000146 10000146 10000146 10000146 10000145 10000146 10000145 10000146 10000146 10000146 10000145 10000146 10000146 10000145 10000146 10000145 10000146 10000146 10000146 10000146 10000146 10000145 10000146 10000146 10000146 10000146 10000146 10000146 min_time_thread_terminate_total=10000145 max_time_thread_terminate_total=10000146 first_time_thread_start_by_thread=3 3 3 4 3 3 3 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 4 3 3 4 3 3 3 3 3 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=1001116367765 threads_final_size=999985 final_keysum=1001116367765 final_size=999985 validate_result=success Validation OK. Structural validation OK. total_find=500695860 total_rq=0 total_inserts=2529802 total_deletes=2530371 total_updates=5060173 total_queries=500695860 total_ops=505756033 find_throughput=50069586 rq_throughput=0 update_throughput=506017 query_throughput=50069586 total_throughput=50575603 total find : 500695860 total rq : 0 total inserts : 2529802 total deletes : 2530371 total updates : 5060173 total queries : 500695860 total ops : 505756033 find throughput : 50069586 rq throughput : 0 update throughput : 506017 query throughput : 50069586 total throughput : 50575603 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=16.7001 PAPI_L3_TCM=2.52574 PAPI_TOT_CYC=2602.51 PAPI_TOT_INS=1065.36 garbage=250438090851702 total_execution_walltime=11.403s REALTIME_MAIN_END_PERF_FORMAT=6981240.867362794 [time_cmd_output] time_elapsed_sec=11.52, faults_major=0, faults_minor=94309, mem_maxresident_kb=379004, user_cputime=560.37, sys_cputime=3.01, percent_cpu=4889% timeout=false algorithm=bronson_pext_bst_occ.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1