observability.adoc 15 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295
  1. [[webflux-observability]]
  2. = Observability
  3. Spring Security integrates with Spring Observability out-of-the-box for tracing; though it's also quite simple to configure for gathering metrics.
  4. [[webflux-observability-tracing]]
  5. == Tracing
  6. When an `ObservationRegistry` bean is present, Spring Security creates traces for:
  7. * the filter chain
  8. * the `ReactiveAuthenticationManager`, and
  9. * the `ReactiveAuthorizationManager`
  10. [[webflux-observability-tracing-boot]]
  11. === Boot Integration
  12. For example, consider a simple Boot application:
  13. [tabs]
  14. ======
  15. Java::
  16. +
  17. [source,java,role="primary"]
  18. ----
  19. @SpringBootApplication
  20. public class MyApplication {
  21. @Bean
  22. public ReactiveUserDetailsService userDetailsService() {
  23. return new MapReactiveUserDetailsManager(
  24. User.withDefaultPasswordEncoder()
  25. .username("user")
  26. .password("password")
  27. .authorities("app")
  28. .build()
  29. );
  30. }
  31. @Bean
  32. ObservationRegistryCustomizer<ObservationRegistry> addTextHandler() {
  33. return (registry) -> registry.observationConfig().observationHandler(new ObservationTextPublisher());
  34. }
  35. public static void main(String[] args) {
  36. SpringApplication.run(ListenerSamplesApplication.class, args);
  37. }
  38. }
  39. ----
  40. Kotlin::
  41. +
  42. [source,kotlin,role="secondary"]
  43. ----
  44. @SpringBootApplication
  45. class MyApplication {
  46. @Bean
  47. fun userDetailsService(): ReactiveUserDetailsService {
  48. MapReactiveUserDetailsManager(
  49. User.withDefaultPasswordEncoder()
  50. .username("user")
  51. .password("password")
  52. .authorities("app")
  53. .build()
  54. );
  55. }
  56. @Bean
  57. fun addTextHandler(): ObservationRegistryCustomizer<ObservationRegistry> {
  58. return registry: ObservationRegistry -> registry.observationConfig()
  59. .observationHandler(ObservationTextPublisher());
  60. }
  61. fun main(args: Array<String>) {
  62. runApplication<MyApplication>(*args)
  63. }
  64. }
  65. ----
  66. ======
  67. And a corresponding request:
  68. [source,bash]
  69. ----
  70. ?> http -a user:password :8080
  71. ----
  72. Will produce the following output (indentation added for clarity):
  73. [source,bash]
  74. ----
  75. START - name='http.server.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@5dfdb78', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.00191856, duration(nanos)=1918560.0, startTimeNanos=101177265022745}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@121549e0']
  76. START - name='spring.security.http.chains', contextualName='spring.security.http.chains.before', error='null', lowCardinalityKeyValues=[chain.size='14', filter.section='before'], highCardinalityKeyValues=[request.line='/'], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@3932a48c', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=4.65777E-4, duration(nanos)=465777.0, startTimeNanos=101177276300777}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@562db70f']
  77. STOP - name='spring.security.http.chains', contextualName='spring.security.http.chains.before', error='null', lowCardinalityKeyValues=[chain.size='14', filter.section='before'], highCardinalityKeyValues=[request.line='/'], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@3932a48c', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.003733105, duration(nanos)=3733105.0, startTimeNanos=101177276300777}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@562db70f']
  78. START - name='spring.security.authentications', contextualName='null', error='null', lowCardinalityKeyValues=[authentication.failure.type='Optional', authentication.method='UserDetailsRepositoryReactiveAuthenticationManager', authentication.request.type='UsernamePasswordAuthenticationToken'], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@574ba6cd', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=3.21015E-4, duration(nanos)=321015.0, startTimeNanos=101177336038417}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@49202cc7']
  79. STOP - name='spring.security.authentications', contextualName='null', error='null', lowCardinalityKeyValues=[authentication.failure.type='Optional', authentication.method='UserDetailsRepositoryReactiveAuthenticationManager', authentication.request.type='UsernamePasswordAuthenticationToken', authentication.result.type='UsernamePasswordAuthenticationToken'], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@574ba6cd', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.37574992, duration(nanos)=3.7574992E8, startTimeNanos=101177336038417}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@49202cc7']
  80. START - name='spring.security.authorizations', contextualName='null', error='null', lowCardinalityKeyValues=[object.type='SecurityContextServerWebExchange'], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@6f837332', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=2.65687E-4, duration(nanos)=265687.0, startTimeNanos=101177777941381}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@7f5bc7cb']
  81. STOP - name='spring.security.authorizations', contextualName='null', error='null', lowCardinalityKeyValues=[authorization.decision='true', object.type='SecurityContextServerWebExchange'], highCardinalityKeyValues=[authentication.authorities='[app]', authorization.decision.details='AuthorizationDecision [granted=true]'], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@6f837332', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.039239047, duration(nanos)=3.9239047E7, startTimeNanos=101177777941381}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@7f5bc7cb']
  82. START - name='spring.security.http.secured.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@2f33dfae', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=3.1775E-4, duration(nanos)=317750.0, startTimeNanos=101177821377592}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@63b0d28f']
  83. STOP - name='spring.security.http.secured.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@2f33dfae', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.219901971, duration(nanos)=2.19901971E8, startTimeNanos=101177821377592}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@63b0d28f']
  84. START - name='spring.security.http.chains', contextualName='spring.security.http.chains.after', error='null', lowCardinalityKeyValues=[chain.size='14', filter.section='after'], highCardinalityKeyValues=[request.line='/'], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@40b25623', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=3.25118E-4, duration(nanos)=325118.0, startTimeNanos=101178044824275}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@3b6cec2']
  85. STOP - name='spring.security.http.chains', contextualName='spring.security.http.chains.after', error='null', lowCardinalityKeyValues=[chain.size='14', filter.section='after'], highCardinalityKeyValues=[request.line='/'], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@40b25623', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.001693146, duration(nanos)=1693146.0, startTimeNanos=101178044824275}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@3b6cec2']
  86. STOP - name='http.server.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.tracing.handler.TracingObservationHandler$TracingContext='io.micrometer.tracing.handler.TracingObservationHandler$TracingContext@5dfdb78', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.784320641, duration(nanos)=7.84320641E8, startTimeNanos=101177265022745}', class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@121549e0']
  87. ----
  88. [[webflux-observability-tracing-manual-configuration]]
  89. === Manual Configuration
  90. For a non-Spring Boot application, or to override the existing Boot configuration, you can publish your own `ObservationRegistry` and Spring Security will still pick it up.
  91. [tabs]
  92. ======
  93. Java::
  94. +
  95. [source,java,role="primary"]
  96. ----
  97. @SpringBootApplication
  98. public class MyApplication {
  99. @Bean
  100. public ReactiveUserDetailsService userDetailsService() {
  101. return new MapReactiveUserDetailsManager(
  102. User.withDefaultPasswordEncoder()
  103. .username("user")
  104. .password("password")
  105. .authorities("app")
  106. .build()
  107. );
  108. }
  109. @Bean
  110. ObservationRegistry observationRegistry() {
  111. ObservationRegistry registry = ObservationRegistry.create();
  112. registry.observationConfig().observationHandler(new ObservationTextPublisher());
  113. return registry;
  114. }
  115. public static void main(String[] args) {
  116. SpringApplication.run(ListenerSamplesApplication.class, args);
  117. }
  118. }
  119. ----
  120. Kotlin::
  121. +
  122. [source,kotlin,role="secondary"]
  123. ----
  124. @SpringBootApplication
  125. class MyApplication {
  126. @Bean
  127. fun userDetailsService(): ReactiveUserDetailsService {
  128. MapReactiveUserDetailsManager(
  129. User.withDefaultPasswordEncoder()
  130. .username("user")
  131. .password("password")
  132. .authorities("app")
  133. .build()
  134. );
  135. }
  136. @Bean
  137. fun observationRegistry(): ObservationRegistry {
  138. ObservationRegistry registry = ObservationRegistry.create()
  139. registry.observationConfig().observationHandler(ObservationTextPublisher())
  140. return registry
  141. }
  142. fun main(args: Array<String>) {
  143. runApplication<MyApplication>(*args)
  144. }
  145. }
  146. ----
  147. Xml::
  148. +
  149. [source,kotlin,role="secondary"]
  150. ----
  151. <sec:http auto-config="true" observation-registry-ref="ref">
  152. <sec:intercept-url pattern="/**" access="authenticated"/>
  153. </sec:http>
  154. <!-- define and configure ObservationRegistry bean -->
  155. ----
  156. ======
  157. [[webflux-observability-tracing-disable]]
  158. === Disabling Observability
  159. If you don't want any Spring Security observations, in a Spring Boot application you can publish a `ObservationRegistry.NOOP` `@Bean`.
  160. However, this may turn off observations for more than just Spring Security.
  161. Instead, you can publish a `SecurityObservationSettings` like the following:
  162. [tabs]
  163. ======
  164. Java::
  165. +
  166. [source,java,role="primary"]
  167. ----
  168. @Bean
  169. SecurityObservationSettings noSpringSecurityObservations() {
  170. return SecurityObservationSettings.noObservations();
  171. }
  172. ----
  173. Kotlin::
  174. +
  175. [source,kotlin,role="secondary"]
  176. ----
  177. @Bean
  178. fun noSpringSecurityObservations(): SecurityObservationSettings {
  179. return SecurityObservationSettings.noObservations()
  180. }
  181. ----
  182. ======
  183. and then Spring Security will not wrap any filter chains, authentications, or authorizations in their `ObservationXXX` counterparts.
  184. [TIP]
  185. There is no facility for disabling observations with XML support.
  186. Instead, simply do not set the `observation-registry-ref` attribute.
  187. You can also disable security for only a subset of Security's observations.
  188. For example, the `SecurityObservationSettings` bean excludes the filter chain observations by default.
  189. So, you can also do:
  190. [tabs]
  191. ======
  192. Java::
  193. +
  194. [source,java,role="primary"]
  195. ----
  196. @Bean
  197. SecurityObservationSettings defaultSpringSecurityObservations() {
  198. return SecurityObservationSettings.withDefaults().build();
  199. }
  200. ----
  201. Kotlin::
  202. +
  203. [source,kotlin,role="secondary"]
  204. ----
  205. @Bean
  206. fun defaultSpringSecurityObservations(): SecurityObservationSettings {
  207. return SecurityObservationSettings.withDefaults().build()
  208. }
  209. ----
  210. ======
  211. Or you can turn on and off observations individually, based on the defaults:
  212. [tabs]
  213. ======
  214. Java::
  215. +
  216. [source,java,role="primary"]
  217. ----
  218. @Bean
  219. SecurityObservationSettings allSpringSecurityObservations() {
  220. return SecurityObservationSettings.withDefaults()
  221. .shouldObserveFilterChains(true).build();
  222. }
  223. ----
  224. Kotlin::
  225. +
  226. [source,kotlin,role="secondary"]
  227. ----
  228. @Bean
  229. fun allSpringSecurityObservations(): SecurityObservationSettings {
  230. return SecurityObservabilityDefaults.builder()
  231. .shouldObserveFilterChains(true).build()
  232. }
  233. ----
  234. ======
  235. [NOTE]
  236. =====
  237. For backward compatibility, all Spring Security observations are made unless a `SecurityObservationSettings` is published.
  238. =====
  239. [[webflux-observability-tracing-listing]]
  240. === Trace Listing
  241. Spring Security tracks the following spans on each request:
  242. 1. `spring.security.http.requests` - a span that wraps the entire filter chain, including the request
  243. 2. `spring.security.http.chains.before` - a span that wraps the receiving part of the security filters
  244. 3. `spring.security.http.chains.after` - a span that wraps the returning part of the security filters
  245. 4. `spring.security.http.secured.requests` - a span that wraps the now-secured application request
  246. 5. `spring.security.http.unsecured.requests` - a span that wraps requests that Spring Security does not secure
  247. 6. `spring.security.authentications` - a span that wraps authentication attempts
  248. 7. `spring.security.authorizations` - a span that wraps authorization attempts
  249. [TIP]
  250. `spring.security.http.chains.before` + `spring.security.http.secured.requests` + `spring.security.http.chains.after` = `spring.security.http.requests` +
  251. `spring.security.http.chains.before` + `spring.security.http.chains.after` = Spring Security's part of the request