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": "cpu_governor", "value": [ "powersave" ] }, { "key": "device_gms_core_version", "value": [ "6.7.79" ] }, { "key": "device_os", "value": [ "L", "LMY48I" ] }, { "key": "device_os_flavor", "value": [ "google" ] }, { "key": "device_playstore_version", "value": [ "5.2.13" ] }, { "key": "device_type", "value": [ "hammerhead" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "id", "value": [ "build41-b1--device6" ] }, { "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": [ "4267-53b17d5" ] }, { "key": "temp_band", "value": [ ">=30" ] }, { "key": "zone", "value": [ "us", "us-mtv", "us-mtv-chops", "us-mtv-chops-b", "us-mtv-chops-b-1" ] } ], "bot_id": "build41-b1--device6", "bot_version": "bd68e04e43fc4d1b7b5b65890a29c5d5bae55ab1423851733f92abd7e13dda14", "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-04-23T17:15:36.363557", "costs_usd": [ 0.0054566956238128505 ], "created_ts": "2019-04-23T15:30:14.320130", "duration": 34.23840808868408, "modified_ts": "2019-04-23T17:15:36.363557", "name": "vr_android_unittests on Android device Nexus 5/Android/bdfdb91c2a/Lollipop Phone Tester/21521", "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/3bcbb9/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target vr_android_unittests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/iot7kQ2B/output.json\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 --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/iot7kQ2B/output.json\nI 0.007s Main condition '<lambda>' met\nI 0.009s Main condition '<lambda>' met\nI 3.150s TimeoutThread-1-for-prepare_device(078080502517f84b) condition 'sd_card_ready' met (0.0s)\nI 3.432s TimeoutThread-1-for-prepare_device(078080502517f84b) condition 'pm_ready' met (0.3s)\nI 3.448s TimeoutThread-1-for-prepare_device(078080502517f84b) condition 'boot_completed' met (0.3s)\nI 17.429s calculate_device_checksums condition '<lambda>' met (0.1s)\nI 19.195s TimeoutThread-1-for-individual_device_set_up(078080502517f84b) Pushing 2530 files via .zip of size 6101723\nI 25.097s list_tests(078080502517f84b) flags:\nI 25.097s list_tests(078080502517f84b) --gtest_list_tests\nI 26.481s list_tests(078080502517f84b) /storage/emulated/legacy/temp_file-a8627497444d.gtest_out size on device: 446\nI 26.564s Main Using external sharding settings. This is shard 0/1\nI 26.564s Main STARTING TRY #1/3\nI 26.564s Main Will run 4 tests on 1 devices: 078080502517f84b\nW 26.613s run_tests_on_device(078080502517f84b) No tombstones to clear.\nI 28.832s run_tests_on_device(078080502517f84b) flags:\nI 28.832s run_tests_on_device(078080502517f84b) Getting logdog client.\nI 30.364s run_tests_on_device(078080502517f84b) /storage/emulated/legacy/temp_file-8a782e0ebb92b.gtest_out size on device: 1234\nI 30.461s run_tests_on_device(078080502517f84b) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F4463a32cdc5d4311%2F%2B%2Flogcat_logcat_-1765853114214702429_20190423T171531-UTC_078080502517f84b\nI 30.461s archive Writing text to logdog stream, logcat_logcat_-1765853114214702429_20190423T171531-UTC_078080502517f84b\nI 30.895s run_tests_on_device(078080502517f84b) [ERROR:memory_mapped_file.cc(53)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 30.895s run_tests_on_device(078080502517f84b) [ERROR:data_pack.cc(250)] Failed to mmap datapack\nI 30.895s run_tests_on_device(078080502517f84b) [ERROR:memory_mapped_file.cc(53)] Couldn't open /storage/emulated/0/chromium_tests_root/paks/vr_test.pak\nI 30.895s run_tests_on_device(078080502517f84b) [ERROR:data_pack.cc(250)] Failed to mmap datapack\nI 30.895s run_tests_on_device(078080502517f84b) >>ScopedMainEntryLogger\nI 30.895s run_tests_on_device(078080502517f84b) Note: Google Test filter = ArCoreDeviceTest.GetFrameData:ArCoreDeviceTest.RequestHitTest:ArCoreDeviceTest.RequestSession:ArCoreDeviceTest.SetDisplayGeometry\nI 30.895s run_tests_on_device(078080502517f84b) [==========] Running 4 tests from 1 test suite.\nI 30.895s run_tests_on_device(078080502517f84b) [----------] Global test environment set-up.\nI 30.895s run_tests_on_device(078080502517f84b) [----------] 4 tests from ArCoreDeviceTest\nI 30.895s run_tests_on_device(078080502517f84b) [ RUN ] ArCoreDeviceTest.RequestSession\nI 30.895s run_tests_on_device(078080502517f84b) [ OK ] ArCoreDeviceTest.RequestSession (45 ms)\nI 30.895s run_tests_on_device(078080502517f84b) [ RUN ] ArCoreDeviceTest.GetFrameData\nI 30.895s run_tests_on_device(078080502517f84b) [ OK ] ArCoreDeviceTest.GetFrameData (24 ms)\nI 30.896s run_tests_on_device(078080502517f84b) [ RUN ] ArCoreDeviceTest.SetDisplayGeometry\nI 30.896s run_tests_on_device(078080502517f84b) [ OK ] ArCoreDeviceTest.SetDisplayGeometry (19 ms)\nI 30.896s run_tests_on_device(078080502517f84b) [ RUN ] ArCoreDeviceTest.RequestHitTest\nI 30.896s run_tests_on_device(078080502517f84b) [ OK ] ArCoreDeviceTest.RequestHitTest (20 ms)\nI 30.896s run_tests_on_device(078080502517f84b) [----------] 4 tests from ArCoreDeviceTest (111 ms total)\nI 30.896s run_tests_on_device(078080502517f84b) \nI 30.896s run_tests_on_device(078080502517f84b) [----------] Global test environment tear-down\nI 30.896s run_tests_on_device(078080502517f84b) [==========] 4 tests from 1 test suite ran. (111 ms total)\nI 30.896s run_tests_on_device(078080502517f84b) [ PASSED ] 4 tests.\nI 30.896s run_tests_on_device(078080502517f84b) <<ScopedMainEntryLogger\nI 30.897s run_tests_on_device(078080502517f84b) Finished running tests on this device.\nI 30.902s Main FINISHED TRY #1/3\nI 30.902s Main All tests completed.\nC 30.902s Main ********************************************************************************\nC 30.902s Main Summary\nC 30.902s Main ********************************************************************************\nC 30.903s Main [==========] 4 tests ran.\nC 30.903s Main [ PASSED ] 4 tests.\nC 30.903s Main ********************************************************************************\nI 31.667s tear_down_device(078080502517f84b) Wrote device cache: /b/swarming/w/ir/out/Debug/device_cache_078080502517f84b.json\nI 31.668s Main Generated json results file at /b/swarming/w/itqyBJqK/tmp7D22hz\nI 31.668s Main Finishing archiving output.\n[W2019-04-23T17:15:34.021057Z 15537 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-04-23T17:15:34.066431Z 15537 0 main.go:205] Butler terminated with error. {\"error\":\"context canceled\"}\n[E2019-04-23T17:15:34.066473Z 15537 0 main.go:233] Failed to serve.\noriginal error: context canceled\n\n[I2019-04-23T17:15:34.066659Z 15537 0 main.go:349] Terminating. {\"returnCode\":250}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' met\n", "outputs_ref": { "isolated": "501cf1c3df9bee07e2d3c08405431daa7475f369", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "4463a32cdc5d4311", "server_versions": [ "4267-53b17d5" ], "started_ts": "2019-04-23T17:14:48.999786", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:Lollipop Phone Tester", "buildnumber:21521", "data:bdfdb91c2a9a6aae9add54a66aef1bc8518ae1ec", "device_os:LMY48I", "device_type:hammerhead", "master:chromium.android", "name:vr_android_unittests", "os:Android", "pool:Chrome", "priority:25", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm98-c4", "spec_name:chromium.ci:Lollipop Phone Tester", "stepname:vr_android_unittests on Android device Nexus 5", "swarming.pool.template:none", "swarming.pool.version:6b864aae429ce845be54cda3f4ca1317a092e4bf", "user:None" ], "task_id": "4463a32cdc5d4310", "try_number": "1" } ] }