__step=000388 __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" ./natarajan_ext_bst_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000388.txt __path_data=data/data000388.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6983511.297736794 binary=./natarajan_ext_bst_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=natarajan_ext_bst_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=5 DEL_FRAC=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=5.0 5.0 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 sizes: node=32 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.037s prefilling_size=8767252 prefilling_elapsed_millis=1s prefilling_size=8947778 prefilling_elapsed_millis=1.1s prefilling_size=9098871 prefilling_elapsed_millis=1.201s prefilling_size=9226305 prefilling_elapsed_millis=1.301s prefilling_size=9336467 prefilling_elapsed_millis=1.401s prefilling_size=9426960 prefilling_elapsed_millis=1.501s prefilling_size=9503935 prefilling_elapsed_millis=1.601s prefilling_size=9569910 prefilling_elapsed_millis=1.701s prefilling_size=9626820 prefilling_elapsed_millis=1.802s prefilling_size=9676069 prefilling_elapsed_millis=1.902s prefilling_size=9719495 prefilling_elapsed_millis=2.002s prefilling_size=9756779 prefilling_elapsed_millis=2.102s prefilling_size=9786923 prefilling_elapsed_millis=2.202s prefilling_size=9812907 prefilling_elapsed_millis=2.302s finished prefilling to size 9812941 for expected size 10000000 keysum=98131096148013, performing 83245107 updates; total_prefilling_elapsed_ms=2404 ms) pref_size=9812941 pref_millis=2404 prefill_elapsed_ms=2428 6node_tIxPvE_object_size=32 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=1062 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983513.935833783 REALTIME_END_PERF_FORMAT=6983523.935976973 ############################################################################### ################################## 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 1014 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.182s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 507 991 1905 3588 6575 11621 19690 31933 49735 74329 107270 150207 203757 268410 342266 421917 502785 579590 646172 694717 720691 723532 700183 656427 596670 525407 449292 372643 298631 232298 175595 129119 92769 65793 44847 29587 19154 12165 7749 4800 2923 1702 988 548 286 151 80 47 32 19 9 2 2 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 3 23 77 222 601 1529 3552 7447 14131 25141 41388 64333 96657 139104 194554 262615 341049 425980 513008 597627 668743 717850 746881 743939 716184 667933 601522 525941 446655 364964 289001 222071 165469 119745 86739 60107 40020 26143 16581 10698 6677 4144 2416 1428 810 421 222 113 62 45 29 16 2 3 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1014 1982 3810 7176 13150 23242 39380 63866 99470 148658 214540 300414 407514 536820 684532 843834 1005570 1159180 1292344 1389434 1441382 1447064 1400366 1312854 1193340 1050814 898584 745286 597262 464596 351190 258238 185538 131586 89694 59174 38308 24330 15498 9600 5846 3404 1976 1096 572 302 160 94 64 38 18 4 4 2 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 3 23 77 222 601 1529 3552 7447 14131 25141 41388 64333 96657 139104 194554 262615 341049 425980 513008 597627 668743 717850 746881 743939 716184 667933 601522 525941 446655 364964 289001 222071 165469 119745 86739 60107 40020 26143 16581 10698 6677 4144 2416 1428 810 421 222 113 62 45 29 16 2 3 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.99412 1.97732 1.96115 1.94173 1.91625 1.88373 1.84717 1.81089 1.77874 1.74725 1.72159 1.70014 1.67825 1.65865 1.63758 1.61636 1.59583 1.57638 1.55744 1.53756 1.51869 1.50197 1.48386 1.46875 1.45448 1.44028 1.42757 1.4147 1.40069 1.38894 1.37795 1.36766 1.35924 1.35461 1.34082 1.32987 1.32369 1.31756 1.3185 1.30972 1.30448 1.29114 1.29025 1.27733 1.26095 1.26399 1.2649 1.29375 1.34043 1.29688 1.23684 1.11111 1.5 1.25 1 tree_stats_height=64 tree_stats_numInternals=9982617 tree_stats_numLeaves=9982618 tree_stats_numNodes=19965235 tree_stats_numKeys=9982618 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=31.7655 tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16320 32448 63424 121920 229632 420800 743744 1260160 2043712 3183040 4757056 6865280 9613248 13040448 17178240 21905024 27002688 32178240 37093760 41355008 44461888 46124224 46306048 44811712 42011328 38186880 33626048 28754688 23849152 19112384 14867072 11238080 8263616 5937216 4210752 2870208 1893568 1225856 778560 495936 307200 187072 108928 63232 35072 18304 9664 5120 3008 2048 1216 576 128 128 64 tree_stats_sizeInBytes=638887520 6node_tIxPvE_object_size=32 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=6257 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:1 8:40 16:23791 32:452722 64:21766 128:208 (2^02, 2^03]: 1 (2^03, 2^04]: 40 (2^04, 2^05]: 23791 (2^05, 2^06]: 452722 (2^06, 2^07]: 21766 (2^07, 2^08]: 208 sum_limbo_reclamation_event_size_total=23066558 count_limbo_reclamation_event_size_by_thread=5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 5193 count_limbo_reclamation_event_size_total=498528 sum_limbo_reclamation_event_count_total=498720 first_thread_announced_epoch_by_thread=12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 12514 sum_num_inserts_by_thread=240101 241394 243614 243142 242175 239214 240447 241293 244313 245196 242063 241134 240402 242015 243637 244756 241221 240595 240223 240279 242417 243742 240282 239041 240162 239878 243738 244488 242259 240003 240464 241784 245018 243617 241462 241969 240433 242820 245387 243946 242696 240995 238899 241357 242743 243308 240541 238799 240631 241806 244889 244206 241949 241778 241314 242344 245789 245400 243837 241488 240933 244268 243793 244436 242697 240422 240724 241326 243173 244177 241544 241197 240919 241222 244769 243971 241749 240990 240992 240629 245239 244763 243483 241746 241645 244002 244515 245066 243503 239411 239605 240776 245403 243464 241916 240029 sum_num_inserts_total=23253390 sum_num_deletes_by_thread=239914 241233 243129 244031 242105 238397 240568 241385 244647 245419 242156 240768 240056 242203 243969 243793 243046 240268 239148 240907 242281 243453 240196 238414 240013 240494 242699 244508 241918 239069 239928 241822 244615 244625 241373 241694 240737 242232 244689 244110 242620 241355 239158 240046 242660 243795 240158 238376 240841 242836 244463 243608 241221 241052 241542 242646 245756 245874 243022 241832 241396 242761 244687 243721 243127 239454 239584 241430 244327 243553 241145 240846 240503 241180 243858 243711 241278 240714 241261 241215 245478 244036 243785 241094 242608 243444 244101 244285 243537 239998 240513 240508 243457 243370 242886 241503 sum_num_deletes_total=23243227 sum_num_searches_by_thread=4310488 4342150 4385589 4387138 4355782 4309413 4324834 4343632 4405419 4413883 4353406 4332308 4334415 4359388 4388620 4390209 4364721 4331572 4317073 4328862 4359990 4386593 4333276 4298164 4321128 4337428 4376296 4384991 4354115 4308535 4332300 4349625 4399769 4412154 4354328 4331990 4346371 4360200 4399344 4390045 4370876 4339525 4300912 4336636 4367942 4383414 4330860 4304345 4337507 4355784 4391733 4393142 4347519 4340278 4341835 4369676 4419305 4415118 4376116 4343053 4347279 4382527 4403595 4403292 4374138 4318675 4320108 4333127 4389470 4384643 4353651 4335268 4334505 4342952 4395261 4381465 4352080 4336051 4342913 4352157 4403960 4408376 4381140 4343547 4345318 4372339 4396356 4406897 4376688 4313773 4319551 4343047 4397328 4391861 4356614 4331024 sum_num_searches_total=418452096 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=4790503 4824777 4872332 4874311 4840062 4787024 4805849 4826310 4894379 4904498 4837625 4814210 4814873 4843606 4876226 4878758 4848988 4812435 4796444 4810048 4844688 4873788 4813754 4775619 4801303 4817800 4862733 4873987 4838292 4787607 4812692 4833231 4889402 4900396 4837163 4815653 4827541 4845252 4889420 4878101 4856192 4821875 4778969 4818039 4853345 4870517 4811559 4781520 4818979 4840426 4881085 4880956 4830689 4823108 4824691 4854666 4910850 4906392 4862975 4826373 4829608 4869556 4892075 4891449 4859962 4798551 4800416 4815883 4876970 4872373 4836340 4817311 4815927 4825354 4883888 4869147 4835107 4817755 4825166 4834001 4894677 4897175 4868408 4826387 4829571 4859785 4884972 4896248 4863728 4793182 4799669 4824331 4886188 4878695 4841416 4812556 average_num_operations_total=4843215 stdev_num_operations_total=3517 sum_num_operations_total=464948713 min_num_operations_total=4775619 max_num_operations_total=4910850 first_time_thread_terminate_by_thread=10000142 10000142 10000143 10000142 10000142 10000144 10000144 10000144 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000143 10000144 10000144 10000144 10000144 10000143 10000142 10000143 10000144 10000142 10000144 10000143 10000144 10000142 10000144 10000142 10000144 10000142 10000142 10000142 10000142 10000142 10000143 10000142 10000143 10000144 10000142 10000144 10000144 10000143 10000142 10000143 10000144 10000142 10000144 10000144 10000142 10000142 10000142 10000143 10000142 10000142 10000143 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000143 10000144 10000144 10000143 10000143 10000143 10000144 10000142 10000143 10000144 10000142 10000142 10000142 10000143 10000144 10000142 10000143 10000142 10000142 10000143 10000142 10000142 10000142 10000143 10000143 10000144 10000143 10000143 10000143 10000142 10000144 min_time_thread_terminate_total=10000142 max_time_thread_terminate_total=10000144 first_time_thread_start_by_thread=5 5 5 4 5 5 5 5 4 5 5 4 5 5 4 4 5 5 5 5 5 4 4 5 5 5 5 4 5 5 5 5 4 5 5 4 5 5 4 4 5 5 5 5 5 4 4 5 4 4 5 5 4 4 4 5 5 4 4 4 4 4 5 5 4 4 4 4 5 4 4 4 4 4 5 5 4 4 4 5 5 4 4 4 4 4 5 5 4 4 4 4 5 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=99818673422037 threads_final_size=9982618 final_keysum=99818673422037 final_size=9982618 validate_result=success Validation OK. Structural validation OK. total_find=418452096 total_rq=0 total_inserts=23253390 total_deletes=23243227 total_updates=46496617 total_queries=418452096 total_ops=464948713 find_throughput=41845209 rq_throughput=0 update_throughput=4649661 query_throughput=41845209 total_throughput=46494871 total find : 418452096 total rq : 0 total inserts : 23253390 total deletes : 23243227 total updates : 46496617 total queries : 418452096 total ops : 464948713 find throughput : 41845209 rq throughput : 0 update throughput : 4649661 query throughput : 41845209 total throughput : 46494871 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=25.8602 PAPI_L3_TCM=10.0078 PAPI_TOT_CYC=5751.54 PAPI_TOT_INS=426.012 garbage=2077435901993328 total_execution_walltime=12.922s REALTIME_MAIN_END_PERF_FORMAT=6983524.220867775 [time_cmd_output] time_elapsed_sec=13.11, faults_major=0, faults_minor=238031, mem_maxresident_kb=950248, user_cputime=1220.59, sys_cputime=4.35, percent_cpu=9343% timeout=false algorithm=natarajan_ext_bst_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