__step=000929
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000929.txt
__path_data=data/data000929.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218033.366638585
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.023s
prefilling_size=100173 prefilling_elapsed_millis=1s
finished prefilling to size 100353 for expected size 100000 keysum=10036849480, performing 35092310 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100353
pref_millis=1101
prefill_elapsed_ms=1114
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=1201

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=218034.526753477
REALTIME_END_PERF_FORMAT=218044.526783028

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

tree_stats_computeWalltime=0.11s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 253 464 802 1275 1932 2736 3635 4461 5397 6414 7180 7700 7865 7702 7309 6706 5961 5237 4432 3686 2853 2144 1518 919 462 195 77 28 13 4 4 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 3 42 126 329 618 1128 1837 2809 3525 4380 5648 6660 7535 8028 8095 7912 7451 6685 6042 5178 4519 3562 2770 2117 1376 729 313 126 43 22 4 8
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 506 928 1604 2550 3864 5472 7270 8922 10794 12828 14360 15400 15730 15404 14618 13412 11922 10474 8864 7372 5706 4288 3036 1838 924 390 154 56 26 8 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 3 42 126 329 618 1128 1837 2809 3525 4380 5648 6660 7535 8028 8095 7912 7451 6685 6042 5178 4519 3562 2770 2117 1376 729 313 126 43 22 4 8
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.98828 1.917 1.86422 1.79489 1.75765 1.70807 1.66429 1.61362 1.60491 1.59422 1.55971 1.53621 1.51071 1.48964 1.47449 1.45875 1.44445 1.43927 1.42314 1.41584 1.387 1.37574 1.35401 1.3027 1.25136 1.21104 1.19744 1.18182 1.23214 1.15385 1.5 1

tree_stats_height=42
tree_stats_numInternals=99621
tree_stats_numLeaves=99622
tree_stats_numNodes=199243
tree_stats_numKeys=99620

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=24.4955

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20240 37120 64160 102000 154560 218880 290800 356880 431760 513120 574400 616000 629200 616160 584720 536480 476880 418960 354560 294880 228240 171520 121440 73520 36960 15600 6160 2240 1040 320 320
tree_stats_sizeInBytes=7969720

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

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:149 2:50 4:6 8:18 16:34 32:64 64:5267 128:257502 256:375783 512:549 1024:40 2048:124 4096:2
    [2^00, 2^01]: 149
    (2^01, 2^02]: 50
    (2^02, 2^03]: 6
    (2^03, 2^04]: 18
    (2^04, 2^05]: 34
    (2^05, 2^06]: 64
    (2^06, 2^07]: 5267
    (2^07, 2^08]: 257502
    (2^08, 2^09]: 375783
    (2^09, 2^10]: 549
    (2^10, 2^11]: 40
    (2^11, 2^12]: 124
    (2^12, 2^13]: 2
sum_limbo_reclamation_event_size_total=182181250
count_limbo_reclamation_event_size_by_thread=9990 9996 9994 9996 9996 9992 9994 9992 9996 9996 9994 9996 9992 9994 9994 9996 9996 9994 9996 9990 9996 9996 9994 9996 9994 9994 9994 9992 9994 9996 9992 9992 9996 9990 9990 9994 9994 9992 9990 9994 9988 9996 9996 9994 9996 9994 9996 9992 9990 9986 9994 9992 9994 9996 9992 9992 9992 9994 9996 9988 9994 9994 9992 9996
count_limbo_reclamation_event_size_total=639588
sum_limbo_reclamation_event_count_total=1527074
first_thread_announced_epoch_by_thread=26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284 26284
sum_num_inserts_by_thread=2443029 2502701 2485472 2476557 2750609 2793982 2778051 2770607 2776691 2773243 2770135 2756821 2723860 2710368 2706495 2700549 2714468 2703774 2693237 2756114 2763961 2752659 2761422 2761442 2756909 2745964 2712732 2704100 2691727 2697202 2695333 2690264 2719597 2776622 2764433 2756898 2772772 2774927 2761223 2771714 2736100 2724764 2722566 2729722 2746760 2750239 2749360 2791084 2778273 2781327 2782572 2780235 2529371 2528188 2512382 2523126 2777911 2783801 2789400 2782271 2796431 2797700 2798145 2805773
sum_num_inserts_total=174116165
sum_num_deletes_by_thread=2442418 2501128 2484124 2476612 2755410 2792901 2775704 2770632 2772664 2769508 2772722 2754414 2723423 2711605 2709068 2698893 2714445 2703349 2691234 2753610 2763793 2753890 2761567 2759768 2754659 2747751 2715603 2696835 2690010 2696668 2696057 2689816 2720222 2775104 2767884 2758020 2771349 2774670 2763314 2770322 2735726 2726540 2723142 2726424 2743439 2751918 2750946 2789392 2780361 2778731 2783336 2780539 2524157 2527564 2512960 2521714 2779741 2785123 2787659 2780136 2794809 2797073 2797531 2806349
sum_num_deletes_total=174086476
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4885447 5003829 4969596 4953169 5506019 5586883 5553755 5541239 5549355 5542751 5542857 5511235 5447283 5421973 5415563 5399442 5428913 5407123 5384471 5509724 5527754 5506549 5522989 5521210 5511568 5493715 5428335 5400935 5381737 5393870 5391390 5380080 5439819 5551726 5532317 5514918 5544121 5549597 5524537 5542036 5471826 5451304 5445708 5456146 5490199 5502157 5500306 5580476 5558634 5560058 5565908 5560774 5053528 5055752 5025342 5044840 5557652 5568924 5577059 5562407 5591240 5594773 5595676 5612122
average_num_operations_total=5440666
stdev_num_operations_total=22721
sum_num_operations_total=348202641
min_num_operations_total=4885447
max_num_operations_total=5612122
first_time_thread_terminate_by_thread=10000032 10000032 10000032 10000032 10000030 10000030 10000030 10000030 10000030 10000030 10000030 10000030 10000029 10000029 10000029 10000029 10000029 10000029 10000030 10000029 10000029 10000029 10000029 10000029 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000031 10000033 10000033 10000033 10000033 10000032 10000032 10000032 10000032 10000032 10000032 10000032 10000032 10000030 10000030 10000030 10000030 10000031 10000031 10000031 10000031 10000030 10000030 10000030 10000030 10000032 10000032 10000032 10000032
min_time_thread_terminate_total=10000029
max_time_thread_terminate_total=10000033
first_time_thread_start_by_thread=5 5 5 5 7 7 7 7 7 7 7 7 6 6 6 6 5 4 4 4 7 7 7 7 7 6 7 7 7 7 7 7 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 8 8 8 8 8 8 8 8 9 9 9 9 9 9 9 9
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=9986400048
threads_final_size=99620
final_keysum=9986400048
final_size=99620
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=174116165
total_deletes=174086476
total_updates=348202641
total_queries=0
total_ops=348202641
find_throughput=0
rq_throughput=0
update_throughput=34820264
query_throughput=0
total_throughput=34820264


total find                    : 0
total rq                      : 0
total inserts                 : 174116165
total deletes                 : 174086476
total updates                 : 348202641
total queries                 : 0
total ops                     : 348202641
find throughput               : 0
rq throughput                 : 0
update throughput             : 34820264
query throughput              : 0
total throughput              : 34820264

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.369s
REALTIME_MAIN_END_PERF_FORMAT=218044.736364902
[time_cmd_output] time_elapsed_sec=11.46, faults_major=0, faults_minor=84989, mem_maxresident_kb=339156, user_cputime=724.00, sys_cputime=14.84, percent_cpu=6442%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1