Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Tests using @QuarkusIntegrationTest with @TestProfile fails after 3.16 upgrade from 3.15 #44764

Open
andrezimmermann opened this issue Nov 27, 2024 · 9 comments
Labels
area/testing kind/bug Something isn't working

Comments

@andrezimmermann
Copy link

andrezimmermann commented Nov 27, 2024

Describe the bug

After upgrading to the latest version 3.16.4, the integration tests using @TestProfile fail to run.

I've included an reproducer for this and will now refer to to it when explaining the issue.

While on 3.15.2

Test Start
    TestProfile.start()
        Resource.QuarkusTestResourceLifecycleManager.inject()
    Quarkus App #1 start()
        Outer Test runs
        @Nested Test 001 runs
        @Nested Test 002 runs
    Quarkus App #1 stop()
    TestProfile.stop()
Test End

While on 3.16.4

Test Start
    TestProfile.start()
        Resource.QuarkusTestResourceLifecycleManager.inject()
    Quarkus App #1 start()
        Outer Test runs
    Quarkus App #1 stop()
    TestProfile.stop()
        TestProfile.start()
            Resource.QuarkusTestResourceLifecycleManager.inject()
        Quarkus App #2 start()
              @Nested Test 001 start()
        Quarkus App #2 stop()
        TestProfile.stop()
        TestProfile.start()
            Resource.QuarkusTestResourceLifecycleManager.inject()
        Quarkus App #3 start()
              @Nested Test 002 runs
        Quarkus App #3 stop()
        TestProfile.stop()
Test End

On 3.16.4 the test fails because the "DynamoClient" at the outer test by the QuarkusTestResourceLifecycleManager is from a different lifecycle that has already been stopped.

After running the tests on 3.16, searching for the application start log message code-with-quarkus 1.0.0-SNAPSHOT native on the junit standard out logs, I can count 13 times. On the 3.15, I can find only 2 start log messages.

Originally my issue was Tests using @QuarkusIntegrationTest with @TestProfile take considerably longer time to execute.
As example, on real production project 1 minutes 20 seconds run with 3.15, upgrading to 3.16 to lead the execution taking 16 minutes.
While investigating the issue seems that for each test, the Quarkus application starts & stop, extending the runtime for each. But when writing the issue reproduction test, I've modified a bit the test structure, leading to the failure above failure. Still I believe that the root cause is the same.

Expected behavior

The expected behavior is that the tests behave the same as 3.15.2, one application for the test class (since the test profile is the same).

Actual behavior

The current behavior is the test failing to run.

How to Reproduce?

I've attached a reproducer, running quarkusIntTest will result into the described issue.

quarkus-kotlin-lambda-native-test.tar.gz

Output of uname -a or ver

Linux cachyos-x8664 6.12.0-1-cachyos-autofdo SMP PREEMPT_DYNAMIC Mon, 18 Nov 2024 15:41:14 +0000 x86_64 GNU/Linux

Output of java -version

OpenJDK 64-Bit Server VM GraalVM CE 23+37.1 (build 23+37-jvmci-b01, mixed mode, sharing)

Quarkus version or git rev

3.16.4

Build tool (ie. output of mvnw --version or gradlew --version)

Gradle 8.9

Additional information

No response

@andrezimmermann andrezimmermann added the kind/bug Something isn't working label Nov 27, 2024
Copy link

quarkus-bot bot commented Nov 27, 2024

/cc @geoand (kotlin,testing)

@geoand
Copy link
Contributor

geoand commented Nov 27, 2024

Can you give 3.17.0 a test please and see it behaves like 3.16.4 or not?

@geoand geoand added triage/needs-feedback We are waiting for feedback. and removed area/kotlin labels Nov 27, 2024
@andrezimmermann
Copy link
Author

If you mean the 3.17.0.CR1 yeah, unfortunately the new behavior persists.

This is the stdout from running the quarkusIntTest, it runs the JVM unit test without issues and then at the native/integration tests it start & stop the quarkus application multiple times (and leads to the error).

