2026-09-21 14:12:17.031 [Test worker @coroutine#2] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:17.080 [Test worker @coroutine#2] INFO  io.ktor.server.Application - Application started in 0.063 seconds.
2026-09-21 14:12:17.247 [DefaultDispatcher-worker-2 @coroutine#6] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37927
2026-09-21 14:12:17.298 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.299 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:17.300 [Test worker @coroutine#2] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:17.841 [eventLoopGroupProxy-4-1 @call-handler#9] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:17.860 [eventLoopGroupProxy-4-1 @call-handler#9] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.861 [eventLoopGroupProxy-4-1 @call-handler#9] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:17.893 [eventLoopGroupProxy-4-1 @call-handler#9] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:17.916 [Test worker @coroutine#2] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.918 [Test worker @coroutine#2] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.918 [Test worker @coroutine#2] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.921 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.922 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:17.926 [eventLoopGroupProxy-4-1 @call-handler#13] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:17.939 [eventLoopGroupProxy-4-1 @call-handler#13] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:17.945 [Test worker @coroutine#2] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.946 [Test worker @coroutine#2] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.946 [Test worker @coroutine#2] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.948 [Test worker @coroutine#2] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:17.952 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.952 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:17.955 [eventLoopGroupProxy-4-1 @call-handler#16] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:17.960 [eventLoopGroupProxy-4-1 @call-handler#16] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:17.962 [Test worker @coroutine#2] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.962 [Test worker @coroutine#2] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.962 [Test worker @coroutine#2] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.968 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.968 [Test worker @coroutine#2] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:17.971 [eventLoopGroupProxy-4-1 @call-handler#19] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:17.972 [eventLoopGroupProxy-4-1 @call-handler#19] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:17.974 [Test worker @coroutine#2] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.975 [Test worker @coroutine#2] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:17.975 [Test worker @coroutine#2] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37927/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.153 [Test worker @coroutine#23] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:18.154 [Test worker @coroutine#23] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:18.158 [Test worker @coroutine#23] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.158 [Test worker @coroutine#23] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.158 [Test worker @coroutine#23] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.157 [DefaultDispatcher-worker-2 @coroutine#27] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35899
2026-09-21 14:12:18.163 [eventLoopGroupProxy-7-1 @call-handler#30] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> SUCCESS @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:POST)]
2026-09-21 14:12:18.163 [eventLoopGroupProxy-7-1 @call-handler#30] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.163 [eventLoopGroupProxy-7-1 @call-handler#30] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.166 [eventLoopGroupProxy-7-1 @call-handler#30] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.167 [Test worker @coroutine#23] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.168 [Test worker @coroutine#23] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.168 [Test worker @coroutine#23] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.169 [Test worker @coroutine#23] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.169 [Test worker @coroutine#23] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.171 [eventLoopGroupProxy-7-1 @call-handler#34] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:18.173 [eventLoopGroupProxy-7-1 @call-handler#34] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:18.174 [Test worker @coroutine#23] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.175 [Test worker @coroutine#23] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.175 [Test worker @coroutine#23] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.176 [Test worker @coroutine#23] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:35899/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:18.328 [Test worker @coroutine#38] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:18.329 [Test worker @coroutine#38] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:18.330 [DefaultDispatcher-worker-1 @coroutine#42] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37371
2026-09-21 14:12:18.331 [Test worker @coroutine#38] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37371/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile
2026-09-21 14:12:18.331 [Test worker @coroutine#38] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37371/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile.
2026-09-21 14:12:18.335 [eventLoopGroupProxy-10-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:18.336 [eventLoopGroupProxy-10-1 @call-handler#45] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.337 [Test worker @coroutine#38] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37371/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile
2026-09-21 14:12:18.337 [Test worker @coroutine#38] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37371/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile
2026-09-21 14:12:18.337 [Test worker @coroutine#38] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37371/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=non-existent-profile
2026-09-21 14:12:18.491 [Test worker @coroutine#49] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:18.492 [Test worker @coroutine#49] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:18.494 [DefaultDispatcher-worker-1 @coroutine#53] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44561
2026-09-21 14:12:18.517 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.517 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.517 [Test worker @coroutine#49] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.521 [eventLoopGroupProxy-13-1 @call-handler#56] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:18.524 [eventLoopGroupProxy-13-1 @call-handler#56] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.525 [eventLoopGroupProxy-13-1 @call-handler#56] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.526 [eventLoopGroupProxy-13-1 @call-handler#56] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.527 [Test worker @coroutine#49] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.527 [Test worker @coroutine#49] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.527 [Test worker @coroutine#49] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.528 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.528 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.528 [Test worker @coroutine#49] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.530 [eventLoopGroupProxy-13-1 @call-handler#60] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:18.531 [eventLoopGroupProxy-13-1 @call-handler#60] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.531 [eventLoopGroupProxy-13-1 @call-handler#60] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.532 [eventLoopGroupProxy-13-1 @call-handler#60] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.533 [Test worker @coroutine#49] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.533 [Test worker @coroutine#49] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.533 [Test worker @coroutine#49] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.534 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.534 [Test worker @coroutine#49] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.536 [eventLoopGroupProxy-13-1 @call-handler#64] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:18.537 [eventLoopGroupProxy-13-1 @call-handler#64] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:18.539 [Test worker @coroutine#49] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.539 [Test worker @coroutine#49] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.539 [Test worker @coroutine#49] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.540 [Test worker @coroutine#49] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:44561/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:18.694 [Test worker @coroutine#68] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:18.695 [Test worker @coroutine#68] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:18.697 [DefaultDispatcher-worker-3 @coroutine#72] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37943
2026-09-21 14:12:18.697 [Test worker @coroutine#68] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.698 [Test worker @coroutine#68] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.698 [Test worker @coroutine#68] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.701 [eventLoopGroupProxy-16-1 @call-handler#75] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:18.702 [eventLoopGroupProxy-16-1 @call-handler#75] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.702 [eventLoopGroupProxy-16-1 @call-handler#75] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.703 [eventLoopGroupProxy-16-1 @call-handler#75] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.705 [Test worker @coroutine#68] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.706 [Test worker @coroutine#68] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.706 [Test worker @coroutine#68] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.706 [Test worker @coroutine#68] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.706 [Test worker @coroutine#68] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.707 [Test worker @coroutine#68] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.709 [eventLoopGroupProxy-16-1 @call-handler#79] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> SUCCESS @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:POST)]
2026-09-21 14:12:18.710 [eventLoopGroupProxy-16-1 @call-handler#79] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.710 [eventLoopGroupProxy-16-1 @call-handler#79] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.714 [eventLoopGroupProxy-16-1 @call-handler#79] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from String to OutgoingContent for the POST /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the String type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.719 [Test worker @coroutine#68] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.719 [Test worker @coroutine#68] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.719 [Test worker @coroutine#68] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37943/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.872 [Test worker @coroutine#83] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:18.873 [Test worker @coroutine#83] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:18.875 [DefaultDispatcher-worker-1 @coroutine#87] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:42249
2026-09-21 14:12:18.875 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.876 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.876 [Test worker @coroutine#83] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:18.881 [eventLoopGroupProxy-19-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:18.882 [eventLoopGroupProxy-19-1 @call-handler#90] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.882 [eventLoopGroupProxy-19-1 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:18.884 [eventLoopGroupProxy-19-1 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.886 [Test worker @coroutine#83] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.886 [Test worker @coroutine#83] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.886 [Test worker @coroutine#83] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.887 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.887 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.889 [eventLoopGroupProxy-19-1 @call-handler#94] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:18.891 [eventLoopGroupProxy-19-1 @call-handler#94] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:18.892 [Test worker @coroutine#83] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.892 [Test worker @coroutine#83] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.892 [Test worker @coroutine#83] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.893 [Test worker @coroutine#83] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:18.893 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.894 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.895 [eventLoopGroupProxy-19-1 @call-handler#97] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> SUCCESS @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:DELETE)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:DELETE)]
2026-09-21 14:12:18.898 [eventLoopGroupProxy-19-1 @call-handler#97] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the DELETE /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.899 [Test worker @coroutine#83] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.899 [Test worker @coroutine#83] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.899 [Test worker @coroutine#83] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.900 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.900 [Test worker @coroutine#83] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:18.901 [eventLoopGroupProxy-19-1 @call-handler#101] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:18.902 [eventLoopGroupProxy-19-1 @call-handler#101] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:18.903 [Test worker @coroutine#83] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.903 [Test worker @coroutine#83] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:18.903 [Test worker @coroutine#83] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42249/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.058 [Test worker @coroutine#105] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:19.058 [Test worker @coroutine#105] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:19.060 [DefaultDispatcher-worker-2 @coroutine#109] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36947
2026-09-21 14:12:19.061 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.061 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1.
2026-09-21 14:12:19.063 [Test worker @coroutine#105] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1 from class kotlin.ByteArray
2026-09-21 14:12:19.067 [eventLoopGroupProxy-22-1 @call-handler#112] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.068 [eventLoopGroupProxy-22-1 @call-handler#112] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.068 [eventLoopGroupProxy-22-1 @call-handler#112] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.069 [eventLoopGroupProxy-22-1 @call-handler#112] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.071 [Test worker @coroutine#105] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.071 [Test worker @coroutine#105] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.071 [Test worker @coroutine#105] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.072 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.072 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2.
2026-09-21 14:12:19.072 [Test worker @coroutine#105] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2 from class kotlin.ByteArray
2026-09-21 14:12:19.074 [eventLoopGroupProxy-22-1 @call-handler#116] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.074 [eventLoopGroupProxy-22-1 @call-handler#116] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.075 [eventLoopGroupProxy-22-1 @call-handler#116] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.076 [eventLoopGroupProxy-22-1 @call-handler#116] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.077 [Test worker @coroutine#105] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.077 [Test worker @coroutine#105] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.077 [Test worker @coroutine#105] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.079 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z
2026-09-21 14:12:19.080 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z.
2026-09-21 14:12:19.082 [eventLoopGroupProxy-22-1 @call-handler#120] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:19.096 [Test worker @coroutine#105] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z
2026-09-21 14:12:19.097 [Test worker @coroutine#105] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z
2026-09-21 14:12:19.097 [Test worker @coroutine#105] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z
2026-09-21 14:12:19.102 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A00Z.
2026-09-21 14:12:19.103 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z
2026-09-21 14:12:19.103 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z.
2026-09-21 14:12:19.110 [eventLoopGroupProxy-22-1 @call-handler#123] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:19.112 [Test worker @coroutine#105] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z
2026-09-21 14:12:19.113 [Test worker @coroutine#105] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z
2026-09-21 14:12:19.113 [Test worker @coroutine#105] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z
2026-09-21 14:12:19.113 [Test worker @coroutine#105] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36947/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&since=2026-01-01T10%3A00%3A10Z.
2026-09-21 14:12:19.291 [Test worker @coroutine#127] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:19.294 [Test worker @coroutine#127] INFO  io.ktor.server.Application - Application started in 0.003 seconds.
2026-09-21 14:12:19.297 [DefaultDispatcher-worker-1 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38255
2026-09-21 14:12:19.300 [Test worker @coroutine#127] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.300 [Test worker @coroutine#127] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:19.300 [Test worker @coroutine#127] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:19.304 [eventLoopGroupProxy-25-1 @call-handler#134] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.306 [eventLoopGroupProxy-25-1 @call-handler#134] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.307 [eventLoopGroupProxy-25-1 @call-handler#134] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.316 [eventLoopGroupProxy-25-1 @call-handler#134] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.319 [Test worker @coroutine#127] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.319 [Test worker @coroutine#127] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.319 [Test worker @coroutine#127] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.319 [Test worker @coroutine#127] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.319 [Test worker @coroutine#127] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:19.322 [eventLoopGroupProxy-25-1 @call-handler#138] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:19.325 [eventLoopGroupProxy-25-1 @call-handler#138] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:19.329 [Test worker @coroutine#127] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.330 [Test worker @coroutine#127] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.330 [Test worker @coroutine#127] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.331 [Test worker @coroutine#127] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:38255/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:19.497 [Test worker @coroutine#142] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:19.499 [Test worker @coroutine#142] INFO  io.ktor.server.Application - Application started in 0.002 seconds.
2026-09-21 14:12:19.501 [DefaultDispatcher-worker-3 @coroutine#146] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45643
2026-09-21 14:12:19.503 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.503 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:19.503 [Test worker @coroutine#142] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:19.514 [eventLoopGroupProxy-28-1 @call-handler#149] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.515 [eventLoopGroupProxy-28-1 @call-handler#149] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.515 [eventLoopGroupProxy-28-1 @call-handler#149] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.516 [eventLoopGroupProxy-28-1 @call-handler#149] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.519 [Test worker @coroutine#142] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.520 [Test worker @coroutine#142] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.520 [Test worker @coroutine#142] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.521 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.521 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:19.521 [Test worker @coroutine#142] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 from class kotlin.ByteArray
2026-09-21 14:12:19.526 [eventLoopGroupProxy-28-1 @call-handler#153] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> SUCCESS @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:POST)]
2026-09-21 14:12:19.527 [eventLoopGroupProxy-28-1 @call-handler#153] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.527 [eventLoopGroupProxy-28-1 @call-handler#153] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.529 [eventLoopGroupProxy-28-1 @call-handler#153] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.531 [Test worker @coroutine#142] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.531 [Test worker @coroutine#142] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.531 [Test worker @coroutine#142] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.532 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.532 [Test worker @coroutine#142] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1.
2026-09-21 14:12:19.535 [eventLoopGroupProxy-28-1 @call-handler#157] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:19.539 [eventLoopGroupProxy-28-1 @call-handler#157] TRACE i.k.s.p.c.ContentNegotiation - Skipping because body is already converted.
2026-09-21 14:12:19.541 [Test worker @coroutine#142] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.541 [Test worker @coroutine#142] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.541 [Test worker @coroutine#142] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1
2026-09-21 14:12:19.542 [Test worker @coroutine#142] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers response body for http://localhost:45643/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=profile-1 to class kotlin.ByteArray
2026-09-21 14:12:19.710 [Test worker @coroutine#161] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:19.711 [Test worker @coroutine#161] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:19.715 [DefaultDispatcher-worker-5 @coroutine#165] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46715
2026-09-21 14:12:19.716 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.717 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1.
2026-09-21 14:12:19.717 [Test worker @coroutine#161] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1 from class kotlin.ByteArray
2026-09-21 14:12:19.727 [eventLoopGroupProxy-31-1 @call-handler#168] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.728 [eventLoopGroupProxy-31-1 @call-handler#168] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.728 [eventLoopGroupProxy-31-1 @call-handler#168] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.729 [eventLoopGroupProxy-31-1 @call-handler#168] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.732 [Test worker @coroutine#161] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.732 [Test worker @coroutine#161] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.732 [Test worker @coroutine#161] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p1
2026-09-21 14:12:19.733 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.733 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2.
2026-09-21 14:12:19.733 [Test worker @coroutine#161] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2 from class kotlin.ByteArray
2026-09-21 14:12:19.735 [eventLoopGroupProxy-31-1 @call-handler#172] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.736 [eventLoopGroupProxy-31-1 @call-handler#172] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.736 [eventLoopGroupProxy-31-1 @call-handler#172] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.737 [eventLoopGroupProxy-31-1 @call-handler#172] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.738 [Test worker @coroutine#161] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.738 [Test worker @coroutine#161] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.738 [Test worker @coroutine#161] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1&profileId=p2
2026-09-21 14:12:19.740 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1
2026-09-21 14:12:19.740 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1.
2026-09-21 14:12:19.740 [Test worker @coroutine#161] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1 from class kotlin.ByteArray
2026-09-21 14:12:19.742 [eventLoopGroupProxy-31-1 @call-handler#176] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.743 [eventLoopGroupProxy-31-1 @call-handler#176] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1
2026-09-21 14:12:19.743 [eventLoopGroupProxy-31-1 @call-handler#176] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.744 [eventLoopGroupProxy-31-1 @call-handler#176] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.746 [Test worker @coroutine#161] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1
2026-09-21 14:12:19.746 [Test worker @coroutine#161] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1
2026-09-21 14:12:19.746 [Test worker @coroutine#161] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p1
2026-09-21 14:12:19.747 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2
2026-09-21 14:12:19.747 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Body type class kotlin.ByteArray is in ignored types. Skipping ContentNegotiation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2.
2026-09-21 14:12:19.747 [Test worker @coroutine#161] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2 from class kotlin.ByteArray
2026-09-21 14:12:19.750 [eventLoopGroupProxy-31-1 @call-handler#180] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> SUCCESS @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:PUT)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:PUT)]
2026-09-21 14:12:19.750 [eventLoopGroupProxy-31-1 @call-handler#180] TRACE i.k.server.engine.DefaultTransform - Transformed class io.ktor.utils.io.ByteChannel to class kotlin.ByteArray for /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2
2026-09-21 14:12:19.750 [eventLoopGroupProxy-31-1 @call-handler#180] TRACE i.k.s.p.c.ContentNegotiation - Skipping for request type class kotlin.ByteArray because the type is ignored.
2026-09-21 14:12:19.751 [eventLoopGroupProxy-31-1 @call-handler#180] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the PUT /activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2 request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:19.753 [Test worker @coroutine#161] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2
2026-09-21 14:12:19.753 [Test worker @coroutine#161] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2
2026-09-21 14:12:19.753 [Test worker @coroutine#161] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-2&profileId=p2
2026-09-21 14:12:19.754 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1
2026-09-21 14:12:19.754 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1.
2026-09-21 14:12:19.757 [eventLoopGroupProxy-31-1 @call-handler#184] TRACE io.ktor.server.routing.Routing - Trace for [activities, profile]
/, segment:0 -> SUCCESS @ /
  /activities, segment:1 -> SUCCESS @ /activities
    /activities/profile, segment:2 -> SUCCESS @ /activities/profile
      /activities/profile [(method:GET)], segment:2 -> SUCCESS @ /activities/profile [(method:GET)]
      /activities/profile [(method:POST)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:POST)]
      /activities/profile [(method:PUT)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:PUT)]
      /activities/profile [(method:DELETE)], segment:2 -> FAILURE "Selector didn't match" @ /activities/profile [(method:DELETE)]
Matched routes:
  "" -> "activities" -> "profile" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /activities/profile [(method:GET)]
2026-09-21 14:12:19.760 [Test worker @coroutine#161] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1
2026-09-21 14:12:19.760 [Test worker @coroutine#161] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1
2026-09-21 14:12:19.760 [Test worker @coroutine#161] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1
2026-09-21 14:12:19.761 [Test worker @coroutine#161] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46715/activities/profile?activityId=http%3A%2F%2Fexample.com%2Factivities%2Fcourse-1.
2026-09-21 14:12:19.965 [Test worker @coroutine#189] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:19.967 [Test worker @coroutine#189] INFO  io.ktor.server.Application - Application started in 0.002 seconds.
2026-09-21 14:12:19.968 [DefaultDispatcher-worker-5 @coroutine#193] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45515
2026-09-21 14:12:19.977 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements
2026-09-21 14:12:19.986 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@32a4ecbe for http://localhost:45515/statements
2026-09-21 14:12:19.986 [Test worker @coroutine#189] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45515/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:19.990 [eventLoopGroupProxy-34-1 @call-handler#196] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:19.993 [eventLoopGroupProxy-34-1 @call-handler#196] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.048 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements
2026-09-21 14:12:20.049 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements
2026-09-21 14:12:20.049 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements
2026-09-21 14:12:20.049 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45515/statements.
2026-09-21 14:12:20.053 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.053 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.055 [eventLoopGroupProxy-34-1 @call-handler#201] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.071 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.072 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.072 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.074 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.091 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements
2026-09-21 14:12:20.092 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@32a4ecbe for http://localhost:45515/statements
2026-09-21 14:12:20.092 [Test worker @coroutine#189] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45515/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:20.094 [eventLoopGroupProxy-34-1 @call-handler#204] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:20.095 [eventLoopGroupProxy-34-1 @call-handler#204] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.100 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements
2026-09-21 14:12:20.101 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements
2026-09-21 14:12:20.101 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements
2026-09-21 14:12:20.101 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45515/statements.
2026-09-21 14:12:20.102 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.102 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.103 [eventLoopGroupProxy-34-1 @call-handler#209] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.107 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.107 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.107 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.108 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.108 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.108 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.109 [eventLoopGroupProxy-34-1 @call-handler#212] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.112 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.112 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.112 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.113 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.113 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.113 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.115 [eventLoopGroupProxy-34-1 @call-handler#215] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.117 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.117 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.117 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.118 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?statementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.118 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.118 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.120 [eventLoopGroupProxy-34-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.125 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.125 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.125 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.127 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.128 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.128 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.129 [eventLoopGroupProxy-34-1 @call-handler#221] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.139 [Test worker @coroutine#189] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.139 [Test worker @coroutine#189] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.139 [Test worker @coroutine#189] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.141 [Test worker @coroutine#189] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45515/statements?voidedStatementId=ba685068-e967-4c35-8bc4-79d452739ac1&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.289 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:20.289 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:20.291 [DefaultDispatcher-worker-2 @coroutine#229] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:33431
2026-09-21 14:12:20.292 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33431/statements
2026-09-21 14:12:20.293 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:33431/statements
2026-09-21 14:12:20.293 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:33431/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:20.297 [eventLoopGroupProxy-37-1 @call-handler#232] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:20.297 [eventLoopGroupProxy-37-1 @call-handler#232] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.305 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33431/statements
2026-09-21 14:12:20.305 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33431/statements
2026-09-21 14:12:20.305 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33431/statements
2026-09-21 14:12:20.306 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33431/statements.
2026-09-21 14:12:20.306 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.306 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.308 [eventLoopGroupProxy-37-1 @call-handler#237] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.313 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.314 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.314 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.316 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.316 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.317 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.318 [eventLoopGroupProxy-37-1 @call-handler#240] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.329 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.336 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.337 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.342 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.343 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.344 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.346 [eventLoopGroupProxy-37-1 @call-handler#243] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.350 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.351 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.351 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.352 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:33431/statements?statementId=cdeb73b2-f957-4ce5-b629-5cddd2ec8847&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.504 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:20.504 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:20.505 [DefaultDispatcher-worker-2 @coroutine#249] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46541
2026-09-21 14:12:20.506 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46541/statements
2026-09-21 14:12:20.507 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:46541/statements
2026-09-21 14:12:20.507 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46541/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:20.510 [eventLoopGroupProxy-40-1 @call-handler#252] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:20.510 [eventLoopGroupProxy-40-1 @call-handler#252] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.515 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46541/statements
2026-09-21 14:12:20.515 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46541/statements
2026-09-21 14:12:20.515 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46541/statements
2026-09-21 14:12:20.516 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46541/statements.
2026-09-21 14:12:20.516 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.516 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.518 [eventLoopGroupProxy-40-1 @call-handler#257] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.521 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.522 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.522 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.523 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.523 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.523 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.525 [eventLoopGroupProxy-40-1 @call-handler#260] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.528 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.528 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.528 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.529 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.530 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.530 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.536 [eventLoopGroupProxy-40-1 @call-handler#263] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.544 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.545 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.545 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.546 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:46541/statements?statementId=f35590ad-0063-4f09-8a5b-1033ec5dd32b&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.692 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:20.692 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:20.693 [DefaultDispatcher-worker-3 @coroutine#269] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40207
2026-09-21 14:12:20.694 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/statements
2026-09-21 14:12:20.694 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:40207/statements
2026-09-21 14:12:20.694 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:40207/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:20.697 [eventLoopGroupProxy-43-1 @call-handler#272] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:20.698 [eventLoopGroupProxy-43-1 @call-handler#272] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.702 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/statements
2026-09-21 14:12:20.703 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/statements
2026-09-21 14:12:20.703 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/statements
2026-09-21 14:12:20.704 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40207/statements.
2026-09-21 14:12:20.704 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.704 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.706 [eventLoopGroupProxy-43-1 @call-handler#277] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.710 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.711 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.711 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.712 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.712 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.712 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.714 [eventLoopGroupProxy-43-1 @call-handler#280] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.718 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.718 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.718 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.720 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.721 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.721 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.723 [eventLoopGroupProxy-43-1 @call-handler#283] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.726 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.726 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.726 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.727 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40207/statements?statementId=d6d5f890-2d24-4a9f-993e-dd147de3d99a&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.882 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:20.882 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:20.884 [DefaultDispatcher-worker-4 @coroutine#289] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44513
2026-09-21 14:12:20.886 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44513/statements
2026-09-21 14:12:20.887 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:44513/statements
2026-09-21 14:12:20.887 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:44513/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:20.890 [eventLoopGroupProxy-46-1 @call-handler#292] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:20.890 [eventLoopGroupProxy-46-1 @call-handler#292] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:20.899 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44513/statements
2026-09-21 14:12:20.899 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44513/statements
2026-09-21 14:12:20.899 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44513/statements
2026-09-21 14:12:20.899 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44513/statements.
2026-09-21 14:12:20.900 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.900 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.901 [eventLoopGroupProxy-46-1 @call-handler#297] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.907 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.907 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.907 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:20.908 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:20.909 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.909 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.910 [eventLoopGroupProxy-46-1 @call-handler#300] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.913 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.914 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.914 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:20.915 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:20.916 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.916 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:20.918 [eventLoopGroupProxy-46-1 @call-handler#303] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:20.922 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.922 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.922 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:20.923 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:44513/statements?statementId=c261398e-a94e-4020-9e8a-797b9a86e213&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.087 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:21.088 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:21.089 [DefaultDispatcher-worker-2 @coroutine#309] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40437
2026-09-21 14:12:21.090 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/statements
2026-09-21 14:12:21.090 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:40437/statements
2026-09-21 14:12:21.090 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:40437/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:21.093 [eventLoopGroupProxy-49-1 @call-handler#312] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:21.093 [eventLoopGroupProxy-49-1 @call-handler#312] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:21.098 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/statements
2026-09-21 14:12:21.099 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/statements
2026-09-21 14:12:21.099 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/statements
2026-09-21 14:12:21.099 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40437/statements.
2026-09-21 14:12:21.099 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.099 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.101 [eventLoopGroupProxy-49-1 @call-handler#317] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.104 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.104 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.105 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.105 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.106 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.106 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.107 [eventLoopGroupProxy-49-1 @call-handler#320] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.110 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.111 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.111 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.112 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.112 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.112 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.113 [eventLoopGroupProxy-49-1 @call-handler#323] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.115 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.116 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.116 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.116 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:40437/statements?statementId=7d7f1103-cb7f-43c9-be14-8d7c757c5333&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.262 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:21.262 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:21.264 [DefaultDispatcher-worker-2 @coroutine#329] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36331
2026-09-21 14:12:21.264 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36331/statements
2026-09-21 14:12:21.265 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:36331/statements
2026-09-21 14:12:21.265 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36331/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:21.267 [eventLoopGroupProxy-52-1 @call-handler#332] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:21.268 [eventLoopGroupProxy-52-1 @call-handler#332] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:21.272 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36331/statements
2026-09-21 14:12:21.272 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36331/statements
2026-09-21 14:12:21.272 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36331/statements
2026-09-21 14:12:21.273 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36331/statements.
2026-09-21 14:12:21.273 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.273 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.274 [eventLoopGroupProxy-52-1 @call-handler#337] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.278 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.278 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.278 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.279 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.280 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.280 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.282 [eventLoopGroupProxy-52-1 @call-handler#340] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.285 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.286 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.286 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.287 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.287 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.287 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.289 [eventLoopGroupProxy-52-1 @call-handler#343] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.291 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.292 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.292 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.295 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36331/statements?statementId=9c722ab0-933f-4366-ad92-400356041af0&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.462 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:21.462 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:21.463 [DefaultDispatcher-worker-4 @coroutine#349] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38487
2026-09-21 14:12:21.464 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38487/statements
2026-09-21 14:12:21.464 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:38487/statements
2026-09-21 14:12:21.464 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:38487/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:21.467 [eventLoopGroupProxy-55-1 @call-handler#352] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:21.467 [eventLoopGroupProxy-55-1 @call-handler#352] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:21.471 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38487/statements
2026-09-21 14:12:21.471 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38487/statements
2026-09-21 14:12:21.471 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38487/statements
2026-09-21 14:12:21.472 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38487/statements.
2026-09-21 14:12:21.472 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.472 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.475 [eventLoopGroupProxy-55-1 @call-handler#357] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.479 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.480 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.480 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.481 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.481 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.481 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.483 [eventLoopGroupProxy-55-1 @call-handler#360] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.486 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.486 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.486 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.487 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.487 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.487 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.499 [eventLoopGroupProxy-55-1 @call-handler#363] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.512 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.512 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.512 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.513 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:38487/statements?statementId=e54474b6-a77e-4bf4-b2a6-0373a4b9825d&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.676 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:21.677 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:21.678 [DefaultDispatcher-worker-2 @coroutine#369] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41181
2026-09-21 14:12:21.678 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41181/statements
2026-09-21 14:12:21.678 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:41181/statements
2026-09-21 14:12:21.678 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:41181/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:21.681 [eventLoopGroupProxy-58-1 @call-handler#372] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:21.681 [eventLoopGroupProxy-58-1 @call-handler#372] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:21.685 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41181/statements
2026-09-21 14:12:21.686 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41181/statements
2026-09-21 14:12:21.686 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41181/statements
2026-09-21 14:12:21.686 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41181/statements.
2026-09-21 14:12:21.686 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.686 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.688 [eventLoopGroupProxy-58-1 @call-handler#377] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.693 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.693 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.693 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.694 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.694 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.694 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.696 [eventLoopGroupProxy-58-1 @call-handler#380] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.700 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.700 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.700 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.701 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.701 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.701 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.703 [eventLoopGroupProxy-58-1 @call-handler#383] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.707 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.707 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.707 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.708 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:41181/statements?statementId=2afbd5b4-4b33-4f50-b1c7-332d2c9004fc&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.851 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:21.852 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:21.853 [DefaultDispatcher-worker-4 @coroutine#389] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43897
2026-09-21 14:12:21.853 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43897/statements
2026-09-21 14:12:21.854 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:43897/statements
2026-09-21 14:12:21.854 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43897/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:21.856 [eventLoopGroupProxy-61-1 @call-handler#392] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:21.856 [eventLoopGroupProxy-61-1 @call-handler#392] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:21.861 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43897/statements
2026-09-21 14:12:21.861 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43897/statements
2026-09-21 14:12:21.861 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43897/statements
2026-09-21 14:12:21.862 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43897/statements.
2026-09-21 14:12:21.862 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.862 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.864 [eventLoopGroupProxy-61-1 @call-handler#397] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.868 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.868 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.868 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:21.869 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:21.869 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.869 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.871 [eventLoopGroupProxy-61-1 @call-handler#400] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.874 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.874 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.874 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:21.874 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:21.875 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.875 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:21.876 [eventLoopGroupProxy-61-1 @call-handler#403] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:21.879 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.879 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.879 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:21.880 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43897/statements?statementId=dd768b14-ac9b-4536-9272-abb8db667279&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.026 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.026 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:22.028 [DefaultDispatcher-worker-5 @coroutine#409] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43123
2026-09-21 14:12:22.029 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43123/statements
2026-09-21 14:12:22.029 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:43123/statements
2026-09-21 14:12:22.029 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43123/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.032 [eventLoopGroupProxy-64-1 @call-handler#412] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.038 [eventLoopGroupProxy-64-1 @call-handler#412] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.044 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43123/statements
2026-09-21 14:12:22.044 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43123/statements
2026-09-21 14:12:22.044 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43123/statements
2026-09-21 14:12:22.044 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43123/statements.
2026-09-21 14:12:22.045 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.045 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.052 [eventLoopGroupProxy-64-1 @call-handler#417] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.058 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.058 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.058 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.059 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.060 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.060 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.061 [eventLoopGroupProxy-64-1 @call-handler#420] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.067 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.068 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.068 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.069 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.069 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.069 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.071 [eventLoopGroupProxy-64-1 @call-handler#423] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.074 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.074 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.074 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.076 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:43123/statements?statementId=2f94d469-a8ed-4cef-a59e-0ec80bc08de3&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.232 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.233 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:22.234 [DefaultDispatcher-worker-5 @coroutine#429] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36701
2026-09-21 14:12:22.234 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36701/statements
2026-09-21 14:12:22.234 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:36701/statements
2026-09-21 14:12:22.235 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36701/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.243 [eventLoopGroupProxy-67-1 @call-handler#432] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.246 [eventLoopGroupProxy-67-1 @call-handler#432] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.253 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36701/statements
2026-09-21 14:12:22.254 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36701/statements
2026-09-21 14:12:22.254 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36701/statements
2026-09-21 14:12:22.254 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36701/statements.
2026-09-21 14:12:22.259 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.259 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.262 [eventLoopGroupProxy-67-1 @call-handler#437] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.269 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.269 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.269 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.270 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.270 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.270 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.272 [eventLoopGroupProxy-67-1 @call-handler#440] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.274 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.274 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.274 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.275 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.275 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.275 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.277 [eventLoopGroupProxy-67-1 @call-handler#443] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.279 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.279 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.279 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.280 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:36701/statements?statementId=1326764b-3ae8-41a1-b69e-4bbadc8f7a1f&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.435 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.436 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:22.437 [DefaultDispatcher-worker-5 @coroutine#449] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37179
2026-09-21 14:12:22.437 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37179/statements
2026-09-21 14:12:22.438 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:37179/statements
2026-09-21 14:12:22.440 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:37179/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.444 [eventLoopGroupProxy-70-1 @call-handler#452] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.445 [eventLoopGroupProxy-70-1 @call-handler#452] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.450 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37179/statements
2026-09-21 14:12:22.450 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37179/statements
2026-09-21 14:12:22.450 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37179/statements
2026-09-21 14:12:22.450 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37179/statements.
2026-09-21 14:12:22.451 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.451 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.452 [eventLoopGroupProxy-70-1 @call-handler#457] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.455 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.455 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.455 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.457 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.458 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.458 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.460 [eventLoopGroupProxy-70-1 @call-handler#460] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.463 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.463 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.463 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.464 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.464 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.464 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.465 [eventLoopGroupProxy-70-1 @call-handler#463] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.474 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.474 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.474 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.475 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:37179/statements?statementId=648dd7d8-fdf9-4c20-b509-0e5183c968d9&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.621 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.622 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:22.624 [DefaultDispatcher-worker-6 @coroutine#469] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45551
2026-09-21 14:12:22.624 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45551/statements
2026-09-21 14:12:22.625 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:45551/statements
2026-09-21 14:12:22.625 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45551/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.627 [eventLoopGroupProxy-73-1 @call-handler#472] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.628 [eventLoopGroupProxy-73-1 @call-handler#472] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.633 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45551/statements
2026-09-21 14:12:22.633 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45551/statements
2026-09-21 14:12:22.633 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45551/statements
2026-09-21 14:12:22.633 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45551/statements.
2026-09-21 14:12:22.634 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.634 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.635 [eventLoopGroupProxy-73-1 @call-handler#477] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.640 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.640 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.640 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.640 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.641 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.641 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.643 [eventLoopGroupProxy-73-1 @call-handler#480] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.646 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.646 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.646 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.647 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.647 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.647 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.648 [eventLoopGroupProxy-73-1 @call-handler#483] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.655 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.656 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.656 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.657 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45551/statements?statementId=c19aa987-9136-4d55-af67-4ee8608c5405&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.810 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.810 [Test worker @coroutine#225] INFO  io.ktor.server.Application - Application started in 0.0 seconds.
2026-09-21 14:12:22.812 [DefaultDispatcher-worker-4 @coroutine#489] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45665
2026-09-21 14:12:22.812 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45665/statements
2026-09-21 14:12:22.812 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@31acfd4e for http://localhost:45665/statements
2026-09-21 14:12:22.813 [Test worker @coroutine#225] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45665/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.815 [eventLoopGroupProxy-76-1 @call-handler#492] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.815 [eventLoopGroupProxy-76-1 @call-handler#492] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.819 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45665/statements
2026-09-21 14:12:22.819 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45665/statements
2026-09-21 14:12:22.819 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45665/statements
2026-09-21 14:12:22.820 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45665/statements.
2026-09-21 14:12:22.820 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.820 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.821 [eventLoopGroupProxy-76-1 @call-handler#497] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.824 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.824 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.824 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false
2026-09-21 14:12:22.825 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=canonical&attachments=false&ascending=false.
2026-09-21 14:12:22.825 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.825 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.827 [eventLoopGroupProxy-76-1 @call-handler#500] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.830 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.831 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.831 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false
2026-09-21 14:12:22.832 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=exact&attachments=false&ascending=false.
2026-09-21 14:12:22.832 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.832 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.833 [eventLoopGroupProxy-76-1 @call-handler#503] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> SUCCESS @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /statements [(method:GET)]
2026-09-21 14:12:22.836 [Test worker @coroutine#225] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.836 [Test worker @coroutine#225] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.836 [Test worker @coroutine#225] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false
2026-09-21 14:12:22.837 [Test worker @coroutine#225] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.xapi.model.XapiStatementResult for http://localhost:45665/statements?statementId=8c078f41-0df3-4266-9c96-9ee62ed68ff4&related_activities=false&related_agents=false&format=ids&attachments=false&ascending=false.
2026-09-21 14:12:22.983 [Test worker @coroutine#507] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-09-21 14:12:22.984 [Test worker @coroutine#507] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-09-21 14:12:22.985 [DefaultDispatcher-worker-6 @coroutine#511] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43509
2026-09-21 14:12:22.988 [Test worker @coroutine#507] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43509/statements
2026-09-21 14:12:22.988 [Test worker @coroutine#507] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@19ae2ee5 for http://localhost:43509/statements
2026-09-21 14:12:22.988 [Test worker @coroutine#507] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43509/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:22.991 [eventLoopGroupProxy-79-1 @call-handler#514] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:22.991 [eventLoopGroupProxy-79-1 @call-handler#514] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:22.997 [Test worker @coroutine#507] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43509/statements
2026-09-21 14:12:22.997 [Test worker @coroutine#507] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43509/statements
2026-09-21 14:12:22.997 [Test worker @coroutine#507] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43509/statements
2026-09-21 14:12:22.997 [Test worker @coroutine#507] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:43509/statements.
2026-09-21 14:12:22.997 [Test worker @coroutine#507] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43509/statements
2026-09-21 14:12:22.998 [Test worker @coroutine#507] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@19ae2ee5 for http://localhost:43509/statements
2026-09-21 14:12:22.998 [Test worker @coroutine#507] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43509/statements from class io.ktor.http.content.TextContent
2026-09-21 14:12:23.000 [eventLoopGroupProxy-79-1 @call-handler#519] TRACE io.ktor.server.routing.Routing - Trace for [statements]
/, segment:0 -> SUCCESS @ /
  /statements, segment:1 -> SUCCESS @ /statements
    /statements [(method:GET)], segment:1 -> FAILURE "Selector didn't match" @ /statements [(method:GET)]
    /statements [(method:POST)], segment:1 -> SUCCESS @ /statements [(method:POST)]
Matched routes:
  "" -> "statements" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /statements [(method:POST)]
2026-09-21 14:12:23.000 [eventLoopGroupProxy-79-1 @call-handler#519] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlinx.serialization.json.JsonElement) for call /statements
2026-09-21 14:12:23.002 [eventLoopGroupProxy-79-1 @call-handler#519] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /statements request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-09-21 14:12:23.003 [Test worker @coroutine#507] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43509/statements
2026-09-21 14:12:23.003 [Test worker @coroutine#507] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43509/statements
2026-09-21 14:12:23.003 [Test worker @coroutine#507] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43509/statements