__step=000003 __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_abtree_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000003.txt __path_data=data/data000003.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6978725.741043937 binary=./brown_ext_abtree_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_abtree_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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=20000000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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 size_node=208 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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.009s prefilling_size=8823691 prefilling_elapsed_millis=1.001s prefilling_size=9076864 prefilling_elapsed_millis=1.101s prefilling_size=9274914 prefilling_elapsed_millis=1.201s prefilling_size=9423448 prefilling_elapsed_millis=1.301s prefilling_size=9543925 prefilling_elapsed_millis=1.401s prefilling_size=9638395 prefilling_elapsed_millis=1.502s prefilling_size=9713343 prefilling_elapsed_millis=1.602s prefilling_size=9777664 prefilling_elapsed_millis=1.702s prefilling_size=9825061 prefilling_elapsed_millis=1.802s finished prefilling to size 9825083 for expected size 10000000 keysum=98254938769728, performing 81190897 updates; total_prefilling_elapsed_ms=1904 ms) pref_size=9825083 pref_millis=1904 prefill_elapsed_ms=1923 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=1464 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6978727.848606198 REALTIME_END_PERF_FORMAT=6978737.848754271 ############################################################################### ################################## 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 3571 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.055s tree_stats_numInternalsAtDepth=1 1 8 65 476 3571 26508 207973 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1640725 tree_stats_numNodesAtDepth=1 1 8 65 476 3571 26508 207973 1640725 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9903555 tree_stats_avgDegreeAtDepth=1 8 8.125 7.32308 7.5021 7.42313 7.84567 7.88913 6.03608 tree_stats_height=9 tree_stats_numInternals=238603 tree_stats_numLeaves=1640725 tree_stats_numNodes=1879328 tree_stats_numKeys=9903555 tree_stats_avgDegreeInternal=7.87638 tree_stats_avgDegreeLeaves=6.03608 tree_stats_avgDegree=6.26973 tree_stats_avgKeyDepth=8 tree_stats_bytesAtDepth=208 208 1664 13520 99008 742768 5513664 43258384 341270800 tree_stats_sizeInBytes=390900224 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=15050 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:42492 2:247384 4:547537 8:113202 16:218 [2^00, 2^01]: 42492 (2^01, 2^02]: 247384 (2^02, 2^03]: 547537 (2^03, 2^04]: 113202 (2^04, 2^05]: 218 sum_limbo_reclamation_event_size_total=4576743 count_limbo_reclamation_event_size_by_thread=9904 9897 9915 9904 9902 9896 9898 9914 9903 9905 9888 9890 9890 9926 9914 9904 9905 9907 9899 9904 9889 9906 9920 9887 9910 9906 9909 9930 9890 9875 9892 9908 9907 9899 9909 9893 9898 9903 9909 9913 9917 9894 9892 9912 9911 9903 9903 9899 9910 9906 9900 9907 9897 9906 9906 9910 9915 9897 9888 9898 9905 9909 9922 9918 9910 9923 9893 9889 9898 9920 9908 9910 9900 9920 9918 9922 9902 9903 9906 9901 9901 9895 9886 9917 9904 9908 9922 9903 9901 9909 9891 9907 9913 9903 9903 9904 count_limbo_reclamation_event_size_total=950833 sum_limbo_reclamation_event_count_total=1304256 first_thread_announced_epoch_by_thread=30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 30100 sum_num_inserts_by_thread=62295 62588 63478 62658 62502 62275 62498 62398 63281 63164 62139 62018 62395 63006 63180 62527 62529 62584 61582 62605 62547 62897 62332 61791 62244 63373 62778 62974 62923 62527 61875 62433 63429 63235 62637 61604 62594 62618 63110 62623 62566 62240 61615 61797 62624 63104 61987 61320 63456 62907 63385 62088 63501 62013 62648 62942 64604 63718 62790 62491 62562 63339 62967 64290 63456 62044 61151 61922 63609 63191 62796 62187 62791 62853 63456 62939 62520 61625 62517 62905 63137 63276 62249 62553 62686 62903 64067 64033 63699 63355 62956 63963 64224 64004 64018 63725 sum_num_inserts_total=6028010 sum_num_deletes_by_thread=62468 62730 62929 63047 62369 62161 62308 62446 63421 63438 62300 61774 61933 63096 63353 62311 62460 62325 62041 61765 62725 62836 62227 61374 62518 63076 63135 63515 62981 62524 62511 62530 63141 63336 62277 61515 62045 62867 63041 62783 62496 62183 61438 61514 62935 63369 61855 60485 62665 62773 63354 62735 63251 62767 62583 62688 63754 63486 62851 61877 63082 63393 63309 63834 63435 62552 61996 61810 63549 63602 62551 62187 62832 63233 62914 62962 62822 61593 62464 62371 63441 63491 62639 62466 62687 63048 64717 64673 63841 63188 63230 63185 64394 64260 64370 63605 sum_num_deletes_total=6028417 sum_num_searches_by_thread=12311840 12382832 12537119 12461883 12414002 12307067 12325038 12377679 12533116 12568921 12363010 12284735 12313432 12455773 12452008 12392616 12397774 12381083 12261424 12324838 12411766 12499285 12341644 12227797 12345982 12464122 12495229 12471706 12425513 12304587 12319080 12349213 12517457 12565266 12396567 12197602 12317939 12417824 12455320 12425883 12382092 12353029 12150708 12155711 12395428 12452057 12297486 12100592 12459300 12437357 12568333 12396545 12473104 12380238 12338108 12456296 12665347 12636946 12435750 12370827 12463456 12498076 12545533 12589662 12531442 12338874 12226133 12292646 12580871 12497513 12431267 12304981 12418020 12421124 12518524 12503403 12416742 12250092 12423224 12449478 12540356 12582582 12429370 12411568 12417175 12396408 12743441 12734563 12636948 12519321 12493087 12574605 12737889 12744529 12689731 12602991 sum_num_searches_total=1193656851 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=12436603 12508150 12663526 12587588 12538873 12431503 12449844 12502523 12659818 12695523 12487449 12408527 12437760 12581875 12578541 12517454 12522763 12505992 12385047 12449208 12537038 12625018 12466203 12350962 12470744 12590571 12621142 12598195 12551417 12429638 12443466 12474176 12644027 12691837 12521481 12320721 12442578 12543309 12581471 12551289 12507154 12477452 12273761 12279022 12520987 12578530 12421328 12222397 12585421 12563037 12695072 12521368 12599856 12505018 12463339 12581926 12793705 12764150 12561391 12495195 12589100 12624808 12671809 12717786 12658333 12463470 12349280 12416378 12708029 12624306 12556614 12429355 12543643 12547210 12644894 12629304 12542084 12373310 12548205 12574754 12666934 12709349 12554258 12536587 12542548 12522359 12872225 12863269 12764488 12645864 12619273 12701753 12866507 12872793 12818119 12730321 average_num_operations_total=12559513 stdev_num_operations_total=13457 sum_num_operations_total=1205713278 min_num_operations_total=12222397 max_num_operations_total=12872793 first_time_thread_terminate_by_thread=10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000149 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000149 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000147 10000147 10000149 10000147 10000148 10000148 10000147 10000148 10000147 10000147 10000149 10000147 10000149 10000149 10000147 10000147 10000149 10000148 10000147 10000147 10000147 10000149 10000149 10000148 10000147 10000147 10000149 10000148 10000148 10000148 10000147 10000148 10000147 10000147 10000149 10000147 10000149 10000147 10000147 10000147 10000149 10000148 10000147 10000147 10000147 10000148 10000149 10000148 min_time_thread_terminate_total=10000147 max_time_thread_terminate_total=10000149 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=99037081271203 threads_final_size=9903555 final_keysum=99037081271203 final_size=9903555 validate_result=success Validation OK. Structural validation OK. total_find=1193656851 total_rq=0 total_inserts=6028010 total_deletes=6028417 total_updates=12056427 total_queries=1193656851 total_ops=1205713278 find_throughput=119365685 rq_throughput=0 update_throughput=1205642 query_throughput=119365685 total_throughput=120571327 total find : 1193656851 total rq : 0 total inserts : 6028010 total deletes : 6028417 total updates : 12056427 total queries : 1193656851 total ops : 1205713278 find throughput : 119365685 rq throughput : 0 update throughput : 1205642 query throughput : 119365685 total throughput : 120571327 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=17.1486 PAPI_L3_TCM=5.68988 PAPI_TOT_CYC=2207.28 PAPI_TOT_INS=381.457 garbage=5829537939333106 total_execution_walltime=12.29s REALTIME_MAIN_END_PERF_FORMAT=6978738.32594425 [time_cmd_output] time_elapsed_sec=12.46, faults_major=0, faults_minor=184013, mem_maxresident_kb=733320, user_cputime=1168.63, sys_cputime=4.00, percent_cpu=9410% timeout=false algorithm=brown_ext_abtree_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1