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

Closed a6pakaga6pa closed 1 year ago

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

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

@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 **8**10ea24 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...`

@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.

Abandoned

reportportal / logger-java-rest-assured

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