__step=000842
__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" ./drachsler_pext_bst_lock.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000842.txt
__path_data=data/data000842.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=217022.798449090
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=drachsler_pext_bst_lock
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=2000000
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=192
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.02s
prefilling_size=998358 prefilling_elapsed_millis=1s
finished prefilling to size 998324 for expected size 1000000 keysum=998865768625, performing 34929712 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=998324
pref_millis=1101
prefill_elapsed_ms=1114
6node_tIxPvE_object_size=192
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=918

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=217023.957524115
REALTIME_END_PERF_FORMAT=217033.957612616

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

tree_stats_computeWalltime=0.135s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 123 244 478 929 1747 3192 5509 8873 13496 19284 25908 32815 39667 45463 50007 52768 52982 51364 48052 43059 37341 30557 24428 18918 14150 10269 7397 5243 3814 2576 1650 992 576 295 153 63 19 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 0 1 8 15 60 178 507 1206 2364 4240 6835 10299 13975 18087 21829 25104 27863 28872 28843 27991 25689 23096 19111 15688 12391 9394 6801 5010 3446 2604 1787 1188 719 457 211 128 57 17 2 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 123 245 486 944 1807 3370 6016 10079 15860 23524 32743 43114 53642 63550 71836 77872 80845 80236 76895 71050 63030 53653 43539 34606 26541 19663 14198 10253 7260 5180 3437 2180 1295 752 364 191 76 21 4 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 123 245 486 944 1807 3370 6016 10079 15860 23524 32743 43114 53642 63550 71836 77872 80845 80236 76895 71050 63030 53653 43539 34606 26541 19663 14198 10253 7260 5180 3437 2180 1295 752 364 191 76 21 4 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.9375 1.99187 1.98776 1.95885 1.93008 1.89817 1.83798 1.75964 1.69322 1.63228 1.57214 1.52549 1.48307 1.44523 1.415 1.3879 1.36055 1.33711 1.3182 1.29908 1.28108 1.2588 1.24196 1.23377 1.22028 1.20772 1.19982 1.20116 1.19672 1.18815 1.16622 1.1542 1.13899 1.13591 1.09176 1.1044 1.06806 1.02632 1 1 1

tree_stats_height=47
tree_stats_numInternals=654533
tree_stats_numLeaves=346076
tree_stats_numNodes=1000609
tree_stats_numKeys=1000609

tree_stats_avgDegreeInternal=1.52874
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34587
tree_stats_avgKeyDepth=23.8287

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 23616 47040 93312 181248 346944 647040 1155072 1935168 3045120 4516608 6286656 8277888 10299264 12201600 13792512 14951424 15522240 15405312 14763840 13641600 12101760 10301376 8359488 6644352 5095872 3775296 2726016 1968576 1393920 994560 659904 418560 248640 144384 69888 36672 14592 4032 768 384
tree_stats_sizeInBytes=192116928

6node_tIxPvE_object_size=192
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=9830


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:2 2:3 4:6 8:19 16:49 32:78 64:24184 128:545263 256:384 512:249
    [2^00, 2^01]: 2
    (2^01, 2^02]: 3
    (2^02, 2^03]: 6
    (2^03, 2^04]: 19
    (2^04, 2^05]: 49
    (2^05, 2^06]: 78
    (2^06, 2^07]: 24184
    (2^07, 2^08]: 545263
    (2^08, 2^09]: 384
    (2^09, 2^10]: 249