Finished generating 'code-with-quarkus-1.0.0-SNAPSHOT-runner' in 34.1s.
> Task :compileTestJava NO-SOURCE
> Task :testClasses UP-TO-DATE
> Task :compileIntegrationTestKotlin
2024-11-27 16:10:26,020 INFO  [io.qua.ama.lam.run.MockEventServer] (build-31) Mock Lambda Event Server Started
2024-11-27 16:10:26,516 INFO  [org.tes.ima.PullPolicy] (pool-3-thread-1 @coroutine#1) Image pull policy will be performed by: DefaultPullPolicy()
2024-11-27 16:10:26,517 INFO  [org.tes.uti.ImageNameSubstitutor] (pool-3-thread-1 @coroutine#1) Image name substitution will be performed by: DefaultImageNameSubstitutor (composite of 'ConfigurationFileImageNameSubstitutor' and 'PrefixingImageNameSubstitutor')
2024-11-27 16:10:26,520 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Testcontainers version: 1.20.3
2024-11-27 16:10:26,562 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Loaded org.testcontainers.dockerclient.UnixSocketClientProviderStrategy from ~/.testcontainers.properties, will try it first
2024-11-27 16:10:26,663 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:26,663 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Storing binary in temporary directory /tmp/hoverfly.9162482067090728244/hoverfly_linux_amd64
2024-11-27 16:10:26,678 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Found Docker environment with local Unix socket (unix:///var/run/docker.sock)
2024-11-27 16:10:26,678 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Docker host IP address is localhost
2024-11-27 16:10:26,685 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Connected to docker: 
  Server Version: 27.3.1
  API Version: 1.47
  Operating System: CachyOS
  Total Memory: 31158 MB
2024-11-27 16:10:26,704 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) Executing binary at /tmp/hoverfly.9162482067090728244/hoverfly_linux_amd64
2024-11-27 16:10:26,705 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Creating container for image: testcontainers/ryuk:0.9.0
2024-11-27 16:10:26,707 INFO  [org.tes.uti.RegistryAuthLocator] (testcontainers-lifecycle-0) Failure when attempting to lookup auth config. Please ignore if you don't have images in an authenticated registry. Details: (dockerImageName: testcontainers/ryuk:0.9.0, configFile: /home/andre/.docker/config.json, configEnv: DOCKER_AUTH_CONFIG). Falling back to docker-java default behaviour. Exception message: Status 404: No config supplied. Checked in order: /home/andre/.docker/config.json (file not found), DOCKER_AUTH_CONFIG (not set)
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) Default proxy port has been overwritten port=43285
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) Default admin port has been overwritten port=41199
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) TLS certificate verification has been disabled 
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) Using memory backend 
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) Proxy prepared... Destination=. Mode=simulate ProxyPort=43285
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) current proxy configuration destination=. mode=simulate port=43285
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) Admin interface is starting... AdminPort=41199
2024-11-27 16:10:26,713 INFO  [hoverfly] (Thread-102) serving proxy 
2024-11-27 16:10:26,726 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:26,729 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:26,731 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy host to localhost
2024-11-27 16:10:26,731 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy proxyPort to 43285
2024-11-27 16:10:27,058 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 is starting: 25d2c29299fc9b7d138d16f305fb35cd774a150b862919caddde9e18afc15445
2024-11-27 16:10:27,200 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 started in PT0.494871157S
2024-11-27 16:10:27,202 INFO  [org.tes.uti.RyukResourceReaper] (testcontainers-lifecycle-0) Ryuk started - will monitor and terminate Testcontainers containers on JVM exit
2024-11-27 16:10:27,202 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Checking the system...
2024-11-27 16:10:27,202 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) ✔︎ Docker server version should be at least 1.6.0
2024-11-27 16:10:27,202 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:27,218 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: d1d361d2580552b55953eecf8d3caeb640dd4c2871ebcf79305287fea4f610cc
2024-11-27 16:10:29,264 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT2.061739418S
2024-11-27 16:10:29,265 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-3-thread-1) DynamoDB - Started at http://localhost:32817
2024-11-27 16:10:29,858 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:29,858 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:29,873 INFO  [io.quarkus] (Test worker) code-with-quarkus 1.0.0-SNAPSHOT on JVM (powered by Quarkus 3.17.0.CR1) started in 4.525s. 
2024-11-27 16:10:29,874 INFO  [io.quarkus] (Test worker) Profile test activated. 
2024-11-27 16:10:29,874 INFO  [io.quarkus] (Test worker) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:29,954 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [dbffe360ee23d35fb922dfc01a32f3bcb98d3bd0] - should be able persist and load some data()
2024-11-27 16:10:29,955 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:29,955 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:30,056 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=1, text=A stranger, is a friend you have not spoken to yet.))
2024-11-27 16:10:30,080 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB URL: Optional[http://localhost:32817]
2024-11-27 16:10:30,102 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [352a8ca0d6f3b82615d410b35bce0a5d63f88836] - should return the data for the stored value 2()
2024-11-27 16:10:30,103 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:30,103 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:30,104 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=2, text=Hard work pays off in the future, laziness pays off now.))
2024-11-27 16:10:30,361 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32817]
2024-11-27 16:10:30,413 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [42c5637130430abe352d67ed8cd478b71059b789] - should return the data for the stored value 3()
2024-11-27 16:10:30,414 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:30,414 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:30,415 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=3, text=Land is always on the mind of a flying bird.))
2024-11-27 16:10:30,429 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32817]
2024-11-27 16:10:30,440 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bc1815a71b2d60894e2613184cbc6519cec154ff] - should return the data for stored value 4()
2024-11-27 16:10:30,441 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:30,441 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:30,442 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=4, text=Wealth awaits you very soon.))
2024-11-27 16:10:30,453 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32817]
2024-11-27 16:10:30,462 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [9fe0704df676a8dc95d38217fcd2d6f51c526ed7] - should return the data for the stored value 5()
2024-11-27 16:10:30,463 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:30,463 INFO  [hoverfly] (Thread-102) Mode has been changed mode=simulate
2024-11-27 16:10:30,464 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=5, text=Land is always on the mind of a flying bird.))
2024-11-27 16:10:30,474 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32817]
Aborting lambda poll loop: ending dev/test mode
Aborting lambda poll loop: ending dev/test mode
2024-11-27 16:10:30,488 WARN  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Aborting lambda poll loop: ending dev/test mode
2024-11-27 16:10:30,488 WARN  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Aborting lambda poll loop: ending dev/test mode
2024-11-27 16:10:30,489 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Lambda polling thread complete (TEST)
2024-11-27 16:10:30,489 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Lambda polling thread complete (TEST)
2024-11-27 16:10:30,496 INFO  [io.quarkus] (Test worker) code-with-quarkus stopped in 0.008s
2024-11-27 16:10:30,659 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-27 16:10:30,661 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-27 16:10:31,195 INFO  [io.qua.ama.lam.run.MockEventServer] (build-24) Mock Lambda Event Server Started
2024-11-27 16:10:31,635 INFO  [org.tes.ima.PullPolicy] (pool-12-thread-1 @coroutine#1) Image pull policy will be performed by: DefaultPullPolicy()
2024-11-27 16:10:31,636 INFO  [org.tes.uti.ImageNameSubstitutor] (pool-12-thread-1 @coroutine#1) Image name substitution will be performed by: DefaultImageNameSubstitutor (composite of 'ConfigurationFileImageNameSubstitutor' and 'PrefixingImageNameSubstitutor')
2024-11-27 16:10:31,638 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Testcontainers version: 1.20.3
2024-11-27 16:10:31,675 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Loaded org.testcontainers.dockerclient.UnixSocketClientProviderStrategy from ~/.testcontainers.properties, will try it first
2024-11-27 16:10:31,735 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-12-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:31,735 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-12-thread-2) Storing binary in temporary directory /tmp/hoverfly.6261716908419658519/hoverfly_linux_amd64
2024-11-27 16:10:31,769 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Found Docker environment with local Unix socket (unix:///var/run/docker.sock)
2024-11-27 16:10:31,770 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Docker host IP address is localhost
2024-11-27 16:10:31,774 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-12-thread-2) Executing binary at /tmp/hoverfly.6261716908419658519/hoverfly_linux_amd64
2024-11-27 16:10:31,777 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Connected to docker: 
  Server Version: 27.3.1
  API Version: 1.47
  Operating System: CachyOS
  Total Memory: 31158 MB
2024-11-27 16:10:31,782 INFO  [hoverfly] (Thread-205) Default proxy port has been overwritten port=45159
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) Default admin port has been overwritten port=45487
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) TLS certificate verification has been disabled 
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) Using memory backend 
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) Proxy prepared... Destination=. Mode=simulate ProxyPort=45159
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) current proxy configuration destination=. mode=simulate port=45159
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) Admin interface is starting... AdminPort=45487
2024-11-27 16:10:31,783 INFO  [hoverfly] (Thread-205) serving proxy 
2024-11-27 16:10:31,794 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Creating container for image: testcontainers/ryuk:0.9.0
2024-11-27 16:10:31,796 INFO  [org.tes.uti.RegistryAuthLocator] (testcontainers-lifecycle-0) Failure when attempting to lookup auth config. Please ignore if you don't have images in an authenticated registry. Details: (dockerImageName: testcontainers/ryuk:0.9.0, configFile: /home/andre/.docker/config.json, configEnv: DOCKER_AUTH_CONFIG). Falling back to docker-java default behaviour. Exception message: Status 404: No config supplied. Checked in order: /home/andre/.docker/config.json (file not found), DOCKER_AUTH_CONFIG (not set)
2024-11-27 16:10:31,796 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-12-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:31,799 INFO  [hoverfly] (Thread-205) Mode has been changed mode=simulate
2024-11-27 16:10:31,800 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-12-thread-2) Setting proxy host to localhost
2024-11-27 16:10:31,800 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-12-thread-2) Setting proxy proxyPort to 45159
2024-11-27 16:10:31,829 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 is starting: 55fc1e460470791ae036dcb21bf7db5a8a147ee18e2e7e023e6c09a3c0fb2128
2024-11-27 16:10:31,962 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 started in PT0.168224158S
2024-11-27 16:10:31,964 INFO  [org.tes.uti.RyukResourceReaper] (testcontainers-lifecycle-0) Ryuk started - will monitor and terminate Testcontainers containers on JVM exit
2024-11-27 16:10:31,964 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Checking the system...
2024-11-27 16:10:31,964 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) ✔︎ Docker server version should be at least 1.6.0
2024-11-27 16:10:31,964 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:31,977 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: b71da652b06476a5ea4213f094631021728173bd2989f89d8abb5d431921fbb4
2024-11-27 16:10:33,704 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.739735627S
2024-11-27 16:10:33,704 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-12-thread-1) DynamoDB - Started at http://localhost:32819
2024-11-27 16:10:34,221 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:34,221 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:34,236 INFO  [io.quarkus] (Test worker) code-with-quarkus 1.0.0-SNAPSHOT on JVM (powered by Quarkus 3.17.0.CR1) started in 3.485s. 
2024-11-27 16:10:34,237 INFO  [io.quarkus] (Test worker) Profile test activated. 
2024-11-27 16:10:34,237 INFO  [io.quarkus] (Test worker) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:34,304 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bd24e7d5515cbcf4ca86ed112241d5539da3c9fd] - should return the same ID in the Controller Request()
2024-11-27 16:10:34,306 INFO  [hoverfly] (Thread-205) Mode has been changed mode=simulate
2024-11-27 16:10:34,306 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:34,309 INFO  [hoverfly] (Thread-205) payloads imported failed=0 successful=1 total=1
2024-11-27 16:10:34,760 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-2) Request: GET https://postman-echo.com/get?id=test-id Headers[User-Agent=Quarkus REST Client], Empty body
2024-11-27 16:10:34,768 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-2) Response: GET https://postman-echo.com/get?id=test-id, Status[200 OK], Headers[Connection=close Content-Type=application/json; charset=utf-8 Date=Tue, 26 Nov 2024 08:11:04 GMT Etag=W/"1a0-sx76+zk0FMsdQxTAQhqxiwcOkws" Hoverfly=Was-Here Server=nginx/1.25.3 Set-Cookie=sails.sid=s%3AQjcBNnVIuNJhnlNVYsKR2_tUOLqu8XqX.EPPLZzlqIZsrDGMX5feq2KkzA9K%2B%2BKh6bxqKzfUQ8bM; Path=/; HttpOnly Transfer-Encoding=chunked], Body:
{
  "args": {
    "id": "test-id"
  },
  "headers": {
    "host": "postman-echo.com",
    "x-request-start": "t=1732608664.550",
    "connection": "close",
    "x-forwarded-proto": "https",
    "x-forwarded-port": "443",
    "x-amzn-trace-id": "Root=1-67458298-2613ddb5441d94b055959c0a",
    "user-agent": "Quarkus REST Client",
    "accept-encoding": "gzip"
  },
  "url": "https://postman-echo.com/get?id=test-id"
}
2024-11-27 16:10:34,812 WARN  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Aborting lambda poll loop: ending dev/test mode
2024-11-27 16:10:34,812 WARN  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Aborting lambda poll loop: ending dev/test mode
2024-11-27 16:10:34,812 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Lambda polling thread complete (TEST)
2024-11-27 16:10:34,812 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (TEST)) Lambda polling thread complete (TEST)
2024-11-27 16:10:34,819 INFO  [io.quarkus] (Test worker) code-with-quarkus stopped in 0.007s
Aborting lambda poll loop: ending dev/test mode
Aborting lambda poll loop: ending dev/test mode
> Task :test
> Task :compileIntegrationTestJava NO-SOURCE
> Task :integrationTestClasses UP-TO-DATE
> Task :quarkusDependenciesBuild
> Task :quarkusBuild
2024-11-27 16:10:37,027 INFO  [io.qua.ama.lam.run.MockEventServer] (build-10) Mock Lambda Event Server Started
2024-11-27 16:10:37,244 INFO  [org.tes.ima.PullPolicy] (pool-3-thread-1 @coroutine#1) Image pull policy will be performed by: DefaultPullPolicy()
2024-11-27 16:10:37,245 INFO  [org.tes.uti.ImageNameSubstitutor] (pool-3-thread-1 @coroutine#1) Image name substitution will be performed by: DefaultImageNameSubstitutor (composite of 'ConfigurationFileImageNameSubstitutor' and 'PrefixingImageNameSubstitutor')
2024-11-27 16:10:37,249 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Testcontainers version: 1.20.3
2024-11-27 16:10:37,289 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Loaded org.testcontainers.dockerclient.UnixSocketClientProviderStrategy from ~/.testcontainers.properties, will try it first
2024-11-27 16:10:37,390 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:37,391 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Storing binary in temporary directory /tmp/hoverfly.2413567950720068564/hoverfly_linux_amd64
2024-11-27 16:10:37,402 INFO  [org.tes.doc.DockerClientProviderStrategy] (testcontainers-lifecycle-0) Found Docker environment with local Unix socket (unix:///var/run/docker.sock)
2024-11-27 16:10:37,403 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Docker host IP address is localhost
2024-11-27 16:10:37,410 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Connected to docker: 
  Server Version: 27.3.1
  API Version: 1.47
  Operating System: CachyOS
  Total Memory: 31158 MB
2024-11-27 16:10:37,426 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Creating container for image: testcontainers/ryuk:0.9.0
2024-11-27 16:10:37,427 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) Executing binary at /tmp/hoverfly.2413567950720068564/hoverfly_linux_amd64
2024-11-27 16:10:37,429 INFO  [org.tes.uti.RegistryAuthLocator] (testcontainers-lifecycle-0) Failure when attempting to lookup auth config. Please ignore if you don't have images in an authenticated registry. Details: (dockerImageName: testcontainers/ryuk:0.9.0, configFile: /home/andre/.docker/config.json, configEnv: DOCKER_AUTH_CONFIG). Falling back to docker-java default behaviour. Exception message: Status 404: No config supplied. Checked in order: /home/andre/.docker/config.json (file not found), DOCKER_AUTH_CONFIG (not set)
2024-11-27 16:10:37,437 INFO  [hoverfly] (Thread-18) Default proxy port has been overwritten port=39781
2024-11-27 16:10:37,437 INFO  [hoverfly] (Thread-18) Default admin port has been overwritten port=35109
2024-11-27 16:10:37,437 INFO  [hoverfly] (Thread-18) TLS certificate verification has been disabled 
2024-11-27 16:10:37,437 INFO  [hoverfly] (Thread-18) Using memory backend 
2024-11-27 16:10:37,437 INFO  [hoverfly] (Thread-18) Proxy prepared... Destination=. Mode=simulate ProxyPort=39781
2024-11-27 16:10:37,438 INFO  [hoverfly] (Thread-18) current proxy configuration destination=. mode=simulate port=39781
2024-11-27 16:10:37,438 INFO  [hoverfly] (Thread-18) Admin interface is starting... AdminPort=35109
2024-11-27 16:10:37,438 INFO  [hoverfly] (Thread-18) serving proxy 
2024-11-27 16:10:37,451 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:37,455 INFO  [hoverfly] (Thread-18) Mode has been changed mode=simulate
2024-11-27 16:10:37,457 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy host to localhost
2024-11-27 16:10:37,457 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy proxyPort to 39781
2024-11-27 16:10:37,468 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 is starting: 0c813e6fc8fdb922d265fa4474dc8559fd57a67d13d028d35c9ef06a90172e6b
2024-11-27 16:10:37,618 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 started in PT0.191312734S
2024-11-27 16:10:37,619 INFO  [org.tes.uti.RyukResourceReaper] (testcontainers-lifecycle-0) Ryuk started - will monitor and terminate Testcontainers containers on JVM exit
2024-11-27 16:10:37,619 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) Checking the system...
2024-11-27 16:10:37,620 INFO  [org.tes.DockerClientFactory] (testcontainers-lifecycle-0) ✔︎ Docker server version should be at least 1.6.0
2024-11-27 16:10:37,620 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:37,635 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 4163474d4f3c438154e1b8a931d3a0e852110074c761973071f2bfbf5dddcf75
2024-11-27 16:10:39,359 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.739451944S
2024-11-27 16:10:39,360 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-3-thread-1) DynamoDB - Started at http://localhost:32821
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -DLOCAL_HOVERFLY_INSTANCE_HOST=localhost -DLOCAL_HOVERFLY_INSTANCE_PORT=39781 -Dquarkus.dynamodb.endpoint-override=http://localhost:32821 -Dquarkus.tls.trust-all=true -DDYNAMODB_TABLE=test-record-table -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -DLOCAL_HOVERFLY_INSTANCE=localhost:39781"
2024-11-27 16:10:40,107 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-27 16:10:40,107 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-27 16:10:40,107 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:40,108 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:40,280 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [dbffe360ee23d35fb922dfc01a32f3bcb98d3bd0] - should be able persist and load some data()
2024-11-27 16:10:40,282 INFO  [hoverfly] (Thread-18) Mode has been changed mode=simulate
2024-11-27 16:10:40,282 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:40,391 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=1, text=A stranger, is a friend you have not spoken to yet.))
2024-11-27 16:10:40,416 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB URL: Optional[http://localhost:32821]
2024-11-27 16:10:40,599 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-27 16:10:40,651 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-27 16:10:41,168 INFO  [io.qua.ama.lam.run.MockEventServer] (build-5) Mock Lambda Event Server Started
2024-11-27 16:10:41,321 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:41,321 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-9-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:41,321 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-9-thread-2) Storing binary in temporary directory /tmp/hoverfly.7919429974125338990/hoverfly_linux_amd64
2024-11-27 16:10:41,334 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: dc14bdb1bacdb911ae2e5f00de150e4a2b211fa5dcb7a70741ace83304616bff
2024-11-27 16:10:41,358 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-9-thread-2) Executing binary at /tmp/hoverfly.7919429974125338990/hoverfly_linux_amd64
2024-11-27 16:10:41,361 INFO  [hoverfly] (Thread-40) Default proxy port has been overwritten port=36455
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) Default admin port has been overwritten port=36159
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) TLS certificate verification has been disabled 
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) Using memory backend 
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) Proxy prepared... Destination=. Mode=simulate ProxyPort=36455
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) current proxy configuration destination=. mode=simulate port=36455
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) serving proxy 
2024-11-27 16:10:41,362 INFO  [hoverfly] (Thread-40) Admin interface is starting... AdminPort=36159
2024-11-27 16:10:41,464 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-9-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:41,464 INFO  [hoverfly] (Thread-40) Mode has been changed mode=simulate
2024-11-27 16:10:41,465 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-9-thread-2) Setting proxy host to localhost
2024-11-27 16:10:41,465 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-9-thread-2) Setting proxy proxyPort to 36455
2024-11-27 16:10:43,052 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.730916036S
2024-11-27 16:10:43,052 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-9-thread-1) DynamoDB - Started at http://localhost:32822
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -DLOCAL_HOVERFLY_INSTANCE_HOST=localhost -Dquarkus.dynamodb.endpoint-override=http://localhost:32822 -DLOCAL_HOVERFLY_INSTANCE_PORT=36455 -Dquarkus.tls.trust-all=true -DDYNAMODB_TABLE=test-record-table -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.http.port=8081 -DLOCAL_HOVERFLY_INSTANCE=localhost:36455 -Dquarkus.http.test-port=8081"
2024-11-27 16:10:43,557 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-27 16:10:43,557 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-27 16:10:43,557 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:43,557 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:43,799 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-27 16:10:43,851 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-27 16:10:44,331 INFO  [io.qua.ama.lam.run.MockEventServer] (build-8) Mock Lambda Event Server Started
2024-11-27 16:10:44,483 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:44,483 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-15-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:44,484 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-15-thread-2) Storing binary in temporary directory /tmp/hoverfly.6175843420835009042/hoverfly_linux_amd64
2024-11-27 16:10:44,495 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 09e129274a629e8ddc73f5cd7ea446dc870b6672e6a511b72b18ee1ccda73a86
2024-11-27 16:10:44,519 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-15-thread-2) Executing binary at /tmp/hoverfly.6175843420835009042/hoverfly_linux_amd64
2024-11-27 16:10:44,523 INFO  [hoverfly] (Thread-61) Default proxy port has been overwritten port=37857
2024-11-27 16:10:44,523 INFO  [hoverfly] (Thread-61) Default admin port has been overwritten port=33179
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) TLS certificate verification has been disabled 
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) Using memory backend 
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) Proxy prepared... Destination=. Mode=simulate ProxyPort=37857
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) current proxy configuration destination=. mode=simulate port=37857
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) Admin interface is starting... AdminPort=33179
2024-11-27 16:10:44,524 INFO  [hoverfly] (Thread-61) serving proxy 
2024-11-27 16:10:44,623 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-15-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:44,624 INFO  [hoverfly] (Thread-61) Mode has been changed mode=simulate
2024-11-27 16:10:44,624 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-15-thread-2) Setting proxy host to localhost
2024-11-27 16:10:44,625 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-15-thread-2) Setting proxy proxyPort to 37857
2024-11-27 16:10:46,205 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.721563714S
2024-11-27 16:10:46,205 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-15-thread-1) DynamoDB - Started at http://localhost:32823
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -DLOCAL_HOVERFLY_INSTANCE_HOST=localhost -Dquarkus.dynamodb.endpoint-override=http://localhost:32823 -DLOCAL_HOVERFLY_INSTANCE_PORT=37857 -Dquarkus.tls.trust-all=true -DDYNAMODB_TABLE=test-record-table -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.http.port=8081 -DLOCAL_HOVERFLY_INSTANCE=localhost:37857 -Dquarkus.http.test-port=8081"
2024-11-27 16:10:46,715 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-27 16:10:46,715 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-27 16:10:46,715 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:46,715 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:46,947 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-27 16:10:46,999 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-27 16:10:47,467 INFO  [io.qua.ama.lam.run.MockEventServer] (build-8) Mock Lambda Event Server Started
2024-11-27 16:10:47,632 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-27 16:10:47,632 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-21-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-27 16:10:47,632 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-21-thread-2) Storing binary in temporary directory /tmp/hoverfly.3506221882670234120/hoverfly_linux_amd64
2024-11-27 16:10:47,644 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: eb832001da0e7a4d5482dc48c612bb6e1c433c92d6c60e8f867bcbb4ebc88870
2024-11-27 16:10:47,668 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-21-thread-2) Executing binary at /tmp/hoverfly.3506221882670234120/hoverfly_linux_amd64
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) Default proxy port has been overwritten port=44815
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) Default admin port has been overwritten port=40763
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) TLS certificate verification has been disabled 
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) Using memory backend 
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) Proxy prepared... Destination=. Mode=simulate ProxyPort=44815
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) current proxy configuration destination=. mode=simulate port=44815
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) Admin interface is starting... AdminPort=40763
2024-11-27 16:10:47,672 INFO  [hoverfly] (Thread-82) serving proxy 
2024-11-27 16:10:47,772 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-21-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-27 16:10:47,772 INFO  [hoverfly] (Thread-82) Mode has been changed mode=simulate
2024-11-27 16:10:47,773 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-21-thread-2) Setting proxy host to localhost
2024-11-27 16:10:47,773 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-21-thread-2) Setting proxy proxyPort to 44815
2024-11-27 16:10:49,361 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.729526764S
2024-11-27 16:10:49,362 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-21-thread-1) DynamoDB - Started at http://localhost:32824
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -DLOCAL_HOVERFLY_INSTANCE_HOST=localhost -Dquarkus.dynamodb.endpoint-override=http://localhost:32824 -DLOCAL_HOVERFLY_INSTANCE_PORT=44815 -Dquarkus.tls.trust-all=true -DDYNAMODB_TABLE=test-record-table -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.http.port=8081 -DLOCAL_HOVERFLY_INSTANCE=localhost:44815 -Dquarkus.http.test-port=8081"
2024-11-27 16:10:49,845 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-27 16:10:49,845 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-27 16:10:49,845 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-27 16:10:49,845 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-27 16:10:49,938 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [352a8ca0d6f3b82615d410b35bce0a5d63f88836] - should return the data for the stored value 2()
2024-11-27 16:10:49,938 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-27 16:10:49,938 INFO  [hoverfly] (Thread-82) Mode has been changed mode=simulate
2024-11-27 16:10:49,941 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=2, text=Hard work pays off in the future, laziness pays off now.))
2024-11-27 16:10:52,150 ERROR [org.acm.dyn.DataRepository] (Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused
	at software.amazon.awssdk.core.exception.SdkClientException$BuilderImpl.build(SdkClientException.java:111)

@geoand
Copy link
Contributor

geoand commented Nov 27, 2024

Thanks for checking

@geoand geoand removed the triage/needs-feedback We are waiting for feedback. label Nov 27, 2024
@geoand
Copy link
Contributor

geoand commented Nov 27, 2024

I'm curious how you created

Test Start
    TestProfile.start()
        Resource.QuarkusTestResourceLifecycleManager.inject()
    Quarkus App #1 start()
        Outer Test runs
        @Nested Test 001 runs
        @Nested Test 002 runs
    Quarkus App #1 stop()
    TestProfile.stop()
Test End

and 3.16 version. Mind including that in the reproducer?

Thanks

@andrezimmermann
Copy link
Author

andrezimmermann commented Nov 28, 2024

Sorry, the above text was just my subjective analysis of what would be happening.
I've added to the reproducer some logging on the QuarkusTestResourceLifecycleManager but seems I was wrong with the structure of the tests lifecycle 😅

QuarkusTestResourceLifecycleManager - start() : Counter 1
[io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
jUnit BeforeEach - Counter: 1
QuarkusTestResourceLifecycleManager - stop() : Counter 1
QuarkusTestResourceLifecycleManager - start() : Counter 2
[io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
QuarkusTestResourceLifecycleManager - stop() : Counter 2
QuarkusTestResourceLifecycleManager - start() : Counter 3
[io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 3
QuarkusTestResourceLifecycleManager - stop() : Counter 3
QuarkusTestResourceLifecycleManager - start() : Counter 4
[io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.014s. 
jUnit BeforeEach - Counter: 3
(Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused
QuarkusTestResourceLifecycleManager - stop() : Counter 4

It creates it runs the QuarkusTestResource, Quarkus Application, QuarkusTestResource will inject into the test instance, then call the actual test 😅

In comparison, 3.15.2

QuarkusTestResourceLifecycleManager - start() : Counter 1
[io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.15.2) started in 0.016s. 
QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
jUnit BeforeEach - Counter: 1

... repeat  inject() and BeforeEach  for the several tests in DataStoreControllerTestNativeTest...

QuarkusTestResourceLifecycleManager - inject() PostmanControllerTestNativeTest - 1
jUnit BeforeEach - Counter: 1
QuarkusTestResourceLifecycleManager - stop() : Counter 1

Here is another version of the reproducer with the very contrived logging I've added.
quarkus-kotlin-lambda-native-test.tar.gz

With the integration tests logging it prints several times the start() & stop() messages, incrementing the counter, in the end of the test start & stop 15 times (so the lambda mock server)

This is the logging of the quarkusIntTest run

3.15.2

2024-11-28 11:03:23,395 INFO  [io.qua.ama.lam.run.MockEventServer] (build-4) Mock Lambda Event Server Started
2024-11-28 11:03:23,569 INFO  [Lifecycle] (pool-3-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 1
2024-11-28 11:03:23,750 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 11:03:23,751 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Storing binary in temporary directory /tmp/hoverfly.6172861343329069494/hoverfly_linux_amd64
2024-11-28 11:03:23,782 INFO  [tc.tes.8.1] (testcontainers-lifecycle-0) Creating container for image: testcontainers/ryuk:0.8.1
2024-11-28 11:03:23,787 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) Executing binary at /tmp/hoverfly.6172861343329069494/hoverfly_linux_amd64
2024-11-28 11:03:23,811 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 11:03:23,816 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy host to localhost
2024-11-28 11:03:23,816 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy proxyPort to 44281
2024-11-28 11:03:23,919 INFO  [tc.tes.8.1] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.8.1 is starting: 604d9cc73193cbb9b961e23e72a0b2d1a149387b5197bbc74e9b935cd8ab7a87
2024-11-28 11:03:24,069 INFO  [tc.tes.8.1] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.8.1 started in PT0.286927807S
2024-11-28 11:03:24,071 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 11:03:24,087 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 155be57da9ffd96bc92b7b39a1692eacd191702118675ae72997398ad57fe33e
2024-11-28 11:03:25,708 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.636695095S
2024-11-28 11:03:25,709 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-3-thread-1) DynamoDB - Started at http://localhost:32965
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.dynamodb.endpoint-override=http://localhost:32965"
2024-11-28 11:03:26,460 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.15.2) started in 0.016s. 
2024-11-28 11:03:26,460 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 11:03:26,460 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 11:03:26,460 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 11:03:26,680 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 11:03:26,684 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [dbffe360ee23d35fb922dfc01a32f3bcb98d3bd0] - should be able persist and load some data()
2024-11-28 11:03:26,686 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:26,786 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:26,788 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=1, text=A stranger, is a friend you have not spoken to yet.))
2024-11-28 11:03:26,811 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB URL: Optional[http://localhost:32965]
2024-11-28 11:03:26,831 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 11:03:26,834 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [352a8ca0d6f3b82615d410b35bce0a5d63f88836] - should return the data for the stored value 2()
2024-11-28 11:03:26,835 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:26,836 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:26,836 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=2, text=Hard work pays off in the future, laziness pays off now.))
2024-11-28 11:03:27,065 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32965]
2024-11-28 11:03:27,101 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 11:03:27,103 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [42c5637130430abe352d67ed8cd478b71059b789] - should return the data for the stored value 3()
2024-11-28 11:03:27,104 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:27,105 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:27,105 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=3, text=Land is always on the mind of a flying bird.))
2024-11-28 11:03:27,116 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32965]
2024-11-28 11:03:27,124 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 11:03:27,125 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 11:03:27,128 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bc1815a71b2d60894e2613184cbc6519cec154ff] - should return the data for stored value 4()
2024-11-28 11:03:27,129 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:27,130 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:27,131 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=4, text=Wealth awaits you very soon.))
2024-11-28 11:03:27,142 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32965]
2024-11-28 11:03:27,152 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 11:03:27,154 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [9fe0704df676a8dc95d38217fcd2d6f51c526ed7] - should return the data for the stored value 5()
2024-11-28 11:03:27,154 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:27,156 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:27,156 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=5, text=Land is always on the mind of a flying bird.))
2024-11-28 11:03:27,168 INFO  [org.acm.dyn.DataRepository] (executor-thread-1) DynamoDB URL: Optional[http://localhost:32965]
2024-11-28 11:03:27,175 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 11:03:27,175 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 11:03:27,179 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() PostmanControllerTestNativeTest - 1
2024-11-28 11:03:27,181 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bd24e7d5515cbcf4ca86ed112241d5539da3c9fd] - should return the same ID in the Controller Request()
2024-11-28 11:03:27,182 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 11:03:27,183 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 11:03:27,783 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-10) Request: GET https://postman-echo.com/get?id=test-id Headers[User-Agent=Quarkus REST Client], Empty body
2024-11-28 11:03:27,969 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-10) Response: GET https://postman-echo.com/get?id=test-id, Status[200 OK], Headers[Date=Thu, 28 Nov 2024 02:03:27 GMT Content-Type=application/json; charset=utf-8 Content-Length=382 Connection=keep-alive Server=nginx ETag=W/"17e-hBMOn32luqFJoxO1MBFveWAGJQk" set-cookie=sails.sid=s%3AI22yCSn2vW2jgr2MKeWNxuB4dzYvmu-4.Hjk0qQuxq8df1mHy%2BXEVUGZQ49%2FJq4FSkMBtlQ2iIXs; Path=/; HttpOnly], Body:
{
  "args": {
    "id": "test-id"
  },
  "headers": {
    "host": "postman-echo.com",
    "x-forwarded-proto": "http",
    "x-request-start": "t1732759407.872",
    "connection": "close",
    "x-forwarded-port": "443",
    "x-amzn-trace-id": "Root=1-6747cf6f-4d42a3af39d774880f533937",
    "user-agent": "Quarkus REST Client"
  },
  "url": "http://postman-echo.com/get?id=test-id"
}
2024-11-28 11:03:27,976 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 11:03:27,977 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 11:03:28,122 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 11:03:28,124 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 1
2024-11-28 11:03:28,174 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
> Task :testNative

