Gradle Test Run :respect-datalayer-repository:jvmTest[jvm]
givenRequestMade_whenDataChangedAndNextRequestSinceParamSetToPreviousConsistentThroughValue_thenRemoteResultShouldBeUpdated[jvm]
summary
|
100%
successful |
standard output
2026-08-18 23:10:09.440 [Test worker @coroutine#196] INFO io.ktor.server.Application - Autoreload is disabled because the development mode is off.
2026-08-18 23:10:09.441 [Test worker @coroutine#196] INFO io.ktor.server.Application - Application started in 0.04 seconds.
2026-08-18 23:10:09.442 [DefaultDispatcher-worker-3 @coroutine#205] INFO io.ktor.server.Application - Responding at http://0.0.0.0:41203
2026-08-18 23:10:09.444 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41203/api/school/respect/person?includeRelated=false
2026-08-18 23:10:09.444 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41203/api/school/respect/person?includeRelated=false.
2026-08-18 23:10:09.446 [eventLoopGroupProxy-28-1 @call-handler#209] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
/api, segment:1 -> SUCCESS @ /api
/api/school, segment:2 -> SUCCESS @ /api/school
/api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
/api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
/api/school/respect/person [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:GET)]
/api/school/respect/person [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:POST)]
Matched routes:
"" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
SUCCESS @ /api/school/respect/person [(method:GET)]
2026-08-18 23:10:09.450 [Test worker @coroutine#196] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41203/api/school/respect/person?includeRelated=false
2026-08-18 23:10:09.450 [Test worker @coroutine#196] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41203/api/school/respect/person?includeRelated=false
2026-08-18 23:10:09.450 [Test worker @coroutine#196] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41203/api/school/respect/person?includeRelated=false
2026-08-18 23:10:09.451 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41203/api/school/respect/person?includeRelated=false.
DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-08-18T19:10:09.340Z, stored=2026-08-18T19:10:09.489Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1787080209340, lastStored=1787080209489, etag=null, url=http://localhost:41203/api/school/respect/person?includeRelated=false, consistentThrough=2026-08-18T19:10:09.489904367Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-08-18T19:10:09.340Z, stored=2026-08-18T19:10:09.489Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1787080209340, lastStored=1787080209489, etag=null, url=null, consistentThrough=2026-08-18T19:10:09.489904367Z, validationInfoKey=0, varyHeader=null, headers=null, permissionsLastModified=null), localState=null, remoteState=null), remoteState=DataReadyState(data=[Person(guid=4242, userActive=true, status=ACTIVE, lastModified=2026-08-18T19:10:09.340Z, stored=2026-08-18T19:10:09.400Z, metadata=null, userMasterIdentifier=null, username=null, givenName=Admin, familyName=User, middleName=null, gender=UNSPECIFIED, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SYSTEM_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null), Person(guid=42, userActive=true, status=ACTIVE, lastModified=2026-08-18T19:10:09.338Z, stored=2026-08-18T19:10:09.442Z, metadata=null, userMasterIdentifier=null, username=test, givenName=test, familyName=test, middleName=null, gender=FEMALE, preferredFirstName=null, preferredMiddleName=null, preferredLastName=null, pronouns=null, roles=[PersonRole(isPrimaryRole=true, roleEnum=SITE_ADMINISTRATOR, beginDate=null, endDate=null)], relatedPersonUids=[], dateOfBirth=null, email=null, phoneNumber=null)], metaInfo=DataLoadMetaInfo(lastModified=1787080209000, lastStored=-1, etag=null, url=http://localhost:41203/api/school/respect/person?includeRelated=false, consistentThrough=2026-08-18T19:10:09.447090853Z, validationInfoKey=7092960727423664838, varyHeader=Authorization, headers=io.ktor.client.engine.okhttp.OkUtilsKt$fromOkHttp$1@2c2aab92, permissionsLastModified=null), localState=null, remoteState=null))
2026-08-18 23:10:09.493 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Adding Accept=application/json header for http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false
2026-08-18 23:10:09.493 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Body type class io.ktor.client.utils.EmptyContent is in ignored types. Skipping ContentNegotiation for http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false.
2026-08-18 23:10:09.494 [eventLoopGroupProxy-28-1 @call-handler#216] TRACE io.ktor.server.routing.Routing - Trace for [api, school, respect, person]
/, segment:0 -> SUCCESS @ /
/api, segment:1 -> SUCCESS @ /api
/api/school, segment:2 -> SUCCESS @ /api/school
/api/school/respect, segment:3 -> SUCCESS @ /api/school/respect
/api/school/respect/person, segment:4 -> SUCCESS @ /api/school/respect/person
/api/school/respect/person [(method:GET)], segment:4 -> SUCCESS @ /api/school/respect/person [(method:GET)]
/api/school/respect/person [(method:POST)], segment:4 -> FAILURE "Selector didn't match" @ /api/school/respect/person [(method:POST)]
Matched routes:
"" -> "api" -> "school" -> "respect" -> "person" -> "(method:GET)"
Routing resolve result:
SUCCESS @ /api/school/respect/person [(method:GET)]
2026-08-18 23:10:09.496 [Test worker @coroutine#196] TRACE io.ktor.client.plugins.SaveBody - Saving body for http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false
2026-08-18 23:10:09.496 [Test worker @coroutine#196] TRACE i.k.client.plugins.HttpCallValidator - Validating response for request http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false
2026-08-18 23:10:09.496 [Test worker @coroutine#196] TRACE i.k.c.p.DefaultResponseValidation - Skipping default response validation for http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false
2026-08-18 23:10:09.497 [Test worker @coroutine#196] TRACE i.k.c.p.c.ContentNegotiation - Response body was converted to class java.util.ArrayList for http://localhost:41203/api/school/respect/person?since=2026-08-18T19%3A10%3A09.447090853Z&includeRelated=false.
Run time: 55.543308ms
error output
Aug 18, 2026 11:10:09 PM io.github.aakira.napier.DebugAntilog performLog FINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000) Aug 18, 2026 11:10:09 PM io.github.aakira.napier.DebugAntilog performLog FINE: [DEBUG] DelegatedInvalidationPagingSource$onSrcInvalidated - RPaging/DelegatedInvalidationPagingSource(extra=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=null, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))) src invalidated Aug 18, 2026 11:10:09 PM io.github.aakira.napier.DebugAntilog performLog FINE: [DEBUG] MapPagingSource$load - MapPagingSource(tag=PersonDataSourceDb/listAsPagingSource(params=GetListParams(common=GetListCommonParams(guid=null, searchQuery=null, since=2026-08-18T19:10:09.447090853Z, sinceIfPermissionsNotChangedSince=null, includeDeleted=null), filterByClazzUid=null, filterByEnrolmentRole=null, filterByName=null, filterByPersonStatus=null, filterByPersonRole=null, includeRelated=false, inClassOnDay=null))): load Refresh(key=0, loadSize=1000)