日志

在 master 上构建 在工作空间 /root/.jenkins/workspace/ddmq_test_11_14-13 中
using credential 63bb1c11-87f5-4bd1-ac9c-72b30fd227f7

git rev-parse --is-inside-work-tree # timeout=10
Fetching changes from the remote Git repository
git config remote.origin.url git@git.xiaojukeji.com:foundation/carrera-docker-test.git # timeout=10
Fetching upstream changes from git@git.xiaojukeji.com:foundation/carrera-docker-test.git
git --version # timeout=10
using GIT_SSH to set credentials
git fetch --tags --progress git@git.xiaojukeji.com:foundation/carrera-docker-test.git +refs/heads/:refs/remotes/origin/
git rev-parse origin/master^{commit} # timeout=10
Checking out Revision ad16f17e0394861dc8576a448ab005cb4102a9c0 (origin/master)
git config core.sparsecheckout # timeout=10
git checkout -f ad16f17e0394861dc8576a448ab005cb4102a9c0
Commit message: "fix cases"
git rev-list --no-walk ad16f17e0394861dc8576a448ab005cb4102a9c0 # timeout=10
No emails were triggered.
Parsing POMs
Established TCP socket on 45501
[autotest] $ java -cp /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven35-agent-1.12.jar:/root/tool/apache-maven-3.6.0/boot/plexus-classworlds-2.5.2.jar:/root/tool/apache-maven-3.6.0/conf/logging jenkins.maven3.agent.Maven35Main /root/tool/apache-maven-3.6.0 /root/.jenkins/war/WEB-INF/lib/remoting-3.27.jar /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven35-interceptor-1.12.jar /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven3-interceptor-commons-1.12.jar 45501
<===[JENKINS REMOTING CAPACITY]===>channel started
Executing Maven: -B -f /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/pom.xml clean test -Dtest=TestProduce,TestSDBroadcastDispatch,TestConsume -DsdUrl=10.179.52.200:9513
[INFO] Scanning for projects...
[INFO]
[INFO] --------------------< com.xiaoju.carrera:autotest >---------------------
[INFO] Building autotest 1.0-SNAPSHOT
[INFO] --------------------------------[ jar ]---------------------------------
[INFO]
[INFO] --- maven-clean-plugin:2.5:clean (default-clean) @ autotest ---
[INFO] Deleting /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/target
[INFO]
[INFO] --- maven-resources-plugin:2.6:resources (default-resources) @ autotest ---
[WARNING] Using platform encoding (UTF-8 actually) to copy filtered resources, i.e. build is platform dependent!
[INFO] skip non existing resourceDirectory /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/src/main/resources
[INFO]
[INFO] --- maven-compiler-plugin:3.6.0:compile (default-compile) @ autotest ---
[INFO] No sources to compile
[INFO]
[INFO] --- maven-resources-plugin:2.6:testResources (default-testResources) @ autotest ---
[WARNING] File encoding has not been set, using platform encoding UTF-8, i.e. build is platform dependent!
[WARNING] Using platform encoding (UTF-8 actually) to copy filtered resources, i.e. build is platform dependent!
[INFO] Copying 1 resource
[INFO]
[INFO] --- maven-compiler-plugin:3.6.0:testCompile (default-testCompile) @ autotest ---
[INFO] Changes detected - recompiling the module!
[INFO] Compiling 7 source files to /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/target/test-classes
[INFO]
[INFO] --- maven-surefire-plugin:2.12.4:test (default-test) @ autotest ---
[INFO] Surefire report directory: /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/target/surefire-reports

T E S T S

Running com.xiaoju.carrera.TestSDBroadcastDispatch
testSDBroadcastDispatch start-------------------------------
----------------broadcastServerIpNumIs1---------------
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
the sdUrl is : 10.179.52.200:9513
----------------update node---------------
new node list size=1, new list:[Node{ip='10.179.52.200', port=9716}]

----------------broadcastServerIpNumIs6---------------
----------------update node---------------
new node list size=6, new list:[Node{ip='10.179.52.200', port=9713}, Node{ip='10.179.52.200', port=9714}, Node{ip='10.179.52.200', port=9715}, Node{ip='10.179.52.200', port=9716}, Node{ip='10.179.52.200', port=9717}, Node{ip='10.179.52.200', port=9718}]

