search

MarathonLabs / marathon

Cross-platform test runner
https://docs.marathonlabs.io
GNU General Public License v2.0
584 stars 122 forks source link

Uncomplete tests with screenshot method on Emulator API 31 #725

Closed swtmrs closed 1 year ago

swtmrs commented 1 year ago

Describe the bug When running tests on an API 31 emulator that use screenshot method (UiAutomator.takeScreenshot()), test is set to "incomplete" at the time screenshot is taken and starts retrying. If remove screenshot method from test body, then test will pass successfully. When running tests locally from AS or running tests with Marathon on emulators with API 29 or API 30, tests pass. Bug is reproduced when running test from samples - MainActivityAllureTest.kt -> testText()

To Reproduce Steps to reproduce the behaviour:

  1. Full configuration I slightly edited Marathonfile to run test that calls allureScreenshot() by adding LargeTest annotation to test. 
    name: "sample-app tests"
outputDir: "build/reports/marathon"
isCodeCoverageEnabled: true
#analyticsConfiguration:
#  type: "influxdb"
#  url: "http://192.168.2.2:8086"
#  dbName: "marathon-5522"
#  user: "admin"
#  password: "xxxxx"
#  type: "influxdb2"
#  url: "http://192.168.2.2:3001"
#  token: "super-secret-token"
#  organization: "home"
#  bucket: "marathon"
#flakinessStrategy:
#  type: "probability"
#  minSuccessRate: 0.99
#  maxCount: 3
#  timeLimit: "-PT1H"
screenRecordingPolicy: "ON_ANY"
filteringConfiguration:
allowlist:
  - type: "annotation"
    values:
        - "androidx.test.filters.LargeTest"
vendorConfiguration:
type: "Android"
applicationApk: "app/build/outputs/apk/debug/app-debug.apk"
testApplicationApk: "app/build/outputs/apk/androidTest/debug/app-debug-androidTest.apk"
disableWindowAnimation: false
autoGrantPermission: true
screenRecordConfiguration:
preferableRecorderType: "screenshot"
instrumentationArgs:
debug: "false"
applicationPmClear: true
testApplicationPmClear: true
waitForDevicesTimeoutMillis: 60000
# See https://marathonlabs.github.io/marathon/ven/android.html#test-parser before copy-pasting this
fileSyncConfiguration:
pull:
- relativePath: "files/allure-results"
  pathRoot: APP_DATA
  aggregationMode: TEST_RUN
push:
- path: "fixtures/external-file"
- path: "fixtures/external-folder"
allureConfiguration:
enabled: true
# See https://marathonlabs.github.io/marathon/ven/android.html#test-access-configuration before copy-pasting this
testAccessConfiguration:
adb: true
grpc: true
console: true
deviceInitializationTimeoutMillis: 180000
uncompletedTestRetryQuota: 3
debug: true
  2. Emulator config 
    AvdId = Pixel_4_API_31
PlayStore.enabled = true
abi.type = x86_64
avd.ini.displayname = Pixel 4 API 31
avd.ini.encoding = UTF-8
disk.dataPartition.size = 6442450944
fastboot.chosenSnapshotFile = 
fastboot.forceChosenSnapshotBoot = no
fastboot.forceColdBoot = no
fastboot.forceFastBoot = yes
hw.accelerometer = yes
hw.arc = false
hw.audioInput = yes
hw.battery = yes
hw.camera.back = virtualscene
hw.camera.front = emulated
hw.cpu.arch = x86_64
hw.cpu.ncore = 4
hw.dPad = no
hw.device.hash2 = MD5:6b5943207fe196d842659d2e43022e20
hw.device.manufacturer = Google
hw.device.name = pixel_4
hw.gps = yes
hw.gpu.enabled = yes
hw.gpu.mode = auto
hw.initialOrientation = Portrait
hw.keyboard = yes
hw.lcd.density = 440
hw.lcd.height = 2280
hw.lcd.width = 1080
hw.mainKeys = no
hw.ramSize = 1536
hw.sdCard = yes
hw.sensors.orientation = yes
hw.sensors.proximity = yes
hw.trackBall = no
image.sysdir.1 = system-images/android-31/google_apis_playstore/x86_64/
runtime.network.latency = none
runtime.network.speed = full
sdcard.size = 512M
showDeviceFrame = no
skin.dynamic = yes
skin.name = 1080x2280
skin.path = _no_skin
tag.display = Google Play
tag.id = google_apis_playstore
vm.heapSize = 256

