2
0

observability.adoc 12 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235
  1. [[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. [[observability-tracing]]
  5. == Tracing
  6. When an `ObservationRegistry` bean is present, Spring Security creates traces for:
  7. * the filter chain
  8. * the `AuthenticationManager`, and
  9. * the `AuthorizationManager`
  10. [[observability-tracing-boot]]
  11. === Boot Integration
  12. For example, consider a simple Boot application:
  13. ====
  14. .Java
  15. [source,java,role="primary"]
  16. ----
  17. @SpringBootApplication
  18. public class MyApplication {
  19. @Bean
  20. public UserDetailsService userDetailsService() {
  21. return new InMemoryUserDetailsManager(
  22. User.withDefaultPasswordEncoder()
  23. .username("user")
  24. .password("password")
  25. .authorities("app")
  26. .build()
  27. );
  28. }
  29. @Bean
  30. ObservationRegistryCustomizer<ObservationRegistry> addTextHandler() {
  31. return (registry) -> registry.observationConfig().observationHandler(new ObservationTextHandler());
  32. }
  33. public static void main(String[] args) {
  34. SpringApplication.run(ListenerSamplesApplication.class, args);
  35. }
  36. }
  37. ----
  38. .Kotlin
  39. [source,kotlin,role="secondary"]
  40. ----
  41. @SpringBootApplication
  42. class MyApplication {
  43. @Bean
  44. fun userDetailsService(): UserDetailsService {
  45. InMemoryUserDetailsManager(
  46. User.withDefaultPasswordEncoder()
  47. .username("user")
  48. .password("password")
  49. .authorities("app")
  50. .build()
  51. );
  52. }
  53. @Bean
  54. fun addTextHandler(): ObservationRegistryCustomizer<ObservationRegistry> {
  55. return registry: ObservationRegistry -> registry.observationConfig()
  56. .observationHandler(ObservationTextHandler());
  57. }
  58. fun main(args: Array<String>) {
  59. runApplication<MyApplication>(*args)
  60. }
  61. }
  62. ----
  63. ====
  64. And a corresponding request:
  65. ====
  66. [source,bash]
  67. ----
  68. ?> http -a user:password :8080
  69. ----
  70. ====
  71. Will produce the following output (indentation added for clarity):
  72. ====
  73. [source,bash]
  74. ----
  75. START - name='http.server.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@687e16d1', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.001779024, duration(nanos)=1779024.0, startTimeNanos=91695917264958}']
  76. START - name='spring.security.http.chains', contextualName='spring.security.http.chains.before', error='null', lowCardinalityKeyValues=[chain.position='0', chain.size='17', filter.section='before'], highCardinalityKeyValues=[request.line='GET /'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@79f554a5', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=7.42147E-4, duration(nanos)=742147.0, startTimeNanos=91695947182029}']
  77. ... skipped for brevity ...
  78. STOP - name='spring.security.http.chains', contextualName='spring.security.http.chains.before', error='null', lowCardinalityKeyValues=[chain.position='0', chain.size='17', filter.section='before'], highCardinalityKeyValues=[request.line='GET /'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@79f554a5', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.014771848, duration(nanos)=1.4771848E7, startTimeNanos=91695947182029}']
  79. START - name='spring.security.authentications', contextualName='null', error='null', lowCardinalityKeyValues=[authentication.failure.type='Optional', authentication.method='ProviderManager', authentication.request.type='UsernamePasswordAuthenticationToken'], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@4d4b2b56', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=7.09759E-4, duration(nanos)=709759.0, startTimeNanos=91696094477504}']
  80. ... skipped for brevity ...
  81. STOP - name='spring.security.authentications', contextualName='null', error='null', lowCardinalityKeyValues=[authentication.failure.type='Optional', authentication.method='ProviderManager', authentication.request.type='UsernamePasswordAuthenticationToken', authentication.result.type='UsernamePasswordAuthenticationToken'], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@4d4b2b56', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.895141386, duration(nanos)=8.95141386E8, startTimeNanos=91696094477504}']
  82. START - name='spring.security.authorizations', contextualName='null', error='null', lowCardinalityKeyValues=[object.type='Servlet3SecurityContextHolderAwareRequestWrapper'], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@6d834cc7', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=3.0965E-4, duration(nanos)=309650.0, startTimeNanos=91697034893983}']
  83. ... skipped for brevity ...
  84. STOP - name='spring.security.authorizations', contextualName='null', error='null', lowCardinalityKeyValues=[authorization.decision='true', object.type='Servlet3SecurityContextHolderAwareRequestWrapper'], highCardinalityKeyValues=[authentication.authorities='[app]', authorization.decision.details='AuthorizationDecision [granted=true]'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@6d834cc7', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.02084809, duration(nanos)=2.084809E7, startTimeNanos=91697034893983}']
  85. START - name='spring.security.http.secured.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@649c5ec3', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=2.67878E-4, duration(nanos)=267878.0, startTimeNanos=91697059819304}']
  86. ... skipped for brevity ...
  87. STOP - name='spring.security.http.secured.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@649c5ec3', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.090753322, duration(nanos)=9.0753322E7, startTimeNanos=91697059819304}']
  88. START - name='spring.security.http.chains', contextualName='spring.security.http.chains.after', error='null', lowCardinalityKeyValues=[chain.position='0', chain.size='17', filter.section='after'], highCardinalityKeyValues=[request.line='GET /'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@47af8207', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=5.31832E-4, duration(nanos)=531832.0, startTimeNanos=91697152857268}']
  89. ... skipped for brevity ...
  90. STOP - name='spring.security.http.chains', contextualName='spring.security.http.chains.after', error='null', lowCardinalityKeyValues=[chain.position='17', chain.size='17', current.filter.name='DisableEncodeUrlFilter', filter.section='after'], highCardinalityKeyValues=[request.line='GET /'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@47af8207', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=0.007689382, duration(nanos)=7689382.0, startTimeNanos=91697152857268}']
  91. STOP - name='http.server.requests', contextualName='null', error='null', lowCardinalityKeyValues=[], highCardinalityKeyValues=[request.line='GET /'], map=[class io.micrometer.core.instrument.Timer$Sample='io.micrometer.core.instrument.Timer$Sample@687e16d1', class io.micrometer.core.instrument.LongTaskTimer$Sample='SampleImpl{duration(seconds)=1.245858319, duration(nanos)=1.245858319E9, startTimeNanos=91695917264958}']
  92. ----
  93. ====
  94. [[observability-tracing-manual-configuration]]
  95. === Manual Configuration
  96. 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.
  97. ====
  98. .Java
  99. [source,java,role="primary"]
  100. ----
  101. @SpringBootApplication
  102. public class MyApplication {
  103. @Bean
  104. public UserDetailsService userDetailsService() {
  105. return new InMemoryUserDetailsManager(
  106. User.withDefaultPasswordEncoder()
  107. .username("user")
  108. .password("password")
  109. .authorities("app")
  110. .build()
  111. );
  112. }
  113. @Bean
  114. ObservationRegistry<ObservationRegistry> observationRegistry() {
  115. ObservationRegistry registry = ObservationRegistry.create();
  116. registry.observationConfig().observationHandler(new ObservationTextHandler());
  117. return registry;
  118. }
  119. public static void main(String[] args) {
  120. SpringApplication.run(ListenerSamplesApplication.class, args);
  121. }
  122. }
  123. ----
  124. .Kotlin
  125. [source,kotlin,role="secondary"]
  126. ----
  127. @SpringBootApplication
  128. class MyApplication {
  129. @Bean
  130. fun userDetailsService(): UserDetailsService {
  131. InMemoryUserDetailsManager(
  132. User.withDefaultPasswordEncoder()
  133. .username("user")
  134. .password("password")
  135. .authorities("app")
  136. .build()
  137. );
  138. }
  139. @Bean
  140. fun observationRegistry(): ObservationRegistry<ObservationRegistry> {
  141. ObservationRegistry registry = ObservationRegistry.create()
  142. registry.observationConfig().observationHandler(ObservationTextHandler())
  143. return registry
  144. }
  145. fun main(args: Array<String>) {
  146. runApplication<MyApplication>(*args)
  147. }
  148. }
  149. ----
  150. .Xml
  151. [source,kotlin,role="secondary"]
  152. ----
  153. <sec:http auto-config="true" observation-registry-ref="ref">
  154. <sec:intercept-url pattern="/**" access="authenticated"/>
  155. </sec:http>
  156. <!-- define and configure ObservationRegistry bean -->
  157. ----
  158. ====
  159. [[observability-tracing-disable]]
  160. ==== Disabling Observability
  161. If you don't want any Spring Security observations, in a Spring Boot application you can publish a `ObservationRegistry.NOOP` `@Bean`.
  162. However, this may turn off observations for more than just Spring Security.
  163. Instead, you can alter the provided `ObservationRegistry` with an `ObservationPredicate` like the following:
  164. ====
  165. .Java
  166. [source,java,role="primary"]
  167. ----
  168. @Bean
  169. ObservationRegistryCustomizer<ObservationRegistry> noSpringSecurityObservations() {
  170. ObservationPredicate predicate = (name, context) -> name.startsWith("spring.security.")
  171. return (registry) -> registry.observationConfig().observationPredicate(predicate)
  172. }
  173. ----
  174. .Kotlin
  175. [source,kotlin,role="secondary"]
  176. ----
  177. @Bean
  178. fun noSpringSecurityObservations(): ObservationRegistryCustomizer<ObservationRegistry> {
  179. ObservationPredicate predicate = (name: String, context: Observation.Context) -> name.startsWith("spring.security.")
  180. (registry: ObservationRegistry) -> registry.observationConfig().observationPredicate(predicate)
  181. }
  182. ----
  183. ====
  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. [[observability-tracing-listing]]
  188. === Trace Listing
  189. Spring Security tracks the following spans on each request:
  190. 1. `spring.security.http.requests` - a span that wraps the entire filter chain, including the request
  191. 2. `spring.security.http.chains.before` - a span that wraps the receiving part of the security filters
  192. 3. `spring.security.http.chains.after` - a span that wraps the returning part of the security filters
  193. 4. `spring.security.http.secured.requests` - a span that wraps the now-secured application request
  194. 5. `spring.security.http.unsecured.requests` - a span that wraps requests that Spring Security does not secure
  195. 6. `spring.security.authentications` - a span that wraps authentication attempts
  196. 7. `spring.security.authorizations` - a span that wraps authorization attempts
  197. [TIP]
  198. `spring.security.http.chains.before` + `spring.security.http.secured.requests` + `spring.security.http.chains.after` = `spring.security.http.requests`
  199. `spring.security.http.chains.before` + `spring.security.http.chains.after` = Spring Security's part of the request