__step=000731
__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" ./drachsler_pext_bst_lock.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000731.txt
__path_data=data/data000731.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987733.280531641
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=drachsler_pext_bst_lock
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=192
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.045s
prefilling_size=8735633 prefilling_elapsed_millis=1s
prefilling_size=8943384 prefilling_elapsed_millis=1.1s
prefilling_size=9117488 prefilling_elapsed_millis=1.201s
prefilling_size=9262973 prefilling_elapsed_millis=1.301s
prefilling_size=9382964 prefilling_elapsed_millis=1.401s
prefilling_size=9480686 prefilling_elapsed_millis=1.501s
prefilling_size=9565365 prefilling_elapsed_millis=1.601s
prefilling_size=9636200 prefilling_elapsed_millis=1.701s
prefilling_size=9693434 prefilling_elapsed_millis=1.802s
prefilling_size=9742247 prefilling_elapsed_millis=1.902s
prefilling_size=9783136 prefilling_elapsed_millis=2.002s
prefilling_size=9818031 prefilling_elapsed_millis=2.102s
finished prefilling to size 9818019 for expected size 10000000 keysum=98177810155641, performing 80071472 updates; total_prefilling_elapsed_ms=2204 ms)
pref_size=9818019
pref_millis=2204
prefill_elapsed_ms=2220
6node_tIxPvE_object_size=192
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=918
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6987735.752157105
REALTIME_END_PERF_FORMAT=6987745.752247463
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 976 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.083s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 252 496 955 1830 3462 6413 11582 20188 33674 53635 81200 117749 163645 217921 278062 340509 399664 450785 488546 508931 510939 492677 458676 409635 353559 294755 236640 184078 138427 99305 69070 45766 29327 18229 10941 6254 3490 1781 904 397 164 54 14 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 5 21 46 108 285 710 1640 3662 7527 14279 24047 38938 58991 84705 115518 150190 185853 219937 248154 267976 279557 277251 266870 244169 215963 184805 150652 119652 92225 67078 47884 32228 20987 13186 8069 4622 2691 1360 733 320 144 53 14 2 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 255 501 976 1876 3570 6698 12292 21828 37336 61162 95479 141796 202583 276912 362767 456027 549854 636638 708483 757085 778915 772234 735927 676505 597728 510718 421445 334730 258079 191530 136148 93650 61555 39216 24127 14323 8112 4472 2264 1130 484 198 67 17 3 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 255 501 976 1876 3570 6698 12292 21828 37336 61162 95479 141796 202583 276912 362767 456027 549854 636638 708483 757085 778915 772234 735927 676505 597728 510718 421445 334730 258079 191530 136148 93650 61555 39216 24127 14323 8112 4472 2264 1130 484 198 67 17 3 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.97647 1.95808 1.94365 1.92751 1.90644 1.87772 1.83355 1.7856 1.73623 1.68415 1.63465 1.59828 1.55911 1.52308 1.49058 1.45906 1.43098 1.40478 1.37903 1.35661 1.33546 1.315 1.29599 1.27804 1.26293 1.24806 1.23275 1.22108 1.20576 1.19236 1.18054 1.1686 1.16065 1.1504 1.14017 1.12972 1.12106 1.10801 1.09982 1.07699 1.07025 1.06566 1.04478 1 1 1
tree_stats_height=54
tree_stats_numInternals=6544840
tree_stats_numLeaves=3453111
tree_stats_numNodes=9997951
tree_stats_numKeys=9997951
tree_stats_avgDegreeInternal=1.52761
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34538
tree_stats_avgKeyDepth=28.4022
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48960 96192 187392 360192 685440 1286016 2360064 4190976 7168512 11743104 18331968 27224832 38895936 53167104 69651264 87557184 105571968 122234496 136028736 145360320 149551680 148268928 141297984 129888960 114763776 98057856 80917440 64268160 49551168 36773760 26140416 17980800 11818560 7529472 4632384 2750016 1557504 858624 434688 216960 92928 38016 12864 3264 576 192
tree_stats_sizeInBytes=1919606592
6node_tIxPvE_object_size=192
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=4935
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:3 16:2 32:13 64:83 128:379077 256:6162 512:97
(2^03, 2^04]: 3
(2^04, 2^05]: 2
(2^05, 2^06]: 13
(2^06, 2^07]: 83
(2^07, 2^08]: 379077
(2^08, 2^09]: 6162
(2^09, 2^10]: 97
sum_limbo_reclamation_event_size_total=85746235
count_limbo_reclamation_event_size_by_thread=4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4014 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4014 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4015 4014 4015
count_limbo_reclamation_event_size_total=385437
sum_limbo_reclamation_event_count_total=385632
first_thread_announced_epoch_by_thread=9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870 9870
sum_num_inserts_by_thread=1771286 1782202 1802620 1799841 1782970 1772668 1781315 1790640 1808056 1813805 1787808 1777259 1778460 1791401 1805290 1802782 1792039 1780362 1768269 1774277 1795337 1798875 1780429 1765802 1774687 1784942 1799431 1801170 1793537 1773218 1775280 1792045 1813372 1814462 1789458 1779596 1775319 1791989 1803030 1802305 1795993 1782179 1765785 1780184 1795079 1800662 1778063 1766513 1773817 1785639 1802541 1802905 1788065 1774543 1782150 1793111 1814821 1818742 1786177 1779400 1785345 1793884 1806805 1799467 1791661 1774797 1764045 1775469 1800977 1798618 1783678 1779190 1771776 1786143 1799225 1799312 1781271 1777051 1781115 1791156 1815791 1816777 1797528 1782366 1783935 1796668 1804598 1807350 1789365 1777288 1767559 1781536 1804818 1807584 1789041 1774783
sum_num_inserts_total=171771975
sum_num_deletes_by_thread=1770605 1781920 1801804 1799555 1787374 1770600 1779878 1790016 1806741 1813852 1786271 1780953 1777479 1794473 1807876 1804403 1792515 1781910 1767139 1775759 1795227 1799211 1776689 1766554 1773560 1786355 1799668 1800349 1791870 1773496 1774891 1792191 1810141 1814390 1791979 1780441 1777998 1789066 1800039 1802465 1793251 1780618 1765812 1780607 1794698 1802211 1780416 1761673 1774233 1788342 1804177 1801202 1785006 1774695 1782569 1793715 1813407 1818060 1784940 1778195 1782566 1792467 1809167 1803506 1794377 1773773 1766329 1775226 1800900 1794274 1783218 1774580 1772086 1785236 1800564 1798560 1781949 1777342 1781875 1793419 1815295 1817366 1798819 1781679 1782645 1796226 1805583 1807817 1789771 1777788 1768144 1779519 1800767 1805737 1788868 1773636
sum_num_deletes_total=171756604
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3541891 3564122 3604424 3599396 3570344 3543268 3561193 3580656 3614797 3627657 3574079 3558212 3555939 3585874 3613166 3607185 3584554 3562272 3535408 3550036 3590564 3598086 3557118 3532356 3548247 3571297 3599099 3601519 3585407 3546714 3550171 3584236 3623513 3628852 3581437 3560037 3553317 3581055 3603069 3604770 3589244 3562797 3531597 3560791 3589777 3602873 3558479 3528186 3548050 3573981 3606718 3604107 3573071 3549238 3564719 3586826 3628228 3636802 3571117 3557595 3567911 3586351 3615972 3602973 3586038 3548570 3530374 3550695 3601877 3592892 3566896 3553770 3543862 3571379 3599789 3597872 3563220 3554393 3562990 3584575 3631086 3634143 3596347 3564045 3566580 3592894 3610181 3615167 3579136 3555076 3535703 3561055 3605585 3613321 3577909 3548419
average_num_operations_total=3578422
stdev_num_operations_total=2779
sum_num_operations_total=343528579
min_num_operations_total=3528186
max_num_operations_total=3636802
first_time_thread_terminate_by_thread=10000091 10000092 10000094 10000090 10000092 10000090 10000092 10000093 10000092 10000094 10000095 10000090 10000092 10000093 10000111 10000093 10000109 10000092 10000127 10000091 10000092 10000092 10000091 10000094 10000091 10000092 10000092 10000094 10000093 10000094 10000092 10000093 10000092 10000094 10000092 10000091 10000092 10000093 10000092 10000091 10000092 10000090 10000090 10000091 10000092 10000092 10000090 10000090 10000090 10000090 10000090 10000093 10000092 10000090 10000090 10000094 10000091 10000091 10000093 10000093 10000090 10000091 10000091 10000090 10000091 10000154 10000092 10000092 10000094 10000091 10000091 10000090 10000090 10000090 10000091 10000093 10000092 10000094 10000090 10000091 10000136 10000090 10000094 10000090 10000092 10000093 10000094 10000093 10000093 10000093 10000093 10000090 10000094 10000091 10000091 10000094
min_time_thread_terminate_total=10000090
max_time_thread_terminate_total=10000154
first_time_thread_start_by_thread=10 10 10 10 10 10 10 11 10 11 10 10 10 10 10 10 11 10 10 10 10 10 10 10 10 10 10 10 10 10 10 11 10 11 10 10 10 10 10 10 11 10 10 10 10 10 10 10 9 9 10 10 10 10 9 10 9 10 10 10 9 10 10 9 10 15 10 10 9 9 9 10 9 9 10 10 10 10 9 10 9 10 10 10 9 10 10 9 10 9 10 10 9 9 9 10
min_time_thread_start_total=9
max_time_thread_start_total=15
sum_duration_all_ops_total=
threads_final_keysum=100004599307619
threads_final_size=9997951
final_keysum=100004599307619
final_size=9997951
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=171771975
total_deletes=171756604
total_updates=343528579
total_queries=0
total_ops=343528579
find_throughput=0
rq_throughput=0
update_throughput=34352857
query_throughput=0
total_throughput=34352857
total find : 0
total rq : 0
total inserts : 171771975
total deletes : 171756604
total updates : 343528579
total queries : 0
total ops : 343528579
find throughput : 0
rq throughput : 0
update throughput : 34352857
query throughput : 0
total throughput : 34352857
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=39.5705
PAPI_L3_TCM=12.299
PAPI_TOT_CYC=7789.74
PAPI_TOT_INS=667.772
garbage=0
total_execution_walltime=12.718s
REALTIME_MAIN_END_PERF_FORMAT=6987746.182107
[time_cmd_output] time_elapsed_sec=12.99, faults_major=0, faults_minor=559182, mem_maxresident_kb=2234192, user_cputime=1199.52, sys_cputime=6.56, percent_cpu=9278%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1