__step=000938
__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 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000938.txt
__path_data=data/data000938.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218138.289942131
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=200000
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=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.021s
prefilling_size=100177 prefilling_elapsed_millis=1s
finished prefilling to size 100145 for expected size 100000 keysum=10011370068, performing 44851381 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100145
pref_millis=1101
prefill_elapsed_ms=1119
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=1281
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=218139.443681478
REALTIME_END_PERF_FORMAT=218149.443763509
###############################################################################
################################## 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 1806 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.166s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 252 489 903 1571 2561 3962 5625 7401 8940 10177 10773 10680 10015 8406 6436 4530 2927 1748 1003 476 264 168 118 76 69 56 43 32 16 4 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 4 15 75 235 581 1160 2299 3849 5862 7703 9581 10866 11345 11624 10376 8342 6133 4106 2493 1530 688 360 218 160 83 82 69 54 48 28 6 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 504 978 1806 3142 5122 7924 11250 14802 17880 20354 21546 21360 20030 16812 12872 9060 5854 3496 2006 952 528 336 236 152 138 112 86 64 32 8 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 4 15 75 235 581 1160 2298 3849 5862 7703 9581 10866 11345 11624 10376 8342 6133 4106 2493 1530 688 360 218 160 83 82 69 54 48 28 6 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98438 1.97024 1.92331 1.86988 1.81509 1.77353 1.70974 1.65787 1.60397 1.56918 1.52928 1.49568 1.46887 1.41967 1.38282 1.35193 1.32307 1.2986 1.2869 1.23729 1.27731 1.31818 1.35119 1.32203 1.45395 1.4058 1.38393 1.37209 1.25 1.125 1.25 1
tree_stats_height=40
tree_stats_numInternals=99978
tree_stats_numLeaves=99979
tree_stats_numNodes=199957
tree_stats_numKeys=99978
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.2062
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20160 39120 72240 125680 204880 316960 450000 592080 715200 814160 861840 854400 801200 672480 514880 362400 234160 139840 80240 38080 21120 13440 9440 6080 5520 4480 3440 2560 1280 320 160
tree_stats_sizeInBytes=7998280
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=12588
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:67 4:17 8:17 16:28 32:41 64:67 128:91096 256:547947 512:166 1024:137 2048:75
(2^01, 2^02]: 67
(2^02, 2^03]: 17
(2^03, 2^04]: 17
(2^04, 2^05]: 28
(2^05, 2^06]: 41
(2^06, 2^07]: 67
(2^07, 2^08]: 91096
(2^08, 2^09]: 547947
(2^09, 2^10]: 166
(2^10, 2^11]: 137
(2^11, 2^12]: 75
sum_limbo_reclamation_event_size_total=180442412
count_limbo_reclamation_event_size_by_thread=9996 9994 9995 9997 9997 9994 9998 9994 9996 9993 9994 9993 9994 9994 9994 9995 9997 9993 9994 9996 9994 9994 9993 9996 9993 9995 9996 9995 9997 9995 9993 9994 9995 9994 9994 9996 9994 9992 9994 9997 9994 9996 9995 9995 9994 9994 9993 9993 9996 9995 9996 9996 9992 9995 9994 9996 9995 9995 9993 9994 9996 9993 9995 9994
count_limbo_reclamation_event_size_total=639658
sum_limbo_reclamation_event_count_total=723465
first_thread_announced_epoch_by_thread=25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176 25176
sum_num_inserts_by_thread=3210953 3203944 3217278 3207915 3211551 3209213 3207097 3207180 3211178 3210036 3177841 3167648 3175894 3165690 3167805 3163218 3164885 3223716 3204213 3206118 3228456 3221858 3217239 3207941 3179700 3158466 3155550 3138433 3155091 3156711 3150526 3214245 3210422 3213494 3205139 3207894 3218909 3214162 3185615 3162509 3157903 3158197 3152438 3151108 3134510 3199035 3191909 3176129 3183730 3186693 3181299 3172175 3174125 3160982 3159193 3164251 3162062 3167938 3167697 3211705 3234726 3238857 3233524 3235833
sum_num_inserts_total=204071752
sum_num_deletes_by_thread=3206625 3208128 3218235 3206135 3212917 3210664 3208922 3210783 3212593 3211900 3176032 3165836 3174730 3171410 3165043 3167516 3170033 3223767 3205169 3204492 3221068 3222166 3217429 3205923 3179223 3157789 3155085 3139084 3155194 3155798 3148443 3212332 3211641 3213094 3201417 3205418 3218676 3211993 3189346 3166073 3162880 3155232 3150397 3150654 3138090 3197071 3190767 3180052 3182628 3188015 3181088 3170877 3172578 3161404 3161588 3166016 3163732 3170966 3171293 3208680 3237427 3236037 3234372 3237652
sum_num_deletes_total=204087618
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6417578 6412072 6435513 6414050 6424468 6419877 6416019 6417963 6423771 6421936 6353873 6333484 6350624 6337100 6332848 6330734 6334918 6447483 6409382 6410610 6449524 6444024 6434668 6413864 6358923 6316255 6310635 6277517 6310285 6312509 6298969 6426577 6422063 6426588 6406556 6413312 6437585 6426155 6374961 6328582 6320783 6313429 6302835 6301762 6272600 6396106 6382676 6356181 6366358 6374708 6362387 6343052 6346703 6322386 6320781 6330267 6325794 6338904 6338990 6420385 6472153 6474894 6467896 6473485
average_num_operations_total=6377490
stdev_num_operations_total=6851
sum_num_operations_total=408159370
min_num_operations_total=6272600
max_num_operations_total=6474894
first_time_thread_terminate_by_thread=10000080 10000080 10000082 10000080 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000082 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000081 10000081 10000081 10000081 10000080 10000080 10000082 10000080 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081
min_time_thread_terminate_total=10000080
max_time_thread_terminate_total=10000082
first_time_thread_start_by_thread=3 3 3 3 4 4 4 4 3 3 4 3 3 3 3 3 2 2 2 2 4 4 5 5 5 5 5 5 6 6 6 6 4 4 4 4 6 6 6 6 5 6 5 5 5 5 5 5 3 3 3 3 3 3 3 3 5 5 5 5 4 4 4 4
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=9999657674
threads_final_size=99978
final_keysum=9999657674
final_size=99978
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=204071752
total_deletes=204087618
total_updates=408159370
total_queries=0
total_ops=408159370
find_throughput=0
rq_throughput=0
update_throughput=40815937
query_throughput=0
total_throughput=40815937
total find : 0
total rq : 0
total inserts : 204071752
total deletes : 204087618
total updates : 408159370
total queries : 0
total ops : 408159370
find throughput : 0
rq throughput : 0
update throughput : 40815937
query throughput : 0
total throughput : 40815937
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.409s
REALTIME_MAIN_END_PERF_FORMAT=218149.700282143
[time_cmd_output] time_elapsed_sec=11.51, faults_major=0, faults_minor=79771, mem_maxresident_kb=318932, user_cputime=745.62, sys_cputime=4.82, percent_cpu=6519%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2