Console Output

Started calculate disk usage of build
Finished Calculation of disk usage of build in 0 seconds
Started calculate disk usage of workspace
Finished Calculation of disk usage of workspace in 0 seconds
[INFO] 
[INFO] --< it.tidalwave.northernwind.rca:it-tidalwave-northernwind-rca-embeddedserver >--
[INFO] Building Zephyr - Embedded Server 1.2-ALPHA-4-SNAPSHOT            [6/15]
[INFO]   from modules/EmbeddedServer/pom.xml
[INFO] --------------------------------[ jar ]---------------------------------
[INFO] 
[INFO] --- clean:3.1.0:clean (default-clean) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] 
[INFO] --- buildnumber:1.4:create (default) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer
[INFO] Storing buildNumber: e9043004a15f at timestamp: 1683633367970
[WARNING] Cannot get the branch information from the git repository: 
Detecting the current branch failed: fatal: ref HEAD is not a symbolic ref

[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer
[INFO] Storing buildScmBranch: UNKNOWN
[INFO] 
[INFO] --- enforcer:3.0.0-M3:enforce (enforce-maven) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] 
[INFO] --- enforcer:3.0.0-M3:enforce (enforce-banned-dependencies) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] 
[INFO] --- antrun:3.0.0:run (generate-and-print-build-description) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Executing tasks
[INFO]      [echo] DESCRIPTION: origin/feature/NWRCA-7 1.2-ALPHA-4-SNAPSHOT e9043004a15f
[INFO]      [echo] Java Version: 11.0.18 -source 11 -target 11 -release 11
[INFO] Executed tasks
[INFO] 
[INFO] --- antrun:3.0.0:run (create-unwoven-classes-dirs) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Executing tasks
[INFO]     [mkdir] Created dir: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/unwoven-classes
[INFO]     [mkdir] Created dir: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/unwoven-test-classes
[INFO] Executed tasks
[INFO] 
[INFO] --- resources:3.2.0:resources (default-resources) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] Using 'UTF-8' encoding to copy filtered properties files.
[INFO] Copying 1 resource
[INFO] 
[INFO] --- compiler:3.8.1:compile (default-compile) @ it-tidalwave-northernwind-rca-embeddedserver ---
[WARNING] Parameter 'optimize' (user property 'maven.compiler.optimize') is deprecated: This property is a no-op in {@code javac}.
[WARNING] Parameter 'outputDirectory' is read-only, must not be used in configuration
[INFO] Changes detected - recompiling the module!
[INFO] Compiling 3 source files to /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/unwoven-classes
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.filesystems.declmime.MIMEResolverProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.NbBundleProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.ServiceProviderProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.NamedServiceProcessor' less than -source '11'
[WARNING] No processor claimed any of these annotations: /it.tidalwave.messagebus.annotation.ListensTo,/javax.annotation.CheckForNull,/javax.annotation.Nonnull,/it.tidalwave.util.annotation.VisibleForTesting,/it.tidalwave.messagebus.annotation.SimpleMessageSubscriber,/javax.annotation.concurrent.Immutable,/javax.annotation.PostConstruct,/javax.annotation.PreDestroy
[WARNING] /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/src/main/java/it/tidalwave/northernwind/rca/embeddedserver/impl/ServletAdapter.java:[45,7] [serial] serializable class ServletAdapter has no definition of serialVersionUID
[INFO] 
[INFO] --- aspectj:1.11:compile (weave-classes) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Showing AJC message detail for messages of types: [error, warning, fail]
[INFO] 
[INFO] --- resources:3.2.0:testResources (default-testResources) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] Using 'UTF-8' encoding to copy filtered properties files.
[INFO] Copying 1 resource
[INFO] 
[INFO] --- compiler:3.8.1:testCompile (default-testCompile) @ it-tidalwave-northernwind-rca-embeddedserver ---
[WARNING] Parameter 'optimize' (user property 'maven.compiler.optimize') is deprecated: This property is a no-op in {@code javac}.
[WARNING] Parameter 'outputDirectory' is read-only, must not be used in configuration
[INFO] Changes detected - recompiling the module!
[INFO] Compiling 1 source file to /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/unwoven-test-classes
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.filesystems.declmime.MIMEResolverProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.NbBundleProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.ServiceProviderProcessor' less than -source '11'
[WARNING] Supported source version 'RELEASE_6' from annotation processor 'org.netbeans.modules.openide.util.NamedServiceProcessor' less than -source '11'
[WARNING] No processor claimed any of these annotations: /org.testng.annotations.Test,/javax.annotation.Nonnull,/org.testng.annotations.BeforeMethod,/org.testng.annotations.AfterMethod
[INFO] 
[INFO] --- aspectj:1.11:test-compile (weave-test-classes) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Showing AJC message detail for messages of types: [error, warning, fail]
[INFO] 
[INFO] --- surefire:3.0.0-M5:test (default-test) @ it-tidalwave-northernwind-rca-embeddedserver ---
[WARNING] Parameter 'localRepository' is deprecated core expression; Avoid use of ArtifactRepository type. If you need access to local repository, switch to '${repositorySystemSession}' expression and get LRM from it instead.
[INFO] 
[INFO] -------------------------------------------------------
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
11:56:17.976 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - STARTING TESTS OF it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
11:56:19.921 [main                ] DEBUG org.eclipse.jetty.util.log                         - Logging to Logger[org.eclipse.jetty.util.log] via org.eclipse.jetty.util.log.Slf4jLog
11:56:19.982 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12345...
11:56:19.992 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@2650f79 + SelectChannelConnector@0.0.0.0:12345 as connector
11:56:19.992 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@2650f79 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d as handler
11:56:19.993 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@2650f79
11:56:19.993 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@2650f79 + qtp2010546406{8<=0<=0/254,-1} as threadpool
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@2650f79
11:56:20.008 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp2010546406{8<=0<=0/254,-1}
11:56:20.013 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp2010546406{8<=6<=8/254,0}
11:56:20.013 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
11:56:20.038 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:20.042 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:20.042 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6fd12c5
11:56:20.055 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6fd12c5
11:56:20.056 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12345
11:56:20.056 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
11:56:20.056 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@2650f79
11:56:20.057 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:20.058 [0546406-12 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp2010546406-12 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@7c679bb8
11:56:20.060 [main                ] TRACE it.tidalwave.messagebus.MessageBusHelper           - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
11:56:20.071 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *********************************************
11:56:20.071 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST "start must properly boot the webserver"
11:56:20.072 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *********************************************
11:56:20.072 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12346...
11:56:20.073 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@18acfe88 + SelectChannelConnector@0.0.0.0:12346 as connector
11:56:20.082 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@18acfe88 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a as handler
11:56:20.082 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@18acfe88
11:56:20.082 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:20.082 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@18acfe88 + qtp1999135146{8<=0<=0/254,-1} as threadpool
11:56:20.083 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.083 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.083 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.083 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@18acfe88
11:56:20.083 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1999135146{8<=0<=0/254,-1}
11:56:20.086 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1999135146{8<=7<=8/254,0}
11:56:20.086 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12346
11:56:20.087 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:20.087 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:20.087 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6631cb64
11:56:20.088 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6631cb64
11:56:20.088 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12346
11:56:20.088 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12346
11:56:20.088 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@18acfe88
11:56:20.088 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:20.094 [9135146-20 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp1999135146-20 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@41022ad1
11:56:20.096 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST PASSED in 25 msec
11:56:20.096 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - 
11:56:20.098 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Stopping webserver...
11:56:20.098 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@2650f79
11:56:20.098 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
11:56:20.104 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6fd12c5
11:56:20.105 [0546406-12 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp2010546406-12 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@7c679bb8
11:56:20.116 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6fd12c5
11:56:20.117 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:20.117 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:20.117 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
11:56:20.117 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.117 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.118 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@129bd55d
11:56:20.118 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@2650f79
11:56:20.118 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp2010546406{8<=8<=8/254,0}
11:56:20.175 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp2010546406{8<=0<=0/254,1}
11:56:20.175 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@2650f79
11:56:20.175 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> stopped
11:56:20.179 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - >>>> shutting down server...
11:56:20.180 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@18acfe88
11:56:20.181 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12346
11:56:20.183 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6631cb64
11:56:20.184 [9135146-20 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp1999135146-20 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@41022ad1
11:56:20.195 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@6631cb64
11:56:20.196 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:20.197 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:20.197 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12346
11:56:20.198 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.198 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.199 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@8a2a6a
11:56:20.199 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@18acfe88
11:56:20.200 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1999135146{8<=8<=8/254,0}
11:56:20.253 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1999135146{8<=0<=0/254,0}
11:56:20.253 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@18acfe88
11:56:20.382 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12345...
11:56:20.390 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@28737371 + SelectChannelConnector@0.0.0.0:12345 as connector
11:56:20.391 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@28737371 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd as handler
11:56:20.391 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@28737371
11:56:20.391 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:20.391 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@28737371 + qtp1979860449{8<=0<=0/254,-1} as threadpool
11:56:20.391 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:20.391 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:20.392 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:20.393 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@28737371
11:56:20.397 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1979860449{8<=0<=0/254,-1}
11:56:20.423 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1979860449{8<=7<=8/254,0}
11:56:20.424 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
11:56:20.424 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:20.425 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:20.425 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@31ceba99
11:56:20.425 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@31ceba99
11:56:20.430 [9860449-28 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp1979860449-28 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@5cf64f48
11:56:20.431 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12345
11:56:20.431 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
11:56:20.431 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@28737371
11:56:20.431 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:20.431 [main                ] TRACE it.tidalwave.messagebus.MessageBusHelper           - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
11:56:20.432 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *******************************************
11:56:20.433 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST "must properly serve loaded documents"
11:56:20.433 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *******************************************
11:56:20.914 [9860449-28 Selector0] DEBUG org.eclipse.jetty.io.nio                           - created SCEP@213c4626{l(/127.0.0.1:54758)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@1ac78ef2,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
11:56:20.916 [qtp1979860449-30    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 207/207
11:56:20.924 [qtp1979860449-30 - /] DEBUG org.eclipse.jetty.server.Server                    - REQUEST / on AsyncHttpConnection@1ac78ef2,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
11:56:20.924 [qtp1979860449-30 - /] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - doGet(/)
11:56:20.925 [qtp1979860449-30 - /] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>> filtered /
11:56:20.976 [qtp1979860449-30 - /] DEBUG org.eclipse.jetty.server.Server                    - RESPONSE /  200 handled=true
11:56:21.018 [qtp1979860449-30    ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection       - Enabled read interest SCEP@213c4626{l(/127.0.0.1:54758)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@1ac78ef2,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
11:56:21.019 [qtp1979860449-30    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.091 [9860449-28 Selector0] DEBUG org.eclipse.jetty.io.nio                           - created SCEP@1a01ed51{l(/127.0.0.1:54770)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@4c2f230a,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
11:56:21.094 [qtp1979860449-32    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.109 [qtp1979860449-33    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 211/211
11:56:21.111 [979860449-33 - /doc2] DEBUG org.eclipse.jetty.server.Server                    - REQUEST /doc2 on AsyncHttpConnection@4c2f230a,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
11:56:21.111 [979860449-33 - /doc2] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - doGet(/doc2)
11:56:21.111 [979860449-33 - /doc2] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>> filtered /doc2
11:56:21.111 [979860449-33 - /doc2] DEBUG org.eclipse.jetty.server.Server                    - RESPONSE /doc2  200 handled=true
11:56:21.112 [qtp1979860449-33    ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection       - Enabled read interest SCEP@1a01ed51{l(/127.0.0.1:54770)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@4c2f230a,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
11:56:21.112 [qtp1979860449-33    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.126 [9860449-28 Selector0] DEBUG org.eclipse.jetty.io.nio                           - created SCEP@5fe6348a{l(/127.0.0.1:54786)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@4a983142,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
11:56:21.127 [qtp1979860449-34    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.154 [qtp1979860449-35    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 211/211
11:56:21.155 [979860449-35 - /doc3] DEBUG org.eclipse.jetty.server.Server                    - REQUEST /doc3 on AsyncHttpConnection@4a983142,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
11:56:21.155 [979860449-35 - /doc3] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - doGet(/doc3)
11:56:21.155 [979860449-35 - /doc3] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>> filtered /doc3
11:56:21.156 [979860449-35 - /doc3] DEBUG org.eclipse.jetty.server.Server                    - RESPONSE /doc3  200 handled=true
11:56:21.157 [qtp1979860449-35    ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection       - Enabled read interest SCEP@5fe6348a{l(/127.0.0.1:54786)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@4a983142,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
11:56:21.157 [qtp1979860449-35    ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.160 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST PASSED in 728 msec
11:56:21.161 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - 
11:56:21.161 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Stopping webserver...
11:56:21.161 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@28737371
11:56:21.161 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
11:56:21.161 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@31ceba99
11:56:21.162 [9860449-28 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp1979860449-28 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@5cf64f48
11:56:21.172 [main                ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint           - close SCEP@1a01ed51{l(/127.0.0.1:54770)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@4c2f230a,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
11:56:21.176 [main                ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint           - close SCEP@5fe6348a{l(/127.0.0.1:54786)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@4a983142,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
11:56:21.176 [main                ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint           - close SCEP@213c4626{l(/127.0.0.1:54758)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1}-{AsyncHttpConnection@1ac78ef2,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
11:56:21.178 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@31ceba99
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [1/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [1/1024@6144,1/1024@32768,0/1024@-]
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2af46afd
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@28737371
11:56:21.179 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1979860449{8<=8<=8/254,0}
11:56:21.232 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1979860449{8<=0<=0/254,0}
11:56:21.232 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@28737371
11:56:21.232 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> stopped
11:56:21.335 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12345...
11:56:21.335 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@60c8a093 + SelectChannelConnector@0.0.0.0:12345 as connector
11:56:21.335 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@60c8a093 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25 as handler
11:56:21.335 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@60c8a093
11:56:21.335 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@60c8a093 + qtp708222484{8<=0<=0/254,-1} as threadpool
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@60c8a093
11:56:21.336 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp708222484{8<=0<=0/254,-1}
11:56:21.392 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp708222484{8<=7<=8/254,0}
11:56:21.392 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
11:56:21.392 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:21.393 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:21.393 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@25aeb5ac
11:56:21.395 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@25aeb5ac
11:56:21.400 [8222484-47 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp708222484-47 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@be691f0
11:56:21.401 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12345
11:56:21.401 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
11:56:21.401 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@60c8a093
11:56:21.401 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:21.402 [main                ] TRACE it.tidalwave.messagebus.MessageBusHelper           - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
11:56:21.403 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *******************************************************
11:56:21.403 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST "must return not found for non existing documents"
11:56:21.403 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *******************************************************
11:56:21.420 [8222484-47 Selector0] DEBUG org.eclipse.jetty.io.nio                           - created SCEP@11efa80{l(/127.0.0.1:54802)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@441c74c7,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
11:56:21.432 [qtp708222484-49     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.440 [qtp708222484-50     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 210/210
11:56:21.441 [p708222484-50 - /foo] DEBUG org.eclipse.jetty.server.Server                    - REQUEST /foo on AsyncHttpConnection@441c74c7,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
11:56:21.441 [p708222484-50 - /foo] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - doGet(/foo)
11:56:21.441 [p708222484-50 - /foo] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>> filtered /foo
11:56:21.441 [p708222484-50 - /foo] WARN  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - 1 - Not found: /foo
11:56:21.441 [p708222484-50 - /foo] DEBUG org.eclipse.jetty.server.Server                    - RESPONSE /foo  404 handled=true
11:56:21.442 [qtp708222484-50     ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection       - Enabled read interest SCEP@11efa80{l(/127.0.0.1:54802)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@441c74c7,g=HttpGenerator{s=4,h=0,b=-1,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
11:56:21.442 [qtp708222484-50     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.454 [8222484-47 Selector0] DEBUG org.eclipse.jetty.io.nio                           - created SCEP@751253be{l(/127.0.0.1:54806)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@32e7d66,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
11:56:21.455 [qtp708222484-51     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.471 [qtp708222484-52     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 210/210
11:56:21.475 [p708222484-52 - /bar] DEBUG org.eclipse.jetty.server.Server                    - REQUEST /bar on AsyncHttpConnection@32e7d66,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
11:56:21.475 [p708222484-52 - /bar] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - doGet(/bar)
11:56:21.476 [p708222484-52 - /bar] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>> filtered /bar
11:56:21.476 [p708222484-52 - /bar] WARN  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - 1 - Not found: /bar
11:56:21.476 [p708222484-52 - /bar] DEBUG org.eclipse.jetty.server.Server                    - RESPONSE /bar  404 handled=true
11:56:21.476 [qtp708222484-52     ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection       - Enabled read interest SCEP@751253be{l(/127.0.0.1:54806)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@32e7d66,g=HttpGenerator{s=4,h=0,b=-1,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
11:56:21.476 [qtp708222484-52     ] DEBUG org.eclipse.jetty.http.HttpParser                  - filled 0/0
11:56:21.495 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST PASSED in 92 msec
11:56:21.495 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - 
11:56:21.496 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Stopping webserver...
11:56:21.497 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@60c8a093
11:56:21.497 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
11:56:21.498 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@25aeb5ac
11:56:21.499 [8222484-47 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp708222484-47 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@be691f0
11:56:21.509 [main                ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint           - close SCEP@11efa80{l(/127.0.0.1:54802)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@441c74c7,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
11:56:21.511 [main                ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint           - close SCEP@751253be{l(/127.0.0.1:54806)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@32e7d66,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
11:56:21.511 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@25aeb5ac
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [1/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [1/1024@6144,0/1024@32768,0/1024@-]
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@44cffc25
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@60c8a093
11:56:21.512 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp708222484{8<=8<=8/254,0}
11:56:21.563 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp708222484{8<=0<=0/254,5}
11:56:21.563 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@60c8a093
11:56:21.563 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> stopped
11:56:21.667 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12345...
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@4f9a6c2d + SelectChannelConnector@0.0.0.0:12345 as connector
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@4f9a6c2d + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f as handler
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@4f9a6c2d
11:56:21.667 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@4f9a6c2d + qtp1977508673{8<=0<=0/254,-1} as threadpool
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:21.667 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@4f9a6c2d
11:56:21.668 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1977508673{8<=0<=0/254,-1}
11:56:21.699 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1977508673{8<=7<=8/254,0}
11:56:21.699 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
11:56:21.699 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:21.699 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:21.699 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@74170687
11:56:21.700 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@74170687
11:56:21.700 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12345
11:56:21.700 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
11:56:21.700 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@4f9a6c2d
11:56:21.700 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:21.700 [main                ] TRACE it.tidalwave.messagebus.MessageBusHelper           - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
11:56:21.705 [7508673-61 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp1977508673-61 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@7e4f0090
11:56:21.706 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *************************************************
11:56:21.707 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST "stop must properly shut the webserver down"
11:56:21.707 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - *************************************************
11:56:21.707 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Starting webserver on port 12346...
11:56:21.707 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@3b545206 + SelectChannelConnector@0.0.0.0:12346 as connector
11:56:21.707 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@3b545206 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5 as handler
11:56:21.707 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@3b545206
11:56:21.707 [main                ] INFO  org.eclipse.jetty.server.Server                    - jetty-8.1.10.v20130312
11:56:21.707 [main                ] DEBUG org.eclipse.jetty.util.component.Container         - Container org.eclipse.jetty.server.Server@3b545206 + qtp404588697{8<=0<=0/254,-1} as threadpool
11:56:21.707 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:21.708 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:21.708 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:21.708 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - starting org.eclipse.jetty.server.Server@3b545206
11:56:21.708 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp404588697{8<=0<=0/254,-1}
11:56:21.736 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp404588697{8<=7<=8/254,0}
11:56:21.736 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12346
11:56:21.736 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
11:56:21.737 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:21.737 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@12d5c30e
11:56:21.737 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@12d5c30e
11:56:21.737 [main                ] INFO  org.eclipse.jetty.server.AbstractConnector         - Started SelectChannelConnector@0.0.0.0:12346
11:56:21.737 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12346
11:56:21.737 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@3b545206
11:56:21.737 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> started
11:56:21.749 [4588697-69 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Starting Thread[qtp404588697-69 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1ca50ad2
11:56:23.737 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Stopping webserver...
11:56:23.738 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@3b545206
11:56:23.738 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12346
11:56:23.742 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@12d5c30e
11:56:23.743 [4588697-69 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp404588697-69 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1ca50ad2
11:56:23.753 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@12d5c30e
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12346
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@77bb48d5
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@3b545206
11:56:23.754 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp404588697{8<=8<=8/254,0}
11:56:23.806 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp404588697{8<=0<=0/254,4}
11:56:23.806 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@3b545206
11:56:23.806 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> stopped
11:56:23.808 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - TEST PASSED in 2100 msec
11:56:23.808 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - 
11:56:23.808 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - Stopping webserver...
11:56:23.808 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@4f9a6c2d
11:56:23.809 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
11:56:23.811 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@74170687
11:56:23.811 [7508673-61 Selector0] DEBUG org.eclipse.jetty.io.nio                           - Stopped Thread[qtp1977508673-61 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@7e4f0090
11:56:23.821 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@74170687
11:56:23.822 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
11:56:23.822 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
11:56:23.822 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
11:56:23.822 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:23.822 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:23.823 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@2b6fcb9f
11:56:23.823 [main                ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler   - stopping org.eclipse.jetty.server.Server@4f9a6c2d
11:56:23.823 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1977508673{8<=8<=8/254,0}
11:56:23.875 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1977508673{8<=0<=0/254,4}
11:56:23.875 [main                ] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@4f9a6c2d
11:56:23.875 [main                ] INFO  i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer  - >>>> stopped
11:56:23.875 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - >>>> shutting down server...
11:56:23.927 [main                ] INFO  i.t.n.r.e.impl.DefaultEmbeddedServerTest           - FINISHED TESTS OF it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 6.865 s - in it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
[INFO] 
[INFO] Results:
[INFO] 
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0
[INFO] 
[JENKINS] Recording test results
[INFO] 
[INFO] --- jar:3.2.0:jar (default-jar) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Building jar: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.e9043004a15f.jar
[INFO] 
[INFO] --- jar:3.2.0:test-jar (default-test-jar) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Building jar: /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.e9043004a15f-tests.jar
[INFO] 
[INFO] --- install:3.0.0-M1:install (default-install) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Installing /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.e9043004a15f.jar to /var/jenkins_home/maven-repositories/1/it/tidalwave/northernwind/rca/it-tidalwave-northernwind-rca-embeddedserver/1.2-ALPHA-4-SNAPSHOT/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.jar
[INFO] Installing /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/pom.xml to /var/jenkins_home/maven-repositories/1/it/tidalwave/northernwind/rca/it-tidalwave-northernwind-rca-embeddedserver/1.2-ALPHA-4-SNAPSHOT/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.pom
[INFO] Installing /var/jenkins_home/jobs/Zephyr_Build_and_Test/workspace/modules/EmbeddedServer/target/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.e9043004a15f-tests.jar to /var/jenkins_home/maven-repositories/1/it/tidalwave/northernwind/rca/it-tidalwave-northernwind-rca-embeddedserver/1.2-ALPHA-4-SNAPSHOT/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT-tests.jar
[JENKINS] Archiving disabled