11:01:10.450 [Test worker] INFO org.springframework.test.context.support.AnnotationConfigContextLoaderUtils -- Could not detect default configuration classes for test class [com.comp5348.group06.bank.RefundIntegrationTest]: RefundIntegrationTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
11:01:10.632 [Test worker] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper -- Found @SpringBootConfiguration com.comp5348.group06.bank.BankApplication for test class com.comp5348.group06.bank.RefundIntegrationTest
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.3.3)
2026-10-18T11:01:11.137Z INFO 2419 --- [ Test worker] c.c.group06.bank.RefundIntegrationTest : Starting RefundIntegrationTest using Java 17.0.20.1 with PID 2419 (started by runner in /home/runner/work/comp5348-ci-relay/comp5348-ci-relay/repo/bank)
2026-10-18T11:01:11.141Z INFO 2419 --- [ Test worker] c.c.group06.bank.RefundIntegrationTest : No active profile set, falling back to 1 default profile: "default"
2026-10-18T11:01:12.469Z INFO 2419 --- [ Test worker] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2026-10-18T11:01:12.524Z INFO 2419 --- [ Test worker] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 47 ms. Found 2 JPA repository interfaces.
2026-10-18T11:01:13.283Z INFO 2419 --- [ Test worker] org.testcontainers.images.PullPolicy : Image pull policy will be performed by: DefaultPullPolicy()
2026-10-18T11:01:13.287Z INFO 2419 --- [ Test worker] o.t.utility.ImageNameSubstitutor : Image name substitution will be performed by: DefaultImageNameSubstitutor (composite of 'ConfigurationFileImageNameSubstitutor' and 'PrefixingImageNameSubstitutor')
2026-10-18T11:01:13.311Z INFO 2419 --- [ Test worker] org.testcontainers.DockerClientFactory : Testcontainers version: 1.21.4
2026-10-18T11:01:13.829Z INFO 2419 --- [ Test worker] o.t.d.DockerClientProviderStrategy : Found Docker environment with local Unix socket (unix:///var/run/docker.sock)
2026-10-18T11:01:13.833Z INFO 2419 --- [ Test worker] org.testcontainers.DockerClientFactory : Docker host IP address is localhost
2026-10-18T11:01:13.854Z INFO 2419 --- [ Test worker] org.testcontainers.DockerClientFactory : Connected to docker:
Server Version: 28.0.4
API Version: 1.48
Operating System: Ubuntu 24.04.5 LTS
Total Memory: 7938 MB
2026-10-18T11:01:13.888Z INFO 2419 --- [ Test worker] tc.testcontainers/ryuk:0.12.0 : Pulling docker image: testcontainers/ryuk:0.12.0. Please be patient; this may take some time but only needs to be done once.
2026-10-18T11:01:14.223Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Starting to pull image
2026-10-18T11:01:14.246Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 0 pending, 0 downloaded, 0 extracted, (0 bytes/0 bytes)
2026-10-18T11:01:14.504Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 2 pending, 1 downloaded, 0 extracted, (906 KB/? MB)
2026-10-18T11:01:14.550Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 1 pending, 2 downloaded, 0 extracted, (906 KB/? MB)
2026-10-18T11:01:14.566Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 0 pending, 3 downloaded, 0 extracted, (6 MB/11 MB)
2026-10-18T11:01:14.692Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 0 pending, 3 downloaded, 1 extracted, (9 MB/11 MB)
2026-10-18T11:01:14.815Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 0 pending, 3 downloaded, 2 extracted, (9 MB/11 MB)
2026-10-18T11:01:14.858Z INFO 2419 --- [eam--1900126211] tc.testcontainers/ryuk:0.12.0 : Pulling image layers: 0 pending, 3 downloaded, 3 extracted, (11 MB/11 MB)
2026-10-18T11:01:14.864Z INFO 2419 --- [ Test worker] tc.testcontainers/ryuk:0.12.0 : Image testcontainers/ryuk:0.12.0 pull took PT0.972867221S
2026-10-18T11:01:14.891Z INFO 2419 --- [ Test worker] tc.testcontainers/ryuk:0.12.0 : Creating container for image: testcontainers/ryuk:0.12.0
2026-10-18T11:01:14.976Z INFO 2419 --- [ Test worker] tc.testcontainers/ryuk:0.12.0 : Container testcontainers/ryuk:0.12.0 is starting: f500fef7105cd245240888a9e3a0b854977ef29619a0db4210def5606a9bcb0c
2026-10-18T11:01:15.335Z INFO 2419 --- [ Test worker] tc.testcontainers/ryuk:0.12.0 : Container testcontainers/ryuk:0.12.0 started in PT0.444173562S
2026-10-18T11:01:15.341Z INFO 2419 --- [ Test worker] o.t.utility.RyukResourceReaper : Ryuk started - will monitor and terminate Testcontainers containers on JVM exit
2026-10-18T11:01:15.341Z INFO 2419 --- [ Test worker] org.testcontainers.DockerClientFactory : Checking the system...
2026-10-18T11:01:15.342Z INFO 2419 --- [ Test worker] org.testcontainers.DockerClientFactory : ✔︎ Docker server version should be at least 1.6.0
2026-10-18T11:01:15.345Z INFO 2419 --- [ Test worker] tc.postgres:17 : Pulling docker image: postgres:17. Please be patient; this may take some time but only needs to be done once.
2026-10-18T11:01:15.596Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Starting to pull image
2026-10-18T11:01:15.597Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 0 downloaded, 0 extracted, (0 bytes/0 bytes)
2026-10-18T11:01:15.746Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 13 pending, 1 downloaded, 0 extracted, (1 KB/? MB)
2026-10-18T11:01:15.876Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 12 pending, 2 downloaded, 0 extracted, (4 MB/? MB)
2026-10-18T11:01:15.886Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 11 pending, 3 downloaded, 0 extracted, (11 MB/? MB)
2026-10-18T11:01:15.972Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 10 pending, 4 downloaded, 0 extracted, (11 MB/? MB)
2026-10-18T11:01:16.028Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 9 pending, 5 downloaded, 0 extracted, (11 MB/? MB)
2026-10-18T11:01:16.039Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 8 pending, 6 downloaded, 0 extracted, (11 MB/? MB)
2026-10-18T11:01:16.075Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 7 pending, 7 downloaded, 0 extracted, (17 MB/? MB)
2026-10-18T11:01:16.106Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 6 pending, 8 downloaded, 0 extracted, (17 MB/? MB)
2026-10-18T11:01:16.144Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 5 pending, 9 downloaded, 0 extracted, (17 MB/? MB)
2026-10-18T11:01:16.183Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 4 pending, 10 downloaded, 0 extracted, (17 MB/? MB)
2026-10-18T11:01:16.211Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 3 pending, 11 downloaded, 0 extracted, (17 MB/? MB)
2026-10-18T11:01:16.268Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 2 pending, 12 downloaded, 0 extracted, (26 MB/? MB)
2026-10-18T11:01:16.286Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 1 pending, 13 downloaded, 0 extracted, (26 MB/? MB)
2026-10-18T11:01:16.690Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 0 extracted, (127 MB/153 MB)
2026-10-18T11:01:17.469Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 1 extracted, (141 MB/153 MB)
2026-10-18T11:01:18.317Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 2 extracted, (141 MB/153 MB)
2026-10-18T11:01:18.533Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 3 extracted, (143 MB/153 MB)
2026-10-18T11:01:18.583Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 4 extracted, (144 MB/153 MB)
2026-10-18T11:01:18.954Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 5 extracted, (146 MB/153 MB)
2026-10-18T11:01:19.054Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 6 extracted, (148 MB/153 MB)
2026-10-18T11:01:19.063Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 7 extracted, (148 MB/153 MB)
2026-10-18T11:01:19.074Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 8 extracted, (148 MB/153 MB)
2026-10-18T11:01:23.653Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 9 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.672Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 10 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.687Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 11 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.704Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 12 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.713Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 13 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.723Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pulling image layers: 0 pending, 14 downloaded, 14 extracted, (153 MB/153 MB)
2026-10-18T11:01:23.731Z INFO 2419 --- [ Test worker] tc.postgres:17 : Image postgres:17 pull took PT8.385002875S
2026-10-18T11:01:23.731Z INFO 2419 --- [tream-765662645] tc.postgres:17 : Pull complete. 14 layers, pulled in 8s (downloaded 153 MB at 19 MB/s)
2026-10-18T11:01:23.734Z INFO 2419 --- [ Test worker] tc.postgres:17 : Creating container for image: postgres:17
2026-10-18T11:01:23.752Z INFO 2419 --- [ Test worker] tc.postgres:17 : Container postgres:17 is starting: 74f52d75ce5909a03b89c777ebf9630d5bc9c487be0adecb31fc05d40e8ae4bb
2026-10-18T11:01:24.935Z INFO 2419 --- [ Test worker] tc.postgres:17 : Container postgres:17 started in PT1.201219283S
2026-10-18T11:01:24.938Z INFO 2419 --- [ Test worker] tc.postgres:17 : Container is started (JDBC URL: jdbc:postgresql://localhost:32769/test?loggerLevel=OFF)
2026-10-18T11:01:25.668Z INFO 2419 --- [ Test worker] org.flywaydb.core.FlywayExecutor : Database: jdbc:postgresql://localhost:32769/test (PostgreSQL 17.11)
2026-10-18T11:01:25.684Z WARN 2419 --- [ Test worker] o.f.c.internal.database.base.Database : Flyway upgrade recommended: PostgreSQL 17.11 is newer than this version of Flyway and support has not been tested. The latest supported version of PostgreSQL is 16.
2026-10-18T11:01:25.709Z INFO 2419 --- [ Test worker] o.f.c.i.s.JdbcTableSchemaHistory : Schema history table "public"."flyway_schema_history" does not exist yet
2026-10-18T11:01:25.712Z INFO 2419 --- [ Test worker] o.f.core.internal.command.DbValidate : Successfully validated 2 migrations (execution time 00:00.013s)
2026-10-18T11:01:25.728Z INFO 2419 --- [ Test worker] o.f.c.i.s.JdbcTableSchemaHistory : Creating Schema History table "public"."flyway_schema_history" ...
2026-10-18T11:01:25.852Z INFO 2419 --- [ Test worker] o.f.core.internal.command.DbMigrate : Current version of schema "public": << Empty Schema >>
2026-10-18T11:01:25.871Z INFO 2419 --- [ Test worker] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version "1 - create bank"
2026-10-18T11:01:25.910Z INFO 2419 --- [ Test worker] o.f.core.internal.command.DbMigrate : Migrating schema "public" to version "2 - refunds"
2026-10-18T11:01:25.928Z INFO 2419 --- [ Test worker] o.f.core.internal.command.DbMigrate : Successfully applied 2 migrations to schema "public", now at version v2 (execution time 00:00.015s)
2026-10-18T11:01:25.986Z INFO 2419 --- [ Test worker] o.f.c.i.c.SqlScriptCallbackFactory : Executing SQL callback: afterMigrate -
2026-10-18T11:01:25.990Z INFO 2419 --- [ Test worker] o.f.c.i.s.DefaultSqlScriptExecutor : +--------+
| setval |
+--------+
| 103 |
+--------+
2026-10-18T11:01:26.105Z INFO 2419 --- [ Test worker] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: default]
2026-10-18T11:01:26.216Z INFO 2419 --- [ Test worker] org.hibernate.Version : HHH000412: Hibernate ORM core version 6.5.2.Final
2026-10-18T11:01:26.263Z INFO 2419 --- [ Test worker] o.h.c.internal.RegionFactoryInitiator : HHH000026: Second-level cache disabled
2026-10-18T11:01:26.546Z INFO 2419 --- [ Test worker] o.s.o.j.p.SpringPersistenceUnitInfo : No LoadTimeWeaver setup: ignoring JPA class transformer
2026-10-18T11:01:26.571Z INFO 2419 --- [ Test worker] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2026-10-18T11:01:26.593Z INFO 2419 --- [ Test worker] com.zaxxer.hikari.pool.HikariPool : HikariPool-1 - Added connection org.postgresql.jdbc.PgConnection@755033c5
2026-10-18T11:01:26.595Z INFO 2419 --- [ Test worker] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Start completed.
2026-10-18T11:01:27.561Z INFO 2419 --- [ Test worker] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000489: No JTA platform available (set 'hibernate.transaction.jta.platform' to enable JTA platform integration)
2026-10-18T11:01:27.601Z INFO 2419 --- [ Test worker] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default'
2026-10-18T11:01:27.913Z INFO 2419 --- [ Test worker] o.s.d.j.r.query.QueryEnhancerFactory : Hibernate is in classpath; If applicable, HQL parser will be used.
2026-10-18T11:01:29.146Z INFO 2419 --- [ Test worker] o.s.b.a.e.web.EndpointLinksResolver : Exposing 1 endpoint beneath base path '/actuator'
2026-10-18T11:01:29.908Z INFO 2419 --- [ Test worker] o.s.b.t.m.w.SpringBootMockServletContext : Initializing Spring TestDispatcherServlet ''
2026-10-18T11:01:29.909Z INFO 2419 --- [ Test worker] o.s.t.web.servlet.TestDispatcherServlet : Initializing Servlet ''
2026-10-18T11:01:29.910Z INFO 2419 --- [ Test worker] o.s.t.web.servlet.TestDispatcherServlet : Completed initialization in 1 ms
2026-10-18T11:01:30.015Z INFO 2419 --- [ Test worker] c.c.group06.bank.RefundIntegrationTest : Started RefundIntegrationTest in 19.219 seconds (process running for 20.782)
2026-10-18T11:01:31.326Z INFO 2419 --- [ Test worker] c.c.group06.bank.web.RefundController : Refund request c8a9d16f-ff24-4fcd-9a39-09f680fa4bd5: SUCCESS
2026-10-18T11:01:31.348Z INFO 2419 --- [ Test worker] c.c.group06.bank.web.RefundController : Refund lookup c8a9d16f-ff24-4fcd-9a39-09f680fa4bd5: SUCCESS
2026-10-18T11:01:31.356Z INFO 2419 --- [ Test worker] c.c.group06.bank.web.RefundController : Refund request c8a9d16f-ff24-4fcd-9a39-09f680fa4bd5: SUCCESS
2026-10-18T11:01:31.707Z INFO 2419 --- [ Test worker] c.c.group06.bank.web.RefundController : Refund request 10c2fe54-efee-44a2-a92b-cbca06222eed: SUCCESS
2026-10-18T11:01:31.754Z INFO 2419 --- [ Test worker] c.c.group06.bank.web.RefundController : Refund request 2272fd7a-aa61-4c92-b4bf-a64431a4ffac: SUCCESS