2025-10-15 09:15:35.310 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:35.408 [Test worker] INFO io.ktor.server.Application - Application started in 0.243 seconds. 2025-10-15 09:15:35.515 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40315 2025-10-15 09:15:35.799 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40315/resources/index.json 2025-10-15 09:15:35.800 [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:40315/resources/index.json. 2025-10-15 09:15:35.800 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40315/resources/index.json 2025-10-15 09:15:35.912 [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) 2025-10-15 09:15:35.946 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 40ms 2025-10-15 09:15:35.953 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40315/resources/index.json 2025-10-15 09:15:35.954 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40315/resources/index.json 2025-10-15 09:15:35.954 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40315/resources/index.json 2025-10-15 09:15:35.970 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:40315/resources/index.json. 2025-10-15 09:15:36.001 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40315/resources/index.json 2025-10-15 09:15:36.002 [DefaultDispatcher-worker-1 @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:40315/resources/index.json. 2025-10-15 09:15:36.002 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40315/resources/index.json 2025-10-15 09:15:36.004 [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) 2025-10-15 09:15:36.005 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 09:15:36.005 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40315/resources/index.json 2025-10-15 09:15:36.006 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40315/resources/index.json 2025-10-15 09:15:36.006 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40315/resources/index.json 2025-10-15 09:15:37.012 [eventLoopGroupProxy-3-1] WARN i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@3eb8d2b3 java.util.concurrent.RejectedExecutionException: event executor terminated at io.netty.util.concurrent.SingleThreadEventExecutor.reject(SingleThreadEventExecutor.java:1005) at io.netty.util.concurrent.SingleThreadEventExecutor.offerTask(SingleThreadEventExecutor.java:388) at io.netty.util.concurrent.SingleThreadEventExecutor.addTask(SingleThreadEventExecutor.java:381) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:907) at io.netty.util.concurrent.SingleThreadEventExecutor.execute0(SingleThreadEventExecutor.java:873) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:863) at io.netty.channel.DefaultChannelPipeline.destroyUp(DefaultChannelPipeline.java:816) at io.netty.channel.DefaultChannelPipeline.destroy(DefaultChannelPipeline.java:801) at io.netty.channel.DefaultChannelPipeline.access$700(DefaultChannelPipeline.java:45) at io.netty.channel.DefaultChannelPipeline$HeadContext.channelUnregistered(DefaultChannelPipeline.java:1411) at io.netty.channel.DefaultChannelPipeline.fireChannelUnregistered(DefaultChannelPipeline.java:780) at io.netty.channel.AbstractChannel$AbstractUnsafe$8.run(AbstractChannel.java:692) at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:148) at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:141) at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:507) at io.netty.channel.SingleThreadIoEventLoop.run(SingleThreadIoEventLoop.java:183) at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:1073) at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base/java.lang.Thread.run(Thread.java:840) 2025-10-15 09:15:38.018 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:38.018 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-10-15 09:15:38.020 [DefaultDispatcher-worker-1 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36105 2025-10-15 09:15:38.069 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36105/resources/index.json 2025-10-15 09:15:38.069 [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:36105/resources/index.json. 2025-10-15 09:15:38.069 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36105/resources/index.json 2025-10-15 09:15:38.072 [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) 2025-10-15 09:15:38.073 [DefaultDispatcher-worker-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-10-15 09:15:38.074 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36105/resources/index.json 2025-10-15 09:15:38.074 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36105/resources/index.json 2025-10-15 09:15:38.074 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36105/resources/index.json 2025-10-15 09:15:38.074 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:36105/resources/index.json. 2025-10-15 09:15:38.079 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36105/resources/index.json 2025-10-15 09:15:38.079 [DefaultDispatcher-worker-2 @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:36105/resources/index.json. 2025-10-15 09:15:38.079 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36105/resources/index.json 2025-10-15 09:15:38.080 [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) 2025-10-15 09:15:38.081 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-10-15 09:15:38.081 [DefaultDispatcher-worker-3 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36105/resources/index.json 2025-10-15 09:15:38.081 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36105/resources/index.json 2025-10-15 09:15:38.081 [DefaultDispatcher-worker-2 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36105/resources/index.json 2025-10-15 09:15:40.089 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:40.090 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 09:15:40.091 [DefaultDispatcher-worker-2 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39013 2025-10-15 09:15:40.095 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39013/resources/lesson001.json 2025-10-15 09:15:40.095 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39013/resources/lesson001.json. 2025-10-15 09:15:40.095 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39013/resources/lesson001.json 2025-10-15 09:15:40.097 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 09:15:40.098 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2025-10-15 09:15:40.099 [DefaultDispatcher-worker-2 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39013/resources/lesson001.json 2025-10-15 09:15:40.099 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39013/resources/lesson001.json 2025-10-15 09:15:40.099 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39013/resources/lesson001.json 2025-10-15 09:15:40.116 [DefaultDispatcher-worker-3 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:39013/resources/lesson001.json. 2025-10-15 09:15:42.607 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:42.617 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.476 seconds. 2025-10-15 09:15:42.620 [DefaultDispatcher-worker-3 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44861 2025-10-15 09:15:42.711 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.711 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44861/api/school/respect/person. 2025-10-15 09:15:42.711 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.718 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 09:15:42.741 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.742 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.742 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.743 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44861/api/school/respect/person. 2025-10-15 09:15:42.777 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.777 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44861/api/school/respect/person. 2025-10-15 09:15:42.777 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.780 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 09:15:42.781 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 09:15:42.782 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.782 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44861/api/school/respect/person 2025-10-15 09:15:42.782 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44861/api/school/respect/person 2025-10-15 09:15:44.841 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:44.842 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-10-15 09:15:44.843 [DefaultDispatcher-worker-5 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40615 2025-10-15 09:15:44.904 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40615/api/school/respect/person?offset=0&limit=100 2025-10-15 09:15:44.904 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:40615/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:15:44.904 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40615/api/school/respect/person?offset=0&limit=100 2025-10-15 09:15:44.907 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 09:15:44.909 [DefaultDispatcher-worker-5 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40615/api/school/respect/person?offset=0&limit=100 2025-10-15 09:15:44.909 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40615/api/school/respect/person?offset=0&limit=100 2025-10-15 09:15:44.909 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40615/api/school/respect/person?offset=0&limit=100 2025-10-15 09:15:44.910 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:40615/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:15:46.971 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:46.972 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-10-15 09:15:46.973 [DefaultDispatcher-worker-2 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46191 2025-10-15 09:15:47.008 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46191/api/school/respect/person 2025-10-15 09:15:47.008 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46191/api/school/respect/person. 2025-10-15 09:15:47.008 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46191/api/school/respect/person 2025-10-15 09:15:47.011 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 09:15:47.013 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46191/api/school/respect/person 2025-10-15 09:15:47.014 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46191/api/school/respect/person 2025-10-15 09:15:47.014 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46191/api/school/respect/person 2025-10-15 09:15:47.014 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46191/api/school/respect/person. 2025-10-15 09:15:47.055 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z 2025-10-15 09:15:47.055 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z. 2025-10-15 09:15:47.055 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z 2025-10-15 09:15:47.057 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 09:15:47.059 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z 2025-10-15 09:15:47.059 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z 2025-10-15 09:15:47.059 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z 2025-10-15 09:15:47.060 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46191/api/school/respect/person?since=2025-10-15T07%3A15%3A47.011Z. 2025-10-15 09:15:49.119 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:49.119 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-10-15 09:15:49.120 [DefaultDispatcher-worker-2 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35283 2025-10-15 09:15:49.154 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35283/api/school/respect/person 2025-10-15 09:15:49.155 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@17ef5c5a for http://localhost:35283/api/school/respect/person 2025-10-15 09:15:49.155 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35283/api/school/respect/person 2025-10-15 09:15:49.155 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35283/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 09:15:49.159 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 09:15:49.166 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 09:15:49.191 [DefaultDispatcher-worker-2 @call-handler#138] 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]. 2025-10-15 09:15:49.192 [DefaultDispatcher-worker-3 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35283/api/school/respect/person 2025-10-15 09:15:49.192 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35283/api/school/respect/person 2025-10-15 09:15:49.192 [DefaultDispatcher-worker-3 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35283/api/school/respect/person 2025-10-15 09:15:51.247 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:51.248 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 09:15:51.249 [DefaultDispatcher-worker-2 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46403 2025-10-15 09:15:51.284 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:51.284 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46403/api/school/respect/person. 2025-10-15 09:15:51.284 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46403/api/school/respect/person 2025-10-15 09:15:51.287 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 09:15:51.289 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:51.290 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46403/api/school/respect/person 2025-10-15 09:15:51.290 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:51.290 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46403/api/school/respect/person. 2025-10-15 09:15:53.322 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:53.322 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46403/api/school/respect/person. 2025-10-15 09:15:53.322 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46403/api/school/respect/person 2025-10-15 09:15:53.323 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 09:15:53.325 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:53.326 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46403/api/school/respect/person 2025-10-15 09:15:53.326 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46403/api/school/respect/person 2025-10-15 09:15:53.326 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46403/api/school/respect/person. 2025-10-15 09:15:55.390 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:15:55.391 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.055 seconds. 2025-10-15 09:15:55.392 [DefaultDispatcher-worker-5 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33615 2025-10-15 09:15:55.421 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33615/api/school/respect/person 2025-10-15 09:15:55.422 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33615/api/school/respect/person. 2025-10-15 09:15:55.422 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33615/api/school/respect/person 2025-10-15 09:15:55.424 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 09:15:55.427 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33615/api/school/respect/person 2025-10-15 09:15:55.427 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33615/api/school/respect/person 2025-10-15 09:15:55.427 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33615/api/school/respect/person 2025-10-15 09:15:55.427 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33615/api/school/respect/person. 2025-10-15 09:15:55.458 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z 2025-10-15 09:15:55.458 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z. 2025-10-15 09:15:55.458 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z 2025-10-15 09:15:55.459 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 09:15:55.461 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z 2025-10-15 09:15:55.461 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z 2025-10-15 09:15:55.461 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z 2025-10-15 09:15:55.461 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33615/api/school/respect/person?since=2025-10-15T07%3A15%3A55.424Z. 2025-10-15 09:27:52.585 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:27:52.659 [Test worker] INFO io.ktor.server.Application - Application started in 0.172 seconds. 2025-10-15 09:27:52.729 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44233 2025-10-15 09:27:52.941 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44233/resources/index.json 2025-10-15 09:27:52.942 [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:44233/resources/index.json. 2025-10-15 09:27:52.942 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44233/resources/index.json 2025-10-15 09:27:53.044 [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) 2025-10-15 09:27:53.074 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 34ms 2025-10-15 09:27:53.078 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44233/resources/index.json 2025-10-15 09:27:53.079 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44233/resources/index.json 2025-10-15 09:27:53.079 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44233/resources/index.json 2025-10-15 09:27:53.095 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:44233/resources/index.json. 2025-10-15 09:27:53.122 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44233/resources/index.json 2025-10-15 09:27:53.122 [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:44233/resources/index.json. 2025-10-15 09:27:53.122 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44233/resources/index.json 2025-10-15 09:27:53.125 [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) 2025-10-15 09:27:53.126 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 09:27:53.126 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44233/resources/index.json 2025-10-15 09:27:53.127 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44233/resources/index.json 2025-10-15 09:27:53.127 [DefaultDispatcher-worker-2 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44233/resources/index.json 2025-10-15 09:27:55.137 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:27:55.138 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 09:27:55.139 [DefaultDispatcher-worker-2 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44337 2025-10-15 09:27:55.178 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44337/resources/index.json 2025-10-15 09:27:55.178 [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:44337/resources/index.json. 2025-10-15 09:27:55.178 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44337/resources/index.json 2025-10-15 09:27:55.181 [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) 2025-10-15 09:27:55.182 [DefaultDispatcher-worker-2 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-10-15 09:27:55.183 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44337/resources/index.json 2025-10-15 09:27:55.183 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44337/resources/index.json 2025-10-15 09:27:55.183 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44337/resources/index.json 2025-10-15 09:27:55.184 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:44337/resources/index.json. 2025-10-15 09:27:55.188 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44337/resources/index.json 2025-10-15 09:27:55.188 [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:44337/resources/index.json. 2025-10-15 09:27:55.189 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44337/resources/index.json 2025-10-15 09:27:55.190 [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) 2025-10-15 09:27:55.190 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2025-10-15 09:27:55.191 [DefaultDispatcher-worker-2 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44337/resources/index.json 2025-10-15 09:27:55.191 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44337/resources/index.json 2025-10-15 09:27:55.191 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44337/resources/index.json 2025-10-15 09:27:57.199 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:27:57.199 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-10-15 09:27:57.201 [DefaultDispatcher-worker-3 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:32777 2025-10-15 09:27:57.204 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:32777/resources/lesson001.json 2025-10-15 09:27:57.204 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:32777/resources/lesson001.json. 2025-10-15 09:27:57.204 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:32777/resources/lesson001.json 2025-10-15 09:27:57.207 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 09:27:57.208 [DefaultDispatcher-worker-2 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2025-10-15 09:27:57.209 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:32777/resources/lesson001.json 2025-10-15 09:27:57.209 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:32777/resources/lesson001.json 2025-10-15 09:27:57.209 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:32777/resources/lesson001.json 2025-10-15 09:27:57.226 [DefaultDispatcher-worker-2 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:32777/resources/lesson001.json. 2025-10-15 09:27:59.702 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:27:59.712 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.462 seconds. 2025-10-15 09:27:59.714 [DefaultDispatcher-worker-2 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39047 2025-10-15 09:27:59.796 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.797 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39047/api/school/respect/person. 2025-10-15 09:27:59.797 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.803 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 09:27:59.825 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.826 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.826 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.828 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39047/api/school/respect/person. 2025-10-15 09:27:59.868 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.868 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39047/api/school/respect/person. 2025-10-15 09:27:59.868 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.870 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 09:27:59.871 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 09:27:59.872 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.873 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39047/api/school/respect/person 2025-10-15 09:27:59.873 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39047/api/school/respect/person 2025-10-15 09:28:01.937 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:28:01.938 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.053 seconds. 2025-10-15 09:28:01.939 [DefaultDispatcher-worker-2 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34091 2025-10-15 09:28:02.000 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34091/api/school/respect/person?offset=0&limit=100 2025-10-15 09:28:02.000 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34091/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:28:02.000 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34091/api/school/respect/person?offset=0&limit=100 2025-10-15 09:28:02.003 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 09:28:02.006 [DefaultDispatcher-worker-1 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34091/api/school/respect/person?offset=0&limit=100 2025-10-15 09:28:02.006 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34091/api/school/respect/person?offset=0&limit=100 2025-10-15 09:28:02.006 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34091/api/school/respect/person?offset=0&limit=100 2025-10-15 09:28:02.006 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34091/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:28:04.068 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:28:04.069 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 09:28:04.071 [DefaultDispatcher-worker-2 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34299 2025-10-15 09:28:04.100 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34299/api/school/respect/person 2025-10-15 09:28:04.100 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34299/api/school/respect/person. 2025-10-15 09:28:04.100 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34299/api/school/respect/person 2025-10-15 09:28:04.103 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 09:28:04.105 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34299/api/school/respect/person 2025-10-15 09:28:04.105 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34299/api/school/respect/person 2025-10-15 09:28:04.105 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34299/api/school/respect/person 2025-10-15 09:28:04.106 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34299/api/school/respect/person. 2025-10-15 09:28:04.148 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z 2025-10-15 09:28:04.148 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z. 2025-10-15 09:28:04.148 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z 2025-10-15 09:28:04.150 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 09:28:04.152 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z 2025-10-15 09:28:04.153 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z 2025-10-15 09:28:04.153 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z 2025-10-15 09:28:04.153 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:34299/api/school/respect/person?since=2025-10-15T07%3A28%3A04.103Z. 2025-10-15 09:28:06.218 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:28:06.218 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.054 seconds. 2025-10-15 09:28:06.220 [DefaultDispatcher-worker-1 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43909 2025-10-15 09:28:06.256 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43909/api/school/respect/person 2025-10-15 09:28:06.256 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@3eaa3adf for http://localhost:43909/api/school/respect/person 2025-10-15 09:28:06.256 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43909/api/school/respect/person 2025-10-15 09:28:06.257 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:43909/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 09:28:06.260 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 09:28:06.266 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 09:28:06.288 [DefaultDispatcher-worker-5 @call-handler#138] 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]. 2025-10-15 09:28:06.289 [DefaultDispatcher-worker-2 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43909/api/school/respect/person 2025-10-15 09:28:06.289 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43909/api/school/respect/person 2025-10-15 09:28:06.290 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43909/api/school/respect/person 2025-10-15 09:28:08.346 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:28:08.347 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 09:28:08.348 [DefaultDispatcher-worker-1 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38219 2025-10-15 09:28:08.377 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:08.377 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38219/api/school/respect/person. 2025-10-15 09:28:08.377 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38219/api/school/respect/person 2025-10-15 09:28:08.380 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 09:28:08.382 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:08.382 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38219/api/school/respect/person 2025-10-15 09:28:08.382 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:08.382 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38219/api/school/respect/person. 2025-10-15 09:28:10.419 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:10.419 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38219/api/school/respect/person. 2025-10-15 09:28:10.419 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38219/api/school/respect/person 2025-10-15 09:28:10.421 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 09:28:10.423 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:10.424 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38219/api/school/respect/person 2025-10-15 09:28:10.424 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38219/api/school/respect/person 2025-10-15 09:28:10.424 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38219/api/school/respect/person. 2025-10-15 09:28:12.481 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:28:12.481 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 09:28:12.482 [DefaultDispatcher-worker-1 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38017 2025-10-15 09:28:12.540 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38017/api/school/respect/person 2025-10-15 09:28:12.540 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38017/api/school/respect/person. 2025-10-15 09:28:12.541 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38017/api/school/respect/person 2025-10-15 09:28:12.543 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 09:28:12.545 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38017/api/school/respect/person 2025-10-15 09:28:12.545 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38017/api/school/respect/person 2025-10-15 09:28:12.545 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38017/api/school/respect/person 2025-10-15 09:28:12.546 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38017/api/school/respect/person. 2025-10-15 09:28:12.592 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z 2025-10-15 09:28:12.592 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z. 2025-10-15 09:28:12.592 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z 2025-10-15 09:28:12.593 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 09:28:12.594 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z 2025-10-15 09:28:12.595 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z 2025-10-15 09:28:12.595 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z 2025-10-15 09:28:12.595 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38017/api/school/respect/person?since=2025-10-15T07%3A28%3A12.543Z. 2025-10-15 09:32:50.291 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:32:50.381 [Test worker] INFO io.ktor.server.Application - Application started in 0.203 seconds. 2025-10-15 09:32:50.485 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42895 2025-10-15 09:32:50.782 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42895/resources/index.json 2025-10-15 09:32:50.783 [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:42895/resources/index.json. 2025-10-15 09:32:50.783 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42895/resources/index.json 2025-10-15 09:32:50.876 [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) 2025-10-15 09:32:50.907 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 34ms 2025-10-15 09:32:50.911 [DefaultDispatcher-worker-2 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42895/resources/index.json 2025-10-15 09:32:50.913 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42895/resources/index.json 2025-10-15 09:32:50.913 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42895/resources/index.json 2025-10-15 09:32:50.928 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:42895/resources/index.json. 2025-10-15 09:32:50.949 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42895/resources/index.json 2025-10-15 09:32:50.949 [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:42895/resources/index.json. 2025-10-15 09:32:50.949 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42895/resources/index.json 2025-10-15 09:32:50.951 [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) 2025-10-15 09:32:50.952 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-10-15 09:32:50.953 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42895/resources/index.json 2025-10-15 09:32:50.953 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42895/resources/index.json 2025-10-15 09:32:50.953 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42895/resources/index.json 2025-10-15 09:32:51.959 [eventLoopGroupProxy-3-1] WARN i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@18da663d java.util.concurrent.RejectedExecutionException: event executor terminated at io.netty.util.concurrent.SingleThreadEventExecutor.reject(SingleThreadEventExecutor.java:1005) at io.netty.util.concurrent.SingleThreadEventExecutor.offerTask(SingleThreadEventExecutor.java:388) at io.netty.util.concurrent.SingleThreadEventExecutor.addTask(SingleThreadEventExecutor.java:381) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:907) at io.netty.util.concurrent.SingleThreadEventExecutor.execute0(SingleThreadEventExecutor.java:873) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:863) at io.netty.channel.DefaultChannelPipeline.destroyUp(DefaultChannelPipeline.java:816) at io.netty.channel.DefaultChannelPipeline.destroy(DefaultChannelPipeline.java:801) at io.netty.channel.DefaultChannelPipeline.access$700(DefaultChannelPipeline.java:45) at io.netty.channel.DefaultChannelPipeline$HeadContext.channelUnregistered(DefaultChannelPipeline.java:1411) at io.netty.channel.DefaultChannelPipeline.fireChannelUnregistered(DefaultChannelPipeline.java:780) at io.netty.channel.AbstractChannel$AbstractUnsafe$8.run(AbstractChannel.java:692) at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:148) at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:141) at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:507) at io.netty.channel.SingleThreadIoEventLoop.run(SingleThreadIoEventLoop.java:183) at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:1073) at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base/java.lang.Thread.run(Thread.java:840) 2025-10-15 09:57:12.314 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:12.464 [Test worker] INFO io.ktor.server.Application - Application started in 0.312 seconds. 2025-10-15 09:57:12.623 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:34611 2025-10-15 09:57:13.039 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34611/resources/index.json 2025-10-15 09:57:13.040 [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:34611/resources/index.json. 2025-10-15 09:57:13.040 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34611/resources/index.json 2025-10-15 09:57:13.206 [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) 2025-10-15 09:57:13.257 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 58ms 2025-10-15 09:57:13.264 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34611/resources/index.json 2025-10-15 09:57:13.266 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34611/resources/index.json 2025-10-15 09:57:13.266 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34611/resources/index.json 2025-10-15 09:57:13.289 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:34611/resources/index.json. 2025-10-15 09:57:13.319 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:34611/resources/index.json 2025-10-15 09:57:13.319 [DefaultDispatcher-worker-1 @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:34611/resources/index.json. 2025-10-15 09:57:13.319 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:34611/resources/index.json 2025-10-15 09:57:13.322 [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) 2025-10-15 09:57:13.323 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 09:57:13.324 [DefaultDispatcher-worker-1 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:34611/resources/index.json 2025-10-15 09:57:13.324 [DefaultDispatcher-worker-6 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:34611/resources/index.json 2025-10-15 09:57:13.324 [DefaultDispatcher-worker-6 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:34611/resources/index.json 2025-10-15 09:57:15.343 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:15.344 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 09:57:15.345 [DefaultDispatcher-worker-6 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43325 2025-10-15 09:57:15.394 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43325/resources/index.json 2025-10-15 09:57:15.394 [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:43325/resources/index.json. 2025-10-15 09:57:15.394 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43325/resources/index.json 2025-10-15 09:57:15.398 [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) 2025-10-15 09:57:15.398 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-10-15 09:57:15.399 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43325/resources/index.json 2025-10-15 09:57:15.399 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43325/resources/index.json 2025-10-15 09:57:15.400 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43325/resources/index.json 2025-10-15 09:57:15.400 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:43325/resources/index.json. 2025-10-15 09:57:15.404 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43325/resources/index.json 2025-10-15 09:57:15.404 [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:43325/resources/index.json. 2025-10-15 09:57:15.404 [DefaultDispatcher-worker-6 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43325/resources/index.json 2025-10-15 09:57:15.405 [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) 2025-10-15 09:57:15.406 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-10-15 09:57:15.406 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43325/resources/index.json 2025-10-15 09:57:15.407 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43325/resources/index.json 2025-10-15 09:57:15.407 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43325/resources/index.json 2025-10-15 09:57:17.413 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:17.414 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 09:57:17.415 [DefaultDispatcher-worker-4 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41601 2025-10-15 09:57:17.419 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41601/resources/lesson001.json 2025-10-15 09:57:17.419 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41601/resources/lesson001.json. 2025-10-15 09:57:17.419 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41601/resources/lesson001.json 2025-10-15 09:57:17.422 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 09:57:17.423 [DefaultDispatcher-worker-6 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 1ms 2025-10-15 09:57:17.423 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41601/resources/lesson001.json 2025-10-15 09:57:17.424 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41601/resources/lesson001.json 2025-10-15 09:57:17.424 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41601/resources/lesson001.json 2025-10-15 09:57:17.440 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:41601/resources/lesson001.json. 2025-10-15 09:57:19.915 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:19.927 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.463 seconds. 2025-10-15 09:57:19.930 [DefaultDispatcher-worker-4 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44121 2025-10-15 09:57:20.017 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.018 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44121/api/school/respect/person. 2025-10-15 09:57:20.018 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.025 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 09:57:20.053 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.054 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.054 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.057 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44121/api/school/respect/person. 2025-10-15 09:57:20.096 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.096 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44121/api/school/respect/person. 2025-10-15 09:57:20.097 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.099 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 09:57:20.100 [DefaultDispatcher-worker-5 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 09:57:20.101 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.102 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44121/api/school/respect/person 2025-10-15 09:57:20.102 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44121/api/school/respect/person 2025-10-15 09:57:22.162 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:22.163 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.051 seconds. 2025-10-15 09:57:22.164 [DefaultDispatcher-worker-5 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45139 2025-10-15 09:57:22.225 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45139/api/school/respect/person?offset=0&limit=100 2025-10-15 09:57:22.225 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45139/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:57:22.225 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45139/api/school/respect/person?offset=0&limit=100 2025-10-15 09:57:22.228 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 09:57:22.230 [DefaultDispatcher-worker-6 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45139/api/school/respect/person?offset=0&limit=100 2025-10-15 09:57:22.230 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45139/api/school/respect/person?offset=0&limit=100 2025-10-15 09:57:22.231 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45139/api/school/respect/person?offset=0&limit=100 2025-10-15 09:57:22.231 [DefaultDispatcher-worker-6 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45139/api/school/respect/person?offset=0&limit=100. 2025-10-15 09:57:24.296 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:24.297 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.054 seconds. 2025-10-15 09:57:24.298 [DefaultDispatcher-worker-4 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37759 2025-10-15 09:57:24.328 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37759/api/school/respect/person 2025-10-15 09:57:24.328 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37759/api/school/respect/person. 2025-10-15 09:57:24.328 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37759/api/school/respect/person 2025-10-15 09:57:24.331 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 09:57:24.333 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37759/api/school/respect/person 2025-10-15 09:57:24.333 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37759/api/school/respect/person 2025-10-15 09:57:24.333 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37759/api/school/respect/person 2025-10-15 09:57:24.334 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37759/api/school/respect/person. 2025-10-15 09:57:24.382 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z 2025-10-15 09:57:24.382 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z. 2025-10-15 09:57:24.382 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z 2025-10-15 09:57:24.384 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 09:57:24.387 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z 2025-10-15 09:57:24.387 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z 2025-10-15 09:57:24.387 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z 2025-10-15 09:57:24.387 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37759/api/school/respect/person?since=2025-10-15T07%3A57%3A24.331Z. 2025-10-15 09:57:26.449 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:26.450 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2025-10-15 09:57:26.451 [DefaultDispatcher-worker-6 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45055 2025-10-15 09:57:26.515 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45055/api/school/respect/person 2025-10-15 09:57:26.515 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@15b6cf9c for http://localhost:45055/api/school/respect/person 2025-10-15 09:57:26.515 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45055/api/school/respect/person 2025-10-15 09:57:26.515 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:45055/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 09:57:26.519 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 09:57:26.525 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 09:57:26.558 [DefaultDispatcher-worker-1 @call-handler#138] 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]. 2025-10-15 09:57:26.559 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45055/api/school/respect/person 2025-10-15 09:57:26.559 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45055/api/school/respect/person 2025-10-15 09:57:26.559 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45055/api/school/respect/person 2025-10-15 09:57:28.615 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:28.616 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 09:57:28.617 [DefaultDispatcher-worker-1 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35863 2025-10-15 09:57:28.652 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:28.652 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35863/api/school/respect/person. 2025-10-15 09:57:28.652 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35863/api/school/respect/person 2025-10-15 09:57:28.655 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 09:57:28.657 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:28.657 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35863/api/school/respect/person 2025-10-15 09:57:28.657 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:28.658 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35863/api/school/respect/person. 2025-10-15 09:57:30.695 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:30.695 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:35863/api/school/respect/person. 2025-10-15 09:57:30.695 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35863/api/school/respect/person 2025-10-15 09:57:30.697 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 09:57:30.699 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:30.699 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35863/api/school/respect/person 2025-10-15 09:57:30.699 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35863/api/school/respect/person 2025-10-15 09:57:30.699 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:35863/api/school/respect/person. 2025-10-15 09:57:32.757 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 09:57:32.758 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-10-15 09:57:32.759 [DefaultDispatcher-worker-1 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41923 2025-10-15 09:57:32.788 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41923/api/school/respect/person 2025-10-15 09:57:32.788 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41923/api/school/respect/person. 2025-10-15 09:57:32.788 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41923/api/school/respect/person 2025-10-15 09:57:32.790 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 09:57:32.792 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41923/api/school/respect/person 2025-10-15 09:57:32.792 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41923/api/school/respect/person 2025-10-15 09:57:32.792 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41923/api/school/respect/person 2025-10-15 09:57:32.793 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41923/api/school/respect/person. 2025-10-15 09:57:32.831 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z 2025-10-15 09:57:32.831 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z. 2025-10-15 09:57:32.831 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z 2025-10-15 09:57:32.832 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 09:57:32.834 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z 2025-10-15 09:57:32.834 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z 2025-10-15 09:57:32.834 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z 2025-10-15 09:57:32.835 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41923/api/school/respect/person?since=2025-10-15T07%3A57%3A32.790Z. 2025-10-15 10:18:38.829 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:38.964 [Test worker] INFO io.ktor.server.Application - Application started in 0.287 seconds. 2025-10-15 10:18:39.075 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36471 2025-10-15 10:18:39.345 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36471/resources/index.json 2025-10-15 10:18:39.346 [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:36471/resources/index.json. 2025-10-15 10:18:39.346 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36471/resources/index.json 2025-10-15 10:18:39.514 [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) 2025-10-15 10:18:39.560 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 51ms 2025-10-15 10:18:39.566 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36471/resources/index.json 2025-10-15 10:18:39.568 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36471/resources/index.json 2025-10-15 10:18:39.569 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36471/resources/index.json 2025-10-15 10:18:39.591 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:36471/resources/index.json. 2025-10-15 10:18:39.627 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36471/resources/index.json 2025-10-15 10:18:39.628 [DefaultDispatcher-worker-4 @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:36471/resources/index.json. 2025-10-15 10:18:39.628 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36471/resources/index.json 2025-10-15 10:18:39.630 [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) 2025-10-15 10:18:39.632 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 10:18:39.633 [DefaultDispatcher-worker-4 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36471/resources/index.json 2025-10-15 10:18:39.633 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36471/resources/index.json 2025-10-15 10:18:39.633 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36471/resources/index.json 2025-10-15 10:18:41.707 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:41.708 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 10:18:41.713 [DefaultDispatcher-worker-4 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35491 2025-10-15 10:18:41.804 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35491/resources/index.json 2025-10-15 10:18:41.805 [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:35491/resources/index.json. 2025-10-15 10:18:41.805 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35491/resources/index.json 2025-10-15 10:18:41.819 [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) 2025-10-15 10:18:41.820 [DefaultDispatcher-worker-3 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms 2025-10-15 10:18:41.822 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35491/resources/index.json 2025-10-15 10:18:41.822 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35491/resources/index.json 2025-10-15 10:18:41.822 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35491/resources/index.json 2025-10-15 10:18:41.823 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:35491/resources/index.json. 2025-10-15 10:18:41.831 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35491/resources/index.json 2025-10-15 10:18:41.832 [DefaultDispatcher-worker-4 @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:35491/resources/index.json. 2025-10-15 10:18:41.832 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35491/resources/index.json 2025-10-15 10:18:41.835 [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) 2025-10-15 10:18:41.836 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 10:18:41.837 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35491/resources/index.json 2025-10-15 10:18:41.837 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35491/resources/index.json 2025-10-15 10:18:41.837 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35491/resources/index.json 2025-10-15 10:18:43.919 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:43.920 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 10:18:43.925 [DefaultDispatcher-worker-1 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46363 2025-10-15 10:18:43.935 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46363/resources/lesson001.json 2025-10-15 10:18:43.936 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46363/resources/lesson001.json. 2025-10-15 10:18:43.936 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46363/resources/lesson001.json 2025-10-15 10:18:43.949 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 10:18:43.951 [eventLoopGroupProxy-10-1 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-10-15 10:18:43.961 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46363/resources/lesson001.json 2025-10-15 10:18:43.961 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46363/resources/lesson001.json 2025-10-15 10:18:43.961 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46363/resources/lesson001.json 2025-10-15 10:18:44.028 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:46363/resources/lesson001.json. 2025-10-15 10:18:46.878 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:46.916 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.818 seconds. 2025-10-15 10:18:46.923 [DefaultDispatcher-worker-4 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33795 2025-10-15 10:18:47.085 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.090 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33795/api/school/respect/person. 2025-10-15 10:18:47.091 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.112 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 10:18:47.171 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.172 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.172 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.176 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33795/api/school/respect/person. 2025-10-15 10:18:47.234 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.234 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33795/api/school/respect/person. 2025-10-15 10:18:47.234 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.239 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 10:18:47.242 [DefaultDispatcher-worker-4 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 10:18:47.244 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.244 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33795/api/school/respect/person 2025-10-15 10:18:47.244 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33795/api/school/respect/person 2025-10-15 10:18:49.360 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:49.362 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.058 seconds. 2025-10-15 10:18:49.364 [DefaultDispatcher-worker-4 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36491 2025-10-15 10:18:49.486 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36491/api/school/respect/person?offset=0&limit=100 2025-10-15 10:18:49.487 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36491/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:18:49.487 [DefaultDispatcher-worker-1 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36491/api/school/respect/person?offset=0&limit=100 2025-10-15 10:18:49.494 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 10:18:49.501 [DefaultDispatcher-worker-7 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36491/api/school/respect/person?offset=0&limit=100 2025-10-15 10:18:49.501 [DefaultDispatcher-worker-7 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36491/api/school/respect/person?offset=0&limit=100 2025-10-15 10:18:49.501 [DefaultDispatcher-worker-7 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36491/api/school/respect/person?offset=0&limit=100 2025-10-15 10:18:49.502 [DefaultDispatcher-worker-7 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36491/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:18:51.571 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:51.572 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.046 seconds. 2025-10-15 10:18:51.574 [DefaultDispatcher-worker-7 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37935 2025-10-15 10:18:51.608 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37935/api/school/respect/person 2025-10-15 10:18:51.608 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37935/api/school/respect/person. 2025-10-15 10:18:51.608 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37935/api/school/respect/person 2025-10-15 10:18:51.610 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 10:18:51.613 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37935/api/school/respect/person 2025-10-15 10:18:51.613 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37935/api/school/respect/person 2025-10-15 10:18:51.613 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37935/api/school/respect/person 2025-10-15 10:18:51.614 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37935/api/school/respect/person. 2025-10-15 10:18:51.654 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z 2025-10-15 10:18:51.655 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z. 2025-10-15 10:18:51.655 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z 2025-10-15 10:18:51.657 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 10:18:51.662 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z 2025-10-15 10:18:51.663 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z 2025-10-15 10:18:51.663 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z 2025-10-15 10:18:51.665 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37935/api/school/respect/person?since=2025-10-15T08%3A18%3A51.611Z. 2025-10-15 10:18:53.745 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:53.746 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.063 seconds. 2025-10-15 10:18:53.748 [DefaultDispatcher-worker-7 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40051 2025-10-15 10:18:53.807 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40051/api/school/respect/person 2025-10-15 10:18:53.808 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@3964063e for http://localhost:40051/api/school/respect/person 2025-10-15 10:18:53.808 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40051/api/school/respect/person 2025-10-15 10:18:53.808 [DefaultDispatcher-worker-2 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:40051/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 10:18:53.813 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 10:18:53.821 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 10:18:53.843 [DefaultDispatcher-worker-2 @call-handler#138] 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]. 2025-10-15 10:18:53.852 [DefaultDispatcher-worker-4 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40051/api/school/respect/person 2025-10-15 10:18:53.852 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40051/api/school/respect/person 2025-10-15 10:18:53.852 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40051/api/school/respect/person 2025-10-15 10:18:55.965 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:18:55.966 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.07 seconds. 2025-10-15 10:18:55.968 [DefaultDispatcher-worker-7 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:44829 2025-10-15 10:18:56.015 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:56.015 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44829/api/school/respect/person. 2025-10-15 10:18:56.015 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44829/api/school/respect/person 2025-10-15 10:18:56.025 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 10:18:56.042 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:56.042 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44829/api/school/respect/person 2025-10-15 10:18:56.042 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:56.043 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44829/api/school/respect/person. 2025-10-15 10:18:58.095 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:58.095 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:44829/api/school/respect/person. 2025-10-15 10:18:58.095 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:44829/api/school/respect/person 2025-10-15 10:18:58.097 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 10:18:58.099 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:58.100 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:44829/api/school/respect/person 2025-10-15 10:18:58.100 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:44829/api/school/respect/person 2025-10-15 10:18:58.100 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:44829/api/school/respect/person. 2025-10-15 10:19:00.156 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:19:00.157 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 10:19:00.158 [DefaultDispatcher-worker-6 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42063 2025-10-15 10:19:00.188 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42063/api/school/respect/person 2025-10-15 10:19:00.188 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42063/api/school/respect/person. 2025-10-15 10:19:00.188 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42063/api/school/respect/person 2025-10-15 10:19:00.190 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 10:19:00.193 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42063/api/school/respect/person 2025-10-15 10:19:00.193 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42063/api/school/respect/person 2025-10-15 10:19:00.193 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42063/api/school/respect/person 2025-10-15 10:19:00.193 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42063/api/school/respect/person. 2025-10-15 10:19:00.236 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z 2025-10-15 10:19:00.237 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z. 2025-10-15 10:19:00.237 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z 2025-10-15 10:19:00.238 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 10:19:00.241 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z 2025-10-15 10:19:00.241 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z 2025-10-15 10:19:00.241 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z 2025-10-15 10:19:00.241 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:42063/api/school/respect/person?since=2025-10-15T08%3A19%3A00.191Z. 2025-10-15 10:20:33.532 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:33.658 [Test worker] INFO io.ktor.server.Application - Application started in 0.279 seconds. 2025-10-15 10:20:33.757 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37491 2025-10-15 10:20:34.033 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37491/resources/index.json 2025-10-15 10:20:34.034 [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:37491/resources/index.json. 2025-10-15 10:20:34.034 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37491/resources/index.json 2025-10-15 10:20:34.183 [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) 2025-10-15 10:20:34.229 [DefaultDispatcher-worker-2 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 50ms 2025-10-15 10:20:34.234 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37491/resources/index.json 2025-10-15 10:20:34.237 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37491/resources/index.json 2025-10-15 10:20:34.237 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37491/resources/index.json 2025-10-15 10:20:34.260 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:37491/resources/index.json. 2025-10-15 10:20:34.297 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37491/resources/index.json 2025-10-15 10:20:34.297 [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:37491/resources/index.json. 2025-10-15 10:20:34.298 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37491/resources/index.json 2025-10-15 10:20:34.300 [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) 2025-10-15 10:20:34.301 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 10:20:34.302 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37491/resources/index.json 2025-10-15 10:20:34.302 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37491/resources/index.json 2025-10-15 10:20:34.302 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37491/resources/index.json 2025-10-15 10:20:35.310 [eventLoopGroupProxy-3-1] WARN i.n.u.c.AbstractEventExecutor - A task raised an exception. Task: io.netty.channel.AbstractChannel$AbstractUnsafe$8@4c61569a java.util.concurrent.RejectedExecutionException: event executor terminated at io.netty.util.concurrent.SingleThreadEventExecutor.reject(SingleThreadEventExecutor.java:1005) at io.netty.util.concurrent.SingleThreadEventExecutor.offerTask(SingleThreadEventExecutor.java:388) at io.netty.util.concurrent.SingleThreadEventExecutor.addTask(SingleThreadEventExecutor.java:381) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:907) at io.netty.util.concurrent.SingleThreadEventExecutor.execute0(SingleThreadEventExecutor.java:873) at io.netty.util.concurrent.SingleThreadEventExecutor.execute(SingleThreadEventExecutor.java:863) at io.netty.channel.DefaultChannelPipeline.destroyUp(DefaultChannelPipeline.java:816) at io.netty.channel.DefaultChannelPipeline.destroy(DefaultChannelPipeline.java:801) at io.netty.channel.DefaultChannelPipeline.access$700(DefaultChannelPipeline.java:45) at io.netty.channel.DefaultChannelPipeline$HeadContext.channelUnregistered(DefaultChannelPipeline.java:1411) at io.netty.channel.DefaultChannelPipeline.fireChannelUnregistered(DefaultChannelPipeline.java:780) at io.netty.channel.AbstractChannel$AbstractUnsafe$8.run(AbstractChannel.java:692) at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:148) at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:141) at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:507) at io.netty.channel.SingleThreadIoEventLoop.run(SingleThreadIoEventLoop.java:183) at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:1073) at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base/java.lang.Thread.run(Thread.java:1583) 2025-10-15 10:20:36.316 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:36.317 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 10:20:36.320 [DefaultDispatcher-worker-3 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:43775 2025-10-15 10:20:36.360 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43775/resources/index.json 2025-10-15 10:20:36.360 [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:43775/resources/index.json. 2025-10-15 10:20:36.360 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43775/resources/index.json 2025-10-15 10:20:36.363 [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) 2025-10-15 10:20:36.363 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 0ms 2025-10-15 10:20:36.364 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43775/resources/index.json 2025-10-15 10:20:36.364 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43775/resources/index.json 2025-10-15 10:20:36.364 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43775/resources/index.json 2025-10-15 10:20:36.365 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:43775/resources/index.json. 2025-10-15 10:20:36.369 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:43775/resources/index.json 2025-10-15 10:20:36.369 [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:43775/resources/index.json. 2025-10-15 10:20:36.369 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:43775/resources/index.json 2025-10-15 10:20:36.370 [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) 2025-10-15 10:20:36.370 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 0ms 2025-10-15 10:20:36.371 [DefaultDispatcher-worker-5 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:43775/resources/index.json 2025-10-15 10:20:36.371 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:43775/resources/index.json 2025-10-15 10:20:36.371 [DefaultDispatcher-worker-3 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:43775/resources/index.json 2025-10-15 10:20:38.379 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:38.379 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-10-15 10:20:38.380 [DefaultDispatcher-worker-3 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42765 2025-10-15 10:20:38.384 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42765/resources/lesson001.json 2025-10-15 10:20:38.384 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:42765/resources/lesson001.json. 2025-10-15 10:20:38.384 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42765/resources/lesson001.json 2025-10-15 10:20:38.387 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 10:20:38.388 [DefaultDispatcher-worker-5 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-10-15 10:20:38.388 [DefaultDispatcher-worker-5 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42765/resources/lesson001.json 2025-10-15 10:20:38.388 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42765/resources/lesson001.json 2025-10-15 10:20:38.389 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42765/resources/lesson001.json 2025-10-15 10:20:38.409 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:42765/resources/lesson001.json. 2025-10-15 10:20:40.907 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:40.917 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.486 seconds. 2025-10-15 10:20:40.920 [DefaultDispatcher-worker-5 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:39859 2025-10-15 10:20:40.996 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:40.997 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39859/api/school/respect/person. 2025-10-15 10:20:40.997 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.003 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 10:20:41.030 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.030 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.030 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.032 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:39859/api/school/respect/person. 2025-10-15 10:20:41.072 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.072 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:39859/api/school/respect/person. 2025-10-15 10:20:41.072 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.074 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 10:20:41.076 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 10:20:41.077 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.077 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:39859/api/school/respect/person 2025-10-15 10:20:41.077 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:39859/api/school/respect/person 2025-10-15 10:20:43.136 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:43.137 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2025-10-15 10:20:43.139 [DefaultDispatcher-worker-5 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41353 2025-10-15 10:20:43.206 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41353/api/school/respect/person?offset=0&limit=100 2025-10-15 10:20:43.206 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41353/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:20:43.206 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41353/api/school/respect/person?offset=0&limit=100 2025-10-15 10:20:43.209 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 10:20:43.212 [DefaultDispatcher-worker-2 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41353/api/school/respect/person?offset=0&limit=100 2025-10-15 10:20:43.212 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41353/api/school/respect/person?offset=0&limit=100 2025-10-15 10:20:43.212 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41353/api/school/respect/person?offset=0&limit=100 2025-10-15 10:20:43.212 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41353/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:20:45.266 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:45.267 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.042 seconds. 2025-10-15 10:20:45.268 [DefaultDispatcher-worker-3 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36357 2025-10-15 10:20:45.297 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36357/api/school/respect/person 2025-10-15 10:20:45.297 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36357/api/school/respect/person. 2025-10-15 10:20:45.297 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36357/api/school/respect/person 2025-10-15 10:20:45.299 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 10:20:45.302 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36357/api/school/respect/person 2025-10-15 10:20:45.302 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36357/api/school/respect/person 2025-10-15 10:20:45.302 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36357/api/school/respect/person 2025-10-15 10:20:45.302 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36357/api/school/respect/person. 2025-10-15 10:20:45.348 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z 2025-10-15 10:20:45.348 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z. 2025-10-15 10:20:45.348 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z 2025-10-15 10:20:45.350 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 10:20:45.352 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z 2025-10-15 10:20:45.352 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z 2025-10-15 10:20:45.352 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z 2025-10-15 10:20:45.352 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36357/api/school/respect/person?since=2025-10-15T08%3A20%3A45.300Z. 2025-10-15 10:20:47.409 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:47.410 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 10:20:47.411 [DefaultDispatcher-worker-5 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36055 2025-10-15 10:20:47.445 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36055/api/school/respect/person 2025-10-15 10:20:47.445 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@14563ee for http://localhost:36055/api/school/respect/person 2025-10-15 10:20:47.445 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36055/api/school/respect/person 2025-10-15 10:20:47.445 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:36055/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 10:20:47.449 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 10:20:47.454 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 10:20:47.482 [DefaultDispatcher-worker-5 @call-handler#138] 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]. 2025-10-15 10:20:47.483 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36055/api/school/respect/person 2025-10-15 10:20:47.483 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36055/api/school/respect/person 2025-10-15 10:20:47.483 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36055/api/school/respect/person 2025-10-15 10:20:49.539 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:49.540 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.048 seconds. 2025-10-15 10:20:49.541 [DefaultDispatcher-worker-2 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38821 2025-10-15 10:20:49.583 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:49.583 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38821/api/school/respect/person. 2025-10-15 10:20:49.583 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38821/api/school/respect/person 2025-10-15 10:20:49.586 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 10:20:49.588 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:49.588 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38821/api/school/respect/person 2025-10-15 10:20:49.588 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:49.589 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38821/api/school/respect/person. 2025-10-15 10:20:51.626 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:51.626 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38821/api/school/respect/person. 2025-10-15 10:20:51.626 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38821/api/school/respect/person 2025-10-15 10:20:51.628 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 10:20:51.630 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:51.630 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38821/api/school/respect/person 2025-10-15 10:20:51.630 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38821/api/school/respect/person 2025-10-15 10:20:51.630 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38821/api/school/respect/person. 2025-10-15 10:20:53.686 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:20:53.686 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.047 seconds. 2025-10-15 10:20:53.687 [DefaultDispatcher-worker-5 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41781 2025-10-15 10:20:53.728 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41781/api/school/respect/person 2025-10-15 10:20:53.728 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41781/api/school/respect/person. 2025-10-15 10:20:53.728 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41781/api/school/respect/person 2025-10-15 10:20:53.731 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 10:20:53.733 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41781/api/school/respect/person 2025-10-15 10:20:53.733 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41781/api/school/respect/person 2025-10-15 10:20:53.733 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41781/api/school/respect/person 2025-10-15 10:20:53.733 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41781/api/school/respect/person. 2025-10-15 10:20:53.769 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z 2025-10-15 10:20:53.769 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z. 2025-10-15 10:20:53.769 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z 2025-10-15 10:20:53.770 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 10:20:53.772 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z 2025-10-15 10:20:53.772 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z 2025-10-15 10:20:53.773 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z 2025-10-15 10:20:53.773 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41781/api/school/respect/person?since=2025-10-15T08%3A20%3A53.731Z. 2025-10-15 10:23:02.546 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:02.687 [Test worker] INFO io.ktor.server.Application - Application started in 0.273 seconds. 2025-10-15 10:23:02.777 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35281 2025-10-15 10:23:03.130 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35281/resources/index.json 2025-10-15 10:23:03.131 [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:35281/resources/index.json. 2025-10-15 10:23:03.131 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35281/resources/index.json 2025-10-15 10:23:03.282 [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) 2025-10-15 10:23:03.354 [DefaultDispatcher-worker-4 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 80ms 2025-10-15 10:23:03.362 [DefaultDispatcher-worker-4 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35281/resources/index.json 2025-10-15 10:23:03.364 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35281/resources/index.json 2025-10-15 10:23:03.365 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35281/resources/index.json 2025-10-15 10:23:03.390 [DefaultDispatcher-worker-4 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:35281/resources/index.json. 2025-10-15 10:23:03.433 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35281/resources/index.json 2025-10-15 10:23:03.433 [DefaultDispatcher-worker-4 @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:35281/resources/index.json. 2025-10-15 10:23:03.433 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35281/resources/index.json 2025-10-15 10:23:03.438 [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) 2025-10-15 10:23:03.440 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 10:23:03.444 [DefaultDispatcher-worker-4 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35281/resources/index.json 2025-10-15 10:23:03.444 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35281/resources/index.json 2025-10-15 10:23:03.444 [DefaultDispatcher-worker-4 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35281/resources/index.json 2025-10-15 10:23:05.472 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:05.473 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 10:23:05.475 [DefaultDispatcher-worker-4 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33447 2025-10-15 10:23:05.541 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33447/resources/index.json 2025-10-15 10:23:05.541 [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:33447/resources/index.json. 2025-10-15 10:23:05.541 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33447/resources/index.json 2025-10-15 10:23:05.548 [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) 2025-10-15 10:23:05.550 [eventLoopGroupProxy-7-1 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 2ms 2025-10-15 10:23:05.552 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33447/resources/index.json 2025-10-15 10:23:05.553 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33447/resources/index.json 2025-10-15 10:23:05.553 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33447/resources/index.json 2025-10-15 10:23:05.554 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:33447/resources/index.json. 2025-10-15 10:23:05.563 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33447/resources/index.json 2025-10-15 10:23:05.563 [DefaultDispatcher-worker-4 @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:33447/resources/index.json. 2025-10-15 10:23:05.563 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33447/resources/index.json 2025-10-15 10:23:05.567 [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) 2025-10-15 10:23:05.568 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 3ms 2025-10-15 10:23:05.568 [DefaultDispatcher-worker-4 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33447/resources/index.json 2025-10-15 10:23:05.569 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33447/resources/index.json 2025-10-15 10:23:05.569 [DefaultDispatcher-worker-4 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33447/resources/index.json 2025-10-15 10:23:07.594 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:07.595 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 10:23:07.598 [DefaultDispatcher-worker-4 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33641 2025-10-15 10:23:07.603 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33641/resources/lesson001.json 2025-10-15 10:23:07.603 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33641/resources/lesson001.json. 2025-10-15 10:23:07.603 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33641/resources/lesson001.json 2025-10-15 10:23:07.608 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 10:23:07.610 [DefaultDispatcher-worker-7 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-10-15 10:23:07.611 [DefaultDispatcher-worker-4 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33641/resources/lesson001.json 2025-10-15 10:23:07.612 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33641/resources/lesson001.json 2025-10-15 10:23:07.612 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33641/resources/lesson001.json 2025-10-15 10:23:07.642 [DefaultDispatcher-worker-4 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:33641/resources/lesson001.json. 2025-10-15 10:23:10.586 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:10.622 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.921 seconds. 2025-10-15 10:23:10.646 [DefaultDispatcher-worker-7 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:38585 2025-10-15 10:23:10.899 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:10.902 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38585/api/school/respect/person. 2025-10-15 10:23:10.902 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38585/api/school/respect/person 2025-10-15 10:23:10.920 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 10:23:11.009 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.014 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.014 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.016 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:38585/api/school/respect/person. 2025-10-15 10:23:11.098 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.098 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:38585/api/school/respect/person. 2025-10-15 10:23:11.098 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.108 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 10:23:11.120 [DefaultDispatcher-worker-4 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 10:23:11.125 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.130 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:38585/api/school/respect/person 2025-10-15 10:23:11.130 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:38585/api/school/respect/person 2025-10-15 10:23:13.273 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:13.275 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.088 seconds. 2025-10-15 10:23:13.286 [DefaultDispatcher-worker-4 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41463 2025-10-15 10:23:13.399 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41463/api/school/respect/person?offset=0&limit=100 2025-10-15 10:23:13.399 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41463/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:23:13.399 [DefaultDispatcher-worker-4 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41463/api/school/respect/person?offset=0&limit=100 2025-10-15 10:23:13.404 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 10:23:13.408 [DefaultDispatcher-worker-2 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41463/api/school/respect/person?offset=0&limit=100 2025-10-15 10:23:13.408 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41463/api/school/respect/person?offset=0&limit=100 2025-10-15 10:23:13.408 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41463/api/school/respect/person?offset=0&limit=100 2025-10-15 10:23:13.409 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41463/api/school/respect/person?offset=0&limit=100. 2025-10-15 10:23:15.520 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:15.521 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.06 seconds. 2025-10-15 10:23:15.523 [DefaultDispatcher-worker-1 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36199 2025-10-15 10:23:15.574 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36199/api/school/respect/person 2025-10-15 10:23:15.574 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36199/api/school/respect/person. 2025-10-15 10:23:15.574 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36199/api/school/respect/person 2025-10-15 10:23:15.578 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 10:23:15.581 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36199/api/school/respect/person 2025-10-15 10:23:15.581 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36199/api/school/respect/person 2025-10-15 10:23:15.581 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36199/api/school/respect/person 2025-10-15 10:23:15.581 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36199/api/school/respect/person. 2025-10-15 10:23:15.645 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z 2025-10-15 10:23:15.645 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z. 2025-10-15 10:23:15.645 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z 2025-10-15 10:23:15.648 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 10:23:15.652 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z 2025-10-15 10:23:15.652 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z 2025-10-15 10:23:15.652 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z 2025-10-15 10:23:15.652 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36199/api/school/respect/person?since=2025-10-15T08%3A23%3A15.578Z. 2025-10-15 10:23:17.749 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:17.750 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.056 seconds. 2025-10-15 10:23:17.776 [DefaultDispatcher-worker-2 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35349 2025-10-15 10:23:17.830 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35349/api/school/respect/person 2025-10-15 10:23:17.830 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@4d9212e9 for http://localhost:35349/api/school/respect/person 2025-10-15 10:23:17.830 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35349/api/school/respect/person 2025-10-15 10:23:17.831 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35349/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 10:23:17.848 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 10:23:17.858 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 10:23:17.870 [DefaultDispatcher-worker-4 @call-handler#138] 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]. 2025-10-15 10:23:17.872 [DefaultDispatcher-worker-5 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35349/api/school/respect/person 2025-10-15 10:23:17.872 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35349/api/school/respect/person 2025-10-15 10:23:17.872 [DefaultDispatcher-worker-5 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35349/api/school/respect/person 2025-10-15 10:23:19.935 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:19.936 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.05 seconds. 2025-10-15 10:23:19.938 [DefaultDispatcher-worker-5 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41069 2025-10-15 10:23:19.974 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:19.975 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41069/api/school/respect/person. 2025-10-15 10:23:19.975 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41069/api/school/respect/person 2025-10-15 10:23:19.984 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 10:23:19.989 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:19.989 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41069/api/school/respect/person 2025-10-15 10:23:19.989 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:19.989 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41069/api/school/respect/person. 2025-10-15 10:23:22.036 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:22.036 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41069/api/school/respect/person. 2025-10-15 10:23:22.036 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:41069/api/school/respect/person 2025-10-15 10:23:22.041 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 10:23:22.048 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:22.049 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41069/api/school/respect/person 2025-10-15 10:23:22.049 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41069/api/school/respect/person 2025-10-15 10:23:22.050 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41069/api/school/respect/person. 2025-10-15 10:23:24.131 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 10:23:24.132 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.057 seconds. 2025-10-15 10:23:24.133 [DefaultDispatcher-worker-1 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46823 2025-10-15 10:23:24.165 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46823/api/school/respect/person 2025-10-15 10:23:24.165 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46823/api/school/respect/person. 2025-10-15 10:23:24.165 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46823/api/school/respect/person 2025-10-15 10:23:24.169 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 10:23:24.173 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46823/api/school/respect/person 2025-10-15 10:23:24.173 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46823/api/school/respect/person 2025-10-15 10:23:24.173 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46823/api/school/respect/person 2025-10-15 10:23:24.174 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46823/api/school/respect/person. 2025-10-15 10:23:24.208 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z 2025-10-15 10:23:24.209 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z. 2025-10-15 10:23:24.209 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z 2025-10-15 10:23:24.210 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 10:23:24.214 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z 2025-10-15 10:23:24.214 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z 2025-10-15 10:23:24.214 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z 2025-10-15 10:23:24.215 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46823/api/school/respect/person?since=2025-10-15T08%3A23%3A24.169Z. 2025-10-15 14:12:15.183 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:15.252 [Test worker] INFO io.ktor.server.Application - Application started in 0.186 seconds. 2025-10-15 14:12:15.313 [DefaultDispatcher-worker-1 @coroutine#2] INFO io.ktor.server.Application - Responding at http://0.0.0.0:42181 2025-10-15 14:12:15.522 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42181/resources/index.json 2025-10-15 14:12:15.523 [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:42181/resources/index.json. 2025-10-15 14:12:15.523 [DefaultDispatcher-worker-2 @coroutine#8] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42181/resources/index.json 2025-10-15 14:12:15.611 [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) 2025-10-15 14:12:15.637 [DefaultDispatcher-worker-1 @call-handler#12] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 30ms 2025-10-15 14:12:15.641 [DefaultDispatcher-worker-1 @coroutine#8] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42181/resources/index.json 2025-10-15 14:12:15.643 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42181/resources/index.json 2025-10-15 14:12:15.643 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42181/resources/index.json 2025-10-15 14:12:15.657 [DefaultDispatcher-worker-1 @coroutine#8] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:42181/resources/index.json. 2025-10-15 14:12:15.680 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:42181/resources/index.json 2025-10-15 14:12:15.680 [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:42181/resources/index.json. 2025-10-15 14:12:15.680 [DefaultDispatcher-worker-3 @coroutine#20] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:42181/resources/index.json 2025-10-15 14:12:15.682 [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) 2025-10-15 14:12:15.683 [eventLoopGroupProxy-4-1 @call-handler#22] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 2ms 2025-10-15 14:12:15.683 [DefaultDispatcher-worker-3 @coroutine#20] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:42181/resources/index.json 2025-10-15 14:12:15.683 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:42181/resources/index.json 2025-10-15 14:12:15.683 [DefaultDispatcher-worker-1 @coroutine#20] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:42181/resources/index.json 2025-10-15 14:12:17.697 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:17.697 [Test worker] INFO io.ktor.server.Application - Application started in 0.0 seconds. 2025-10-15 14:12:17.698 [DefaultDispatcher-worker-1 @coroutine#26] INFO io.ktor.server.Application - Responding at http://0.0.0.0:40515 2025-10-15 14:12:17.753 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40515/resources/index.json 2025-10-15 14:12:17.753 [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:40515/resources/index.json. 2025-10-15 14:12:17.753 [Test worker @coroutine#30] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40515/resources/index.json 2025-10-15 14:12:17.756 [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) 2025-10-15 14:12:17.757 [DefaultDispatcher-worker-5 @call-handler#35] INFO io.ktor.server.Application - 200 OK: GET - /resources/index.json in 1ms 2025-10-15 14:12:17.757 [Test worker @coroutine#30] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40515/resources/index.json 2025-10-15 14:12:17.757 [Test worker @coroutine#30] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40515/resources/index.json 2025-10-15 14:12:17.757 [Test worker @coroutine#30] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40515/resources/index.json 2025-10-15 14:12:17.758 [Test worker @coroutine#30] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsFeed for http://localhost:40515/resources/index.json. 2025-10-15 14:12:17.762 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:40515/resources/index.json 2025-10-15 14:12:17.762 [DefaultDispatcher-worker-5 @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:40515/resources/index.json. 2025-10-15 14:12:17.762 [DefaultDispatcher-worker-5 @coroutine#43] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:40515/resources/index.json 2025-10-15 14:12:17.764 [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) 2025-10-15 14:12:17.764 [eventLoopGroupProxy-7-1 @call-handler#45] INFO io.ktor.server.Application - 304 Not Modified: GET - /resources/index.json in 1ms 2025-10-15 14:12:17.764 [DefaultDispatcher-worker-1 @coroutine#43] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:40515/resources/index.json 2025-10-15 14:12:17.764 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:40515/resources/index.json 2025-10-15 14:12:17.764 [DefaultDispatcher-worker-1 @coroutine#43] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:40515/resources/index.json 2025-10-15 14:12:19.770 [Test worker] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:19.771 [Test worker] INFO io.ktor.server.Application - Application started in 0.001 seconds. 2025-10-15 14:12:19.772 [DefaultDispatcher-worker-1 @coroutine#49] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45715 2025-10-15 14:12:19.777 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45715/resources/lesson001.json 2025-10-15 14:12:19.777 [Test worker @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45715/resources/lesson001.json. 2025-10-15 14:12:19.777 [Test worker @coroutine#52] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45715/resources/lesson001.json 2025-10-15 14:12:19.780 [eventLoopGroupProxy-10-1 @call-handler#56] 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) 2025-10-15 14:12:19.781 [DefaultDispatcher-worker-2 @call-handler#56] INFO io.ktor.server.Application - 200 OK: GET - /resources/lesson001.json in 2ms 2025-10-15 14:12:19.781 [DefaultDispatcher-worker-1 @coroutine#52] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45715/resources/lesson001.json 2025-10-15 14:12:19.782 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45715/resources/lesson001.json 2025-10-15 14:12:19.782 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45715/resources/lesson001.json 2025-10-15 14:12:19.800 [DefaultDispatcher-worker-5 @coroutine#52] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class world.respect.datalayer.opds.model.OpdsPublication for http://localhost:45715/resources/lesson001.json. 2025-10-15 14:12:22.287 [Test worker @coroutine#61] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:22.298 [Test worker @coroutine#61] INFO io.ktor.server.Application - Application started in 0.476 seconds. 2025-10-15 14:12:22.301 [DefaultDispatcher-worker-5 @coroutine#67] INFO io.ktor.server.Application - Responding at http://0.0.0.0:45965 2025-10-15 14:12:22.386 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.386 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45965/api/school/respect/person. 2025-10-15 14:12:22.386 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.393 [eventLoopGroupProxy-13-1 @call-handler#72] 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) 2025-10-15 14:12:22.419 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.419 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.419 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.421 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:45965/api/school/respect/person. 2025-10-15 14:12:22.468 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.469 [Test worker @coroutine#61] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:45965/api/school/respect/person. 2025-10-15 14:12:22.469 [Test worker @coroutine#61] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.471 [eventLoopGroupProxy-13-1 @call-handler#78] 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) 2025-10-15 14:12:22.472 [DefaultDispatcher-worker-2 @call-handler#78] TRACE i.k.s.p.c.ContentNegotiation - Skipping response body transformation from HttpStatusCode to OutgoingContent for the GET /api/school/respect/person request because the HttpStatusCode type is ignored. See [ContentNegotiationConfig::ignoreType]. 2025-10-15 14:12:22.474 [Test worker @coroutine#61] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.474 [Test worker @coroutine#61] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:45965/api/school/respect/person 2025-10-15 14:12:22.474 [Test worker @coroutine#61] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:45965/api/school/respect/person 2025-10-15 14:12:24.531 [Test worker @coroutine#82] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:24.532 [Test worker @coroutine#82] INFO io.ktor.server.Application - Application started in 0.047 seconds. 2025-10-15 14:12:24.533 [DefaultDispatcher-worker-2 @coroutine#88] INFO io.ktor.server.Application - Responding at http://0.0.0.0:36103 2025-10-15 14:12:24.640 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:36103/api/school/respect/person?offset=0&limit=100 2025-10-15 14:12:24.640 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:36103/api/school/respect/person?offset=0&limit=100. 2025-10-15 14:12:24.640 [DefaultDispatcher-worker-2 @coroutine#91] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:36103/api/school/respect/person?offset=0&limit=100 2025-10-15 14:12:24.643 [eventLoopGroupProxy-16-1 @call-handler#97] 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) 2025-10-15 14:12:24.645 [DefaultDispatcher-worker-5 @coroutine#91] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:36103/api/school/respect/person?offset=0&limit=100 2025-10-15 14:12:24.646 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:36103/api/school/respect/person?offset=0&limit=100 2025-10-15 14:12:24.646 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:36103/api/school/respect/person?offset=0&limit=100 2025-10-15 14:12:24.646 [DefaultDispatcher-worker-5 @coroutine#91] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:36103/api/school/respect/person?offset=0&limit=100. 2025-10-15 14:12:26.696 [Test worker @coroutine#102] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:26.696 [Test worker @coroutine#102] INFO io.ktor.server.Application - Application started in 0.038 seconds. 2025-10-15 14:12:26.698 [DefaultDispatcher-worker-2 @coroutine#108] INFO io.ktor.server.Application - Responding at http://0.0.0.0:33613 2025-10-15 14:12:26.728 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33613/api/school/respect/person 2025-10-15 14:12:26.729 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33613/api/school/respect/person. 2025-10-15 14:12:26.729 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33613/api/school/respect/person 2025-10-15 14:12:26.731 [eventLoopGroupProxy-19-1 @call-handler#113] 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) 2025-10-15 14:12:26.733 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33613/api/school/respect/person 2025-10-15 14:12:26.733 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33613/api/school/respect/person 2025-10-15 14:12:26.733 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33613/api/school/respect/person 2025-10-15 14:12:26.734 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33613/api/school/respect/person. 2025-10-15 14:12:26.773 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z 2025-10-15 14:12:26.773 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z. 2025-10-15 14:12:26.773 [Test worker @coroutine#102] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z 2025-10-15 14:12:26.777 [eventLoopGroupProxy-19-1 @call-handler#119] 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) 2025-10-15 14:12:26.779 [Test worker @coroutine#102] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z 2025-10-15 14:12:26.779 [Test worker @coroutine#102] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z 2025-10-15 14:12:26.779 [Test worker @coroutine#102] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z 2025-10-15 14:12:26.779 [Test worker @coroutine#102] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:33613/api/school/respect/person?since=2025-10-15T12%3A12%3A26.731Z. 2025-10-15 14:12:28.828 [Test worker @coroutine#124] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:28.829 [Test worker @coroutine#124] INFO io.ktor.server.Application - Application started in 0.038 seconds. 2025-10-15 14:12:28.831 [DefaultDispatcher-worker-4 @coroutine#130] INFO io.ktor.server.Application - Responding at http://0.0.0.0:35505 2025-10-15 14:12:28.867 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:35505/api/school/respect/person 2025-10-15 14:12:28.867 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.p.c.ContentNegotiation - Converted request body using io.ktor.serialization.kotlinx.KotlinxSerializationConverter@5fc4be8 for http://localhost:35505/api/school/respect/person 2025-10-15 14:12:28.867 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:35505/api/school/respect/person 2025-10-15 14:12:28.867 [DefaultDispatcher-worker-1 @coroutine#128] TRACE i.k.c.plugins.defaultTransformers - Transformed with default transformers request body for http://localhost:35505/api/school/respect/person from class io.ktor.http.content.TextContent 2025-10-15 14:12:28.871 [eventLoopGroupProxy-22-1 @call-handler#138] 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) 2025-10-15 14:12:28.876 [eventLoopGroupProxy-22-1 @call-handler#138] TRACE i.k.server.engine.DefaultTransform - No Default Transformations found for class io.ktor.utils.io.ByteChannel and expected type TypeInfo(kotlin.collections.List) for call /api/school/respect/person 2025-10-15 14:12:28.899 [DefaultDispatcher-worker-5 @call-handler#138] 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]. 2025-10-15 14:12:28.900 [DefaultDispatcher-worker-4 @coroutine#128] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:35505/api/school/respect/person 2025-10-15 14:12:28.900 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:35505/api/school/respect/person 2025-10-15 14:12:28.900 [DefaultDispatcher-worker-4 @coroutine#128] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:35505/api/school/respect/person 2025-10-15 14:12:30.954 [Test worker @coroutine#143] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:30.955 [Test worker @coroutine#143] INFO io.ktor.server.Application - Application started in 0.049 seconds. 2025-10-15 14:12:30.956 [DefaultDispatcher-worker-3 @coroutine#149] INFO io.ktor.server.Application - Responding at http://0.0.0.0:37239 2025-10-15 14:12:30.990 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:30.990 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37239/api/school/respect/person. 2025-10-15 14:12:30.990 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37239/api/school/respect/person 2025-10-15 14:12:30.992 [eventLoopGroupProxy-25-1 @call-handler#154] 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) 2025-10-15 14:12:30.994 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:30.995 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37239/api/school/respect/person 2025-10-15 14:12:30.995 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:30.995 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37239/api/school/respect/person. 2025-10-15 14:12:33.027 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:33.027 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:37239/api/school/respect/person. 2025-10-15 14:12:33.027 [Test worker @coroutine#143] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:37239/api/school/respect/person 2025-10-15 14:12:33.028 [eventLoopGroupProxy-25-1 @call-handler#161] 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) 2025-10-15 14:12:33.030 [Test worker @coroutine#143] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:33.030 [Test worker @coroutine#143] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:37239/api/school/respect/person 2025-10-15 14:12:33.030 [Test worker @coroutine#143] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:37239/api/school/respect/person 2025-10-15 14:12:33.031 [Test worker @coroutine#143] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:37239/api/school/respect/person. 2025-10-15 14:12:35.093 [Test worker @coroutine#167] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off. 2025-10-15 14:12:35.094 [Test worker @coroutine#167] INFO io.ktor.server.Application - Application started in 0.053 seconds. 2025-10-15 14:12:35.095 [DefaultDispatcher-worker-3 @coroutine#173] INFO io.ktor.server.Application - Responding at http://0.0.0.0:46565 2025-10-15 14:12:35.131 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46565/api/school/respect/person 2025-10-15 14:12:35.131 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46565/api/school/respect/person. 2025-10-15 14:12:35.131 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46565/api/school/respect/person 2025-10-15 14:12:35.134 [eventLoopGroupProxy-28-1 @call-handler#178] 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) 2025-10-15 14:12:35.136 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46565/api/school/respect/person 2025-10-15 14:12:35.136 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46565/api/school/respect/person 2025-10-15 14:12:35.136 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46565/api/school/respect/person 2025-10-15 14:12:35.136 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46565/api/school/respect/person. 2025-10-15 14:12:35.167 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z 2025-10-15 14:12:35.167 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z. 2025-10-15 14:12:35.167 [Test worker @coroutine#167] TRACE i.ktor.client.plugins.HttpPlainText - Adding Accept-Charset=UTF-8 to http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z 2025-10-15 14:12:35.168 [eventLoopGroupProxy-28-1 @call-handler#185] 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) 2025-10-15 14:12:35.169 [Test worker @coroutine#167] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z 2025-10-15 14:12:35.169 [Test worker @coroutine#167] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z 2025-10-15 14:12:35.170 [Test worker @coroutine#167] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z 2025-10-15 14:12:35.170 [Test worker @coroutine#167] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:46565/api/school/respect/person?since=2025-10-15T12%3A12%3A35.134Z.