14:02:25.070 [Test worker] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating CacheAwareContextLoaderDelegate from class [org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate]
14:02:25.109 [Test worker] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating BootstrapContext using constructor [public org.springframework.test.context.support.DefaultBootstrapContext(java.lang.Class,org.springframework.test.context.CacheAwareContextLoaderDelegate)]
14:02:25.163 [Test worker] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating TestContextBootstrapper for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests] from class [org.springframework.boot.test.context.SpringBootTestContextBootstrapper]
14:02:25.187 [Test worker] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper - Neither @ContextConfiguration nor @ContextHierarchy found for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests], using SpringBootContextLoader
14:02:25.193 [Test worker] DEBUG org.springframework.test.context.support.AbstractContextLoader - Did not detect default resource location for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]: class path resource [uk/gov/dhsc/htbhf/dwp/DWPIntegrationTests-context.xml] does not exist
14:02:25.194 [Test worker] DEBUG org.springframework.test.context.support.AbstractContextLoader - Did not detect default resource location for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]: class path resource [uk/gov/dhsc/htbhf/dwp/DWPIntegrationTestsContext.groovy] does not exist
14:02:25.194 [Test worker] INFO org.springframework.test.context.support.AbstractContextLoader - Could not detect default resource locations for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]: no resource found for suffixes {-context.xml, Context.groovy}.
14:02:25.195 [Test worker] INFO org.springframework.test.context.support.AnnotationConfigContextLoaderUtils - Could not detect default configuration classes for test class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]: DWPIntegrationTests does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
14:02:25.256 [Test worker] DEBUG org.springframework.test.util.ReflectionTestUtils - Getting field 'configuration' from target object [org.flywaydb.core.Flyway@601bc9f0] or target class [class org.flywaydb.core.Flyway]
14:02:25.258 [Test worker] DEBUG org.springframework.test.util.ReflectionTestUtils - Invoking method 'getUndoSqlMigrationPrefix' on target object [org.flywaydb.core.api.configuration.ClassicConfiguration@3a0fc508] or target class [null] with arguments {}
14:02:25.300 [Test worker] DEBUG org.springframework.test.context.support.ActiveProfilesUtils - Could not find an 'annotation declaring class' for annotation type [org.springframework.test.context.ActiveProfiles] and class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]
14:02:25.445 [Test worker] DEBUG org.springframework.context.annotation.ClassPathScanningCandidateComponentProvider - Identified candidate component class: file [/home/circleci/project/api/build/classes/java/main/uk/gov/dhsc/htbhf/dwp/DWPApplication.class]
14:02:25.446 [Test worker] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper - Found @SpringBootConfiguration uk.gov.dhsc.htbhf.dwp.DWPApplication for test class uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests
14:02:25.578 [Test worker] DEBUG org.springframework.boot.test.context.SpringBootTestContextBootstrapper - @TestExecutionListeners is not present for class [uk.gov.dhsc.htbhf.dwp.DWPIntegrationTests]: using defaults.
14:02:25.579 [Test worker] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper - Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.cloud.contract.stubrunner.provider.wiremock.StubRunnerWireMockTestExecutionListener, org.springframework.cloud.contract.wiremock.WireMockTestExecutionListener, 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.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.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, io.zonky.test.db.flyway.OptimizedFlywayTestExecutionListener]
14:02:25.611 [Test worker] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper - Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@60e17cf1, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@2f61c21b, org.springframework.boot.test.mock.mockito.MockitoTestExecutionListener@11b3abba, org.springframework.boot.test.autoconfigure.SpringBootDependencyInjectionTestExecutionListener@69506224, org.springframework.test.context.support.DirtiesContextTestExecutionListener@2bd9d0b, io.zonky.test.db.flyway.OptimizedFlywayTestExecutionListener@236de65d, org.springframework.test.context.transaction.TransactionalTestExecutionListener@2f0f77f1, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@45a46176, org.springframework.test.context.event.EventPublishingTestExecutionListener@2b9ff90c, org.springframework.boot.test.autoconfigure.restdocs.RestDocsTestExecutionListener@678cad2c, org.springframework.boot.test.autoconfigure.web.client.MockRestServiceServerResetTestExecutionListener@33e8eed3, org.springframework.boot.test.autoconfigure.web.servlet.MockMvcPrintOnlyOnFailureTestExecutionListener@55218609, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverTestExecutionListener@1a25238, org.springframework.boot.test.mock.mockito.ResetMocksTestExecutionListener@3457aed, org.springframework.cloud.contract.stubrunner.provider.wiremock.StubRunnerWireMockTestExecutionListener@772f9220, org.springframework.cloud.contract.wiremock.WireMockTestExecutionListener@2ee75302]
14:02:25.619 [Test worker] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - Before test class: context [DefaultTestContext@74a12b84 testClass = DWPIntegrationTests, testInstance = [null], testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@79f985c3 testClass = DWPIntegrationTests, locations = '{}', classes = '{class uk.gov.dhsc.htbhf.dwp.DWPApplication}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{org.springframework.boot.test.context.SpringBootTestContextBootstrapper=true, server.port=0}', contextCustomizers = set[org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@810a4eb1, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@50434a93, [ImportsContextCustomizer@3a6d18de key = [org.springframework.cloud.contract.wiremock.WireMockRestTemplateConfiguration, org.springframework.cloud.contract.wiremock.WireMockConfiguration]], org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@2c888e3d, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@60c97890, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.web.client.TestRestTemplateContextCustomizer@5cfad7f2, io.zonky.test.db.postgres.EmbeddedPostgresContextCustomizerFactory$PreloadableEmbeddedPostgresContextCustomizer@b450baa9], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.boot.test.context.SpringBootContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.activateListener' -> false]], class annotated with @DirtiesContext [false] with mode [null].
14:02:25.659 [Test worker] DEBUG org.springframework.test.context.support.TestPropertySourceUtils - Adding inlined properties to environment: {spring.jmx.enabled=false, org.springframework.boot.test.context.SpringBootTestContextBootstrapper=true, server.port=0}
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v2.2.2.RELEASE)
2020-01-24 14:02:26.211 INFO 706 --- [ Test worker] u.g.dhsc.htbhf.dwp.DWPIntegrationTests : Starting DWPIntegrationTests on a43fb2d2eb54 with PID 706 (started by circleci in /home/circleci/project/api)
2020-01-24 14:02:26.213 INFO 706 --- [ Test worker] u.g.dhsc.htbhf.dwp.DWPIntegrationTests : No active profile set, falling back to default profiles: default
2020-01-24 14:02:28.233 INFO 706 --- [ Test worker] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2020-01-24 14:02:28.310 INFO 706 --- [ Test worker] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 65ms. Found 1 JPA repository interfaces.
2020-01-24 14:02:28.436 INFO 706 --- [ Test worker] EmbeddedPostgresContextCustomizerFactory : Replacing 'dataSource' DataSource bean with embedded version
2020-01-24 14:02:29.047 INFO 706 --- [ Test worker] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2020-01-24 14:02:29.874 INFO 706 --- [ Test worker] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 0 (http)
2020-01-24 14:02:29.894 INFO 706 --- [ Test worker] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2020-01-24 14:02:29.894 INFO 706 --- [ Test worker] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.29]
2020-01-24 14:02:30.055 INFO 706 --- [ Test worker] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2020-01-24 14:02:30.055 INFO 706 --- [ Test worker] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 3351 ms
2020-01-24 14:02:30.459 INFO 706 --- [ Test worker] eProvider$PriorityThreadPoolTaskExecutor : Initializing ExecutorService
2020-01-24 14:02:30.947 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : Detected a Linux x86_64 system
2020-01-24 14:02:30.961 INFO 706 --- [ prefetching-1] .z.t.d.p.e.DefaultPostgresBinaryResolver : Detected distribution: 'Debian'
2020-01-24 14:02:30.966 INFO 706 --- [ prefetching-1] .z.t.d.p.e.DefaultPostgresBinaryResolver : System specific postgres binaries found: postgres-linux-x86_64.txz
2020-01-24 14:02:31.047 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : Extracting Postgres...
2020-01-24 14:02:33.478 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : Postgres binaries at /tmp/embedded-pg/PG-7010611ea87e721fb4b2e2a8657cce54
2020-01-24 14:02:33.494 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : The files belonging to this database system will be owned by user "circleci".
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : This user must also own the server process.
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres :
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : The database cluster will be initialized with locale "C.UTF-8".
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : The default text search configuration will be set to "english".
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres :
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : Data page checksums are disabled.
2020-01-24 14:02:33.495 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres :
2020-01-24 14:02:33.496 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : fixing permissions on existing directory /tmp/epg14230352086910862265 ... ok
2020-01-24 14:02:33.498 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : creating subdirectories ... ok
2020-01-24 14:02:33.510 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : selecting default max_connections ... 100
2020-01-24 14:02:33.528 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : selecting default shared_buffers ... 128MB
2020-01-24 14:02:33.529 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : selecting dynamic shared memory implementation ... posix
2020-01-24 14:02:33.789 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : creating configuration files ... ok
2020-01-24 14:02:33.942 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : running bootstrap script ... ok
2020-01-24 14:02:34.476 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : performing post-bootstrap initialization ... ok
2020-01-24 14:02:35.848 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : syncing data to disk ... ok
2020-01-24 14:02:35.849 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres :
2020-01-24 14:02:35.849 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres : Success. You can now start the database server using:
2020-01-24 14:02:35.849 INFO 706 --- [initdb:pid(778)] i.z.t.d.p.embedded.EmbeddedPostgres :
2020-01-24 14:02:35.849 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : 1c35f806-979a-495a-94b4-095580a19a3e initdb completed in 00:00:02.368
2020-01-24 14:02:35.858 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : 1c35f806-979a-495a-94b4-095580a19a3e postmaster started as Process[pid=792, exitValue="not exited"] on port 36509. Waiting up to PT20S for server startup to finish.
2020-01-24 14:02:35.877 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : waiting for server to start....2020-01-24 14:02:35.877 UTC [796] LOG: listening on IPv4 address "127.0.0.1", port 36509
2020-01-24 14:02:35.878 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.877 UTC [796] LOG: could not bind IPv4 address "127.0.0.1": Address already in use
2020-01-24 14:02:35.878 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.877 UTC [796] HINT: Is another postmaster already running on port 36509? If not, wait a few seconds and retry.
2020-01-24 14:02:35.878 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.877 UTC [796] LOG: could not bind IPv6 address "::1": Cannot assign requested address
2020-01-24 14:02:35.878 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.877 UTC [796] HINT: Is another postmaster already running on port 36509? If not, wait a few seconds and retry.
2020-01-24 14:02:35.879 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.877 UTC [796] LOG: listening on Unix socket "/tmp/.s.PGSQL.36509"
2020-01-24 14:02:35.894 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.894 UTC [797] LOG: database system was shut down at 2020-01-24 14:02:34 UTC
2020-01-24 14:02:35.896 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : 2020-01-24 14:02:35.896 UTC [796] LOG: database system is ready to accept connections
2020-01-24 14:02:35.965 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : done
2020-01-24 14:02:35.966 INFO 706 --- [pg_ctl:pid(792)] i.z.t.d.p.embedded.EmbeddedPostgres : server started
2020-01-24 14:02:36.094 INFO 706 --- [ prefetching-1] i.z.t.d.p.embedded.EmbeddedPostgres : 1c35f806-979a-495a-94b4-095580a19a3e postmaster startup finished in 00:00:00.238
2020-01-24 14:02:36.375 INFO 706 --- [ prefetching-2] o.f.c.internal.license.VersionPrinter : Flyway Community Edition 5.2.4 by Boxfuse
2020-01-24 14:02:36.406 INFO 706 --- [ prefetching-2] o.f.c.internal.database.DatabaseFactory : Database: jdbc:postgresql://localhost:36509/kkqgfdqgtskr (PostgreSQL 10.7)
2020-01-24 14:02:36.480 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbValidate : Successfully validated 9 migrations (execution time 00:00.035s)
2020-01-24 14:02:36.493 INFO 706 --- [ prefetching-2] o.f.c.i.s.JdbcTableSchemaHistory : Creating Schema History table: "public"."flyway_schema_history"
2020-01-24 14:02:36.525 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Current version of schema "public": << Empty Schema >>
2020-01-24 14:02:36.527 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.001 - initialscript
2020-01-24 14:02:36.538 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.002 - UC datafeed initial format
2020-01-24 14:02:36.554 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.003 - legacy datafeed initial format
2020-01-24 14:02:36.578 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.004 - UC replace flags with boolean
2020-01-24 14:02:36.603 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.005 - fix nino length
2020-01-24 14:02:36.608 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.006 - drop unused tables
2020-01-24 14:02:36.617 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.007 - add mobile and email
2020-01-24 14:02:36.622 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.008 - delete unused columns
2020-01-24 14:02:36.628 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version 1.009 - add adult dob
2020-01-24 14:02:36.632 INFO 706 --- [ prefetching-2] o.f.core.internal.command.DbMigrate : Successfully applied 9 migrations to schema "public" (execution time 00:00.139s)
2020-01-24 14:02:36.914 INFO 706 --- [ Test worker] i.z.t.d.l.EmbeddedDatabaseReporter : JDBC URL to connect to the embedded database: jdbc:postgresql://localhost:36509/efjhdavquuxa?user=postgres
2020-01-24 14:02:36.940 INFO 706 --- [ Test worker] o.f.core.internal.command.DbValidate : Successfully validated 9 migrations (execution time 00:00.011s)
2020-01-24 14:02:36.944 INFO 706 --- [ Test worker] o.f.core.internal.command.DbMigrate : Current version of schema "public": 1.009
2020-01-24 14:02:36.945 INFO 706 --- [ Test worker] o.f.core.internal.command.DbMigrate : Schema "public" is up to date. No migration necessary.
2020-01-24 14:02:37.102 INFO 706 --- [ Test worker] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: default]
2020-01-24 14:02:37.221 INFO 706 --- [ Test worker] org.hibernate.Version : HHH000412: Hibernate Core {5.4.9.Final}
2020-01-24 14:02:37.427 INFO 706 --- [ Test worker] o.hibernate.annotations.common.Version : HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
2020-01-24 14:02:37.631 INFO 706 --- [ Test worker] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL10Dialect
2020-01-24 14:02:38.679 INFO 706 --- [ Test worker] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2020-01-24 14:02:38.689 INFO 706 --- [ Test worker] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default'
2020-01-24 14:02:39.651 WARN 706 --- [ Test worker] JpaBaseConfiguration$JpaWebConfiguration : spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning
2020-01-24 14:02:39.876 INFO 706 --- [ Test worker] o.s.b.a.e.web.EndpointLinksResolver : Exposing 2 endpoint(s) beneath base path '/actuator'
2020-01-24 14:02:40.455 INFO 706 --- [ Test worker] wiremock.org.eclipse.jetty.util.log : Logging initialized @16757ms
2020-01-24 14:02:40.691 INFO 706 --- [ Test worker] pertySourcedRequestMappingHandlerMapping : Mapped URL path [/v2/api-docs] onto method [springfox.documentation.swagger2.web.Swagger2Controller#getDocumentation(String, HttpServletRequest)]
2020-01-24 14:02:40.990 INFO 706 --- [ Test worker] o.s.s.concurrent.ThreadPoolTaskExecutor : Initializing ExecutorService 'applicationTaskExecutor'
2020-01-24 14:02:41.452 INFO 706 --- [ Test worker] w.org.eclipse.jetty.server.Server : jetty-9.2.z-SNAPSHOT
2020-01-24 14:02:41.476 INFO 706 --- [ Test worker] w.o.e.j.server.handler.ContextHandler : Started w.o.e.j.s.ServletContextHandler@4598d0a5{/__admin,null,AVAILABLE}
2020-01-24 14:02:41.477 INFO 706 --- [ Test worker] w.o.e.j.server.handler.ContextHandler : Started w.o.e.j.s.ServletContextHandler@79242b91{/,null,AVAILABLE}
2020-01-24 14:02:41.486 INFO 706 --- [ Test worker] w.o.e.j.s.NetworkTrafficServerConnector : Started NetworkTrafficServerConnector@67cefbb7{HTTP/1.1}{0.0.0.0:8120}
2020-01-24 14:02:41.486 INFO 706 --- [ Test worker] w.org.eclipse.jetty.server.Server : Started @17788ms
2020-01-24 14:02:41.487 INFO 706 --- [ Test worker] d.s.w.p.DocumentationPluginsBootstrapper : Context refreshed
2020-01-24 14:02:41.503 INFO 706 --- [ Test worker] d.s.w.p.DocumentationPluginsBootstrapper : Found 1 custom documentation plugin(s)
2020-01-24 14:02:41.533 INFO 706 --- [ Test worker] s.d.s.w.s.ApiListingReferenceScanner : Scanning for api listing references
2020-01-24 14:02:41.773 INFO 706 --- [ Test worker] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 41227 (http) with context path ''
2020-01-24 14:02:41.775 INFO 706 --- [ Test worker] u.g.dhsc.htbhf.dwp.DWPIntegrationTests : Started DWPIntegrationTests in 16.112 seconds (JVM running for 18.077)
2020-01-24 14:02:42.323 INFO 706 --- [o-auto-1-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2020-01-24 14:02:42.324 INFO 706 --- [o-auto-1-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2020-01-24 14:02:42.341 INFO 706 --- [o-auto-1-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 17 ms
2020-01-24 14:02:42.877 INFO 706 --- [tp1235122726-50] / : RequestHandlerClass from context returned com.github.tomakehurst.wiremock.http.StubRequestHandler. Normalized mapped under returned 'null'
2020-01-24 14:02:43.249 INFO 706 --- [tp1235122726-50] WireMock : Request received:
127.0.0.1 - GET /v2/dwp/benefits
mobilePhoneNumber: [+447700900000]
Accept: [application/json, application/*+json]
postcode: [AA1 1AA]
ucMonthlyIncomeThreshold: [40800]
User-Agent: [Java/11.0.4]
Connection: [keep-alive]
dateOfBirth: [1985-12-31]
X-REQUEST-ID: [ebbb2757-da5e-4031-9c91-15e1dc288b94]
Host: [localhost:8120]
nino: [MC123456C]
emailAddress: [homer@simpson.com]
surname: [Simpson]
addressLine1: [742 Evergreen Terrace]
eligibilityEndDate: [2020-02-21]
pregnantDependentDob: [2019-07-24]
X-SESSION-ID: []
Matched response definition:
{
"status" : 200,
"body" : "{\"eligibilityStatus\":\"confirmed\",\"deathVerificationFlag\":\"n/a\",\"mobilePhoneMatch\":\"matched\",\"emailAddressMatch\":\"matched\",\"addressLine1Match\":\"matched\",\"postcodeMatch\":\"matched\",\"pregnantChildDOBMatch\":\"not_supplied\",\"qualifyingBenefits\":\"universal_credit\",\"householdIdentifier\":\"\",\"dobOfChildrenUnder4\":[\"2019-07-24\",\"2018-01-24\"],\"identityStatus\":\"matched\"}",
"headers" : {
"Content-Type" : "application/json"
}
}
Response:
HTTP/1.1 200
Content-Type: [application/json]
Matched-Stub-Id: [34ad28f1-944f-4bf9-94e1-c8b70f759599]
2020-01-24 14:02:43.315 ERROR 706 --- [o-auto-1-exec-3] u.g.d.htbhf.errorhandler.ErrorHandler : Binding error(s) during incoming GET request to /v2/dwp/eligibility: [ErrorResponse.FieldError(field=person.nino, message=must match "^(?!BG|GB|NK|KN|TN|NT|ZZ)[A-CEGHJ-PR-TW-Z][A-CEGHJ-NPR-TW-Z](\d{6})[A-D]$")]
2020-01-24 14:02:43.395 WARN 706 --- [ Test worker] o.s.c.c.w.WireMockTestExecutionListener : You've used fixed ports for WireMock setup - will mark context as dirty. Please use random ports, as much as possible. Your tests will be faster and more reliable and this warning will go away
2020-01-24 14:02:43.402 INFO 706 --- [ Test worker] w.o.e.j.s.NetworkTrafficServerConnector : Stopped NetworkTrafficServerConnector@67cefbb7{HTTP/1.1}{0.0.0.0:8120}
2020-01-24 14:02:43.404 INFO 706 --- [ Test worker] w.o.e.j.server.handler.ContextHandler : Stopped w.o.e.j.s.ServletContextHandler@79242b91{/,null,UNAVAILABLE}
2020-01-24 14:02:43.404 INFO 706 --- [ Test worker] w.o.e.j.server.handler.ContextHandler : Stopped w.o.e.j.s.ServletContextHandler@4598d0a5{/__admin,null,UNAVAILABLE}
2020-01-24 14:02:43.405 WARN 706 --- [ Test worker] w.o.e.j.util.thread.QueuedThreadPool : qtp1235122726{STOPPING,8<=8<=10,i=3,q=5} Couldn't stop Thread[qtp1235122726-47,5,]
2020-01-24 14:02:43.405 WARN 706 --- [ Test worker] w.o.e.j.util.thread.QueuedThreadPool : qtp1235122726{STOPPING,8<=8<=10,i=0,q=4} Couldn't stop Thread[qtp1235122726-52,5,]
2020-01-24 14:02:43.406 INFO 706 --- [ Test worker] o.s.s.concurrent.ThreadPoolTaskExecutor : Shutting down ExecutorService 'applicationTaskExecutor'
2020-01-24 14:02:43.408 INFO 706 --- [ Test worker] j.LocalContainerEntityManagerFactoryBean : Closing JPA EntityManagerFactory for persistence unit 'default'