3.17.0

2024-11-28 10:34:31,780 INFO  [io.qua.ama.lam.run.MockEventServer] (build-10) Mock Lambda Event Server Started
2024-11-28 10:34:31,977 INFO  [Lifecycle] (pool-3-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 1
2024-11-28 10:34:32,150 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:32,151 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-3-thread-2) Storing binary in temporary directory /tmp/hoverfly.4199606361945635312/hoverfly_linux_amd64
2024-11-28 10:34:32,176 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Creating container for image: testcontainers/ryuk:0.9.0
2024-11-28 10:34:32,189 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) Executing binary at /tmp/hoverfly.4199606361945635312/hoverfly_linux_amd64
2024-11-28 10:34:32,214 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-3-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:32,220 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy host to localhost
2024-11-28 10:34:32,220 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-3-thread-2) Setting proxy proxyPort to 34677
2024-11-28 10:34:32,388 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 is starting: e6d2e4c895d0a2838a39fe3d2e1c54e34cd1feb32ba8fb5d263daab94d7f2a0d
2024-11-28 10:34:32,543 INFO  [tc.tes.9.0] (testcontainers-lifecycle-0) Container testcontainers/ryuk:0.9.0 started in PT0.367499868S
2024-11-28 10:34:32,545 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:32,561 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: c75467a4fe6529a69b6b2d8ba90a06de34e05c160d77f5dbe54f6f4b29b62d6e
2024-11-28 10:34:34,480 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.934282738S
2024-11-28 10:34:34,481 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-3-thread-1) DynamoDB - Started at http://localhost:32947
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.dynamodb.endpoint-override=http://localhost:32947"
2024-11-28 10:34:35,241 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:34:35,241 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:35,241 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:35,241 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:35,453 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 1
2024-11-28 10:34:35,457 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [dbffe360ee23d35fb922dfc01a32f3bcb98d3bd0] - should be able persist and load some data()
2024-11-28 10:34:35,459 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:34:35,556 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 1
2024-11-28 10:34:35,558 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=1, text=A stranger, is a friend you have not spoken to yet.))
2024-11-28 10:34:35,582 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB URL: Optional[http://localhost:32947]
2024-11-28 10:34:35,754 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:35,759 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 1
2024-11-28 10:34:35,809 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:34:36,324 INFO  [io.qua.ama.lam.run.MockEventServer] (build-5) Mock Lambda Event Server Started
2024-11-28 10:34:36,506 INFO  [Lifecycle] (pool-9-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 2
2024-11-28 10:34:36,507 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:36,507 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-9-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:36,507 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-9-thread-2) Storing binary in temporary directory /tmp/hoverfly.13994543323675541291/hoverfly_linux_amd64
2024-11-28 10:34:36,520 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 5e72688fb4203eb6f6981c28fe9b99ad28d565c72a9c8f7915b466a64f93886a
2024-11-28 10:34:36,544 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-9-thread-2) Executing binary at /tmp/hoverfly.13994543323675541291/hoverfly_linux_amd64
2024-11-28 10:34:36,649 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-9-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:36,650 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-9-thread-2) Setting proxy host to localhost
2024-11-28 10:34:36,650 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-9-thread-2) Setting proxy proxyPort to 45201
2024-11-28 10:34:38,246 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.739173645S
2024-11-28 10:34:38,247 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-9-thread-1) DynamoDB - Started at http://localhost:32948
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32948 -Dquarkus.http.test-port=8081"
2024-11-28 10:34:38,763 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:34:38,763 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:38,763 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:38,763 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:38,993 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:38,995 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 2
2024-11-28 10:34:39,045 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:34:39,519 INFO  [io.qua.ama.lam.run.MockEventServer] (build-9) Mock Lambda Event Server Started
2024-11-28 10:34:39,702 INFO  [Lifecycle] (pool-15-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 3
2024-11-28 10:34:39,702 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:39,702 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-15-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:39,703 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-15-thread-2) Storing binary in temporary directory /tmp/hoverfly.13884025429539076904/hoverfly_linux_amd64
2024-11-28 10:34:39,715 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 6141347fca491332531182b8a257da510f880354ff144435dbc655a2da6362c1
2024-11-28 10:34:39,738 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-15-thread-2) Executing binary at /tmp/hoverfly.13884025429539076904/hoverfly_linux_amd64
2024-11-28 10:34:39,842 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-15-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:39,843 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-15-thread-2) Setting proxy host to localhost
2024-11-28 10:34:39,843 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-15-thread-2) Setting proxy proxyPort to 34435
2024-11-28 10:34:41,423 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.720815949S
2024-11-28 10:34:41,423 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-15-thread-1) DynamoDB - Started at http://localhost:32949
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32949 -Dquarkus.http.test-port=8081"
2024-11-28 10:34:41,908 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:34:41,908 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:41,908 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:41,908 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:41,999 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 3
2024-11-28 10:34:42,150 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:42,152 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 3
2024-11-28 10:34:42,202 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:34:42,674 INFO  [io.qua.ama.lam.run.MockEventServer] (build-3) Mock Lambda Event Server Started
2024-11-28 10:34:42,871 INFO  [Lifecycle] (pool-21-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 4
2024-11-28 10:34:42,872 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:42,872 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-21-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:42,872 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-21-thread-2) Storing binary in temporary directory /tmp/hoverfly.17655188331572335351/hoverfly_linux_amd64
2024-11-28 10:34:42,885 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 3b1f1e0efebabd6f978e058eafaeb0fd86af551b97d0dc903ba9069547d51dbf
2024-11-28 10:34:42,908 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-21-thread-2) Executing binary at /tmp/hoverfly.17655188331572335351/hoverfly_linux_amd64
2024-11-28 10:34:43,012 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-21-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:43,013 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-21-thread-2) Setting proxy host to localhost
2024-11-28 10:34:43,013 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-21-thread-2) Setting proxy proxyPort to 35547
2024-11-28 10:34:44,593 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.720668132S
2024-11-28 10:34:44,593 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-21-thread-1) DynamoDB - Started at http://localhost:32950
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32950 -Dquarkus.http.test-port=8081"
2024-11-28 10:34:45,087 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.014s. 
2024-11-28 10:34:45,087 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:45,087 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:45,087 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:45,177 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [352a8ca0d6f3b82615d410b35bce0a5d63f88836] - should return the data for the stored value 2()
2024-11-28 10:34:45,178 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:34:45,179 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 3
2024-11-28 10:34:45,180 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=2, text=Hard work pays off in the future, laziness pays off now.))
2024-11-28 10:34:49,007 ERROR [org.acm.dyn.DataRepository] (Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused

2024-11-28 10:34:49,180 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:49,182 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 4
2024-11-28 10:34:49,232 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:34:49,733 INFO  [io.qua.ama.lam.run.MockEventServer] (build-6) Mock Lambda Event Server Started
2024-11-28 10:34:49,924 INFO  [Lifecycle] (pool-27-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 5
2024-11-28 10:34:49,924 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:49,924 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-27-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:49,925 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-27-thread-2) Storing binary in temporary directory /tmp/hoverfly.14548217981947959973/hoverfly_linux_amd64
2024-11-28 10:34:49,940 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 56dbc9cd6f1e1b895f31cb06b1bfb8f6107e741d7c8df3a01d6cba9d06e13177
2024-11-28 10:34:49,960 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-27-thread-2) Executing binary at /tmp/hoverfly.14548217981947959973/hoverfly_linux_amd64
2024-11-28 10:34:50,064 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-27-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:50,065 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-27-thread-2) Setting proxy host to localhost
2024-11-28 10:34:50,065 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-27-thread-2) Setting proxy proxyPort to 37587
2024-11-28 10:34:51,653 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.729172645S
2024-11-28 10:34:51,654 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-27-thread-1) DynamoDB - Started at http://localhost:32951
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32951 -Dquarkus.http.test-port=8081"
2024-11-28 10:34:52,149 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-28 10:34:52,149 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:52,149 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:52,150 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:52,239 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 5
2024-11-28 10:34:52,391 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:52,394 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 5
2024-11-28 10:34:52,444 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:34:52,934 INFO  [io.qua.ama.lam.run.MockEventServer] (build-11) Mock Lambda Event Server Started
2024-11-28 10:34:53,081 INFO  [Lifecycle] (pool-33-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 6
2024-11-28 10:34:53,082 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:53,082 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-33-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:53,082 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-33-thread-2) Storing binary in temporary directory /tmp/hoverfly.10516392937902909437/hoverfly_linux_amd64
2024-11-28 10:34:53,098 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: e00a9e9762cde17adf0b9d448f74357a37aff315e206565c71ee7ba187578325
2024-11-28 10:34:53,118 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-33-thread-2) Executing binary at /tmp/hoverfly.10516392937902909437/hoverfly_linux_amd64
2024-11-28 10:34:53,222 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-33-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:53,223 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-33-thread-2) Setting proxy host to localhost
2024-11-28 10:34:53,223 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-33-thread-2) Setting proxy proxyPort to 40701
2024-11-28 10:34:54,800 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.718675547S
2024-11-28 10:34:54,801 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-33-thread-1) DynamoDB - Started at http://localhost:32952
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32952 -Dquarkus.http.test-port=8081"
2024-11-28 10:34:55,292 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:34:55,293 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:34:55,293 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:34:55,293 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:34:55,383 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [42c5637130430abe352d67ed8cd478b71059b789] - should return the data for the stored value 3()
2024-11-28 10:34:55,384 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:34:55,385 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 5
2024-11-28 10:34:55,385 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=3, text=Land is always on the mind of a flying bird.))
2024-11-28 10:34:58,487 ERROR [org.acm.dyn.DataRepository] (Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused

2024-11-28 10:34:58,674 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:34:58,676 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 6
2024-11-28 10:34:58,727 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server

2024-11-28 10:34:59,219 INFO  [io.qua.ama.lam.run.MockEventServer] (build-8) Mock Lambda Event Server Started
2024-11-28 10:34:59,379 INFO  [Lifecycle] (pool-39-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 7
2024-11-28 10:34:59,379 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:34:59,380 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-39-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:34:59,380 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-39-thread-2) Storing binary in temporary directory /tmp/hoverfly.534684903071686354/hoverfly_linux_amd64
2024-11-28 10:34:59,394 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 089e7560ffad229a5ea1b028acdf873401cb1e06107f552c303b36fbba630e1b
2024-11-28 10:34:59,415 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-39-thread-2) Executing binary at /tmp/hoverfly.534684903071686354/hoverfly_linux_amd64
2024-11-28 10:34:59,519 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-39-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:34:59,519 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-39-thread-2) Setting proxy host to localhost
2024-11-28 10:34:59,520 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-39-thread-2) Setting proxy proxyPort to 40037
2024-11-28 10:35:01,088 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.708821785S
2024-11-28 10:35:01,089 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-39-thread-1) DynamoDB - Started at http://localhost:32953
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32953 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:01,592 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:01,592 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:01,592 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:01,592 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:01,824 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:01,826 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 7
2024-11-28 10:35:01,877 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:02,342 INFO  [io.qua.ama.lam.run.MockEventServer] (build-9) Mock Lambda Event Server Started
2024-11-28 10:35:02,499 INFO  [Lifecycle] (pool-45-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 8
2024-11-28 10:35:02,500 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:02,500 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-45-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:02,500 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-45-thread-2) Storing binary in temporary directory /tmp/hoverfly.17201942299540889373/hoverfly_linux_amd64
2024-11-28 10:35:02,512 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: cb922de4639bd53c6c0c70e8348ae426ee3a96dd68bb312bceb1ca87e30764c9
2024-11-28 10:35:02,536 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-45-thread-2) Executing binary at /tmp/hoverfly.17201942299540889373/hoverfly_linux_amd64
2024-11-28 10:35:02,641 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-45-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:02,642 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-45-thread-2) Setting proxy host to localhost
2024-11-28 10:35:02,642 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-45-thread-2) Setting proxy proxyPort to 37409
2024-11-28 10:35:04,109 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.609225681S
2024-11-28 10:35:04,109 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-45-thread-1) DynamoDB - Started at http://localhost:32954
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32954 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:04,604 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-28 10:35:04,604 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:04,604 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:04,604 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:04,694 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 8
2024-11-28 10:35:04,845 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:04,847 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 8
2024-11-28 10:35:04,897 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:05,363 INFO  [io.qua.ama.lam.run.MockEventServer] (build-11) Mock Lambda Event Server Started
2024-11-28 10:35:05,524 INFO  [Lifecycle] (pool-51-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 9
2024-11-28 10:35:05,524 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:05,524 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-51-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:05,524 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-51-thread-2) Storing binary in temporary directory /tmp/hoverfly.498533526252868742/hoverfly_linux_amd64
2024-11-28 10:35:05,538 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 3a5c9b540a6b110efbc20b61374c1cfdf42bdec9701f5a03a24370a905ae0cf3
2024-11-28 10:35:05,560 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-51-thread-2) Executing binary at /tmp/hoverfly.498533526252868742/hoverfly_linux_amd64
2024-11-28 10:35:05,664 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-51-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:05,665 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-51-thread-2) Setting proxy host to localhost
2024-11-28 10:35:05,665 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-51-thread-2) Setting proxy proxyPort to 41607
2024-11-28 10:35:07,257 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.733423916S
2024-11-28 10:35:07,258 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-51-thread-1) DynamoDB - Started at http://localhost:32955
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32955 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:07,780 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:07,780 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:07,780 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:07,780 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:07,871 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bc1815a71b2d60894e2613184cbc6519cec154ff] - should return the data for stored value 4()
2024-11-28 10:35:07,871 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:35:07,873 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 8
2024-11-28 10:35:07,874 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=4, text=Wealth awaits you very soon.))
2024-11-28 10:35:10,402 ERROR [org.acm.dyn.DataRepository] (Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused

2024-11-28 10:35:10,573 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:10,575 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 9
2024-11-28 10:35:10,625 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:11,067 INFO  [io.qua.ama.lam.run.MockEventServer] (build-6) Mock Lambda Event Server Started
2024-11-28 10:35:11,239 INFO  [Lifecycle] (pool-57-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 10
2024-11-28 10:35:11,239 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:11,239 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-57-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:11,240 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-57-thread-2) Storing binary in temporary directory /tmp/hoverfly.8950222282489292245/hoverfly_linux_amd64
2024-11-28 10:35:11,253 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 618440ba2cf6289969b646b065816f4c1a95d52b69f8c8634b87a5276306de3c
2024-11-28 10:35:11,275 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-57-thread-2) Executing binary at /tmp/hoverfly.8950222282489292245/hoverfly_linux_amd64
2024-11-28 10:35:11,379 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-57-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:11,379 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-57-thread-2) Setting proxy host to localhost
2024-11-28 10:35:11,380 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-57-thread-2) Setting proxy proxyPort to 42691
2024-11-28 10:35:12,960 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.7208267S
2024-11-28 10:35:12,960 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-57-thread-1) DynamoDB - Started at http://localhost:32956
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32956 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:13,474 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-28 10:35:13,474 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:13,474 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:13,474 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:13,564 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() DataStoreControllerTestNativeTest - 10
2024-11-28 10:35:13,702 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:13,704 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 10
2024-11-28 10:35:13,754 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:14,234 INFO  [io.qua.ama.lam.run.MockEventServer] (build-10) Mock Lambda Event Server Started
2024-11-28 10:35:14,393 INFO  [Lifecycle] (pool-63-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 11
2024-11-28 10:35:14,394 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:14,394 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-63-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:14,394 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-63-thread-2) Storing binary in temporary directory /tmp/hoverfly.8948448167112182846/hoverfly_linux_amd64
2024-11-28 10:35:14,411 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 382445a959a5c40c783cd31c68ccc48bc9acc1ced3c514b59a4649121de8a69c
2024-11-28 10:35:14,429 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-63-thread-2) Executing binary at /tmp/hoverfly.8948448167112182846/hoverfly_linux_amd64
2024-11-28 10:35:14,533 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-63-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:14,533 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-63-thread-2) Setting proxy host to localhost
2024-11-28 10:35:14,534 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-63-thread-2) Setting proxy proxyPort to 46515
2024-11-28 10:35:16,120 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.726509423S
2024-11-28 10:35:16,121 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-63-thread-1) DynamoDB - Started at http://localhost:32957
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32957 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:16,612 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:16,612 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:16,612 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:16,612 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:16,703 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [9fe0704df676a8dc95d38217fcd2d6f51c526ed7] - should return the data for the stored value 5()
2024-11-28 10:35:16,703 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:35:16,706 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 10
2024-11-28 10:35:16,706 INFO  [org.acm.dyn.DataRepository] (Test worker) DynamoDB - test-record-table persistInformation(FortuneCookie(id=5, text=Land is always on the mind of a flying bird.))
2024-11-28 10:35:20,796 ERROR [org.acm.dyn.DataRepository] (Test worker) Error while add in DynamoDB: software.amazon.awssdk.core.exception.SdkClientException: Unable to execute HTTP request: Connection refused


