__step=000947
__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 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000947.txt
__path_data=data/data000947.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990354.489246078
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=50
DEL_FRAC=50
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=50.0 50.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.038s
prefilling_size=100002 prefilling_elapsed_millis=1s
finished prefilling to size 100012 for expected size 100000 keysum=9987014491, performing 51628214 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100012
pref_millis=1102
prefill_elapsed_ms=1125
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=1122

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6990355.831585021
REALTIME_END_PERF_FORMAT=6990365.831749087

###############################################################################
################################## 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 942 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 126 244 471 876 1541 2523 3763 5145 6586 7967 9021 9377 9254 8688 7815 6808 5635 4385 3192 2145 1507 1067 735 490 336 173 97 54 20 6 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 8 17 66 211 559 1283 2381 3704 5205 6913 8665 9500 9820 9561 8822 7981 6885 5578 4239 2783 1947 1399 980 644 499 249 140 88 34 10 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 488 942 1752 3082 5046 7526 10290 13172 15934 18042 18754 18508 17376 15630 13616 11270 8770 6384 4290 3014 2134 1470 980 672 346 194 108 40 12 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 2 8 17 66 211 559 1283 2381 3704 5205 6913 8665 9500 9820 9561 8822 7981 6885 5578 4239 2783 1947 1399 980 644 499 249 140 88 34 10 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.96825 1.96516 1.92994 1.87957 1.81862 1.74574 1.68363 1.64004 1.60484 1.56615 1.51973 1.49344 1.46942 1.44976 1.43557 1.41385 1.38909 1.36397 1.336 1.35128 1.35401 1.34442 1.33333 1.34286 1.25744 1.28035 1.27835 1.18519 1.15 1.16667 1

tree_stats_height=39
tree_stats_numInternals=100176
tree_stats_numLeaves=100177
tree_stats_numNodes=200353
tree_stats_numKeys=100177

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.9216

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8064 15616 30144 56064 98624 161472 240832 329280 421504 509888 577344 600128 592256 556032 500160 435712 360640 280640 204288 137280 96448 68288 47040 31360 21504 11072 6208 3456 1280 384 128
tree_stats_sizeInBytes=6411296

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=12192


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:48357 4:2876 8:5906 16:11544 32:23552 64:50442 128:114031 256:544271 512:10055 1024:86
    (2^01, 2^02]: 48357
    (2^02, 2^03]: 2876
    (2^03, 2^04]: 5906
    (2^04, 2^05]: 11544
    (2^05, 2^06]: 23552
    (2^06, 2^07]: 50442
    (2^07, 2^08]: 114031
    (2^08, 2^09]: 544271
    (2^09, 2^10]: 10055
    (2^10, 2^11]: 86
