Back to build
Raw log | Switch to full mode | Login

{ "shards": [ { "bot_dimensions": [ { "key": "android_devices", "value": [ "1" ] }, { "key": "caches", "value": [ "swarming_module_cache_vpython" ] }, { "key": "device_gms_core_version", "value": [ "4.3.23" ] }, { "key": "device_os", "value": [ "K", "KTU84P" ] }, { "key": "device_os_flavor", "value": [ "google" ] }, { "key": "device_os_type", "value": [ "userdebug" ] }, { "key": "device_playstore_version", "value": [ "4.5.10" ] }, { "key": "device_type", "value": [ "hammerhead" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "id", "value": [ "build285-m1--device1" ] }, { "key": "inside_docker", "value": [ "1", "stock" ] }, { "key": "locale", "value": [ "en_US.UTF-8" ] }, { "key": "os", "value": [ "Android" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.12" ] }, { "key": "server_version", "value": [ "4302-e8210c4" ] }, { "key": "temp_band", "value": [ "<30" ] }, { "key": "zone", "value": [ "us", "us-golo", "us-golo-1" ] } ], "bot_id": "build285-m1--device1", "bot_version": "4b0ae3934529ef453cbdb4972bf2db7960acae5445e24fb3eb608f68a4076974", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/linux-amd64", "version": "nFftZl2kFquaI2EUmPGwzbc5sIbCocl9L55UeASqlLsC" }, "packages": [ { "package_name": "infra/python/cpython/linux-amd64", "path": ".swarming_module", "version": "46c0c897ca0f053799ee41fd148bb7a47232df47" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": ".swarming_module", "version": "2737ea8ed9b958f4d5aa9ffe106115a649ada241" }, { "package_name": "infra/tools/luci/vpython-native/linux-amd64", "path": ".swarming_module", "version": "tfTmX4aGCfFtfQucj_nEfwiNisK0RmpKrITkZMBBq3cC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "bmnYyAg9mbM_538s1dIP1hZZmOtc8C7ssF41ztN2cr0C" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": "bin", "version": "a57ad614c01fec9fa4259473c8ea3fd992d7c349" } ] }, "completed_ts": "2019-05-20T23:14:23.719786", "costs_usd": [ 0.0054176701444770305 ], "created_ts": "2019-05-20T23:13:36.488894", "duration": 36.85038185119629, "modified_ts": "2019-05-20T23:14:23.719786", "name": "vr_android_unittests on Android device Nexus 5 (with patch)/Android/ecf1eeb6f4/android-kitkat-arm-rel/266057", "output": "/b/swarming/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown.\nAdditional test environment:\n CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox\n CHROME_HEADLESS=1\n LANG=en_US.UTF-8\nCommand: /b/swarming/w/ir/.swarming_module_cache/vpython/a01b17/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target vr_android_unittests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --test-launcher-summary-output=/b/swarming/w/ioYNHL9N/output.json --gs-results-bucket=chromium-result-details --recover-devices\n\nI 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/chrome/browser/android/vr/vr_android_unittests__test_runner_script.runtime_deps --suite vr_android_unittests -v --store-tombstones --test-launcher-summary-output=/b/swarming/w/ioYNHL9N/output.json --gs-results-bucket=chromium-result-details --recover-devices\nI 0.007s Main condition '<lambda>' met\nI 0.009s Main condition '<lambda>' met\nI 3.160s TimeoutThread-1-for-prepare_device(064128f013c86d0d) condition 'sd_card_ready' met (0.0s)\nI 3.700s TimeoutThread-1-for-prepare_device(064128f013c86d0d) condition 'pm_ready' met (0.6s)\nI 3.716s TimeoutThread-1-for-prepare_device(064128f013c86d0d) condition 'boot_completed' met (0.6s)\nI 11.139s calculate_device_checksums condition '<lambda>' met (0.1s)\nI 12.401s TimeoutThread-1-for-individual_device_set_up(064128f013c86d0d) Pushing 2559 files via .zip of size 6141357\nI 18.946s list_tests(064128f013c86d0d) flags:\nI 18.947s list_tests(064128f013c86d0d) --gtest_list_tests\nI 20.290s list_tests(064128f013c86d0d) /storage/emulated/legacy/temp_file-cd2691b5090ef.gtest_out size on device: 425\nI 20.363s Main Using external sharding settings. This is shard 0/1\nI 20.363s Main STARTING TRY #1/3\nI 20.364s Main Will run 3 tests on 1 devices: 064128f013c86d0d\nI 22.789s run_tests_on_device(064128f013c86d0d) flags:\nI 22.789s run_tests_on_device(064128f013c86d0d) Getting logdog client.\nI 24.732s run_tests_on_device(064128f013c86d0d) /storage/emulated/legacy/temp_file-58ec266495406.gtest_out size on device: 749\nI 24.821s run_tests_on_device(064128f013c86d0d) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44f0571af8b52b11%2F%2B%2Flogcat_logcat_4092382167060317254_20190520T231409-UTC_064128f013c86d0d\nI 24.822s archive Writing text to logdog stream, logcat_logcat_4092382167060317254_20190520T231409-UTC_064128f013c86d0d\nI 25.457s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 25.458s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 25.458s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 25.458s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 25.458s run_tests_on_device(064128f013c86d0d) >>ScopedMainEntryLogger\nI 25.458s run_tests_on_device(064128f013c86d0d) Note: Google Test filter = ArCoreDeviceTest.GetFrameData:ArCoreDeviceTest.RequestHitTest:ArCoreDeviceTest.RequestSession\nI 25.458s run_tests_on_device(064128f013c86d0d) [==========] Running 3 tests from 1 test suite.\nI 25.459s run_tests_on_device(064128f013c86d0d) [----------] Global test environment set-up.\nI 25.459s run_tests_on_device(064128f013c86d0d) [----------] 3 tests from ArCoreDeviceTest\nI 25.459s run_tests_on_device(064128f013c86d0d) [ RUN ] ArCoreDeviceTest.RequestSession\nI 25.459s run_tests_on_device(064128f013c86d0d) [ OK ] ArCoreDeviceTest.RequestSession (19 ms)\nI 25.459s run_tests_on_device(064128f013c86d0d) [ RUN ] ArCoreDeviceTest.GetFrameData\nI 25.459s run_tests_on_device(064128f013c86d0d) [ CRASHED ]\nI 25.753s run_tests_on_device(064128f013c86d0d) tombstone_00 created on 2019-05-20 23:14:00, about this long ago: 0:00:11 Device: 064128f013c86d0d\nI 25.753s run_tests_on_device(064128f013c86d0d) Resolving...\nI 26.324s run_tests_on_device(064128f013c86d0d) Total time spent symbolizing: 0.57s\nI 26.324s run_tests_on_device(064128f013c86d0d) Writing text to logdog stream, tombstones_20190520T231413_064128f013c86d0d\nW 26.365s run_tests_on_device(064128f013c86d0d) No tombstones to clear.\nI 28.190s run_tests_on_device(064128f013c86d0d) flags:\nI 29.470s run_tests_on_device(064128f013c86d0d) /storage/emulated/legacy/temp_file-f2ac6391f9ab3.gtest_out size on device: 831\nI 29.656s run_tests_on_device(064128f013c86d0d) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44f0571af8b52b11%2F%2B%2Flogcat_logcat_7235044538210728878_20190520T231415-UTC_064128f013c86d0d\nI 29.657s archive Writing text to logdog stream, logcat_logcat_7235044538210728878_20190520T231415-UTC_064128f013c86d0d\nI 30.269s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 30.269s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 30.269s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 30.269s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 30.270s run_tests_on_device(064128f013c86d0d) >>ScopedMainEntryLogger\nI 30.270s run_tests_on_device(064128f013c86d0d) Note: Google Test filter = ArCoreDeviceTest.RequestHitTest\nI 30.270s run_tests_on_device(064128f013c86d0d) [==========] Running 1 test from 1 test suite.\nI 30.270s run_tests_on_device(064128f013c86d0d) [----------] Global test environment set-up.\nI 30.270s run_tests_on_device(064128f013c86d0d) [----------] 1 test from ArCoreDeviceTest\nI 30.270s run_tests_on_device(064128f013c86d0d) [ RUN ] ArCoreDeviceTest.RequestHitTest\nI 30.271s run_tests_on_device(064128f013c86d0d) [ OK ] ArCoreDeviceTest.RequestHitTest (19 ms)\nI 30.271s run_tests_on_device(064128f013c86d0d) [----------] 1 test from ArCoreDeviceTest (19 ms total)\nI 30.271s run_tests_on_device(064128f013c86d0d) \nI 30.271s run_tests_on_device(064128f013c86d0d) [----------] Global test environment tear-down\nI 30.271s run_tests_on_device(064128f013c86d0d) [==========] 1 test from 1 test suite ran. (20 ms total)\nI 30.271s run_tests_on_device(064128f013c86d0d) [ PASSED ] 1 test.\nI 30.272s run_tests_on_device(064128f013c86d0d) <<ScopedMainEntryLogger\nI 30.273s run_tests_on_device(064128f013c86d0d) Finished running tests on this device.\nI 30.286s Main FINISHED TRY #1/3\nI 30.286s Main 1 failed tests remain.\nI 30.286s Main STARTING TRY #2/3\nI 30.287s Main Will run 1 tests on 1 devices: 064128f013c86d0d\nW 30.324s run_tests_on_device(064128f013c86d0d) No tombstones to clear.\nI 32.147s run_tests_on_device(064128f013c86d0d) flags:\nI 33.472s run_tests_on_device(064128f013c86d0d) /storage/emulated/legacy/temp_file-6fc5277c0e5cd.gtest_out size on device: 825\nI 33.608s archive Writing text to logdog stream, logcat_logcat_9076943636285733945_20190520T231419-UTC_064128f013c86d0d\nI 33.609s run_tests_on_device(064128f013c86d0d) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44f0571af8b52b11%2F%2B%2Flogcat_logcat_9076943636285733945_20190520T231419-UTC_064128f013c86d0d\nI 34.230s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 34.231s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 34.231s run_tests_on_device(064128f013c86d0d) [ERROR:memory_mapped_file.cc(60)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 34.231s run_tests_on_device(064128f013c86d0d) [ERROR:data_pack.cc(259)] Failed to mmap datapack\nI 34.231s run_tests_on_device(064128f013c86d0d) >>ScopedMainEntryLogger\nI 34.231s run_tests_on_device(064128f013c86d0d) Note: Google Test filter = ArCoreDeviceTest.GetFrameData\nI 34.231s run_tests_on_device(064128f013c86d0d) [==========] Running 1 test from 1 test suite.\nI 34.231s run_tests_on_device(064128f013c86d0d) [----------] Global test environment set-up.\nI 34.231s run_tests_on_device(064128f013c86d0d) [----------] 1 test from ArCoreDeviceTest\nI 34.231s run_tests_on_device(064128f013c86d0d) [ RUN ] ArCoreDeviceTest.GetFrameData\nI 34.231s run_tests_on_device(064128f013c86d0d) [ OK ] ArCoreDeviceTest.GetFrameData (18 ms)\nI 34.231s run_tests_on_device(064128f013c86d0d) [----------] 1 test from ArCoreDeviceTest (18 ms total)\nI 34.231s run_tests_on_device(064128f013c86d0d) \nI 34.232s run_tests_on_device(064128f013c86d0d) [----------] Global test environment tear-down\nI 34.232s run_tests_on_device(064128f013c86d0d) [==========] 1 test from 1 test suite ran. (18 ms total)\nI 34.232s run_tests_on_device(064128f013c86d0d) [ PASSED ] 1 test.\nI 34.232s run_tests_on_device(064128f013c86d0d) <<ScopedMainEntryLogger\nI 34.234s run_tests_on_device(064128f013c86d0d) Finished running tests on this device.\nI 34.261s Main FINISHED TRY #2/3\nI 34.261s Main All tests completed.\nC 34.262s Main ********************************************************************************\nC 34.262s Main Summary\nC 34.262s Main ********************************************************************************\nC 34.262s Main [==========] 3 tests ran.\nC 34.262s Main [ PASSED ] 3 tests.\nC 34.262s Main ********************************************************************************\nI 34.270s tear_down_device(064128f013c86d0d) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_064128f013c86d0d.json\nI 34.272s Main Generated json results file at /b/swarming/w/itSjUo8G/tmpizJX91\nI 34.273s Main Finishing archiving output.\n[W2019-05-20T23:14:21.361703Z 3775 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {\"error\":\"context canceled\"}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met\n[E2019-05-20T23:14:21.413589Z 3775 0 main.go:205] Butler terminated with error. {\"error\":\"context canceled\"}\n[E2019-05-20T23:14:21.413637Z 3775 0 main.go:233] Failed to serve.\noriginal error: context canceled\n\n[I2019-05-20T23:14:21.413728Z 3775 0 main.go:349] Terminating. {\"returnCode\":250}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' met\n", "outputs_ref": { "isolated": "0a86063704c52e111b8fa29ddb0c9e1b974da208", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "44f0571af8b52b11", "server_versions": [ "4302-e8210c4" ], "started_ts": "2019-05-20T23:13:36.884742", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:android-kitkat-arm-rel", "buildnumber:266057", "data:ecf1eeb6f41d8b49af6a30993158b3d10d9a473a", "device_os:KTU84P", "device_os_type:userdebug", "device_type:hammerhead", "gerrit:https://chromium-review.googlesource.com/c/1611258/8", "master:tryserver.chromium.android", "name:vr_android_unittests", "os:Android", "patch_project:chromium/src", "pool:Chrome", "priority:30", "project:chromium", "purpose:ManualTS", "purpose:luci", "purpose:pre-commit", "service_account:none", "slavename:swarm1789-c4", "spec_name:chromium.try:android-kitkat-arm-rel", "stepname:vr_android_unittests on Android device Nexus 5 (with patch)", "swarming.pool.template:none", "swarming.pool.version:720d2650fefc2551c724c60d45c7b64d5f666899", "user:None" ], "task_id": "44f0571af8b52b10", "try_number": "1" } ] }