__step=000269 __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 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000269.txt __path_data=data/data000269.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6997841.748133295 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=2000000 PREFILL_THREADS=144 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=144 WORK_THREADS=144 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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167 Hybrid noREC system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.037s prefilling_size=214015 prefilling_elapsed_millis=1s prefilling_size=232642 prefilling_elapsed_millis=1.1s prefilling_size=250955 prefilling_elapsed_millis=1.201s prefilling_size=268886 prefilling_elapsed_millis=1.301s prefilling_size=286102 prefilling_elapsed_millis=1.401s prefilling_size=303016 prefilling_elapsed_millis=1.501s prefilling_size=319441 prefilling_elapsed_millis=1.601s prefilling_size=335702 prefilling_elapsed_millis=1.702s prefilling_size=351348 prefilling_elapsed_millis=1.802s prefilling_size=366801 prefilling_elapsed_millis=1.902s prefilling_size=381751 prefilling_elapsed_millis=2.002s prefilling_size=396096 prefilling_elapsed_millis=2.102s prefilling_size=410482 prefilling_elapsed_millis=2.203s prefilling_size=424321 prefilling_elapsed_millis=2.303s prefilling_size=437966 prefilling_elapsed_millis=2.403s prefilling_size=451071 prefilling_elapsed_millis=2.503s prefilling_size=464153 prefilling_elapsed_millis=2.603s prefilling_size=476753 prefilling_elapsed_millis=2.704s prefilling_size=488863 prefilling_elapsed_millis=2.804s prefilling_size=500936 prefilling_elapsed_millis=2.904s prefilling_size=512773 prefilling_elapsed_millis=3.004s prefilling_size=524523 prefilling_elapsed_millis=3.104s prefilling_size=535757 prefilling_elapsed_millis=3.205s prefilling_size=546606 prefilling_elapsed_millis=3.305s prefilling_size=557145 prefilling_elapsed_millis=3.405s prefilling_size=567654 prefilling_elapsed_millis=3.505s prefilling_size=577699 prefilling_elapsed_millis=3.606s prefilling_size=587791 prefilling_elapsed_millis=3.706s prefilling_size=597419 prefilling_elapsed_millis=3.806s prefilling_size=606867 prefilling_elapsed_millis=3.906s prefilling_size=616220 prefilling_elapsed_millis=4.006s prefilling_size=625180 prefilling_elapsed_millis=4.107s prefilling_size=633912 prefilling_elapsed_millis=4.207s prefilling_size=642542 prefilling_elapsed_millis=4.307s prefilling_size=650814 prefilling_elapsed_millis=4.407s prefilling_size=659158 prefilling_elapsed_millis=4.508s prefilling_size=667039 prefilling_elapsed_millis=4.608s prefilling_size=675064 prefilling_elapsed_millis=4.708s prefilling_size=682664 prefilling_elapsed_millis=4.808s prefilling_size=690267 prefilling_elapsed_millis=4.908s prefilling_size=697287 prefilling_elapsed_millis=5.009s Info: prefilling requires an additional insert phase to complete. Info: prefilling using INSERTION ONLY. timing_start inserting 302656 keys with 144 threads... tid=0 thread_prefill_amount=5552 percent_done_estimate=264.2 elapsed_s=5 est_remaining_s=-7 / -2 tid=0 thread_prefill_amount=6940 percent_done_estimate=330.2 elapsed_s=6 est_remaining_s=-9 / -3 timing_elapsed 1.18119s prefilling_size=1000000 prefilling_elapsed_millis=1.184s finished prefilling to size 1000000 for expected size 1000000 keysum=999341629182, performing 2925520 updates; total_prefilling_elapsed_ms=1184 ms) pref_size=1000000 pref_millis=1184 prefill_elapsed_ms=1184 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6997848.298078578 REALTIME_END_PERF_FORMAT=6997858.298183523 ############################################################################### ################################## 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 (144 threads)... partitioned into 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.017s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32757 64758 116143 153600 120339 45737 6563 214 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 10 685 11547 63658 142664 140447 57698 8320 261 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65443 127690 217258 263003 186184 64261 8534 261 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65443 127690 217258 263003 186184 64261 8534 261 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99994 1.99753 1.96163 1.79188 1.50356 1.25036 1.09949 1.03067 1.00551 1 tree_stats_height=24 tree_stats_numInternals=572878 tree_stats_numLeaves=425290 tree_stats_numNodes=998168 tree_stats_numKeys=998168 tree_stats_avgDegreeInternal=1.74237 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42607 tree_stats_avgKeyDepth=18.3435 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=52080 first_thread_announced_epoch_by_thread=756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 756 sum_num_inserts_by_thread=19249 19734 19849 19452 19086 19221 20527 19872 19839 19910 19615 20110 19227 20285 19956 19279 19230 19176 19107 19192 20163 20127 19845 20006 19685 20040 19053 19505 19791 19371 19516 19629 20134 19180 20238 20535 19348 19490 19743 20110 19322 19869 19449 19771 19723 20009 19829 19723 18695 17306 17534 17910 17445 16988 17749 17735 17257 17403 17527 16768 18512 17281 18124 16968 17443 17456 18154 17665 17867 18094 18023 18200 18487 17032 17678 17328 17046 16767 18434 17837 17017 17987 17511 17586 18045 16995 17607 17872 17093 16762 18085 18191 17935 17822 18108 17807 12668 11787 12059 11837 12605 12586 12220 12249 12317 12259 12000 12537 12623 12454 11876 12574 12372 12632 12543 12176 12807 12803 12694 11946 12825 11926 12584 11651 12621 12396 12519 12328 12656 12645 11772 12709 12749 12464 12288 12519 11768 12045 12535 12590 12702 12566 12421 12397 sum_num_inserts_total=2386556 sum_num_deletes_by_thread=19122 19895 19609 19658 19218 18940 20442 19931 20056 19971 19492 19645 19496 20012 19945 19584 19068 19019 19174 19514 20170 20256 19864 19775 19600 20150 18822 19236 19742 19275 19490 19356 20000 19423 20149 20071 19317 19423 19687 19970 19401 19517 19414 19716 19790 19740 19810 19891 18800 17527 17807 17652 17479 16978 17846 17878 17554 17259 17626 16843 18761 17583 18560 17177 17615 17608 18171 17617 17691 18009 17686 18147 18370 16921 17713 17169 17142 16763 18253 17938 17352 17942 17829 17748 18226 17069 17604 17960 16788 16984 17874 18030 17786 17921 17855 17604 12484 11869 12082 11970 12673 12371 12514 12107 12203 12298 12208 12482 12431 12576 12158 12611 12372 12485 12387 11998 12663 12992 12794 11912 12865 11774 12504 11677 12625 12310 12445 12372 12580 12642 11873 12498 12770 12488 12120 12583 11839 12279 12692 12338 12487 12882 12670 12490 sum_num_deletes_total=2386004 sum_num_searches_by_thread=344917 359712 352914 353214 345378 345441 368908 355085 358020 358571 353763 357907 347760 362224 359318 351916 343871 342814 346131 343706 362567 365125 356744 360020 352696 363073 339540 348245 355333 346138 351871 349776 362342 345539 361741 367322 348388 350861 356798 363519 346569 357591 349619 355422 353108 357708 359431 354787 338896 315940 315193 318678 312954 305372 319144 319648 312732 310990 316999 301241 336627 316220 329798 307887 313362 314589 329296 318289 317753 320302 321608 326987 330883 306580 314143 308847 310907 301977 328872 321510 307006 320897 318871 319873 321769 307410 316234 324113 306343 304804 320236 326057 321566 322655 322465 316437 224518 211539 219038 214963 226600 223251 222302 218986 221146 221188 220551 223813 225581 225884 216138 227497 223949 224724 224229 215889 227901 233902 228255 215000 229794 211978 226577 212797 227777 223853 225150 224218 224627 227208 211457 227521 227663 222512 220605 223361 213026 217350 224414 225953 229415 228940 227817 224094 sum_num_searches_total=42929354 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=383288 399341 392372 392324 383682 383602 409877 394888 397915 398452 392870 397662 386483 402521 399219 390779 382169 381009 384412 382412 402900 405508 396453 399801 391981 403263 377415 386986 394866 384784 390877 388761 402476 384142 402128 407928 387053 389774 396228 403599 385292 396977 388482 394909 392621 397457 399070 394401 376391 350773 350534 354240 347878 339338 354739 355261 347543 345652 352152 334852 373900 351084 366482 342032 348420 349653 365621 353571 353311 356405 357317 363334 367740 340533 349534 343344 345095 335507 365559 357285 341375 356826 354211 355207 358040 341474 351445 359945 340224 338550 356195 362278 357287 358398 358428 351848 249670 235195 243179 238770 251878 248208 247036 243342 245666 245745 244759 248832 250635 250914 240172 252682 248693 249841 249159 240063 253371 259697 253743 238858 255484 235678 251665 236125 253023 248559 250114 248918 249863 252495 235102 252728 253182 247464 245013 248463 236633 241674 249641 250881 254604 254388 252908 248981 average_num_operations_total=331263 stdev_num_operations_total=5197 sum_num_operations_total=47701914 min_num_operations_total=235102 max_num_operations_total=409877 first_time_thread_terminate_by_thread=10000239 10000549 10000207 10000621 10000600 10000297 10000298 10000276 10000105 10000622 10000591 10000505 10000526 10000610 10000114 10000578 10000190 10000620 10000280 10000277 10000145 10000609 10000106 10000116 10000104 10000550 10000575 10000616 10000241 10000580 10000511 10000557 10000583 10000597 10000502 10000209 10000581 10000109 10000292 10000527 10000191 10000622 10000107 10000565 10000105 10000122 10000306 10000598 10000107 10000243 10000544 10000262 10000606 10000571 10000105 10000321 10000624 10000324 10000605 10000140 10000136 10000289 10000214 10000624 10000105 10000516 10000106 10000570 10000269 10000573 10000604 10000568 10000613 10000151 10000194 10000615 10000608 10000153 10000537 10000222 10000619 10000603 10000235 10000164 10000138 10000162 10000614 10000625 10000534 10000156 10000248 10000264 10000271 10000618 10000521 10000218 10000202 10000319 10000513 10000199 10000508 10000545 10000593 10000178 10000260 10000561 10000314 10000554 10000176 10000532 10000540 10000301 10000254 10000251 10000286 10000612 10000310 10000552 10000315 10000183 10000204 10000318 10000130 10000522 10000564 10000542 10000500 10000592 10000594 10000562 10000160 10000558 10000114 10000532 10000257 10000169 10000589 10000258 10000611 10000596 10000230 10000587 10000174 10000226 min_time_thread_terminate_total=10000104 max_time_thread_terminate_total=10000625 first_time_thread_start_by_thread=9 4 4 4 4 5 5 5 4 4 4 4 4 5 4 5 4 5 4 4 5 5 5 5 3 4 4 4 4 5 5 5 4 4 4 4 4 5 4 5 4 5 4 4 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 4 5 5 5 4 5 5 4 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 min_time_thread_start_total=3 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=998265558227 threads_final_size=998168 final_keysum=998265558227 final_size=998168 validate_result=success Validation OK. Structural validation OK. total_find=42929354 total_rq=0 total_inserts=2386556 total_deletes=2386004 total_updates=4772560 total_queries=42929354 total_ops=47701914 find_throughput=4292935 rq_throughput=0 update_throughput=477256 query_throughput=4292935 total_throughput=4770191 total find : 42929354 total rq : 0 total inserts : 2386556 total deletes : 2386004 total updates : 4772560 total queries : 42929354 total ops : 47701914 find throughput : 4292935 rq throughput : 0 update throughput : 477256 query throughput : 4292935 total throughput : 4770191 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=28.6825 PAPI_L3_TCM=6.35731 PAPI_TOT_CYC=83847.2 PAPI_TOT_INS=8685.95 garbage=21274782194498 total_execution_walltime=16.676s REALTIME_MAIN_END_PERF_FORMAT=6997858.425532086 Hybrid noREC system shutdown: HTM_ATTEMPT_THRESH=40 [fast htm] total fast htm commit : 47107282 [slow htm] [fallback] total fallback commit : 3520153 seconds global lock is held : 0.651306 [time_cmd_output] time_elapsed_sec=16.82, faults_major=0, faults_minor=119701, mem_maxresident_kb=474060, user_cputime=2348.74, sys_cputime=6.55, percent_cpu=14001% 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=1