__step=000153
__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=data000153.txt
__path_data=data/data000153.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=208701.853964380
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.019s
prefilling_size=1000276 prefilling_elapsed_millis=1s
finished prefilling to size 1000255 for expected size 1000000 keysum=1000441463996, performing 32803622 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000255
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=901
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=208703.2976668
REALTIME_END_PERF_FORMAT=208713.3012253
###############################################################################
################################## 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 1818 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.135s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 249 483 909 1634 2846 4805 7752 12125 18022 25764 35089 45484 56031 66004 74280 80135 82955 82031 77645 70471 62347 52934 42214 32274 23353 16108 10607 6572 3830 2075 1105 642 357 202 114 52 26 11 6 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 5 15 57 184 422 887 1858 3379 6228 10280 16439 24694 34937 46058 57728 68425 77315 83879 86417 84819 78595 71760 63654 52154 41195 30598 21609 14642 9314 5585 3045 1568 927 512 290 176 78 41 16 12
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 498 966 1818 3268 5692 9610 15504 24250 36044 51528 70178 90968 112062 132008 148560 160270 165910 164062 155290 140942 124694 105868 84428 64548 46706 32216 21214 13144 7660 4150 2210 1284 714 404 228 104 52 22 12
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 5 15 57 184 422 887 1858 3379 6228 10280 16439 24694 34937 46058 57727 68425 77315 83879 86417 84819 78595 71760 63654 52154 41195 30598 21609 14642 9314 5585 3045 1568 927 512 290 176 78 41 16 12
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.98031 1.96988 1.94099 1.89879 1.87087 1.84417 1.80666 1.78206 1.74318 1.71479 1.68097 1.64812 1.61594 1.589 1.56269 1.53941 1.5176 1.49443 1.47327 1.4538 1.44236 1.42451 1.39874 1.38227 1.36179 1.34488 1.32925 1.3098 1.29139 1.27089 1.26627 1.2905 1.27804 1.28291 1.28218 1.22807 1.25 1.21154 1.27273 1
tree_stats_height=48
tree_stats_numInternals=999797
tree_stats_numLeaves=999798
tree_stats_numNodes=1999595
tree_stats_numKeys=999797
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.3266
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10160 19920 38640 72720 130720 227680 384400 620160 970000 1441760 2061120 2807120 3638720 4482480 5280320 5942400 6410800 6636400 6562480 6211600 5637680 4987760 4234720 3377120 2581920 1868240 1288640 848560 525760 306400 166000 88400 51360 28560 16160 9120 4160 2080 880 480
tree_stats_sizeInBytes=79983800
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=11698
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:211029 4:245326 8:44707 16:328 32:10
(2^01, 2^02]: 211029
(2^02, 2^03]: 245326
(2^03, 2^04]: 44707
(2^04, 2^05]: 328
(2^05, 2^06]: 10
sum_limbo_reclamation_event_size_total=1965790
count_limbo_reclamation_event_size_by_thread=7844 7862 7849 7866 7896 7758 7793 7845 7878 7871 7938 7844 7850 7855 7816 7830 7960 7864 7849 7841 7840 7864 7809 7907 7853 7838 7776 7844 7781 7876 7849 7759 7728 7795 7857 7807 7762 7903 7899 7890 7853 7886 7911 7832 7788 7852 7710 7747 7737 7756 7744 7771 7788 7862 7875 7911 7829 7813 7856 7775 7953 7816 7818 7771
count_limbo_reclamation_event_size_total=501400
sum_limbo_reclamation_event_count_total=691008
first_thread_announced_epoch_by_thread=23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396 23396
sum_num_inserts_by_thread=33512 33770 33700 33256 33424 33395 33017 33145 33241 33554 33670 33170 33504 33356 33394 33100 33463 33050 32952 32676 33050 32845 32910 33916 34024 33243 33612 32879 33387 33314 33070 32733 33220 32963 33056 32752 33075 33858 33402 32931 33525 33287 33289 33233 33333 32868 32584 32611 32916 32274 32677 33280 33355 32908 33040 33186 33060 33061 32883 32909 32635 32994 32892 32884
sum_num_inserts_total=2122273
sum_num_deletes_by_thread=33810 33444 33548 33491 33477 33120 32817 33361 33300 33749 33532 33627 33483 33355 33058 33040 33611 33265 33241 32846 32731 32852 32690 33322 33319 33286 33370 33136 33102 33377 33166 32749 32970 33063 33115 32891 32963 33719 33677 33551 33460 33660 33416 33140 32998 33104 32782 32487 32196 32322 32448 33249 32949 33130 33274 33156 33209 33090 33000 32477 32965 32907 32938 32979
sum_num_deletes_total=2121560
sum_num_searches_by_thread=6663746 6665455 6602785 6572526 6601821 6596731 6573941 6579133 6564244 6651947 6619392 6606836 6620125 6614892 6594097 6593345 6578912 6546299 6515847 6516198 6505102 6512861 6484219 6623130 6600195 6590794 6578390 6570652 6580815 6568963 6526918 6495618 6537615 6538843 6510315 6509742 6505433 6669303 6633935 6626792 6619430 6617397 6602609 6598240 6556162 6529439 6496669 6493857 6447540 6447217 6430296 6594885 6575142 6580790 6553623 6547474 6566233 6562371 6503965 6472588 6488530 6514105 6510832 6523730
sum_num_searches_total=419881031
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6731068 6732669 6670033 6639273 6668722 6663246 6639775 6645639 6630785 6719250 6686594 6673633 6687112 6681603 6660549 6659485 6645986 6612614 6582040 6581720 6570883 6578558 6549819 6690368 6667538 6657323 6645372 6636667 6647304 6635654 6593154 6561100 6603805 6604869 6576486 6575385 6571471 6736880 6701014 6693274 6686415 6684344 6669314 6664613 6622493 6595411 6562035 6558955 6512652 6511813 6495421 6661414 6641446 6646828 6619937 6613816 6632502 6628522 6569848 6537974 6554130 6580006 6576662 6589593
average_num_operations_total=6626951
stdev_num_operations_total=7083
sum_num_operations_total=424124864
min_num_operations_total=6495421
max_num_operations_total=6736880
first_time_thread_terminate_by_thread=10000038 10000038 10000038 10000038 10000039 10000039 10000039 10000039 10000039 10000039 10000039 10000039 10000036 10000036 10000036 10000036 10000036 10000036 10000036 10000036 10000037 10000037 10000036 10000036 10000037 10000037 10000037 10000037 10000038 10000038 10000038 10000038 10000038 10000038 10000038 10000038 10000037 10000037 10000037 10000037 10000040 10000040 10000041 10000040 10000037 10000037 10000037 10000037 10000036 10000036 10000036 10000036 10000040 10000040 10000040 10000040 10000039 10000039 10000039 10000040 10000040 10000040 10000040 10000040
min_time_thread_terminate_total=10000036
max_time_thread_terminate_total=10000041
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 4 4 4 8 8 8 8 7 7 7 7 7 7 7 7 4 4 4 4 7 7 7 7 8 8 8 8 4 4 4 4 6 6 6 6 3 3 3 3 4 4 4 4 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=1000071386674
threads_final_size=999797
final_keysum=1000071386674
final_size=999797
validate_result=success
Validation OK.
Structural validation OK.
total_find=419881031
total_rq=0
total_inserts=2122273
total_deletes=2121560
total_updates=4243833
total_queries=419881031
total_ops=424124864
find_throughput=41988103
rq_throughput=0
update_throughput=424383
query_throughput=41988103
total_throughput=42412486
total find : 419881031
total rq : 0
total inserts : 2122273
total deletes : 2121560
total updates : 4243833
total queries : 419881031
total ops : 424124864
find throughput : 41988103
rq throughput : 0
update throughput : 424383
query throughput : 41988103
total throughput : 42412486
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=68949411005201
total_execution_walltime=11.369s
REALTIME_MAIN_END_PERF_FORMAT=208713.224209417
[time_cmd_output] time_elapsed_sec=11.48, faults_major=0, faults_minor=99591, mem_maxresident_kb=399516, user_cputime=742.04, sys_cputime=4.40, percent_cpu=6501%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1