2022-03-02 15:02:31.746 INFO 2310 --- [ Test worker] .b.t.c.SpringBootTestContextBootstrapper : Neither @ContextConfiguration nor @ContextHierarchy found for test class [delta.codecharacter.server.game.GameControllerIntegrationTest], using SpringBootContextLoader
2022-03-02 15:02:31.763 INFO 2310 --- [ Test worker] o.s.t.c.support.AbstractContextLoader : Could not detect default resource locations for test class [delta.codecharacter.server.game.GameControllerIntegrationTest]: no resource found for suffixes {-context.xml, Context.groovy}.
2022-03-02 15:02:31.764 INFO 2310 --- [ Test worker] t.c.s.AnnotationConfigContextLoaderUtils : Could not detect default configuration classes for test class [delta.codecharacter.server.game.GameControllerIntegrationTest]: GameControllerIntegrationTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2022-03-02 15:02:31.849 INFO 2310 --- [ Test worker] .b.t.c.SpringBootTestContextBootstrapper : Found @SpringBootConfiguration delta.codecharacter.server.ServerApplication for test class delta.codecharacter.server.game.GameControllerIntegrationTest
2022-03-02 15:02:31.854 INFO 2310 --- [ Test worker] .b.t.c.SpringBootTestContextBootstrapper : Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [com.ninjasquad.springmockk.MockkTestExecutionListener, com.ninjasquad.springmockk.ClearMocksTestExecutionListener, org.springframework.security.test.context.support.WithSecurityContextTestExecutionListener, org.springframework.security.test.context.support.ReactorContextTestExecutionListener, org.springframework.boot.test.autoconfigure.restdocs.RestDocsTestExecutionListener, org.springframework.boot.test.autoconfigure.web.client.MockRestServiceServerResetTestExecutionListener, org.springframework.boot.test.autoconfigure.web.servlet.MockMvcPrintOnlyOnFailureTestExecutionListener, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverTestExecutionListener, org.springframework.boot.test.autoconfigure.webservices.client.MockWebServiceServerTestExecutionListener, org.springframework.boot.test.mock.mockito.MockitoTestExecutionListener, org.springframework.boot.test.mock.mockito.ResetMocksTestExecutionListener, org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.event.ApplicationEventsTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
2022-03-02 15:02:31.867 INFO 2310 --- [ Test worker] .b.t.c.SpringBootTestContextBootstrapper : Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@159e6d3, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@22bd197, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@2d12248c, com.ninjasquad.springmockk.MockkTestExecutionListener@267d2d02, org.springframework.boot.test.mock.mockito.MockitoTestExecutionListener@685c2860, org.springframework.boot.test.autoconfigure.SpringBootDependencyInjectionTestExecutionListener@3427fb95, org.springframework.test.context.support.DirtiesContextTestExecutionListener@82d8fd9, org.springframework.test.context.transaction.TransactionalTestExecutionListener@4777a6e3, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@4e619945, org.springframework.security.test.context.support.WithSecurityContextTestExecutionListener@4591384f, org.springframework.test.context.event.EventPublishingTestExecutionListener@21a62463, org.springframework.security.test.context.support.ReactorContextTestExecutionListener@5b1cde0a, com.ninjasquad.springmockk.ClearMocksTestExecutionListener@19f5df9d, org.springframework.boot.test.autoconfigure.restdocs.RestDocsTestExecutionListener@556adfac, org.springframework.boot.test.autoconfigure.web.client.MockRestServiceServerResetTestExecutionListener@45ff6c5e, org.springframework.boot.test.autoconfigure.web.servlet.MockMvcPrintOnlyOnFailureTestExecutionListener@782e0665, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverTestExecutionListener@4f1037ca, org.springframework.boot.test.autoconfigure.webservices.client.MockWebServiceServerTestExecutionListener@4c84163b, org.springframework.boot.test.mock.mockito.ResetMocksTestExecutionListener@72a71e69]
2022-03-02 15:02:31.928 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:31.927+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn3","msg":"createCollection","attr":{"namespace":"test.user","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"c2989c50-3fba-44f4-903d-36813264bc82"}},"options":{}}}
2022-03-02 15:02:31.938 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:31.938+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn3","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"test.user","index":"_id_","commitTimestamp":null}}
2022-03-02 15:02:31.995 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:31.995+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn3","msg":"createCollection","attr":{"namespace":"test.game","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"80f5d874-5560-4662-b53c-113bb46baa02"}},"options":{}}}
2022-03-02 15:02:32.003 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.003+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn3","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"test.game","index":"_id_","commitTimestamp":null}}
2022-03-02 15:02:32.033 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.033+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn3","msg":"createCollection","attr":{"namespace":"test.game_log","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"a4137285-f490-482a-aa14-b8ee6967fbee"}},"options":{}}}
2022-03-02 15:02:32.041 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.041+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn3","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"test.game_log","index":"_id_","commitTimestamp":null}}
2022-03-02 15:02:32.145 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.145+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.user"}}
2022-03-02 15:02:32.146 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.145+00:00"},"s":"I", "c":"STORAGE", "id":20318, "ctx":"conn3","msg":"Finishing collection drop","attr":{"namespace":"test.user","uuid":{"uuid":{"$uuid":"c2989c50-3fba-44f4-903d-36813264bc82"}}}}
2022-03-02 15:02:32.146 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.145+00:00"},"s":"I", "c":"STORAGE", "id":22206, "ctx":"conn3","msg":"Deferring table drop for index","attr":{"index":"_id_","namespace":"test.user","uuid":{"uuid":{"$uuid":"c2989c50-3fba-44f4-903d-36813264bc82"}},"ident":"index-34--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.146 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.145+00:00"},"s":"I", "c":"STORAGE", "id":22214, "ctx":"conn3","msg":"Deferring table drop for collection","attr":{"namespace":"test.user","ident":"collection-33--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.151 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.151+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.game"}}
2022-03-02 15:02:32.151 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.151+00:00"},"s":"I", "c":"STORAGE", "id":20318, "ctx":"conn3","msg":"Finishing collection drop","attr":{"namespace":"test.game","uuid":{"uuid":{"$uuid":"80f5d874-5560-4662-b53c-113bb46baa02"}}}}
2022-03-02 15:02:32.152 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.151+00:00"},"s":"I", "c":"STORAGE", "id":22206, "ctx":"conn3","msg":"Deferring table drop for index","attr":{"index":"_id_","namespace":"test.game","uuid":{"uuid":{"$uuid":"80f5d874-5560-4662-b53c-113bb46baa02"}},"ident":"index-36--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.152 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.151+00:00"},"s":"I", "c":"STORAGE", "id":22214, "ctx":"conn3","msg":"Deferring table drop for collection","attr":{"namespace":"test.game","ident":"collection-35--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.157 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.156+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.game_log"}}
2022-03-02 15:02:32.157 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.156+00:00"},"s":"I", "c":"STORAGE", "id":20318, "ctx":"conn3","msg":"Finishing collection drop","attr":{"namespace":"test.game_log","uuid":{"uuid":{"$uuid":"a4137285-f490-482a-aa14-b8ee6967fbee"}}}}
2022-03-02 15:02:32.157 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.156+00:00"},"s":"I", "c":"STORAGE", "id":22206, "ctx":"conn3","msg":"Deferring table drop for index","attr":{"index":"_id_","namespace":"test.game_log","uuid":{"uuid":{"$uuid":"a4137285-f490-482a-aa14-b8ee6967fbee"}},"ident":"index-38--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.158 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.156+00:00"},"s":"I", "c":"STORAGE", "id":22214, "ctx":"conn3","msg":"Deferring table drop for collection","attr":{"namespace":"test.game_log","ident":"collection-37--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.196 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.195+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn3","msg":"createCollection","attr":{"namespace":"test.user","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"65eee0ff-cc9c-49f8-a258-364e40f2d0a6"}},"options":{}}}
2022-03-02 15:02:32.204 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.203+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"conn3","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"test.user","index":"_id_","commitTimestamp":null}}
2022-03-02 15:02:32.229 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.228+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.user"}}
2022-03-02 15:02:32.229 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.228+00:00"},"s":"I", "c":"STORAGE", "id":20318, "ctx":"conn3","msg":"Finishing collection drop","attr":{"namespace":"test.user","uuid":{"uuid":{"$uuid":"65eee0ff-cc9c-49f8-a258-364e40f2d0a6"}}}}
2022-03-02 15:02:32.230 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.228+00:00"},"s":"I", "c":"STORAGE", "id":22206, "ctx":"conn3","msg":"Deferring table drop for index","attr":{"index":"_id_","namespace":"test.user","uuid":{"uuid":{"$uuid":"65eee0ff-cc9c-49f8-a258-364e40f2d0a6"}},"ident":"index-40--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.230 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.229+00:00"},"s":"I", "c":"STORAGE", "id":22214, "ctx":"conn3","msg":"Deferring table drop for collection","attr":{"namespace":"test.user","ident":"collection-39--3213531206115516651","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}}
2022-03-02 15:02:32.232 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.231+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.game"}}
2022-03-02 15:02:32.236 INFO 2310 --- [ Thread-7] o.s.b.a.mongo.embedded.EmbeddedMongo : {"t":{"$date":"2022-03-02T15:02:32.236+00:00"},"s":"I", "c":"COMMAND", "id":518070, "ctx":"conn3","msg":"CMD: drop","attr":{"namespace":"test.game_log"}}