__step=000377
__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" ./guerraoui_ext_bst_ticket.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000377.txt
__path_data=data/data000377.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=211362.467379634
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=guerraoui_ext_bst_ticket
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40
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.019s
prefilling_size=7331731 prefilling_elapsed_millis=1s
prefilling_size=7608169 prefilling_elapsed_millis=1.101s
prefilling_size=7853616 prefilling_elapsed_millis=1.201s
prefilling_size=8067733 prefilling_elapsed_millis=1.301s
prefilling_size=8259331 prefilling_elapsed_millis=1.401s
prefilling_size=8432245 prefilling_elapsed_millis=1.502s
prefilling_size=8586158 prefilling_elapsed_millis=1.602s
prefilling_size=8722722 prefilling_elapsed_millis=1.702s
prefilling_size=8845522 prefilling_elapsed_millis=1.802s
prefilling_size=8955888 prefilling_elapsed_millis=1.903s
prefilling_size=9056337 prefilling_elapsed_millis=2.003s
prefilling_size=9147122 prefilling_elapsed_millis=2.103s
prefilling_size=9228920 prefilling_elapsed_millis=2.203s
prefilling_size=9301703 prefilling_elapsed_millis=2.303s
prefilling_size=9368137 prefilling_elapsed_millis=2.404s
prefilling_size=9429714 prefilling_elapsed_millis=2.504s
prefilling_size=9482254 prefilling_elapsed_millis=2.604s
prefilling_size=9532305 prefilling_elapsed_millis=2.704s
prefilling_size=9576247 prefilling_elapsed_millis=2.805s
prefilling_size=9616362 prefilling_elapsed_millis=2.905s
prefilling_size=9652637 prefilling_elapsed_millis=3.006s
prefilling_size=9686293 prefilling_elapsed_millis=3.106s
prefilling_size=9717103 prefilling_elapsed_millis=3.206s
prefilling_size=9743416 prefilling_elapsed_millis=3.306s
prefilling_size=9767150 prefilling_elapsed_millis=3.406s
prefilling_size=9788743 prefilling_elapsed_millis=3.507s
prefilling_size=9809150 prefilling_elapsed_millis=3.607s
finished prefilling to size 9809147 for expected size 10000000 keysum=98104449789864, performing 78959378 updates; total_prefilling_elapsed_ms=3708 ms)
pref_size=9809147
pref_millis=3708
prefill_elapsed_ms=3727
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=2040
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=211366.225381596
REALTIME_END_PERF_FORMAT=211376.225444297
###############################################################################
################################## 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 1786 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.241s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 246 480 893 1664 3031 5404 9420 16098 26682 43215 67899 102999 150722 211676 284950 367440 454683 539604 615730 674657 713819 729917 722127 692240 643048 579329 505725 429265 352978 281147 216535 161157 115623 79585 52922 34131 21429 12742 7299 4042 2214 1148 565 259 121 44 13 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 10 12 67 122 297 658 1388 2742 5514 10149 18531 32799 55276 89768 138402 202460 280197 369762 463478 556803 635495 697721 737707 752014 741432 706767 652933 582185 505552 424809 345759 271913 206691 151661 106248 71713 46833 30116 18185 10556 5870 3280 1731 871 397 198 75 24 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 492 960 1786 3328 6062 10808 18840 32196 53364 86430 135798 205998 301444 423352 569900 734880 909366 1079208 1231460 1349314 1427638 1459834 1444254 1384480 1286096 1158658 1011450 858530 705956 562294 433070 322314 231246 159170 105844 68262 42858 25484 14598 8084 4428 2296 1130 518 242 88 26 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 10 12 66 122 297 658 1388 2742 5514 10149 18531 32799 55276 89768 138402 202460 280197 369762 463478 556803 635495 697721 737707 752014 741432 706767 652933 582185 505552 424809 345759 271913 206691 151661 106248 71713 46833 30116 18185 10556 5870 3280 1731 871 397 198 75 24 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.96094 1.97561 1.92917 1.93169 1.91076 1.89145 1.87158 1.85446 1.82874 1.80982 1.7856 1.75847 1.73167 1.70221 1.67308 1.64474 1.61872 1.59338 1.57054 1.54785 1.52902 1.51128 1.49466 1.47931 1.46447 1.45046 1.43647 1.42441 1.41114 1.39825 1.38509 1.37213 1.35873 1.34416 1.33249 1.32247 1.31392 1.29731 1.28642 1.27689 1.27387 1.25926 1.24608 1.2292 1.23359 1.18182 1.14773 1.07692 1.25 1
tree_stats_height=58
tree_stats_numInternals=9937175
tree_stats_numLeaves=9937176
tree_stats_numNodes=19874351
tree_stats_numKeys=9937175
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=31.5166
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 19680 38400 71440 133120 242480 432320 753600 1287840 2134560 3457200 5431920 8239920 12057760 16934080 22796000 29395200 36374640 43168320 49258400 53972560 57105520 58393360 57770160 55379200 51443840 46346320 40458000 34341200 28238240 22491760 17322800 12892560 9249840 6366800 4233760 2730480 1714320 1019360 583920 323360 177120 91840 45200 20720 9680 3520 1040 160 80
tree_stats_sizeInBytes=794974040
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=7837
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:1 4:48 8:5554 16:197602 32:167299 64:375
(2^01, 2^02]: 1
(2^02, 2^03]: 48
(2^03, 2^04]: 5554
(2^04, 2^05]: 197602
(2^05, 2^06]: 167299
(2^06, 2^07]: 375
sum_limbo_reclamation_event_size_total=11290402
count_limbo_reclamation_event_size_by_thread=5795 5795 5795 5794 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795 5795
count_limbo_reclamation_event_size_total=370879
sum_limbo_reclamation_event_count_total=371008
first_thread_announced_epoch_by_thread=15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674 15674
sum_num_inserts_by_thread=179885 181533 180837 179661 179643 180636 179297 179242 179493 179044 178270 178921 178454 178701 179906 180252 178385 179518 177792 178559 178470 177543 177867 176609 177155 176972 176862 176126 179342 179200 178304 178200 179872 178933 178679 178587 178912 178104 177644 177734 177871 177753 177660 179333 180008 179335 178513 178768 178934 178253 177190 177196 176194 176770 176144 176245 176048 179155 177864 178250 178847 178765 179065 178516
sum_num_inserts_total=11421821
sum_num_deletes_by_thread=180120 180364 180137 179320 179555 181106 179623 180061 179662 179934 178625 178221 179063 178876 179052 179506 178828 178849 178591 178052 178605 178204 176495 177125 177870 177393 176264 176390 178543 179321 178863 178426 179476 179630 179168 178911 179375 178723 178118 177800 178595 178294 177884 180014 179768 179371 179099 178540 178070 178987 176957 177271 177173 176652 175334 175435 177237 180026 178481 177613 179302 178405 178855 178091
sum_num_deletes_total=11427699
sum_num_searches_by_thread=3253133 3253641 3240507 3228135 3247040 3245407 3237208 3230657 3233884 3228104 3213703 3211349 3216432 3219238 3240739 3234054 3220052 3217713 3206341 3208948 3214696 3208350 3188632 3185013 3195394 3194171 3182908 3183505 3225114 3220845 3207868 3208859 3229492 3231241 3221004 3220343 3218266 3215672 3195592 3194171 3205945 3207306 3194076 3234414 3236809 3235334 3223573 3222652 3214004 3213726 3195301 3186884 3185481 3187311 3172092 3175418 3177399 3222811 3207656 3206509 3217212 3220825 3209906 3210837
sum_num_searches_total=205690902
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3613138 3615538 3601481 3587116 3606238 3607149 3596128 3589960 3593039 3587082 3570598 3568491 3573949 3576815 3599697 3593812 3577265 3576080 3562724 3565559 3571771 3564097 3542994 3538747 3550419 3548536 3536034 3536021 3582999 3579366 3565035 3565485 3588840 3589804 3578851 3577841 3576553 3572499 3551354 3549705 3562411 3563353 3549620 3593761 3596585 3594040 3581185 3579960 3571008 3570966 3549448 3541351 3538848 3540733 3523570 3527098 3530684 3581992 3564001 3562372 3575361 3577995 3567826 3567444
average_num_operations_total=3570944
stdev_num_operations_total=2743
sum_num_operations_total=228540422
min_num_operations_total=3523570
max_num_operations_total=3615538
first_time_thread_terminate_by_thread=10000064 10000064 10000064 10000064 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000063 10000063 10000063 10000063 10000065 10000065 10000065 10000065 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000065 10000065 10000065 10000065 10000062 10000062 10000062 10000062 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000062 10000062 10000062 10000063 10000064 10000063 10000063 10000062 10000064 10000062 10000062 10000064 10000064 10000064 10000064 10000065 10000065 10000065 10000065
min_time_thread_terminate_total=10000062
max_time_thread_terminate_total=10000065
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 6 6 6 6 5 5 5 5 4 5 5 4 5 5 5 5 8 7 8 8 7 7 7 7 9 9 9 8 6 6 6 6 9 9 9 9 8 8 8 8 7 7 7 7 3 3 3 3 7 7 7 7 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=99385537066881
threads_final_size=9937175
final_keysum=99385537066881
final_size=9937175
validate_result=success
Validation OK.
Structural validation OK.
total_find=205690902
total_rq=0
total_inserts=11421821
total_deletes=11427699
total_updates=22849520
total_queries=205690902
total_ops=228540422
find_throughput=20569090
rq_throughput=0
update_throughput=2284952
query_throughput=20569090
total_throughput=22854042
total find : 205690902
total rq : 0
total inserts : 11421821
total deletes : 11427699
total updates : 22849520
total queries : 205690902
total ops : 228540422
find throughput : 20569090
rq throughput : 0
update throughput : 2284952
query throughput : 20569090
total throughput : 22854042
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=524547115806114
total_execution_walltime=14.048s
REALTIME_MAIN_END_PERF_FORMAT=211376.516110498
[time_cmd_output] time_elapsed_sec=14.21, faults_major=0, faults_minor=310552, mem_maxresident_kb=1243516, user_cputime=906.18, sys_cputime=5.30, percent_cpu=6411%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1