2026-05-07 10:21:02.936 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:03.049 [Test worker] INFO  io.ktor.server.Application - Application started in 0.323 seconds.
2026-05-07 10:21:03.135 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38533
2026-05-07 10:21:04.307 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38533/resources/index.json
2026-05-07 10:21:04.308 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38533/resources/index.json.
2026-05-07 10:21:04.309 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38533/resources/index.json
2026-05-07 10:21:04.525 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 10:21:04.593 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38533/resources/index.json
2026-05-07 10:21:04.594 [eventLoopGroupProxy-4-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 74ms
2026-05-07 10:21:04.595 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38533/resources/index.json
2026-05-07 10:21:04.596 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38533/resources/index.json
2026-05-07 10:21:04.624 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:38533/resources/index.json.
2026-05-07 10:21:04.670 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38533/resources/index.json
2026-05-07 10:21:04.670 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38533/resources/index.json.
2026-05-07 10:21:04.670 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38533/resources/index.json
2026-05-07 10:21:04.676 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 10:21:04.678 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms
2026-05-07 10:21:04.681 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38533/resources/index.json
2026-05-07 10:21:04.681 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38533/resources/index.json
2026-05-07 10:21:04.681 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38533/resources/index.json
2026-05-07 10:21:06.705 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:06.706 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-07 10:21:06.708 [DefaultDispatcher-worker-1 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40467
2026-05-07 10:21:06.762 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40467/resources/index.json
2026-05-07 10:21:06.762 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40467/resources/index.json.
2026-05-07 10:21:06.762 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40467/resources/index.json
2026-05-07 10:21:06.766 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 10:21:06.768 [eventLoopGroupProxy-7-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2026-05-07 10:21:06.769 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40467/resources/index.json
2026-05-07 10:21:06.770 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40467/resources/index.json
2026-05-07 10:21:06.770 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40467/resources/index.json
2026-05-07 10:21:06.772 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:40467/resources/index.json.
2026-05-07 10:21:06.780 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40467/resources/index.json
2026-05-07 10:21:06.780 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40467/resources/index.json.
2026-05-07 10:21:06.780 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40467/resources/index.json
2026-05-07 10:21:06.782 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 10:21:06.782 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms
2026-05-07 10:21:06.783 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40467/resources/index.json
2026-05-07 10:21:06.783 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40467/resources/index.json
2026-05-07 10:21:06.783 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40467/resources/index.json
2026-05-07 10:21:08.792 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:08.793 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-07 10:21:08.794 [DefaultDispatcher-worker-3 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44715
2026-05-07 10:21:08.800 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44715/resources/lesson001.json
2026-05-07 10:21:08.800 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44715/resources/lesson001.json.
2026-05-07 10:21:08.800 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44715/resources/lesson001.json
2026-05-07 10:21:08.803 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 10:21:08.804 [DefaultDispatcher-worker-6 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms
2026-05-07 10:21:08.805 [DefaultDispatcher-worker-5 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44715/resources/lesson001.json
2026-05-07 10:21:08.805 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44715/resources/lesson001.json
2026-05-07 10:21:08.805 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44715/resources/lesson001.json
2026-05-07 10:21:08.807 [DefaultDispatcher-worker-6 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:44715/resources/lesson001.json.
2026-05-07 10:21:11.412 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:11.443 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.283 seconds.
2026-05-07 10:21:11.453 [DefaultDispatcher-worker-3 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:36771
2026-05-07 10:21:11.498 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36771/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:11.500 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36771/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:11.501 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36771/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:11.519 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 10:21:11.560 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36771/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:11.560 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36771/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:11.560 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36771/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:11.562 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36771/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:11.695 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.696 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36771/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:11.696 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.698 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:11.724 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.724 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.724 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.726 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36771/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:11.737 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.738 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36771/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:11.738 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.740 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:11.745 [DefaultDispatcher-worker-2 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 10:21:11.746 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.746 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:11.746 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36771/api/school/respect/person?includeRelated=false
2026-05-07 10:21:13.907 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:13.908 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2026-05-07 10:21:13.909 [DefaultDispatcher-worker-1 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:38129
2026-05-07 10:21:13.910 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38129/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:13.910 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38129/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:13.910 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38129/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:13.914 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 10:21:13.917 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38129/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:13.917 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38129/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:13.917 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38129/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:13.917 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38129/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:13.971 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 10:21:13.971 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-07 10:21:13.971 [DefaultDispatcher-worker-2 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 10:21:13.973 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:13.976 [DefaultDispatcher-worker-3 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 10:21:13.976 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 10:21:13.976 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 10:21:13.977 [DefaultDispatcher-worker-3 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38129/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-07 10:21:16.126 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:16.126 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.055 seconds.
2026-05-07 10:21:16.127 [DefaultDispatcher-worker-3 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34879
2026-05-07 10:21:16.130 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34879/api/school/respect/person?includeRelated=false
2026-05-07 10:21:16.130 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34879/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:16.131 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34879/api/school/respect/person?includeRelated=false
2026-05-07 10:21:16.134 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:16.141 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34879/api/school/respect/person?includeRelated=false
2026-05-07 10:21:16.141 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34879/api/school/respect/person?includeRelated=false
2026-05-07 10:21:16.141 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34879/api/school/respect/person?includeRelated=false
2026-05-07 10:21:16.146 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34879/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:16.242 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false
2026-05-07 10:21:16.243 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false.
2026-05-07 10:21:16.243 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false
2026-05-07 10:21:16.248 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:16.255 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false
2026-05-07 10:21:16.256 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false
2026-05-07 10:21:16.256 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false
2026-05-07 10:21:16.257 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34879/api/school/respect/person?since=2026-05-07T06%3A21%3A16.134790866Z&includeRelated=false.
2026-05-07 10:21:18.453 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:18.459 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.056 seconds.
2026-05-07 10:21:18.469 [DefaultDispatcher-worker-3 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46797
2026-05-07 10:21:18.531 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46797/api/school/respect/person
2026-05-07 10:21:18.531 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5cc9cde1 for http://localhost:46797/api/school/respect/person
2026-05-07 10:21:18.531 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46797/api/school/respect/person
2026-05-07 10:21:18.531 [DefaultDispatcher-worker-2 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:46797/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-07 10:21:18.550 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-07 10:21:18.584 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2026-05-07 10:21:18.587 [DefaultDispatcher-worker-7 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 10:21:18.600 [DefaultDispatcher-worker-7 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46797/api/school/respect/person
2026-05-07 10:21:18.601 [DefaultDispatcher-worker-7 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46797/api/school/respect/person
2026-05-07 10:21:18.601 [DefaultDispatcher-worker-7 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46797/api/school/respect/person
2026-05-07 10:21:20.795 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:20.802 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.062 seconds.
2026-05-07 10:21:20.806 [DefaultDispatcher-worker-2 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:44079
2026-05-07 10:21:20.807 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44079/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:20.808 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44079/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:20.808 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44079/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:20.811 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 10:21:20.813 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44079/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:20.813 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44079/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:20.813 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44079/api/school/respect/schoolpermissiongrant
2026-05-07 10:21:20.814 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44079/api/school/respect/schoolpermissiongrant.
2026-05-07 10:21:20.880 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:20.880 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44079/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:20.880 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:20.882 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:20.888 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:20.888 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:20.888 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:20.889 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44079/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:22.894 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:22.894 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44079/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:22.894 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:22.896 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:22.902 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:22.902 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:22.902 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44079/api/school/respect/person?includeRelated=false
2026-05-07 10:21:22.903 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44079/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:25.069 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:25.070 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.053 seconds.
2026-05-07 10:21:25.072 [DefaultDispatcher-worker-14 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41881
2026-05-07 10:21:25.075 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41881/api/school/respect/person?includeRelated=false
2026-05-07 10:21:25.075 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41881/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:25.075 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41881/api/school/respect/person?includeRelated=false
2026-05-07 10:21:25.078 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:25.083 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41881/api/school/respect/person?includeRelated=false
2026-05-07 10:21:25.084 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41881/api/school/respect/person?includeRelated=false
2026-05-07 10:21:25.084 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41881/api/school/respect/person?includeRelated=false
2026-05-07 10:21:25.085 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41881/api/school/respect/person?includeRelated=false.
2026-05-07 10:21:25.162 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false
2026-05-07 10:21:25.162 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false.
2026-05-07 10:21:25.162 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false
2026-05-07 10:21:25.166 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 10:21:25.172 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false
2026-05-07 10:21:25.172 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false
2026-05-07 10:21:25.172 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false
2026-05-07 10:21:25.174 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41881/api/school/respect/person?since=2026-05-07T06%3A21%3A25.078729969Z&includeRelated=false.
2026-05-07 10:21:27.306 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:27.308 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.045 seconds.
2026-05-07 10:21:27.309 [DefaultDispatcher-worker-5 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43223
2026-05-07 10:21:27.311 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3
2026-05-07 10:21:27.311 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3.
2026-05-07 10:21:27.311 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3
2026-05-07 10:21:27.313 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3]] @ /playlist/{uuid}/(method:GET)
2026-05-07 10:21:27.319 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3
2026-05-07 10:21:27.319 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3
2026-05-07 10:21:27.319 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3
2026-05-07 10:21:27.320 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:43223/playlist/55f6b7a7-2bbd-4ec1-b7a5-0015179dd6a3.
2026-05-07 10:21:29.478 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 10:21:29.478 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-07 10:21:29.479 [DefaultDispatcher-worker-12 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45727
2026-05-07 10:21:29.520 [DefaultDispatcher-worker-12 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.521 [DefaultDispatcher-worker-12 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@41424a16 for http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.521 [DefaultDispatcher-worker-12 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.521 [DefaultDispatcher-worker-12 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff from class io.ktor.http.content.TextContent
2026-05-07 10:21:29.523 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 8ea51aa4-555e-4d25-bd88-7582355ac7ff]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[8ea51aa4-555e-4d25-bd88-7582355ac7ff]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[8ea51aa4-555e-4d25-bd88-7582355ac7ff]] @ /playlist/{uuid}/(method:POST)
2026-05-07 10:21:29.524 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.524 [DefaultDispatcher-worker-12 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 10:21:29.525 [DefaultDispatcher-worker-9 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.525 [DefaultDispatcher-worker-9 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 10:21:29.525 [DefaultDispatcher-worker-9 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45727/playlist/8ea51aa4-555e-4d25-bd88-7582355ac7ff
2026-05-07 14:49:32.464 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:32.579 [Test worker] INFO  io.ktor.server.Application - Application started in 0.315 seconds.
2026-05-07 14:49:32.659 [DefaultDispatcher-worker-1 @coroutine#2] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46089
2026-05-07 14:49:33.736 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46089/resources/index.json
2026-05-07 14:49:33.737 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46089/resources/index.json.
2026-05-07 14:49:33.740 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46089/resources/index.json
2026-05-07 14:49:34.005 [eventLoopGroupProxy-4-1 @call-handler#12] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 14:49:34.079 [DefaultDispatcher-worker-1 @call-handler#12] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 81ms
2026-05-07 14:49:34.090 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46089/resources/index.json
2026-05-07 14:49:34.095 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46089/resources/index.json
2026-05-07 14:49:34.095 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46089/resources/index.json
2026-05-07 14:49:34.122 [DefaultDispatcher-worker-3 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:46089/resources/index.json.
2026-05-07 14:49:34.169 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46089/resources/index.json
2026-05-07 14:49:34.169 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46089/resources/index.json.
2026-05-07 14:49:34.169 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46089/resources/index.json
2026-05-07 14:49:34.175 [eventLoopGroupProxy-4-1 @call-handler#22] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 14:49:34.177 [eventLoopGroupProxy-4-1 @call-handler#22] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms
2026-05-07 14:49:34.179 [DefaultDispatcher-worker-2 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46089/resources/index.json
2026-05-07 14:49:34.179 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46089/resources/index.json
2026-05-07 14:49:34.179 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46089/resources/index.json
2026-05-07 14:49:36.198 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:36.199 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-07 14:49:36.200 [DefaultDispatcher-worker-2 @coroutine#26] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37181
2026-05-07 14:49:36.267 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37181/resources/index.json
2026-05-07 14:49:36.267 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37181/resources/index.json.
2026-05-07 14:49:36.267 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37181/resources/index.json
2026-05-07 14:49:36.271 [eventLoopGroupProxy-7-1 @call-handler#35] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 14:49:36.273 [DefaultDispatcher-worker-1 @call-handler#35] INFO  io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms
2026-05-07 14:49:36.275 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37181/resources/index.json
2026-05-07 14:49:36.275 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37181/resources/index.json
2026-05-07 14:49:36.275 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37181/resources/index.json
2026-05-07 14:49:36.276 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:37181/resources/index.json.
2026-05-07 14:49:36.287 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37181/resources/index.json
2026-05-07 14:49:36.287 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37181/resources/index.json.
2026-05-07 14:49:36.287 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37181/resources/index.json
2026-05-07 14:49:36.289 [eventLoopGroupProxy-7-1 @call-handler#45] TRACE io.ktor.server.routing.Routing - Trace for [resources, index.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[index.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 14:49:36.293 [eventLoopGroupProxy-7-1 @call-handler#45] INFO  io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 4ms
2026-05-07 14:49:36.298 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37181/resources/index.json
2026-05-07 14:49:36.299 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37181/resources/index.json
2026-05-07 14:49:36.299 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37181/resources/index.json
2026-05-07 14:49:38.312 [Test worker] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:38.313 [Test worker] INFO  io.ktor.server.Application - Application started in 0.001 seconds.
2026-05-07 14:49:38.314 [DefaultDispatcher-worker-1 @coroutine#49] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:40915
2026-05-07 14:49:38.320 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40915/resources/lesson001.json
2026-05-07 14:49:38.321 [Test worker @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40915/resources/lesson001.json.
2026-05-07 14:49:38.321 [Test worker @coroutine#55] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40915/resources/lesson001.json
2026-05-07 14:49:38.323 [eventLoopGroupProxy-10-1 @call-handler#59] TRACE io.ktor.server.routing.Routing - Trace for [resources, lesson001.json]
/, segment:0 -> SUCCESS @ /
  /(staticContent), segment:0 -> SUCCESS @ /(staticContent)
    /(staticContent)/resources, segment:1 -> SUCCESS @ /(staticContent)/resources
      /(staticContent)/resources/{...}, segment:2 -> SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}
        /(staticContent)/resources/{...}/(method:GET), segment:2 -> SUCCESS @ /(staticContent)/resources/{...}/(method:GET)
Matched routes:
  "" -> "(staticContent)" -> "resources" -> "{...}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [static-content-path-parameter=[lesson001.json]] @ /(staticContent)/resources/{...}/(method:GET)
2026-05-07 14:49:38.325 [DefaultDispatcher-worker-3 @call-handler#59] INFO  io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms
2026-05-07 14:49:38.325 [DefaultDispatcher-worker-3 @coroutine#55] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40915/resources/lesson001.json
2026-05-07 14:49:38.326 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40915/resources/lesson001.json
2026-05-07 14:49:38.326 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40915/resources/lesson001.json
2026-05-07 14:49:38.328 [DefaultDispatcher-worker-2 @coroutine#55] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class kotlinx.serialization.json.JsonObject for http://localhost:40915/resources/lesson001.json.
2026-05-07 14:49:40.799 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:40.829 [Test worker @coroutine#65] INFO  io.ktor.server.Application - Application started in 0.266 seconds.
2026-05-07 14:49:40.841 [DefaultDispatcher-worker-1 @coroutine#74] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:45417
2026-05-07 14:49:40.866 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45417/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:40.867 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45417/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:40.867 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45417/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:40.901 [eventLoopGroupProxy-13-1 @call-handler#78] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 14:49:40.990 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45417/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:40.991 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45417/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:40.991 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45417/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:41.001 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45417/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:41.162 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.162 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45417/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:41.162 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.165 [eventLoopGroupProxy-13-1 @call-handler#84] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:41.229 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.229 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.229 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.231 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45417/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:41.246 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.246 [Test worker @coroutine#65] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45417/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:41.246 [Test worker @coroutine#65] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.248 [eventLoopGroupProxy-13-1 @call-handler#90] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:41.252 [DefaultDispatcher-worker-3 @call-handler#90] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person?includeRelated=false request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 14:49:41.253 [Test worker @coroutine#65] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.253 [Test worker @coroutine#65] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:41.254 [Test worker @coroutine#65] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45417/api/school/respect/person?includeRelated=false
2026-05-07 14:49:43.439 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:43.440 [Test worker @coroutine#94] INFO  io.ktor.server.Application - Application started in 0.059 seconds.
2026-05-07 14:49:43.442 [DefaultDispatcher-worker-4 @coroutine#103] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:37109
2026-05-07 14:49:43.443 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37109/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:43.443 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37109/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:43.443 [Test worker @coroutine#94] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37109/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:43.445 [eventLoopGroupProxy-16-1 @call-handler#107] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 14:49:43.447 [Test worker @coroutine#94] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37109/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:43.447 [Test worker @coroutine#94] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37109/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:43.447 [Test worker @coroutine#94] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37109/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:43.448 [Test worker @coroutine#94] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37109/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:43.502 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 14:49:43.502 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-07 14:49:43.502 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 14:49:43.504 [eventLoopGroupProxy-16-1 @call-handler#117] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:43.507 [DefaultDispatcher-worker-5 @coroutine#113] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 14:49:43.507 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 14:49:43.507 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100
2026-05-07 14:49:43.508 [DefaultDispatcher-worker-5 @coroutine#113] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37109/api/school/respect/person?includeDeleted=true&includeRelated=false&offset=0&limit=100.
2026-05-07 14:49:45.658 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:45.659 [Test worker @coroutine#122] INFO  io.ktor.server.Application - Application started in 0.053 seconds.
2026-05-07 14:49:45.663 [DefaultDispatcher-worker-4 @coroutine#131] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:46065
2026-05-07 14:49:45.667 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46065/api/school/respect/person?includeRelated=false
2026-05-07 14:49:45.668 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46065/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:45.668 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46065/api/school/respect/person?includeRelated=false
2026-05-07 14:49:45.683 [eventLoopGroupProxy-19-1 @call-handler#136] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:45.692 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46065/api/school/respect/person?includeRelated=false
2026-05-07 14:49:45.693 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46065/api/school/respect/person?includeRelated=false
2026-05-07 14:49:45.693 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46065/api/school/respect/person?includeRelated=false
2026-05-07 14:49:45.694 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46065/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:45.765 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false
2026-05-07 14:49:45.765 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false.
2026-05-07 14:49:45.765 [Test worker @coroutine#122] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false
2026-05-07 14:49:45.767 [eventLoopGroupProxy-19-1 @call-handler#142] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:45.771 [Test worker @coroutine#122] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false
2026-05-07 14:49:45.772 [Test worker @coroutine#122] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false
2026-05-07 14:49:45.772 [Test worker @coroutine#122] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false
2026-05-07 14:49:45.773 [Test worker @coroutine#122] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46065/api/school/respect/person?since=2026-05-07T10%3A49%3A45.684468623Z&includeRelated=false.
2026-05-07 14:49:47.959 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:47.960 [Test worker @coroutine#148] INFO  io.ktor.server.Application - Application started in 0.055 seconds.
2026-05-07 14:49:47.979 [DefaultDispatcher-worker-5 @coroutine#157] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43129
2026-05-07 14:49:48.084 [DefaultDispatcher-worker-1 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43129/api/school/respect/person
2026-05-07 14:49:48.084 [DefaultDispatcher-worker-1 @coroutine#155] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@6d6cf0d3 for http://localhost:43129/api/school/respect/person
2026-05-07 14:49:48.084 [DefaultDispatcher-worker-1 @coroutine#155] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43129/api/school/respect/person
2026-05-07 14:49:48.084 [DefaultDispatcher-worker-1 @coroutine#155] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43129/api/school/respect/person from class io.ktor.http.content.TextContent
2026-05-07 14:49:48.100 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> SUCCESS @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:POST)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:POST)
2026-05-07 14:49:48.109 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List<world.respect.datalayer.school.model.Person>) for call /api/school/respect/person
2026-05-07 14:49:48.112 [eventLoopGroupProxy-22-1 @call-handler#167] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 14:49:48.116 [DefaultDispatcher-worker-7 @coroutine#155] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43129/api/school/respect/person
2026-05-07 14:49:48.117 [DefaultDispatcher-worker-7 @coroutine#155] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43129/api/school/respect/person
2026-05-07 14:49:48.117 [DefaultDispatcher-worker-7 @coroutine#155] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43129/api/school/respect/person
2026-05-07 14:49:50.277 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:50.279 [Test worker @coroutine#172] INFO  io.ktor.server.Application - Application started in 0.053 seconds.
2026-05-07 14:49:50.281 [DefaultDispatcher-worker-3 @coroutine#181] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:34761
2026-05-07 14:49:50.283 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34761/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:50.283 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34761/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:50.283 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34761/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:50.286 [eventLoopGroupProxy-25-1 @call-handler#185] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, schoolpermissiongrant]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/person
        /api/school/respect/schoolpermissiongrant, segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant
          /api/school/respect/schoolpermissiongrant/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "schoolpermissiongrant" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/schoolpermissiongrant/(method:GET)
2026-05-07 14:49:50.289 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34761/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:50.290 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34761/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:50.290 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34761/api/school/respect/schoolpermissiongrant
2026-05-07 14:49:50.291 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34761/api/school/respect/schoolpermissiongrant.
2026-05-07 14:49:50.364 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:50.364 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34761/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:50.364 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:50.366 [eventLoopGroupProxy-25-1 @call-handler#191] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:50.374 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:50.374 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:50.374 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:50.375 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34761/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:52.389 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:52.389 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34761/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:52.389 [Test worker @coroutine#172] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:52.391 [eventLoopGroupProxy-25-1 @call-handler#198] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
        /api/school/respect/schoolpermissiongrant, segment:3 -> FAILURE "Selector didn't match" @ /api/school/respect/schoolpermissiongrant
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:52.395 [Test worker @coroutine#172] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:52.396 [Test worker @coroutine#172] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:52.396 [Test worker @coroutine#172] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34761/api/school/respect/person?includeRelated=false
2026-05-07 14:49:52.397 [Test worker @coroutine#172] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34761/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:54.585 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:54.586 [Test worker @coroutine#204] INFO  io.ktor.server.Application - Application started in 0.05 seconds.
2026-05-07 14:49:54.587 [DefaultDispatcher-worker-7 @coroutine#213] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:35639
2026-05-07 14:49:54.590 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35639/api/school/respect/person?includeRelated=false
2026-05-07 14:49:54.590 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35639/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:54.590 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35639/api/school/respect/person?includeRelated=false
2026-05-07 14:49:54.592 [eventLoopGroupProxy-28-1 @call-handler#218] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:54.596 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35639/api/school/respect/person?includeRelated=false
2026-05-07 14:49:54.597 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35639/api/school/respect/person?includeRelated=false
2026-05-07 14:49:54.597 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35639/api/school/respect/person?includeRelated=false
2026-05-07 14:49:54.598 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35639/api/school/respect/person?includeRelated=false.
2026-05-07 14:49:54.664 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false
2026-05-07 14:49:54.664 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false.
2026-05-07 14:49:54.664 [Test worker @coroutine#204] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false
2026-05-07 14:49:54.669 [eventLoopGroupProxy-28-1 @call-handler#225] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
  /api, segment:1 -> SUCCESS @ /api
    /api/school, segment:2 -> SUCCESS @ /api/school
      /api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
        /api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
          /api/school/respect/person/(method:GET), segment:4 -> SUCCESS @ /api/school/respect/person/(method:GET)
          /api/school/respect/person/(method:POST), segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person/(method:POST)
Matched routes:
  "" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
  SUCCESS @ /api/school/respect/person/(method:GET)
2026-05-07 14:49:54.687 [Test worker @coroutine#204] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false
2026-05-07 14:49:54.688 [Test worker @coroutine#204] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false
2026-05-07 14:49:54.688 [Test worker @coroutine#204] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false
2026-05-07 14:49:54.689 [Test worker @coroutine#204] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35639/api/school/respect/person?since=2026-05-07T10%3A49%3A54.593197363Z&includeRelated=false.
2026-05-07 14:49:56.795 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:56.797 [Test worker @coroutine#231] INFO  io.ktor.server.Application - Application started in 0.043 seconds.
2026-05-07 14:49:56.798 [DefaultDispatcher-worker-6 @coroutine#241] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:41315
2026-05-07 14:49:56.800 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044
2026-05-07 14:49:56.800 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044.
2026-05-07 14:49:56.800 [Test worker @coroutine#231] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044
2026-05-07 14:49:56.802 [eventLoopGroupProxy-31-1 @call-handler#245] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 56ddf0bc-0053-457d-bb6a-5189692ad044]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[56ddf0bc-0053-457d-bb6a-5189692ad044]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:GET)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[56ddf0bc-0053-457d-bb6a-5189692ad044]] @ /playlist/{uuid}/(method:GET)
2026-05-07 14:49:56.809 [Test worker @coroutine#231] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044
2026-05-07 14:49:56.809 [Test worker @coroutine#231] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044
2026-05-07 14:49:56.809 [Test worker @coroutine#231] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044
2026-05-07 14:49:56.809 [Test worker @coroutine#231] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.lib.opds.model.OpdsFeed for http://localhost:41315/playlist/56ddf0bc-0053-457d-bb6a-5189692ad044.
2026-05-07 14:49:58.973 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-05-07 14:49:58.974 [Test worker @coroutine#249] INFO  io.ktor.server.Application - Application started in 0.039 seconds.
2026-05-07 14:49:58.975 [DefaultDispatcher-worker-8 @coroutine#258] INFO  io.ktor.server.Application - Responding at http://0.0.0.0:43979
2026-05-07 14:49:59.015 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.015 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@20a499e9 for http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.015 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.015 [DefaultDispatcher-worker-6 @coroutine#256] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc from class io.ktor.http.content.TextContent
2026-05-07 14:49:59.018 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE io.ktor.server.routing.Routing - Trace for [playlist, 88b27031-f840-44d5-bf67-90b68fbdcdbc]
/, segment:0 -> SUCCESS @ /
  /playlist, segment:1 -> SUCCESS @ /playlist
    /playlist/{uuid}, segment:2 -> SUCCESS; Parameters [uuid=[88b27031-f840-44d5-bf67-90b68fbdcdbc]] @ /playlist/{uuid}
      /playlist/{uuid}/(method:GET), segment:2 -> FAILURE "Selector didn't match" @ /playlist/{uuid}/(method:GET)
      /playlist/{uuid}/(method:POST), segment:2 -> SUCCESS @ /playlist/{uuid}/(method:POST)
Matched routes:
  "" -> "playlist" -> "{uuid}" -> "(method:POST)"
Routing resolve result:
  SUCCESS; Parameters [uuid=[88b27031-f840-44d5-bf67-90b68fbdcdbc]] @ /playlist/{uuid}/(method:POST)
2026-05-07 14:49:59.018 [eventLoopGroupProxy-34-1 @call-handler#266] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(world.respect.lib.opds.model.OpdsFeed) for call /playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.019 [DefaultDispatcher-worker-6 @call-handler#266] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the POST /playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType].
2026-05-07 14:49:59.020 [DefaultDispatcher-worker-7 @coroutine#256] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.020 [DefaultDispatcher-worker-7 @coroutine#256] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc
2026-05-07 14:49:59.020 [DefaultDispatcher-worker-7 @coroutine#256] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43979/playlist/88b27031-f840-44d5-bf67-90b68fbdcdbc