__step=000163
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000163.txt
__path_data=data/data000163.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980783.729877120
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
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
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.038s
prefilling_size=998437 prefilling_elapsed_millis=1s
finished prefilling to size 998449 for expected size 1000000 keysum=998028517232, performing 48519699 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=998449
pref_millis=1102
prefill_elapsed_ms=1132
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=748
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6980785.87599485
REALTIME_END_PERF_FORMAT=6980795.87737989
###############################################################################
################################## 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 830 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.034s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 123 230 415 739 1294 2277 3949 6600 10416 15680 22649 31232 40762 50608 60625 69556 76604 81038 82478 80449 74819 66232 56115 45852 35872 26899 19459 13785 9295 5987 3580 1939 981 455 192 69 17 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 5 16 45 91 184 311 605 1298 2784 5152 8711 14066 21702 30916 40591 51694 62508 72170 79598 84507 86079 83406 76349 66378 55832 44845 34339 25133 18275 12603 8394 5221 2897 1507 718 315 121 32 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 246 460 830 1478 2588 4554 7898 13200 20832 31360 45298 62464 81524 101216 121250 139112 153208 162076 164956 160898 149638 132464 112230 91704 71744 53798 38918 27570 18590 11974 7160 3878 1962 910 384 138 34 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 5 16 45 91 184 311 605 1298 2784 5152 8711 14066 21702 30916 40591 51694 62508 72170 79598 84507 86079 83406 76349 66378 55832 44845 34339 25133 18275 12603 8394 5221 2897 1507 718 315 121 32 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96094 1.93496 1.90217 1.89036 1.87551 1.87983 1.86715 1.83565 1.78909 1.75269 1.72223 1.68948 1.65257 1.62077 1.59897 1.57366 1.55066 1.52894 1.50888 1.4877 1.46501 1.44261 1.42362 1.40855 1.39117 1.37493 1.3617 1.35421 1.33714 1.32205 1.29898 1.27081 1.25297 1.23191 1.21099 1.17969 1.12319 1.05882 1
tree_stats_height=46
tree_stats_numInternals=999401
tree_stats_numLeaves=999402
tree_stats_numNodes=1998803
tree_stats_numKeys=999402
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.7955
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 7872 14720 26560 47296 82816 145728 252736 422400 666624 1003520 1449536 1998848 2608768 3238912 3880000 4451584 4902656 5186432 5278592 5148736 4788416 4238848 3591360 2934528 2295808 1721536 1245376 882240 594880 383168 229120 124096 62784 29120 12288 4416 1088 128
tree_stats_sizeInBytes=63961696
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=12622
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:218436 4:451444 8:194053 16:2598
(2^01, 2^02]: 218436
(2^02, 2^03]: 451444
(2^03, 2^04]: 194053
(2^04, 2^05]: 2598
sum_limbo_reclamation_event_size_total=4457948
count_limbo_reclamation_event_size_by_thread=8952 9009 9010 9033 9082 8999 9042 8991 9030 9072 9016 9010 9014 9059 9043 9079 9043 9011 9002 9043 9074 9054 9077 9003 8943 9096 9016 9107 8963 8964 9001 8998 9063 9080 8980 9006 9038 9017 9083 9051 9070 9001 8968 9054 9097 9059 9078 8944 9070 9039 9070 9038 9056 9052 8995 9003 9059 9065 9045 8994 8994 9014 8992 9021 9043 9069 8985 8999 9038 9009 9043 9034 9026 8978 9049 9029 8992 8958 8978 8990 9063 9078 9085 9051 9002 8975 8991 9004 9023 8957 8962 9009 9063 9045 9042 9029
count_limbo_reclamation_event_size_total=866531
sum_limbo_reclamation_event_count_total=1139904
first_thread_announced_epoch_by_thread=25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244 25244
sum_num_inserts_by_thread=54427 55136 55701 55273 54922 54567 54920 54991 55682 55678 55285 54915 54817 55841 55399 55859 55625 54904 54713 55191 56041 55570 55005 54264 54857 55201 55672 55698 55312 53930 55067 54677 56157 56009 55006 54379 54687 55231 55808 55698 55622 54755 54134 54848 55066 55503 55482 54463 55094 55252 56060 55629 55447 55050 55011 55379 56478 55632 55047 54589 55016 54907 55695 55423 54834 54566 54794 54622 55320 55316 55258 54497 54708 55348 55609 55248 54817 54830 54379 55081 56198 55768 55411 55345 55073 55540 55559 55891 55004 54587 53933 54749 55322 56063 55617 55047
sum_num_inserts_total=5298031
sum_num_deletes_by_thread=54733 54974 55494 55223 55185 54339 55326 54829 56134 55436 54955 55150 54547 55368 55602 56200 55549 55044 54903 55100 55300 55758 55184 54558 54878 55037 55767 55382 54969 53991 54594 54437 55521 56259 55221 54673 54900 55501 55455 55652 55407 54954 54169 55369 55772 55681 55373 54437 55003 55313 55277 55143 55250 55058 55429 55245 56334 55654 55106 54968 54790 54645 55222 55552 55021 54896 54711 54612 55170 55612 54900 54576 54511 54674 55471 55549 55144 54735 54718 54803 56314 55901 55629 54907 54699 55060 55334 55629 54854 54458 54219 54618 55461 55573 55622 55320
sum_num_deletes_total=5294980
sum_num_searches_by_thread=10783101 10868572 11000846 10971771 10932604 10773947 10868240 10905281 11065394 11081759 10920706 10853422 10865363 10938347 11018128 11058174 11016669 10929267 10820164 10902126 11023811 11033426 10914753 10811017 10805625 10883105 10982043 10982248 10909530 10755146 10835746 10894669 11057754 11066568 10915802 10816668 10874441 10920657 11019258 11037067 10964194 10865635 10754245 10896943 11007984 11048478 10901932 10815122 10852576 10920654 11043671 11057378 10960358 10914101 10927523 10990180 11085499 11042024 10909665 10840761 10839980 10928719 11014058 11013596 10942802 10796662 10788863 10828604 11017472 10994798 10913761 10833204 10808064 10892000 11005995 11009976 10904938 10839752 10824492 10921158 11096963 11097804 10986497 10904665 10900571 10939929 10993596 11009574 10882950 10765540 10752026 10833632 11028022 11037460 10970370 10883117
sum_num_searches_total=1049113748
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10892261 10978682 11112041 11082267 11042711 10882853 10978486 11015101 11177210 11192873 11030946 10963487 10974727 11049556 11129129 11170233 11127843 11039215 10929780 11012417 11135152 11144754 11024942 10919839 10915360 10993343 11093482 11093328 11019811 10863067 10945407 11003783 11169432 11178836 11026029 10925720 10984028 11031389 11130521 11148417 11075223 10975344 10862548 11007160 11118822 11159662 11012787 10924022 10962673 11031219 11155008 11168150 11071055 11024209 11037963 11100804 11198311 11153310 11019818 10950318 10949786 11038271 11124975 11124571 11052657 10906124 10898368 10937838 11127962 11105726 11023919 10942277 10917283 11002022 11117075 11120773 11014899 10949317 10933589 11031042 11209475 11209473 11097537 11014917 11010343 11050529 11104489 11121094 10992808 10874585 10860178 10942999 11138805 11149096 11081609 10993484
average_num_operations_total=11038612
stdev_num_operations_total=9437
sum_num_operations_total=1059706759
min_num_operations_total=10860178
max_num_operations_total=11209475
first_time_thread_terminate_by_thread=10000139 10000138 10000138 10000139 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000138 10000139 10000138 10000139 10000138 10000138 10000138 10000139 10000139 10000138 10000138 10000138 10000138 10000138 10000138 10000139 10000138 10000138 10000139 10000139 10000139 10000138 10000138 10000138 10000138 10000139 10000138 10000139 10000137 10000138 10000139 10000137 10000139 10000137 10000139 10000138 10000137 10000137 10000137 10000137 10000138 10000137 10000139 10000138 10000138 10000137 10000138 10000139 10000137 10000138 10000138 10000139 10000137 10000138 10000139 10000137 10000139 10000137 10000139 10000138 10000137 10000137 10000137 10000137 10000138 10000137 10000139 10000138 10000138 10000137 10000138 10000139 10000137 10000138 10000138 10000139
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000139
first_time_thread_start_by_thread=5 4 4 4 5 5 5 4 5 4 5 5 4 5 5 4 5 4 5 5 5 5 4 5 5 4 4 4 5 5 5 4 5 4 5 5 4 5 5 4 5 4 5 5 5 5 4 5 4 4 4 4 4 5 4 4 4 5 5 5 4 4 5 5 4 4 5 4 4 4 5 4 4 4 4 4 4 5 4 4 4 5 5 5 4 4 5 5 4 4 5 4 4 4 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=999544963487
threads_final_size=999402
final_keysum=999544963487
final_size=999402
validate_result=success
Validation OK.
Structural validation OK.
total_find=1049113748
total_rq=0
total_inserts=5298031
total_deletes=5294980
total_updates=10593011
total_queries=1049113748
total_ops=1059706759
find_throughput=104911374
rq_throughput=0
update_throughput=1059301
query_throughput=104911374
total_throughput=105970675
total find : 1049113748
total rq : 0
total inserts : 5298031
total deletes : 5294980
total updates : 10593011
total queries : 1049113748
total ops : 1059706759
find throughput : 104911374
rq throughput : 0
update throughput : 1059301
query throughput : 104911374
total throughput : 105970675
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=12.0373
PAPI_L3_TCM=1.92123
PAPI_TOT_CYC=2519.72
PAPI_TOT_INS=335.882
garbage=524285595873212
total_execution_walltime=11.512s
REALTIME_MAIN_END_PERF_FORMAT=6980795.255968135
[time_cmd_output] time_elapsed_sec=11.66, faults_major=0, faults_minor=94189, mem_maxresident_kb=374856, user_cputime=1094.59, sys_cputime=4.13, percent_cpu=9418%
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=1