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.2.0:clean (default-clean) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO]
[INFO] --- buildnumber:3.0.0: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: 30819703aea5 at timestamp: 1683633605219
[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.3.0:enforce (enforce-maven) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.DependencyConvergence passed
[INFO] Rule 3: org.apache.maven.enforcer.rules.RequirePluginVersions passed
[INFO]
[INFO] --- enforcer:3.3.0:enforce (enforce-banned-dependencies) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.BannedDependencies passed
[INFO]
[INFO] --- antrun:3.1.0:run (generate-and-print-build-description) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Executing tasks
[INFO] [echo] DESCRIPTION: origin/release/1.2-ALPHA-4 1.2-ALPHA-4-SNAPSHOT 30819703aea5
[INFO] [echo] Java Version: 11.0.18 -source 11 -target 11 -release 11
[INFO] Executed tasks
[INFO]
[INFO] --- antrun:3.1.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.3.1:resources (default-resources) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Copying 1 resource from src/main/resources to target/classes
[INFO]
[INFO] --- compiler:3.11.0:compile (default-compile) @ it-tidalwave-northernwind-rca-embeddedserver ---
[WARNING] Parameter 'outputDirectory' is read-only, must not be used in configuration
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 3 source files with javac [forked debug deprecation release 11] to 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] /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.14.0:compile (weave-classes) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Showing AJC message detail for messages of types: [error, warning, fail]
[INFO]
[INFO] --- resources:3.3.1:testResources (default-testResources) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Copying 1 resource from src/test/resources to target/test-classes
[INFO]
[INFO] --- compiler:3.11.0:testCompile (default-testCompile) @ it-tidalwave-northernwind-rca-embeddedserver ---
[WARNING] Parameter 'outputDirectory' is read-only, must not be used in configuration
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 1 source file with javac [forked debug deprecation release 11] to 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'
[INFO]
[INFO] --- aspectj:1.14.0: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:test (default-test) @ it-tidalwave-northernwind-rca-embeddedserver ---
[INFO] Using auto detected provider org.apache.maven.surefire.testng.TestNGProvider
[INFO]
[INFO] -------------------------------------------------------
[INFO] T E S T S
[INFO] -------------------------------------------------------
[INFO] Running it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
12:00:16.899 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.setup()[pri:0, instance:null] 1299532819
12:00:16.909 [main ] TRACE org.testng.internal.Graph - [Graph] ================ SORTING
12:00:16.919 [main ] TRACE org.testng.internal.Graph - [Graph] =============== DONE SORTING
12:00:16.919 [main ] TRACE org.testng.internal.Graph - [Graph] ====== SORTED NODES
12:00:16.919 [main ] TRACE org.testng.internal.Graph - [Graph] ====== END SORTED NODES
12:00:16.928 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.shutDown()[pri:0, instance:null] -1104671714
12:00:16.928 [main ] TRACE org.testng.internal.Graph - [Graph] ================ SORTING
12:00:16.928 [main ] TRACE org.testng.internal.Graph - [Graph] =============== DONE SORTING
12:00:16.928 [main ] TRACE org.testng.internal.Graph - [Graph] ====== SORTED NODES
12:00:16.929 [main ] TRACE org.testng.internal.Graph - [Graph] ====== END SORTED NODES
12:00:16.943 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.must_return_not_found_for_non_existing_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] -431245525
12:00:16.946 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.must_return_not_found_for_non_existing_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.947 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM INDEPENDENT OBJECTS
12:00:16.948 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] -2092743546
12:00:16.948 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.stop_must_properly_shut_the_webserver_down()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] -399761153
12:00:16.948 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.stop_must_properly_shut_the_webserver_down()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.948 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM INDEPENDENT OBJECTS
12:00:16.949 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING NODE DefaultEmbeddedServerTest.must_properly_serve_loaded_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] 2079872831
12:00:16.949 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.must_properly_serve_loaded_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.949 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM INDEPENDENT OBJECTS
12:00:16.949 [main ] TRACE org.testng.internal.Graph - [Graph] ================ SORTING
12:00:16.950 [main ] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.stop_must_properly_shut_the_webserver_down()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.950 [.commonPool-worker-3] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.must_return_not_found_for_non_existing_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.955 [.commonPool-worker-3] TRACE org.testng.internal.Graph - [Graph] ADDING PREDECESSOR FOR DefaultEmbeddedServerTest.must_properly_serve_loaded_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] ==> DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.960 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED PRED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM NODE DefaultEmbeddedServerTest.must_properly_serve_loaded_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.963 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED PRED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM NODE DefaultEmbeddedServerTest.must_return_not_found_for_non_existing_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.963 [main ] TRACE org.testng.internal.Graph - [Graph] REMOVED PRED DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531] FROM NODE DefaultEmbeddedServerTest.stop_must_properly_shut_the_webserver_down()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.964 [main ] TRACE org.testng.internal.Graph - [Graph] =============== DONE SORTING
12:00:16.964 [main ] TRACE org.testng.internal.Graph - [Graph] ====== SORTED NODES
12:00:16.964 [main ] TRACE org.testng.internal.Graph - [Graph] DefaultEmbeddedServerTest.start_must_properly_boot_the_webserver()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.965 [main ] TRACE org.testng.internal.Graph - [Graph] DefaultEmbeddedServerTest.must_properly_serve_loaded_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.976 [main ] TRACE org.testng.internal.Graph - [Graph] DefaultEmbeddedServerTest.must_return_not_found_for_non_existing_documents()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.977 [main ] TRACE org.testng.internal.Graph - [Graph] DefaultEmbeddedServerTest.stop_must_properly_shut_the_webserver_down()[pri:0, instance:it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest@42530531]
12:00:16.977 [main ] TRACE org.testng.internal.Graph - [Graph] ====== END SORTED NODES
12:00:17.028 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - STARTING TESTS OF it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServerTest
12:00:19.268 [main ] DEBUG org.eclipse.jetty.util.log - Logging to Logger[org.eclipse.jetty.util.log] via org.eclipse.jetty.util.log.Slf4jLog
12:00:19.308 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12345...
12:00:19.320 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@2f84acf7 + SelectChannelConnector@0.0.0.0:12345 as connector
12:00:19.321 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@2f84acf7 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b as handler
12:00:19.321 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@2f84acf7
12:00:19.321 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:19.357 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@2f84acf7 + qtp472262461{8<=0<=0/254,-1} as threadpool
12:00:19.357 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.357 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.358 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.358 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@2f84acf7
12:00:19.358 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp472262461{8<=0<=0/254,-1}
12:00:19.403 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp472262461{8<=7<=8/254,0}
12:00:19.404 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
12:00:19.431 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:19.433 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:19.433 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5f254608
12:00:19.446 [2262461-14 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp472262461-14 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@25c4a4b3
12:00:19.446 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5f254608
12:00:19.450 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12345
12:00:19.451 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
12:00:19.453 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@2f84acf7
12:00:19.453 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:19.455 [main ] TRACE it.tidalwave.messagebus.MessageBusHelper - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
12:00:19.489 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *********************************************
12:00:19.490 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST "start must properly boot the webserver"
12:00:19.490 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *********************************************
12:00:19.492 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12346...
12:00:19.494 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1e0a864d + SelectChannelConnector@0.0.0.0:12346 as connector
12:00:19.496 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1e0a864d + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6 as handler
12:00:19.497 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@1e0a864d
12:00:19.497 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:19.498 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1e0a864d + qtp1047000562{8<=0<=0/254,-1} as threadpool
12:00:19.501 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.502 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.502 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.502 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@1e0a864d
12:00:19.502 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1047000562{8<=0<=0/254,-1}
12:00:19.558 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1047000562{8<=7<=8/254,0}
12:00:19.559 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12346
12:00:19.559 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:19.560 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:19.560 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@fd53053
12:00:19.560 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@fd53053
12:00:19.560 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12346
12:00:19.560 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12346
12:00:19.560 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@1e0a864d
12:00:19.561 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:19.566 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST PASSED in 77 msec
12:00:19.567 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest -
12:00:19.568 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Stopping webserver...
12:00:19.568 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@2f84acf7
12:00:19.568 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
12:00:19.578 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5f254608
12:00:19.581 [7000562-22 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp1047000562-22 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@553c8230
12:00:19.587 [2262461-14 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp472262461-14 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@25c4a4b3
12:00:19.589 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5f254608
12:00:19.590 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:19.590 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:19.590 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
12:00:19.591 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.591 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.591 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@38ed139b
12:00:19.591 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@2f84acf7
12:00:19.591 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp472262461{8<=8<=8/254,0}
12:00:19.655 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp472262461{8<=0<=0/254,0}
12:00:19.655 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@2f84acf7
12:00:19.655 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> stopped
12:00:19.657 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - >>>> shutting down server...
12:00:19.657 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@1e0a864d
12:00:19.657 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12346
12:00:19.659 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@fd53053
12:00:19.660 [7000562-22 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp1047000562-22 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@553c8230
12:00:19.671 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@fd53053
12:00:19.671 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:19.672 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:19.672 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12346
12:00:19.672 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.672 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.672 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@440e3ce6
12:00:19.672 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@1e0a864d
12:00:19.672 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1047000562{8<=8<=8/254,0}
12:00:19.724 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1047000562{8<=0<=0/254,1}
12:00:19.725 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@1e0a864d
12:00:19.848 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12345...
12:00:19.848 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@76332405 + SelectChannelConnector@0.0.0.0:12345 as connector
12:00:19.849 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@76332405 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235 as handler
12:00:19.849 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@76332405
12:00:19.849 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:19.849 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@76332405 + qtp220040730{8<=0<=0/254,-1} as threadpool
12:00:19.849 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:19.849 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:19.849 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:19.849 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@76332405
12:00:19.849 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp220040730{8<=0<=0/254,-1}
12:00:19.852 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp220040730{8<=7<=8/254,0}
12:00:19.853 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
12:00:19.853 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:19.853 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:19.854 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5434e40c
12:00:19.854 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5434e40c
12:00:19.854 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12345
12:00:19.854 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
12:00:19.854 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@76332405
12:00:19.854 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:19.854 [main ] TRACE it.tidalwave.messagebus.MessageBusHelper - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
12:00:19.856 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *******************************************
12:00:19.856 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST "must properly serve loaded documents"
12:00:19.856 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *******************************************
12:00:19.861 [0040730-30 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp220040730-30 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1f11ae7d
12:00:20.560 [0040730-30 Selector0] DEBUG org.eclipse.jetty.io.nio - created SCEP@6b3582c0{l(/127.0.0.1:41240)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@344f85c6,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
12:00:20.564 [qtp220040730-33 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 207/207
12:00:20.570 [qtp220040730-33 - / ] DEBUG org.eclipse.jetty.server.Server - REQUEST / on AsyncHttpConnection@344f85c6,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
12:00:20.579 [qtp220040730-33 - / ] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - doGet(/)
12:00:20.579 [qtp220040730-33 - / ] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>> filtered /
12:00:20.615 [qtp220040730-33 - / ] DEBUG org.eclipse.jetty.server.Server - RESPONSE / 200 handled=true
12:00:20.632 [qtp220040730-33 ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection - Enabled read interest SCEP@6b3582c0{l(/127.0.0.1:41240)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@344f85c6,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
12:00:20.634 [qtp220040730-33 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.674 [0040730-30 Selector0] DEBUG org.eclipse.jetty.io.nio - created SCEP@1b9f2d99{l(/127.0.0.1:41248)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@5c7b9fa8,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
12:00:20.675 [qtp220040730-35 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.690 [qtp220040730-36 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 211/211
12:00:20.691 [220040730-36 - /doc2] DEBUG org.eclipse.jetty.server.Server - REQUEST /doc2 on AsyncHttpConnection@5c7b9fa8,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
12:00:20.691 [220040730-36 - /doc2] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - doGet(/doc2)
12:00:20.691 [220040730-36 - /doc2] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>> filtered /doc2
12:00:20.691 [220040730-36 - /doc2] DEBUG org.eclipse.jetty.server.Server - RESPONSE /doc2 200 handled=true
12:00:20.692 [qtp220040730-36 ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection - Enabled read interest SCEP@1b9f2d99{l(/127.0.0.1:41248)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@5c7b9fa8,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
12:00:20.692 [qtp220040730-36 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.704 [0040730-30 Selector0] DEBUG org.eclipse.jetty.io.nio - created SCEP@c4493ec{l(/127.0.0.1:41256)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@6ed58418,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
12:00:20.705 [qtp220040730-37 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.709 [qtp220040730-32 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 211/211
12:00:20.710 [220040730-32 - /doc3] DEBUG org.eclipse.jetty.server.Server - REQUEST /doc3 on AsyncHttpConnection@6ed58418,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
12:00:20.710 [220040730-32 - /doc3] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - doGet(/doc3)
12:00:20.710 [220040730-32 - /doc3] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>> filtered /doc3
12:00:20.710 [220040730-32 - /doc3] DEBUG org.eclipse.jetty.server.Server - RESPONSE /doc3 200 handled=true
12:00:20.711 [qtp220040730-32 ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection - Enabled read interest SCEP@c4493ec{l(/127.0.0.1:41256)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@6ed58418,g=HttpGenerator{s=4,h=0,b=0,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
12:00:20.711 [qtp220040730-32 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.717 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST PASSED in 860 msec
12:00:20.717 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest -
12:00:20.718 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Stopping webserver...
12:00:20.718 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@76332405
12:00:20.718 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
12:00:20.720 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5434e40c
12:00:20.721 [0040730-30 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp220040730-30 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1f11ae7d
12:00:20.732 [main ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint - close SCEP@c4493ec{l(/127.0.0.1:41256)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@6ed58418,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
12:00:20.738 [main ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint - close SCEP@6b3582c0{l(/127.0.0.1:41240)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1}-{AsyncHttpConnection@344f85c6,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
12:00:20.739 [main ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint - close SCEP@1b9f2d99{l(/127.0.0.1:41248)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@5c7b9fa8,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
12:00:20.741 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@5434e40c
12:00:20.741 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [1/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [1/1024@6144,1/1024@32768,0/1024@-]
12:00:20.742 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:20.742 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
12:00:20.742 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:20.742 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:20.742 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@187e5235
12:00:20.742 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@76332405
12:00:20.742 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp220040730{8<=8<=8/254,0}
12:00:20.795 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp220040730{8<=0<=0/254,5}
12:00:20.796 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@76332405
12:00:20.796 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> stopped
12:00:20.903 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12345...
12:00:20.904 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5f174dd2 + SelectChannelConnector@0.0.0.0:12345 as connector
12:00:20.904 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5f174dd2 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f as handler
12:00:20.906 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@5f174dd2
12:00:20.906 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:20.906 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5f174dd2 + qtp1168942230{8<=0<=0/254,-1} as threadpool
12:00:20.906 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:20.906 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:20.906 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:20.906 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@5f174dd2
12:00:20.906 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1168942230{8<=0<=0/254,-1}
12:00:20.909 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1168942230{8<=7<=8/254,0}
12:00:20.910 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
12:00:20.910 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:20.912 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:20.912 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@697173d9
12:00:20.912 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@697173d9
12:00:20.912 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12345
12:00:20.912 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
12:00:20.912 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@5f174dd2
12:00:20.912 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:20.912 [main ] TRACE it.tidalwave.messagebus.MessageBusHelper - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
12:00:20.915 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *******************************************************
12:00:20.916 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST "must return not found for non existing documents"
12:00:20.916 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *******************************************************
12:00:20.934 [8942230-48 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp1168942230-48 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@d019bd7
12:00:20.936 [8942230-48 Selector0] DEBUG org.eclipse.jetty.io.nio - created SCEP@7f9f0a7{l(/127.0.0.1:41268)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@42fb6e3c,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
12:00:20.945 [qtp1168942230-50 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.951 [qtp1168942230-51 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 210/210
12:00:20.952 [1168942230-51 - /foo] DEBUG org.eclipse.jetty.server.Server - REQUEST /foo on AsyncHttpConnection@42fb6e3c,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
12:00:20.952 [1168942230-51 - /foo] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - doGet(/foo)
12:00:20.952 [1168942230-51 - /foo] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>> filtered /foo
12:00:20.952 [1168942230-51 - /foo] WARN i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - 1 - Not found: /foo
12:00:20.952 [1168942230-51 - /foo] DEBUG org.eclipse.jetty.server.Server - RESPONSE /foo 404 handled=true
12:00:20.953 [qtp1168942230-51 ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection - Enabled read interest SCEP@7f9f0a7{l(/127.0.0.1:41268)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@42fb6e3c,g=HttpGenerator{s=4,h=0,b=-1,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
12:00:20.953 [qtp1168942230-51 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:20.980 [8942230-48 Selector0] DEBUG org.eclipse.jetty.io.nio - created SCEP@737328a8{l(/127.0.0.1:41280)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=0}-{AsyncHttpConnection@3b4792a9,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=0},r=0}
12:00:20.980 [qtp1168942230-52 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:21.000 [qtp1168942230-53 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 210/210
12:00:21.001 [1168942230-53 - /bar] DEBUG org.eclipse.jetty.server.Server - REQUEST /bar on AsyncHttpConnection@3b4792a9,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=24,c=0},r=1
12:00:21.001 [1168942230-53 - /bar] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - doGet(/bar)
12:00:21.001 [1168942230-53 - /bar] DEBUG i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>> filtered /bar
12:00:21.001 [1168942230-53 - /bar] WARN i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - 1 - Not found: /bar
12:00:21.001 [1168942230-53 - /bar] DEBUG org.eclipse.jetty.server.Server - RESPONSE /bar 404 handled=true
12:00:21.002 [qtp1168942230-53 ] DEBUG org.eclipse.jetty.server.AsyncHttpConnection - Enabled read interest SCEP@737328a8{l(/127.0.0.1:41280)<->r(/127.0.0.1:12345),d=true,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@3b4792a9,g=HttpGenerator{s=4,h=0,b=-1,c=-1},p=HttpParser{s=0,l=24,c=0},r=1}
12:00:21.002 [qtp1168942230-53 ] DEBUG org.eclipse.jetty.http.HttpParser - filled 0/0
12:00:21.004 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST PASSED in 89 msec
12:00:21.005 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest -
12:00:21.005 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Stopping webserver...
12:00:21.005 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@5f174dd2
12:00:21.006 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
12:00:21.006 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@697173d9
12:00:21.007 [8942230-48 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp1168942230-48 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@d019bd7
12:00:21.017 [main ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint - close SCEP@7f9f0a7{l(/127.0.0.1:41268)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@42fb6e3c,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
12:00:21.018 [main ] DEBUG org.eclipse.jetty.io.nio.ChannelEndPoint - close SCEP@737328a8{l(/127.0.0.1:41280)<->r(/127.0.0.1:12345),d=false,open=true,ishut=false,oshut=false,rb=false,wb=false,w=true,i=1r}-{AsyncHttpConnection@3b4792a9,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-14,l=0,c=-3},r=1}
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@697173d9
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [1/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [1/1024@6144,0/1024@32768,0/1024@-]
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:21.019 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:21.019 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@1945113f
12:00:21.019 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@5f174dd2
12:00:21.020 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1168942230{8<=8<=8/254,0}
12:00:21.073 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1168942230{8<=0<=0/254,6}
12:00:21.073 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@5f174dd2
12:00:21.074 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> stopped
12:00:21.168 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12345...
12:00:21.169 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1eff3cfb + SelectChannelConnector@0.0.0.0:12345 as connector
12:00:21.169 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1eff3cfb + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586 as handler
12:00:21.169 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@1eff3cfb
12:00:21.169 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:21.169 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@1eff3cfb + qtp1841421417{8<=0<=0/254,-1} as threadpool
12:00:21.169 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:21.169 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:21.169 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:21.169 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@1eff3cfb
12:00:21.169 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp1841421417{8<=0<=0/254,-1}
12:00:21.207 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp1841421417{8<=7<=8/254,0}
12:00:21.208 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12345
12:00:21.208 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:21.208 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:21.208 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@7e9f2c32
12:00:21.208 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@7e9f2c32
12:00:21.209 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12345
12:00:21.209 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12345
12:00:21.209 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@1eff3cfb
12:00:21.209 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:21.209 [main ] TRACE it.tidalwave.messagebus.MessageBusHelper - registerMessageListener(void it.tidalwave.northernwind.rca.embeddedserver.impl.DefaultEmbeddedServer.onOpenSite(it.tidalwave.northernwind.rca.ui.event.OpenSiteEvent))
12:00:21.211 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *************************************************
12:00:21.211 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST "stop must properly shut the webserver down"
12:00:21.211 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - *************************************************
12:00:21.216 [1421417-62 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp1841421417-62 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1108ff83
12:00:21.217 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Starting webserver on port 12346...
12:00:21.218 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5d4e13e1 + SelectChannelConnector@0.0.0.0:12346 as connector
12:00:21.218 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5d4e13e1 + it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5 as handler
12:00:21.218 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.Server@5d4e13e1
12:00:21.218 [main ] INFO org.eclipse.jetty.server.Server - jetty-8.1.10.v20130312
12:00:21.218 [main ] DEBUG org.eclipse.jetty.util.component.Container - Container org.eclipse.jetty.server.Server@5d4e13e1 + qtp964094970{8<=0<=0/254,-1} as threadpool
12:00:21.218 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:21.218 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:21.218 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:21.218 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - starting org.eclipse.jetty.server.Server@5d4e13e1
12:00:21.218 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting qtp964094970{8<=0<=0/254,-1}
12:00:21.228 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED qtp964094970{8<=7<=8/254,0}
12:00:21.228 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting SelectChannelConnector@0.0.0.0:12346
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting null/null
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - starting org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@2676dc05
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@2676dc05
12:00:21.229 [main ] INFO org.eclipse.jetty.server.AbstractConnector - Started SelectChannelConnector@0.0.0.0:12346
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED SelectChannelConnector@0.0.0.0:12346
12:00:21.229 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STARTED org.eclipse.jetty.server.Server@5d4e13e1
12:00:21.229 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> started
12:00:21.235 [4094970-70 Selector0] DEBUG org.eclipse.jetty.io.nio - Starting Thread[qtp964094970-70 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1cb7dea
12:00:23.230 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Stopping webserver...
12:00:23.230 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@5d4e13e1
12:00:23.230 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12346
12:00:23.231 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@2676dc05
12:00:23.233 [4094970-70 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp964094970-70 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1cb7dea
12:00:23.243 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@2676dc05
12:00:23.244 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:23.244 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:23.245 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12346
12:00:23.245 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:23.245 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:23.245 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@3e0fbeb5
12:00:23.245 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@5d4e13e1
12:00:23.245 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp964094970{8<=8<=8/254,0}
12:00:23.298 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp964094970{8<=0<=0/254,2}
12:00:23.298 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@5d4e13e1
12:00:23.298 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> stopped
12:00:23.299 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - TEST PASSED in 2087 msec
12:00:23.299 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest -
12:00:23.300 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - Stopping webserver...
12:00:23.300 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@1eff3cfb
12:00:23.301 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectChannelConnector@0.0.0.0:12345
12:00:23.301 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@7e9f2c32
12:00:23.301 [1421417-62 Selector0] DEBUG org.eclipse.jetty.io.nio - Stopped Thread[qtp1841421417-62 Selector0,5,main] on org.eclipse.jetty.io.nio.SelectorManager$1@1108ff83
12:00:23.312 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.nio.SelectChannelConnector$ConnectorSelectorManager@7e9f2c32
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping PooledBuffers [0/1024@6144,0/1024@16384,0/1024@-]/PooledBuffers [0/1024@6144,0/1024@32768,0/1024@-]
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED null/null
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectChannelConnector@0.0.0.0:12345
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:23.313 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED it.tidalwave.northernwind.rca.embeddedserver.impl.ServletAdapter$1@70c69586
12:00:23.313 [main ] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@1eff3cfb
12:00:23.313 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - stopping qtp1841421417{8<=8<=8/254,0}
12:00:23.365 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED qtp1841421417{8<=0<=0/254,4}
12:00:23.365 [main ] DEBUG o.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@1eff3cfb
12:00:23.365 [main ] INFO i.t.n.r.embeddedserver.impl.DefaultEmbeddedServer - >>>> stopped
12:00:23.366 [main ] INFO i.t.n.r.e.impl.DefaultEmbeddedServerTest - >>>> shutting down server...
12:00:23.368 [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: 7.843 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.3.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.30819703aea5.jar
[INFO]
[INFO] --- jar:3.3.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.30819703aea5-tests.jar
[INFO]
[INFO] --- install:3.1.1:install (default-install) @ it-tidalwave-northernwind-rca-embeddedserver ---
[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.30819703aea5.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/target/it-tidalwave-northernwind-rca-embeddedserver-1.2-ALPHA-4-SNAPSHOT.30819703aea5-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