summaryrefslogtreecommitdiffstats
path: root/vespa-osgi-testrunner/src/main/java/com/yahoo/vespa/testrunner/VespaJunitLogListener.java
blob: 90a5775f8c211fc75a0d3d721471941d0cbe84ca (plain) (blame)
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
// Copyright Yahoo. Licensed under the terms of the Apache 2.0 license. See LICENSE in the project root.

package com.yahoo.vespa.testrunner;

import ai.vespa.hosted.cd.InconclusiveTestException;
import org.junit.platform.engine.TestExecutionResult;
import org.junit.platform.engine.reporting.ReportEntry;
import org.junit.platform.launcher.TestExecutionListener;
import org.junit.platform.launcher.TestIdentifier;

import java.time.ZoneOffset;
import java.util.ArrayList;
import java.util.HashMap;
import java.util.List;
import java.util.Map;
import java.util.NavigableMap;
import java.util.Set;
import java.util.concurrent.ConcurrentSkipListMap;
import java.util.concurrent.CopyOnWriteArrayList;
import java.util.function.Consumer;
import java.util.logging.Level;
import java.util.logging.LogRecord;

import static java.util.Collections.emptyNavigableMap;
import static java.util.Objects.requireNonNull;
import static java.util.logging.Level.INFO;
import static java.util.logging.Level.SEVERE;
import static java.util.logging.Level.WARNING;
import static java.util.stream.Collectors.joining;

class VespaJunitLogListener implements TestExecutionListener {

    private final Map<String, NavigableMap<Status, List<String>>> results = new ConcurrentSkipListMap<>();
    private final Consumer<LogRecord> logger;

    VespaJunitLogListener(Consumer<LogRecord> logger) {
        this.logger = requireNonNull(logger);
    }

    @Override
    public void dynamicTestRegistered(TestIdentifier testIdentifier) {
        if (testIdentifier.isContainer() && testIdentifier.getParentId().isPresent()) // Skip root engine level.
            log(INFO, "Registered dynamic container: " + testIdentifier.getDisplayName());
        if (testIdentifier.isTest())
            log(INFO, "Registered dynamic test: " + testIdentifier.getDisplayName());
    }

    @Override
    public void executionStarted(TestIdentifier testIdentifier) {
        if (testIdentifier.isContainer() && testIdentifier.getParentId().isPresent()) // Skip root engine level.
            log(INFO, "Running all tests in: " + testIdentifier.getDisplayName());
        if (testIdentifier.isTest())
            log(INFO, "Running test: " + testIdentifier.getDisplayName());
    }

    @Override
    public void executionSkipped(TestIdentifier testIdentifier, String reason) {
        log(WARNING, "Skipped: " +  testIdentifier.getDisplayName() + ": " +  reason);
        if (testIdentifier.isTest())
            testIdentifier.getParentId().ifPresent(parent -> {
                results.computeIfAbsent(parent, __ -> new ConcurrentSkipListMap<>())
                       .computeIfAbsent(Status.skipped, __ -> new CopyOnWriteArrayList<>())
                       .add(testIdentifier.getDisplayName());
            });
    }

    @Override
    public void executionFinished(TestIdentifier testIdentifier, TestExecutionResult testExecutionResult) {
        if (testIdentifier.isContainer()) {
            if (testIdentifier.getParentIdObject().isPresent()) {
                NavigableMap<Status, List<String>> children = results.getOrDefault(testIdentifier.getUniqueId(), emptyNavigableMap());
                Level level = children.containsKey(Status.failed) ? SEVERE : INFO;
                log(level,
                    "Tests in " + testIdentifier.getDisplayName() + " done: " +
                    children.entrySet().stream().map(entry -> entry.getValue().size() + " " + entry.getKey()).collect(joining(", ")));
            }
            else {
                Map<Status, List<String>> testResults = new HashMap<>();
                results.forEach((parent, results) -> results.forEach((status, tests) -> tests.forEach(test -> testResults.computeIfAbsent(status, __ -> new ArrayList<>())
                                                                                                                         .add(parent + "." + test))));
                log(INFO, "Done running " + testResults.values().stream().mapToInt(List::size).sum() + " tests:");
                testResults.forEach((status, tests) -> {
                    if (status != Status.successful)
                        log(status == Status.failed ? SEVERE : status == Status.inconclusive ? INFO : WARNING,
                            status.name().substring(0, 1).toUpperCase() + status.name().substring(1) + " tests:\n" + String.join("\n", tests));
                });
            }
        }
        if (testIdentifier.isTest()) {
            Level level;
            Status status;
            if (testExecutionResult.getThrowable().map(InconclusiveTestException.class::isInstance).orElse(false)) {
                level = INFO;
                 status = Status.inconclusive;
            }
            else {
                switch (testExecutionResult.getStatus()) {
                    case SUCCESSFUL: level = INFO;    status = Status.successful; break;
                    case ABORTED:    level = WARNING; status = Status.aborted;    break;
                    case FAILED:
                    default:         level = SEVERE;  status = Status.failed;     break;
                }
            }
            testIdentifier.getParentId().ifPresent(parent -> {
                results.computeIfAbsent(parent, __ -> new ConcurrentSkipListMap<>())
                       .computeIfAbsent(status, __ -> new CopyOnWriteArrayList<>())
                       .add(testIdentifier.getDisplayName());
            });
            log(level, "Test " + status + ": " + testIdentifier.getDisplayName(), testExecutionResult.getThrowable().orElse(null));
        }
    }

    @Override
    public void reportingEntryPublished(TestIdentifier testIdentifier, ReportEntry report) {
        String message = report.getKeyValuePairs().keySet().equals(Set.of("value"))
                ? report.getKeyValuePairs().get("value")
                : report.getKeyValuePairs().entrySet().stream()
                        .map(entry -> entry.getKey() + ": " + entry.getValue())
                        .collect(joining("\n"));
        LogRecord record = new LogRecord(INFO, message);
        record.setInstant(report.getTimestamp().toInstant(ZoneOffset.UTC));
        logger.accept(record);
    }

    private void log(Level level, String message) {
        log(level, message, null);
    }

    private void log(Level level, String message, Throwable thrown) {
        LogRecord record = new LogRecord(level, message);
        record.setThrown(thrown);
        logger.accept(record);
    }

    private enum Status {

        successful,
        inconclusive,
        failed,
        aborted,
        skipped;

    }

}