[Android][libraries] Waiting for command timed out: execution may be compromised Arm64 #51017
Description
When running Android library tests, the following suites fail with Waiting for command timed out: execution may be compromised on Arm64
Microsoft.Extensions.Configuration.Xml.Tests.log
Microsoft.Extensions.Hosting.Functinoal.Tests.log
Microsoft.Extensions.Logging.Testing.Tests.log
System.Resources.ResourceManager.Tests.log
System.Runtime.Loader.Tests.log
System.Runtime.Serialization.Json.Tests.log
Console log: 'Microsoft.Extensions.Configuration.Xml.Tests' from job a86ff6d6-3d82-45e5-9d4a-227c66d4ce2b workitem 3c78b122-aadf-41f7-99b5-75fd23e72212 (windows.10.amd64.android.open) executed on machine DNCENGWIN-020
C:\h\w\B22A09B4\w\B0210946\e>set PATH=C:\h\w\B22A09B4\p/dotnet-cli;C:\python3.7.0\lib\site-packages\pywin32_system32;C:\python3.7.0\Scripts\;C:\python3.7.0\;C:\python\python37\Scripts\;C:\python\python37\;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Program Files\Git\cmd;C:\Users\runner\AppData\Local\Microsoft\WindowsApps
C:\h\w\B22A09B4\w\B0210946\e>set DOTNET_ROOT=C:\h\w\B22A09B4\p/dotnet-cli
C:\h\w\B22A09B4\w\B0210946\e>set DOTNET_CLI_TELEMETRY_OPTOUT=1
C:\h\w\B22A09B4\w\B0210946\e>set PATH=C:\h\w\B22A09B4\p/xharness-cli;C:\h\w\B22A09B4\p/dotnet-cli;C:\python3.7.0\lib\site-packages\pywin32_system32;C:\python3.7.0\Scripts\;C:\python3.7.0\;C:\python\python37\Scripts\;C:\python\python37\;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Program Files\Git\cmd;C:\Users\runner\AppData\Local\Microsoft\WindowsApps
C:\h\w\B22A09B4\w\B0210946\e>set XHARNESS_DISABLE_COLORED_OUTPUT=true
C:\h\w\B22A09B4\w\B0210946\e>set XHARNESS_LOG_WITH_TIMESTAMPS=true
C:\h\w\B22A09B4\w\B0210946\e>set XHARNESS_CLI_PATH=C:\h\w\B22A09B4\p/microsoft.dotnet.xharness.cli/1.0.0-prerelease.21207.1/tools/net6.0/any/Microsoft.DotNet.XHarness.CLI.dll
C:\h\w\B22A09B4\w\B0210946\e>call xharness-helix-job.android.bat dotnet exec "C:\h\w\B22A09B4\p/microsoft.dotnet.xharness.cli/1.0.0-prerelease.21207.1/tools/net6.0/any/Microsoft.DotNet.XHarness.CLI.dll" android test --app "Microsoft.Extensions.Configuration.Xml.Tests.apk" --output-directory "C:\h\w\B22A09B4\w\B0210946\uploads" --timeout "00:30:00" -p="net.dot.Microsoft.Extensions.Configuration.Xml.Tests" -v -i=net.dot.MonoRunner
Xharness Helix Wrapper: Arguments: dotnet exec "C:\h\w\B22A09B4\p/microsoft.dotnet.xharness.cli/1.0.0-prerelease.21207.1/tools/net6.0/any/Microsoft.DotNet.XHarness.CLI.dll" android test --app "Microsoft.Extensions.Configuration.Xml.Tests.apk" --output-directory "C:\h\w\B22A09B4\w\B0210946\uploads" --timeout "00:30:00" -p="net.dot.Microsoft.Extensions.Configuration.Xml.Tests" -v -i=net.dot.MonoRunner
XHarness command issued: android test --app Microsoft.Extensions.Configuration.Xml.Tests.apk --output-directory C:\h\w\B22A09B4\w\B0210946\uploads --timeout 00:30:00 -p=net.dot.Microsoft.Extensions.Configuration.Xml.Tests -v -i=net.dot.MonoRunner
[09:22:47] dbug: Android Test command called: App = C:\h\w\B22A09B4\w\B0210946\e\Microsoft.Extensions.Configuration.Xml.Tests.apk
Instrumentation Name = net.dot.MonoRunner
[09:22:47] dbug: Output Directory:C:\h\w\B22A09B4\w\B0210946\uploads
Timeout = 1800 seconds.
[09:22:47] dbug: Arguments to instrumentation:
[09:22:47] dbug: ADBRunner using ADB.exe supplied from C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\tools\net6.0\any\..\..\..\runtimes\any\native\adb\windows\adb.exe
[09:22:47] dbug: Full resolved path:'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe'
[09:22:47] info: Will attempt to run device on detected architecture: 'arm64-v8a'
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe start-server'
[09:22:47] dbug:
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe devices -l'
[09:22:47] dbug: Evaluating output line for device serial: 9CBAY1NP1W device product:sargo model:Pixel_3a device:sargo transport_id:1
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W shell getprop ro.product.cpu.abi'
[09:22:47] dbug: Using first-found compatible device of 1 total- serial: '9CBAY1NP1W' - architecture: arm64-v8a
[09:22:47] info: Active Android device set to serial '9CBAY1NP1W'
[09:22:47] info: Waiting for device to be available (max 5 minutes)
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W wait-for-device'
[09:22:47] dbug:
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W shell getprop sys.boot_completed'
[09:22:47] dbug: Waited 0.0893601 seconds for device for sys.boot_completed to be 1.
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W version'
[09:22:47] dbug: Working with Android Debug Bridge version 1.0.41
Version 29.0.6-6198805
Installed as C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe
[09:22:47] info: Attempting to remove apk 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests':
[09:22:47] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W uninstall net.dot.Microsoft.Extensions.Configuration.Xml.Tests'
[09:22:48] info: APK 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests' not on device.
[09:22:48] info: Attempting to install C:\h\w\B22A09B4\w\B0210946\e\Microsoft.Extensions.Configuration.Xml.Tests.apk:
[09:22:48] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W install "C:\h\w\B22A09B4\w\B0210946\e\Microsoft.Extensions.Configuration.Xml.Tests.apk"'
[09:27:48] fail: Waiting for command timed out: execution may be compromised.
[09:27:48] fail: Error:
Exit code: -2
Standard Output:
[09:27:48] crit: Install failure: Test command cannot continue
[09:27:48] info: Attempting to remove apk 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests':
[09:27:48] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W uninstall net.dot.Microsoft.Extensions.Configuration.Xml.Tests'
[09:27:48] info: APK 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests' not on device.
[09:27:48] info: Attempting to remove apk 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests':
[09:27:48] dbug: Executing command: 'C:\h\w\B22A09B4\p\microsoft.dotnet.xharness.cli\1.0.0-prerelease.21207.1\runtimes\any\native\adb\windows\adb.exe -s 9CBAY1NP1W uninstall net.dot.Microsoft.Extensions.Configuration.Xml.Tests'
[09:27:48] info: APK 'net.dot.Microsoft.Extensions.Configuration.Xml.Tests' not on device.
XHarness exit code: 78 (PACKAGE_INSTALLATION_FAILURE)
Fri 04/09/2021- 9:27:48.48
Fri 04/09/2021- 9:27:48.74
2021-04-09 09:27:49,152: INFO: 11632: run(82): main: Main thread starting 10 workers
Worker 0: starting...
Worker 1: starting...
Worker 2: starting...
Worker 3: starting...
Worker 4: starting...
Worker 5: starting...
Worker 6: starting...
Worker 7: starting...
Worker 8: starting...
Worker 9: starting...
2021-04-09 09:27:49,152: INFO: 11632: run(89): main: Beginning reading of test results.
2021-04-09 09:27:49,152: INFO: 11632: run(98): main: Uploading results in batches of size 1000
2021-04-09 09:27:49,152: INFO: 11632: run(103): main: Main thread finished queueing batches
2021-04-09 09:27:49,152: INFO: 11632: run(107): main: Main thread exiting
Searching 'C:\h\w\B22A09B4\w\B0210946\e\..' for log files
Found log 'C:\h\w\B22A09B4\w\B0210946\e\..\console.0759e6a9.log'
Uri 'https://helixre107v0xdeko0k025g8.blob.core.windows.net/dotnet-runtime-refs-pull-50095-merge-a86ff6d63d8245e59d/Microsoft.Extensions.Configuration.Xml.Tests/console.0759e6a9.log?sv=2019-07-07&se=2021-04-29T16%3A22%3A32Z&sr=c&sp=rl&sig=AelVJ3%2F49S%2BlKx6HiyAaiHJqg4JakvlZtWc9rq3ednQ%3D'
Generated log list: console.0759e6a9.log:
https://helixre107v0xdeko0k025g8.blob.core.windows.net/dotnet-runtime-refs-pull-50095-merge-a86ff6d63d8245e59d/Microsoft.Extensions.Configuration.Xml.Tests/console.0759e6a9.log?sv=2019-07-07&se=2021-04-29T16%3A22%3A32Z&sr=c&sp=rl&sig=AelVJ3%2F49S%2BlKx6HiyAaiHJqg4JakvlZtWc9rq3ednQ%3D
Searching 'C:\h\w\B22A09B4\w\B0210946\e' for test results files
Searching 'C:\h\w\B22A09B4\w\B0210946\uploads' for test results files
No results file found in any of the following formats: xunit, junit, trx
Fri 04/09/2021- 9:27:49.18