Created
June 5, 2020 12:37
-
-
Save galderz/c65e8a85802d8ffcd0c0600c05689b0b to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
[INFO] ------< io.quarkus:quarkus-universe-integration-tests-camel-kudu >------ | |
[INFO] Building quarkus-universe-integration-tests-camel-kudu 999-SNAPSHOT [1/49] | |
[INFO] --------------------------------[ jar ]--------------------------------- | |
[WARNING] The POM for org.apache.yetus:audience-annotations:jar:0.11.0 is invalid, transitive dependencies (if any) will not be available, enable debug logging for more details | |
[INFO] | |
[INFO] --- maven-enforcer-plugin:3.0.0-M2:enforce (enforce-java-version) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] | |
[INFO] --- maven-enforcer-plugin:3.0.0-M2:enforce (enforce-maven-version) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] | |
[INFO] --- buildnumber-maven-plugin:1.4:create (get-scm-revision) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] Executing: /bin/sh -c cd '/home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu' && 'git' 'rev-parse' '--verify' 'HEAD' | |
[INFO] Working directory: /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu | |
[INFO] Storing buildNumber: 97e3043b7b92052a79e996683a39bd94f886f785 at timestamp: 1591360198816 | |
[INFO] Storing buildScmBranch: master | |
[INFO] | |
[INFO] --- maven-resources-plugin:3.1.0:resources (default-resources) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] Using 'UTF-8' encoding to copy filtered resources. | |
[INFO] skip non existing resourceDirectory /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/src/main/resources | |
[INFO] | |
[INFO] --- build-helper-maven-plugin:3.1.0:reserve-network-port (reserve-network-port) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] Reserved port 42742 for test.http.port.jvm | |
[INFO] Reserved port 41056 for test.https.port.jvm | |
[INFO] Reserved port 46097 for test.http.port.native | |
[INFO] Reserved port 37087 for test.https.port.native | |
[INFO] | |
[INFO] --- maven-compiler-plugin:3.8.0-jboss-2:compile (default-compile) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] No sources to compile | |
[INFO] | |
[INFO] --- maven-resources-plugin:3.1.0:testResources (default-testResources) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] Using 'UTF-8' encoding to copy filtered resources. | |
[INFO] skip non existing resourceDirectory /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/src/test/resources | |
[INFO] | |
[INFO] --- maven-compiler-plugin:3.8.0-jboss-2:testCompile (default-testCompile) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] No sources to compile | |
[INFO] | |
[INFO] --- maven-surefire-plugin:2.22.0:test (default-test) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] | |
[INFO] ------------------------------------------------------- | |
[INFO] T E S T S | |
[INFO] ------------------------------------------------------- | |
[INFO] Running org.apache.camel.quarkus.component.kudu.it.KuduTest | |
ℹ︎ Checking the system... | |
✔ Docker version should be at least 1.6.0 | |
✔ Docker environment should have more than 2GB free disk space | |
2020-06-05 13:30:17,480 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (main) TestcontainersConfiguration(environmentProperties={docker.client.strategy=org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy}, properties={docker.client.strategy=org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy, pull.pause.timeout=120}) | |
2020-06-05 13:30:17,633 INFO [org.tes.doc.DockerClientProviderStrategy] (main) Loaded org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy from ~/.testcontainers.properties, will try it first | |
2020-06-05 13:30:18,911 INFO [org.tes.doc.EnvironmentAndSystemPropertyClientProviderStrategy] (main) Found docker client settings from environment | |
2020-06-05 13:30:18,912 INFO [org.tes.doc.DockerClientProviderStrategy] (main) Found Docker environment with Environment variables, system properties and defaults. Resolved dockerHost=unix:///var/run/docker.sock | |
2020-06-05 13:30:19,751 INFO [org.tes.DockerClientFactory] (main) Docker host IP address is localhost | |
2020-06-05 13:30:20,140 INFO [org.tes.DockerClientFactory] (main) Connected to docker: | |
Server Version: 1.13.1 | |
API Version: 1.26 | |
Operating System: CentOS Linux 7 (Core) | |
Total Memory: 15840 MB | |
2020-06-05 13:30:22,843 INFO [org.tes.DockerClientFactory] (main) Ryuk started - will monitor and terminate Testcontainers containers on JVM exit | |
2020-06-05 13:30:23,515 INFO [🐳 .9.0]] (main) Pulling docker image: apache/kudu:1.9.0. Please be patient; this may take some time but only needs to be done once. | |
2020-06-05 13:30:23,546 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Starting to pull image | |
2020-06-05 13:30:25,159 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 0 downloaded, 0 extracted, (0 bytes/0 bytes) | |
2020-06-05 13:30:25,562 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 10 pending, 1 downloaded, 0 extracted, (847 bytes/? MB) | |
2020-06-05 13:30:25,669 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 9 pending, 2 downloaded, 0 extracted, (431 KB/? MB) | |
2020-06-05 13:30:26,152 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 8 pending, 3 downloaded, 0 extracted, (7 MB/? MB) | |
2020-06-05 13:30:26,395 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 7 pending, 4 downloaded, 0 extracted, (10 MB/? MB) | |
2020-06-05 13:30:27,324 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 6 pending, 5 downloaded, 0 extracted, (23 MB/? MB) | |
2020-06-05 13:30:29,224 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 5 pending, 6 downloaded, 0 extracted, (49 MB/? MB) | |
2020-06-05 13:30:30,782 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 4 pending, 7 downloaded, 0 extracted, (68 MB/? MB) | |
2020-06-05 13:30:32,276 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 3 pending, 8 downloaded, 0 extracted, (89 MB/? MB) | |
2020-06-05 13:30:33,100 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 2 pending, 9 downloaded, 0 extracted, (101 MB/? MB) | |
2020-06-05 13:30:37,424 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 1 pending, 10 downloaded, 0 extracted, (162 MB/? MB) | |
2020-06-05 13:30:37,765 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 0 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:43,063 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 1 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:43,151 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 2 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:43,211 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 3 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:43,278 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 4 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:43,349 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 5 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:45,352 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 6 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:45,422 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 7 extracted, (166 MB/168 MB) | |
2020-06-05 13:30:50,877 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 8 extracted, (167 MB/168 MB) | |
2020-06-05 13:30:51,070 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 9 extracted, (167 MB/168 MB) | |
2020-06-05 13:30:51,131 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 10 extracted, (167 MB/168 MB) | |
2020-06-05 13:30:56,680 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pulling image layers: 0 pending, 11 downloaded, 11 extracted, (168 MB/168 MB) | |
2020-06-05 13:30:56,689 INFO [🐳 .9.0]] (tc-okhttp-stream-1129119773) Pull complete. 11 layers, pulled in 33s (downloaded 168 MB at 5 MB/s) | |
2020-06-05 13:30:56,749 INFO [🐳 .9.0]] (main) Creating container for image: apache/kudu:1.9.0 | |
2020-06-05 13:30:57,114 INFO [🐳 .9.0]] (main) Starting container with ID: bae6fe01123a681f28eaddb16ce2ad7569e1759745efda6e9e0efbbf8e1cc741 | |
2020-06-05 13:30:58,342 INFO [🐳 .9.0]] (main) Container apache/kudu:1.9.0 is starting: bae6fe01123a681f28eaddb16ce2ad7569e1759745efda6e9e0efbbf8e1cc741 | |
2020-06-05 13:31:03,411 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.399549 1 master_main.cc:73] Master server non-default flags: | |
2020-06-05 13:31:03,411 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: --use_hybrid_clock=false | |
2020-06-05 13:31:03,432 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: --fs_wal_dir=/var/lib/kudu/master | |
2020-06-05 13:31:03,432 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: --webserver_doc_root=/opt/kudu/www | |
2020-06-05 13:31:03,433 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: --heap_profile_path=/tmp/kudu-master.1 | |
2020-06-05 13:31:03,434 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: --logtostderr=true | |
2020-06-05 13:31:03,434 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Master server version: | |
2020-06-05 13:31:03,435 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: kudu 1.9.0 | |
2020-06-05 13:31:03,442 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: revision deb0f04b0 | |
2020-06-05 13:31:03,442 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: build type RELEASE | |
2020-06-05 13:31:03,443 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: built by None at 12 Jun 2019 22:07:34 UTC on 3be9a5c52ce2 | |
2020-06-05 13:31:03,443 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.400354 1 minidump.cc:237] Setting minidump size limit to 20M | |
2020-06-05 13:31:03,444 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404122 1 master_main.cc:80] Initializing master server... | |
2020-06-05 13:31:03,444 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404443 1 fs_manager.cc:248] Data directories (fs_data_dirs) not provided | |
2020-06-05 13:31:03,445 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404471 1 fs_manager.cc:249] Using write-ahead log directory (fs_wal_dir) as data directory | |
2020-06-05 13:31:03,445 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404489 1 fs_manager.cc:263] Metadata directory not provided | |
2020-06-05 13:31:03,446 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404527 1 fs_manager.cc:269] Using write-ahead log directory (fs_wal_dir) as metadata directory | |
2020-06-05 13:31:03,446 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404624 1 server_base.cc:432] Could not load existing FS layout: Not found: could not find a healthy instance file | |
2020-06-05 13:31:03,447 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.404649 1 server_base.cc:433] Attempting to create new FS layout instead | |
2020-06-05 13:31:03,447 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.408277 1 fs_manager.cc:602] Generated new instance metadata in path /var/lib/kudu/master/instance: | |
2020-06-05 13:31:03,448 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: uuid: "b89e18a189b548ea94789ee912bb07cb" | |
2020-06-05 13:31:03,448 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: format_stamp: "Formatted at 2020-06-05 12:31:03 on bae6fe01123a" | |
2020-06-05 13:31:03,448 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.412839 1 fs_manager.cc:503] Time spent creating directory manager: real 0.004s user 0.000s sys 0.003s | |
2020-06-05 13:31:03,449 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: W0605 12:31:03.413144 1 env_posix.cc:1724] Path /var/lib/kudu/master has permissions 755 which are less restrictive than current umask value 077: resetting permissions to 700 | |
2020-06-05 13:31:03,449 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.413211 1 env_posix.cc:1676] Not raising this process' open files per process limit of 1048576; it is already as high as it can go | |
2020-06-05 13:31:03,450 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.413717 1 file_cache.cc:466] Constructed file cache lbm with capacity 419430 | |
2020-06-05 13:31:03,450 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.415314 1 fs_manager.cc:419] Time spent opening block manager: real 0.000s user 0.000s sys 0.000s | |
2020-06-05 13:31:03,451 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.415360 1 fs_manager.cc:436] Opened local filesystem: /var/lib/kudu/master | |
2020-06-05 13:31:03,451 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: uuid: "b89e18a189b548ea94789ee912bb07cb" | |
2020-06-05 13:31:03,452 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: format_stamp: "Formatted at 2020-06-05 12:31:03 on bae6fe01123a" | |
2020-06-05 13:31:03,452 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.415406 1 fs_report.cc:352] FS layout report | |
2020-06-05 13:31:03,453 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: -------------------- | |
2020-06-05 13:31:03,453 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: wal directory: /var/lib/kudu/master | |
2020-06-05 13:31:03,453 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: metadata directory: /var/lib/kudu/master | |
2020-06-05 13:31:03,454 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 1 data directories: /var/lib/kudu/master/data | |
2020-06-05 13:31:03,454 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total live blocks: 0 | |
2020-06-05 13:31:03,455 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total live bytes: 0 | |
2020-06-05 13:31:03,455 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total live bytes (after alignment): 0 | |
2020-06-05 13:31:03,456 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total number of LBM containers: 0 (0 full) | |
2020-06-05 13:31:03,456 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Did not check for missing blocks | |
2020-06-05 13:31:03,457 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Did not check for orphaned blocks | |
2020-06-05 13:31:03,457 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total full LBM containers with extra space: 0 (0 repaired) | |
2020-06-05 13:31:03,457 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total full LBM container extra space in bytes: 0 (0 repaired) | |
2020-06-05 13:31:03,458 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total incomplete LBM containers: 0 (0 repaired) | |
2020-06-05 13:31:03,458 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Total LBM partial records: 0 (0 repaired) | |
2020-06-05 13:31:03,610 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.608687 1 env_posix.cc:1676] Not raising this process' running threads per effective uid limit of 1048576; it is already as high as it can go | |
2020-06-05 13:31:03,610 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.609179 1 master_main.cc:83] Starting Master server... | |
2020-06-05 13:31:03,615 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.613175 1 rpc_server.cc:205] RPC server started. Bound to: 0.0.0.0:7051 | |
2020-06-05 13:31:03,615 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.613248 1 webserver.cc:175] Starting webserver on 0.0.0.0:8051 | |
2020-06-05 13:31:03,616 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.613270 1 webserver.cc:180] Document root: /opt/kudu/www | |
2020-06-05 13:31:03,617 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.613546 1 webserver.cc:313] Webserver started. Bound to: http://0.0.0.0:8051/ | |
2020-06-05 13:31:03,618 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.614127 134 data_dirs.cc:938] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed | |
2020-06-05 13:31:03,620 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.618862 134 tablet_bootstrap.cc:439] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb: Bootstrap starting. | |
2020-06-05 13:31:03,621 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.619422 134 tablet_bootstrap.cc:593] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb: No blocks or log segments found. Creating new log. | |
2020-06-05 13:31:03,621 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.619683 134 log.cc:525] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb: Log is configured to *not* fsync() on all Append() calls | |
2020-06-05 13:31:03,622 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.620225 134 tablet_bootstrap.cc:439] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb: No bootstrap required, opened a new log | |
2020-06-05 13:31:03,623 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.621862 134 raft_consensus.cc:340] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Replica starting. Triggering 0 pending transactions. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } | |
2020-06-05 13:31:03,623 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.621908 134 raft_consensus.cc:366] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely | |
2020-06-05 13:31:03,630 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.621930 134 raft_consensus.cc:705] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b89e18a189b548ea94789ee912bb07cb, State: Initialized, Role: FOLLOWER | |
2020-06-05 13:31:03,630 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622007 134 consensus_queue.cc:229] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } | |
2020-06-05 13:31:03,630 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622035 134 raft_consensus.cc:380] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately | |
2020-06-05 13:31:03,630 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622056 134 raft_consensus.cc:472] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration) | |
2020-06-05 13:31:03,630 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622083 134 raft_consensus.cc:2886] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 0 FOLLOWER]: Advancing to term 1 | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622637 134 raft_consensus.cc:494] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622697 134 leader_election.cc:306] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: b89e18a189b548ea94789ee912bb07cb; no voters: | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622817 134 leader_election.cc:292] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [CANDIDATE]: Term 1 election: Requested vote from peers | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.622896 136 raft_consensus.cc:2640] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 1 FOLLOWER]: Leader election won for term 1 | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623041 136 raft_consensus.cc:667] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [term 1 LEADER]: Becoming Leader. State: Replica: b89e18a189b548ea94789ee912bb07cb, State: Running, Role: LEADER | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623101 136 consensus_queue.cc:206] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } | |
2020-06-05 13:31:03,631 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623306 134 sys_catalog.cc:337] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: SysCatalogTable state changed. Reason: Started TabletReplica. Latest consensus state: current_term: 1 leader_uuid: "b89e18a189b548ea94789ee912bb07cb" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } } | |
2020-06-05 13:31:03,632 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623360 137 sys_catalog.cc:337] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "b89e18a189b548ea94789ee912bb07cb" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } } | |
2020-06-05 13:31:03,632 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623391 137 sys_catalog.cc:340] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: This master's current role is: LEADER | |
2020-06-05 13:31:03,632 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623440 134 sys_catalog.cc:340] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: This master's current role is: LEADER | |
2020-06-05 13:31:03,632 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623349 138 sys_catalog.cc:337] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: SysCatalogTable state changed. Reason: New leader b89e18a189b548ea94789ee912bb07cb. Latest consensus state: current_term: 1 leader_uuid: "b89e18a189b548ea94789ee912bb07cb" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "b89e18a189b548ea94789ee912bb07cb" member_type: VOTER } } | |
2020-06-05 13:31:03,632 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623592 134 sys_catalog.cc:424] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: configured and running, proceeding with master startup. | |
2020-06-05 13:31:03,633 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623606 140 catalog_manager.cc:1046] Loading table and tablet metadata into memory... | |
2020-06-05 13:31:03,634 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623713 138 sys_catalog.cc:340] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb [sys.catalog]: This master's current role is: LEADER | |
2020-06-05 13:31:03,634 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.623951 1 master_main.cc:86] Master server successfully started. | |
2020-06-05 13:31:03,635 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.624002 140 catalog_manager.cc:1057] Initializing Kudu internal certificate authority... | |
2020-06-05 13:31:03,827 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.825832 140 catalog_manager.cc:941] Generated new certificate authority record | |
2020-06-05 13:31:03,852 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:03.828768 140 catalog_manager.cc:1066] Loading token signing keys... | |
2020-06-05 13:31:04,003 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: W0605 12:31:03.999984 160 negotiation.cc:313] Failed RPC negotiation. Trace: | |
2020-06-05 13:31:04,003 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:03.999287 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 127.0.0.1:42384 | |
2020-06-05 13:31:04,003 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:03.999784 (+ 497us) server_negotiation.cc:183] Beginning negotiation | |
2020-06-05 13:31:04,003 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:03.999790 (+ 6us) server_negotiation.cc:372] Waiting for connection header | |
2020-06-05 13:31:04,004 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:03.999900 (+ 110us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 127.0.0.1:42384: BlockingRecv error: recv got EOF from 127.0.0.1:42384 (error 108) | |
2020-06-05 13:31:04,004 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Metrics: {"server-negotiator.queue_time_us":427,"thread_start_us":389,"threads_started":1} | |
2020-06-05 13:31:04,014 INFO [🐳 .9.0]] (main) Container apache/kudu:1.9.0 started in PT46.406553S | |
2020-06-05 13:31:04,016 INFO [🐳 .9.0]] (main) Creating container for image: apache/kudu:1.9.0 | |
2020-06-05 13:31:04,017 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: W0605 12:31:04.015666 160 negotiation.cc:313] Failed RPC negotiation. Trace: | |
2020-06-05 13:31:04,018 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:04.015223 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 172.18.0.1:54028 | |
2020-06-05 13:31:04,018 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:04.015313 (+ 90us) server_negotiation.cc:183] Beginning negotiation | |
2020-06-05 13:31:04,019 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:04.015318 (+ 5us) server_negotiation.cc:372] Waiting for connection header | |
2020-06-05 13:31:04,019 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:04.015608 (+ 290us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 172.18.0.1:54028: BlockingRecv error: recv got EOF from 172.18.0.1:54028 (error 108) | |
2020-06-05 13:31:04,020 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Metrics: {"server-negotiator.queue_time_us":37} | |
2020-06-05 13:31:04,057 INFO [🐳 .9.0]] (main) Starting container with ID: 73815976c21ff02094d2a57d48fd4c09e3171d2c7a374e699fdd6afacdf7424d | |
2020-06-05 13:31:04,352 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:04.349237 140 catalog_manager.cc:4095] T 00000000000000000000000000000000 P b89e18a189b548ea94789ee912bb07cb: Generated new TSK 0 | |
2020-06-05 13:31:04,456 INFO [🐳 .9.0]] (main) Container apache/kudu:1.9.0 is starting: 73815976c21ff02094d2a57d48fd4c09e3171d2c7a374e699fdd6afacdf7424d | |
2020-06-05 13:31:09,517 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.514295 1 tablet_server_main.cc:78] Tablet server non-default flags: | |
2020-06-05 13:31:09,518 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --use_hybrid_clock=false | |
2020-06-05 13:31:09,518 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --fs_wal_dir=/var/lib/kudu/tserver | |
2020-06-05 13:31:09,518 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --webserver_doc_root=/opt/kudu/www | |
2020-06-05 13:31:09,520 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --tserver_master_addrs=kudu-master | |
2020-06-05 13:31:09,520 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --heap_profile_path=/tmp/kudu-tserver.1 | |
2020-06-05 13:31:09,527 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: --logtostderr=true | |
2020-06-05 13:31:09,527 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Tablet server version: | |
2020-06-05 13:31:09,528 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: kudu 1.9.0 | |
2020-06-05 13:31:09,528 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: revision deb0f04b0 | |
2020-06-05 13:31:09,529 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: build type RELEASE | |
2020-06-05 13:31:09,529 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: built by None at 12 Jun 2019 22:07:34 UTC on 3be9a5c52ce2 | |
2020-06-05 13:31:09,530 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.515494 1 minidump.cc:237] Setting minidump size limit to 20M | |
2020-06-05 13:31:09,530 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.518795 1 tablet_server_main.cc:85] Initializing tablet server... | |
2020-06-05 13:31:09,562 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.560745 1 fs_manager.cc:248] Data directories (fs_data_dirs) not provided | |
2020-06-05 13:31:09,563 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.560802 1 fs_manager.cc:249] Using write-ahead log directory (fs_wal_dir) as data directory | |
2020-06-05 13:31:09,563 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.560827 1 fs_manager.cc:263] Metadata directory not provided | |
2020-06-05 13:31:09,564 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.560914 1 fs_manager.cc:269] Using write-ahead log directory (fs_wal_dir) as metadata directory | |
2020-06-05 13:31:09,564 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.561046 1 server_base.cc:432] Could not load existing FS layout: Not found: could not find a healthy instance file | |
2020-06-05 13:31:09,564 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.561071 1 server_base.cc:433] Attempting to create new FS layout instead | |
2020-06-05 13:31:09,565 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.564296 1 fs_manager.cc:602] Generated new instance metadata in path /var/lib/kudu/tserver/instance: | |
2020-06-05 13:31:09,598 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: uuid: "c49a97e6ad874c3bb6a397b392503c3b" | |
2020-06-05 13:31:09,598 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: format_stamp: "Formatted at 2020-06-05 12:31:09 on kudu-tserver" | |
2020-06-05 13:31:09,599 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.569723 1 fs_manager.cc:503] Time spent creating directory manager: real 0.005s user 0.003s sys 0.002s | |
2020-06-05 13:31:09,600 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: W0605 12:31:09.570219 1 env_posix.cc:1724] Path /var/lib/kudu/tserver has permissions 755 which are less restrictive than current umask value 077: resetting permissions to 700 | |
2020-06-05 13:31:09,600 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.570348 1 env_posix.cc:1676] Not raising this process' open files per process limit of 1048576; it is already as high as it can go | |
2020-06-05 13:31:09,601 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.571060 1 file_cache.cc:466] Constructed file cache lbm with capacity 419430 | |
2020-06-05 13:31:09,601 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.572934 1 fs_manager.cc:419] Time spent opening block manager: real 0.000s user 0.000s sys 0.000s | |
2020-06-05 13:31:09,601 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.572984 1 fs_manager.cc:436] Opened local filesystem: /var/lib/kudu/tserver | |
2020-06-05 13:31:09,602 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: uuid: "c49a97e6ad874c3bb6a397b392503c3b" | |
2020-06-05 13:31:09,603 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: format_stamp: "Formatted at 2020-06-05 12:31:09 on kudu-tserver" | |
2020-06-05 13:31:09,603 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:09.573043 1 fs_report.cc:352] FS layout report | |
2020-06-05 13:31:09,603 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: -------------------- | |
2020-06-05 13:31:09,604 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: wal directory: /var/lib/kudu/tserver | |
2020-06-05 13:31:09,605 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: metadata directory: /var/lib/kudu/tserver | |
2020-06-05 13:31:09,605 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 1 data directories: /var/lib/kudu/tserver/data | |
2020-06-05 13:31:09,605 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total live blocks: 0 | |
2020-06-05 13:31:09,606 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total live bytes: 0 | |
2020-06-05 13:31:09,606 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total live bytes (after alignment): 0 | |
2020-06-05 13:31:09,607 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total number of LBM containers: 0 (0 full) | |
2020-06-05 13:31:09,607 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Did not check for missing blocks | |
2020-06-05 13:31:09,608 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Did not check for orphaned blocks | |
2020-06-05 13:31:09,608 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total full LBM containers with extra space: 0 (0 repaired) | |
2020-06-05 13:31:09,609 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total full LBM container extra space in bytes: 0 (0 repaired) | |
2020-06-05 13:31:09,609 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total incomplete LBM containers: 0 (0 repaired) | |
2020-06-05 13:31:09,610 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Total LBM partial records: 0 (0 repaired) | |
2020-06-05 13:31:10,004 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.001855 1 env_posix.cc:1676] Not raising this process' running threads per effective uid limit of 1048576; it is already as high as it can go | |
2020-06-05 13:31:10,005 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.002427 1 ts_tablet_manager.cc:356] Loaded tablet metadata (0 live tablets) | |
2020-06-05 13:31:10,006 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.002526 1 tablet_server_main.cc:90] Starting tablet server... | |
2020-06-05 13:31:10,012 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.010999 1 rpc_server.cc:205] RPC server started. Bound to: 0.0.0.0:7050 | |
2020-06-05 13:31:10,013 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.011107 1 webserver.cc:175] Starting webserver on 0.0.0.0:8050 | |
2020-06-05 13:31:10,014 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.011126 1 webserver.cc:180] Document root: /opt/kudu/www | |
2020-06-05 13:31:10,014 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.011467 1 webserver.cc:313] Webserver started. Bound to: http://0.0.0.0:8050/ | |
2020-06-05 13:31:10,015 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.011931 1 tablet_server_main.cc:93] Tablet server successfully started. | |
2020-06-05 13:31:10,028 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.026729 194 heartbeater.cc:345] Connected to a master server at kudu-master:7051 | |
2020-06-05 13:31:10,028 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.026813 194 heartbeater.cc:425] Registering TS with master... | |
2020-06-05 13:31:10,029 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:10.027089 194 heartbeater.cc:474] Master kudu-master:7051 requested a full tablet report, sending... | |
2020-06-05 13:31:10,030 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:10.027599 101 ts_manager.cc:98] Registered new tserver with Master: c49a97e6ad874c3bb6a397b392503c3b (kudu-tserver:7050) | |
2020-06-05 13:31:10,033 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:10.031877 101 master_service.cc:263] Signed X509 certificate for tserver {username='kudu'} at 172.18.0.3:52066 | |
2020-06-05 13:31:10,710 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: W0605 12:31:10.707801 212 negotiation.cc:313] Failed RPC negotiation. Trace: | |
2020-06-05 13:31:10,711 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.707375 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 127.0.0.1:49782 | |
2020-06-05 13:31:10,715 INFO [🐳 .9.0]] (main) Container apache/kudu:1.9.0 started in PT6.699127S | |
2020-06-05 13:31:10,715 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (main) Kudu master RPC accessible at localhost:32865 | |
2020-06-05 13:31:10,715 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (main) Kudu master HTTP accessible at localhost:32864 | |
2020-06-05 13:31:10,715 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (main) Kudu tablet server RPC accessible at localhost:7050 | |
2020-06-05 13:31:10,715 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (main) Kudu tablet server HTTP accessible at localhost:8050 | |
2020-06-05 13:31:10,831 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.707593 (+ 218us) server_negotiation.cc:183] Beginning negotiation | |
2020-06-05 13:31:10,832 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.707597 (+ 4us) server_negotiation.cc:372] Waiting for connection header | |
2020-06-05 13:31:10,832 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.707698 (+ 101us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 127.0.0.1:49782: BlockingRecv error: recv got EOF from 127.0.0.1:49782 (error 108) | |
2020-06-05 13:31:10,832 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Metrics: {"server-negotiator.queue_time_us":152,"thread_start_us":79,"threads_started":1} | |
2020-06-05 13:31:10,832 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: W0605 12:31:10.715709 212 negotiation.cc:313] Failed RPC negotiation. Trace: | |
2020-06-05 13:31:10,833 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.715386 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 172.18.0.1:56738 | |
2020-06-05 13:31:10,833 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.715455 (+ 69us) server_negotiation.cc:183] Beginning negotiation | |
2020-06-05 13:31:10,834 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.715458 (+ 3us) server_negotiation.cc:372] Waiting for connection header | |
2020-06-05 13:31:10,834 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: 0605 12:31:10.715677 (+ 219us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 172.18.0.1:56738: BlockingRecv error: recv got EOF from 172.18.0.1:56738 (error 108) | |
2020-06-05 13:31:10,835 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: Metrics: {"server-negotiator.queue_time_us":33} | |
2020-06-05 13:31:10,839 WARN [io.qua.config] (main) Unrecognized configuration key "quarkus.version" was provided; it will be ignored | |
2020-06-05 13:31:11,035 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:11.032950 194 heartbeater.cc:466] Master kudu-master:7051 was elected leader, sending a full tablet report... | |
2020-06-05 13:31:13,383 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) is starting | |
2020-06-05 13:31:13,384 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) StreamCaching is not in use. If using streams then its recommended to enable stream caching. See more details at http://camel.apache.org/stream-caching.html | |
2020-06-05 13:31:13,878 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route1 started and consuming from: direct://create_table | |
2020-06-05 13:31:13,880 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route2 started and consuming from: direct://insert | |
2020-06-05 13:31:13,880 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route3 started and consuming from: direct://scan | |
2020-06-05 13:31:13,881 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Total 3 routes, of which 3 are started | |
2020-06-05 13:31:13,881 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) started in 0.498 seconds | |
2020-06-05 13:31:13,887 INFO [org.apa.cam.qua.com.kud.it.KuduInfrastructureTestHelper] (main) Attempting to override the kudu tablet server hostname resolution on application startup | |
2020-06-05 13:31:14,333 INFO [io.quarkus] (main) Quarkus 999-SNAPSHOT on JVM started in 62.422s. Listening on: http://0.0.0.0:42742 | |
2020-06-05 13:31:14,341 INFO [io.quarkus] (main) Profile test activated. | |
2020-06-05 13:31:14,342 INFO [io.quarkus] (main) Installed features: [camel-bean, camel-core, camel-direct, camel-kudu, camel-policy, camel-support-common, camel-support-commons-logging, cdi, resteasy] | |
2020-06-05 13:31:15,886 INFO [org.apa.cam.qua.com.kud.it.KuduTest] (main) Calling createTableShouldSucceed | |
2020-06-05 13:31:19,104 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: W0605 12:31:19.100332 165 negotiation.cc:313] Failed RPC negotiation. Trace: | |
2020-06-05 13:31:19,170 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:16.100167 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 172.18.0.1:54072 | |
2020-06-05 13:31:19,171 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:16.100460 (+ 293us) server_negotiation.cc:183] Beginning negotiation | |
2020-06-05 13:31:19,171 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:16.100466 (+ 6us) server_negotiation.cc:372] Waiting for connection header | |
2020-06-05 13:31:19,171 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:16.115724 (+ 15258us) server_negotiation.cc:380] Connection header received | |
2020-06-05 13:31:19,172 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:18.271094 (+2155370us) server_negotiation.cc:336] Received NEGOTIATE NegotiatePB request | |
2020-06-05 13:31:19,172 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:18.271097 (+ 3us) server_negotiation.cc:419] Received NEGOTIATE request from client | |
2020-06-05 13:31:19,172 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:18.271126 (+ 29us) server_negotiation.cc:348] Sending NEGOTIATE NegotiatePB response | |
2020-06-05 13:31:19,172 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:18.271242 (+ 116us) server_negotiation.cc:204] Negotiated authn=SASL | |
2020-06-05 13:31:19,173 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: 0605 12:31:19.100215 (+828973us) negotiation.cc:304] Negotiation complete: Timed out: Server connection negotiation failed: server connection from 172.18.0.1:54072 | |
2020-06-05 13:31:19,173 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: Metrics: {"server-negotiator.queue_time_us":218,"thread_start_us":110,"threads_started":1} | |
2020-06-05 13:31:19,368 INFO [org.apa.kud.cli.ConnectToCluster] (New I/O worker #52) Unable to connect to master localhost:32865: connection disconnected | |
2020-06-05 13:31:19,381 WARN [org.apa.kud.cli.ConnectToCluster] (New I/O worker #52) Unable to find the leader master localhost:32865; will retry | |
2020-06-05 13:31:21,230 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling createTable | |
2020-06-05 13:31:21,565 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:21.563024 101 catalog_manager.cc:1386] Servicing CreateTable request from {username='g'} at 172.18.0.1:54082: | |
2020-06-05 13:31:21,565 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: name: "TestTable" | |
2020-06-05 13:31:21,566 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: schema { | |
2020-06-05 13:31:21,566 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: columns { | |
2020-06-05 13:31:21,566 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: name: "id" | |
2020-06-05 13:31:21,574 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: type: STRING | |
2020-06-05 13:31:21,575 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: is_key: true | |
2020-06-05 13:31:21,575 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: is_nullable: false | |
2020-06-05 13:31:21,575 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: cfile_block_size: 0 | |
2020-06-05 13:31:21,575 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,576 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: columns { | |
2020-06-05 13:31:21,576 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: name: "name" | |
2020-06-05 13:31:21,576 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: type: STRING | |
2020-06-05 13:31:21,576 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: is_key: false | |
2020-06-05 13:31:21,577 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: is_nullable: false | |
2020-06-05 13:31:21,577 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: cfile_block_size: 0 | |
2020-06-05 13:31:21,577 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,578 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,578 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: num_replicas: 1 | |
2020-06-05 13:31:21,578 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: partition_schema { | |
2020-06-05 13:31:21,579 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: range_schema { | |
2020-06-05 13:31:21,579 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: columns { | |
2020-06-05 13:31:21,579 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: name: "id" | |
2020-06-05 13:31:21,683 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,683 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.578379 131 tablet_service.cc:774] Processing CreateTablet for tablet d5fc23dca1314008a20e7c895ba6c30e (table=TestTable [id=b1a86b781cd64415bdd665d64281f53e]), partition=RANGE (id) PARTITION UNBOUNDED | |
2020-06-05 13:31:21,684 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,684 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.578912 131 data_dirs.cc:938] Could only allocate 1 dirs of requested 3 for tablet d5fc23dca1314008a20e7c895ba6c30e. 1 dirs total, 0 dirs full, 0 dirs failed | |
2020-06-05 13:31:21,684 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: } | |
2020-06-05 13:31:21,696 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.672451 131 ts_tablet_manager.cc:1175] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Registered tablet (data state: TABLET_DATA_READY) | |
2020-06-05 13:31:21,696 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.674077 214 ts_tablet_manager.cc:1030] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Bootstrapping tablet | |
2020-06-05 13:31:21,698 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.674291 214 tablet_bootstrap.cc:439] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Bootstrap starting. | |
2020-06-05 13:31:21,698 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.675071 214 tablet_bootstrap.cc:593] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: No blocks or log segments found. Creating new log. | |
2020-06-05 13:31:21,698 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.675410 214 log.cc:525] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Log is configured to *not* fsync() on all Append() calls | |
2020-06-05 13:31:21,699 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.681780 214 tablet_bootstrap.cc:439] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: No bootstrap required, opened a new log | |
2020-06-05 13:31:21,699 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.681881 214 ts_tablet_manager.cc:1047] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Time spent bootstrapping tablet: real 0.008s user 0.000s sys 0.001s | |
2020-06-05 13:31:21,699 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.683723 214 raft_consensus.cc:340] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending transactions. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c49a97e6ad874c3bb6a397b392503c3b" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
2020-06-05 13:31:21,701 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.683840 214 raft_consensus.cc:366] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely | |
2020-06-05 13:31:21,701 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.683953 214 raft_consensus.cc:705] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c49a97e6ad874c3bb6a397b392503c3b, State: Initialized, Role: FOLLOWER | |
2020-06-05 13:31:21,702 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.684128 214 consensus_queue.cc:229] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c49a97e6ad874c3bb6a397b392503c3b" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
2020-06-05 13:31:21,702 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.684255 214 raft_consensus.cc:380] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately | |
2020-06-05 13:31:21,703 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.684350 214 raft_consensus.cc:472] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration) | |
2020-06-05 13:31:21,703 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.684449 214 raft_consensus.cc:2886] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 0 FOLLOWER]: Advancing to term 1 | |
2020-06-05 13:31:21,703 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686400 214 raft_consensus.cc:494] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c49a97e6ad874c3bb6a397b392503c3b" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
2020-06-05 13:31:21,704 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686506 214 leader_election.cc:306] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: c49a97e6ad874c3bb6a397b392503c3b; no voters: | |
2020-06-05 13:31:21,705 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686683 214 leader_election.cc:292] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [CANDIDATE]: Term 1 election: Requested vote from peers | |
2020-06-05 13:31:21,706 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686786 216 raft_consensus.cc:2640] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 1 FOLLOWER]: Leader election won for term 1 | |
2020-06-05 13:31:21,711 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686903 214 ts_tablet_manager.cc:1075] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b: Time spent starting tablet: real 0.005suser 0.003s sys 0.001s | |
2020-06-05 13:31:21,712 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.686995 216 raft_consensus.cc:667] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [term 1 LEADER]: Becoming Leader. State: Replica: c49a97e6ad874c3bb6a397b392503c3b, State: Running, Role: LEADER | |
2020-06-05 13:31:21,713 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-1693394713) STDOUT: I0605 12:31:21.687860 101 catalog_manager.cc:3791] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b reported cstate change: term changed from 0 to 1, leader changed from <none> to c49a97e6ad874c3bb6a397b392503c3b (kudu-tserver). New cstate: current_term: 1 leader_uuid: "c49a97e6ad874c3bb6a397b392503c3b" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c49a97e6ad874c3bb6a397b392503c3b" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } health_report { overall_health: HEALTHY } } } | |
2020-06-05 13:31:21,713 INFO [org.apa.cam.qua.com.kud.it.KuduTestResource] (tc-okhttp-stream-820854836) STDOUT: I0605 12:31:21.687095 216 consensus_queue.cc:206] T d5fc23dca1314008a20e7c895ba6c30e P c49a97e6ad874c3bb6a397b392503c3b [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c49a97e6ad874c3bb6a397b392503c3b" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
2020-06-05 13:31:21,898 INFO [org.apa.cam.qua.com.kud.it.KuduTest] (main) Calling insertShouldSucceed | |
2020-06-05 13:31:21,922 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling insert | |
2020-06-05 13:31:22,422 INFO [org.apa.cam.qua.com.kud.it.KuduTest] (main) Calling scanShouldSucceed | |
2020-06-05 13:31:22,446 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling scan | |
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 75.515 s - in org.apache.camel.quarkus.component.kudu.it.KuduTest | |
2020-06-05 13:31:22,720 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) is shutting down | |
2020-06-05 13:31:22,748 INFO [org.apa.cam.com.kud.KuduEndpoint] (main) doStop() | |
2020-06-05 13:31:22,762 INFO [org.apa.cam.com.kud.KuduEndpoint] (main) doStop() | |
2020-06-05 13:31:22,767 INFO [org.apa.cam.com.kud.KuduEndpoint] (main) doStop() | |
2020-06-05 13:31:22,782 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) uptime 9.399 seconds | |
2020-06-05 13:31:22,783 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) is shutdown in 0.063 seconds | |
2020-06-05 13:31:22,809 INFO [io.quarkus] (main) Quarkus stopped in 0.115s | |
[INFO] | |
[INFO] Results: | |
[INFO] | |
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0 | |
[INFO] | |
[INFO] | |
[INFO] --- maven-jar-plugin:3.1.0:jar (default-jar) @ quarkus-universe-integration-tests-camel-kudu --- | |
[WARNING] JAR will be empty - no content was marked for inclusion! | |
[INFO] | |
[INFO] --- quarkus-maven-plugin:999-SNAPSHOT:native-image (native-image) @ quarkus-universe-integration-tests-camel-kudu --- | |
[WARNING] Your application is setting the deprecated 'enableJni' Maven option to false. Please consider removing this option as it is ignored (JNI is always enabled) and it will be removed in a future Quarkus version. | |
[INFO] [org.jboss.threads] JBoss Threads version 3.1.1.Final | |
[INFO] [io.quarkus.deployment.pkg.steps.JarResultBuildStep] Building native image source jar: /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/target/quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-native-image-source-jar/quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner.jar | |
[INFO] [io.quarkus.deployment.pkg.steps.NativeImageBuildStep] Building native image from /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/target/quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-native-image-source-jar/quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner.jar | |
[INFO] [io.quarkus.deployment.pkg.steps.NativeImageBuildStep] Running Quarkus native-image plugin on GraalVM Version dev (Java Version 11.0.9-internal) | |
Warning: Ignoring server-mode native-image argument --server-shutdown. | |
Error: Please specify class containing the main entry point method. (see --help) | |
[INFO] [io.quarkus.deployment.pkg.steps.NativeImageBuildStep] /home/g/workspace/qollider/0506/graalvm/mandrel/sdk/mxbuild/linux-amd64/GRAALVM_BC62B52CD1_JAVA11/graalvm-bc62b52cd1-java11-20.1.0/bin/native-image -J-Dsun.nio.ch.maxUpdateArraySize=100 -J-Djava.util.logging.manager=org.jboss.logmanager.LogManager -J-Dvertx.logger-delegate-factory-class-name=io.quarkus.vertx.core.runtime.VertxLogDelegateFactory -J-Dvertx.disableDnsResolver=true -J-Dio.netty.leakDetection.level=DISABLED -J-Dio.netty.allocator.maxOrder=1 -J-Duser.language=en -J-Dfile.encoding=UTF-8 --initialize-at-build-time= -H:InitialCollectionPolicy=com.oracle.svm.core.genscavenge.CollectionPolicy$BySpaceAndTime -H:+JNI -jar quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner.jar -H:FallbackThreshold=0 -H:+ReportExceptionStackTraces -H:-AddAllCharsets -H:-IncludeAllTimeZones -H:EnableURLProtocols=http,https --enable-all-security-services --no-server -H:-UseServiceLoaderFeature -H:+StackTrace quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner | |
Warning: Ignoring server-mode native-image argument --no-server. | |
-H:IncludeAllTimeZones and -H:IncludeTimeZones are now deprecated. Native-image includes all timezonesby default. | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] classlist: 15,524.24 ms, 0.93 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (cap): 2,271.15 ms, 0.93 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] setup: 5,747.14 ms, 1.17 GB | |
Warning: RecomputeFieldValue.ArrayIndexScale automatic substitution failed. The automatic substitution registration was attempted because a call to jdk.internal.misc.Unsafe.arrayIndexScale(Class) was detected in the static initializer of org.apache.kudu.shaded.com.google.common.primitives.UnsignedBytes$LexicographicalComparatorHolder$UnsafeComparator. Detailed failure reason(s): Could not determine the field where the value produced by the call to jdk.internal.misc.Unsafe.arrayIndexScale(Class) for the array index scale computation is stored. The call is not directly followed by a field store or by a sign extend node followed directly by a field store. | |
13:32:39,587 INFO [org.jbo.threads] JBoss Threads version 3.1.1.Final | |
WARNING GR-10238: VarHandle for static field is currently not fully supported. Static field private static volatile java.lang.System$Logger jdk.internal.event.EventHelper.securityLogger is not properly marked for Unsafe access! | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (clinit): 2,753.07 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (typeflow): 47,784.33 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (objects): 77,498.38 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (features): 2,511.83 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] analysis: 136,458.16 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] universe: 3,602.02 ms, 4.55 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (parse): 12,926.98 ms, 4.49 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (inline): 7,223.86 ms, 4.26 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] (compile): 51,110.18 ms, 5.53 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] compile: 77,804.97 ms, 5.53 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] image: 18,258.40 ms, 5.67 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] write: 2,188.93 ms, 5.67 GB | |
[quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner:6480] [total]: 260,961.18 ms, 5.67 GB | |
[INFO] [io.quarkus.deployment.QuarkusAugmentor] Quarkus augmentation completed in 270495ms | |
[INFO] | |
[INFO] --- maven-failsafe-plugin:2.22.0:integration-test (default) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] | |
[INFO] ------------------------------------------------------- | |
[INFO] T E S T S | |
[INFO] ------------------------------------------------------- | |
[INFO] Running org.apache.camel.quarkus.component.kudu.it.KuduIT | |
Jun 05, 2020 1:36:01 PM org.apache.camel.quarkus.component.kudu.it.KuduTestResource start | |
INFO: TestcontainersConfiguration(environmentProperties={docker.client.strategy=org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy}, properties={docker.client.strategy=org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy, pull.pause.timeout=120}) | |
Jun 05, 2020 1:36:01 PM org.testcontainers.dockerclient.DockerClientProviderStrategy lambda$getFirstValidStrategy$1 | |
INFO: Loaded org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy from ~/.testcontainers.properties, will try it first | |
Jun 05, 2020 1:36:02 PM org.testcontainers.dockerclient.EnvironmentAndSystemPropertyClientProviderStrategy test | |
INFO: Found docker client settings from environment | |
Jun 05, 2020 1:36:02 PM org.testcontainers.dockerclient.DockerClientProviderStrategy lambda$getFirstValidStrategy$2 | |
INFO: Found Docker environment with Environment variables, system properties and defaults. Resolved dockerHost=unix:///var/run/docker.sock | |
Jun 05, 2020 1:36:02 PM org.testcontainers.DockerClientFactory client | |
INFO: Docker host IP address is localhost | |
Jun 05, 2020 1:36:03 PM org.testcontainers.DockerClientFactory client | |
INFO: Connected to docker: | |
Server Version: 1.13.1 | |
API Version: 1.26 | |
Operating System: CentOS Linux 7 (Core) | |
Total Memory: 15840 MB | |
Jun 05, 2020 1:36:04 PM org.testcontainers.DockerClientFactory client | |
INFO: Ryuk started - will monitor and terminate Testcontainers containers on JVM exit | |
ℹ︎ Checking the system... | |
✔ Docker version should be at least 1.6.0 | |
✔ Docker environment should have more than 2GB free disk space | |
Jun 05, 2020 1:36:04 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Creating container for image: apache/kudu:1.9.0 | |
Jun 05, 2020 1:36:05 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Starting container with ID: 6d87cfaee3d353795897b7d16b4d305685ef7821561a1424444df6d3c0d88651 | |
Jun 05, 2020 1:36:05 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Container apache/kudu:1.9.0 is starting: 6d87cfaee3d353795897b7d16b4d305685ef7821561a1424444df6d3c0d88651 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.499783 1 master_main.cc:73] Master server non-default flags: | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --use_hybrid_clock=false | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --fs_wal_dir=/var/lib/kudu/master | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --webserver_doc_root=/opt/kudu/www | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --heap_profile_path=/tmp/kudu-master.1 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --logtostderr=true | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Master server version: | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: kudu 1.9.0 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: revision deb0f04b0 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: build type RELEASE | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: built by None at 12 Jun 2019 22:07:34 UTC on 3be9a5c52ce2 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.500561 1 minidump.cc:237] Setting minidump size limit to 20M | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.504354 1 master_main.cc:80] Initializing master server... | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.504681 1 fs_manager.cc:248] Data directories (fs_data_dirs) not provided | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.504829 1 fs_manager.cc:249] Using write-ahead log directory (fs_wal_dir) as data directory | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.504863 1 fs_manager.cc:263] Metadata directory not provided | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.504912 1 fs_manager.cc:269] Using write-ahead log directory (fs_wal_dir) as metadata directory | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.505096 1 server_base.cc:432] Could not load existing FS layout: Not found: could not find a healthy instance file | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.505123 1 server_base.cc:433] Attempting to create new FS layout instead | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.507746 1 fs_manager.cc:602] Generated new instance metadata in path /var/lib/kudu/master/instance: | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: uuid: "c17e5504f0974593991843fddba1c93d" | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: format_stamp: "Formatted at 2020-06-05 12:36:10 on 6d87cfaee3d3" | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.512220 1 fs_manager.cc:503] Time spent creating directory manager: real 0.004s user 0.001s sys 0.002s | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:10.512493 1 env_posix.cc:1724] Path /var/lib/kudu/master has permissions 755 which are less restrictive than current umask value 077: resetting permissions to 700 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.512554 1 env_posix.cc:1676] Not raising this process' open files per process limit of 1048576; it is already as high as it can go | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.513082 1 file_cache.cc:466] Constructed file cache lbm with capacity 419430 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.516449 1 fs_manager.cc:419] Time spent opening block manager: real 0.000s user 0.000s sys 0.000s | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.516635 1 fs_manager.cc:436] Opened local filesystem: /var/lib/kudu/master | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: uuid: "c17e5504f0974593991843fddba1c93d" | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: format_stamp: "Formatted at 2020-06-05 12:36:10 on 6d87cfaee3d3" | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.516880 1 fs_report.cc:352] FS layout report | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: -------------------- | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: wal directory: /var/lib/kudu/master | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: metadata directory: /var/lib/kudu/master | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 1 data directories: /var/lib/kudu/master/data | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live blocks: 0 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live bytes: 0 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live bytes (after alignment): 0 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total number of LBM containers: 0 (0 full) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Did not check for missing blocks | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Did not check for orphaned blocks | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total full LBM containers with extra space: 0 (0 repaired) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total full LBM container extra space in bytes: 0 (0 repaired) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total incomplete LBM containers: 0 (0 repaired) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total LBM partial records: 0 (0 repaired) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.624264 1 env_posix.cc:1676] Not raising this process' running threads per effective uid limit of 1048576; it is already as high as it can go | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.624730 1 master_main.cc:83] Starting Master server... | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.629580 1 rpc_server.cc:205] RPC server started. Bound to: 0.0.0.0:7051 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.629714 1 webserver.cc:175] Starting webserver on 0.0.0.0:8051 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.629781 1 webserver.cc:180] Document root: /opt/kudu/www | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.630177 1 webserver.cc:313] Webserver started. Bound to: http://0.0.0.0:8051/ | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.630951 134 data_dirs.cc:938] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.638656 134 tablet_bootstrap.cc:439] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: Bootstrap starting. | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.639232 134 tablet_bootstrap.cc:593] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: No blocks or log segments found. Creating new log. | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.639997 134 log.cc:525] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: Log is configured to *not* fsync() on all Append() calls | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.641340 134 tablet_bootstrap.cc:439] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: No bootstrap required, opened a new log | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644640 134 raft_consensus.cc:340] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending transactions. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644678 134 raft_consensus.cc:366] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644707 134 raft_consensus.cc:705] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c17e5504f0974593991843fddba1c93d, State: Initialized, Role: FOLLOWER | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644819 134 consensus_queue.cc:229] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644850 134 raft_consensus.cc:380] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644881 134 raft_consensus.cc:472] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration) | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.644910 134 raft_consensus.cc:2886] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 0 FOLLOWER]: Advancing to term 1 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.645546 134 raft_consensus.cc:494] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.645608 134 leader_election.cc:306] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: c17e5504f0974593991843fddba1c93d; no voters: | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.645733 134 leader_election.cc:292] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [CANDIDATE]: Term 1 election: Requested vote from peers | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.645921 134 sys_catalog.cc:337] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: SysCatalogTable state changed. Reason: Started TabletReplica. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.645983 134 sys_catalog.cc:340] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: This master's current role is: FOLLOWER | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646014 137 raft_consensus.cc:2640] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 1 FOLLOWER]: Leader election won for term 1 | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646273 137 raft_consensus.cc:667] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [term 1 LEADER]: Becoming Leader. State: Replica: c17e5504f0974593991843fddba1c93d, State: Running, Role: LEADER | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646378 137 consensus_queue.cc:206] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646611 134 sys_catalog.cc:424] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: configured and running, proceeding with master startup. | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646687 138 sys_catalog.cc:337] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: SysCatalogTable state changed. Reason: New leader c17e5504f0974593991843fddba1c93d. Latest consensus state: current_term: 1 leader_uuid: "c17e5504f0974593991843fddba1c93d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646724 138 sys_catalog.cc:340] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: This master's current role is: LEADER | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.647205 1 master_main.cc:86] Master server successfully started. | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.646894 136 sys_catalog.cc:337] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "c17e5504f0974593991843fddba1c93d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c17e5504f0974593991843fddba1c93d" member_type: VOTER } } | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.647812 136 sys_catalog.cc:340] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d [sys.catalog]: This master's current role is: LEADER | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:10.657966 140 catalog_manager.cc:1104] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: acquiring CA information for follower catalog manager: Not found: root CA entry not found | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:10.658040 140 catalog_manager.cc:587] Not found: root CA entry not found: failed to prepare follower catalog manager, will retry | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.658129 141 catalog_manager.cc:1046] Loading table and tablet metadata into memory... | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.658370 141 catalog_manager.cc:1057] Initializing Kudu internal certificate authority... | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.762362 141 catalog_manager.cc:941] Generated new certificate authority record | |
Jun 05, 2020 1:36:10 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:10.766443 141 catalog_manager.cc:1066] Loading token signing keys... | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:11.142802 160 negotiation.cc:313] Failed RPC negotiation. Trace: | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.142335 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 127.0.0.1:42506 | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.142579 (+ 244us) server_negotiation.cc:183] Beginning negotiation | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.142586 (+ 7us) server_negotiation.cc:372] Waiting for connection header | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.142712 (+ 126us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 127.0.0.1:42506: BlockingRecv error: recv got EOF from 127.0.0.1:42506 (error 108) | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Metrics: {"server-negotiator.queue_time_us":163,"thread_start_us":79,"threads_started":1} | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Container apache/kudu:1.9.0 started in PT9.846191S | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Creating container for image: apache/kudu:1.9.0 | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:11.153918 160 negotiation.cc:313] Failed RPC negotiation. Trace: | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.153535 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 172.18.0.1:54152 | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.153646 (+ 111us) server_negotiation.cc:183] Beginning negotiation | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.153650 (+ 4us) server_negotiation.cc:372] Waiting for connection header | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:11.153851 (+ 201us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 172.18.0.1:54152: BlockingRecv error: recv got EOF from 172.18.0.1:54152 (error 108) | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Metrics: {"server-negotiator.queue_time_us":32} | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Starting container with ID: 0ec9c840f2bec15dd10f101bb96ef6772f81bb9ec4301759b56015fb34bc1f17 | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:11.315955 141 catalog_manager.cc:4095] T 00000000000000000000000000000000 P c17e5504f0974593991843fddba1c93d: Generated new TSK 0 | |
Jun 05, 2020 1:36:11 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Container apache/kudu:1.9.0 is starting: 0ec9c840f2bec15dd10f101bb96ef6772f81bb9ec4301759b56015fb34bc1f17 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.619639 1 tablet_server_main.cc:78] Tablet server non-default flags: | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --use_hybrid_clock=false | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --fs_wal_dir=/var/lib/kudu/tserver | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --webserver_doc_root=/opt/kudu/www | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --tserver_master_addrs=kudu-master | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --heap_profile_path=/tmp/kudu-tserver.1 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: --logtostderr=true | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Tablet server version: | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: kudu 1.9.0 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: revision deb0f04b0 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: build type RELEASE | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: built by None at 12 Jun 2019 22:07:34 UTC on 3be9a5c52ce2 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.620524 1 minidump.cc:237] Setting minidump size limit to 20M | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.624341 1 tablet_server_main.cc:85] Initializing tablet server... | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626790 1 fs_manager.cc:248] Data directories (fs_data_dirs) not provided | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626827 1 fs_manager.cc:249] Using write-ahead log directory (fs_wal_dir) as data directory | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626844 1 fs_manager.cc:263] Metadata directory not provided | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626890 1 fs_manager.cc:269] Using write-ahead log directory (fs_wal_dir) as metadata directory | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626982 1 server_base.cc:432] Could not load existing FS layout: Not found: could not find a healthy instance file | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.626997 1 server_base.cc:433] Attempting to create new FS layout instead | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.656846 1 fs_manager.cc:602] Generated new instance metadata in path /var/lib/kudu/tserver/instance: | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: uuid: "3bd47727ae834fd2a256a0ec9a350281" | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: format_stamp: "Formatted at 2020-06-05 12:36:16 on kudu-tserver" | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.661381 1 fs_manager.cc:503] Time spent creating directory manager: real 0.004s user 0.002s sys 0.001s | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:16.661659 1 env_posix.cc:1724] Path /var/lib/kudu/tserver has permissions 755 which are less restrictive than current umask value 077: resetting permissions to 700 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.661728 1 env_posix.cc:1676] Not raising this process' open files per process limit of 1048576; it is already as high as it can go | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.662273 1 file_cache.cc:466] Constructed file cache lbm with capacity 419430 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.663812 1 fs_manager.cc:419] Time spent opening block manager: real 0.000s user 0.000s sys 0.000s | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.663856 1 fs_manager.cc:436] Opened local filesystem: /var/lib/kudu/tserver | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: uuid: "3bd47727ae834fd2a256a0ec9a350281" | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: format_stamp: "Formatted at 2020-06-05 12:36:16 on kudu-tserver" | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:16.663908 1 fs_report.cc:352] FS layout report | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: -------------------- | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: wal directory: /var/lib/kudu/tserver | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: metadata directory: /var/lib/kudu/tserver | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 1 data directories: /var/lib/kudu/tserver/data | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live blocks: 0 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live bytes: 0 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total live bytes (after alignment): 0 | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total number of LBM containers: 0 (0 full) | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Did not check for missing blocks | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Did not check for orphaned blocks | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total full LBM containers with extra space: 0 (0 repaired) | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total full LBM container extra space in bytes: 0 (0 repaired) | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total incomplete LBM containers: 0 (0 repaired) | |
Jun 05, 2020 1:36:16 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Total LBM partial records: 0 (0 repaired) | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.090402 1 env_posix.cc:1676] Not raising this process' running threads per effective uid limit of 1048576; it is already as high as it can go | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.091054 1 ts_tablet_manager.cc:356] Loaded tablet metadata (0 live tablets) | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.091152 1 tablet_server_main.cc:90] Starting tablet server... | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.098318 1 rpc_server.cc:205] RPC server started. Bound to: 0.0.0.0:7050 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.098398 1 webserver.cc:175] Starting webserver on 0.0.0.0:8050 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.098417 1 webserver.cc:180] Document root: /opt/kudu/www | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.098723 1 webserver.cc:313] Webserver started. Bound to: http://0.0.0.0:8050/ | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.099251 1 tablet_server_main.cc:93] Tablet server successfully started. | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.112602 194 heartbeater.cc:345] Connected to a master server at kudu-master:7051 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.112673 194 heartbeater.cc:425] Registering TS with master... | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.112974 194 heartbeater.cc:474] Master kudu-master:7051 requested a full tablet report, sending... | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.113492 101 ts_manager.cc:98] Registered new tserver with Master: 3bd47727ae834fd2a256a0ec9a350281 (kudu-tserver:7050) | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:17.117760 101 master_service.cc:263] Signed X509 certificate for tserver {username='kudu'} at 172.18.0.3:52188 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:17.776432 212 negotiation.cc:313] Failed RPC negotiation. Trace: | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.775972 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 127.0.0.1:49904 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.776201 (+ 229us) server_negotiation.cc:183] Beginning negotiation | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.776205 (+ 4us) server_negotiation.cc:372] Waiting for connection header | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.776317 (+ 112us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 127.0.0.1:49904: BlockingRecv error: recv got EOF from 127.0.0.1:49904 (error 108) | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Metrics: {"server-negotiator.queue_time_us":154,"thread_start_us":77,"threads_started":1} | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.GenericContainer tryStart | |
INFO: Container apache/kudu:1.9.0 started in PT6.6278S | |
Jun 05, 2020 1:36:17 PM org.apache.camel.quarkus.component.kudu.it.KuduTestResource start | |
INFO: Kudu master RPC accessible at localhost:32868 | |
Jun 05, 2020 1:36:17 PM org.apache.camel.quarkus.component.kudu.it.KuduTestResource start | |
INFO: Kudu master HTTP accessible at localhost:32867 | |
Jun 05, 2020 1:36:17 PM org.apache.camel.quarkus.component.kudu.it.KuduTestResource start | |
INFO: Kudu tablet server RPC accessible at localhost:7050 | |
Jun 05, 2020 1:36:17 PM org.apache.camel.quarkus.component.kudu.it.KuduTestResource start | |
INFO: Kudu tablet server HTTP accessible at localhost:8050 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:17.785962 212 negotiation.cc:313] Failed RPC negotiation. Trace: | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.785454 (+ 0us) reactor.cc:583] Submitting negotiation task for server connection from 172.18.0.1:56858 | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.785796 (+ 342us) server_negotiation.cc:183] Beginning negotiation | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.785801 (+ 5us) server_negotiation.cc:372] Waiting for connection header | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: 0605 12:36:17.785909 (+ 108us) negotiation.cc:304] Negotiation complete: Network error: Server connection negotiation failed: server connection from 172.18.0.1:56858: BlockingRecv error: recv got EOF from 172.18.0.1:56858 (error 108) | |
Jun 05, 2020 1:36:17 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: Metrics: {"server-negotiator.queue_time_us":272} | |
Executing [/home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/target/quarkus-universe-integration-tests-camel-kudu-999-SNAPSHOT-runner, -Dquarkus.http.port=46097, -Dquarkus.http.ssl-port=37087, -Dtest.url=http://localhost:46097, -Dquarkus.log.file.path=target/quarkus.log, -Dcamel.kudu.test.master.rpc-authority=localhost:32868] | |
__ ____ __ _____ ___ __ ____ ______ | |
--/ __ \/ / / / _ | / _ \/ //_/ / / / __/ | |
-/ /_/ / /_/ / __ |/ , _/ ,< / /_/ /\ \ | |
--\___\_\____/_/ |_/_/|_/_/|_|\____/___/ | |
2020-06-05 13:36:17,928 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) is starting | |
2020-06-05 13:36:17,928 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) StreamCaching is not in use. If using streams then its recommended to enable stream caching. See more details at http://camel.apache.org/stream-caching.html | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route1 started and consuming from: direct://create_table | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route2 started and consuming from: direct://insert | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Route: route3 started and consuming from: direct://scan | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Total 3 routes, of which 3 are started | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.imp.eng.AbstractCamelContext] (main) Apache Camel 3.3.0 (CamelContext: camel-1) started in 0.030 seconds | |
2020-06-05 13:36:17,958 INFO [org.apa.cam.qua.com.kud.it.KuduInfrastructureTestHelper] (main) Attempting to override the kudu tablet server hostname resolution on application startup | |
2020-06-05 13:36:17,962 WARN [org.apa.cam.qua.com.kud.it.KuduInfrastructureTestHelper] (main) An issue occurred while attempting the Open JDK9+ override of the kudu tablet server hostname resolution: java.lang.NoSuchMethodException: java.util.concurrent.ConcurrentHashMap.get(java.lang.Object) | |
at java.lang.Class.getMethod(DynamicHub.java:1036) | |
at org.apache.camel.quarkus.component.kudu.it.KuduInfrastructureTestHelper.overrideTabletServerHostnameResolution(KuduInfrastructureTestHelper.java:83) | |
at org.apache.camel.quarkus.component.kudu.it.KuduInfrastructureTestHelper.onStart(KuduInfrastructureTestHelper.java:72) | |
at org.apache.camel.quarkus.component.kudu.it.KuduInfrastructureTestHelper_Observer_onStart_fd71b5e0b207b7d1ef838b94eaeff75e52b8f463.notify(KuduInfrastructureTestHelper_Observer_onStart_fd71b5e0b207b7d1ef838b94eaeff75e52b8f463.zig:147) | |
at io.quarkus.arc.impl.EventImpl$Notifier.notifyObservers(EventImpl.java:282) | |
at io.quarkus.arc.impl.EventImpl$Notifier.notify(EventImpl.java:267) | |
at io.quarkus.arc.impl.EventImpl.fire(EventImpl.java:69) | |
at io.quarkus.arc.runtime.LifecycleEventRunner.fireStartupEvent(LifecycleEventRunner.java:23) | |
at io.quarkus.arc.runtime.ArcRecorder.handleLifecycleEvents(ArcRecorder.java:113) | |
at io.quarkus.deployment.steps.LifecycleEventsBuildStep$startupEvent-858218658.deploy_0(LifecycleEventsBuildStep$startupEvent-858218658.zig:77) | |
at io.quarkus.deployment.steps.LifecycleEventsBuildStep$startupEvent-858218658.deploy(LifecycleEventsBuildStep$startupEvent-858218658.zig:36) | |
at io.quarkus.runner.ApplicationImpl.doStart(ApplicationImpl.zig:458) | |
at io.quarkus.runtime.Application.start(Application.java:90) | |
at io.quarkus.runtime.ApplicationLifecycleManager.run(ApplicationLifecycleManager.java:91) | |
at io.quarkus.runtime.Quarkus.run(Quarkus.java:61) | |
at io.quarkus.runtime.Quarkus.run(Quarkus.java:38) | |
at io.quarkus.runtime.Quarkus.run(Quarkus.java:106) | |
at io.quarkus.runner.GeneratedMain.main(GeneratedMain.zig:29) | |
2020-06-05 13:36:17,971 INFO [io.quarkus] (main) quarkus-universe-integration-tests-camel-kudu 999-SNAPSHOT native (powered by Quarkus 999-SNAPSHOT) started in 0.079s. Listening on: http://0.0.0.0:46097 | |
2020-06-05 13:36:17,972 INFO [io.quarkus] (main) Profile prod activated. | |
2020-06-05 13:36:17,972 INFO [io.quarkus] (main) Installed features: [camel-bean, camel-core, camel-direct, camel-kudu, camel-policy, camel-support-common, camel-support-commons-logging, cdi, resteasy] | |
Jun 05, 2020 1:36:18 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:18.118662 194 heartbeater.cc:466] Master kudu-master:7051 was elected leader, sending a full tablet report... | |
Jun 05, 2020 1:36:19 PM org.apache.camel.quarkus.component.kudu.it.KuduTest createTableShouldSucceed | |
INFO: Calling createTableShouldSucceed | |
2020-06-05 13:36:20,854 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling createTable | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.882083 101 catalog_manager.cc:1386] Servicing CreateTable request from {username='g'} at 172.18.0.1:54204: | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: name: "TestTable" | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: schema { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: columns { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: name: "id" | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: type: STRING | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: is_key: true | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: is_nullable: false | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: cfile_block_size: 0 | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: columns { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: name: "name" | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: type: STRING | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: is_key: false | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: is_nullable: false | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: cfile_block_size: 0 | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: num_replicas: 1 | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: partition_schema { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: range_schema { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: columns { | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: name: "id" | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.897073 131 tablet_service.cc:774] Processing CreateTablet for tablet f5bdddb95a3743c792c8d422493cc33d (table=TestTable [id=94f288d3a69f40e3bfe6647ba5a9b703]), partition=RANGE (id) PARTITION UNBOUNDED | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.897222 131 data_dirs.cc:938] Could only allocate 1 dirs of requested 3 for tablet f5bdddb95a3743c792c8d422493cc33d. 1 dirs total, 0 dirs full, 0 dirs failed | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.901624 131 ts_tablet_manager.cc:1175] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Registered tablet (data state: TABLET_DATA_READY) | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.901821 214 ts_tablet_manager.cc:1030] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Bootstrapping tablet | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.901898 214 tablet_bootstrap.cc:439] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Bootstrap starting. | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.902369 214 tablet_bootstrap.cc:593] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: No blocks or log segments found. Creating new log. | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.902602 214 log.cc:525] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Log is configured to *not* fsync() on all Append() calls | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.903146 214 tablet_bootstrap.cc:439] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: No bootstrap required, opened a new log | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.903203 214 ts_tablet_manager.cc:1047] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Time spent bootstrapping tablet: real 0.001s user 0.000s sys 0.001s | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.904717 214 raft_consensus.cc:340] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending transactions. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "3bd47727ae834fd2a256a0ec9a350281" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.904745 214 raft_consensus.cc:366] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.904763 214 raft_consensus.cc:705] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3bd47727ae834fd2a256a0ec9a350281, State: Initialized, Role: FOLLOWER | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.904966 214 consensus_queue.cc:229] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "3bd47727ae834fd2a256a0ec9a350281" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.905051 214 raft_consensus.cc:380] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.905158 214 raft_consensus.cc:472] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration) | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.905251 214 raft_consensus.cc:2886] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 0 FOLLOWER]: Advancing to term 1 | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.905890 214 raft_consensus.cc:494] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "3bd47727ae834fd2a256a0ec9a350281" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906065 214 leader_election.cc:306] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 3bd47727ae834fd2a256a0ec9a350281; no voters: | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906230 214 leader_election.cc:292] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [CANDIDATE]: Term 1 election: Requested vote from peers | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906286 216 raft_consensus.cc:2640] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 1 FOLLOWER]: Leader election won for term 1 | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906452 214 ts_tablet_manager.cc:1075] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281: Time spent starting tablet: real 0.003s user 0.002s sys 0.001s | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906534 216 raft_consensus.cc:667] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [term 1 LEADER]: Becoming Leader. State: Replica: 3bd47727ae834fd2a256a0ec9a350281, State: Running, Role: LEADER | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.906606 216 consensus_queue.cc:206] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "3bd47727ae834fd2a256a0ec9a350281" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } } | |
Jun 05, 2020 1:36:20 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: I0605 12:36:20.913182 101 catalog_manager.cc:3791] T f5bdddb95a3743c792c8d422493cc33d P 3bd47727ae834fd2a256a0ec9a350281 reported cstate change: term changed from 0 to 1, leader changed from <none> to 3bd47727ae834fd2a256a0ec9a350281 (kudu-tserver). New cstate: current_term: 1 leader_uuid: "3bd47727ae834fd2a256a0ec9a350281" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "3bd47727ae834fd2a256a0ec9a350281" member_type: VOTER last_known_addr { host: "kudu-tserver" port: 7050 } health_report { overall_health: HEALTHY } } } | |
Jun 05, 2020 1:36:21 PM org.apache.camel.quarkus.component.kudu.it.KuduTest insertShouldSucceed | |
INFO: Calling insertShouldSucceed | |
2020-06-05 13:36:21,069 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling insert | |
2020-06-05 13:36:21,098 ERROR [org.apa.kud.uti.NetUtil] (New I/O worker #18) Failed to resolve the IP of `kudu-tserver' in 6958521ns | |
Jun 05, 2020 1:36:21 PM org.apache.camel.quarkus.component.kudu.it.KuduTest scanShouldSucceed | |
INFO: Calling scanShouldSucceed | |
2020-06-05 13:36:21,528 INFO [org.apa.cam.qua.com.kud.it.KuduResource] (executor-thread-1) Calling scan | |
2020-06-05 13:36:21,550 ERROR [org.apa.kud.uti.NetUtil] (New I/O worker #35) Failed to resolve the IP of `kudu-tserver' in 81934ns | |
2020-06-05 13:36:21,551 ERROR [org.apa.cam.pro.err.DefaultErrorHandler] (executor-thread-1) Failed delivery for (MessageId: FB07D3D804F30A7-0000000000000002 on ExchangeId: FB07D3D804F30A7-0000000000000002). Exhausted after delivery attempt: 1 caught: java.lang.RuntimeException: org.apache.kudu.client.NonRecoverableException: Couldn't find any valid locations, exceptions: [java.net.UnknownHostException: Failed to resolve the IP of `kudu-tserver'] | |
Message History (complete message history is disabled) | |
--------------------------------------------------------------------------------------------------------------------------------------- | |
RouteId ProcessorId Processor Elapsed (ms) | |
[route3 ] [route3 ] [from[direct://scan] ] [ 23] | |
... | |
[route3 ] [to3 ] [kudu:{{camel.kudu.test.master.rpc-authority}}/TestTable?operation=scan ] [ 0] | |
Stacktrace | |
---------------------------------------------------------------------------------------------------------------------------------------: java.lang.RuntimeException: org.apache.kudu.client.NonRecoverableException: Couldn't find any valid locations, exceptions: [java.net.UnknownHostException: Failed to resolve the IP of `kudu-tserver'] | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:77) | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:83) | |
at org.apache.camel.component.kudu.KuduUtils.scannerToList(KuduUtils.java:47) | |
at org.apache.camel.component.kudu.KuduUtils.doScan(KuduUtils.java:72) | |
at org.apache.camel.component.kudu.KuduProducer.doScan(KuduProducer.java:107) | |
at org.apache.camel.component.kudu.KuduProducer.process(KuduProducer.java:64) | |
at org.apache.camel.support.AsyncProcessorConverterHelper$ProcessorToAsyncProcessorBridge.process(AsyncProcessorConverterHelper.java:67) | |
at org.apache.camel.processor.SendProcessor.process(SendProcessor.java:168) | |
at org.apache.camel.processor.errorhandler.RedeliveryErrorHandler$SimpleTask.run(RedeliveryErrorHandler.java:395) | |
at org.apache.camel.impl.engine.DefaultReactiveExecutor$Worker.schedule(DefaultReactiveExecutor.java:148) | |
at org.apache.camel.impl.engine.DefaultReactiveExecutor.scheduleMain(DefaultReactiveExecutor.java:60) | |
at org.apache.camel.processor.Pipeline.process(Pipeline.java:147) | |
at org.apache.camel.processor.CamelInternalProcessor.process(CamelInternalProcessor.java:286) | |
at org.apache.camel.component.direct.DirectProducer.process(DirectProducer.java:66) | |
at org.apache.camel.processor.SharedCamelInternalProcessor.process(SharedCamelInternalProcessor.java:212) | |
at org.apache.camel.processor.SharedCamelInternalProcessor$1.process(SharedCamelInternalProcessor.java:110) | |
at org.apache.camel.impl.engine.DefaultAsyncProcessorAwaitManager.process(DefaultAsyncProcessorAwaitManager.java:83) | |
at org.apache.camel.processor.SharedCamelInternalProcessor.process(SharedCamelInternalProcessor.java:107) | |
at org.apache.camel.impl.engine.DefaultProducerCache.send(DefaultProducerCache.java:185) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.send(DefaultProducerTemplate.java:176) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.send(DefaultProducerTemplate.java:172) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.requestBody(DefaultProducerTemplate.java:390) | |
at org.apache.camel.quarkus.component.kudu.it.KuduResource.scan(KuduResource.java:92) | |
at org.apache.camel.quarkus.component.kudu.it.KuduResource_ClientProxy.scan(KuduResource_ClientProxy.zig:184) | |
at java.lang.reflect.Method.invoke(Method.java:566) | |
at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:167) | |
at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:130) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.internalInvokeOnTarget(ResourceMethodInvoker.java:621) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTargetAfterFilter(ResourceMethodInvoker.java:487) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.lambda$invokeOnTarget$2(ResourceMethodInvoker.java:437) | |
at org.jboss.resteasy.core.interception.jaxrs.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:362) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:439) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:400) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:374) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:67) | |
at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:488) | |
at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:259) | |
at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:160) | |
at org.jboss.resteasy.core.interception.jaxrs.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:362) | |
at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:163) | |
at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:245) | |
at io.quarkus.resteasy.runtime.standalone.RequestDispatcher.service(RequestDispatcher.java:73) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler.dispatch(VertxRequestHandler.java:132) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler.access$000(VertxRequestHandler.java:37) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler$1.run(VertxRequestHandler.java:94) | |
at org.jboss.threads.ContextClassLoaderSavingRunnable.run(ContextClassLoaderSavingRunnable.java:35) | |
at org.jboss.threads.EnhancedQueueExecutor.safeRun(EnhancedQueueExecutor.java:2046) | |
at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.doRunTask(EnhancedQueueExecutor.java:1578) | |
at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.run(EnhancedQueueExecutor.java:1452) | |
at org.jboss.threads.DelegatingRunnable.run(DelegatingRunnable.java:29) | |
at org.jboss.threads.ThreadLocalResettingRunnable.run(ThreadLocalResettingRunnable.java:29) | |
at java.lang.Thread.run(Thread.java:834) | |
at org.jboss.threads.JBossThread.run(JBossThread.java:479) | |
at com.oracle.svm.core.thread.JavaThreads.threadStartRoutine(JavaThreads.java:517) | |
at com.oracle.svm.core.posix.thread.PosixJavaThreads.pthreadStartRoutine(PosixJavaThreads.java:193) | |
Caused by: org.apache.kudu.client.NonRecoverableException: Couldn't find any valid locations, exceptions: [java.net.UnknownHostException: Failed to resolve the IP of `kudu-tserver'] | |
at org.apache.kudu.client.KuduClient.joinAndHandleException(KuduClient.java:413) | |
at org.apache.kudu.client.KuduScanner.nextRows(KuduScanner.java:72) | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:69) | |
... 54 more | |
2020-06-05 13:36:21,552 ERROR [io.qua.ver.htt.run.QuarkusErrorHandler] (executor-thread-1) HTTP Request to /kudu/scan failed, error id: 558e9739-1106-4332-b2b5-142e63f4c129-1: org.jboss.resteasy.spi.UnhandledException: org.apache.camel.CamelExecutionException: Exception occurred during execution on the exchange: Exchange[FB07D3D804F30A7-0000000000000002] | |
at org.jboss.resteasy.core.ExceptionHandler.handleApplicationException(ExceptionHandler.java:106) | |
at org.jboss.resteasy.core.ExceptionHandler.handleException(ExceptionHandler.java:372) | |
at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:216) | |
at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:515) | |
at org.jboss.resteasy.core.SynchronousDispatcher.lambda$invoke$4(SynchronousDispatcher.java:259) | |
at org.jboss.resteasy.core.SynchronousDispatcher.lambda$preprocess$0(SynchronousDispatcher.java:160) | |
at org.jboss.resteasy.core.interception.jaxrs.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:362) | |
at org.jboss.resteasy.core.SynchronousDispatcher.preprocess(SynchronousDispatcher.java:163) | |
at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:245) | |
at io.quarkus.resteasy.runtime.standalone.RequestDispatcher.service(RequestDispatcher.java:73) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler.dispatch(VertxRequestHandler.java:132) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler.access$000(VertxRequestHandler.java:37) | |
at io.quarkus.resteasy.runtime.standalone.VertxRequestHandler$1.run(VertxRequestHandler.java:94) | |
at org.jboss.threads.ContextClassLoaderSavingRunnable.run(ContextClassLoaderSavingRunnable.java:35) | |
at org.jboss.threads.EnhancedQueueExecutor.safeRun(EnhancedQueueExecutor.java:2046) | |
at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.doRunTask(EnhancedQueueExecutor.java:1578) | |
at org.jboss.threads.EnhancedQueueExecutor$ThreadBody.run(EnhancedQueueExecutor.java:1452) | |
at org.jboss.threads.DelegatingRunnable.run(DelegatingRunnable.java:29) | |
at org.jboss.threads.ThreadLocalResettingRunnable.run(ThreadLocalResettingRunnable.java:29) | |
at java.lang.Thread.run(Thread.java:834) | |
at org.jboss.threads.JBossThread.run(JBossThread.java:479) | |
at com.oracle.svm.core.thread.JavaThreads.threadStartRoutine(JavaThreads.java:517) | |
at com.oracle.svm.core.posix.thread.PosixJavaThreads.pthreadStartRoutine(PosixJavaThreads.java:193) | |
Caused by: org.apache.camel.CamelExecutionException: Exception occurred during execution on the exchange: Exchange[FB07D3D804F30A7-0000000000000002] | |
at org.apache.camel.support.ExchangeHelper.extractResultBody(ExchangeHelper.java:687) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.extractResultBody(DefaultProducerTemplate.java:568) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.extractResultBody(DefaultProducerTemplate.java:564) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.requestBody(DefaultProducerTemplate.java:391) | |
at org.apache.camel.quarkus.component.kudu.it.KuduResource.scan(KuduResource.java:92) | |
at org.apache.camel.quarkus.component.kudu.it.KuduResource_ClientProxy.scan(KuduResource_ClientProxy.zig:184) | |
at java.lang.reflect.Method.invoke(Method.java:566) | |
at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:167) | |
at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:130) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.internalInvokeOnTarget(ResourceMethodInvoker.java:621) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTargetAfterFilter(ResourceMethodInvoker.java:487) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.lambda$invokeOnTarget$2(ResourceMethodInvoker.java:437) | |
at org.jboss.resteasy.core.interception.jaxrs.PreMatchContainerRequestContext.filter(PreMatchContainerRequestContext.java:362) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:439) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:400) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:374) | |
at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:67) | |
at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:488) | |
... 19 more | |
Caused by: java.lang.RuntimeException: org.apache.kudu.client.NonRecoverableException: Couldn't find any valid locations, exceptions: [java.net.UnknownHostException: Failed to resolve the IP of `kudu-tserver'] | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:77) | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:83) | |
at org.apache.camel.component.kudu.KuduUtils.scannerToList(KuduUtils.java:47) | |
at org.apache.camel.component.kudu.KuduUtils.doScan(KuduUtils.java:72) | |
at org.apache.camel.component.kudu.KuduProducer.doScan(KuduProducer.java:107) | |
at org.apache.camel.component.kudu.KuduProducer.process(KuduProducer.java:64) | |
at org.apache.camel.support.AsyncProcessorConverterHelper$ProcessorToAsyncProcessorBridge.process(AsyncProcessorConverterHelper.java:67) | |
at org.apache.camel.processor.SendProcessor.process(SendProcessor.java:168) | |
at org.apache.camel.processor.errorhandler.RedeliveryErrorHandler$SimpleTask.run(RedeliveryErrorHandler.java:395) | |
at org.apache.camel.impl.engine.DefaultReactiveExecutor$Worker.schedule(DefaultReactiveExecutor.java:148) | |
at org.apache.camel.impl.engine.DefaultReactiveExecutor.scheduleMain(DefaultReactiveExecutor.java:60) | |
at org.apache.camel.processor.Pipeline.process(Pipeline.java:147) | |
at org.apache.camel.processor.CamelInternalProcessor.process(CamelInternalProcessor.java:286) | |
at org.apache.camel.component.direct.DirectProducer.process(DirectProducer.java:66) | |
at org.apache.camel.processor.SharedCamelInternalProcessor.process(SharedCamelInternalProcessor.java:212) | |
at org.apache.camel.processor.SharedCamelInternalProcessor$1.process(SharedCamelInternalProcessor.java:110) | |
at org.apache.camel.impl.engine.DefaultAsyncProcessorAwaitManager.process(DefaultAsyncProcessorAwaitManager.java:83) | |
at org.apache.camel.processor.SharedCamelInternalProcessor.process(SharedCamelInternalProcessor.java:107) | |
at org.apache.camel.impl.engine.DefaultProducerCache.send(DefaultProducerCache.java:185) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.send(DefaultProducerTemplate.java:176) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.send(DefaultProducerTemplate.java:172) | |
at org.apache.camel.impl.engine.DefaultProducerTemplate.requestBody(DefaultProducerTemplate.java:390) | |
... 33 more | |
Caused by: org.apache.kudu.client.NonRecoverableException: Couldn't find any valid locations, exceptions: [java.net.UnknownHostException: Failed to resolve the IP of `kudu-tserver'] | |
at org.apache.kudu.client.KuduClient.joinAndHandleException(KuduClient.java:413) | |
at org.apache.kudu.client.KuduScanner.nextRows(KuduScanner.java:72) | |
at org.apache.kudu.client.KuduScannerIterator.hasNext(KuduScannerIterator.java:69) | |
... 54 more | |
[ERROR] Tests run: 3, Failures: 2, Errors: 0, Skipped: 0, Time elapsed: 20.625 s <<< FAILURE! - in org.apache.camel.quarkus.component.kudu.it.KuduIT | |
[ERROR] insertShouldSucceed Time elapsed: 0.453 s <<< FAILURE! | |
org.opentest4j.AssertionFailedError: expected: <1> but was: <0> | |
[ERROR] scanShouldSucceed Time elapsed: 0.148 s <<< FAILURE! | |
java.lang.AssertionError: | |
1 expectation failed. | |
Expected status code <200> but was <500>. | |
Jun 05, 2020 1:36:21 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:21.622422 82 connection.cc:647] client connection to 172.18.0.2:7051 recv error: Network error: failed to read from TLS socket (remote: 172.18.0.2:7051): Connection reset by peer (error 104) | |
Jun 05, 2020 1:36:21 PM org.testcontainers.containers.output.Slf4jLogConsumer accept | |
INFO: STDOUT: W0605 12:36:21.622587 83 connection.cc:647] server connection from 172.18.0.2:43722 recv error: Network error: failed to read from TLS socket (remote: 172.18.0.2:43722): Connection reset by peer (error 104) | |
[INFO] | |
[INFO] Results: | |
[INFO] | |
[ERROR] Failures: | |
[ERROR] KuduIT>KuduTest.insertShouldSucceed:82 expected: <1> but was: <0> | |
[ERROR] KuduIT>KuduTest.scanShouldSucceed:94 1 expectation failed. | |
Expected status code <200> but was <500>. | |
[INFO] | |
[ERROR] Tests run: 3, Failures: 2, Errors: 0, Skipped: 0 | |
[INFO] | |
[INFO] | |
[INFO] --- maven-failsafe-plugin:2.22.0:verify (default) @ quarkus-universe-integration-tests-camel-kudu --- | |
[INFO] ------------------------------------------------------------------------ | |
[INFO] Reactor Summary for quarkus-universe-integration-tests-camel-kudu 999-SNAPSHOT: | |
[INFO] | |
[INFO] quarkus-universe-integration-tests-camel-kudu ...... FAILURE [06:34 min] | |
[INFO] quarkus-universe-integration-tests-camel-mail ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-main ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-main-caffein-lrucache SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-main-collector SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-main-xml-io SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-main-xml-jaxb SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-messaging . SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-microprofile SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-mongodb ... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-mustache .. SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-netty ..... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-olingo4 ... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-opentracing SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-pdf ....... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-platform-http SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-platform-http-engine SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-quartz .... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-qute ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-reactive-streams SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-ref ....... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-rest-binding-mode-xml SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-rest-openapi SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-salesforce SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-sap-netweaver SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-scheduler . SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-seda ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-send-dynamic-http SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-servicenow SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-servlet ... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-slack ..... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-soap ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-sql ....... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-stream .... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-tarfile ... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-telegram .. SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-twitter ... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-validator . SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-websocket-jsr356 SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-xml ....... SKIPPED | |
[INFO] quarkus-universe-integration-tests-camel-xstream ... SKIPPED | |
[INFO] Quarkus universe - Integration Tests - Kogito ...... SKIPPED | |
[INFO] quarkus-universe-integration-tests-kogito-rpkgtests SKIPPED | |
[INFO] kogito-quarkus-integration-test .................... SKIPPED | |
[INFO] quarkus-universe-integration-tests-rpkgtests ....... SKIPPED | |
[INFO] quarkus-universe-integration-tests-hazelcast-client SKIPPED | |
[INFO] quarkus-universe-integration-tests-quarkus-qpid-jms SKIPPED | |
[INFO] quarkus-universe-integration-tests-debezium-outbox . SKIPPED | |
[INFO] quarkus-universe-integration-tests-blaze-persistence SKIPPED | |
[INFO] ------------------------------------------------------------------------ | |
[INFO] BUILD FAILURE | |
[INFO] ------------------------------------------------------------------------ | |
[INFO] Total time: 06:37 min | |
[INFO] Finished at: 2020-06-05T13:36:22+01:00 | |
[INFO] ------------------------------------------------------------------------ | |
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-failsafe-plugin:2.22.0:verify (default) on project quarkus-universe-integration-tests-camel-kudu: There are test failures. | |
[ERROR] | |
[ERROR] Please refer to /home/g/workspace/qollider/0506/quarkus-platform/integration-tests/camel/camel-kudu/target/failsafe-reports for the individual test results. | |
[ERROR] Please refer to dump files (if any exist) [date]-jvmRun[N].dump, [date].dumpstream and [date]-jvmRun[N].dumpstream. | |
[ERROR] -> [Help 1] | |
[ERROR] | |
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch. | |
[ERROR] Re-run Maven using the -X switch to enable full debug logging. | |
[ERROR] | |
[ERROR] For more information about the errors and possible solutions, please read the following articles: | |
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException | |
java.lang.RuntimeException: java.lang.RuntimeException: Failed, exit code: 1 | |
at OperatingSystem.exec(qollider.java:1443) | |
at MavenTest$Maven.doTest(qollider.java:926) | |
at MavenTest$Maven.test(qollider.java:918) | |
at MavenTest$RunTest.accept(qollider.java:907) | |
at MavenTest$RunTest.accept(qollider.java:893) | |
at MavenTest.run(qollider.java:890) | |
at picocli.CommandLine.executeUserObject(CommandLine.java:1769) | |
at picocli.CommandLine.access$900(CommandLine.java:145) | |
at picocli.CommandLine$RunLast.executeUserObjectOfLastSubcommandWithSameParent(CommandLine.java:2150) | |
at picocli.CommandLine$RunLast.handle(CommandLine.java:2144) | |
at picocli.CommandLine$RunLast.handle(CommandLine.java:2108) | |
at picocli.CommandLine$AbstractParseResultHandler.execute(CommandLine.java:1975) | |
at picocli.CommandLine.execute(CommandLine.java:1904) | |
at qollider.main(qollider.java:108) | |
Caused by: java.lang.RuntimeException: Failed, exit code: 1 | |
at OperatingSystem.exec(qollider.java:1437) | |
... 13 more |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment