__step=000154
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000154.txt
__path_data=data/data000154.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208713.388342307
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.013s
prefilling_size=1001106 prefilling_elapsed_millis=1s
finished prefilling to size 1001139 for expected size 1000000 keysum=1001091358057, performing 33233800 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1001139
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=914
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=208714.530981219
REALTIME_END_PERF_FORMAT=208724.531033694
###############################################################################
################################## 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 1770 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.141s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 242 470 885 1610 2820 4768 7735 12024 17715 25059 34419 45306 57225 68864 78778 85576 88266 86550 80455 71127 59915 48453 37758 28158 20052 13510 8919 5645 3344 1944 1088 580 272 116 51 25 8 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 10 14 55 160 400 872 1801 3446 6333 10371 15699 23532 33387 45586 58950 71980 82886 89982 92645 89783 82339 71377 59148 47358 36264 26594 18101 12193 7946 4744 2800 1596 888 428 181 77 42 15 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 484 940 1770 3220 5640 9536 15470 24048 35430 50118 68838 90612 114450 137728 157556 171152 176532 173100 160910 142254 119830 96906 75516 56316 40104 27020 17838 11290 6688 3888 2176 1160 544 232 102 50 16 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 2 10 14 55 159 400 872 1801 3446 6333 10371 15699 23532 33387 45586 58950 71980 82886 89982 92645 89783 82339 71377 59148 47358 36264 26594 18101 12193 7946 4744 2800 1596 888 428 181 77 42 15 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.96032 1.97107 1.94149 1.90904 1.87578 1.84539 1.81114 1.77725 1.73665 1.70728 1.68676 1.65815 1.63154 1.6017 1.57198 1.54315 1.51572 1.49028 1.46479 1.44203 1.42118 1.40435 1.38964 1.37287 1.35606 1.33687 1.33009 1.31646 1.29619 1.29067 1.27984 1.26654 1.23448 1.21324 1.21983 1.2451 1.16 1.0625 1.5 1
tree_stats_height=48
tree_stats_numInternals=999987
tree_stats_numLeaves=999988
tree_stats_numNodes=1999975
tree_stats_numKeys=999987
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.1475
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10080 19360 37600 70800 128800 225600 381440 618800 961920 1417200 2004720 2753520 3624480 4578000 5509120 6302240 6846080 7061280 6924000 6436400 5690160 4793200 3876240 3020640 2252640 1604160 1080800 713520 451600 267520 155520 87040 46400 21760 9280 4080 2000 640 80 80
tree_stats_sizeInBytes=79999000
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=11676
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:212347 4:244804 8:44493 16:264 32:14
(2^01, 2^02]: 212347
(2^02, 2^03]: 244804
(2^03, 2^04]: 44493
(2^04, 2^05]: 264
(2^05, 2^06]: 14
sum_limbo_reclamation_event_size_total=1963124
count_limbo_reclamation_event_size_by_thread=7886 7885 7797 7925 7865 7911 7806 7843 7821 7809 7811 7889 7782 7776 7892 7858 7875 7861 7883 7881 7874 7835 7863 7767 7781 7833 7812 7830 7832 7837 7885 7856 7915 7805 7818 7884 7803 7833 7839 7832 7765 7821 7920 7812 7837 7920 7849 7855 7824 7872 7818 7857 7818 7805 7757 7802 7804 7823 7830 7841 7935 7848 7837 7882
count_limbo_reclamation_event_size_total=501922
sum_limbo_reclamation_event_count_total=688768
first_thread_announced_epoch_by_thread=23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352 23352
sum_num_inserts_by_thread=33349 33543 33310 33047 33721 33469 33306 33401 33097 33023 32924 32667 32343 32819 33112 32955 33515 33271 33226 33053 33247 33078 32553 32827 32846 32551 32410 32559 33347 32845 33297 33113 33167 33178 33321 32984 32721 32682 32860 33003 32578 32895 33683 33064 33005 33388 33230 33209 32892 32796 32844 32429 32315 32383 32303 32415 32031 33116 33130 32577 33136 32838 33055 32689
sum_num_inserts_total=2109741
sum_num_deletes_by_thread=33266 33620 33282 33393 33486 33777 33012 33158 33100 32878 32872 32835 32929 32713 33399 33139 33305 33427 33111 33279 33281 33244 32668 32717 32488 32587 32795 32843 32851 32952 33217 33472 33191 33128 33020 33107 32742 32906 32971 32395 32666 32922 33304 33222 33233 33395 33249 33419 32559 32913 32555 32591 32489 32700 32309 32369 32371 33137 32991 33049 33090 33284 33303 33150
sum_num_deletes_total=2112826
sum_num_searches_by_thread=6623199 6647095 6614205 6584490 6617577 6607371 6588738 6584965 6538104 6528645 6490912 6492427 6482477 6488293 6589332 6572634 6581509 6576418 6561575 6562004 6566871 6531233 6480253 6460876 6459178 6448528 6432547 6424267 6577307 6560946 6538865 6536746 6595209 6594768 6578316 6525753 6513107 6495741 6477941 6461280 6454718 6450097 6604422 6591952 6579961 6581592 6567330 6563695 6519284 6529395 6474965 6437457 6417826 6430409 6382869 6392168 6396032 6567718 6541007 6529881 6557153 6561144 6561350 6562687
sum_num_searches_total=417846814
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6689814 6714258 6680797 6650930 6684784 6674617 6655056 6651524 6604301 6594546 6556708 6557929 6547749 6553825 6655843 6638728 6648329 6643116 6627912 6628336 6633399 6597555 6545474 6526420 6524512 6513666 6497752 6489669 6643505 6626743 6605379 6603331 6661567 6661074 6644657 6591844 6578570 6561329 6543772 6526678 6519962 6515914 6671409 6658238 6646199 6648375 6633809 6630323 6584735 6595104 6540364 6502477 6482630 6495492 6447481 6456952 6460434 6633971 6607128 6595507 6623379 6627266 6627708 6628526
average_num_operations_total=6594834
stdev_num_operations_total=8213
sum_num_operations_total=422069381
min_num_operations_total=6447481
max_num_operations_total=6714258
first_time_thread_terminate_by_thread=10000054 10000054 10000054 10000054 10000055 10000055 10000055 10000055 10000053 10000053 10000053 10000053 10000057 10000057 10000057 10000057 10000057 10000057 10000057 10000057 10000058 10000058 10000058 10000058 10000053 10000053 10000053 10000053 10000055 10000055 10000055 10000055 10000054 10000054 10000054 10000054 10000053 10000053 10000053 10000053 10000052 10000053 10000052 10000053 10000053 10000053 10000053 10000053 10000057 10000057 10000057 10000057 10000055 10000055 10000055 10000055 10000056 10000056 10000056 10000056 10000054 10000054 10000054 10000054
min_time_thread_terminate_total=10000052
max_time_thread_terminate_total=10000058
first_time_thread_start_by_thread=3 3 3 3 4 4 4 4 6 6 6 6 4 4 4 4 4 4 4 4 8 8 8 8 9 9 9 9 7 7 7 7 7 7 7 7 7 7 7 7 6 6 6 6 3 3 3 3 4 4 4 4 5 5 5 5 5 5 5 5 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=999854577394
threads_final_size=999987
final_keysum=999854577394
final_size=999987
validate_result=success
Validation OK.
Structural validation OK.
total_find=417846814
total_rq=0
total_inserts=2109741
total_deletes=2112826
total_updates=4222567
total_queries=417846814
total_ops=422069381
find_throughput=41784681
rq_throughput=0
update_throughput=422256
query_throughput=41784681
total_throughput=42206938
total find : 417846814
total rq : 0
total inserts : 2109741
total deletes : 2112826
total updates : 4222567
total queries : 417846814
total ops : 422069381
find throughput : 41784681
rq throughput : 0
update throughput : 422256
query throughput : 41784681
total throughput : 42206938
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=45863103604419
total_execution_walltime=11.369s
REALTIME_MAIN_END_PERF_FORMAT=208724.757943241
[time_cmd_output] time_elapsed_sec=11.47, faults_major=0, faults_minor=99512, mem_maxresident_kb=399200, user_cputime=741.63, sys_cputime=5.25, percent_cpu=6507%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2