Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
[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
You can’t perform that action at this time.