09:17:21.665 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Found @PactTestFor annotation on test method public final void edu.obya.blueprint.client.cdc.pact.consumer.ClientPactConsumerBTest.getClient_whenExists(au.com.dius.pact.consumer.MockServer)
09:17:21.666 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - providerInfo = ProviderInfo(providerName=, hostInterface=, port=, pactVersion=null, providerType=null, https=false, mockServerImplementation=Default, keyStorePath=, keyStoreAlias=, keyStorePassword=, privateKeyPassword=)
09:17:21.667 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Looking for @Pact method named 'getClient' for provider 'default'
09:17:21.667 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Invoking method 'getClient' to get Pact for the test 'getClient_whenExists'
09:17:21.667 [Test worker] DEBUG io.pact.plugins.jvm.core.CatalogueManager - Core catalogue entries:
core/content-matcher/xml
core/content-matcher/json
core/content-matcher/text
core/content-matcher/multipart-form-data
core/content-matcher/form-urlencoded
core/matcher/v1-equality
core/matcher/v2-regex
core/matcher/v2-type
core/matcher/v2-min-type
core/matcher/v2-max-type
core/matcher/v2-minmax-type
core/matcher/v3-number-type
core/matcher/v3-integer-type
core/matcher/v3-decimal-type
core/matcher/v3-date
core/matcher/v3-time
core/matcher/v3-datetime
core/matcher/v3-includes
core/matcher/v3-null
core/matcher/v3-content-type
core/matcher/v4-equals-ignore-order
core/matcher/v4-min-equals-ignore-order
core/matcher/v4-max-equals-ignore-order
core/matcher/v4-minmax-equals-ignore-order
core/matcher/v4-array-contains
core/matcher/v4-notempty
core/matcher/v4-semver
core/matcher/v4-each-key
core/matcher/v4-each-value
core/transport/http
core/transport/https
core/interaction/message
core/interaction/synchronous-message
core/content-generator/json
09:17:21.670 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Starting mock server
09:17:21.671 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Mock server started: /127.0.0.1:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000011 preparing request execution
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.protocol.RequestAddCookies - ex-0000000011 Cookie spec selected: strict
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.protocol.RequestAuthCache - ex-0000000011 Auth cache not set in the context
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000011 target auth state: UNCHALLENGED
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000011 proxy auth state: UNCHALLENGED
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000011 acquiring connection with route {}->http://localhost:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000011 acquiring endpoint (3 MINUTES)
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000005 Get connection for route {}->http://localhost:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000011 acquired endpoint InternalConnectionEndpoint-1570cad0
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000011 opening connection {}->http://localhost:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-1570cad0 connecting endpoint (3 MINUTES)
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.DefaultHttpClientConnectionOperator - http-outgoing-6 connecting to localhost/127.0.0.1:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.DefaultHttpClientConnectionOperator - http-outgoing-6 connection established 127.0.0.1:33544<->127.0.0.1:44231
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-1570cad0 endpoint connected
09:17:21.672 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000011 executing OPTIONS / HTTP/1.1
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-1570cad0 start execution ex-0000000011
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000005 Executing exchange ex-0000000011
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> OPTIONS / HTTP/1.1
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> X-PACT-BOOTCHECK: true
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> Accept-Encoding: gzip, x-gzip, deflate
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> Host: localhost:44231
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> Connection: keep-alive
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 >> User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "OPTIONS / HTTP/1.1[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "X-PACT-BOOTCHECK: true[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "Accept-Encoding: gzip, x-gzip, deflate[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "Host: localhost:44231[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "Connection: keep-alive[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)[\r][\n]"
09:17:21.673 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 >> "[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "HTTP/1.1 200 OK[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "Transfer-encoding: chunked[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "X-pact-bootcheck: true[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 << HTTP/1.1 200 OK
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 << Transfer-encoding: chunked
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-6 << X-pact-bootcheck: true
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000011 connection can be kept alive for 3 MINUTES
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "0[\r][\n]"
09:17:21.674 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-6 << "[\r][\n]"
09:17:21.675 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-1570cad0 releasing valid endpoint
09:17:21.675 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000005 Releasing connection 127.0.0.1:33544<->127.0.0.1:44231
09:17:21.675 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000005 Connection can be kept alive for 3 MINUTES
09:17:21.679 [Test worker] DEBUG org.springframework.web.client.RestTemplate - HTTP GET http://localhost:44231/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd
09:17:21.681 [Test worker] DEBUG org.springframework.web.client.RestTemplate - Accept=[application/json, application/*+json]
09:17:21.681 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
09:17:21.681 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
09:17:21.681 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection request: [route: {}->http://localhost:44231][total available: 0; route allocated: 0 of 5; total allocated: 0 of 10]
09:17:21.682 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection leased: [id: 5][route: {}->http://localhost:44231][total available: 0; route allocated: 1 of 5; total allocated: 1 of 10]
09:17:21.682 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://localhost:44231
09:17:21.682 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to localhost/127.0.0.1:44231
09:17:21.682 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 127.0.0.1:33556<->127.0.0.1:44231
09:17:21.682 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1
09:17:21.683 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> Authorization: Basic dGVzdDp0ZXN0
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> Accept: application/json, application/*+json
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> Host: localhost:44231
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> Connection: Keep-Alive
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> User-Agent: Apache-HttpClient/4.5.14 (Java/17.0.7)
09:17:21.683 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 >> Accept-Encoding: gzip,deflate
09:17:21.683 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1[\r][\n]"
09:17:21.683 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "Authorization: Basic dGVzdDp0ZXN0[\r][\n]"
09:17:21.683 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "Accept: application/json, application/*+json[\r][\n]"
09:17:21.684 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "Host: localhost:44231[\r][\n]"
09:17:21.684 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "Connection: Keep-Alive[\r][\n]"
09:17:21.684 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "User-Agent: Apache-HttpClient/4.5.14 (Java/17.0.7)[\r][\n]"
09:17:21.684 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "Accept-Encoding: gzip,deflate[\r][\n]"
09:17:21.684 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 >> "[\r][\n]"
09:17:21.684 [HTTP-Dispatcher] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Received request: method: GET
path: /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd
query: {}
headers: {Accept-encoding=[gzip,deflate], Accept=[application/json, application/*+json], Connection=[Keep-Alive], Host=[localhost:44231], User-agent=[Apache-HttpClient/4.5.14 (Java/17.0.7)], Authorization=[Basic dGVzdDp0ZXN0]}
matchers: MatchingRules(rules={})
generators: Generators(categories={})
body: EMPTY
09:17:21.685 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - comparing to expected request:
HttpRequest(method=GET, path=/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd, query={}, headers={Authorization=[Basic dGVzdDp0ZXN0]}, body=MISSING, matchingRules=MatchingRules(rules={path=MatchingRuleCategory(name=path, matchingRules={=MatchingRuleGroup(rules=[RegexMatcher(regex=^/clients/[a-f0-9]{8}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{12}$, example=null)], ruleLogic=AND, cascaded=false)}), header=MatchingRuleCategory(name=header, matchingRules={Authorization=MatchingRuleGroup(rules=[RegexMatcher(regex=Basic (?:[A-Za-z0-9+/]{4})*(?:[A-Za-z0-9+/]{2}==|[A-Za-z0-9+/]{3}=)?, example=null)], ruleLogic=AND, cascaded=false)})}), generators=Generators(categories={}))
09:17:21.685 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - pluginConfiguration={}
09:17:21.685 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.MatcherExecutor - comparing '/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd' with regexp ^/clients/[a-f0-9]{8}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{12}$ at [] -> true
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.HeaderMatcher - Comparing header 'Authorization': 'Basic dGVzdDp0ZXN0' to 'Basic dGVzdDp0ZXN0'
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.MatcherExecutor - comparing 'Basic dGVzdDp0ZXN0' with regexp Basic (?:[A-Za-z0-9+/]{4})*(?:[A-Za-z0-9+/]{2}==|[A-Za-z0-9+/]{3}=)? at [Authorization] -> true
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.Matching - matchBody: context=MatchingContext(matchers=MatchingRuleCategory(name=body, matchingRules={}), allowUnexpectedKeys=false, pluginConfiguration={})
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.Matching - No matcher for null, using equality
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - Request mismatch: RequestMatchResult(method=null, path=null, query=[], cookie=null, headers=[HeaderMatchResult(key=Authorization, result=[])], body=BodyMatchResult(typeMismatch=null, bodyResults=[]))
09:17:21.686 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.generators.DefaultResponseGenerator - Either no content generator was found, or is a core one, will use the internal implementation
09:17:21.687 [HTTP-Dispatcher] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Generating response: HttpResponse(status=200, headers={Content-Type=[application/json]}, body=PRESENT({"activated":true,"age":21,"createdAt":"2023-05-22T09:17:21","id":"64a0f7d1-7b25-412d-b1e0-abacde3c21cd","name":"John"}), matchingRules=MatchingRules(rules={header=MatchingRuleCategory(name=header, matchingRules={Content-Type=MatchingRuleGroup(rules=[RegexMatcher(regex=application/json, example=null)], ruleLogic=AND, cascaded=false)}), body=MatchingRuleCategory(name=body, matchingRules={$.id=MatchingRuleGroup(rules=[RegexMatcher(regex=[0-9a-f]{8}-[0-9a-f]{4}-[0-9a-f]{4}-[0-9a-f]{4}-[0-9a-f]{12}, example=null)], ruleLogic=AND, cascaded=false), $.name=MatchingRuleGroup(rules=[au.com.dius.pact.core.model.matchingrules.TypeMatcher@6d4d9dee], ruleLogic=AND, cascaded=false), $.age=MatchingRuleGroup(rules=[NumberTypeMatcher(numberType=INTEGER)], ruleLogic=AND, cascaded=false), $.createdAt=MatchingRuleGroup(rules=[TimestampMatcher(format=yyyy-MM-dd'T'HH:mm:ss)], ruleLogic=AND, cascaded=false), $.activated=MatchingRuleGroup(rules=[au.com.dius.pact.core.model.matchingrules.TypeMatcher@6d4d9dee], ruleLogic=AND, cascaded=false)}), status=MatchingRuleCategory(name=status, matchingRules={})}), generators=Generators(categories={BODY={$.createdAt=DateTimeGenerator(format=yyyy-MM-dd'T'HH:mm:ss, expression=null)}}))
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "HTTP/1.1 200 OK[\r][\n]"
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "Content-length: 119[\r][\n]"
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "Content-Type: application/json[\r][\n]"
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "[\r][\n]"
09:17:21.688 [Test worker] DEBUG org.apache.http.wire - http-outgoing-5 << "{"activated":true,"age":21,"createdAt":"2023-05-22T09:17:21","id":"64a0f7d1-7b25-412d-b1e0-abacde3c21cd","name":"John"}"
09:17:21.688 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 << HTTP/1.1 200 OK
09:17:21.688 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.688 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 << Content-length: 119
09:17:21.688 [Test worker] DEBUG org.apache.http.headers - http-outgoing-5 << Content-Type: application/json
09:17:21.689 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
09:17:21.689 [Test worker] DEBUG org.springframework.web.client.RestTemplate - Response 200 OK
09:17:21.689 [Test worker] DEBUG org.springframework.web.client.RestTemplate - Reading to [edu.obya.blueprint.client.adapter.rest.ClientOutput]
09:17:21.690 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection [id: 5][route: {}->http://localhost:44231] can be kept alive indefinitely
09:17:21.690 [Test worker] DEBUG org.apache.http.impl.conn.DefaultManagedHttpClientConnection - http-outgoing-5: set socket timeout to 0
09:17:21.690 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection released: [id: 5][route: {}->http://localhost:44231][total available: 1; route allocated: 1 of 5; total allocated: 1 of 10]
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000012 preparing request execution
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.protocol.RequestAddCookies - ex-0000000012 Cookie spec selected: strict
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.protocol.RequestAuthCache - ex-0000000012 Auth cache not set in the context
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000012 target auth state: UNCHALLENGED
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000012 proxy auth state: UNCHALLENGED
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000012 acquiring connection with route {s}->https://www.google-analytics.com:443
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000012 acquiring endpoint (3 MINUTES)
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000012 endpoint lease request (3 MINUTES) [route: {s}->https://www.google-analytics.com:443][total available: 1; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.697 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000012 endpoint leased [route: {s}->https://www.google-analytics.com:443][total available: 0; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000012 acquired ep-0000000006
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000012 acquired endpoint ep-0000000006
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000012 executing POST /collect HTTP/1.1
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ep-0000000006 start execution ex-0000000012
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000006 executing exchange ex-0000000012 over http-outgoing-1
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> POST /collect HTTP/1.1
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Accept-Encoding: gzip, x-gzip, deflate
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Content-Length: 234
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Content-Type: application/x-www-form-urlencoded; charset=ISO-8859-1
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Host: www.google-analytics.com
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Connection: keep-alive
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "POST /collect HTTP/1.1[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Accept-Encoding: gzip, x-gzip, deflate[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Content-Length: 234[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Content-Type: application/x-www-form-urlencoded; charset=ISO-8859-1[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Host: www.google-analytics.com[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Connection: keep-alive[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "[\r][\n]"
09:17:21.698 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "v=1&t=event&tid=UA-117778936-1&cid=aa7a8634942d6ae694480de4c1b1765c&an=pact-jvm&aid=pact-jvm&av=4.5.5&aip=true&ds=client&cd2=CI&cd3=linux-amd64&cd6=junit5&cd7=17.0.7%2B7-LTS&el=Pact+consumer+tests+ran&ec=ConsumerTest&ea=Completed&ev=1"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "HTTP/1.1 200 OK[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Access-Control-Allow-Origin: *[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Pragma: no-cache[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Expires: Fri, 01 Jan 1990 00:00:00 GMT[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Cache-Control: no-cache, no-store, must-revalidate[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Last-Modified: Sun, 17 May 1998 03:00:00 GMT[\r][\n]"
09:17:21.709 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "X-Content-Type-Options: nosniff[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Content-Type: image/gif[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Cross-Origin-Resource-Policy: cross-origin[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Server: Golfe2[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Content-Length: 35[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "[\r][\n]"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "GIF89a[0x1][0x0][0x1][0x0][0xffffff80][0xffffffff][0x0][0xffffffff][0xffffffff][0xffffffff][0x0][0x0][0x0],[0x0][0x0][0x0][0x0][0x1][0x0][0x1][0x0][0x0][0x2][0x2]D[0x1][0x0];"
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << HTTP/1.1 200 OK
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Access-Control-Allow-Origin: *
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.710 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Pragma: no-cache
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Expires: Fri, 01 Jan 1990 00:00:00 GMT
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Cache-Control: no-cache, no-store, must-revalidate
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Last-Modified: Sun, 17 May 1998 03:00:00 GMT
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << X-Content-Type-Options: nosniff
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Content-Type: image/gif
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Cross-Origin-Resource-Policy: cross-origin
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Server: Golfe2
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Content-Length: 35
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000
09:17:21.711 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000012 connection can be kept alive for 3 MINUTES
09:17:21.712 [Thread-14] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ep-0000000006 releasing valid endpoint
09:17:21.712 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000006 releasing endpoint
09:17:21.712 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000006 connection http-outgoing-1 can be kept alive for 3 MINUTES
09:17:21.712 [Thread-14] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000006 connection released [route: {s}->https://www.google-analytics.com:443][total available: 1; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.794 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Mock server shutdown
09:17:21.800 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Found @PactTestFor annotation on test method public final void edu.obya.blueprint.client.cdc.pact.consumer.ClientPactConsumerBTest.getClient_whenNoAuth(au.com.dius.pact.consumer.MockServer)
09:17:21.800 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - providerInfo = ProviderInfo(providerName=, hostInterface=, port=, pactVersion=null, providerType=null, https=false, mockServerImplementation=Default, keyStorePath=, keyStoreAlias=, keyStorePassword=, privateKeyPassword=)
09:17:21.801 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Looking for @Pact method named 'getClient_noAuth' for provider 'default'
09:17:21.801 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Invoking method 'getClient_noAuth' to get Pact for the test 'getClient_whenNoAuth'
09:17:21.801 [Test worker] DEBUG io.pact.plugins.jvm.core.CatalogueManager - Core catalogue entries:
core/content-matcher/xml
core/content-matcher/json
core/content-matcher/text
core/content-matcher/multipart-form-data
core/content-matcher/form-urlencoded
core/matcher/v1-equality
core/matcher/v2-regex
core/matcher/v2-type
core/matcher/v2-min-type
core/matcher/v2-max-type
core/matcher/v2-minmax-type
core/matcher/v3-number-type
core/matcher/v3-integer-type
core/matcher/v3-decimal-type
core/matcher/v3-date
core/matcher/v3-time
core/matcher/v3-datetime
core/matcher/v3-includes
core/matcher/v3-null
core/matcher/v3-content-type
core/matcher/v4-equals-ignore-order
core/matcher/v4-min-equals-ignore-order
core/matcher/v4-max-equals-ignore-order
core/matcher/v4-minmax-equals-ignore-order
core/matcher/v4-array-contains
core/matcher/v4-notempty
core/matcher/v4-semver
core/matcher/v4-each-key
core/matcher/v4-each-value
core/transport/http
core/transport/https
core/interaction/message
core/interaction/synchronous-message
core/content-generator/json
09:17:21.804 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Starting mock server
09:17:21.804 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Mock server started: /127.0.0.1:40293
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000013 preparing request execution
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.protocol.RequestAddCookies - ex-0000000013 Cookie spec selected: strict
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.protocol.RequestAuthCache - ex-0000000013 Auth cache not set in the context
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000013 target auth state: UNCHALLENGED
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000013 proxy auth state: UNCHALLENGED
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000013 acquiring connection with route {}->http://localhost:40293
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000013 acquiring endpoint (3 MINUTES)
09:17:21.805 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000006 Get connection for route {}->http://localhost:40293
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000013 acquired endpoint InternalConnectionEndpoint-6f3b13d0
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000013 opening connection {}->http://localhost:40293
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-6f3b13d0 connecting endpoint (3 MINUTES)
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.DefaultHttpClientConnectionOperator - http-outgoing-7 connecting to localhost/127.0.0.1:40293
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.DefaultHttpClientConnectionOperator - http-outgoing-7 connection established 127.0.0.1:53112<->127.0.0.1:40293
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-6f3b13d0 endpoint connected
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000013 executing OPTIONS / HTTP/1.1
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-6f3b13d0 start execution ex-0000000013
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000006 Executing exchange ex-0000000013
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> OPTIONS / HTTP/1.1
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> X-PACT-BOOTCHECK: true
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> Accept-Encoding: gzip, x-gzip, deflate
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> Host: localhost:40293
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> Connection: keep-alive
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 >> User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "OPTIONS / HTTP/1.1[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "X-PACT-BOOTCHECK: true[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "Accept-Encoding: gzip, x-gzip, deflate[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "Host: localhost:40293[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "Connection: keep-alive[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)[\r][\n]"
09:17:21.806 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 >> "[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "HTTP/1.1 200 OK[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "Transfer-encoding: chunked[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "X-pact-bootcheck: true[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "[\r][\n]"
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 << HTTP/1.1 200 OK
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 << Transfer-encoding: chunked
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.headers - http-outgoing-7 << X-pact-bootcheck: true
09:17:21.807 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000013 connection can be kept alive for 3 MINUTES
09:17:21.808 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "0[\r][\n]"
09:17:21.808 [Test worker] DEBUG org.apache.hc.client5.http.wire - http-outgoing-7 << "[\r][\n]"
09:17:21.808 [Test worker] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - InternalConnectionEndpoint-6f3b13d0 releasing valid endpoint
09:17:21.808 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000006 Releasing connection 127.0.0.1:53112<->127.0.0.1:40293
09:17:21.808 [Test worker] DEBUG org.apache.hc.client5.http.impl.io.BasicHttpClientConnectionManager - ep-0000000006 Connection can be kept alive for 3 MINUTES
09:17:21.813 [Test worker] DEBUG org.springframework.web.client.RestTemplate - HTTP GET http://localhost:40293/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd
09:17:21.815 [Test worker] DEBUG org.springframework.web.client.RestTemplate - Accept=[application/json, application/*+json]
09:17:21.816 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
09:17:21.816 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
09:17:21.816 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection request: [route: {}->http://localhost:40293][total available: 0; route allocated: 0 of 5; total allocated: 0 of 10]
09:17:21.816 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection leased: [id: 6][route: {}->http://localhost:40293][total available: 0; route allocated: 1 of 5; total allocated: 1 of 10]
09:17:21.816 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://localhost:40293
09:17:21.816 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to localhost/127.0.0.1:40293
09:17:21.817 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 127.0.0.1:53116<->127.0.0.1:40293
09:17:21.817 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1
09:17:21.817 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Target auth state: UNCHALLENGED
09:17:21.817 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
09:17:21.817 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1
09:17:21.817 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> Accept: application/json, application/*+json
09:17:21.817 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> Host: localhost:40293
09:17:21.817 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> Connection: Keep-Alive
09:17:21.818 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> User-Agent: Apache-HttpClient/4.5.14 (Java/17.0.7)
09:17:21.818 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 >> Accept-Encoding: gzip,deflate
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "GET /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd HTTP/1.1[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "Accept: application/json, application/*+json[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "Host: localhost:40293[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "Connection: Keep-Alive[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "User-Agent: Apache-HttpClient/4.5.14 (Java/17.0.7)[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "Accept-Encoding: gzip,deflate[\r][\n]"
09:17:21.818 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 >> "[\r][\n]"
09:17:21.819 [HTTP-Dispatcher] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Received request: method: GET
path: /clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd
query: {}
headers: {Accept-encoding=[gzip,deflate], Accept=[application/json, application/*+json], Connection=[Keep-Alive], Host=[localhost:40293], User-agent=[Apache-HttpClient/4.5.14 (Java/17.0.7)]}
matchers: MatchingRules(rules={})
generators: Generators(categories={})
body: EMPTY
09:17:21.819 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - comparing to expected request:
HttpRequest(method=GET, path=/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd, query={}, headers={}, body=MISSING, matchingRules=MatchingRules(rules={path=MatchingRuleCategory(name=path, matchingRules={=MatchingRuleGroup(rules=[RegexMatcher(regex=^/clients/[a-f0-9]{8}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{12}$, example=null)], ruleLogic=AND, cascaded=false)})}), generators=Generators(categories={}))
09:17:21.819 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - pluginConfiguration={}
09:17:21.819 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.MatcherExecutor - comparing '/clients/64a0f7d1-7b25-412d-b1e0-abacde3c21cd' with regexp ^/clients/[a-f0-9]{8}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{4}-[a-f0-9]{12}$ at [] -> true
09:17:21.820 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.Matching - matchBody: context=MatchingContext(matchers=MatchingRuleCategory(name=body, matchingRules={}), allowUnexpectedKeys=false, pluginConfiguration={})
09:17:21.820 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.Matching - No matcher for null, using equality
09:17:21.820 [HTTP-Dispatcher] DEBUG au.com.dius.pact.core.matchers.RequestMatching - Request mismatch: RequestMatchResult(method=null, path=null, query=[], cookie=null, headers=[], body=BodyMatchResult(typeMismatch=null, bodyResults=[]))
09:17:21.820 [HTTP-Dispatcher] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Generating response: HttpResponse(status=401, headers={}, body=MISSING, matchingRules=MatchingRules(rules={status=MatchingRuleCategory(name=status, matchingRules={}), header=MatchingRuleCategory(name=header, matchingRules={})}), generators=Generators(categories={}))
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "HTTP/1.1 401 Unauthorized[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "Transfer-encoding: chunked[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "0[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.wire - http-outgoing-6 << "[\r][\n]"
09:17:21.821 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 << HTTP/1.1 401 Unauthorized
09:17:21.821 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.821 [Test worker] DEBUG org.apache.http.headers - http-outgoing-6 << Transfer-encoding: chunked
09:17:21.823 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
09:17:21.823 [Test worker] DEBUG org.apache.http.impl.auth.HttpAuthenticator - Authentication required
09:17:21.823 [Test worker] DEBUG org.apache.http.impl.auth.HttpAuthenticator - localhost:40293 requested authentication
09:17:21.823 [Test worker] DEBUG org.apache.http.impl.auth.HttpAuthenticator - Response contains no authentication challenges
09:17:21.823 [Test worker] DEBUG org.springframework.web.client.RestTemplate - Response 401 UNAUTHORIZED
09:17:21.824 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection [id: 6][route: {}->http://localhost:40293] can be kept alive indefinitely
09:17:21.824 [Test worker] DEBUG org.apache.http.impl.conn.DefaultManagedHttpClientConnection - http-outgoing-6: set socket timeout to 0
09:17:21.824 [Test worker] DEBUG org.apache.http.impl.conn.PoolingHttpClientConnectionManager - Connection released: [id: 6][route: {}->http://localhost:40293][total available: 1; route allocated: 1 of 5; total allocated: 1 of 10]
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000014 preparing request execution
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.protocol.RequestAddCookies - ex-0000000014 Cookie spec selected: strict
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.protocol.RequestAuthCache - ex-0000000014 Auth cache not set in the context
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000014 target auth state: UNCHALLENGED
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.ProtocolExec - ex-0000000014 proxy auth state: UNCHALLENGED
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.ConnectExec - ex-0000000014 acquiring connection with route {s}->https://www.google-analytics.com:443
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000014 acquiring endpoint (3 MINUTES)
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000014 endpoint lease request (3 MINUTES) [route: {s}->https://www.google-analytics.com:443][total available: 1; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000014 endpoint leased [route: {s}->https://www.google-analytics.com:443][total available: 0; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ex-0000000014 acquired ep-0000000007
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ex-0000000014 acquired endpoint ep-0000000007
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000014 executing POST /collect HTTP/1.1
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ep-0000000007 start execution ex-0000000014
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000007 executing exchange ex-0000000014 over http-outgoing-1
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> POST /collect HTTP/1.1
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Accept-Encoding: gzip, x-gzip, deflate
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Content-Length: 234
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Content-Type: application/x-www-form-urlencoded; charset=ISO-8859-1
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Host: www.google-analytics.com
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> Connection: keep-alive
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 >> User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "POST /collect HTTP/1.1[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Accept-Encoding: gzip, x-gzip, deflate[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Content-Length: 234[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Content-Type: application/x-www-form-urlencoded; charset=ISO-8859-1[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Host: www.google-analytics.com[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "Connection: keep-alive[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "User-Agent: Apache-HttpClient/5.1.4 (Java/17.0.7)[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "[\r][\n]"
09:17:21.831 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 >> "v=1&t=event&tid=UA-117778936-1&cid=aa7a8634942d6ae694480de4c1b1765c&an=pact-jvm&aid=pact-jvm&av=4.5.5&aip=true&ds=client&cd2=CI&cd3=linux-amd64&cd6=junit5&cd7=17.0.7%2B7-LTS&el=Pact+consumer+tests+ran&ec=ConsumerTest&ea=Completed&ev=1"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "HTTP/1.1 200 OK[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Access-Control-Allow-Origin: *[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Date: Mon, 22 May 2023 09:17:21 GMT[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Pragma: no-cache[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Expires: Fri, 01 Jan 1990 00:00:00 GMT[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Cache-Control: no-cache, no-store, must-revalidate[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Last-Modified: Sun, 17 May 1998 03:00:00 GMT[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "X-Content-Type-Options: nosniff[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Content-Type: image/gif[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Cross-Origin-Resource-Policy: cross-origin[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Server: Golfe2[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Content-Length: 35[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "[\r][\n]"
09:17:21.842 [Thread-16] DEBUG org.apache.hc.client5.http.wire - http-outgoing-1 << "GIF89a[0x1][0x0][0x1][0x0][0xffffff80][0xffffffff][0x0][0xffffffff][0xffffffff][0xffffffff][0x0][0x0][0x0],[0x0][0x0][0x0][0x0][0x1][0x0][0x1][0x0][0x0][0x2][0x2]D[0x1][0x0];"
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << HTTP/1.1 200 OK
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Access-Control-Allow-Origin: *
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Date: Mon, 22 May 2023 09:17:21 GMT
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Pragma: no-cache
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Expires: Fri, 01 Jan 1990 00:00:00 GMT
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Cache-Control: no-cache, no-store, must-revalidate
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Last-Modified: Sun, 17 May 1998 03:00:00 GMT
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << X-Content-Type-Options: nosniff
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Content-Type: image/gif
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Cross-Origin-Resource-Policy: cross-origin
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Server: Golfe2
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Content-Length: 35
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.headers - http-outgoing-1 << Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.MainClientExec - ex-0000000014 connection can be kept alive for 3 MINUTES
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.impl.classic.InternalHttpClient - ep-0000000007 releasing valid endpoint
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000007 releasing endpoint
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000007 connection http-outgoing-1 can be kept alive for 3 MINUTES
09:17:21.843 [Thread-16] DEBUG org.apache.hc.client5.http.impl.io.PoolingHttpClientConnectionManager - ep-0000000007 connection released [route: {s}->https://www.google-analytics.com:443][total available: 1; route allocated: 1 of 100; total allocated: 1 of 200]
09:17:21.927 [Test worker] DEBUG au.com.dius.pact.consumer.BaseJdkMockServer - Mock server shutdown
09:17:21.929 [Test worker] INFO au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Writing pacts out to directory from @PactDirectory annotation
09:17:21.930 [Test worker] DEBUG au.com.dius.pact.consumer.junit5.PactConsumerTestExt - Writing pact consumerB -> clientAPI to file src/contractTest/resources/client/cdc/pact/consumerB-clientAPI.json