__step=000490
__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 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000490.txt
__path_data=data/data000490.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212773.209564579
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=2000000
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.02s
prefilling_size=999664 prefilling_elapsed_millis=1s
finished prefilling to size 999655 for expected size 1000000 keysum=999842027929, performing 32415990 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999655
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=892
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=212774.364631153
REALTIME_END_PERF_FORMAT=212784.364734414
###############################################################################
################################## 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 1736 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.146s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 249 466 868 1605 2873 4994 8220 12800 18872 26562 35982 46552 57243 67086 75641 82196 85400 84862 79938 71379 60819 49411 38086 27784 19657 13649 9210 6071 4016 2619 1627 929 505 268 135 64 21 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 7 32 64 131 337 752 1768 3640 6728 11182 17142 25412 35861 47400 58531 69086 78992 85938 89786 88497 81939 72227 60736 48388 35911 25665 18088 12349 8126 5413 3611 2325 1353 742 401 206 107 38 8
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 498 932 1736 3210 5746 9988 16440 25600 37744 53124 71964 93104 114486 134172 151282 164392 170800 169724 159876 142758 121638 98822 76172 55568 39314 27298 18420 12142 8032 5238 3254 1858 1010 536 270 128 42 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 7 32 64 131 337 752 1768 3640 6727 11182 17142 25412 35861 47400 58531 69086 78992 85938 89786 88497 81939 72227 60736 48388 35911 25665 18088 12349 8126 5413 3611 2325 1353 742 401 206 107 38 8
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97266 1.93574 1.93133 1.92454 1.89502 1.86913 1.82299 1.77859 1.73715 1.70374 1.67732 1.64688 1.61483 1.58598 1.56376 1.54333 1.51949 1.49685 1.47099 1.44646 1.42603 1.40621 1.3854 1.36475 1.35375 1.34718 1.33739 1.32959 1.33075 1.32607 1.31061 1.28549 1.2718 1.26535 1.25187 1.23704 1.16406 1.09524 1
tree_stats_height=47
tree_stats_numInternals=998918
tree_stats_numLeaves=998919
tree_stats_numNodes=1997837
tree_stats_numKeys=998918
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.1624
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 19920 37280 69440 128400 229840 399520 657600 1024000 1509760 2124960 2878560 3724160 4579440 5366880 6051280 6575680 6832000 6788960 6395040 5710320 4865520 3952880 3046880 2222720 1572560 1091920 736800 485680 321280 209520 130160 74320 40400 21440 10800 5120 1680 320
tree_stats_sizeInBytes=79913480
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=11620
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:86 8:9165 16:336265 32:293725 64:453 128:175
(2^01, 2^02]: 2
(2^02, 2^03]: 86
(2^03, 2^04]: 9165
(2^04, 2^05]: 336265
(2^05, 2^06]: 293725
(2^06, 2^07]: 453
(2^07, 2^08]: 175
sum_limbo_reclamation_event_size_total=19582412
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639871
sum_limbo_reclamation_event_count_total=686591
first_thread_announced_epoch_by_thread=23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240 23240
sum_num_inserts_by_thread=332546 333088 332171 328580 331117 330851 329363 332589 333423 332337 331327 331095 330818 331624 329243 329409 326304 325653 325242 324608 324453 332173 329817 328261 330647 329821 328660 328162 327486 325791 324215 324064 325042 326228 324252 332187 332223 331636 330655 330004 330479 331294 328940 325249 326816 327443 323898 324017 321949 329629 328511 328084 329316 328804 328555 327460 327285 325153 324117 324503 324174 325924 325164 326407
sum_num_inserts_total=21010336
sum_num_deletes_by_thread=333253 333542 331372 328211 330614 330909 328944 333454 332484 333734 332596 331080 331161 332794 329765 328896 326557 326192 324302 323937 324937 329591 329287 329369 330939 330300 327712 329196 327620 325738 324164 323062 326397 325660 324431 329901 331974 332447 330786 330719 330624 330875 327562 326062 326656 326803 324296 325364 321925 330725 329260 328806 328359 329250 328304 328283 327270 324936 323011 325180 323839 325239 326071 326066
sum_num_deletes_total=21012793
sum_num_searches_by_thread=5997339 6005102 5963658 5928754 5950816 5945624 5932768 5996702 5992988 5992571 5976363 5968105 5976224 5978803 5932246 5912708 5868105 5867333 5845378 5844594 5848302 5958847 5933671 5918562 5945494 5940278 5925656 5915720 5890539 5862137 5830420 5828428 5864745 5863424 5840127 5977531 5972917 5967990 5951148 5945505 5957333 5955602 5902141 5872295 5882503 5875192 5846043 5855006 5807608 5955834 5920349 5910565 5926322 5921891 5902071 5898476 5889414 5859083 5828998 5828448 5839952 5861009 5861551 5875644
sum_num_searches_total=378290952
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6663138 6671732 6627201 6585545 6612547 6607384 6591075 6662745 6658895 6658642 6640286 6630280 6638203 6643221 6591254 6571013 6520966 6519178 6494922 6493139 6497692 6620611 6592775 6576192 6607080 6600399 6582028 6573078 6545645 6513666 6478799 6475554 6516184 6515312 6488810 6639619 6637114 6632073 6612589 6606228 6618436 6617771 6558643 6523606 6535975 6529438 6494237 6504387 6451482 6616188 6578120 6567455 6583997 6579945 6558930 6554219 6543969 6509172 6476126 6478131 6487965 6512172 6512786 6528117
average_num_operations_total=6567407
stdev_num_operations_total=7440
sum_num_operations_total=420314081
min_num_operations_total=6451482
max_num_operations_total=6671732
first_time_thread_terminate_by_thread=10000106 10000106 10000106 10000106 10000104 10000104 10000104 10000104 10000102 10000102 10000102 10000103 10000106 10000106 10000106 10000106 10000104 10000104 10000104 10000104 10000106 10000106 10000106 10000106 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000104 10000104 10000104 10000104 10000103 10000102 10000102 10000103 10000106 10000106 10000106 10000106 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000104 10000104 10000103 10000103 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000105
min_time_thread_terminate_total=10000102
max_time_thread_terminate_total=10000106
first_time_thread_start_by_thread=5 5 5 5 4 4 4 4 6 6 6 6 5 5 5 5 5 5 5 5 7 7 7 7 6 6 2515 6 8 8 8 8 7 7 7 7 9 9 9 9 8 8 8 8 8 8 8 8 9 9 9 9 7 7 7 7 6 6 6 6 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=2515
sum_duration_all_ops_total=
threads_final_keysum=998340602662
threads_final_size=998918
final_keysum=998340602662
final_size=998918
validate_result=success
Validation OK.
Structural validation OK.
total_find=378290952
total_rq=0
total_inserts=21010336
total_deletes=21012793
total_updates=42023129
total_queries=378290952
total_ops=420314081
find_throughput=37829095
rq_throughput=0
update_throughput=4202312
query_throughput=37829095
total_throughput=42031408
total find : 378290952
total rq : 0
total inserts : 21010336
total deletes : 21012793
total updates : 42023129
total queries : 378290952
total ops : 420314081
find throughput : 37829095
rq throughput : 0
update throughput : 4202312
query throughput : 37829095
total throughput : 42031408
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=124150221587351
total_execution_walltime=11.392s
REALTIME_MAIN_END_PERF_FORMAT=212784.602739101
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=99613, mem_maxresident_kb=399672, user_cputime=744.68, sys_cputime=5.62, percent_cpu=6525%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2