__step=000866 __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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000866.txt __path_data=data/data000866.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6989405.454256686 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=2000000 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.006s prefilling_size=999666 prefilling_elapsed_millis=1.001s finished prefilling to size 999644 for expected size 1000000 keysum=998830960970, performing 16045877 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999644 pref_millis=1102 prefill_elapsed_ms=1123 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=912 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=6989406.750623344 REALTIME_END_PERF_FORMAT=6989416.750765052 ############################################################################### ################################## 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.058s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16364 32403 62221 109962 167096 203218 186290 123830 58288 19359 4599 773 103 11 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 20 325 2585 14480 52828 130974 220146 248750 189372 97217 34119 8425 1443 195 22 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32728 64806 124442 219924 334192 406436 372580 247660 116576 38718 9198 1546 206 22 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 20 325 2585 14480 52828 130974 220146 248750 189372 97217 34119 8425 1443 195 22 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99878 1.99007 1.96011 1.88364 1.75979 1.60809 1.45835 1.33236 1.23535 1.16606 1.11878 1.08404 1.06662 1.0534 1 tree_stats_height=29 tree_stats_numInternals=1000900 tree_stats_numLeaves=1000901 tree_stats_numNodes=2001801 tree_stats_numKeys=1000901 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=20.8151 tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1832768 3629136 6968752 12315744 18714752 22760416 20864480 13868960 6528256 2168208 515088 86576 11536 1232 tree_stats_sizeInBytes=112100856 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=9650 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:0 2:2 4:0 8:0 16:0 32:4 64:8590 128:237318 256:233161 512:733 (2^01, 2^02]: 2 (2^02, 2^03]: 0 (2^03, 2^04]: 0 (2^04, 2^05]: 0 (2^05, 2^06]: 4 (2^06, 2^07]: 8590 (2^07, 2^08]: 237318 (2^08, 2^09]: 233161 (2^09, 2^10]: 733 sum_limbo_reclamation_event_size_total=132467195 count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 count_limbo_reclamation_event_size_total=479808 sum_limbo_reclamation_event_count_total=838828 first_thread_announced_epoch_by_thread=19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 19300 sum_num_inserts_by_thread=1597296 1605480 1610097 1606914 1609286 1592669 1597994 1602517 1616545 1617210 1603879 1597346 1599816 1606784 1615828 1611828 1608308 1601170 1593798 1598913 1610765 1616104 1599120 1588735 1600483 1603795 1606546 1607034 1607309 1594441 1600018 1604582 1616317 1618495 1604469 1595386 1600281 1607888 1616563 1609336 1609704 1598733 1589246 1596193 1609927 1612678 1600429 1592490 sum_num_inserts_total=77010745 sum_num_deletes_by_thread=1595909 1601912 1608512 1610173 1609051 1591847 1599001 1599863 1616037 1616302 1602581 1598370 1601864 1605152 1614607 1611140 1608082 1598355 1589426 1600682 1609407 1610914 1600076 1591430 1597879 1600313 1611602 1607545 1606732 1590453 1597067 1603008 1616844 1617202 1605449 1596979 1602501 1609671 1614918 1612116 1609664 1599825 1591432 1598090 1609302 1615139 1602208 1593356 sum_num_deletes_total=76999988 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3193205 3207392 3218609 3217087 3218337 3184516 3196995 3202380 3232582 3233512 3206460 3195716 3201680 3211936 3230435 3222968 3216390 3199525 3183224 3199595 3220172 3227018 3199196 3180165 3198362 3204108 3218148 3214579 3214041 3184894 3197085 3207590 3233161 3235697 3209918 3192365 3202782 3217559 3231481 3221452 3219368 3198558 3180678 3194283 3219229 3227817 3202637 3185846 average_num_operations_total=3208556 stdev_num_operations_total=2254 sum_num_operations_total=154010733 min_num_operations_total=3180165 max_num_operations_total=3235697 first_time_thread_terminate_by_thread=10000141 10000141 10000142 10000141 10000141 10000142 10000142 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000142 10000142 10000141 10000141 10000142 10000142 10000144 10000141 10000150 10000142 10000141 10000141 10000142 10000142 10000141 10000141 10000144 10000141 10000141 10000142 10000142 10000141 10000141 10000141 10000141 10000142 10000142 min_time_thread_terminate_total=10000141 max_time_thread_terminate_total=10000150 first_time_thread_start_by_thread=2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 2 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 2 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=1000782427030 threads_final_size=1000901 final_keysum=1000782427030 final_size=1000901 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=77010745 total_deletes=76999988 total_updates=154010733 total_queries=0 total_ops=154010733 find_throughput=0 rq_throughput=0 update_throughput=15401073 query_throughput=0 total_throughput=15401073 total find : 0 total rq : 0 total inserts : 77010745 total deletes : 76999988 total updates : 154010733 total queries : 0 total ops : 154010733 find throughput : 0 rq throughput : 0 update throughput : 15401073 query throughput : 0 total throughput : 15401073 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=50.6254 PAPI_L3_TCM=10.802 PAPI_TOT_CYC=8631.31 PAPI_TOT_INS=2004.18 garbage=0 total_execution_walltime=11.437s REALTIME_MAIN_END_PERF_FORMAT=6989416.893381098 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=131094, mem_maxresident_kb=525988, user_cputime=559.86, sys_cputime=5.29, percent_cpu=4883% 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