__step=000708
__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" ./ellen_ext_bst_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000708.txt
__path_data=data/data000708.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987418.816131265
binary=./ellen_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=ellen_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=50
DEL_FRAC=50
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=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40 descriptor=64
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.036s
prefilling_size=7427930 prefilling_elapsed_millis=1s
prefilling_size=7714047 prefilling_elapsed_millis=1.1s
prefilling_size=7960779 prefilling_elapsed_millis=1.201s
prefilling_size=8183118 prefilling_elapsed_millis=1.301s
prefilling_size=8382660 prefilling_elapsed_millis=1.401s
prefilling_size=8551606 prefilling_elapsed_millis=1.501s
prefilling_size=8704876 prefilling_elapsed_millis=1.601s
prefilling_size=8841389 prefilling_elapsed_millis=1.701s
prefilling_size=8969011 prefilling_elapsed_millis=1.802s
prefilling_size=9074643 prefilling_elapsed_millis=1.902s
prefilling_size=9169588 prefilling_elapsed_millis=2.002s
prefilling_size=9254065 prefilling_elapsed_millis=2.102s
prefilling_size=9330405 prefilling_elapsed_millis=2.202s
prefilling_size=9399972 prefilling_elapsed_millis=2.303s
prefilling_size=9462745 prefilling_elapsed_millis=2.403s
prefilling_size=9518124 prefilling_elapsed_millis=2.503s
prefilling_size=9568309 prefilling_elapsed_millis=2.603s
prefilling_size=9612411 prefilling_elapsed_millis=2.704s
prefilling_size=9651748 prefilling_elapsed_millis=2.804s
prefilling_size=9686784 prefilling_elapsed_millis=2.904s
prefilling_size=9716808 prefilling_elapsed_millis=3.004s
prefilling_size=9744952 prefilling_elapsed_millis=3.104s
prefilling_size=9771869 prefilling_elapsed_millis=3.204s
prefilling_size=9795729 prefilling_elapsed_millis=3.305s
prefilling_size=9816211 prefilling_elapsed_millis=3.405s
finished prefilling to size 9816213 for expected size 10000000 keysum=98184194829128, performing 81713322 updates; total_prefilling_elapsed_ms=3506 ms)
pref_size=9816213
pref_millis=3506
prefill_elapsed_ms=3535
6node_tIxPvE_object_size=40
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=1217

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6987422.556440483
REALTIME_END_PERF_FORMAT=6987432.556579318

###############################################################################
################################## 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 1014 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.162s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 255 507 992 1946 3701 6970 12757 22740 39168 64744 102465 155150 223237 306709 401979 503668 601397 686998 748647 781848 783826 757352 706250 636058 552610 464719 380079 301040 231501 171579 122499 84088 55933 35855 22051 13011 7425 4072 2286 1227 677 406 253 133 53 26 9 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 1 3 22 38 191 432 1183 2774 6312 13592 27023 49780 87063 139765 211439 300290 405939 515796 625349 715446 779870 810300 808454 776442 719506 640501 549359 459118 370579 291423 220659 160910 112243 76011 49659 31091 18597 10778 5858 3345 1777 948 559 373 213 80 43 16 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 510 1014 1984 3892 7402 13940 25514 45480 78336 129488 204930 310300 446474 613418 803958 1007336 1202794 1373996 1497294 1563696 1567652 1514704 1412500 1272116 1105220 929438 760158 602080 463002 343158 244998 168176 111866 71710 44102 26022 14850 8144 4572 2454 1354 812 506 266 106 52 18 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 1 3 22 38 191 432 1183 2774 6312 13592 27023 49780 87063 139765 211439 300290 405939 515796 625349 715446 779870 810300 808454 776442 719506 640501 549359 459118 370579 291423 220659 160910 112243 76011 49659 31091 18597 10778 5858 3345 1777 948 559 373 213 80 43 16 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.99609 1.99412 1.9783 1.98085 1.95092 1.94164 1.91514 1.89128 1.86121 1.82649 1.79131 1.75709 1.71942 1.68696 1.65531 1.62649 1.59702 1.57117 1.54487 1.52217 1.50126 1.48311 1.46626 1.45031 1.4344 1.42048 1.40893 1.39602 1.3845 1.37058 1.35698 1.34322 1.33259 1.32052 1.3075 1.29502 1.28534 1.27421 1.2807 1.26837 1.27588 1.29985 1.31158 1.26285 1.19925 1.24528 1.17308 1.11111 1

