__step=000937
__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=data000937.txt
__path_data=data/data000937.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218126.723378518
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=99878 prefilling_elapsed_millis=1s
finished prefilling to size 99919 for expected size 100000 keysum=9982563497, performing 44245377 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99919
pref_millis=1101
prefill_elapsed_ms=1115
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=1272
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=218127.874972893
REALTIME_END_PERF_FORMAT=218137.875054259
###############################################################################
################################## 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 1690 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.144s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 250 470 845 1446 2321 3419 4699 6108 7344 8326 8938 9264 9096 8496 7658 6460 5055 3665 2477 1611 968 554 278 136 44 19 9 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 6 30 95 244 571 1223 2139 3290 4872 6362 7714 8612 9432 9696 9334 8856 7865 6445 4853 3343 2254 1382 830 420 228 69 29 14 7 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 500 940 1690 2892 4642 6838 9398 12216 14688 16652 17876 18528 18192 16992 15316 12920 10110 7330 4954 3222 1936 1108 556 272 88 38 18 8 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 6 30 94 244 571 1223 2139 3290 4872 6362 7714 8612 9432 9696 9334 8856 7865 6445 4853 3343 2254 1382 830 420 228 69 29 14 7 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97656 1.94 1.89787 1.85562 1.80256 1.73654 1.68719 1.64993 1.60118 1.56686 1.53675 1.51824 1.49093 1.46702 1.45068 1.42178 1.39125 1.36251 1.33793 1.32519 1.30043 1.28616 1.2509 1.2446 1.16176 1.21591 1.23684 1.22222 1.125 1
tree_stats_height=38
tree_stats_numInternals=100216
tree_stats_numLeaves=100217
tree_stats_numNodes=200433
tree_stats_numKeys=100216
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=21.1012
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20000 37600 67600 115680 185680 273520 375920 488640 587520 666080 715040 741120 727680 679680 612640 516800 404400 293200 198160 128880 77440 44320 22240 10880 3520 1520 720 320 80
tree_stats_sizeInBytes=8017320
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=12941
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:66 4:6 8:13 16:22 32:40 64:114 128:123676 256:515328 512:291 1024:65 2048:63
(2^01, 2^02]: 66
(2^02, 2^03]: 6
(2^03, 2^04]: 13
(2^04, 2^05]: 22
(2^05, 2^06]: 40
(2^06, 2^07]: 114
(2^07, 2^08]: 123676
(2^08, 2^09]: 515328
(2^09, 2^10]: 291
(2^10, 2^11]: 65
(2^11, 2^12]: 63
sum_limbo_reclamation_event_size_total=178170396
count_limbo_reclamation_event_size_by_thread=9996 9997 9994 9995 9995 9996 9996 9994 9995 9995 9995 9994 9996 9995 9995 9995 9993 9997 9996 9997 9995 9995 9994 9994 9996 9996 9996 9995 9995 9994 9994 9993 9995 9997 9995 9994 9995 9993 9995 9995 9993 9995 9996 9995 9995 9995 9995 9995 9995 9995 9995 9995 9994 9996 9995 9995 9996 9997 9996 9994 9995 9994 9997 9994
count_limbo_reclamation_event_size_total=639684
sum_limbo_reclamation_event_count_total=746557
first_thread_announced_epoch_by_thread=25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882 25882
sum_num_inserts_by_thread=3196158 3215697 3204029 3181164 3192974 3187715 3231736 3202167 3350795 3361607 3354162 3341730 3313155 3285491 3265273 3245247 3201124 3196270 3182345 3179340 3277646 3351552 3335414 3327667 3207576 3208395 3200085 3186744 3266534 3251561 3250201 3234529 3283947 3284381 3258638 3347112 3342276 3353489 3347479 3348600 3261648 3261119 3252059 3239779 3153776 3150995 3134721 3134005 3279863 3344464 3332485 3332307 3321809 3307141 3305105 3310608 3204656 3202083 3198087 3202553 3227103 3226872 3227225 3249913
sum_num_inserts_total=208412381
sum_num_deletes_by_thread=3198011 3216233 3202207 3177653 3195897 3190529 3227228 3206909 3355913 3361737 3350212 3340441 3311486 3281305 3266810 3243590 3198271 3199123 3181967 3180153 3276235 3347531 3335293 3332000 3207275 3212757 3201770 3189629 3266185 3249639 3255385 3233900 3286560 3285449 3262858 3347932 3343595 3355662 3349631 3349568 3265803 3260525 3257475 3236419 3149557 3151452 3135292 3134601 3277533 3344057 3335427 3329642 3324105 3309187 3307718 3311992 3203576 3206131 3194016 3205436 3229278 3224514 3224761 3244316
sum_num_deletes_total=208437342
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6394169 6431930 6406236 6358817 6388871 6378244 6458964 6409076 6706708 6723344 6704374 6682171 6624641 6566796 6532083 6488837 6399395 6395393 6364312 6359493 6553881 6699083 6670707 6659667 6414851 6421152 6401855 6376373 6532719 6501200 6505586 6468429 6570507 6569830 6521496 6695044 6685871 6709151 6697110 6698168 6527451 6521644 6509534 6476198 6303333 6302447 6270013 6268606 6557396 6688521 6667912 6661949 6645914 6616328 6612823 6622600 6408232 6408214 6392103 6407989 6456381 6451386 6451986 6494229
average_num_operations_total=6513276
stdev_num_operations_total=16235
sum_num_operations_total=416849723
min_num_operations_total=6268606
max_num_operations_total=6723344
first_time_thread_terminate_by_thread=10000079 10000081 10000079 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000082 10000082 10000082 10000082 10000079 10000079 10000081 10000079 10000082 10000082 10000082 10000082 10000083 10000083 10000083 10000083 10000081 10000081 10000081 10000081 10000080 10000080 10000080 10000080 10000082 10000082 10000082 10000082 10000080 10000080 10000080 10000082 10000080 10000080 10000080 10000081 10000082 10000082 10000082 10000082 10000080 10000080 10000080 10000081 10000080 10000080 10000080 10000080
min_time_thread_terminate_total=10000079
max_time_thread_terminate_total=10000083
first_time_thread_start_by_thread=5 5 5 3254 3 3 3 3 3 3 3 3 5 4 5 5 3 3 3 3 6 6 6 6 4 4 4 4 5 5 5 5 7 7 7 7 7 7 7 7 7 7 7 7 6 6 6 6 6 6 6 6 4 4 4 4 4 4 4 3 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=3254
sum_duration_all_ops_total=
threads_final_keysum=10011002972
threads_final_size=100216
final_keysum=10011002972
final_size=100216
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=208412381
total_deletes=208437342
total_updates=416849723
total_queries=0
total_ops=416849723
find_throughput=0
rq_throughput=0
update_throughput=41684972
query_throughput=0
total_throughput=41684972
total find : 0
total rq : 0
total inserts : 208412381
total deletes : 208437342
total updates : 416849723
total queries : 0
total ops : 416849723
find throughput : 0
rq throughput : 0
update throughput : 41684972
query throughput : 0
total throughput : 41684972
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.392s
REALTIME_MAIN_END_PERF_FORMAT=218138.116102658
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=80044, mem_maxresident_kb=320336, user_cputime=742.46, sys_cputime=5.10, percent_cpu=6502%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1