__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000154.txt
__path_data=data/data000154.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980678.751961506
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.004s
prefilling_size=1000250 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000214 for expected size 1000000 keysum=1000450603795, performing 32379062 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000214
pref_millis=1102
prefill_elapsed_ms=1120
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=1517
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6980680.46130100
REALTIME_END_PERF_FORMAT=6980690.46275319
###############################################################################
################################## 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 (192 threads)...
partitioned into 904 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.042s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 125 237 452 870 1645 3035 5375 9133 14740 22507 32218 43246 55175 66570 75916 82562 85229 84039 78660 71003 61180 50660 40780 31668 23791 17659 12814 9153 6452 4455 2872 1766 1077 638 369 193 97 53 25 7 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 13 22 34 95 255 695 1617 3526 6973 12796 21190 31317 43780 57224 69270 79895 86419 89418 86317 80826 71700 60540 49892 39545 29923 22504 16475 11854 8449 6038 3978 2455 1516 907 545 289 141 81 43 13 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 250 474 904 1740 3290 6070 10750 18266 29480 45014 64436 86492 110350 133140 151832 165124 170458 168078 157320 142006 122360 101320 81560 63336 47582 35318 25628 18306 12904 8910 5744 3532 2154 1276 738 386 194 106 50 14 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 3 13 21 34 95 255 695 1617 3526 6973 12796 21190 31317 43780 57224 69270 79895 86419 89418 86317 80826 71700 60540 49892 39545 29923 22504 16475 11854 8449 6038 3978 2455 1516 907 545 289 141 81 43 13 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.948 1.95148 1.96239 1.9454 1.92249 1.8855 1.84958 1.80696 1.76347 1.71573 1.67115 1.63792 1.60326 1.5702 1.54377 1.51615 1.49302 1.468 1.45133 1.43083 1.41402 1.40249 1.38828 1.37563 1.37113 1.36282 1.35715 1.35245 1.34524 1.32233 1.30745 1.30493 1.29619 1.28918 1.26152 1.2513 1.2732 1.23585 1.14 1.07143 1.5 1
tree_stats_height=50
tree_stats_numInternals=998575
tree_stats_numLeaves=998576
tree_stats_numNodes=1997151
tree_stats_numKeys=998575
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=25.6877
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10000 18960 36160 69600 131600 242800 430000 730640 1179200 1800560 2577440 3459680 4414000 5325600 6073280 6604960 6818320 6723120 6292800 5680240 4894400 4052800 3262400 2533440 1903280 1412720 1025120 732240 516160 356400 229760 141280 86160 51040 29520 15440 7760 4240 2000 560 80 80
tree_stats_sizeInBytes=79886040
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=19427
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:175497 4:138806 8:14110 16:10
(2^01, 2^02]: 175497
(2^02, 2^03]: 138806
(2^03, 2^04]: 14110
(2^04, 2^05]: 10
sum_limbo_reclamation_event_size_total=1102976
count_limbo_reclamation_event_size_by_thread=6845 6852 6813 6826 6893 6769 6834 6809 6900 6881 6857 6761 6851 6871 6890 6973 6828 6772 6846 6785 6897 6904 6816 6833 6805 6925 6852 6899 6860 6790 6914 6822 6888 6896 6877 6882 6795 6793 6833 6916 6769 6795 6786 6791 6715 6855 6864 6795
count_limbo_reclamation_event_size_total=328423
sum_limbo_reclamation_event_count_total=859680
first_thread_announced_epoch_by_thread=38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854 38854
sum_num_inserts_by_thread=40676 41169 41227 41380 40972 40758 40891 41099 41703 41572 41265 40458 40763 41053 41428 41423 41310 40857 40638 40889 41243 41120 41268 40897 40998 40634 41453 41455 40914 40701 41045 40744 41858 41389 41080 40699 40663 41189 41597 41843 40881 40730 40582 40742 41206 41329 40885 40884
sum_num_inserts_total=1971560
sum_num_deletes_by_thread=40981 41207 41164 41336 41191 40518 41040 41040 41685 41574 41320 40579 41349 41267 41500 41872 40948 40530 40818 40811 41174 41701 41203 40710 40369 41049 41186 41780 40999 40863 41258 40941 41386 41767 40929 40912 41028 40799 41329 41418 40940 41006 40695 40749 41161 41545 41143 40543
sum_num_deletes_total=1973313
sum_num_searches_by_thread=8053547 8107713 8168183 8172192 8134853 8032195 8073202 8115044 8214862 8234420 8137841 8088720 8094105 8149830 8196808 8216192 8169591 8103839 8053039 8103163 8177007 8209376 8111916 8046198 8044986 8108827 8174244 8174776 8131680 8051198 8091282 8136703 8223861 8221198 8135266 8083292 8103192 8155530 8215760 8215762 8158472 8090720 8039328 8095988 8161899 8215055 8107783 8056098
sum_num_searches_total=390356736
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8135204 8190089 8250574 8254908 8217016 8113471 8155133 8197183 8298250 8317566 8220426 8169757 8176217 8232150 8279736 8299487 8251849 8185226 8134495 8184863 8259424 8292197 8194387 8127805 8126353 8190510 8256883 8258011 8213593 8132762 8173585 8218388 8307105 8304354 8217275 8164903 8184883 8237518 8298686 8299023 8240293 8172456 8120605 8177479 8244266 8297929 8189811 8137525
average_num_operations_total=8214616
stdev_num_operations_total=8628
sum_num_operations_total=394301609
min_num_operations_total=8113471
max_num_operations_total=8317566
first_time_thread_terminate_by_thread=10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145
min_time_thread_terminate_total=10000145
max_time_thread_terminate_total=10000145
first_time_thread_start_by_thread=3 3 3 2 2 2 2 2 2 2 3 3 3 2 3 2 3 3 2 3 2 2 3 3 3 3 3 2 2 2 2 2 2 2 3 3 3 2 3 2 3 3 2 3 2 2 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=998295140265
threads_final_size=998575
final_keysum=998295140265
final_size=998575
validate_result=success
Validation OK.
Structural validation OK.
total_find=390356736
total_rq=0
total_inserts=1971560
total_deletes=1973313
total_updates=3944873
total_queries=390356736
total_ops=394301609
find_throughput=39035673
rq_throughput=0
update_throughput=394487
query_throughput=39035673
total_throughput=39430160
total find : 390356736
total rq : 0
total inserts : 1971560
total deletes : 1973313
total updates : 3944873
total queries : 390356736
total ops : 394301609
find throughput : 39035673
rq throughput : 0
update throughput : 394487
query throughput : 39035673
total throughput : 39430160
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=20.9433
PAPI_L3_TCM=4.05376
PAPI_TOT_CYC=3392.79
PAPI_TOT_INS=311.21
garbage=195051297328436
total_execution_walltime=11.425s
REALTIME_MAIN_END_PERF_FORMAT=6980690.190578244
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=98810, mem_maxresident_kb=397348, user_cputime=561.28, sys_cputime=2.88, percent_cpu=4874%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2