__step=000484 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_sigouin_int_avl_tm_auto.debra.hybridnorec -nwork 96 -nprefill 96 -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=data000484.txt __path_data=data/data000484.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7000632.189778661 binary=./brown_sigouin_int_avl_tm_auto.debra.hybridnorec parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_sigouin_int_avl_tm_auto 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=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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 sizes: node=48 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 Hybrid noREC system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.044s prefilling_size=96365 prefilling_elapsed_millis=1.001s prefilling_size=97318 prefilling_elapsed_millis=1.101s prefilling_size=98181 prefilling_elapsed_millis=1.201s finished prefilling to size 98174 for expected size 100000 keysum=9811718074, performing 802329 updates; total_prefilling_elapsed_ms=1303 ms) pref_size=98174 pref_millis=1303 prefill_elapsed_ms=1328 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7000633.744479734 REALTIME_END_PERF_FORMAT=7000643.744565474 ############################################################################### ################################## 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.042s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4090 7997 13479 15643 9557 2324 182 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 6 166 2124 9006 16229 11726 2939 230 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8163 15603 24649 25786 14050 3121 230 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8163 15603 24649 25786 14050 3121 230 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99438 1.93177 1.71589 1.4115 1.17424 1.05673 1.01538 1 tree_stats_height=20 tree_stats_numInternals=57367 tree_stats_numLeaves=42426 tree_stats_numNodes=99793 tree_stats_numKeys=99793 tree_stats_avgDegreeInternal=1.73955 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42514 tree_stats_avgKeyDepth=14.9949 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=98304 first_thread_announced_epoch_by_thread=2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 2068 sum_num_inserts_by_thread=32523 32480 32891 34172 33622 33717 32745 32179 32994 33518 32704 33248 32378 33184 33155 34581 33493 33542 32718 31991 33419 33634 32396 32752 32595 32377 33364 33784 33629 33238 32914 32367 33217 34022 33350 33256 32275 32734 32996 33907 32951 33451 32527 32869 32860 33948 32714 33191 32875 33105 33045 33173 33642 33386 32134 33311 33347 34209 33812 33458 32738 32848 33956 33963 33541 33564 32888 32747 33392 33271 33981 34322 32660 32634 33343 34510 33735 32952 32738 32735 33362 34456 33230 34108 32744 32226 33554 34585 34390 33950 33471 32538 33379 32981 33733 34009 sum_num_inserts_total=3191303 sum_num_deletes_by_thread=32700 32861 32923 34078 33958 34029 32951 31979 32852 33366 32663 33158 32658 33006 33337 34156 33936 33245 32495 31816 33202 33359 32572 32327 32426 32425 33210 34152 33956 33623 33099 32349 32708 34091 33372 33382 32147 32870 33186 34507 33059 33428 32633 32695 32866 34008 32592 32893 32842 32998 32946 33109 33918 32884 32180 33155 33508 34198 33816 33499 33030 32551 33754 33802 33949 33474 32846 32861 33509 33437 33816 33868 32973 32316 32833 33965 33841 32742 32585 32874 33334 34138 33276 34084 32981 32569 33347 34870 34292 34444 33300 32438 33314 33044 34011 33781 sum_num_deletes_total=3190606 sum_num_searches_by_thread=588214 590005 592597 616788 605443 611493 589228 573394 594054 601532 588616 598206 589260 597314 596985 619477 605685 600594 587984 576319 598112 600693 583812 586673 584225 580694 598355 613307 610996 599282 592017 582684 589779 608662 600584 599648 577414 593105 600786 617896 590092 602720 586374 587635 593138 608493 589096 593219 590768 595064 594756 600769 610197 595609 578495 595450 602209 617492 609251 602762 592798 587913 605368 609042 603446 601861 587119 587237 601135 598839 605973 618235 588298 588237 597894 615798 600097 593946 584227 592834 600764 620214 599836 609313 589834 584582 600867 623247 613776 617278 596630 587204 600992 600718 612043 612069 sum_num_searches_total=57415165 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=653437 655346 658411 685038 673023 679239 654924 637552 659900 668416 653983 664612 654296 663504 663477 688214 673114 667381 653197 640126 664733 667686 648780 651752 649246 645496 664929 681243 678581 666143 658030 647400 655704 676775 667306 666286 641836 658709 666968 686310 656102 669599 651534 653199 658864 676449 654402 659303 656485 661167 660747 667051 677757 661879 642809 661916 669064 685899 676879 669719 658566 653312 673078 676807 670936 668899 652853 652845 668036 665547 673770 686425 653931 653187 664070 684273 667673 659640 649550 658443 667460 688808 666342 677505 655559 649377 667768 692702 682458 685672 663401 652180 667685 666743 679787 679859 average_num_operations_total=664552 stdev_num_operations_total=1250 sum_num_operations_total=63797074 min_num_operations_total=637552 max_num_operations_total=692702 first_time_thread_terminate_by_thread=10000118 10000143 10000085 10000223 10000131 10000186 10000085 10000219 10000217 10000120 10000140 10000166 10000175 10000085 10000232 10000142 10000085 10000085 10000216 10000188 10000113 10000178 10000180 10000157 10000207 10000089 10000134 10000221 10000231 10000183 10000225 10000218 10000085 10000212 10000108 10000232 10000210 10000159 10000168 10000214 10000220 10000154 10000193 10000138 10000113 10000208 10000144 10000169 10000086 10000171 10000204 10000084 10000094 10000156 10000225 10000203 10000197 10000181 10000192 10000224 10000184 10000099 10000103 10000091 10000151 10000084 10000163 10000106 10000173 10000084 10000149 10000162 10000121 10000147 10000196 10000091 10000202 10000084 10000200 10000084 10000135 10000084 10000111 10000228 10000229 10000227 10000153 10000230 10000191 10000199 10000096 10000131 10000126 10000123 10000115 10000201 min_time_thread_terminate_total=10000084 max_time_thread_terminate_total=10000232 first_time_thread_start_by_thread=4 4 4 4 4 4 4 5 4 4 5 4 5 5 5 4 4 5 4 4 4 4 5 4 4 4 4 4 4 4 4 5 4 4 5 4 5 4 5 4 4 5 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=9956659131 threads_final_size=99793 final_keysum=9956659131 final_size=99793 validate_result=success Validation OK. Structural validation OK. total_find=57415165 total_rq=0 total_inserts=3191303 total_deletes=3190606 total_updates=6381909 total_queries=57415165 total_ops=63797074 find_throughput=5741516 rq_throughput=0 update_throughput=638190 query_throughput=5741516 total_throughput=6379707 total find : 57415165 total rq : 0 total inserts : 3191303 total deletes : 3190606 total updates : 6381909 total queries : 57415165 total ops : 63797074 find throughput : 5741516 rq throughput : 0 update throughput : 638190 query throughput : 5741516 total throughput : 6379707 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=18.579 PAPI_L3_TCM=3.3354 PAPI_TOT_CYC=41720.7 PAPI_TOT_INS=5808.76 garbage=2869585139963 total_execution_walltime=11.763s REALTIME_MAIN_END_PERF_FORMAT=7000643.953677139 Hybrid noREC system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 61664514 [slow htm] [fallback] total fallback commit : 2934890 seconds global lock is held : 0.475225 [time_cmd_output] time_elapsed_sec=11.89, faults_major=0, faults_minor=101478, mem_maxresident_kb=403236, user_cputime=1112.54, sys_cputime=4.65, percent_cpu=9395% timeout=false algorithm=brown_sigouin_int_avl_tm_auto.debra.hybridnorec thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2