See <https://builds.apache.org/job/pulsar-master/643/display/redirect?page=changes>
Changes: [guosijie] Cleanup Arquillian consolidate projects (#2180) ------------------------------------------ [...truncated 1.22 MB...] 2018-07-24 08:57:13.981 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns1/my-python-test-producer-deduplication-1532422633.72, my-sub, 0] Created consumer on broker [127.0.0.1:51536 -> 127.0.0.1:8885] 2018-07-24 08:57:15.789 INFO ProducerImpl:466 | [persistent://sample/standalone/ns1/my-python-test-producer-deduplication-1532422633.72, my-producer-name] Closed producer 2018-07-24 08:57:15.791 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test-producer-deduplication-1532422633.72, my-producer-name] Getting connection from pool 2018-07-24 08:57:15.793 INFO ProducerImpl:154 | [persistent://sample/standalone/ns1/my-python-test-producer-deduplication-1532422633.72, my-producer-name] Created producer on broker [127.0.0.1:51536 -> 127.0.0.1:8885] .2018-07-24 08:57:16.795 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:16.796 INFO ClientConnection:285 | [127.0.0.1:51538 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:16.799 INFO HandlerBase:53 | [persistent://public/default/my-python-test-producer, ] Getting connection from pool 2018-07-24 08:57:16.841 INFO ProducerImpl:154 | [persistent://public/default/my-python-test-producer, ] Created producer on broker [127.0.0.1:51538 -> 127.0.0.1:8885] 2018-07-24 08:57:16.861 INFO ProducerImpl:466 | [persistent://public/default/my-python-test-producer, standalone-0-92] Closed producer .2018-07-24 08:57:16.861 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:16.862 INFO ClientConnection:285 | [127.0.0.1:51540 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:16.865 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic, ] Getting connection from pool 2018-07-24 08:57:16.952 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic, ] Created producer on broker [127.0.0.1:51540 -> 127.0.0.1:8885] 2018-07-24 08:57:16.953 WARN ConsumerImpl:97 | [persistent://sample/standalone/ns1/my-python-test-producer-deduplication-1532422633.72, my-sub, 0] Destroyed consumer which was not properly closed 2018-07-24 08:57:17.054 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic, standalone-0-93] Closed producer .2018-07-24 08:57:17.082 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:17.083 INFO ClientConnection:285 | [127.0.0.1:51544 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:17.085 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test-producer-sequence-after-reconnection-1532422637.08, my-producer-name] Getting connection from pool 2018-07-24 08:57:17.181 INFO ProducerImpl:154 | [persistent://sample/standalone/ns1/my-python-test-producer-sequence-after-reconnection-1532422637.08, my-producer-name] Created producer on broker [127.0.0.1:51544 -> 127.0.0.1:8885] 2018-07-24 08:57:17.293 INFO ProducerImpl:466 | [persistent://sample/standalone/ns1/my-python-test-producer-sequence-after-reconnection-1532422637.08, my-producer-name] Closed producer 2018-07-24 08:57:17.295 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test-producer-sequence-after-reconnection-1532422637.08, my-producer-name] Getting connection from pool 2018-07-24 08:57:17.296 INFO ProducerImpl:154 | [persistent://sample/standalone/ns1/my-python-test-producer-sequence-after-reconnection-1532422637.08, my-producer-name] Created producer on broker [127.0.0.1:51544 -> 127.0.0.1:8885] .2018-07-24 08:57:17.377 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:17.378 INFO ClientConnection:285 | [127.0.0.1:51546 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:17.381 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-producer-name] Getting connection from pool 2018-07-24 08:57:17.531 INFO ProducerImpl:154 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-producer-name] Created producer on broker [127.0.0.1:51546 -> 127.0.0.1:8885] 2018-07-24 08:57:17.533 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 0] Getting connection from pool 2018-07-24 08:57:17.581 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 0] Created consumer on broker [127.0.0.1:51546 -> 127.0.0.1:8885] 2018-07-24 08:57:17.583 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 0] Closed consumer 0 2018-07-24 08:57:17.585 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub2, 1] Getting connection from pool 2018-07-24 08:57:17.648 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub2, 1] Created consumer on broker [127.0.0.1:51546 -> 127.0.0.1:8885] 2018-07-24 08:57:17.677 INFO ProducerImpl:466 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-producer-name] Closed producer Compact still running {"status":"RUNNING","lastError":""} Compact still running {"status":"RUNNING","lastError":""} Compact still running {"status":"RUNNING","lastError":""} Compact Complete now {"status":"SUCCESS","lastError":""} 2018-07-24 08:57:18.499 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 2] Getting connection from pool 2018-07-24 08:57:18.501 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 2] Created consumer on broker [127.0.0.1:51546 -> 127.0.0.1:8885] 2018-07-24 08:57:18.547 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub1, 2] Closed consumer 2 2018-07-24 08:57:18.548 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns1/my-python-test_publish_compact_and_consume, my-sub2, 1] Closed consumer 1 .2018-07-24 08:57:18.549 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:18.550 INFO ClientConnection:285 | [127.0.0.1:51560 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:18.553 INFO HandlerBase:53 | [persistent://sample/standalone/ns1/my-python-test-producer, reader-6ff282, 0] Getting connection from pool 2018-07-24 08:57:18.555 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns1/my-python-test-producer, reader-6ff282, 0] Created consumer on broker [127.0.0.1:51560 -> 127.0.0.1:8885] 2018-07-24 08:57:18.557 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns1/my-python-test-producer, reader-6ff282, 0] Closed consumer 0 .2018-07-24 08:57:18.557 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:18.558 INFO ClientConnection:285 | [127.0.0.1:51562 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:18.560 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, ] Getting connection from pool 2018-07-24 08:57:18.644 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, ] Created producer on broker [127.0.0.1:51562 -> 127.0.0.1:8885] 2018-07-24 08:57:18.646 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, reader-d18cd0, 0] Getting connection from pool 2018-07-24 08:57:18.649 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, reader-d18cd0, 0] Created consumer on broker [127.0.0.1:51562 -> 127.0.0.1:8885] 2018-07-24 08:57:18.853 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, reader-d18cd0, 0] Closed consumer 0 2018-07-24 08:57:18.853 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-reader-has-message-available, standalone-0-94] Closed producer .2018-07-24 08:57:18.854 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:18.855 INFO ClientConnection:285 | [127.0.0.1:51564 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:18.859 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, ] Getting connection from pool 2018-07-24 08:57:18.911 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, ] Created producer on broker [127.0.0.1:51564 -> 127.0.0.1:8885] 2018-07-24 08:57:19.012 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, reader-ad67d3, 0] Getting connection from pool 2018-07-24 08:57:19.016 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, reader-ad67d3, 0] Created consumer on broker [127.0.0.1:51564 -> 127.0.0.1:8885] 2018-07-24 08:57:19.113 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, reader-ad67d3, 0] Closed consumer 0 2018-07-24 08:57:19.114 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-reader-on-last-message, standalone-0-95] Closed producer .2018-07-24 08:57:19.115 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:19.116 INFO ClientConnection:285 | [127.0.0.1:51566 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:19.119 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, ] Getting connection from pool 2018-07-24 08:57:19.179 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, ] Created producer on broker [127.0.0.1:51566 -> 127.0.0.1:8885] 2018-07-24 08:57:19.278 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-8056eb, 0] Getting connection from pool 2018-07-24 08:57:19.282 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-8056eb, 0] Created consumer on broker [127.0.0.1:51566 -> 127.0.0.1:8885] 2018-07-24 08:57:19.289 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-4be383, 1] Getting connection from pool 2018-07-24 08:57:19.292 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-4be383, 1] Created consumer on broker [127.0.0.1:51566 -> 127.0.0.1:8885] 2018-07-24 08:57:19.295 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-8056eb, 0] Closed consumer 0 2018-07-24 08:57:19.296 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, reader-4be383, 1] Closed consumer 1 2018-07-24 08:57:19.296 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message, standalone-0-96] Closed producer .2018-07-24 08:57:19.297 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:19.298 INFO ClientConnection:285 | [127.0.0.1:51568 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:19.302 INFO BatchMessageContainer:41 | { BatchContainer [size = 0] [batchSizeInBytes_ = 0] [maxAllowedMessageBatchSizeInBytes_ = 131072] [maxAllowedNumMessagesInBatch_ = 1000] [topicName = persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches] [producerName_ = ] [batchSizeInBytes_ = 0] [numberOfBatchesSent = 0] [averageBatchSize = 0]} BatchMessageContainer constructed 2018-07-24 08:57:19.302 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, ] Getting connection from pool 2018-07-24 08:57:19.360 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, ] Created producer on broker [127.0.0.1:51568 -> 127.0.0.1:8885] 2018-07-24 08:57:20.387 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-0ccf5c, 0] Getting connection from pool 2018-07-24 08:57:20.391 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-0ccf5c, 0] Created consumer on broker [127.0.0.1:51568 -> 127.0.0.1:8885] 2018-07-24 08:57:20.399 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-b64370, 1] Getting connection from pool 2018-07-24 08:57:20.404 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-b64370, 1] Created consumer on broker [127.0.0.1:51568 -> 127.0.0.1:8885] 2018-07-24 08:57:20.409 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-0ccf5c, 0] Closed consumer 0 2018-07-24 08:57:20.410 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, reader-b64370, 1] Closed consumer 1 2018-07-24 08:57:20.411 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-reader-on-specific-message-with-batches, standalone-0-97] Closed producer .2018-07-24 08:57:20.412 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:20.413 INFO ClientConnection:285 | [127.0.0.1:51570 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:20.416 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, reader-06dd9d, 0] Getting connection from pool 2018-07-24 08:57:20.469 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, reader-06dd9d, 0] Created consumer on broker [127.0.0.1:51570 -> 127.0.0.1:8885] 2018-07-24 08:57:20.470 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, ] Getting connection from pool 2018-07-24 08:57:20.475 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, ] Created producer on broker [127.0.0.1:51570 -> 127.0.0.1:8885] 2018-07-24 08:57:20.596 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, reader-06dd9d, 0] Closed consumer 0 2018-07-24 08:57:20.597 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-reader-simple, standalone-0-98] Closed producer .2018-07-24 08:57:20.598 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:20.599 INFO ClientConnection:285 | [127.0.0.1:51572 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:20.603 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Getting connection from pool 2018-07-24 08:57:20.767 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Created consumer on broker [127.0.0.1:51572 -> 127.0.0.1:8885] 2018-07-24 08:57:20.771 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-seek, ] Getting connection from pool 2018-07-24 08:57:20.778 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic-seek, ] Created producer on broker [127.0.0.1:51572 -> 127.0.0.1:8885] 2018-07-24 08:57:21.695 INFO HandlerBase:129 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Schedule reconnection in 0.1 s 2018-07-24 08:57:21.701 INFO ConsumerImpl:893 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Seek successfully 2018-07-24 08:57:21.795 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Getting connection from pool 2018-07-24 08:57:21.800 INFO ConsumerImpl:168 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Created consumer on broker [127.0.0.1:51572 -> 127.0.0.1:8885] 2018-07-24 08:57:22.203 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic-seek, standalone-0-99] Closed producer 2018-07-24 08:57:22.203 INFO ConsumerImpl:761 | [persistent://sample/standalone/ns/my-python-topic-seek, my-sub, 0] Closed consumer 0 .2018-07-24 08:57:22.204 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:22.205 INFO ClientConnection:285 | [127.0.0.1:51574 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:22.209 INFO HandlerBase:53 | [persistent://sample/standalone/ns/my-python-topic, ] Getting connection from pool 2018-07-24 08:57:22.215 INFO ProducerImpl:154 | [persistent://sample/standalone/ns/my-python-topic, ] Created producer on broker [127.0.0.1:51574 -> 127.0.0.1:8885] 2018-07-24 08:57:22.227 INFO ProducerImpl:466 | [persistent://sample/standalone/ns/my-python-topic, standalone-0-100] Closed producer .2018-07-24 08:57:22.229 INFO ConnectionPool:63 | Created connection for pulsar+ssl://localhost:9886 2018-07-24 08:57:22.230 INFO ClientConnection:285 | [127.0.0.1:47274 -> 127.0.0.1:9886] Connected to broker 2018-07-24 08:57:22.281 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Getting connection from pool 2018-07-24 08:57:22.284 INFO ConnectionPool:63 | Created connection for pulsar://localhost:9886 2018-07-24 08:57:22.285 INFO ClientConnection:287 | [127.0.0.1:47276 -> 127.0.0.1:9886] Connected to broker through proxy. Logical broker: pulsar://localhost:9886 2018-07-24 08:57:22.462 INFO ConsumerImpl:168 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Created consumer on broker [127.0.0.1:47276 -> 127.0.0.1:9886] 2018-07-24 08:57:22.468 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Getting connection from pool 2018-07-24 08:57:22.478 INFO ProducerImpl:154 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Created producer on broker [127.0.0.1:47276 -> 127.0.0.1:9886] 2018-07-24 08:57:22.614 INFO ProducerImpl:466 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, cluster-0-1] Closed producer 2018-07-24 08:57:22.617 INFO ConsumerImpl:761 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Closed consumer 0 .2018-07-24 08:57:22.619 INFO ConnectionPool:63 | Created connection for pulsar+ssl://localhost:9886 2018-07-24 08:57:22.620 INFO ClientConnection:285 | [127.0.0.1:47278 -> 127.0.0.1:9886] Connected to broker 2018-07-24 08:57:22.656 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Getting connection from pool 2018-07-24 08:57:22.659 INFO ConnectionPool:63 | Created connection for pulsar://localhost:9886 2018-07-24 08:57:22.659 INFO ClientConnection:287 | [127.0.0.1:47280 -> 127.0.0.1:9886] Connected to broker through proxy. Logical broker: pulsar://localhost:9886 2018-07-24 08:57:22.693 INFO ConsumerImpl:168 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Created consumer on broker [127.0.0.1:47280 -> 127.0.0.1:9886] 2018-07-24 08:57:22.696 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Getting connection from pool 2018-07-24 08:57:22.713 INFO ProducerImpl:154 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Created producer on broker [127.0.0.1:47280 -> 127.0.0.1:9886] 2018-07-24 08:57:22.733 INFO ProducerImpl:466 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, cluster-0-2] Closed producer 2018-07-24 08:57:22.734 INFO ConsumerImpl:761 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Closed consumer 0 .2018-07-24 08:57:22.736 INFO ConnectionPool:63 | Created connection for pulsar+ssl://localhost:9886 2018-07-24 08:57:22.736 INFO ClientConnection:285 | [127.0.0.1:47282 -> 127.0.0.1:9886] Connected to broker 2018-07-24 08:57:22.773 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Getting connection from pool 2018-07-24 08:57:22.776 INFO ConnectionPool:63 | Created connection for pulsar://localhost:9886 2018-07-24 08:57:22.776 INFO ClientConnection:287 | [127.0.0.1:47284 -> 127.0.0.1:9886] Connected to broker through proxy. Logical broker: pulsar://localhost:9886 2018-07-24 08:57:22.807 INFO ConsumerImpl:168 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Created consumer on broker [127.0.0.1:47284 -> 127.0.0.1:9886] 2018-07-24 08:57:22.810 INFO HandlerBase:53 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Getting connection from pool 2018-07-24 08:57:22.818 INFO ProducerImpl:154 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, ] Created producer on broker [127.0.0.1:47284 -> 127.0.0.1:9886] 2018-07-24 08:57:22.829 INFO ProducerImpl:466 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, cluster-0-3] Closed producer 2018-07-24 08:57:22.831 INFO ConsumerImpl:761 | [persistent://property/cluster/namespace/my-python-topic-producer-consumer, my-sub, 0] Closed consumer 0 .2018-07-24 08:57:22.832 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:22.832 INFO ClientConnection:285 | [127.0.0.1:51588 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:22.836 INFO HandlerBase:53 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Getting connection from pool 2018-07-24 08:57:22.956 INFO ConsumerImpl:168 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Created consumer on broker [127.0.0.1:51588 -> 127.0.0.1:8885] 2018-07-24 08:57:22.961 INFO HandlerBase:53 | [persistent://public/default/my-v2-topic-producer-consumer, ] Getting connection from pool 2018-07-24 08:57:22.963 INFO ProducerImpl:154 | [persistent://public/default/my-v2-topic-producer-consumer, ] Created producer on broker [127.0.0.1:51588 -> 127.0.0.1:8885] 2018-07-24 08:57:23.086 INFO ProducerImpl:466 | [persistent://public/default/my-v2-topic-producer-consumer, standalone-0-101] Closed producer 2018-07-24 08:57:23.087 INFO ConsumerImpl:761 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Closed consumer 0 .2018-07-24 08:57:23.088 INFO HTTPLookupService:161 | Curl Lookup Request sent forhttp://localhost:8765/admin/v2/persistent/public/default/my-v2-topic-producer-consumer/partitions 2018-07-24 08:57:23.101 INFO HTTPLookupService:173 | Response received for url http://localhost:8765/admin/v2/persistent/public/default/my-v2-topic-producer-consumer/partitions code 200 2018-07-24 08:57:23.101 INFO HTTPLookupService:214 | parsePartitionData = { LookupDataResult [brokerUrl_ = ] [brokerUrlSsl_ = ] [partitions = 0] [authoritative = 0] [redirect = 0] proxyThroughServiceUrl = 0] } 2018-07-24 08:57:23.102 INFO HandlerBase:53 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Getting connection from pool 2018-07-24 08:57:23.102 INFO HTTPLookupService:161 | Curl Lookup Request sent forhttp://localhost:8765/lookup/v2/topic/persistent/public/default/my-v2-topic-producer-consumer 2018-07-24 08:57:23.110 INFO HTTPLookupService:173 | Response received for url http://localhost:8765/lookup/v2/topic/persistent/public/default/my-v2-topic-producer-consumer code 200 2018-07-24 08:57:23.110 INFO HTTPLookupService:243 | parseLookupData = { LookupDataResult [brokerUrl_ = pulsar://localhost:8885] [brokerUrlSsl_ = ] [partitions = 0] [authoritative = 0] [redirect = 0] proxyThroughServiceUrl = 0] } 2018-07-24 08:57:23.111 INFO ConnectionPool:63 | Created connection for pulsar://localhost:8885 2018-07-24 08:57:23.111 INFO ClientConnection:285 | [127.0.0.1:51594 -> 127.0.0.1:8885] Connected to broker 2018-07-24 08:57:23.115 INFO ConsumerImpl:168 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Created consumer on broker [127.0.0.1:51594 -> 127.0.0.1:8885] 2018-07-24 08:57:23.115 INFO HTTPLookupService:161 | Curl Lookup Request sent forhttp://localhost:8765/admin/v2/persistent/public/default/my-v2-topic-producer-consumer/partitions 2018-07-24 08:57:23.124 INFO HTTPLookupService:173 | Response received for url http://localhost:8765/admin/v2/persistent/public/default/my-v2-topic-producer-consumer/partitions code 200 2018-07-24 08:57:23.124 INFO HTTPLookupService:214 | parsePartitionData = { LookupDataResult [brokerUrl_ = ] [brokerUrlSsl_ = ] [partitions = 0] [authoritative = 0] [redirect = 0] proxyThroughServiceUrl = 0] } 2018-07-24 08:57:23.124 INFO HandlerBase:53 | [persistent://public/default/my-v2-topic-producer-consumer, ] Getting connection from pool 2018-07-24 08:57:23.124 INFO HTTPLookupService:161 | Curl Lookup Request sent forhttp://localhost:8765/lookup/v2/topic/persistent/public/default/my-v2-topic-producer-consumer 2018-07-24 08:57:23.132 INFO HTTPLookupService:173 | Response received for url http://localhost:8765/lookup/v2/topic/persistent/public/default/my-v2-topic-producer-consumer code 200 2018-07-24 08:57:23.132 INFO HTTPLookupService:243 | parseLookupData = { LookupDataResult [brokerUrl_ = pulsar://localhost:8885] [brokerUrlSsl_ = ] [partitions = 0] [authoritative = 0] [redirect = 0] proxyThroughServiceUrl = 0] } 2018-07-24 08:57:23.134 INFO ProducerImpl:154 | [persistent://public/default/my-v2-topic-producer-consumer, ] Created producer on broker [127.0.0.1:51594 -> 127.0.0.1:8885] 2018-07-24 08:57:23.246 INFO ProducerImpl:466 | [persistent://public/default/my-v2-topic-producer-consumer, standalone-0-102] Closed producer 2018-07-24 08:57:23.246 INFO ConsumerImpl:761 | [persistent://public/default/my-v2-topic-producer-consumer, my-sub, 0] Closed consumer 0 . ---------------------------------------------------------------------- Ran 27 tests in 10.324s OK /pulsar/pulsar-client-cpp/python /pulsar/pulsar-client-cpp /pulsar/pulsar-client-cpp [pulsar-master] $ /bin/bash -xe /tmp/jenkins6206085019485398789.sh + echo 'Building Docker images' Building Docker images + docker/build.sh [INFO] Scanning for projects... [WARNING] [WARNING] Some problems were encountered while building the effective model for org.apache.pulsar:docker-images:pom:2.2.0-incubating-SNAPSHOT [WARNING] 'dependencyManagement.dependencies.dependency.(groupId:artifactId:type:classifier)' must be unique: commons-io:commons-io:jar -> duplicate declaration of version 2.5 @ org.apache.pulsar:pulsar:2.2.0-incubating-SNAPSHOT, <https://builds.apache.org/job/pulsar-master/ws/pom.xml,> line 486, column 19 [WARNING] [WARNING] It is highly recommended to fix these problems because they threaten the stability of your build. [WARNING] [WARNING] For this reason, future Maven versions might no longer support building such malformed projects. [WARNING] [INFO] ------------------------------------------------------------------------ [INFO] Reactor Build Order: [INFO] [INFO] Apache Pulsar :: Docker Images [INFO] Apache Pulsar :: Docker Images :: Pulsar Latest Version [INFO] Apache Pulsar :: Docker Images :: Grafana [INFO] Apache Pulsar :: Docker Images :: Pulsar Latest Version (Include All Components) [INFO] [INFO] ------------------------------------------------------------------------ [INFO] Building Apache Pulsar :: Docker Images 2.2.0-incubating-SNAPSHOT [INFO] ------------------------------------------------------------------------ Downloading: http://repository.apache.org/snapshots/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/maven-metadata.xml Downloading: https://repo1.maven.org/maven2/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/maven-metadata.xml Progress (1): 813 B Downloaded: http://repository.apache.org/snapshots/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/maven-metadata.xml (813 B at 1.8 kB/s) Downloading: https://repo1.maven.org/maven2/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/buildtools-2.2.0-incubating-20180723.124046-27.pom Downloading: http://repository.apache.org/snapshots/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/buildtools-2.2.0-incubating-20180723.124046-27.pom [WARNING] The POM for org.apache.pulsar:buildtools:jar:2.2.0-incubating-20180723.124046-27 is missing, no dependency information available Downloading: http://repository.apache.org/snapshots/org/apache/pulsar/buildtools/2.2.0-incubating-SNAPSHOT/buildtools-2.2.0-incubating-20180723.124046-27.jar [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] Apache Pulsar :: Docker Images ..................... FAILURE [ 1.606 s] [INFO] Apache Pulsar :: Docker Images :: Pulsar Latest Version SKIPPED [INFO] Apache Pulsar :: Docker Images :: Grafana .......... SKIPPED [INFO] Apache Pulsar :: Docker Images :: Pulsar Latest Version (Include All Components) SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 2.109 s [INFO] Finished at: 2018-07-24T08:57:28Z [INFO] Final Memory: 19M/1095M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal on project docker-images: Could not resolve dependencies for project org.apache.pulsar:docker-images:pom:2.2.0-incubating-SNAPSHOT: Could not find artifact org.apache.pulsar:buildtools:jar:2.2.0-incubating-20180723.124046-27 in Nexus (http://repository.apache.org/snapshots) -> [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/DependencyResolutionException [INFO] Scanning for projects... [ERROR] [ERROR] Some problems were encountered while processing the POMs: [FATAL] Non-resolvable parent POM for org.apache.pulsar:dashboard-docker-image:[unknown-version]: Could not find artifact org.apache.pulsar:docker-images:pom:2.1.0-incubating-SNAPSHOT and 'parent.relativePath' points at wrong local POM @ line 23, column 11 @ [ERROR] The build could not read 1 project -> [Help 1] [ERROR] [ERROR] The project org.apache.pulsar:dashboard-docker-image:[unknown-version] (<https://builds.apache.org/job/pulsar-master/ws/docker/../dashboard/pom.xml)> has 1 error [ERROR] Non-resolvable parent POM for org.apache.pulsar:dashboard-docker-image:[unknown-version]: Could not find artifact org.apache.pulsar:docker-images:pom:2.1.0-incubating-SNAPSHOT and 'parent.relativePath' points at wrong local POM @ line 23, column 11 -> [Help 2] [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/ProjectBuildingException [ERROR] [Help 2] http://cwiki.apache.org/confluence/display/MAVEN/UnresolvableModelException Build step 'Execute shell' marked build as failure Not sending mail to unregistered user nore...@github.com Not sending mail to unregistered user guosi...@gmail.com Not sending mail to unregistered user y.shiga.91+yush...@gmail.com