__step=000732
__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=data000732.txt
__path_data=data/data000732.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987746.336369170
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.023s
prefilling_size=8746104 prefilling_elapsed_millis=1.001s
prefilling_size=8955394 prefilling_elapsed_millis=1.101s
prefilling_size=9123530 prefilling_elapsed_millis=1.201s
prefilling_size=9268001 prefilling_elapsed_millis=1.302s
prefilling_size=9388471 prefilling_elapsed_millis=1.402s
prefilling_size=9487835 prefilling_elapsed_millis=1.502s
prefilling_size=9569572 prefilling_elapsed_millis=1.602s
prefilling_size=9639521 prefilling_elapsed_millis=1.702s
prefilling_size=9699078 prefilling_elapsed_millis=1.803s
prefilling_size=9747013 prefilling_elapsed_millis=1.903s
prefilling_size=9788012 prefilling_elapsed_millis=2.003s
prefilling_size=9821485 prefilling_elapsed_millis=2.103s
finished prefilling to size 9821502 for expected size 10000000 keysum=98224645655830, performing 80383477 updates; total_prefilling_elapsed_ms=2205 ms)
pref_size=9821502
pref_millis=2205
prefill_elapsed_ms=2231
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=922
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6987748.784210376
REALTIME_END_PERF_FORMAT=6987758.784346928
###############################################################################
################################## 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 976 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.097s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 498 955 1818 3303 5806 9999 16698 27114 42335 63884 92601 129799 174971 227256 284569 343368 399272 446832 482437 500592 500159 482087 447377 399811 345265 287582 231499 180262 135171 97788 68015 45770 29616 18597 11261 6606 3614 1895 949 404 151 63 25 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 6 21 56 182 441 871 1820 3458 6508 11305 19111 29927 45679 66202 91298 120816 153772 187188 218012 245710 265047 273804 272124 259713 238142 210872 179578 147526 117259 89785 66245 46909 32069 21063 13383 8069 4897 2732 1441 761 341 120 46 24 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 504 976 1874 3485 6247 10870 18518 30572 48843 75189 111712 159726 220650 293458 375867 464184 553044 634020 700449 746302 765206 755891 719501 659524 583407 498454 411077 327788 252430 187573 134260 92679 61685 39660 24644 14675 8511 4627 2390 1165 492 183 71 28 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 504 976 1874 3485 6247 10870 18518 30572 48843 75189 111712 159726 220650 293458 375867 464184 553044 634020 700449 746302 765206 755891 719501 659524 583407 498454 411077 327788 252430 187573 134260 92679 61685 39660 24644 14675 8511 4627 2390 1165 492 183 71 28 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97656 1.94841 1.9416 1.88954 1.84476 1.81063 1.78372 1.74922 1.71075 1.67265 1.6361 1.60088 1.56879 1.53699 1.50641 1.47787 1.45171 1.42447 1.40001 1.37671 1.35457 1.3342 1.31408 1.29485 1.27838 1.26258 1.24776 1.23424 1.22017 1.20759 1.19444 1.1837 1.17172 1.16283 1.15247 1.13853 1.12981 1.11902 1.10698 1.09038 1.07554 1.06504 1.04372 1.04225 1 1 1
tree_stats_height=55
tree_stats_numInternals=6548588
tree_stats_numLeaves=3454339
tree_stats_numNodes=10002927
tree_stats_numKeys=10002927
tree_stats_avgDegreeInternal=1.52749
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34533
tree_stats_avgKeyDepth=29.2269
tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 49152 96768 187392 359808 669120 1199424 2087040 3555456 5869824 9377856 14436288 21448704 30667392 42364800 56343936 72166464 89123328 106184448 121731840 134486208 143289984 146919552 145131072 138144192 126628608 112014144 95703168 78926784 62935296 48466560 36014016 25777920 17794368 11843520 7614720 4731648 2817600 1634112 888384 458880 223680 94464 35136 13632 5376 768 192
tree_stats_sizeInBytes=1920561984
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=4933
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:0 64:7 128:378658 256:6197
(2^06, 2^07]: 7
(2^07, 2^08]: 378658
(2^08, 2^09]: 6197
sum_limbo_reclamation_event_size_total=85562694
count_limbo_reclamation_event_size_by_thread=4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4007 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009 4009
count_limbo_reclamation_event_size_total=384862
sum_limbo_reclamation_event_count_total=385055
first_thread_announced_epoch_by_thread=9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866 9866
sum_num_inserts_by_thread=1769246 1788036 1800320 1793458 1791863 1770394 1784646 1790035 1802412 1813463 1779797 1774646 1773471 1786511 1802643 1811309 1787073 1778449 1765880 1774759 1800326 1809474 1787023 1758698 1768102 1788318 1791847 1802322 1783533 1761104 1780713 1790755 1797715 1814327 1778647 1766732 1782235 1792619 1800188 1807868 1794059 1774333 1760023 1779543 1794786 1804998 1782741 1761654 1769518 1778748 1800113 1797419 1777850 1774667 1774187 1785811 1807248 1800981 1787504 1767278 1778763 1781754 1799448 1800942 1784806 1763657 1756592 1771012 1794807 1794421 1780606 1768098 1769127 1777824 1799149 1797011 1779318 1774958 1779486 1785958 1808071 1808228 1790710 1777298 1784771 1787395 1801967 1801609 1787931 1764256 1762483 1775047 1801167 1795619 1783690 1771556
sum_num_inserts_total=171413953
sum_num_deletes_by_thread=1765152 1789534 1797898 1788989 1790676 1771926 1786646 1791103 1806578 1816128 1779656 1775301 1773578 1782766 1801698 1811793 1788988 1778695 1766910 1772154 1800824 1806816 1785002 1759880 1766934 1788101 1794081 1799846 1784439 1763148 1782592 1791796 1800925 1814761 1779548 1767626 1780827 1789690 1799320 1806021 1794032 1773399 1761032 1781235 1795714 1808756 1784369 1760831 1769951 1777264 1799140 1798768 1779935 1774893 1777073 1785204 1807008 1801925 1786353 1769326 1778690 1782811 1799380 1800080 1783928 1761383 1756908 1772739 1794881 1793796 1781432 1768454 1767420 1778855 1799848 1798259 1780321 1776418 1778808 1786011 1809683 1807627 1790481 1776963 1781834 1786576 1800639 1801496 1786161 1765930 1760289 1775431 1798779 1798768 1784391 1772628
sum_num_deletes_total=171422652
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3534398 3577570 3598218 3582447 3582539 3542320 3571292 3581138 3608990 3629591 3559453 3549947 3547049 3569277 3604341 3623102 3576061 3557144 3532790 3546913 3601150 3616290 3572025 3518578 3535036 3576419 3585928 3602168 3567972 3524252 3563305 3582551 3598640 3629088 3558195 3534358 3563062 3582309 3599508 3613889 3588091 3547732 3521055 3560778 3590500 3613754 3567110 3522485 3539469 3556012 3599253 3596187 3557785 3549560 3551260 3571015 3614256 3602906 3573857 3536604 3557453 3564565 3598828 3601022 3568734 3525040 3513500 3543751 3589688 3588217 3562038 3536552 3536547 3556679 3598997 3595270 3559639 3551376 3558294 3571969 3617754 3615855 3581191 3554261 3566605 3573971 3602606 3603105 3574092 3530186 3522772 3550478 3599946 3594387 3568081 3544184
average_num_operations_total=3571214
stdev_num_operations_total=2918
sum_num_operations_total=342836605
min_num_operations_total=3513500
max_num_operations_total=3629591
first_time_thread_terminate_by_thread=10000136 10000136 10000137 10000135 10000139 10000137 10000136 10000147 10000137 10000138 10000135 10000140 10000136 10000139 10000138 10000140 10000137 10000137 10000136 10000137 10000136 10000139 10000138 10000135 10000138 10000140 10000137 10000135 10000139 10000137 10000139 10000136 10000137 10000138 10000135 10000140 10000136 10000140 10000137 10000140 10000140 10000135 10000138 10000137 10000136 10000140 10000139 10000135 10000166 10000139 10000138 10000135 10000137 10000138 10000139 10000137 10000136 10000139 10000135 10000137 10000135 10000139 10000138 10000137 10000135 10000136 10000136 10000136 10000139 10000136 10000135 10000136 10000139 10000139 10000134 10000135 10000137 10000139 10000135 10000137 10000138 10000135 10000135 10000137 10000137 10000136 10000139 10000135 10000138 10000136 10000138 10000136 10000139 10000135 10000135 10000135
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000166
first_time_thread_start_by_thread=4 5 4 5 5 4 4 4 4 5 5 5 4 5 5 5 4 4 4 5 5 5 4 4 4 5 4 5 5 4 4 4 4 5 5 5 4 5 5 5 4 4 4 5 5 5 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 5 5 5 5 5 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=100006721978107
threads_final_size=10002927
final_keysum=100006721978107
final_size=10002927
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=171413953
total_deletes=171422652
total_updates=342836605
total_queries=0
total_ops=342836605
find_throughput=0
rq_throughput=0
update_throughput=34283660
query_throughput=0
total_throughput=34283660
total find : 0
total rq : 0
total inserts : 171413953
total deletes : 171422652
total updates : 342836605
total queries : 0
total ops : 342836605
find throughput : 0
rq throughput : 0
update throughput : 34283660
query throughput : 0
total throughput : 34283660
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=39.5609
PAPI_L3_TCM=12.2634
PAPI_TOT_CYC=7804.46
PAPI_TOT_INS=673.973
garbage=0
total_execution_walltime=12.613s
REALTIME_MAIN_END_PERF_FORMAT=6987758.950804743
[time_cmd_output] time_elapsed_sec=12.88, faults_major=0, faults_minor=560745, mem_maxresident_kb=2240168, user_cputime=1193.20, sys_cputime=5.72, percent_cpu=9307%
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=2