__step=000978 __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" ./brown_ext_chromatic_lf.debra -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=data000978.txt __path_data=data/data000978.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6990717.665487590 binary=./brown_ext_chromatic_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_chromatic_lf 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 sizes: node=56 descriptor=128 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=100219 prefilling_elapsed_millis=1.001s finished prefilling to size 100167 for expected size 100000 keysum=10008365068, performing 28595246 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100167 pref_millis=1102 prefill_elapsed_ms=1120 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=2123 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6990718.938002723 REALTIME_END_PERF_FORMAT=6990728.938150837 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s 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.04s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4089 7995 14474 21349 22407 15680 7314 2262 469 79 6 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 7 183 1516 7599 20291 29134 24046 12366 4055 859 152 12 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8178 15990 28948 42698 44814 31360 14628 4524 938 158 12 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 7 183 1516 7599 20291 29134 24046 12366 4055 859 152 12 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.97762 1.90519 1.73749 1.52478 1.34989 1.23323 1.15463 1.10367 1.08422 1.03797 1 tree_stats_height=24 tree_stats_numInternals=100219 tree_stats_numLeaves=100220 tree_stats_numNodes=200439 tree_stats_numKeys=100220 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=17.2435 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 457968 895440 1621088 2391088 2509584 1756160 819168 253344 52528 8848 672 tree_stats_sizeInBytes=11224584 4NodeIxPvE_object_size=56 4NodeIxPvE_allocated_count=0 4NodeIxPvE_allocated_size=0MB 4NodeIxPvE_get_from_pool=0 4NodeIxPvE_deallocated=0 4NodeIxPvE_limbo_count=0 4NodeIxPvE_limbo_details=0 0 0 global_epoch_counter=22918 9SCXRecordIxPvE_object_size=128 9SCXRecordIxPvE_allocated_count=0 9SCXRecordIxPvE_allocated_size=0MB 9SCXRecordIxPvE_get_from_pool=0 9SCXRecordIxPvE_deallocated=0 9SCXRecordIxPvE_limbo_count=0 9SCXRecordIxPvE_limbo_details=0 0 0 global_epoch_counter=0 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:6541 2:4968 4:2727 8:5854 16:13548 32:33367 64:74751 128:185690 256:138945 512:897 [2^00, 2^01]: 6541 (2^01, 2^02]: 4968 (2^02, 2^03]: 2727 (2^03, 2^04]: 5854 (2^04, 2^05]: 13548 (2^05, 2^06]: 33367 (2^06, 2^07]: 74751 (2^07, 2^08]: 185690 (2^08, 2^09]: 138945 (2^09, 2^10]: 897 sum_limbo_reclamation_event_size_total=100090023 count_limbo_reclamation_event_size_by_thread=9749 9763 9717 9728 9716 9749 9713 9733 9730 9726 9737 9727 9754 9761 9687 9735 9703 9744 9743 9769 9718 9757 9758 9769 9727 9720 9697 9731 9698 9750 9725 9744 9732 9748 9743 9713 9772 9717 9736 9741 9744 9735 9721 9754 9739 9727 9741 9747 count_limbo_reclamation_event_size_total=467288 sum_limbo_reclamation_event_count_total=1996274 first_thread_announced_epoch_by_thread=45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 45836 sum_num_inserts_by_thread=2856077 2873947 2880536 2875064 2877544 2862868 2867268 2870984 2872626 2894511 2882919 2860363 2861749 2881082 2871170 2882529 2874541 2860373 2858877 2860463 2891429 2883651 2870378 2860377 2861051 2867843 2880991 2877607 2877694 2854183 2871162 2874597 2886930 2910615 2870377 2855329 2859552 2878983 2879989 2889962 2868359 2862328 2856371 2867989 2887026 2880185 2869782 2859835 sum_num_inserts_total=137880066 sum_num_deletes_by_thread=2853111 2871557 2885719 2874136 2877912 2860893 2867387 2871780 2874354 2891554 2882034 2858619 2865847 2877773 2866416 2887173 2876469 2858747 2856039 2860546 2888885 2885230 2867681 2859927 2857428 2870923 2880941 2870872 2875822 2854462 2872855 2874665 2886763 2906192 2871856 2856580 2856831 2883620 2878114 2888937 2869153 2861834 2855181 2870196 2885532 2880040 2871372 2862844 sum_num_deletes_total=137862802 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=5709188 5745504 5766255 5749200 5755456 5723761 5734655 5742764 5746980 5786065 5764953 5718982 5727596 5758855 5737586 5769702 5751010 5719120 5714916 5721009 5780314 5768881 5738059 5720304 5718479 5738766 5761932 5748479 5753516 5708645 5744017 5749262 5773693 5816807 5742233 5711909 5716383 5762603 5758103 5778899 5737512 5724162 5711552 5738185 5772558 5760225 5741154 5722679 average_num_operations_total=5744643 stdev_num_operations_total=3440 sum_num_operations_total=275742868 min_num_operations_total=5708645 max_num_operations_total=5816807 first_time_thread_terminate_by_thread=10000147 10000147 10000186 10000147 10000198 10000176 10000147 10000147 10000147 10000147 10000147 10000209 10000148 10000147 10000147 10000147 10000173 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000173 10000147 10000186 10000149 10000147 10000147 10000147 10000147 10000147 10000157 10000147 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 min_time_thread_terminate_total=10000147 max_time_thread_terminate_total=10000209 first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 6 6 6 6 6 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 6 6 6 6 6 5 5 5 min_time_thread_start_total=5 max_time_thread_start_total=6 sum_duration_all_ops_total= threads_final_keysum=10025407328 threads_final_size=100220 final_keysum=10025407328 final_size=100220 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=137880066 total_deletes=137862802 total_updates=275742868 total_queries=0 total_ops=275742868 find_throughput=0 rq_throughput=0 update_throughput=27574286 query_throughput=0 total_throughput=27574286 total find : 0 total rq : 0 total inserts : 137880066 total deletes : 137862802 total updates : 275742868 total queries : 0 total ops : 275742868 find throughput : 0 rq throughput : 0 update throughput : 27574286 query throughput : 0 total throughput : 27574286 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=30.9502 PAPI_L3_TCM=0.3962 PAPI_TOT_CYC=4781.91 PAPI_TOT_INS=1635.93 garbage=0 total_execution_walltime=11.516s REALTIME_MAIN_END_PERF_FORMAT=6990729.182421366 [time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=82566, mem_maxresident_kb=331964, user_cputime=557.16, sys_cputime=6.63, percent_cpu=4844% timeout=false algorithm=brown_ext_chromatic_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2