__step=000844
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000844.txt
__path_data=data/data000844.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989147.720985255
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=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=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,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.01s
prefilling_size=1000113 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000071 for expected size 1000000 keysum=1000145295920, performing 54848271 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000071
pref_millis=1102
prefill_elapsed_ms=1126
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=657
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6989149.40702467
REALTIME_END_PERF_FORMAT=6989159.40891759
###############################################################################
################################## 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 1001 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.04s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 507 981 1826 3290 5634 9153 14240 20841 28773 37366 45694 52915 58075 60793 60067 56214 49832 42118 33298 24962 17851 12081 7744 4744 2729 1479 836 442 222 79 23 9 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 4 20 80 209 531 1185 2184 4158 6946 10879 15611 20724 25491 29372 32613 33620 33012 30102 26637 21680 16710 12198 8500 5528 3494 2097 1118 625 324 183 69 17 8 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 511 1001 1906 3499 6165 10338 16424 24999 35719 48245 61305 73639 83566 90165 92680 89834 82844 72220 59935 46642 34561 24279 16244 10272 6223 3576 1954 1067 546 262 92 26 10 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 511 1001 1906 3499 6165 10338 16424 24999 35719 48245 61305 73639 83566 90165 92680 89834 82844 72220 59935 46642 34561 24279 16244 10272 6223 3576 1954 1067 546 262 92 26 10 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.96673 1.92408 1.87775 1.82166 1.76302 1.70333 1.65508 1.59514 1.54514 1.4962 1.45584 1.41623 1.38401 1.35365 1.32118 1.29644 1.27024 1.2467 1.22264 1.2058 1.18599 1.17147 1.15563 1.14398 1.13611 1.13283 1.11822 1.09747 1.07326 1.04962 1.03261 1.03846 1 1
tree_stats_height=43
tree_stats_numInternals=655331
tree_stats_numLeaves=345931
tree_stats_numNodes=1001262
tree_stats_numKeys=1001262
tree_stats_avgDegreeInternal=1.52787
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34549
tree_stats_avgKeyDepth=22.9677
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 98112 192192 365952 671808 1183680 1984896 3153408 4799808 6858048 9263040 11770560 14138688 16044672 17311680 17794560 17248128 15906048 13866240 11507520 8955264 6635712 4661568 3118848 1972224 1194816 686592 375168 204864 104832 50304 17664 4992 1920 384
tree_stats_sizeInBytes=192242304
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=7154
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:20 2:1 4:2 8:4 16:9 32:14 64:101 128:618331 256:4869 512:91 1024:4
[2^00, 2^01]: 20
(2^01, 2^02]: 1
(2^02, 2^03]: 2
(2^03, 2^04]: 4
(2^04, 2^05]: 9
(2^05, 2^06]: 14
(2^06, 2^07]: 101
(2^07, 2^08]: 618331
(2^08, 2^09]: 4869
(2^09, 2^10]: 91
(2^10, 2^11]: 4
sum_limbo_reclamation_event_size_total=135019633
count_limbo_reclamation_event_size_by_thread=6494 6494 6493 6494 6495 6494 6494 6493 6494 6494 6494 6494 6495 6495 6494 6495 6494 6495 6495 6494 6495 6494 6495 6494 6494 6495 6494 6494 6494 6494 6495 6494 6494 6495 6494 6494 6495 6494 6494 6495 6495 6494 6495 6493 6495 6494 6494 6494 6494 6494 6495 6494 6495 6494 6495 6494 6494 6495 6494 6495 6493 6494 6494 6495 6494 6494 6494 6494 6494 6494 6494 6495 6494 6493 6494 6495 6494 6494 6494 6494 6494 6493 6495 6494 6494 6494 6495 6494 6494 6494 6494 6494 6495 6495 6494 6494
count_limbo_reclamation_event_size_total=623446
sum_limbo_reclamation_event_count_total=623708
first_thread_announced_epoch_by_thread=14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308 14308
sum_num_inserts_by_thread=2806418 2838809 2805598 2835459 2794240 2806218 2787447 2799857 2815468 2817681 2835219 2776470 2787389 2792536 2865247 2821341 2805796 2789747 2781551 2840689 2803422 2845253 2819932 2817166 2773188 2839907 2837648 2806556 2824167 2770117 2782842 2796969 2854769 2818099 2840654 2810616 2785828 2830877 2859151 2818012 2829921 2787744 2808745 2839017 2832894 2808025 2785846 2821696 2785585 2799257 2815437 2850660 2797879 2794764 2798364 2801999 2858928 2820383 2801918 2786869 2796167 2800101 2852679 2846874 2810201 2777670 2770834 2800290 2809893 2847225 2830063 2819326 2786347 2796211 2834696 2847858 2795357 2806198 2792318 2822333 2859682 2835771 2811754 2813812 2802591 2807368 2856307 2855820 2799928 2801838 2781583 2789341 2819369 2855205 2836974 2824058
sum_num_inserts_total=270158326
sum_num_deletes_by_thread=2804437 2837726 2802673 2833483 2799906 2799032 2786448 2797462 2816788 2816750 2836864 2781508 2790610 2794932 2863549 2823417 2803038 2789806 2780137 2840523 2804839 2844797 2820831 2819543 2775994 2838864 2840193 2807427 2822954 2768180 2786377 2793550 2850197 2818573 2843074 2811355 2784015 2826917 2860488 2814178 2828645 2787483 2811542 2841214 2831565 2810739 2789296 2825334 2785614 2801052 2817960 2848649 2796813 2790386 2796692 2802612 2861823 2815898 2799520 2785597 2795374 2803663 2849611 2847772 2812943 2775981 2771319 2799172 2812610 2844220 2832238 2817974 2785477 2793750 2834132 2849381 2795767 2805970 2795133 2824939 2862570 2832761 2808113 2813542 2804404 2811810 2857602 2856735 2797654 2799834 2779386 2789426 2817433 2855088 2838423 2823705
sum_num_deletes_total=270155781
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5610855 5676535 5608271 5668942 5594146 5605250 5573895 5597319 5632256 5634431 5672083 5557978 5577999 5587468 5728796 5644758 5608834 5579553 5561688 5681212 5608261 5690050 5640763 5636709 5549182 5678771 5677841 5613983 5647121 5538297 5569219 5590519 5704966 5636672 5683728 5621971 5569843 5657794 5719639 5632190 5658566 5575227 5620287 5680231 5664459 5618764 5575142 5647030 5571199 5600309 5633397 5699309 5594692 5585150 5595056 5604611 5720751 5636281 5601438 5572466 5591541 5603764 5702290 5694646 5623144 5553651 5542153 5599462 5622503 5691445 5662301 5637300 5571824 5589961 5668828 5697239 5591124 5612168 5587451 5647272 5722252 5668532 5619867 5627354 5606995 5619178 5713909 5712555 5597582 5601672 5560969 5578767 5636802 5710293 5675397 5647763
average_num_operations_total=5628271
stdev_num_operations_total=4928
sum_num_operations_total=540314107
min_num_operations_total=5538297
max_num_operations_total=5728796
first_time_thread_terminate_by_thread=10000191 10000190 10000189 10000189 10000190 10000189 10000189 10000189 10000191 10000191 10000191 10000189 10000192 10000192 10000189 10000189 10000189 10000193 10000189 10000190 10000189 10000190 10000189 10000189 10000189 10000189 10000192 10000189 10000189 10000189 10000189 10000192 10000191 10000190 10000191 10000192 10000192 10000192 10000189 10000189 10000192 10000192 10000189 10000190 10000190 10000190 10000189 10000189 10000189 10000191 10000188 10000189 10000188 10000192 10000189 10000189 10000191 10000188 10000189 10000189 10000189 10000189 10000190 10000191 10000192 10000192 10000188 10000192 10000191 10000188 10000189 10000190 10000189 10000191 10000188 10000190 10000189 10000188 10000189 10000189 10000189 10000189 10000189 10000189 10000188 10000190 10000190 10000191 10000192 10000192 10000188 10000193 10000189 10000190 10000190 10000190
min_time_thread_terminate_total=10000188
max_time_thread_terminate_total=10000193
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=1000779622857
threads_final_size=1001262
final_keysum=1000779622857
final_size=1001262
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=270158326
total_deletes=270155781
total_updates=540314107
total_queries=0
total_ops=540314107
find_throughput=0
rq_throughput=0
update_throughput=54031410
query_throughput=0
total_throughput=54031410
total find : 0
total rq : 0
total inserts : 270158326
total deletes : 270155781
total updates : 540314107
total queries : 0
total ops : 540314107
find throughput : 0
rq throughput : 0
update throughput : 54031410
query throughput : 0
total throughput : 54031410
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=20.458
PAPI_L3_TCM=7.09603
PAPI_TOT_CYC=4952.2
PAPI_TOT_INS=601.04
garbage=0
total_execution_walltime=11.462s
REALTIME_MAIN_END_PERF_FORMAT=6989159.183954124
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=132399, mem_maxresident_kb=524736, user_cputime=1091.29, sys_cputime=3.02, percent_cpu=9438%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2