[Reg] schema load affects first request SLA

I created a new workspace and a new project.

I loaded the WSDL and created a new testsuite and testcase.

I saved everything.

I ran the the tests from the command-line. The results are identical to before:

SoapUI Pro 4.6.4 TestCase Runner Configuring log4j from [C:\Program Files\SmartBear\SoapUI-Pro-4.6.4\bin\soapui-log4j.xml] 13:01:26,640 INFO [DefaultSoapUICore] initialized soapui-settings from [h:\pcss-testing\soapui-settings.xml] 13:01:27,030 INFO [SoapUIProGroovyScriptEngineFactory] Setting Script Library to [C:\Program Files\SmartBear\SoapUI-Pro-4.6.4\bin\scripts] 13:01:27,030 INFO [DefaultSoapUICore] Adding listeners from [C:\Program Files\SmartBear\SoapUI-Pro-4.6.4\bin\listeners\demo-listeners.xml] 13:01:28,842 INFO [WsdlProject] Loaded project from [file:/h:/pcss-testing/new-soapui-project.xml] 13:01:29,342 INFO [SoapUIProTestCaseRunner] Running SoapUI tests in project [new] 13:01:29,342 INFO [SoapUIProTestCaseRunner] Running Project [new], runType = SEQUENTIAL 13:01:29,358 INFO [SoapUIProTestCaseRunner] Running SoapUI testcase [GetAppearanceCivil] 13:01:29,374 INFO [SoapUIProTestCaseRunner] running step [Request 1] 13:01:30,311 DEBUG [HttpClientSupport$SoapUIHttpClient] Attempt 1 to execute request 13:01:30,327 DEBUG [SoapUIMultiThreadedHttpConnectionManager$SoapUIDefaultClientConnection] Sending request: POST /courts/pcssCivil HTTP/1.1 13:01:30,795 DEBUG [SoapUIMultiThreadedHttpConnectionManager$SoapUIDefaultClientConnection] Receiving response: HTTP/1.1 200 OK 13:01:30,811 DEBUG [HttpClientSupport$SoapUIHttpClient] Connection can be kept alive indefinitely Progress: 1 - Loading Definition from cache 13:01:30,998 DEBUG [AbstractDefinitionContext] Loading Definition... 13:01:31,014 DEBUG [WsdlInterfaceDefinition] Loading WSDL: file:\H:\pcss-testing\PCSS%20Civil\PCSSCivil.wsdl 13:01:31,014 DEBUG [AbstractWsdlDefinitionLoader] Returning baseInputSource [file:\H:\pcss-testing\PCSS%20Civil\PCSSCivil.wsdl] Retrieving document at 'file:\H:\pcss-testing\PCSS%20Civil\PCSSCivil.wsdl'. 13:01:31,623 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/xop.xsd with targetNamespace http://www.w3.org/2004/08/xop/include 13:01:31,670 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/XMLSchema.xsd with targetNamespace http://www.w3.org/2001/XMLSchema 13:01:31,764 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/xml.xsd with targetNamespace http://www.w3.org/XML/1998/namespace 13:01:31,764 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/swaref.xsd with targetNamespace http://ws-i.org/profiles/basic/1.1/xsd 13:01:31,764 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/xmime200505.xsd with targetNamespace http://www.w3.org/2005/05/xmlmime 13:01:31,779 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/xmime200411.xsd with targetNamespace http://www.w3.org/2004/11/xmlmime 13:01:31,779 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/soapEnvelope.xsd with targetNamespace http://schemas.xmlsoap.org/soap/envelope/ 13:01:31,795 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/soapEncoding.xsd with targetNamespace http://schemas.xmlsoap.org/soap/encoding/ 13:01:31,795 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/soapEnvelope12.xsd with targetNamespace http://www.w3.org/2003/05/soap-envelope 13:01:31,795 INFO [SchemaUtils] Added default schema from file:/C:/Program%20Files/SmartBear/SoapUI-Pro-4.6.4/lib/soapui-4.6.4.jar!/com/eviware/soapui/resources/xsds/soapEncoding12.xsd with targetNamespace http://www.w3.org/2003/05/soap-encoding 13:01:31,811 INFO [SchemaUtils] Loading schema types from [file:\H:\pcss-testing\PCSS%20Civil\PCSSCivil.wsdl] 13:01:31,811 INFO [SchemaUtils] Getting schema file:\H:\pcss-testing\PCSS%20Civil\PCSSCivil.wsdl 13:01:32,420 DEBUG [AbstractDefinitionContext] Loaded Definition: ok 13:01:32,467 INFO [SoapUIProTestCaseRunner] Assertion [SOAP Response] has status VALID 13:01:32,467 INFO [SoapUIProTestCaseRunner] Assertion [Schema Compliance] has status VALID 13:01:32,467 INFO [SoapUIProTestCaseRunner] Assertion [Not SOAP Fault] has status VALID 13:01:32,467 INFO [SoapUIProTestCaseRunner] Assertion [Response SLA] has status FAILED 13:01:32,467 ERROR [SoapUIProTestCaseRunner] ASSERTION FAILED -> Response did not meet SLA 1360/1000 13:01:32,482 ERROR [SoapUIProTestCaseRunner] Request 1 failed, exporting to [h:\pcss-testing\TestSuite-GetAppearanceCivil-Request_1-0-FAILED.txt] 13:01:32,498 INFO [SoapUIProTestCaseRunner] Finished running SoapUI testcase [GetAppearanceCivil], time taken: 3083ms, status: FAILED 13:01:32,498 INFO [SoapUIProTestCaseRunner] Project [new] finished with status [FAILED] in 3156ms

Normally, that first request takes ~500 ms to return.

SB