sum_limbo_reclamation_event_size_total=84511032
count_limbo_reclamation_event_size_by_thread=8910 8910 8910 8908 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8910 8909 8910
count_limbo_reclamation_event_size_total=570237
sum_limbo_reclamation_event_count_total=570367
first_thread_announced_epoch_by_thread=19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660 19660
sum_num_inserts_by_thread=2693328 2700315 2695913 2686039 2664128 2647481 2640097 2631760 2688684 2686520 2625394 2623421 2616344 2666190 2610728 2660133 2628130 2626866 2623868 2646381 2571212 2593905 2563960 2561694 2635981 2633600 2652826 2612374 2608135 2663186 2601930 2658892 2617666 2705977 2698804 2637406 2584516 2585480 2580413 2581337 2635039 2679587 2669134 2608629 2672253 2616557 2607426 2663572 2702676 2702311 2616514 2694949 2628761 2692669 2627093 2668440 2628835 2629881 2629285 2631449 2686509 2691868 2642682 2641739
sum_num_inserts_total=169078872
sum_num_deletes_by_thread=2697894 2698851 2696402 2685331 2662605 2643934 2638730 2633064 2684725 2690576 2625053 2626298 2611814 2665756 2608470 2657954 2628519 2628577 2621380 2645637 2568548 2595360 2565247 2561588 2633296 2636247 2650539 2612673 2608801 2665470 2601887 2656969 2619258 2707671 2700498 2639155 2584690 2585688 2582524 2583508 2637039 2678192 2668119 2608313 2673605 2614105 2610244 2662681 2702056 2703667 2614965 2692943 2632593 2690831 2624889 2670897 2630964 2632136 2628967 2635740 2686778 2691398 2642855 2643805
sum_num_deletes_total=169088969
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5391222 5399166 5392315 5371370 5326733 5291415 5278827 5264824 5373409 5377096 5250447 5249719 5228158 5331946 5219198 5318087 5256649 5255443 5245248 5292018 5139760 5189265 5129207 5123282 5269277 5269847 5303365 5225047 5216936 5328656 5203817 5315861 5236924 5413648 5399302 5276561 5169206 5171168 5162937 5164845 5272078 5357779 5337253 5216942 5345858 5230662 5217670 5326253 5404732 5405978 5231479 5387892 5261354 5383500 5251982 5339337 5259799 5262017 5258252 5267189 5373287 5383266 5285537 5285544
average_num_operations_total=5283872
stdev_num_operations_total=9620
sum_num_operations_total=338167841
min_num_operations_total=5123282
max_num_operations_total=5413648
first_time_thread_terminate_by_thread=10000088 10000088 10000095 10000088 10000091 10000092 10000091 10000091 10000089 10000089 10000091 10000089 10000087 10000087 10000087 10000087 10000089 10000089 10000089 10000089 10000092 10000090 10000090 10000090 10000091 10000091 10000091 10000093 10000090 10000090 10000090 10000090 10000088 10000088 10000088 10000088 10000090 10000087 10000087 10000090 10000088 10000088 10000088 10000088 10000094 10000088 10000088 10000088 10000090 10000106 10000090 10000090 10000091 10000091 10000091 10000091 10000090 10000090 10000090 10000090 10000092 10000096 10000092 10000092
min_time_thread_terminate_total=10000087
max_time_thread_terminate_total=10000106
first_time_thread_start_by_thread=6 6 6 6 7 7 7 7 7 7 7 7 5 5 5 5 8 8 8 8 7 7 7 7 8 8 8 8 11 11 11 11 9 9 9 9 9 9 9 9 8 8 8 8 10 10 10 10 10 10 10 10 10 10 10 10 9 9 9 9 11 11 11 11
min_time_thread_start_total=5
max_time_thread_start_total=11
sum_duration_all_ops_total=

threads_final_keysum=999978443125
threads_final_size=1000609
final_keysum=999978443125
final_size=1000609
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=169078872
total_deletes=169088969
total_updates=338167841
total_queries=0
total_ops=338167841
find_throughput=0
rq_throughput=0
update_throughput=33816784
query_throughput=0
total_throughput=33816784


total find                    : 0
total rq                      : 0
total inserts                 : 169078872
total deletes                 : 169088969
total updates                 : 338167841
total queries                 : 0
total ops                     : 338167841
find throughput               : 0
rq throughput                 : 0
update throughput             : 33816784
query throughput              : 0
total throughput              : 33816784

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.38s
REALTIME_MAIN_END_PERF_FORMAT=217034.179028061
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=130419, mem_maxresident_kb=518468, user_cputime=746.46, sys_cputime=5.18, percent_cpu=6538%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2