Hey everyone!
Previously, when troubleshooting VA based Web Services connectors, we would get these kinds of log entries when enabling Debug mode for the cluster/connector. However, lately these have not been showing, particularly the “Dumping Provisioning Plan details” and “==> Dumping request for troubleshooting purposes” logs. These were very helpful for troubleshooting issues without the need to create a before operations rule to log this information. Is there any reason why these logs were removed? Or perhaps I am missing something?
I found some old logs I had to share here and have sanitized them for the forum post.
{"stack":"ccg","pod":"cook","connector-logging":"150","Operation":"Create","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"ConnectorProxy.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":2475,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.WebServicesConnector","mantis-client":"1400","class":"sailpoint.connector.ConnectorProxy","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"942","source_host":"REMOVED_FOR_FORUM_POST","method":"logMe","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"Dumping Application details : <?xml version='1.0' encoding='UTF-8'?>\n<!DOCTYPE Application PUBLIC \"sailpoint.dtd\" \"sailpoint.dtd\">\n<Application connector=\"sailpoint.connector.webservices.WebServicesConnector\" created=\"1712693771637\" featuresString=\"ENABLE, AUTHENTICATE, PASSWORD, PROVISIONING, UNLOCK\" icon=\"internetIcon\" id=\"REMOVED_FOR_FORUM_POST\" modified=\"1712759033698\" name=\"REMOVED_FOR_FORUM_POST\" profileClass=\"\" type=\"Web Services\">\n <Attributes>\n <Map>\n <entry key=\"accesstoken\"\/>\n <entry key=\"acctAggregationEnd\">\n <value>\n <Date>1712756802104<\/Date>\n <\/value>\n <\/entry>\n <entry key=\"acctAggregationStart\">\n <value>\n <Date>1712756763062<\/Date>\n <\/value>\n <\/entry>\n <entry key=\"authenticationFailedErrorMsg\">\n <value>\n <List>\n <String>The client session has expired or is invalid.<\/String>\n <\/List>\n <\/value>\n <\/entry>\n <entry key=\"authenticationMethod\" value=\"No Auth\"\/>\n <entry key=\"beforeProvisioningRule\"\/>\n <entry key=\"clientCertificate\"\/>\n <entry key=\"clientKeySpec\"\/>\n <entry key=\"client_id\"\/>\n <entry key=\"client_secret\"\/>\n <entry key=\"cloudCacheUpdate\">\n <value>\n <Long>REMOVED_FOR_FORUM_POST<\/Long>\n <\/value>\n <\/entry>\n <entry key=\"cloudDisplayName\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"cloudExternalId\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"connectionParameters\">\n <value>\n <List>\n <Map>\n <entry key=\"body\">\n <value>\n <Map>\n <entry key=\"bodyFormData\"\/>\n <entry key=\"bodyFormat\" value=\"raw\"\/>\n <entry key=\"jsonBody\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"contextUrl\"\/>\n <entry key=\"curlCommand\"\/>\n <entry key=\"curlEnabled\">\n <value>\n <Boolean><\/Boolean>\n <\/value>\n <\/entry>\n <entry key=\"customAuthUrl\" value=\"REMOVED_FOR_FORUM_POST"\/>\n <entry key=\"header\"\/>\n <entry key=\"httpMethodType\" value=\"POST\"\/>\n <entry key=\"operationType\" value=\"Custom Authentication\"\/>\n <entry key=\"paginationSteps\"\/>\n <entry key=\"pagingInitialOffset\">\n <value>\n <Integer>0<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"pagingSize\">\n <value>\n <Integer>50<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"parentEndpointName\"\/>\n <entry key=\"resMappingObj\">\n <value>\n <Map>\n <entry key=\"customToken\" value=\"token\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"responseCode\"\/>\n <entry key=\"rootPath\"\/>\n <entry key=\"sequenceNumberForEndpoint\" value=\"1\"\/>\n <entry key=\"uniqueNameForEndPoint\" value=\"Start Session\"\/>\n <entry key=\"xpathNamespaces\"\/>\n <\/Map>\n <Map>\n <entry key=\"body\">\n <value>\n <Map>\n <entry key=\"bodyFormData\"\/>\n <entry key=\"bodyFormat\" value=\"raw\"\/>\n <entry key=\"jsonBody\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"contextUrl\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"curlCommand\"\/>\n <entry key=\"curlEnabled\">\n <value>\n <Boolean><\/Boolean>\n <\/value>\n <\/entry>\n <entry key=\"customAuthUrl\"\/>\n <entry key=\"header\">\n <value>\n <Map>\n <entry key=\"Authentication\" value=\"Bearer $application.customToken$\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"httpMethodType\" value=\"GET\"\/>\n <entry key=\"operationType\" value=\"Test Connection\"\/>\n <entry key=\"paginationSteps\"\/>\n <entry key=\"pagingInitialOffset\">\n <value>\n <Integer>0<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"pagingSize\">\n <value>\n <Integer>50<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"parentEndpointName\"\/>\n <entry key=\"resMappingObj\"\/>\n <entry key=\"responseCode\"\/>\n <entry key=\"rootPath\"\/>\n <entry key=\"sequenceNumberForEndpoint\" value=\"2\"\/>\n <entry key=\"uniqueNameForEndPoint\" value=\"Test Connection\"\/>\n <entry key=\"xpathNamespaces\"\/>\n <\/Map>\n <Map>\n <entry key=\"body\">\n <value>\n <Map>\n <entry key=\"bodyFormData\"\/>\n <entry key=\"bodyFormat\" value=\"raw\"\/>\n <entry key=\"jsonBody\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"contextUrl\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"curlCommand\"\/>\n <entry key=\"curlEnabled\">\n <value>\n <Boolean><\/Boolean>\n <\/value>\n <\/entry>\n <entry key=\"customAuthUrl\"\/>\n <entry key=\"header\">\n <value>\n <Map>\n <entry key=\"Authorization\" value=\"Bearer $application.customToken$\"\/>\n <\/Map>\n <\/value>\n <\/entry>\n <entry key=\"httpMethodType\" value=\"GET\"\/>\n <entry key=\"operationType\" value=\"Account Aggregation\"\/>\n <entry key=\"paginationSteps\"\/>\n <entry key=\"pagingInitialOffset\">\n <value>\n <Integer>0<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"pagingSize\">\n <value>\n <Integer>50<\/Integer>\n <\/value>\n <\/entry>\n <entry key=\"parentEndpointName\"\/>\n <entry key=\"resMappingObj\">\n <value>\n <Map>\n <entry key=\"_modified_at\" value=\"_modified_at\"\/>\n <entry key=\"active\" value=\"active\"\/>\n <entry key=\"business_phone\" value=\"business_phone\"\/>\n <entry key=\"city\" value=\"city\"\/>\n <entry key=\"country\" value=\"country\"\/>\n <entry key=\"defaults\" value=\"defaults\"\/>\n <entry key=\"email\" value=\"email\"\/>\n <entry key=\"fax\" value=\"fax\"\/>\n <entry key=\"first_name\" value=\"first_name\"\/>\n <entry key=\"foreign_id\" value=\"foreign_id\"\/>\n <entry key=\"home_phone\" value=\"home_phone\"\/>\n <entry key=\"home_supplier\" value=\"home_supplier\"\/>\n <entry key=\"id\" value=\"id\"\/>\n <entry key=\"is_ldap_user\" value=\"is_ldap_user\"\/>\n <entry key=\"is_sso_user\" value=\"is_sso_user\"\/>\n <entry key=\"last_name\" value=\"last_name\"\/>\n <entry key=\"locale\" value=\"locale\"\/>\n <entry key=\"middle_name\" value=\"middle_name\"\/>\n <entry key=\"mobile_phone\" value=\"mobile_phone\"\/>\n <entry key=\"modified_by\" value=\"modified_by\"\/>\n <entry key=\"node_name\" value=\"node_name\"\/>\n <entry key=\"postal_code\" value=\"postal_code\"\/>\n <entry key=\"p...","pipeline":"1266","@timestamp":"2024-04-10T14:26:52.744Z","NativeIdentity":"REMOVED_FOR_FORUM_POST","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","Application":"REMOVED_FOR_FORUM_POST","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","Operation":"Create","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"ConnectorProxy.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":2475,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.WebServicesConnector","mantis-client":"1400","class":"sailpoint.connector.ConnectorProxy","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"943","source_host":"REMOVED_FOR_FORUM_POST","method":"logMe","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"Dumping Provisioning Plan details : <?xml version='1.0' encoding='UTF-8'?>\n<!DOCTYPE ProvisioningPlan PUBLIC \"sailpoint.dtd\" \"sailpoint.dtd\">\n<ProvisioningPlan nativeIdentity=\"REMOVED_FOR_FORUM_POST\">\n <AccountRequest application=\"REMOVED_FOR_FORUM_POST\" op=\"Create\">\n <AttributeRequest name=\"groups\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"node_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"user_id\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"first_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"last_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"email\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"active\" op=\"Add\" value=\"true\"\/>\n <\/AccountRequest>\n <Attributes>\n <Map>\n <entry key=\"accessRequestType\" value=\"GRANT_ACCESS\"\/>\n <entry key=\"identityRequestId\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"requester\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"source\" value=\"LCM\"\/>\n <\/Map>\n <\/Attributes>\n<\/ProvisioningPlan>\n","pipeline":"1266","@timestamp":"2024-04-10T14:26:52.745Z","NativeIdentity":"REMOVED_FOR_FORUM_POST","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","Application":"REMOVED_FOR_FORUM_POST","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"ConnectorProxy.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":2475,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.WebServicesConnector","mantis-client":"1400","class":"sailpoint.connector.ConnectorProxy","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"2752","source_host":"REMOVED_FOR_FORUM_POST","method":"logMe","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"Provisioning plan in return : <?xml version='1.0' encoding='UTF-8'?>\n<!DOCTYPE ProvisioningPlan PUBLIC \"sailpoint.dtd\" \"sailpoint.dtd\">\n<ProvisioningPlan nativeIdentity=\"REMOVED_FOR_FORUM_POST\">\n <AccountRequest application=\"***** [source]\" op=\"Create\">\n <AttributeRequest name=\"groups\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\">\n <ProvisioningResult status=\"committed\"\/>\n <\/AttributeRequest>\n <AttributeRequest name=\"node_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"user_id\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"first_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"last_name\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"email\" op=\"Add\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <AttributeRequest name=\"active\" op=\"Add\" value=\"*****\"\/>\n <ProvisioningResult status=\"committed\"\/>\n <\/AccountRequest>\n <Attributes>\n <Map>\n <entry key=\"accessRequestType\" value=\"GRANT_ACCESS\"\/>\n <entry key=\"identityRequestId\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"requester\" value=\"REMOVED_FOR_FORUM_POST\"\/>\n <entry key=\"source\" value=\"LCM\"\/>\n <\/Map>\n <\/Attributes>\n<\/ProvisioningPlan>\n","pipeline":"1266","@timestamp":"2024-04-10T14:26:54.554Z","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"ConnectorProxy.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":2475,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.WebServicesConnector","mantis-client":"1400","class":"sailpoint.connector.ConnectorProxy","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"2753","source_host":"REMOVED_FOR_FORUM_POST","method":"logMe","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"result after method exit : <?xml version='1.0' encoding='UTF-8'?>\n<!DOCTYPE ProvisioningResult PUBLIC \"sailpoint.dtd\" \"sailpoint.dtd\">\n<ProvisioningResult status=\"committed\"\/>\n","pipeline":"1266","@timestamp":"2024-04-10T14:26:54.554Z","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","Operation":"Create","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"ExecutionMediator.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":613,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"connector.sdk.webservices.ExecutionMediator","mantis-client":"1400","class":"connector.sdk.webservices.ExecutionMediator","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"985","source_host":"REMOVED_FOR_FORUM_POST","method":"processEndpoint","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"==> Dumping request for troubleshooting purposes: HttpRequestWrapper [url=*****\/users, headers={Authorization=Bearer *****, Content-Type=application\/json}, payload={\"node_name\":\"REMOVED_FOR_FORUM_POST\",\"active\":*****,\"email\":\"REMOVED_FOR_FORUM_POST\",\"first_name\":\"REMOVED_FOR_FORUM_POST\",\"last_name\":\"REMOVED_FOR_FORUM_POST\",\"user_id\":\"REMOVED_FOR_FORUM_POST\"}, type=POST, allowedSuccessCodes=[2**], possibleHttpErrorCodes=[401], possibleHttpErrorMessages=[The client session has expired or is invalid.]]","pipeline":"1266","@timestamp":"2024-04-10T14:26:52.787Z","NativeIdentity":"REMOVED_FOR_FORUM_POST","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","Application":"REMOVED_FOR_FORUM_POST","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","Operation":"Create","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"AbstractHttpRequestBuilder.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":339,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.v2.AbstractHttpRequestBuilder","mantis-client":"1400","class":"sailpoint.connector.webservices.v2.AbstractHttpRequestBuilder","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"973","source_host":"REMOVED_FOR_FORUM_POST","method":"prepareRawBody","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"Value for placeholder ''plan.business_phone'' is empty. Skipping...","pipeline":"1266","@timestamp":"2024-04-10T14:26:52.775Z","NativeIdentity":"REMOVED_FOR_FORUM_POST","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","Application":"REMOVED_FOR_FORUM_POST","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
{"stack":"ccg","pod":"cook","connector-logging":"150","Operation":"Create","clusterId":"1219","buildNumber":"962","apiUsername":"REMOVED_FOR_FORUM_POST","orgType":"","file":"JsonRequestBuilder.java","encryption":"1266","messageType":"provision","connector-bundle-identityiq":"213","line_number":157,"@version":1,"CB_version":"1188","cloud-modules-api":"1477","logger_name":"sailpoint.connector.webservices.v2.JsonRequestBuilder","mantis-client":"1400","class":"sailpoint.connector.webservices.v2.JsonRequestBuilder","ParentOperation":"ProvisioningOperation","atlas-api":"1823","va-gateway-client":"46","tracing":"1400","clientId":"REMOVED_FOR_FORUM_POST","request_milliseconds":"974","source_host":"REMOVED_FOR_FORUM_POST","method":"removePlaceholdersFromJson","org":"vsp-sb","level":"DEBUG","IdentityIQ":"8.3p4 Build 1527a593753-20230805-223436","message":"Removing entry value null from request body for placeholder key: $plan.home_phone$","pipeline":"1266","@timestamp":"2024-04-10T14:26:52.776Z","NativeIdentity":"REMOVED_FOR_FORUM_POST","thread_name":"pool-4-thread-94","atlas-util":"1823","metrics":"1266","region":"us-east-1","AppType":"Web Services","Application":"REMOVED_FOR_FORUM_POST","request_id":"REMOVED_FOR_FORUM_POST","CB_Type":"connector-bundle-webservices","queue":"cook-vsp-sb-cluster-1219","SCIM Common":"8.0 Build 00b1f252d1b-20200225-190809"}
Thank you,
- Zach