jenkins：应用篇（Gatling plugin的使用）
1 Started by user anonymous2 Building in workspace /root/.jenkins/jobs/mueas-gatling/workspace
3> git rev-parse --is-inside-work-tree # timeout=10
4 Fetching changes from the remote Git repository
5> git config remote.origin.url git@109.105.5.108:/data/git/mueas.git # timeout=10
6 Fetching upstream changes from git@109.105.5.108:/data/git/mueas.git
7> git --version # timeout=10
8 using GIT_SSH to set credentials root private key
9> git -c core.askpass=true fetch --tags --progress git@109.105.5.108:/data/git/mueas.git +refs/heads/*:refs/remotes/origin/*
10> git rev-parse refs/remotes/origin/master^{commit} # timeout=10
11> git rev-parse refs/remotes/origin/origin/master^{commit} # timeout=10
12 Checking out Revision b9dc8261faf8d172c9ee689048b232b9b7c698d2 (refs/remotes/origin/master)
13> git config core.sparsecheckout # timeout=10
14> git checkout -f b9dc8261faf8d172c9ee689048b232b9b7c698d2
15> git rev-list 7ae96f26da0f7b1ff289b6008d3531872938bd17 # timeout=10
16> git tag -a -f -m Jenkins Build #15 jenkins-mueas-gatling-15 # timeout=10
17 $ /bin/bash /tmp/hudson7254261757720827244.sh
18 ================= PRE STEPS TRACKING BEGIN =================
19 WORKSPACE: /root/.jenkins/jobs/mueas-gatling/workspace
20 target dir: /root/.jenkins/jobs/mueas-gatling/workspace/target
21 war file: /root/.jenkins/jobs/mueas-gatling/workspace/target/mueas-0.0.1-SNAPSHOT.war
22 specified running instance: mueas-0.0.1-SNAPSHOT.war --server.port=8080
23 runningpid:
24 There is no running instance as specified
25 ================= PRE STEPS TRACKING END ===================
26 Parsing POMs
27 $ /usr/java/jdk1.8.0_65/bin/java -cp /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven31-agent-1.5.jar:/usr/local/apache-maven-3.3.3/boot/plexus-classworlds-2.5.2.jar:/usr/local/apache-maven-3.3.3/conf/logging jenkins.maven3.agent.Maven31Main /usr/local/apache-maven-3.3.3 /root/.jenkins/war/WEB-INF/lib/remoting-2.53.2.jar /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven31-interceptor-1.5.jar /root/.jenkins/plugins/maven-plugin/WEB-INF/lib/maven3-interceptor-commons-1.5.jar 48577
28 <======>???channel started
29 Executing Maven:-B -f /root/.jenkins/jobs/mueas-gatling/workspace/pom.xml -s /root/.m2/settings.xml -gs /usr/local/apache-maven-3.3.3/conf/settings.xml package -Dmaven.test.skip=true
30 INFO org.apache.maven.cli.event.ExecutionEventLogger - Scanning for projects...
31 INFO org.apache.maven.cli.event.ExecutionEventLogger -
32 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
33 INFO org.apache.maven.cli.event.ExecutionEventLogger - Building mueas 0.0.1-SNAPSHOT
34 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
35 INFO org.apache.maven.cli.event.ExecutionEventLogger -
36 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-resources-plugin:2.6:resources (default-resources) @ mueas ---
37 INFO org.apache.maven.shared.filtering.DefaultMavenResourcesFiltering - Using 'UTF-8' encoding to copy filtered resources.
38 INFO org.apache.maven.shared.filtering.DefaultMavenResourcesFiltering - Copying 0 resource
39 INFO org.apache.maven.shared.filtering.DefaultMavenResourcesFiltering - Copying 863 resources
40 INFO org.apache.maven.cli.event.ExecutionEventLogger -
41 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-compiler-plugin:3.1:compile (default-compile) @ mueas ---
42 INFO org.apache.maven.plugin.compiler.CompilerMojo - Nothing to compile - all>
43 INFO org.apache.maven.cli.event.ExecutionEventLogger -
44 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-resources-plugin:2.6:testResources (default-testResources) @ mueas ---
45 INFO org.apache.maven.plugin.resources.TestResourcesMojo - Not copying test resources
46 INFO org.apache.maven.cli.event.ExecutionEventLogger -
47 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-compiler-plugin:3.1:testCompile (default-testCompile) @ mueas ---
48 INFO org.apache.maven.plugin.compiler.TestCompilerMojo - Not compiling test sources
49 INFO org.apache.maven.cli.event.ExecutionEventLogger -
50 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-surefire-plugin:2.17:test (default-test) @ mueas ---
51 INFO org.apache.maven.plugin.surefire.SurefirePlugin - Tests are skipped.
52 INFO org.apache.maven.cli.event.ExecutionEventLogger -
53 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- maven-war-plugin:2.5:war (default-war) @ mueas ---
54 INFO org.apache.maven.plugin.war.WarMojo - Packaging webapp
55 INFO org.apache.maven.plugin.war.WarMojo - Assembling webapp in
56 INFO org.apache.maven.plugin.war.WarMojo - Processing war project
57 INFO org.apache.maven.plugin.war.WarMojo - Copying webapp resources
58 INFO org.apache.maven.plugin.war.WarMojo - Webapp assembled in
59 INFO org.codehaus.plexus.archiver.war.WarArchiver - Building war: /root/.jenkins/jobs/mueas-gatling/workspace/target/mueas-0.0.1-SNAPSHOT.war
60 INFO org.apache.maven.cli.event.ExecutionEventLogger -
61 INFO org.apache.maven.cli.event.ExecutionEventLogger - --- spring-boot-maven-plugin:1.2.7.RELEASE:repackage (default) @ mueas ---
62 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
63 INFO org.apache.maven.cli.event.ExecutionEventLogger - BUILD SUCCESS
64 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
65 INFO org.apache.maven.cli.event.ExecutionEventLogger - Total time: 11.598 s
66 INFO org.apache.maven.cli.event.ExecutionEventLogger - Finished at: 2016-01-22T11:51:28+08:00
67 INFO org.apache.maven.cli.event.ExecutionEventLogger - Final Memory: 34M/381M
68 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
69 Waiting for Jenkins to finish collecting data
70 Archiving /root/.jenkins/jobs/mueas-gatling/workspace/pom.xml to com.tinguish/mueas/0.0.1-SNAPSHOT/mueas-0.0.1-SNAPSHOT.pom
71 Archiving /root/.jenkins/jobs/mueas-gatling/workspace/target/mueas-0.0.1-SNAPSHOT.war to com.tinguish/mueas/0.0.1-SNAPSHOT/mueas-0.0.1-SNAPSHOT.war
72 channel stopped
73 $ /bin/bash /tmp/hudson1088999714714478379.sh
74 ================= POST STEPS TRACKING BEGIN =================
75 WORKSPACE: /root/.jenkins/jobs/mueas-gatling/workspace
76 target dir: /root/.jenkins/jobs/mueas-gatling/workspace/target
77 war file: /root/.jenkins/jobs/mueas-gatling/workspace/target/mueas-0.0.1-SNAPSHOT.war
78 BEGIN TO DO GATLING SIMULATION....
79 SLF4J:>
80 SLF4J: Found binding in
81 SLF4J: Found binding in
82 SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
83 SLF4J: Actual binding is of type
84
85 . ____ _ __ _ _
86/\\ / ___'_ __ _ _(_)_ ____ _ \ \ \ \
87 ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
88\\/___)| |_)| | | | | || (_| |) ) ) )
89 '|____| .__|_| |_|_| |_\__, | / / / /
90=========|_|==============|___/=/_/_/_/
91:: Spring Boot :: (v1.2.7.RELEASE)
92
93 2016-01-22 11:51:31.766INFO 6660 --- [ main] com.tinguish.mueas.Application : Starting Application on CloudGame with PID 6660
94
95 。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。
96 这里省略了mueas项目启动的日志，和这个博文的重点不相干，且涉及到项目机密
97 。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。。
98
99 2016-01-22 11:51:55.192INFO 6660 --- [ main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat started on port(s): 8080 (http)
100 2016-01-22 11:51:55.194INFO 6660 --- [ main] com.tinguish.mueas.Application : Started Application in 24.398 seconds (JVM running for 25.896)
101 Simulation simple.MueasSimulation started...
102 log4j - ????INFO --- HttpProtocol:123: Start warm up
103 log4j - ????INFO --- HttpProtocol:169: Warm up done
104 log4j - ????INFO --- Controller:91: Total number of users : 2
105 log4j - ????INFO --- FileDataWriter:90: Initializing
106 log4j - ????INFO --- ConsoleDataWriter:90: Initializing
107 log4j - ????INFO --- ConsoleDataWriter:92: Initialized
108 log4j - ????INFO --- FileDataWriter:92: Initialized
109 log4j - ????INFO --- Controller:216: Start user #1295396986639070879-0
110 log4j - ????INFO --- Controller:216: Start user #1295396986639070879-1
111 log4j - ????INFO --- HttpEngine:270: Sending request=Redirect Login uri=http://localhost:8080/: scenario=Search mueas home page, userId=1295396986639070879-0
112 log4j - ????INFO --- HttpEngine:270: Sending request=Redirect Login uri=http://localhost:8080/: scenario=Search mueas home page, userId=1295396986639070879-1
113
114 ================================================================================
115 2016-01-22 11:52:06 0s elapsed
116 ---- Search mueas home page ----------------------------------------------------
117 [ ]0%
118 waiting: 2 / active: 0 / done:0
119 ---- Requests ------------------------------------------------------------------
120 > Global (OK=0 KO=0 )
121
122 ================================================================================
123
124 2016-01-22 11:52:06.291INFO 6660 --- o.a.c.c.C...[/] : Initializing Spring FrameworkServlet 'dispatcherServlet'
125 2016-01-22 11:52:06.291INFO 6660 --- o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization started
126 2016-01-22 11:52:06.332INFO 6660 --- o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization completed in 41 ms
127 log4j - ????INFO --- HttpEngine:270: Sending request=Redirect Login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-0
128 log4j - ????INFO --- HttpEngine:270: Sending request=Redirect Login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-1
129 log4j - ????INFO --- Pause:46: Pausing for 10000ms (real=9970ms)
130 log4j - ????INFO --- Pause:46: Pausing for 10000ms (real=9955ms)
131
132 ================================================================================
133 2016-01-22 11:52:11 5s elapsed
134 ---- Search mueas home page ----------------------------------------------------
135 [--------------------------------------------------------------------------]0%
136 waiting: 0 / active: 2 / done:0
137 ---- Requests ------------------------------------------------------------------
138 > Global (OK=4 KO=0 )
139 > Redirect Login (OK=2 KO=0 )
140 > Redirect Login Redirect 1 (OK=2 KO=0 )
141 ================================================================================
142
143
144 ================================================================================
145 2016-01-22 11:52:16 10s elapsed
146 ---- Search mueas home page ----------------------------------------------------
147 [--------------------------------------------------------------------------]0%
148 waiting: 0 / active: 2 / done:0
149 ---- Requests ------------------------------------------------------------------
150 > Global (OK=4 KO=0 )
151 > Redirect Login (OK=2 KO=0 )
152 > Redirect Login Redirect 1 (OK=2 KO=0 )
153 ================================================================================
154
155 log4j - ????INFO --- HttpEngine:270: Sending request=Try login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-1
156 log4j - ????INFO --- HttpEngine:270: Sending request=Try login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-0
157 log4j - ????INFO --- HttpEngine:270: Sending request=Try login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-1
158 log4j - ????INFO --- HttpEngine:270: Sending request=Try login uri=http://localhost:8080/login: scenario=Search mueas home page, userId=1295396986639070879-0
159 log4j - ????WARN --- AsyncHandlerActor:119: Request 'Try login Redirect 1' failed: currentLocation.find.is(http://localhost:8080/), but actually found http://localhost:8080/login
160 log4j - ????INFO --- Pause:46: Pausing for 10000ms (real=9980ms)
161 log4j - ????WARN --- AsyncHandlerActor:119: Request 'Try login Redirect 1' failed: currentLocation.find.is(http://localhost:8080/), but actually found http://localhost:8080/login
162 log4j - ????INFO --- Pause:46: Pausing for 10000ms (real=9968ms)
163
164 ================================================================================
165 2016-01-22 11:52:21 15s elapsed
166 ---- Search mueas home page ----------------------------------------------------
167 [--------------------------------------------------------------------------]0%
168 waiting: 0 / active: 2 / done:0
169 ---- Requests ------------------------------------------------------------------
170 > Global (OK=6 KO=2 )
171 > Redirect Login (OK=2 KO=0 )
172 > Redirect Login Redirect 1 (OK=2 KO=0 )
173 > Try login (OK=2 KO=0 )
174 > Try login Redirect 1 (OK=0 KO=2 )
175 ---- Errors --------------------------------------------------------------------
176 > currentLocation.find.is(http://localhost:8080/), but actually 2 (100.0%)
177 found http://localhost:8080/login
178 ================================================================================
179
180
181 ================================================================================
182 2016-01-22 11:52:26 20s elapsed
183 ---- Search mueas home page ----------------------------------------------------
184 [--------------------------------------------------------------------------]0%
185 waiting: 0 / active: 2 / done:0
186 ---- Requests ------------------------------------------------------------------
187 > Global (OK=6 KO=2 )
188 > Redirect Login (OK=2 KO=0 )
189 > Redirect Login Redirect 1 (OK=2 KO=0 )
190 > Try login (OK=2 KO=0 )
191 > Try login Redirect 1 (OK=0 KO=2 )
192 ---- Errors --------------------------------------------------------------------
193 > currentLocation.find.is(http://localhost:8080/), but actually 2 (100.0%)
194 found http://localhost:8080/login
195 ================================================================================
196
197 log4j - ????INFO --- Controller:203: End user #1295396986639070879-0
198 log4j - ????INFO --- Controller:203: End user #1295396986639070879-1
199
200 ================================================================================
201 2016-01-22 11:52:27 21s elapsed
202 ---- Search mueas home page ----------------------------------------------------
203 [##########################################################################]100%
204 waiting: 0 / active: 0 / done:2
205 ---- Requests ------------------------------------------------------------------
206 > Global (OK=6 KO=2 )
207 > Redirect Login (OK=2 KO=0 )
208 > Redirect Login Redirect 1 (OK=2 KO=0 )
209 > Try login (OK=2 KO=0 )
210 > Try login Redirect 1 (OK=0 KO=2 )
211 ---- Errors --------------------------------------------------------------------
212 > currentLocation.find.is(http://localhost:8080/), but actually 2 (100.0%)
213 found http://localhost:8080/login
214 ================================================================================
215
216 Simulation finished
217 Parsing log file(s)...
218 log4j - ????INFO --- FileDataReader:56: Collected List(/root/.jenkins/jobs/mueas-gatling/workspace/target/gatling/results/mueassimulation-1453434726032/simulation.log) from mueassimulation-1453434726032
219 log4j - ????INFO --- FileDataReader:73: First pass
220 log4j - ????INFO --- FileDataReader:118: First pass done: read 13 lines
221 log4j - ????INFO --- FileDataReader:132: Second pass
222 log4j - ????INFO --- FileDataReader:157: Second pass: read 13 lines
223 Parsing log file(s) done
224 Generating reports...
225
226 ================================================================================
227 ---- Global Information --------------------------------------------------------
228 > request count 8 (OK=6 KO=2 )
229 > min response time 62 (OK=148 KO=62 )
230 > max response time 573 (OK=573 KO=68 )
231 > mean response time 258 (OK=322 KO=65 )
232 > std deviation 189 (OK=176 KO=3 )
233 > response time 50th percentile 194 (OK=250 KO=65 )
234 > response time 75th percentile 339 (OK=485 KO=66 )
235 > mean requests/sec 0.378 (OK=0.283KO=0.094 )
236 ---- Response Time Distribution ------------------------------------------------
237 > t < 800 ms 6 ( 75%)
238 > 800 ms < t < 1200 ms 0 (0%)
239 > t > 1200 ms 0 (0%)
240 > failed 2 ( 25%)
241 ---- Errors --------------------------------------------------------------------
242 > currentLocation.find.is(http://localhost:8080/), but actually 2 (100.0%)
243 found http://localhost:8080/login
244 ================================================================================
245
246 Reports generated in 0s.
247 Please open the following file: /root/.jenkins/jobs/mueas-gatling/workspace/target/gatling/results/mueassimulation-1453434726032/index.html
248 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
249 INFO org.apache.maven.cli.event.ExecutionEventLogger - BUILD SUCCESS
250 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
251 INFO org.apache.maven.cli.event.ExecutionEventLogger - Total time: 55.110 s
252 INFO org.apache.maven.cli.event.ExecutionEventLogger - Finished at: 2016-01-22T11:52:27+08:00
253 INFO org.apache.maven.cli.event.ExecutionEventLogger - Final Memory: 13M/228M
254 INFO org.apache.maven.cli.event.ExecutionEventLogger - ------------------------------------------------------------------------
255 ================= POST STEPS TRACKING END ===================
256 Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information
257 Archiving Gatling reports...
258 2016-01-22 11:52:38.063INFO 6660 --- [ Thread-2] ationConfigEmbeddedWebApplicationContext : Closing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@3e795823: startup date ; root of context hierarchy
259 2016-01-22 11:52:38.065INFO 6660 --- [ Thread-2] o.s.c.support.DefaultLifecycleProcessor: Stopping beans in phase 2147483647
260 Adding report 'mueassimulation-1453434726032'
261 Finished: SUCCESS
页:
[1]