tree_stats_height=59
tree_stats_numInternals=10001155
tree_stats_numLeaves=10001156
tree_stats_numNodes=20002311
tree_stats_numKeys=10001154

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=32.0551

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20400 40560 79360 155680 296080 557600 1020560 1819200 3133440 5179520 8197200 12412000 17858960 24536720 32158320 40293440 48111760 54959840 59891760 62547840 62706080 60588160 56500000 50884640 44208800 37177520 30406320 24083200 18520080 13726320 9799920 6727040 4474640 2868400 1764080 1040880 594000 325760 182880 98160 54160 32480 20240 10640 4240 2080 720 160
tree_stats_sizeInBytes=800092440

6node_tIxPvE_object_size=40
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=4598

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:84 2:26 4:2 8:5 16:14 32:57 64:1302 128:55901 256:418324 512:172819 1024:136
    [2^00, 2^01]: 84
    (2^01, 2^02]: 26
    (2^02, 2^03]: 2
    (2^03, 2^04]: 5
    (2^04, 2^05]: 14
    (2^05, 2^06]: 57
    (2^06, 2^07]: 1302
    (2^07, 2^08]: 55901
    (2^08, 2^09]: 418324
    (2^09, 2^10]: 172819
    (2^10, 2^11]: 136
sum_limbo_reclamation_event_size_total=276890018
count_limbo_reclamation_event_size_by_thread=6756 6756 6758 6756 6758 6758 6756 6758 6756 6756 6758 6758 6758 6756 6758 6758 6756 6754 6756 6756 6758 6758 6756 6756 6758 6758 6756 6754 6756 6756 6758 6758 6758 6756 6758 6758 6756 6758 6758 6758 6756 6756 6758 6758 6756 6758 6756 6758 6756 6758 6758 6754 6758 6758 6758 6758 6758 6754 6756 6758 6758 6758 6754 6754 6756 6758 6754 6758 6758 6758 6758 6758 6758 6756 6758 6754 6758 6758 6756 6758 6756 6756 6758 6756 6758 6758 6758 6756 6756 6758 6758 6758 6756 6758 6758 6756
count_limbo_reclamation_event_size_total=648670
sum_limbo_reclamation_event_count_total=649142
first_thread_announced_epoch_by_thread=9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196 9196
sum_num_inserts_by_thread=1147177 1154141 1157521 1160773 1150512 1150215 1150527 1151073 1161443 1164525 1151480 1151080 1153501 1157751 1162182 1158311 1156506 1150028 1149372 1148683 1158522 1161625 1148980 1143704 1147012 1153184 1161753 1159288 1161166 1146911 1151963 1153211 1159972 1165146 1150381 1151137 1154210 1158024 1161189 1161412 1155122 1149632 1144188 1152540 1156375 1159341 1149953 1140811 1149231 1156041 1162254 1157530 1151057 1145332 1146365 1154478 1163103 1163510 1152177 1149426 1154421 1155969 1158002 1163531 1158173 1146974 1145596 1154775 1160279 1162562 1154646 1148538 1150954 1155262 1161292 1158898 1156501 1150710 1149415 1153640 1163860 1162668 1153521 1152791 1155813 1159410 1164417 1166140 1156503 1147469 1148263 1153532 1165479 1162655 1157836 1149881
sum_num_inserts_total=110874433
sum_num_deletes_by_thread=1147791 1153138 1159739 1160110 1150033 1151369 1150210 1151735 1160219 1163178 1150204 1150811 1151958 1157047 1161640 1158160 1156418 1150385 1147779 1150358 1158516 1160688 1145804 1144682 1147380 1152621 1161406 1160808 1158758 1148006 1150595 1151794 1160487 1164857 1148081 1149295 1154588 1156009 1160252 1160016 1155147 1149189 1145123 1152812 1157037 1160150 1152343 1141475 1150087 1156401 1158796 1158118 1150544 1144945 1146729 1155172 1162765 1162825 1152180 1151654 1149322 1154147 1158285 1162764 1154598 1148846 1145785 1152984 1161357 1163693 1154295 1149361 1150802 1155137 1159965 1160774 1157517 1152686 1150957 1153060 1164783 1164548 1154784 1151865 1156712 1159821 1162304 1165828 1157176 1148135 1147323 1152422 1165454 1162256 1153125 1150012
sum_num_deletes_total=110853300
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2294968 2307279 2317260 2320883 2300545 2301584 2300737 2302808 2321662 2327703 2301684 2301891 2305459 2314798 2323822 2316471 2312924 2300413 2297151 2299041 2317038 2322313 2294784 2288386 2294392 2305805 2323159 2320096 2319924 2294917 2302558 2305005 2320459 2330003 2298462 2300432 2308798 2314033 2321441 2321428 2310269 2298821 2289311 2305352 2313412 2319491 2302296 2282286 2299318 2312442 2321050 2315648 2301601 2290277 2293094 2309650 2325868 2326335 2304357 2301080 2303743 2310116 2316287 2326295 2312771 2295820 2291381 2307759 2321636 2326255 2308941 2297899 2301756 2310399 2321257 2319672 2314018 2303396 2300372 2306700 2328643 2327216 2308305 2304656 2312525 2319231 2326721 2331968 2313679 2295604 2295586 2305954 2330933 2324911 2310961 2299893
average_num_operations_total=2309663
stdev_num_operations_total=1181
sum_num_operations_total=221727733
min_num_operations_total=2282286
max_num_operations_total=2331968
first_time_thread_terminate_by_thread=10000730 10000139 10000916 10000537 10000812 10000138 10000799 10000738 10000871 10000143 10000138 10000685 10001002 10000830 10000716 10001014 10000817 10000862 10000842 10000138 10000763 10000234 10000991 10000137 10000511 10000138 10000898 10000588 10000817 10000137 10000177 10000760 10000138 10000623 10000138 10000137 10000932 10000685 10000863 10000953 10000137 10000866 10001054 10000137 10000838 10000958 10001109 10000137 10000547 10000805 10000228 10000376 10000137 10001071 10000170 10000420 10000331 10000138 10000624 10000137 10000303 10000139 10000915 10000138 10000823 10000137 10000352 10000627 10000138 10000665 10000138 10001055 10000250 10000137 10000139 10000425 10000138 10000271 10000137 10000915 10000137 10000208 10000138 10000316 10000285 10000881 10000402 10000137 10000876 10000708 10000137 10000763 10000138 10000908 10000137 10000693
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10001109
first_time_thread_start_by_thread=5 6 6 5 5 5 6 5 6 5 6 6 5 6 5 6 5 5 5 5 5 6 6 6 5 6 6 5 5 5 6 5 6 5 6 6 5 6 5 6 5 5 5 5 5 6 6 6 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=99992520860150
threads_final_size=10001154
final_keysum=99992520860150
final_size=10001154
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=110874433
total_deletes=110853300
total_updates=221727733
total_queries=0
total_ops=221727733
find_throughput=0
rq_throughput=0
update_throughput=22172773
query_throughput=0
total_throughput=22172773


total find                    : 0
total rq                      : 0
total inserts                 : 110874433
total deletes                 : 110853300
total updates                 : 221727733
total queries                 : 0
total ops                     : 221727733
find throughput               : 0
rq throughput                 : 0
update throughput             : 22172773
query throughput              : 0
total throughput              : 22172773

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=60.4648
PAPI_L3_TCM=24.5754
PAPI_TOT_CYC=11937.1
PAPI_TOT_INS=1369
garbage=0
total_execution_walltime=14.108s
REALTIME_MAIN_END_PERF_FORMAT=6987432.925083203
[time_cmd_output] time_elapsed_sec=14.30, faults_major=0, faults_minor=322768, mem_maxresident_kb=1288368, user_cputime=1311.42, sys_cputime=7.67, percent_cpu=9221%
timeout=false
algorithm=ellen_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