----------------broadcastServerIpNumIs10---------------
----------------update node---------------
new node list size=6, new list:[Node{ip='10.179.52.200', port=9713}, Node{ip='10.179.52.200', port=9714}, Node{ip='10.179.52.200', port=9715}, Node{ip='10.179.52.200', port=9716}, Node{ip='10.179.52.200', port=9717}, Node{ip='10.179.52.200', port=9718}]

----------------broadcastServerIpNumIsDefault2---------------
----------------update node---------------
new node list size=2, new list:[Node{ip='10.179.52.200', port=9716}, Node{ip='10.179.52.200', port=9717}]

----------------broadcastServerIpNumIsNegativeNumber---------------
----------------update node---------------
new node list size=6, new list:[Node{ip='10.179.52.200', port=9713}, Node{ip='10.179.52.200', port=9714}, Node{ip='10.179.52.200', port=9715}, Node{ip='10.179.52.200', port=9716}, Node{ip='10.179.52.200', port=9717}, Node{ip='10.179.52.200', port=9718}]

Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.67 sec
Running com.xiaoju.carrera.TestConsume
testConsume start-------------------------------
----------------testConsumeOrderByJsonPath---------------
the key of message0 is : lzSiru9sdIbkE1QS
the key of message1 is : c1D8uBJHccl1T5FC
the key of message2 is : FludPk2TU7KvEuuS
message0: Result(code:0, msg:OK, key:lzSiru9sdIbkE1QS)
message1: Result(code:0, msg:OK, key:c1D8uBJHccl1T5FC)
message2: Result(code:0, msg:OK, key:FludPk2TU7KvEuuS)
produce endTime : 1597720213435
process key: lzSiru9sdIbkE1QS, value: {"orderId":12,"body":"this is message body._1"}, offset: 0, context: Context(groupId:cg_auto_test_orderly_msg_by_json_path, topic:auto_test_orderly_msg_by_json_path, qid:R_auto_test_auto_test-01_4)
process key: c1D8uBJHccl1T5FC, value: {"orderId":12,"body":"this is message body._2"}, offset: 1, context: Context(groupId:cg_auto_test_orderly_msg_by_json_path, topic:auto_test_orderly_msg_by_json_path, qid:R_auto_test_auto_test-01_4)
process key: FludPk2TU7KvEuuS, value: {"orderId":12,"body":"this is message body._3"}, offset: 2, context: Context(groupId:cg_auto_test_orderly_msg_by_json_path, topic:auto_test_orderly_msg_by_json_path, qid:R_auto_test_auto_test-01_4)
consume over, the num of message is : 3, order and qid map: {1=R_auto_test_auto_test-01_4, 2=R_auto_test_auto_test-01_4, 3=R_auto_test_auto_test-01_4}, order and offset map: {1=0, 2=1, 3=2}
----------------testConsumeOrderByKey---------------
the key is : th4iwWRSqTbVKdCU
message0: Result(code:0, msg:OK, key:th4iwWRSqTbVKdCU)
process key: th4iwWRSqTbVKdCU, value: this is message body._1, offset: 0, context: Context(groupId:cg_auto_test_orderly_msg_by_key, topic:auto_test_orderly_msg_by_key, qid:R_auto_test_auto_test-00_4)
process key: th4iwWRSqTbVKdCU, value: this is message body._2, offset: 1, context: Context(groupId:cg_auto_test_orderly_msg_by_key, topic:auto_test_orderly_msg_by_key, qid:R_auto_test_auto_test-00_4)
message1: Result(code:0, msg:OK, key:th4iwWRSqTbVKdCU)
message2: Result(code:0, msg:OK, key:th4iwWRSqTbVKdCU)
produce endTime : 1597720218981
process key: th4iwWRSqTbVKdCU, value: this is message body._3, offset: 2, context: Context(groupId:cg_auto_test_orderly_msg_by_key, topic:auto_test_orderly_msg_by_key, qid:R_auto_test_auto_test-00_4)
consume over, the num of message is : 3, order and qid map: {1=R_auto_test_auto_test-00_4, 2=R_auto_test_auto_test-00_4, 3=R_auto_test_auto_test-00_4}, order and offset map: {1=0, 2=1, 3=2}
----------------testConsumeOrderByQid---------------
the key of message0 is : AkT6cqQFA2w40EIA
the key of message1 is : BSRP6HXqRh3NSk9R
the key of message2 is : G2HysdSwK4N907Sh
message0: Result(code:0, msg:OK, key:AkT6cqQFA2w40EIA)
message1: Result(code:0, msg:OK, key:BSRP6HXqRh3NSk9R)
message2: Result(code:0, msg:OK, key:G2HysdSwK4N907Sh)
produce endTime : 1597720223793
process key: AkT6cqQFA2w40EIA, value: this is message body._1, offset: 0, context: Context(groupId:cg_auto_test_orderly_msg_by_qid, topic:auto_test_orderly_msg_by_qid, qid:R_auto_test_auto_test-00_6)
process key: BSRP6HXqRh3NSk9R, value: this is message body._2, offset: 1, context: Context(groupId:cg_auto_test_orderly_msg_by_qid, topic:auto_test_orderly_msg_by_qid, qid:R_auto_test_auto_test-00_6)
process key: G2HysdSwK4N907Sh, value: this is message body._3, offset: 2, context: Context(groupId:cg_auto_test_orderly_msg_by_qid, topic:auto_test_orderly_msg_by_qid, qid:R_auto_test_auto_test-00_6)
consume over, the num of message is : 3, order and qid map: {1=R_auto_test_auto_test-00_6, 2=R_auto_test_auto_test-00_6, 3=R_auto_test_auto_test-00_6}, order and offset map: {1=0, 2=1, 3=2}
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.369 sec
Running com.xiaoju.carrera.TestProduce
testProduce start-------------------------------
----------------testProducerIpWhiteList---------------
Result(code:24, msg:FAILED: client ip not in white list, key:ghnR0Uax0oFUwpOH)
----------------testSimpleProduce---------------
Result(code:0, msg:OK, key:GIwPvFwbWBoMnV5L)
process key: GIwPvFwbWBoMnV5L, value: this is message body., offset: 0, context: Context(groupId:cg_auto_test_test_founction_0, topic:auto_test_test_founction_0, qid:R_auto_test_auto_test-01_7)
the realMessage is : this is message body.
----------------testOrderlyByPartition---------------
the key of message0 is : NsFbfIpWaQ5KaWlh
the key of message1 is : B2G6JdxATcppX46d
the key of message2 is : rTD2KGhirxe2lezT
produce startTime : 1597720240734
Result(code:0, msg:OK)
produce endTime : 1597720240817
process key: NsFbfIpWaQ5KaWlh, value: this is message body._1, offset: 0, context: Context(groupId:cg_auto_test_orderly_msg_by_partition, topic:auto_test_orderly_msg_by_partition, qid:R_auto_test_auto_test-00_6)
process key: B2G6JdxATcppX46d, value: this is message body._2, offset: 1, context: Context(groupId:cg_auto_test_orderly_msg_by_partition, topic:auto_test_orderly_msg_by_partition, qid:R_auto_test_auto_test-00_6)
process key: rTD2KGhirxe2lezT, value: this is message body._3, offset: 2, context: Context(groupId:cg_auto_test_orderly_msg_by_partition, topic:auto_test_orderly_msg_by_partition, qid:R_auto_test_auto_test-00_6)
consume over, the num of message is : 3, order and offset map: {1=R_auto_test_auto_test-00_6, 2=R_auto_test_auto_test-00_6, 3=R_auto_test_auto_test-00_6}
----------------testDelayMessage_0---------------
produce startTime : 1597720248010
timestamp=1597720249
send delay message, result msg is : OK, the uniqDelayMsgId=1597720249-2-1597893049-0-0-0-0-69d6dd00-e100-11ea-aa22-02cd7abdb7b9
produce endTime : 1597720248026
process key: 1597720249-2-1597893049-0-0-0-0-69d6dd00-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_0, topic:auto_test_delay_0, qid:R_auto_test_auto_test-00_2)
the delayMessage: send time is:1597720248011 real trigger time is :1597720249148, spentTime is:1137
the message real trigger time is 1597720249148, spent 1137ms
----------------testDelayMessage_1---------------
timestamp=1597720254
send delay message, result msg is : OK, the uniqDelayMsgId=1597720254-3-1597720263-3-0-3-0-6d644980-e100-11ea-aa22-02cd7abdb7b9
produce endTime : 1597720254015
process key: 1597720254-3-1597720263-3-0-3-0-6d644980-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_1, topic:auto_test_delay_1, qid:R_auto_test_auto_test-01_6), realTriggerTime is: 1597720254
process key: 1597720257-3-1597720263-3-1-3-0-6d644980-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_1, topic:auto_test_delay_1, qid:R_auto_test_auto_test-00_7), realTriggerTime is: 1597720257
process key: 1597720260-3-1597720263-3-2-3-0-6d644980-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_1, topic:auto_test_delay_1, qid:R_auto_test_auto_test-01_5), realTriggerTime is: 1597720260
consume endTime : 1597720264016
the message trigger times is 3, and the last trigger time is 1597720260
----------------testDelayMessage_2---------------
timestamp=1597720268
send delay message, result msg is : OK, the uniqDelayMsgId=1597720268-4-1597720367-3-0-2-0-75b70640-e100-11ea-aa22-02cd7abdb7b9
produce endTime : 1597720267951
process key: 1597720268-4-1597720367-3-0-2-0-75b70640-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_2, topic:auto_test_delay_2, qid:R_auto_test_auto_test-00_5), realTriggerTime is: 1597720268
process key: 1597720270-4-1597720367-3-1-2-0-75b70640-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_2, topic:auto_test_delay_2, qid:R_auto_test_auto_test-01_1), realTriggerTime is: 1597720270
process key: 1597720274-4-1597720367-3-2-2-0-75b70640-e100-11ea-aa22-02cd7abdb7b9, value: this is delay message body., offset: 0, context: Context(groupId:cg_auto_test_delay_2, topic:auto_test_delay_2, qid:R_auto_test_auto_test-01_5), realTriggerTime is: 1597720274
consume endTime : 1597720277951
the message trigger times is 3, and the last trigger time is 1597720274
----------------testOrderlyByHashId---------------
the key of message0 is : 6Ww67eAwh0IN1BoB
the key of message1 is : zd40LkIXfHXZmh0N
the key of message2 is : XHbWoF6LL1EX06Mz
produce startTime : 1597720282038
Result(code:0, msg:OK)
produce endTime : 1597720282141
process key: 6Ww67eAwh0IN1BoB, value: this is message body._1, offset: 0, context: Context(groupId:cg_auto_test_orderly_msg_by_hash_id, topic:auto_test_orderly_msg_by_hash_id, qid:R_auto_test_auto_test-01_4)
process key: zd40LkIXfHXZmh0N, value: this is message body._2, offset: 1, context: Context(groupId:cg_auto_test_orderly_msg_by_hash_id, topic:auto_test_orderly_msg_by_hash_id, qid:R_auto_test_auto_test-01_4)
process key: XHbWoF6LL1EX06Mz, value: this is message body._3, offset: 2, context: Context(groupId:cg_auto_test_orderly_msg_by_hash_id, topic:auto_test_orderly_msg_by_hash_id, qid:R_auto_test_auto_test-01_4)
consume over, the num of message is : 3, order and values map: {1=R_auto_test_auto_test-01_4, 2=R_auto_test_auto_test-01_4, 3=R_auto_test_auto_test-01_4}
----------------testBatchMessage---------------
the key of message0 is : qtD1pyk0WUjKPKEr
the key of message1 is : lkvkJjLzE6DjlSYB
the key of message2 is : Ji6GuqZyvAE5Jlka
produce startTime : 1597720289301
Result(code:0, msg:OK)
produce endTime : 1597720289315
process key: Ji6GuqZyvAE5Jlka, value: this is message body., offset: 0, context: Context(groupId:cg_auto_test_batch, topic:auto_test_batch, qid:R_auto_test_auto_test-00_5), realTriggerTime is: 1597720289
process key: lkvkJjLzE6DjlSYB, value: this is message body., offset: 0, context: Context(groupId:cg_auto_test_batch, topic:auto_test_batch, qid:R_auto_test_auto_test-00_3), realTriggerTime is: 1597720289
process key: qtD1pyk0WUjKPKEr, value: this is message body., offset: 0, context: Context(groupId:cg_auto_test_batch, topic:auto_test_batch, qid:R_auto_test_auto_test-00_6), realTriggerTime is: 1597720289
consume over, the num of message is : 3
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 69.71 sec

Results :

Tests run: 16, Failures: 0, Errors: 0, Skipped: 0

[JENKINS] Recording test results
[WARNING] Attempt to (de-)serialize anonymous class hudson.maven.reporters.SurefireArchiver$2; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:30 min
[INFO] Finished at: 2020-08-18T11:11:40+08:00
[INFO] ------------------------------------------------------------------------
Waiting for Jenkins to finish collecting data
[JENKINS] Archiving /root/.jenkins/workspace/ddmq_test_11_14-13/autotest-case/java/autotest/pom.xml to com.xiaoju.carrera/autotest/1.0-SNAPSHOT/autotest-1.0-SNAPSHOT.pom
channel stopped
Email was triggered for: Always
Sending email for trigger: Always
Sending email to: mq@didiglobal.com
Finished: SUCCESS