sum_limbo_reclamation_event_size_total=253919962
count_limbo_reclamation_event_size_by_thread=8596 8708 8425 8573 8318 8400 8544 8516 8537 8588 8316 8614 8557 8540 8301 8212 8508 8583 8427 8421 8582 8304 8339 8357 8470 8411 8502 8343 8434 8313 8593 8400 8278 8292 8348 8624 8421 8396 8311 8347 8385 8672 8407 8338 8599 8278 8392 8609 8486 8595 8584 8390 8345 8333 8294 8588 8447 8263 8498 8413 8497 8586 8454 8425 8465 8546 8589 8373 8365 8370 8543 8425 8384 8504 8498 8418 8605 8334 8361 8643 8226 8303 8611 8628 8642 8381 8293 8367 8589 8367 8588 8681 8344 8346 8349 8355
count_limbo_reclamation_event_size_total=811120
sum_limbo_reclamation_event_count_total=952571
first_thread_announced_epoch_by_thread=24384 24384 24384 24384 24384 24382 24384 24384 24384 24384 24382 24384 24384 24384 24384 24384 24382 24382 24382 24384 24382 24382 24384 24384 24384 24382 24384 24384 24384 24384 24384 24384 24382 24384 24384 24384 24384 24384 24384 24384 24384 24382 24382 24382 24384 24384 24382 24384 24384 24382 24384 24382 24384 24382 24384 24384 24384 24382 24382 24382 24384 24382 24384 24382 24384 24382 24384 24384 24382 24382 24384 24382 24382 24384 24384 24382 24384 24384 24382 24382 24382 24382 24382 24382 24384 24382 24384 24382 24384 24382 24384 24384 24384 24382 24382 24384
sum_num_inserts_by_thread=2688283 2720558 2646430 2678489 2628630 2621155 2670466 2675871 2700396 2692321 2629702 2699514 2681296 2685516 2624629 2601486 2663618 2719227 2645094 2640600 2711343 2633906 2634608 2616636 2650828 2630283 2673562 2625818 2650139 2601305 2710116 2614832 2615162 2609888 2637930 2715675 2632948 2623399 2631581 2630996 2642630 2726875 2623509 2614164 2703704 2640451 2639048 2682467 2624844 2693793 2695614 2639200 2582244 2591382 2580861 2704706 2666886 2606979 2687395 2607256 2652964 2682834 2655305 2623219 2657367 2657522 2675432 2585433 2609101 2597320 2664711 2601962 2597095 2621032 2681607 2609937 2680169 2596856 2588454 2710645 2589289 2613765 2710297 2690299 2713613 2592459 2589052 2627438 2691187 2587888 2671588 2713747 2614878 2614770 2591191 2605899
sum_num_inserts_total=254084569
sum_num_deletes_by_thread=2688696 2722938 2646115 2679353 2625129 2621111 2671269 2673177 2702618 2694181 2631661 2700791 2682984 2686950 2626414 2605361 2665534 2718216 2649548 2638235 2712312 2636101 2630478 2616314 2646931 2627697 2673113 2623497 2649358 2599156 2709153 2616111 2613288 2611228 2634444 2718225 2627958 2627427 2632251 2628959 2637874 2725573 2623752 2611654 2707171 2642111 2637099 2682873 2624433 2695253 2697377 2640326 2579167 2591899 2582259 2705343 2669805 2608224 2688188 2606253 2656651 2680339 2649906 2623343 2655468 2652569 2674257 2585837 2612782 2598980 2666957 2600946 2596048 2622292 2680167 2612185 2677292 2595812 2586310 2712477 2590550 2613247 2708346 2689447 2713472 2593252 2583786 2627770 2689013 2589903 2674355 2714971 2619742 2615259 2589152 2609706
sum_num_deletes_total=254083505
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5376979 5443496 5292545 5357842 5253759 5242266 5341735 5349048 5403014 5386502 5261363 5400305 5364280 5372466 5251043 5206847 5329152 5437443 5294642 5278835 5423655 5270007 5265086 5232950 5297759 5257980 5346675 5249315 5299497 5200461 5419269 5230943 5228450 5221116 5272374 5433900 5260906 5250826 5263832 5259955 5280504 5452448 5247261 5225818 5410875 5282562 5276147 5365340 5249277 5389046 5392991 5279526 5161411 5183281 5163120 5410049 5336691 5215203 5375583 5213509 5309615 5363173 5305211 5246562 5312835 5310091 5349689 5171270 5221883 5196300 5331668 5202908 5193143 5243324 5361774 5222122 5357461 5192668 5174764 5423122 5179839 5227012 5418643 5379746 5427085 5185711 5172838 5255208 5380200 5177791 5345943 5428718 5234620 5230029 5180343 5215605
average_num_operations_total=5293417
stdev_num_operations_total=8396
sum_num_operations_total=508168074
min_num_operations_total=5161411
max_num_operations_total=5452448
first_time_thread_terminate_by_thread=10000919 10000671 10001316 10001395 10000698 10001417 10000342 10001019 10000167 10000307 10000923 10001300 10001261 10001179 10001074 10001294 10001366 10001386 10001250 10000921 10001391 10001338 10001433 10000162 10001248 10001357 10001242 10001285 10000719 10000163 10001412 10001232 10001345 10001237 10001316 10000299 10001273 10001236 10001443 10001341 10000938 10001391 10001340 10001273 10001033 10001196 10000760 10000718 10000470 10000480 10001378 10000505 10001279 10001133 10000583 10000876 10001384 10001370 10001445 10001091 10001479 10000477 10001469 10001432 10001119 10001266 10000487 10001401 10001460 10000427 10001153 10001399 10000475 10001495 10001337 10001276 10001094 10000425 10001114 10000876 10001339 10000287 10001122 10000236 10001321 10000391 10000236 10000432 10001368 10001261 10000501 10001295 10000877 10000391 10001421 10000326
min_time_thread_terminate_total=10000162
max_time_thread_terminate_total=10001495
first_time_thread_start_by_thread=7 7 7 6 7 6 7 7 7 7 6 7 6 6 7 7 7 7 7 7 7 7 7 7 7 7 7 6 7 6 7 7 7 7 6 7 6 6 7 7 7 7 7 7 7 7 7 7 6 7 7 7 7 7 6 6 7 7 7 6 7 6 7 7 7 6 7 6 6 6 6 6 6 7 7 7 7 7 6 6 7 7 7 6 7 6 7 7 7 6 7 6 6 6 6 6
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=10033578382
threads_final_size=100177
final_keysum=10033578382
final_size=100177
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=254084569
total_deletes=254083505
total_updates=508168074
total_queries=0
total_ops=508168074
find_throughput=0
rq_throughput=0
update_throughput=50816807
query_throughput=0
total_throughput=50816807


total find                    : 0
total rq                      : 0
total inserts                 : 254084569
total deletes                 : 254083505
total updates                 : 508168074
total queries                 : 0
total ops                     : 508168074
find throughput               : 0
rq throughput                 : 0
update throughput             : 50816807
query throughput              : 0
total throughput              : 50816807

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=12.7025
PAPI_L3_TCM=3.64106
PAPI_TOT_CYC=4827.85
PAPI_TOT_INS=986.223
garbage=0
total_execution_walltime=11.595s
REALTIME_MAIN_END_PERF_FORMAT=6990366.85769786
[time_cmd_output] time_elapsed_sec=11.71, faults_major=0, faults_minor=80860, mem_maxresident_kb=321128, user_cputime=1010.94, sys_cputime=10.20, percent_cpu=8715%
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