Logs and reports

10:14:48.949 [main] INFO  c.m.marathon.cli.ApplicationView - Starting marathon v0.7.6
10:14:49.070 [main] INFO  c.m.m.e.BugsnagExceptionsReporter - Init BugSnag
10:14:49.070 [main] INFO  c.m.marathon.cli.ApplicationView - Checking Marathonfile config
I 10:14:49.895 [main @coroutine#1] <com.malinskiy.marathon.Marathon> System Information:
I 10:14:49.896 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.specification.version: 17
I 10:14:49.896 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.class.path: /usr/local/Cellar/marathon/0.7.6/libexec/lib/cli-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/vendor-ios-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/ddmlib-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/adam-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/base-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/core-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/usage-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/configuration-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/html-report-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/execution-timeline-0.7.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/ddmlib-30.0.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/common-30.0.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/adam-0.4.5.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-logging-jvm-2.1.23.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/koin-core-jvm-3.2.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/influxdb-java-2.23.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/influxdb-client-java-6.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/influxdb-client-core-6.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/logging-interceptor-4.10.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/vertx-lang-kotlin-4.2.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/vertx-lang-kotlin-coroutines-4.2.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/parser-2.3.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/clikt-jvm-3.1.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-kotlin-stub-1.2.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlinx-coroutines-core-jvm-1.6.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/converter-moshi-2.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/converter-scalars-2.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/converter-gson-2.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/retrofit-2.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/okhttp-4.10.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-okhttp-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/okhttp-2.7.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/okio-jvm-3.2.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-stdlib-jdk8-1.5.21.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-kotlin-commons-2.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/bugsnag-3.6.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-dataformat-yaml-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-datatype-jsr310-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-databind-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-annotations-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/vertx-core-4.2.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-core-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jackson-module-kotlin-2.13.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-reflect-1.5.21.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/logback-classic-1.2.11.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-argparser-2.0.7.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-test-filter-2.18.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-environment-writer-1.0.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-testng-2.8.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-descriptions-javadoc-2.8.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-java-commons-2.19.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-core-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/gson-2.9.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/rsync4j-all-3.2.3-10.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/rsync4j-windows32-3.2.3-10.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/rsync4j-windows64-3.2.3-10.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/rsync4j-core-3.2.3-10.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-io-2.11.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/dd-plist-1.24.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/axmlparser-1.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-protobuf-lite-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-stub-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-api-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/guava-31.1-jre.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/sshj-0.34.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jansi-2.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/imgscalr-lib-4.2.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/android-testrunner-contract-0.4.5.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/google-analytics-java-2.0.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-stdlib-jdk7-1.5.21.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/xenocom-0.0.7.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-kotlin-model-2.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlinx-serialization-json-jvm-1.2.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlinx-serialization-core-jvm-1.2.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-stdlib-1.5.21.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/logback-core-1.2.11.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/asn-one-0.6.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jcl-over-slf4j-1.7.25.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/slf4j-api-1.7.36.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-text-1.9.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/allure-model-2.19.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/testng-6.14.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/msgpack-core-0.9.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/rxjava-3.1.5.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/adapter-rxjava3-2.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/gson-fire-1.8.5.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/influxdb-client-utils-6.4.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jsr305-3.0.2.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/failureaccess-1.0.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/listenablefuture-9999.0-empty-to-avoid-conflict-with-guava.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/checker-qual-3.12.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/error_prone_annotations-2.11.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/j2objc-annotations-1.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/bcpkix-jdk15on-1.70.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/bcutil-jdk15on-1.70.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/bcprov-jdk15on-1.70.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jzlib-1.1.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/eddsa-0.3.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/snakeyaml-1.30.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-lang3-3.11.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/annotations-30.0.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kxml2-2.3.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/protobuf-java-3.10.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/annotations-23.0.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/javax.annotation-api-1.3.2.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-pool2-2.11.1.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/protobuf-javalite-3.19.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/httpclient-4.5.3.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/kotlin-stdlib-common-1.5.21.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/jcommander-1.72.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/bsh-2.0b6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/moshi-1.8.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-csv-1.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/reactive-streams-1.0.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-lang-2.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/argparse4j-0.9.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/processoutput4j-0.0.11.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-handler-proxy-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-codec-http2-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-codec-http-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-resolver-dns-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-handler-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-codec-socks-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-codec-dns-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-codec-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-transport-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-buffer-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-resolver-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-common-4.1.73.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/perfmark-api-0.23.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/httpcore-4.4.6.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/commons-codec-1.9.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/netty-tcnative-classes-2.0.46.Final.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/grpc-context-1.44.0.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/annotations-4.1.1.4.jar:/usr/local/Cellar/marathon/0.7.6/libexec/lib/animal-sniffer-annotations-1.19.jar
I 10:14:49.909 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.vendor: Homebrew
I 10:14:49.909 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vendor.url: https://github.com/Homebrew/homebrew-core/issues
I 10:14:49.909 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.specification.version: 17
I 10:14:49.909 [main @coroutine#1] <com.malinskiy.marathon.Marathon> os.name: Mac OS X
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.specification.vendor: Oracle Corporation
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.version.date: 2021-10-19
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.home: /usr/local/Cellar/openjdk/17.0.1_1/libexec/openjdk.jdk/Contents/Home
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.compressedOopsMode: Zero based
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.specification.vendor: Oracle Corporation
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.specification.name: Java Platform API Specification
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.runtime.version: 17.0.1+1
I 10:14:49.910 [main @coroutine#1] <com.malinskiy.marathon.Marathon> os.version: 12.5.1
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.runtime.name: OpenJDK Runtime Environment
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.name: OpenJDK 64-Bit Server VM
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vendor.version: Homebrew
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vendor.url.bug: https://github.com/Homebrew/homebrew-core/issues
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.io.tmpdir: /var/folders/vl/v64j2xyj3_39r8qhcnf2s57c0000gn/T/
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.version: 17.0.1
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> os.arch: x86_64
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.specification.name: Java Virtual Machine Specification
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.library.path: /Users/user/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.info: mixed mode, sharing
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vendor: Homebrew
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.vm.version: 17.0.1+1
I 10:14:49.911 [main @coroutine#1] <com.malinskiy.marathon.Marathon> java.class.version: 61.0
D 10:14:50.274 [main @coroutine#1] <AdamDeviceProvider> Android Debug Bridge /127.0.0.1:5037: version 41
D 10:14:50.338 [DeviceMonitor @coroutine#6] <AdamDeviceProvider> Device emulator-5554 changed state to CONNECTED
D 10:14:50.404 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#12] <AndroidDevice> Device 127.0.0.1:5037:emulator-5554 booted!
I 10:14:51.338 [main @coroutine#1] <com.malinskiy.marathon.Marathon> Scheduling 1 tests
D 10:14:51.339 [main @coroutine#1] <com.malinskiy.marathon.Marathon> com.example.MainActivityAllureTest#testText
I 10:14:51.340 [main @coroutine#1] <com.malinskiy.marathon.Marathon> Output /Users/user/Documents/marathon/sample/android-app/build/reports/marathon already exists
D 10:14:51.355 [main @coroutine#33] <Scheduler> device 127.0.0.1:5037:emulator-5554 associated with poolId omni
D 10:14:51.356 [main @coroutine#33] <Scheduler> pool actor omni is being created
D 10:14:51.373 [main @coroutine#34] <DevicePoolActor[omni]> add device 127.0.0.1:5037:emulator-5554
D 10:14:51.382 [main @coroutine#36] <D.0.0.1:5037:emulator-5554]> initialize 127.0.0.1:5037:emulator-5554
D 10:14:51.402 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#38] <AndroidAppInstaller> Installing application output to 127.0.0.1:5037:emulator-5554
I 10:14:51.449 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Uninstalling com.example from 127.0.0.1:5037:emulator-5554
D 10:14:51.853 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Success
I 10:14:51.853 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Installing com.example, /Users/user/Documents/marathon/sample/android-app/app/build/intermediates/apk/debug/app-debug.apk to 127.0.0.1:5037:emulator-5554
D 10:14:51.923 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidDevice> Transferred app-debug.apk to/from 127.0.0.1:5037:emulator-5554. 34895.52 KB/s (2338865 bytes in 0.0670)
D 10:14:52.031 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidDevice> /data/local/tmp/app-debug.apk synced in 69ms
D 10:14:52.420 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Success
D 10:14:52.421 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Installing instrumentation package to 127.0.0.1:5037:emulator-5554
I 10:14:52.526 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidAppInstaller> Uninstalling com.example.test from 127.0.0.1:5037:emulator-5554
D 10:14:52.922 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#38] <AndroidAppInstaller> Success
I 10:14:52.922 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#38] <AndroidAppInstaller> Installing com.example.test, /Users/user/Documents/marathon/sample/android-app/app/build/intermediates/apk/androidTest/debug/app-debug-androidTest.apk to 127.0.0.1:5037:emulator-5554
D 10:14:53.059 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidDevice> Transferred app-debug-androidTest.apk to/from 127.0.0.1:5037:emulator-5554. 73481.48 KB/s (9920445 bytes in 0.1350)
D 10:14:53.185 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#38] <AndroidDevice> /data/local/tmp/app-debug-androidTest.apk synced in 100ms
D 10:14:53.492 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#38] <AndroidAppInstaller> Success
D 10:14:53.493 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#38] <AndroidAppInstaller> Prepare installation finished for 127.0.0.1:5037:emulator-5554
D 10:14:53.621 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> request next batch for device 127.0.0.1:5037:emulator-5554
D 10:14:53.621 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> sending next batch for device 127.0.0.1:5037:emulator-5554
D 10:14:53.623 [main @coroutine#36] <D.0.0.1:5037:emulator-5554]> executeBatch 127.0.0.1:5037:emulator-5554
D 10:14:53.637 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <AndroidDeviceTestRunner> tests = [com.example.MainActivityAllureTest#testText]
D 10:14:53.638 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <ArgumentsFactory> Assuming gRPC port is console port 5554 + 3000 = 8554
D 10:14:53.777 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDeviceTestRunner> Package com.example cleared: Success
D 10:14:53.851 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <AndroidDeviceTestRunner> Package com.example.test cleared: Success
D 10:14:54.239 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <FileSyncTestRunListener> Pushing file fixtures/external-file into /data/local/tmp/external-file
D 10:14:54.249 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <AndroidDevice> Transferred external-file to/from 127.0.0.1:5037:emulator-5554. 0.00 KB/s (9 bytes in 0.0100)
D 10:14:54.280 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <AndroidDevice> /data/local/tmp/external-file synced in 31ms
D 10:14:54.281 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <FileSyncTestRunListener> Pushing folder fixtures/external-folder into /data/local/tmp/external-folder
D 10:14:54.345 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDeviceTestRunner> Running 025Dshell:am instrument -w -r -e class com.example.MainActivityAllureTest#testText -e coverageFile /data/data/com.example/coverage/coverage-fe6092de-d38e-4758-acb0-c0c5b52d5a09.ec -e debug false -e com.malinskiy.adam.android.ADB_PORT 5037 -e com.malinskiy.adam.android.ADB_HOST 10.0.2.2 -e com.malinskiy.adam.android.ADB_SERIAL emulator-5554 -e com.malinskiy.adam.android.CONSOLE_PORT 5554 -e com.malinskiy.adam.android.CONSOLE_HOST 10.0.2.2 -e com.malinskiy.adam.android.GRPC_PORT 8554 -e com.malinskiy.adam.android.GRPC_HOST 10.0.2.2 -e coverage true com.example.test/androidx.test.runner.AndroidJUnitRunner
I 10:14:55.524 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <DebugTestRunListener> testRunStarted 127.0.0.1:5037:emulator-5554
D 10:14:55.524 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <ScreenCapturerTestRunListener> Starting recording for MainActivityAllureTest.testText
I 10:14:55.525 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <DebugTestRunListener> testStarted 127.0.0.1:5037:emulator-5554 test = TestIdentifier(className=com.example.MainActivityAllureTest, testName=testText)
00% | [omni]-[127.0.0.1:5037:emulator-5554] com.example.MainActivityAllureTest#testText started
I 10:14:57.792 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <DebugTestRunListener> testRunFailed 127.0.0.1:5037:emulator-5554 errorMessage = Test run failed to complete. Expected 1 tests, executed 0
D 10:14:57.793 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDeviceTestRunner> Execution finished
W 10:14:57.795 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <TestRunResultsListener> uncompleted = com.example.MainActivityAllureTest#testText, 127.0.0.1:5037:emulator-5554
D 10:14:57.796 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:14:57.882 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDevice> Transferred 45013f95-73eb-49b0-a076-4a7f796b9c6b-result.json to/from 127.0.0.1:5037:emulator-5554. 153.85 KB/s (2718 bytes in 0.0130)
D 10:14:57.894 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDevice> Transferred e4571d54-aaba-4254-9131-4adfca301480-attachment.png to/from 127.0.0.1:5037:emulator-5554. 3181.82 KB/s (35046 bytes in 0.0110)
D 10:14:57.894 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/omni/coverage
D 10:14:57.963 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#77] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:14:58.020 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDevice> Transferred 45013f95-73eb-49b0-a076-4a7f796b9c6b-result.json to/from 127.0.0.1:5037:emulator-5554. 181.82 KB/s (2718 bytes in 0.0110)
D 10:14:58.034 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#77] <AndroidDevice> Transferred e4571d54-aaba-4254-9131-4adfca301480-attachment.png to/from 127.0.0.1:5037:emulator-5554. 2692.31 KB/s (35046 bytes in 0.0130)
D 10:14:58.086 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> handle test results 127.0.0.1:5037:emulator-5554
D 10:14:58.087 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> request next batch for device 127.0.0.1:5037:emulator-5554
D 10:14:58.088 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> sending next batch for device 127.0.0.1:5037:emulator-5554
D 10:14:58.088 [main @coroutine#34] <DevicePoolActor[omni]> Notify devices
D 10:14:58.088 [main @coroutine#36] <D.0.0.1:5037:emulator-5554]> executeBatch 127.0.0.1:5037:emulator-5554
D 10:14:58.088 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <AndroidDeviceTestRunner> tests = [com.example.MainActivityAllureTest#testText]
D 10:14:58.089 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <ArgumentsFactory> Assuming gRPC port is console port 5554 + 3000 = 8554
D 10:14:58.124 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <AndroidDeviceTestRunner> Package com.example cleared: Success
D 10:14:58.182 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <AndroidDeviceTestRunner> Package com.example.test cleared: Success
D 10:14:58.457 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <FileSyncTestRunListener> Pushing file fixtures/external-file into /data/local/tmp/external-file
D 10:14:58.465 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <AndroidDevice> Transferred external-file to/from 127.0.0.1:5037:emulator-5554. 0.00 KB/s (9 bytes in 0.0070)
D 10:14:58.494 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <AndroidDevice> /data/local/tmp/external-file synced in 29ms
D 10:14:58.494 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <FileSyncTestRunListener> Pushing folder fixtures/external-folder into /data/local/tmp/external-folder
D 10:14:58.544 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <AndroidDeviceTestRunner> Running 025Dshell:am instrument -w -r -e class com.example.MainActivityAllureTest#testText -e coverageFile /data/data/com.example/coverage/coverage-357d056d-f9e0-4b66-99d3-7e4a3f3da67d.ec -e debug false -e com.malinskiy.adam.android.ADB_PORT 5037 -e com.malinskiy.adam.android.ADB_HOST 10.0.2.2 -e com.malinskiy.adam.android.ADB_SERIAL emulator-5554 -e com.malinskiy.adam.android.CONSOLE_PORT 5554 -e com.malinskiy.adam.android.CONSOLE_HOST 10.0.2.2 -e com.malinskiy.adam.android.GRPC_PORT 8554 -e com.malinskiy.adam.android.GRPC_HOST 10.0.2.2 -e coverage true com.example.test/androidx.test.runner.AndroidJUnitRunner
I 10:14:59.476 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <DebugTestRunListener> testRunStarted 127.0.0.1:5037:emulator-5554
D 10:14:59.476 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <ScreenCapturerTestRunListener> Starting recording for MainActivityAllureTest.testText
I 10:14:59.476 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <DebugTestRunListener> testStarted 127.0.0.1:5037:emulator-5554 test = TestIdentifier(className=com.example.MainActivityAllureTest, testName=testText)
00% | [omni]-[127.0.0.1:5037:emulator-5554] com.example.MainActivityAllureTest#testText started
I 10:15:01.370 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <DebugTestRunListener> testRunFailed 127.0.0.1:5037:emulator-5554 errorMessage = Test run failed to complete. Expected 1 tests, executed 0
D 10:15:01.370 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <AndroidDeviceTestRunner> Execution finished
W 10:15:01.371 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <TestRunResultsListener> uncompleted = com.example.MainActivityAllureTest#testText, 127.0.0.1:5037:emulator-5554
D 10:15:01.371 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:01.522 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <AndroidDevice> Transferred 40f7f9e8-97a4-440a-9269-ca618a950e57-attachment.png to/from 127.0.0.1:5037:emulator-5554. 2333.33 KB/s (35046 bytes in 0.0150)
D 10:15:01.523 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#183] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/omni/coverage
D 10:15:01.598 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:01.658 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#183] <AndroidDevice> Transferred 40f7f9e8-97a4-440a-9269-ca618a950e57-attachment.png to/from 127.0.0.1:5037:emulator-5554. 2692.31 KB/s (35046 bytes in 0.0130)
D 10:15:01.700 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> handle test results 127.0.0.1:5037:emulator-5554
D 10:15:01.700 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> request next batch for device 127.0.0.1:5037:emulator-5554
D 10:15:01.701 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> sending next batch for device 127.0.0.1:5037:emulator-5554
D 10:15:01.701 [main @coroutine#34] <DevicePoolActor[omni]> Notify devices
D 10:15:01.701 [main @coroutine#36] <D.0.0.1:5037:emulator-5554]> executeBatch 127.0.0.1:5037:emulator-5554
D 10:15:01.701 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <AndroidDeviceTestRunner> tests = [com.example.MainActivityAllureTest#testText]
D 10:15:01.701 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <ArgumentsFactory> Assuming gRPC port is console port 5554 + 3000 = 8554
D 10:15:01.800 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDeviceTestRunner> Package com.example cleared: Success
D 10:15:01.869 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDeviceTestRunner> Package com.example.test cleared: Success
D 10:15:02.216 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <FileSyncTestRunListener> Pushing file fixtures/external-file into /data/local/tmp/external-file
D 10:15:02.223 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDevice> Transferred external-file to/from 127.0.0.1:5037:emulator-5554. 0.00 KB/s (9 bytes in 0.0060)
D 10:15:02.251 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <AndroidDevice> /data/local/tmp/external-file synced in 28ms
D 10:15:02.252 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <FileSyncTestRunListener> Pushing folder fixtures/external-folder into /data/local/tmp/external-folder
D 10:15:02.301 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <AndroidDeviceTestRunner> Running 025Dshell:am instrument -w -r -e class com.example.MainActivityAllureTest#testText -e coverageFile /data/data/com.example/coverage/coverage-148bd0fa-bcc5-4be3-8354-b42fde1036b1.ec -e debug false -e com.malinskiy.adam.android.ADB_PORT 5037 -e com.malinskiy.adam.android.ADB_HOST 10.0.2.2 -e com.malinskiy.adam.android.ADB_SERIAL emulator-5554 -e com.malinskiy.adam.android.CONSOLE_PORT 5554 -e com.malinskiy.adam.android.CONSOLE_HOST 10.0.2.2 -e com.malinskiy.adam.android.GRPC_PORT 8554 -e com.malinskiy.adam.android.GRPC_HOST 10.0.2.2 -e coverage true com.example.test/androidx.test.runner.AndroidJUnitRunner
I 10:15:03.237 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <DebugTestRunListener> testRunStarted 127.0.0.1:5037:emulator-5554
D 10:15:03.237 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <ScreenCapturerTestRunListener> Starting recording for MainActivityAllureTest.testText
I 10:15:03.237 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <DebugTestRunListener> testStarted 127.0.0.1:5037:emulator-5554 test = TestIdentifier(className=com.example.MainActivityAllureTest, testName=testText)
00% | [omni]-[127.0.0.1:5037:emulator-5554] com.example.MainActivityAllureTest#testText started
I 10:15:06.383 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <DebugTestRunListener> testRunFailed 127.0.0.1:5037:emulator-5554 errorMessage = Test run failed to complete. Expected 1 tests, executed 0
D 10:15:06.383 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <AndroidDeviceTestRunner> Execution finished
W 10:15:06.383 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <TestRunResultsListener> uncompleted = com.example.MainActivityAllureTest#testText, 127.0.0.1:5037:emulator-5554
D 10:15:06.383 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:06.459 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#275] <AndroidDevice> Transferred b56cdccf-516e-4a88-881c-9fb12bae90e8-attachment.png to/from 127.0.0.1:5037:emulator-5554. 3500.00 KB/s (35294 bytes in 0.0100)
D 10:15:06.468 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDevice> Transferred c03a8059-dc8e-4c4b-9575-2414f17ba968-result.json to/from 127.0.0.1:5037:emulator-5554. 250.00 KB/s (2718 bytes in 0.0080)
D 10:15:06.468 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/omni/coverage
D 10:15:06.525 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:06.573 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDevice> Transferred b56cdccf-516e-4a88-881c-9fb12bae90e8-attachment.png to/from 127.0.0.1:5037:emulator-5554. 3888.89 KB/s (35294 bytes in 0.0090)
D 10:15:06.582 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#275] <AndroidDevice> Transferred c03a8059-dc8e-4c4b-9575-2414f17ba968-result.json to/from 127.0.0.1:5037:emulator-5554. 222.22 KB/s (2718 bytes in 0.0090)
D 10:15:06.613 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> handle test results 127.0.0.1:5037:emulator-5554
D 10:15:06.614 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> request next batch for device 127.0.0.1:5037:emulator-5554
D 10:15:06.614 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> sending next batch for device 127.0.0.1:5037:emulator-5554
D 10:15:06.614 [main @coroutine#34] <DevicePoolActor[omni]> Notify devices
D 10:15:06.614 [main @coroutine#36] <D.0.0.1:5037:emulator-5554]> executeBatch 127.0.0.1:5037:emulator-5554
D 10:15:06.614 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <AndroidDeviceTestRunner> tests = [com.example.MainActivityAllureTest#testText]
D 10:15:06.614 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <ArgumentsFactory> Assuming gRPC port is console port 5554 + 3000 = 8554
D 10:15:06.651 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <AndroidDeviceTestRunner> Package com.example cleared: Success
D 10:15:06.708 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <AndroidDeviceTestRunner> Package com.example.test cleared: Success
D 10:15:06.997 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <FileSyncTestRunListener> Pushing file fixtures/external-file into /data/local/tmp/external-file
D 10:15:07.004 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <AndroidDevice> Transferred external-file to/from 127.0.0.1:5037:emulator-5554. 0.00 KB/s (9 bytes in 0.0060)
D 10:15:07.029 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <AndroidDevice> /data/local/tmp/external-file synced in 25ms
D 10:15:07.030 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <FileSyncTestRunListener> Pushing folder fixtures/external-folder into /data/local/tmp/external-folder
D 10:15:07.075 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <AndroidDeviceTestRunner> Running 025Dshell:am instrument -w -r -e class com.example.MainActivityAllureTest#testText -e coverageFile /data/data/com.example/coverage/coverage-221c38fc-2a0b-4b6f-a9b3-7fc7d84bb23d.ec -e debug false -e com.malinskiy.adam.android.ADB_PORT 5037 -e com.malinskiy.adam.android.ADB_HOST 10.0.2.2 -e com.malinskiy.adam.android.ADB_SERIAL emulator-5554 -e com.malinskiy.adam.android.CONSOLE_PORT 5554 -e com.malinskiy.adam.android.CONSOLE_HOST 10.0.2.2 -e com.malinskiy.adam.android.GRPC_PORT 8554 -e com.malinskiy.adam.android.GRPC_HOST 10.0.2.2 -e coverage true com.example.test/androidx.test.runner.AndroidJUnitRunner
I 10:15:08.044 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <DebugTestRunListener> testRunStarted 127.0.0.1:5037:emulator-5554
D 10:15:08.044 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <ScreenCapturerTestRunListener> Starting recording for MainActivityAllureTest.testText
I 10:15:08.044 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <DebugTestRunListener> testStarted 127.0.0.1:5037:emulator-5554 test = TestIdentifier(className=com.example.MainActivityAllureTest, testName=testText)
00% | [omni]-[127.0.0.1:5037:emulator-5554] com.example.MainActivityAllureTest#testText started
I 10:15:11.472 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <DebugTestRunListener> testRunFailed 127.0.0.1:5037:emulator-5554 errorMessage = Test run failed to complete. Expected 1 tests, executed 0
D 10:15:11.472 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <AndroidDeviceTestRunner> Execution finished
W 10:15:11.472 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <TestRunResultsListener> uncompleted = com.example.MainActivityAllureTest#testText, 127.0.0.1:5037:emulator-5554
D 10:15:11.472 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:11.575 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <AndroidDevice> Transferred 89e1b7c1-d5e9-45f2-bafa-5952caf0fe79-attachment.png to/from 127.0.0.1:5037:emulator-5554. 3181.82 KB/s (35294 bytes in 0.0110)
D 10:15:11.575 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/omni/coverage
D 10:15:11.641 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-1 @coroutine#381] <FileSyncTestRunListener> Pulling into /Users/user/Documents/marathon/sample/android-app/build/reports/marathon/device-files/allure-results
D 10:15:11.701 [AndroidDevice - execution - 127.0.0.1:5037:emulator-5554-2 @coroutine#381] <AndroidDevice> Transferred 89e1b7c1-d5e9-45f2-bafa-5952caf0fe79-attachment.png to/from 127.0.0.1:5037:emulator-5554. 2692.31 KB/s (35294 bytes in 0.0130)
D 10:15:11.762 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> handle test results 127.0.0.1:5037:emulator-5554
D 10:15:11.763 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> uncompletedRetryQuotaExceeded for com.example.MainActivityAllureTest#testText
D 10:15:11.764 [main @coroutine#35] <QueueActor[DevicePoolId(name=omni)]> request next batch for device 127.0.0.1:5037:emulator-5554
Allure environment data saved.
Marathon run finished:
Device pool omni:
        0 passed, 1 failed, 0 ignored tests
        Failed tests:
                com.example.MainActivityAllureTest#testText
        Flakiness overhead: 7307ms
        Raw: 0 passed, 1 failed, 0 ignored, 3 incomplete tests
        Failed tests:
                com.example.MainActivityAllureTest#testText failed 1 time(s)
        Incomplete tests:
                com.example.MainActivityAllureTest#testText incomplete 3 time(s)
Total time: 0H 0m 22s

I 10:15:12.033 [main] <c.m.m.e.BugsnagExceptionsReporter> Finish BugSnag
D 10:15:12.033 [main] <com.bugsnag.Bugsnag> Closing connection to Bugsnag
marathon v0.7.6: Test run failed
D 10:15:12.034 [Thread-2] <com.bugsnag.Bugsnag> Closing connection to Bugsnag

Devices (please complete the following information):

Malinskiy commented 1 year ago

Executing tests on API 31 using am instrument produces output that breaks previous conventions:

INSTRUMENTATION_STATUS: class=com.example.MainActivityAllureTest
INSTRUMENTATION_STATUS: current=1
INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
INSTRUMENTATION_STATUS: numtests=1
INSTRUMENTATION_STATUS: stream=
com.example.MainActivityAllureTest:
INSTRUMENTATION_STATUS: test=testText
INSTRUMENTATION_STATUS_CODE: 1
s_glBindAttribLocation: bind attrib 0 name position
s_glBindAttribLocation: bind attrib 1 name localCoord
INSTRUMENTATION_STATUS: class=com.example.MainActivityAllureTest
INSTRUMENTATION_STATUS: current=1
INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
INSTRUMENTATION_STATUS: numtests=1
INSTRUMENTATION_STATUS: stream=.
INSTRUMENTATION_STATUS: test=testText
INSTRUMENTATION_STATUS_CODE: 0
INSTRUMENTATION_RESULT: stream=

Time: 0.915

OK (1 test)

INSTRUMENTATION_CODE: -1

Pay attention to the s_glBindAttribLocation. It is actually written to stderr, not stdout. For devices that only support shell v1 this means that our parser will fail since the stderr is interleaved with stdout.

Malinskiy commented 1 year ago

Fixed upstream in https://github.com/Malinskiy/adam/pull/93