ERROR LaunchLoggingCallback : [26] ReportPortal execution error with logger-java-rest-assured

[a6pakaga6pa]

Describe the bug

We try to use logger-java-rest-assured library to log request/response logs to Report Portal, that runs in AWS. So, we need for logs to be present after pipelines run in GitLab. Without that library all works good, we have connection and reports we need, we see logs, but, obviously, not Rest-Assured requests/responses.

When we add logger-java-rest-assured, locally, all works fine. I mean, that we have connection with Report Portal instance, we have reports, logs (with all Rest-Assured request/response) and even log filter is working.

But, if we run same build on the pipelines, we got this:

14:06:35.721 [rp-io-1] ERROR LaunchLoggingCallback : [26] ReportPortal execution error [223](https://gitlab.****/dev/services/****/-/jobs/3497256#L223) retrofit2.adapter.rxjava2.HttpException: HTTP 401 [224](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L224) at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:57) [225](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L225) at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:38) [226](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L226) at retrofit2.adapter.rxjava2.CallExecuteObservable.subscribeActual(CallExecuteObservable.java:48) [227](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L227) at io.reactivex.Observable.subscribe(Observable.java:12267) [228](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L228) at retrofit2.adapter.rxjava2.BodyObservable.subscribeActual(BodyObservable.java:35) [229](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L229) at io.reactivex.Observable.subscribe(Observable.java:12267) [230](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L230) at io.reactivex.internal.operators.observable.ObservableSubscribeOn$SubscribeTask.run(ObservableSubscribeOn.java:96) [231](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L231) at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:38) [232](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L232) at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:26) [233](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L233) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [234](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L234) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [235](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L235) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [236](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L236) at java.base/java.lang.Thread.run(Thread.java:829) [237](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L237) 14:06:35.723 [rp-io-1] ERROR LaunchLoggingCallback : [26] ReportPortal execution error [238](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L238) retrofit2.adapter.rxjava2.HttpException: HTTP 401 [239](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L239) at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:57) [240](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L240) at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:38) [241](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L241) at retrofit2.adapter.rxjava2.CallExecuteObservable.subscribeActual(CallExecuteObservable.java:48) [242](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L242) at io.reactivex.Observable.subscribe(Observable.java:12267) [243](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L243) at retrofit2.adapter.rxjava2.BodyObservable.subscribeActual(BodyObservable.java:35) [244](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L244) at io.reactivex.Observable.subscribe(Observable.java:12267) [245](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L245) at io.reactivex.internal.operators.observable.ObservableSubscribeOn$SubscribeTask.run(ObservableSubscribeOn.java:96) [246](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L246) at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:38) [247](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L247) at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:26) [248](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L248) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [249](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L249) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [250](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L250) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [251](https://gitlab.****.systems/dev/services/****/-/jobs/3497256#L251) at java.base/java.lang.Thread.run(Thread.java:829)

As a result - no connection to Report Portal. We can't find out the reason of that 401 error and how we can fix it.
Here are what related dependencies we have in build.gradle:

compile group: 'io.rest-assured', name: 'rest-assured', version: '5.1.1' 
compile group: 'com.epam.reportportal', name: 'client-java', version: '5.1.10'
compile group: 'com.epam.reportportal', name: 'agent-java-testng', version: '5.1.0'
compile group: 'com.epam.reportportal', name: 'logger-java-log4j', version: '5.1.4'
compile group: 'com.epam.reportportal', name: 'logger-java-logback', version: '5.1.2'
compile group: 'com.google.guava', name: 'guava', version: '29.0-jre'
testCompile 'com.epam.reportportal:logger-java-rest-assured:5.2.1'
testCompile group: 'org.testng', name: 'testng', version: '7.3.0'
implementation group: 'org.apache.groovy', name: 'groovy', version: '4.0.1'

here is a listener in regression.xml:

<listeners>
        <listener class-name="com.epam.reportportal.testng.ReportPortalTestNGListener"/>
 </listeners>

Here is a webhook:

@BeforeSuite
	public void baseTestStart() {

		log.info("This is the BaseTest BeforeSuite...");
		

		// add filters to log Rest Assured calls and ignore some of them
        RestAssured.filters(new ReportPortalRestAssuredLoggingFilter(42, LogLevel.INFO)
                .addRequestFilter(requestSpec -> {
                            var pathValue = getPathValue(requestSpec);
                            return ignoredLogPathList.contains(pathValue);
                        }
                ));

	}

I've tried to "play" with different versions - same result. Locally all is good. On the pipeline job - 401 Response, no connection.

Could you please help to clarify why we got that error? If you need other details, please ask

[HardNorth]

@a6pakaga6pa Could you get the exact response? I think this might be related to server settings.

[a6pakaga6pa]

@HardNorth I'm not sure what exact response you've meant. Alright, here are logs from cmd before the tests itself. In the end you can see two exceptions that I've mentioned above:

`Running with gitlab-runner 14.9.0 (d1f69508)
on dev01-medium-standard-gitlab-runner-759dd96c5c-thfqk _VvsjchU
Resolving secrets
00:00
Preparing the "kubernetes" executor
00:00
Using Kubernetes namespace: gitlab-medium-standard
Using Kubernetes executor with image 357751856777.dkr.ecr.us-east-2.amazonaws.com/soa-ci-runner:359f07be ...
Using attach strategy to execute scripts...
Preparing environment
00:11
Waiting for pod gitlab--standard/runner--project-574-concurrent-to be running, status is Pending
ContainersNotInitialized: "containers with incomplete status: [init-permissions]"
ContainersNotReady: "containers with unready status: [build helper]"
ContainersNotReady: "containers with unready status: [build helper]"
Waiting for pod gitlab--standard/runner--project--concurrent-to be running, status is Pending
ContainersNotInitialized: "containers with incomplete status: [init-permissions]"
ContainersNotReady: "containers with unready status: [build helper]"
ContainersNotReady: "containers with unready status: [build helper]"
Running on runner--project--concurrent-via dev01-medium-standard-gitlab-runner--thfqk...
Getting source from Git repository
00:01
Fetching changes with git depth set to 50...
Initialized empty Git repository in /builds/dev/services//.git/
Created fresh repository.
Checking out 5a778097 as feature/next...
Skipping Git submodules setup
Downloading artifacts
00:00
Downloading artifacts for CDKTF Apply - Dev-Next (3497254)...
Downloading artifacts from coordinator... ok id=3497254 responseStatus=200 OK token=******
Downloading artifacts for Deploy to Dev Inactive (3497255)...
Downloading artifacts from coordinator... ok id=3497255 responseStatus=200 OK token=******
Executing "step_script" stage of the job script
03:43
$ echo "Cloning Pipelines project with branch '$PIPELINES_BRANCH'..." && git clone -b $PIPELINES_BRANCH https://gitlab-ci-token:$PIPELINES_ACCESS_TOKEN@gitlab.******.systems/central-support/pipelines.git && chmod -R 755 pipelines/scripts
Cloning Pipelines project with branch 'stable'...
Cloning into 'pipelines'...
Note: checking out '******6e5d438d5fc9682af1cf08c687f667d'.
You are in 'detached HEAD' state. You can look around, make experimental
changes and commit them, and you can discard any commits you make in this
state without impacting any branches by performing another checkout.
If you want to create a new branch to retain commits you create, you may
do so (now or later) by using -b with the checkout command again. Example:
git checkout -b
$ # checking if autotest folder exist, if not, we're not running anything. # collapsed multi-line command
Checking last commit for ./bamboo-specs ./.dockerignore ./mvnw ./artifact_hash.env ./autotest ./charts ./util ./Dockerfile ./.gitlab-ci.yml ./formatter.xml ./documentation ./.mvn ./.gitignore ./lombok.config ./docker-compose.yml ./pom.xml ./mvnw.cmd ./service_docker_image_tag.env ./src ./pipelines ./README.md
Last commit found 810ea24
Checking previous artifact for job Dev e2e Tests in ref feature/next
https://gitlab.******.systems/api/v4/projects/574/jobs/artifacts/feature/next/raw/artifact_hash.env?job_token=[MASKED]
Checking file artifact_hash.env
Not found artifact_hash.env
Saving... CODE_CHANGE_DETECTED=true to code_change_detected_vars.sh
Running DEV-next test automation...
[MASKED]
DEV
next
https://api.dev.******.systems
https://dev-next.******-config.dev.******.systems
[MASKED]
https://dev-next.******.dev.******.systems
https://gitlab.******.systems/dev/services/******/-/jobs/3497256
user
Downloading https://services.gradle.org/distributions/gradle-6.6.1-bin.zip
.
........10%..........20%..........30%..........
40%.........50%..........60%..........70%....
......80%..........90%.........100%
Welcome to Gradle 6.6.1!
Here are the highlights of this release:

• Experimental build configuration caching
• Built-in conventions for handling credentials
• Java compilation supports --release flag
  For more details see https://docs.gradle.org/6.6.1/release-notes.html
  Starting a Gradle Daemon (subsequent builds will be faster)

Configure project :
Copying file "config.sample" and renaming to "config.yaml"...
Task :clean UP-TO-DATE
Task :copyConfig
Task :copyReportPortal
Copying file "reportportal.properties.sample" and renaming to "reportportal.properties"...
Task :compileJava
Note: /builds/dev/services//autotest/src/main/java/com//autotest/soa//utils/TestListener.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.
Note: /builds/dev/services//autotest/src/main/java/com//autotest/soa//utils/Helper.java uses unchecked or unsafe operations.
Note: Recompile with -Xlint:unchecked for details.
Task :processResources
Task :classes
Task :compileTestJava
/builds/dev/services//autotest/src/test/java/com//autotest/soa/******/service/VisitRequestResourceTest.java:229: error: unmappable character (0xE2) for encoding US-ASCII

Task :processTestResources
Task :testClasses
Task :testServiceRegression
Gradle Test Executor 1 STANDARD_OUT
14:06:33,817 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
14:06:33,817 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/builds/dev/services//autotest/build/resources/main/logback.xml]
14:06:33,817 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath.
14:06:33,817 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..autotest.soa./-automation/2.0.6-20221018.095304-11/b160de16e92550e813b6562c4a3ef8ebd9c7684c/-automation-2.0.6-20221018.095304-11.jar!/logback.xml]
14:06:33,817 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/builds/dev/services//autotest/build/resources/main/logback.xml]
14:06:33,817 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..autotest.soa./-automation/2.2.12-SNAPSHOT/5afb788a434e9b880efaf1e522d65d8b86c58106/-automation-2.2.12-SNAPSHOT.jar!/logback.xml]
14:06:33,817 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..autotest.soa./-automation/2.0.10-20221007.091303-2/cc720d823d4bc27117460a0448d64bc076f0a437/-automation-2.0.10-20221007.091303-2.jar!/logback.xml]
14:06:33,836 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
14:06:33,837 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [com.epam.reportportal.logback.appender.ReportPortalAppender]
14:06:33,842 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ReportPortalAppender]
14:06:33,845 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
14:06:33,857 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
14:06:33,858 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
14:06:33,859 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
14:06:33,861 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com..autotest..] to INFO
14:06:33,861 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [io.restassured.internal] to INFO
14:06:33,861 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com..autotest...utils] to INFO
14:06:33,861 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com..autotest.soa..utils] to INFO
14:06:33,861 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com..autotest..] to INFO
14:06:33,862 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.epam.reportportal] to INFO
14:06:33,862 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.http] to WARN
14:06:33,862 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [ca.uhn.fhir] to INFO
14:06:33,862 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [ca.uhn.fhir] to false
14:06:33,862 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
14:06:33,862 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ReportPortalAppender] to Logger[ROOT]
14:06:33,862 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
14:06:33,863 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@3ab8a791 - Registering current configuration as safe fallback point
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by retrofit2.Platform (file:/root/.gradle/caches/modules-2/files-2.1/com.squareup.retrofit2/retrofit/2.9.0/d8fdfbd5da952141a665a403348b74538efc05ff/retrofit-2.9.0.jar) to constructor java.lang.invoke.MethodHandles$Lookup(java.lang.Class,int)
WARNING: Please consider reporting this to the maintainers of retrofit2.Platform
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
14:06:34.178 [Test worker] WARN AutomationBase : .env file was not found. Exception msg: Could not find /.env on the classpath
14:06:34.282 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/test_data/DataProviderService.class]
14:06:34.283 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/auth/AuthService.class]
14:06:34.285 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/config/ModuleService.class]
14:06:34.291 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/core/AutomationBase.class]
14:06:34.292 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/core/RestAssuredConfig.class]
14:06:34.293 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/core/Properties.class]
14:06:34.294 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/reporter/ReportingService.class]
14:06:34.301 [Test worker] DEBUG AbstractApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@5c42ee2d
14:06:34.315 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor'
14:06:34.338 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/test_data/DataProviderService.class]
14:06:34.338 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/auth/AuthService.class]
14:06:34.339 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/config/ModuleService.class]
14:06:34.339 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/core/RestAssuredConfig.class]
14:06:34.339 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/core/Properties.class]
14:06:34.339 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/reporter/ReportingService.class]
14:06:34.360 [Test worker] DEBUG YamlProcessor : Loading from YAML: class path resource [automation.yml]
14:06:34.372 [Test worker] DEBUG YamlProcessor : Merging document (no matchers set): {zephyr={api={accessKey=${Z_API_ACCESSKEY}, secretKey=${Z_API_SECRETKEY}, accountId=${Z_API_ACCOUNTID}}, keys={versionName=Automation Reports}, cycleCustomName=VRP, projectKey=VRPS}, jira={api={username=${J_API_USERNAME}, token=${J_API_TOKEN}}}, testng={retryDefault=2}}
14:06:34.373 [Test worker] DEBUG YamlProcessor : Loaded 1 document from YAML resource: class path resource [automation.yml]
14:06:34.428 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'org.springframework.context.event.internalEventListenerProcessor'
14:06:34.429 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'org.springframework.context.event.internalEventListenerFactory'
14:06:34.431 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor'
14:06:34.432 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor'
14:06:34.438 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'dataProviderService'
14:06:34.450 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'moduleService'
14:06:34.452 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'authService'
14:06:34.453 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'automationBase'
14:06:34.455 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'restAssuredConfig'
14:06:34.702 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'reportingService'
14:06:34.709 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Identified candidate component class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/reporting-zephyr/1.2-SNAPSHOT/2e7c621a90048d028012b042ae643a8fc3da3f6e/reporting-zephyr-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/reporting/zephyr/ZephyrClient.class]
14:06:34.721 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Ignored because not a concrete top-level class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/reporter/IReporter.class]
14:06:34.725 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.api.accessKey' in PropertySource 'automation.yml' with value of type String
14:06:34.725 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'Z_API_ACCESSKEY' in PropertySource 'systemEnvironment' with value of type String
14:06:34.725 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.api.secretKey' in PropertySource 'automation.yml' with value of type String
14:06:34.726 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'Z_API_SECRETKEY' in PropertySource 'systemEnvironment' with value of type String
14:06:34.726 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.api.accountId' in PropertySource 'automation.yml' with value of type String
14:06:34.726 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'Z_API_ACCOUNTID' in PropertySource 'systemEnvironment' with value of type String
14:06:34.727 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.keys.versionName' in PropertySource 'automation.yml' with value of type String
14:06:34.727 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'jira.api.username' in PropertySource 'automation.yml' with value of type String
14:06:34.727 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'J_API_USERNAME' in PropertySource 'systemEnvironment' with value of type String
14:06:34.728 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'jira.api.token' in PropertySource 'automation.yml' with value of type String
14:06:34.728 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'J_API_TOKEN' in PropertySource 'systemEnvironment' with value of type String
14:06:34.729 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.cycleCustomName' in PropertySource 'automation.yml' with value of type String
14:06:34.729 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'zephyr.projectKey' in PropertySource 'automation.yml' with value of type String
14:06:34.730 [Test worker] DEBUG DefaultSingletonBeanRegistry : Creating shared instance of singleton bean 'properties'
14:06:34.744 [Test worker] DEBUG ReportingService : Initializing reporter: class com..qaautomation.apiframework.reporting.zephyr.ZephyrClient
14:06:35.322 [Test worker] DEBUG ClassPathScanningCandidateComponentProvider: Ignored because not a concrete top-level class: URL [jar:file:/root/.gradle/caches/modules-2/files-2.1/com..qaautomation.apiframework/core/1.2-SNAPSHOT/56d934e18fe7f27018e1a0ea6b32f0d216f7a21d/core-1.2-SNAPSHOT.jar!/com//qaautomation/apiframework/config/Module.class]
14:06:35.433 [Test worker] INFO LaunchImpl : Rerun: false
...
... TestNG 7.3.0 by C??dric Beust (cedric@beust.com)
...
14:06:35.541 [Test worker] DEBUG PropertySourcesPropertyResolver: Found key 'testng.retryDefault' in PropertySource 'automation.yml' with value of type Integer
14:06:35.721 [rp-io-1] ERROR LaunchLoggingCallback : [26] ReportPortal execution error
retrofit2.adapter.rxjava2.HttpException: HTTP 401
at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:57)
at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:38)
at retrofit2.adapter.rxjava2.CallExecuteObservable.subscribeActual(CallExecuteObservable.java:48)
at io.reactivex.Observable.subscribe(Observable.java:12267)
at retrofit2.adapter.rxjava2.BodyObservable.subscribeActual(BodyObservable.java:35)
at io.reactivex.Observable.subscribe(Observable.java:12267)
at io.reactivex.internal.operators.observable.ObservableSubscribeOn$SubscribeTask.run(ObservableSubscribeOn.java:96)
at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:38)
at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:26)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
14:06:35.723 [rp-io-1] ERROR LaunchLoggingCallback : [26] ReportPortal execution error
retrofit2.adapter.rxjava2.HttpException: HTTP 401
at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:57)
at retrofit2.adapter.rxjava2.BodyObservable$BodyObserver.onNext(BodyObservable.java:38)
at retrofit2.adapter.rxjava2.CallExecuteObservable.subscribeActual(CallExecuteObservable.java:48)
at io.reactivex.Observable.subscribe(Observable.java:12267)
at retrofit2.adapter.rxjava2.BodyObservable.subscribeActual(BodyObservable.java:35)
at io.reactivex.Observable.subscribe(Observable.java:12267)
at io.reactivex.internal.operators.observable.ObservableSubscribeOn$SubscribeTask.run(ObservableSubscribeOn.java:96)
at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:38)
at io.reactivex.internal.schedulers.ScheduledDirectTask.call(ScheduledDirectTask.java:26)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
Regression_Suite STANDARD_OUT
14:06:36.865
[Test worker] INFO BaseTest : This is the BaseTest BeforeSuite...`

[HardNorth]

@a6pakaga6pa Well, actually there is no any connection between rest-assured logger and your 401 error. I can only guess, that the logger requires client-java library of version 5.1.11, where the logging flow was updated, so that you start seeing what you didn't see already.

And you are using rather old version of TestNG agent, I would recommend an update.

[HardNorth]

Abandoned