Skip to content

Instantly share code, notes, and snippets.

@dimitrijer
Created January 24, 2018 13:20
Show Gist options
  • Save dimitrijer/d6433bc07b22903aa0d1d284e895b46a to your computer and use it in GitHub Desktop.
Save dimitrijer/d6433bc07b22903aa0d1d284e895b46a to your computer and use it in GitHub Desktop.
Local test (with less log spam)
-------------------------------------------------------
T E S T S
-------------------------------------------------------
24.01.2018 14:10:30,525 [main] INFO org.testcontainers.dockerclient.UnixSocketClientProviderStrategy - Accessing docker with local Unix socket
24.01.2018 14:10:30,537 [main] INFO org.testcontainers.dockerclient.DockerClientProviderStrategy - Found Docker environment with local Unix socket (unix:///var/run/docker.sock)
24.01.2018 14:10:30,543 [main] INFO org.testcontainers.DockerClientFactory - Docker host IP address is localhost
24.01.2018 14:10:30,732 [main] INFO org.testcontainers.DockerClientFactory - Connected to docker:
Server Version: 17.12.0-ce
API Version: 1.35
Operating System: Docker for Mac
Total Memory: 1998 MB
ℹ︎ Checking the system... 
✔ Docker version is newer than 1.6.0 
✔ Docker environment has more than 2GB free 
✔ File should be mountable 
✔ Exposed port is accessible 
24.01.2018 14:10:32,492 [main] DEBUG:PROFILER 🐳 [test-02.topeleven.com:5000/aerospike:latest] -
+ Profiler [Rule creation - prefetch image]
|---+ Profiler [Obtaining client]
|-- Subtotal [Obtaining client] 20.847 microseconds.
|-- elapsed time [Obtaining client] 20.847 microseconds.
|-- elapsed time [Check local images] 6379.637 microseconds.
|-- Total [Rule creation - prefetch image] 7251.497 microseconds.
24.01.2018 14:10:32,493 [main] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Starting container: test-02.topeleven.com:5000/aerospike:latest
24.01.2018 14:10:32,493 [main] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Trying to start container: test-02.topeleven.com:5000/aerospike:latest
24.01.2018 14:10:32,494 [main] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Trying to start container: test-02.topeleven.com:5000/aerospike:latest (attempt 1/1)
24.01.2018 14:10:32,494 [main] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Starting container: test-02.topeleven.com:5000/aerospike:latest
24.01.2018 14:10:32,494 [main] INFO 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Creating container for image: test-02.topeleven.com:5000/aerospike:latest
24.01.2018 14:10:32,639 [main] INFO 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Starting container with ID: c465cd3f824eb18766e58b7a3bbc3e3c3e0cf383a25a14e36d9646f218abfa33
24.01.2018 14:10:33,441 [main] INFO 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Container test-02.topeleven.com:5000/aerospike:latest is starting: c465cd3f824eb18766e58b7a3bbc3e3c3e0cf383a25a14e36d9646f218abfa33
24.01.2018 14:10:33,469 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/sh -c nc -vz -w 1 localhost 3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:33,531 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/bash -c </dev/tcp/localhost/3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:34,593 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/sh -c nc -vz -w 1 localhost 3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:34,657 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/bash -c </dev/tcp/localhost/3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:35,719 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/sh -c nc -vz -w 1 localhost 3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:35,785 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/bash -c </dev/tcp/localhost/3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:36,854 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/sh -c nc -vz -w 1 localhost 3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:36,911 [pool-2-thread-1] DEBUG 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Running "exec" command: /bin/bash -c </dev/tcp/localhost/3000 && echo TESTCONTAINERS_SUCCESS
24.01.2018 14:10:36,967 [main] INFO 🐳 [test-02.topeleven.com:5000/aerospike:latest] - Container test-02.topeleven.com:5000/aerospike:latest started
24.01.2018 14:10:36,968 [main] DEBUG:PROFILER 🐳 [test-02.topeleven.com:5000/aerospike:latest] -
+ Profiler [Container startup]
|-- elapsed time [Prepare container configuration and host configuration] 1.343 milliseconds.
|---+ Profiler [Container startup attempt]
|-- elapsed time [Create container] 144.652 milliseconds.
|-- elapsed time [Start container] 802.120 milliseconds.
|-- elapsed time [Inspecting container] 6.516 milliseconds.
|-- elapsed time [Call containerIsStarting on subclasses] 0.006 milliseconds.
|-- elapsed time [Wait until container has started properly, or there's evidence it failed to start.] 9.580 milliseconds.
|-- elapsed time [Wait until container started properly] 3509.983 milliseconds.
|-- Subtotal [Container startup attempt] 4473.486 milliseconds.
|-- elapsed time [Container startup attempt] 4473.486 milliseconds.
|-- Total [Container startup] 4474.888 milliseconds.
Running eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords
24.01.2018 14:10:36,975 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testIncrementUnknownLevelGroup
24.01.2018 14:10:38,016 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testIncrementUnknownLevelGroup finished in 1041ms
24.01.2018 14:10:38,019 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testIncrementWithAerospikeException
24.01.2018 14:10:38,038 [main] ERROR UserPoolTracker - Cannot update user count tracker for level group: unknownL3v3lGroup@To#Operate
com.aerospike.client.AerospikeException: com.aerospike.client.AerospikeException
at eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.UserCountAerospikeRecords.incrementAndProlongForLevelGroup(UserCountAerospikeRecords.java:56) [classes/:?]
at eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords.testIncrementWithAerospikeException(TestUserCountAerospikeRecords.java:126) [test-classes/:?]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_162]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_162]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_162]
at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_162]
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) [junit-4.12.jar:4.12]
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.12.jar:4.12]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) [junit-4.12.jar:4.12]
at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [junit-4.12.jar:4.12]
at org.testcontainers.containers.FailureDetectingExternalResource$1.evaluate(FailureDetectingExternalResource.java:30) [testcontainers-1.4.1.jar:?]
at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [junit-4.12.jar:4.12]
at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.12.jar:4.12]
at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [junit-4.12.jar:4.12]
at org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:161) [surefire-junit47-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:290) [surefire-booter-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:242) [surefire-booter-2.19.1.jar:2.19.1]
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:121) [surefire-booter-2.19.1.jar:2.19.1]
24.01.2018 14:10:38,050 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testIncrementWithAerospikeException finished in 31ms
24.01.2018 14:10:38,051 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testGetUnknownLevelGroup
24.01.2018 14:10:38,067 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testGetUnknownLevelGroup finished in 16ms
24.01.2018 14:10:38,068 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testIncrementLevelGroup
24.01.2018 14:10:38,089 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testIncrementLevelGroup finished in 21ms
24.01.2018 14:10:38,090 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testGetLevelGroup
24.01.2018 14:10:38,108 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testGetLevelGroup finished in 18ms
24.01.2018 14:10:38,110 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - Starting testIncrementWithUncheckedException
24.01.2018 14:10:38,127 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords - testIncrementWithUncheckedException finished in 17ms
24.01.2018 14:10:38,130 [main] DEBUG eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.MyGenContainer - Generic container is to be stopped: java.lang.Thread.getStackTrace(Thread.java:1559)
eu.nordeus.util.logging.StackTracer.getCurrentStackTrace(StackTracer.java:21)
eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.MyGenContainer.stop(MyGenContainer.java:25)
org.testcontainers.containers.GenericContainer.finished(GenericContainer.java:549)
org.testcontainers.containers.FailureDetectingExternalResource$1.evaluate(FailureDetectingExternalResource.java:36)
org.junit.rules.RunRules.evaluate(RunRules.java:20)
org.junit.runners.ParentRunner.run(ParentRunner.java:363)
org.junit.runners.Suite.runChild(Suite.java:128)
org.junit.runners.Suite.runChild(Suite.java:27)
org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
org.junit.runners.ParentRunner.run(ParentRunner.java:363)
org.apache.maven.surefire.junitcore.JUnitCore.run(JUnitCore.java:55)
org.apache.maven.surefire.junitcore.JUnitCoreWrapper.createRequestAndRun(JUnitCoreWrapper.java:137)
org.apache.maven.surefire.junitcore.JUnitCoreWrapper.executeEager(JUnitCoreWrapper.java:107)
org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:83)
org.apache.maven.surefire.junitcore.JUnitCoreWrapper.execute(JUnitCoreWrapper.java:75)
org.apache.maven.surefire.junitcore.JUnitCoreProvider.invoke(JUnitCoreProvider.java:161)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:290)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:242)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:121)
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.794 sec - in eu.nordeus.auctionhouse.auction.pool.usercount.aerospike.TestUserCountAerospikeRecords
Results :
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 16.676 s
[INFO] Finished at: 2018-01-24T14:10:39+01:00
[INFO] Final Memory: 42M/415M
[INFO] ------------------------------------------------------------------------
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment