500 Internal Server Error - Testing Navision Webservices
Hi,
I'm new to soapUI, but trying it as a simple test against our webservice. I can create a project, add a WSDL and a test case. We're using NTLM authentication and the tests autheticate, validate ect great. I just can't get a valid response message back. Similiar tests with the example webservices work great so I am either doing something wrong or there is a problem with our webservices. The webservice is generated by a "Microsoft Dynamics Nav" system (formally known and Navision).
A test with HTML code using javascript to connect to the webservice proves that a successful connection and response can be made, but our end aim is to connect to a Navision webservice using Adobe Flex/Coldfusion. With our Flex tests, we get a simlier "soap message is invalid" error but Flex is not so good at giving you reasons for the failure, hence our trial with soapUI.
To try an simplfy the tests both the webservice and soapUI tests are both running on a local machine.
The http log is a below. Some pointers for what to look for with the error 500 would be greatly appreciated.
Thanks in Advance...
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Content-Length: 0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "WWW-Authenticate: NTLM[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:00 GMT[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Authorization: NTLM TlRMTVNTUAABAAAABlIAAAYABgApAAAACQAJACAAAABMT0NBTEhPU1RHTE9CQUw=[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Content-Length: 0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "WWW-Authenticate: NTLM TlRMTVNTUAACAAAABgAGADgAAAAGAoECiiDgCfIDULIAAAAAAAAAALoAugA+AAAABgGwHQAAAA9HTE9CQUwCAAwARwBMAE8AQgBBAEwAAQAYAEIAUABJAEwAQQBQADAANwAwADMAOAAwAAQAIgBHAEwATwBCAEEATAAuAEMATwBSAEUALgBMAE8AQwBBAEwAAwA8AEIAUABJAEwAQQBQADAANwAwADMAOAAwAC4ARwBMAE8AQgBBAEwALgBDAE8AUgBFAC4ATABPAEMAQQBMAAUAFABDAE8AUgBFAC4ATABPAEMAQQBMAAcACABFQ7ZNqB/MAQAAAAA=[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:00 GMT[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Authorization: NTLM TlRMTVNTUAADAAAAGAAYAFgAAAAAAAAAcAAAAAYABgBAAAAACQAJAEYAAAAJAAkATwAAAAAAAABwAAAABlIAAEdMT0JBTFNJTU1PTkRTVExPQ0FMSE9TVLB20xg60Puw4TCW0Nc3yhgy7dAWf6e2Mg==[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "HTTP/1.1 500 Internal Server Error[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "HTTP/1.1 500 Internal Server Error[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Content-Length: 394[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Content-Type: text/xml; charset=utf-8[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:03 GMT[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"><s:Body><s:Fault><faultcode xmlns:a="urn:microsoft-dynamics-schemas/error">a:System.Net.WebException</faultcode><faultstring xml:lang="en-GB">Soap message is invalid!</faultstring><detail><string xmlns="http://schemas.microsoft.com/2003/10/Serialization/">Soap message is invalid!</string></detail></s:Fault></s:Body></s:Envelope>"
I'm new to soapUI, but trying it as a simple test against our webservice. I can create a project, add a WSDL and a test case. We're using NTLM authentication and the tests autheticate, validate ect great. I just can't get a valid response message back. Similiar tests with the example webservices work great so I am either doing something wrong or there is a problem with our webservices. The webservice is generated by a "Microsoft Dynamics Nav" system (formally known and Navision).
A test with HTML code using javascript to connect to the webservice proves that a successful connection and response can be made, but our end aim is to connect to a Navision webservice using Adobe Flex/Coldfusion. With our Flex tests, we get a simlier "soap message is invalid" error but Flex is not so good at giving you reasons for the failure, hence our trial with soapUI.
To try an simplfy the tests both the webservice and soapUI tests are both running on a local machine.
The http log is a below. Some pointers for what to look for with the error 500 would be greatly appreciated.
Thanks in Advance...
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Content-Length: 0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "WWW-Authenticate: NTLM[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:00 GMT[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Authorization: NTLM TlRMTVNTUAABAAAABlIAAAYABgApAAAACQAJACAAAABMT0NBTEhPU1RHTE9CQUw=[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "HTTP/1.1 401 Unauthorized[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Content-Length: 0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "WWW-Authenticate: NTLM TlRMTVNTUAACAAAABgAGADgAAAAGAoECiiDgCfIDULIAAAAAAAAAALoAugA+AAAABgGwHQAAAA9HTE9CQUwCAAwARwBMAE8AQgBBAEwAAQAYAEIAUABJAEwAQQBQADAANwAwADMAOAAwAAQAIgBHAEwATwBCAEEATAAuAEMATwBSAEUALgBMAE8AQwBBAEwAAwA8AEIAUABJAEwAQQBQADAANwAwADMAOAAwAC4ARwBMAE8AQgBBAEwALgBDAE8AUgBFAC4ATABPAEMAQQBMAAUAFABDAE8AUgBFAC4ATABPAEMAQQBMAAcACABFQ7ZNqB/MAQAAAAA=[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:00 GMT[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "POST /DynamicsNAV/WS/SystemService HTTP/1.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Accept-Encoding: gzip,deflate[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Type: text/xml;charset=UTF-8[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "SOAPAction: "urn:microsoft-dynamics-schemas/nav/system/:Companies"[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "User-Agent: Jakarta Commons-HttpClient/3.1[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Content-Length: 232[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Authorization: NTLM TlRMTVNTUAADAAAAGAAYAFgAAAAAAAAAcAAAAAYABgBAAAAACQAJAEYAAAAJAAkATwAAAAAAAABwAAAABlIAAEdMT0JBTFNJTU1PTkRTVExPQ0FMSE9TVLB20xg60Puw4TCW0Nc3yhgy7dAWf6e2Mg==[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "Host: localhost:7047[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "[\r][\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "<soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sys="urn:microsoft-dynamics-schemas/nav/system/">[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Header/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " <sys:Companies/>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> " </soapenv:Body>[\n]"
Tue May 31 16:35:00 BST 2011:DEBUG:>> "</soapenv:Envelope>"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "HTTP/1.1 500 Internal Server Error[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "HTTP/1.1 500 Internal Server Error[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Content-Length: 394[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Content-Type: text/xml; charset=utf-8[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Server: Microsoft-HTTPAPI/2.0[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "Date: Tue, 31 May 2011 15:35:03 GMT[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "[\r][\n]"
Tue May 31 16:35:03 BST 2011:DEBUG:<< "<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"><s:Body><s:Fault><faultcode xmlns:a="urn:microsoft-dynamics-schemas/error">a:System.Net.WebException</faultcode><faultstring xml:lang="en-GB">Soap message is invalid!</faultstring><detail><string xmlns="http://schemas.microsoft.com/2003/10/Serialization/">Soap message is invalid!</string></detail></s:Fault></s:Body></s:Envelope>"