2024-11-28 10:35:20,966 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:20,968 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 11
2024-11-28 10:35:21,018 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:21,511 INFO  [io.qua.ama.lam.run.MockEventServer] (build-8) Mock Lambda Event Server Started
2024-11-28 10:35:21,658 INFO  [Lifecycle] (pool-69-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 12
2024-11-28 10:35:21,659 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:21,659 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-69-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:21,659 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-69-thread-2) Storing binary in temporary directory /tmp/hoverfly.9800490105984612044/hoverfly_linux_amd64
2024-11-28 10:35:21,672 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 96d1e03de4210b65895dbb731323ecd3073a7282db21316213c9105bb1d349b3
2024-11-28 10:35:21,694 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-69-thread-2) Executing binary at /tmp/hoverfly.9800490105984612044/hoverfly_linux_amd64
2024-11-28 10:35:21,798 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-69-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:21,799 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-69-thread-2) Setting proxy host to localhost
2024-11-28 10:35:21,799 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-69-thread-2) Setting proxy proxyPort to 42881
2024-11-28 10:35:23,382 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.723461612S
2024-11-28 10:35:23,382 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-69-thread-1) DynamoDB - Started at http://localhost:32958
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32958 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:23,864 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:23,864 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:23,864 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:23,865 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:24,111 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:24,112 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 12
2024-11-28 10:35:24,163 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:24,641 INFO  [io.qua.ama.lam.run.MockEventServer] (build-9) Mock Lambda Event Server Started
2024-11-28 10:35:24,799 INFO  [Lifecycle] (pool-75-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 13
2024-11-28 10:35:24,800 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:24,800 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-75-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:24,800 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-75-thread-2) Storing binary in temporary directory /tmp/hoverfly.13335110499545396646/hoverfly_linux_amd64
2024-11-28 10:35:24,813 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: 5493007fe3353c499fbe8ed0a7be5add24e4a77c454981ac7f00b740f1e1e4c2
2024-11-28 10:35:24,835 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-75-thread-2) Executing binary at /tmp/hoverfly.13335110499545396646/hoverfly_linux_amd64
2024-11-28 10:35:24,939 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-75-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:24,940 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-75-thread-2) Setting proxy host to localhost
2024-11-28 10:35:24,940 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-75-thread-2) Setting proxy proxyPort to 34791
2024-11-28 10:35:26,522 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.721823583S
2024-11-28 10:35:26,522 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-75-thread-1) DynamoDB - Started at http://localhost:32959
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32959 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:27,004 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:27,004 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:27,004 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:27,004 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:27,254 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:27,256 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 13
2024-11-28 10:35:27,306 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:27,764 INFO  [io.qua.ama.lam.run.MockEventServer] (build-8) Mock Lambda Event Server Started
2024-11-28 10:35:27,928 INFO  [Lifecycle] (pool-81-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 14
2024-11-28 10:35:27,928 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:27,928 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-81-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:27,928 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-81-thread-2) Storing binary in temporary directory /tmp/hoverfly.11445170055603604846/hoverfly_linux_amd64
2024-11-28 10:35:27,941 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: f5e49e74e8db8e4d9ff7867732481f6cdd0a88e5744c0707948036525bb161f2
2024-11-28 10:35:27,963 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-81-thread-2) Executing binary at /tmp/hoverfly.11445170055603604846/hoverfly_linux_amd64
2024-11-28 10:35:28,067 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-81-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:28,068 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-81-thread-2) Setting proxy host to localhost
2024-11-28 10:35:28,068 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-81-thread-2) Setting proxy proxyPort to 45823
2024-11-28 10:35:29,553 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.625216429S
2024-11-28 10:35:29,554 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-81-thread-1) DynamoDB - Started at http://localhost:32960
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32960 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:30,093 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.013s. 
2024-11-28 10:35:30,093 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:30,093 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:30,093 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:30,184 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - inject() PostmanControllerTestNativeTest - 14
2024-11-28 10:35:30,341 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:30,343 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 14
2024-11-28 10:35:30,393 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server
2024-11-28 10:35:30,852 INFO  [io.qua.ama.lam.run.MockEventServer] (build-2) Mock Lambda Event Server Started
2024-11-28 10:35:31,005 INFO  [Lifecycle] (pool-87-thread-3) QuarkusTestResourceLifecycleManager - start() : Counter 15
2024-11-28 10:35:31,006 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Creating container for image: amazon/dynamodb-local:2.5.2
2024-11-28 10:35:31,006 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-87-thread-2) Selecting the following binary based on the current operating system: hoverfly_linux_amd64
2024-11-28 10:35:31,006 INFO  [io.spe.hov.jun.cor.TempFileManager] (pool-87-thread-2) Storing binary in temporary directory /tmp/hoverfly.6055881614776826193/hoverfly_linux_amd64
2024-11-28 10:35:31,018 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 is starting: daff33bea1b5e7bc3fef2adf0a68cb397f9088a95f717d13022bf89d87a832ec
2024-11-28 10:35:31,042 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-87-thread-2) Executing binary at /tmp/hoverfly.6055881614776826193/hoverfly_linux_amd64
2024-11-28 10:35:31,146 INFO  [io.spe.hov.jun.cor.Hoverfly] (pool-87-thread-2) A local Hoverfly with version v1.10.3 is ready
2024-11-28 10:35:31,147 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-87-thread-2) Setting proxy host to localhost
2024-11-28 10:35:31,147 INFO  [io.spe.hov.jun.cor.ProxyConfigurer] (pool-87-thread-2) Setting proxy proxyPort to 37613
2024-11-28 10:35:32,622 INFO  [tc.ama.5.2] (testcontainers-lifecycle-0) Container amazon/dynamodb-local:2.5.2 started in PT1.615814363S
2024-11-28 10:35:32,622 INFO  [org.acm.res.dyn.DynamoDbResource] (pool-87-thread-1) DynamoDB - Started at http://localhost:32961
Executing "/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/code-with-quarkus-1.0.0-SNAPSHOT-runner -Dquarkus.http.port=8081 -Dquarkus.http.ssl-port=8444 -Dtest.url=http://localhost:8081 -Dquarkus.log.file.path=/home/andre/Documents/GitHub/quarkus-kotlin-lambda-native-test/build/quarkus.log -Dquarkus.log.file.enable=true -Dquarkus.log.category."io.quarkus".level=INFO -Dquarkus-internal.aws-lambda.test-api=localhost:8081/_lambda_ -Dquarkus.dynamodb.aws.region=ap-northeast-1 -Dquarkus.tls.trust-all=true -Dquarkus.dynamodb.aws.credentials.static-provider.access-key-id=testKey -DDYNAMODB_TABLE=test-record-table -Dquarkus.dynamodb.aws.credentials.type=static -Dquarkus.dynamodb.devservices.enabled=false -Dquarkus.configuration.build-time-mismatch-at-runtime=fail -Dquarkus.dynamodb.aws.credentials.static-provider.secret-access-key=testSecret -Dquarkus.http.port=8081 -Dquarkus.dynamodb.endpoint-override=http://localhost:32961 -Dquarkus.http.test-port=8081"
2024-11-28 10:35:33,114 INFO  [io.quarkus] (main) code-with-quarkus 1.0.0-SNAPSHOT native (powered by Quarkus 3.17.0.CR1) started in 0.012s. 
2024-11-28 10:35:33,114 INFO  [io.quarkus] (main) Profile prod activated. 
2024-11-28 10:35:33,114 INFO  [io.quarkus] (main) Installed features: [amazon-dynamodb, amazon-lambda, cdi, kotlin, rest, rest-client, rest-client-kotlin-serialization, rest-kotlin-serialization, security, smallrye-context-propagation, vertx]
2024-11-28 10:35:33,114 INFO  [io.qua.ama.lam.run.AbstractLambdaPollLoop] (Lambda Thread (NORMAL)) Listening on: http://localhost:8081/_lambda_/2018-06-01/runtime/invocation/next
2024-11-28 10:35:33,205 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker)  - CASSETE [bd24e7d5515cbcf4ca86ed112241d5539da3c9fd] - should return the same ID in the Controller Request()
2024-11-28 10:35:33,206 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Importing simulation data to Hoverfly
2024-11-28 10:35:33,208 INFO  [Lifecycle] (Test worker) jUnit BeforeEach - Counter: 14
2024-11-28 10:35:34,004 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-2) Request: GET https://postman-echo.com/get?id=test-id Headers[User-Agent=Quarkus REST Client], Empty body
2024-11-28 10:35:34,191 DEBUG [org.jbo.res.rea.cli.log.DefaultClientLogger] (vert.x-eventloop-thread-2) Response: GET https://postman-echo.com/get?id=test-id, Status[200 OK], Headers[Date=Thu, 28 Nov 2024 01:35:34 GMT Content-Type=application/json; charset=utf-8 Content-Length=382 Connection=keep-alive Server=nginx ETag=W/"17e-fpV8n5v8+o+8jbsqWMCH5Ez8uew" set-cookie=sails.sid=s%3Ar7cGi11WXrQWv-OPC3q0uOWBDkW9CnCV.U1P%2Br%2FuJdl94LbxdvYI97yVBAToc%2FRuP0AvVqs%2FrKWo; Path=/; HttpOnly], Body:
{
  "args": {
    "id": "test-id"
  },
  "headers": {
    "host": "postman-echo.com",
    "x-forwarded-proto": "http",
    "x-request-start": "t1732757734.088",
    "connection": "close",
    "x-forwarded-port": "443",
    "x-amzn-trace-id": "Root=1-6747c8e6-3ff923a260f6a98c2672b5e9",
    "user-agent": "Quarkus REST Client"
  },
  "url": "http://postman-echo.com/get?id=test-id"
}
2024-11-28 10:35:34,237 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 10:35:34,237 INFO  [Lifecycle] (Test worker) Test End - QuarkusTestContext is empty
2024-11-28 10:35:34,394 INFO  [io.spe.hov.jun.cor.Hoverfly] (Test worker) Destroying hoverfly process
2024-11-28 10:35:34,396 INFO  [Lifecycle] (Test worker) QuarkusTestResourceLifecycleManager - stop() : Counter 15
2024-11-28 10:35:34,446 INFO  [io.qua.ama.lam.run.MockEventServer] (Test worker) Stopping Mock Lambda Event Server

@geoand
Copy link
Contributor

geoand commented Nov 29, 2024

Thanks a lot.

I tried this but I'm having a really hard time debugging this.
Would it be possible to create a sample that uses Maven, doesn't depend on Lambda and the test resources do the minimum amount of things to surface the problem?

Thanks again!

@andrezimmermann
Copy link
Author

Sure, not familiar with Maven but I will give a try. Sorry this haven't been straight forward reproduce.
I created the reproducer close to the production code I have, sans the actual business related code.

I will try with Gradle without lambda first to see if relates to it.
Anyway thanks for taking the time, I appreciate it.

@geoand
Copy link
Contributor

geoand commented Nov 29, 2024

Thank you for your help!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
area/testing kind/bug Something isn't working
Projects
None yet
Development

No branches or pull requests

2 participants