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", "LMY49B" ] }, { "key": "device_os_flavor", "value": [ "google" ] }, { "key": "device_playstore_version", "value": [ "5.2.13" ] }, { "key": "device_type", "value": [ "flo" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "id", "value": [ "build135-b1--device2" ] }, { "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": [ "4201-b04f7f8" ] }, { "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": "build135-b1--device2", "bot_version": "51d929b905e4fffb3652f17e0ff8dceb0f7077275d215d276fb6c5a2f238b3f7", "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": "OAXVAmcUSrvDygYUrCDzv20LRono9938YOHPu0zKowgC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "ucaOciwAE9aweCUDOrmSvyiwrjmbywuB0NzAGUXIHjAC" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": "bin", "version": "a57ad614c01fec9fa4259473c8ea3fd992d7c349" } ] }, "completed_ts": "2019-03-16T16:55:04.708106", "cost_saved_usd": 0.037341053271797944, "created_ts": "2019-03-18T15:27:29.629785", "deduped_from": "43a03a2d998a1611", "duration": 317.9522030353546, "modified_ts": "2019-03-18T15:27:29.642043", "name": "ipc_tests on Android device Nexus 7 [2013]/Android/666631b7f0/Lollipop Tablet Tester/13305", "output": "Additional 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/9ede37/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target ipc_tests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/io4zrYDd/output.json\n\nI 0.000s Main command: ../../build/android/test_runner.py gtest --suite ipc_tests --output-directory . --runtime-deps-path gen.runtime/ipc/ipc_tests__test_runner_script.runtime_deps -v --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/io4zrYDd/output.json\nI 0.006s Main condition '<lambda>' met\nI 0.008s Main condition '<lambda>' met\nI 3.171s TimeoutThread-1-for-prepare_device(0a06fabe) condition 'sd_card_ready' met (0.0s)\nI 3.601s TimeoutThread-1-for-prepare_device(0a06fabe) condition 'pm_ready' met (0.5s)\nI 3.621s TimeoutThread-1-for-prepare_device(0a06fabe) condition 'boot_completed' met (0.5s)\nI 10.910s calculate_device_checksums condition '<lambda>' met (0.1s)\nI 12.946s list_tests(0a06fabe) flags:\nI 12.946s list_tests(0a06fabe) --gtest_list_tests\nI 14.646s list_tests(0a06fabe) /storage/emulated/legacy/temp_file-4a651b6716210.gtest_out size on device: 2823\nI 14.714s Main Using external sharding settings. This is shard 0/1\nI 14.714s Main STARTING TRY #1/3\nI 14.714s Main Will run 88 tests on 1 devices: 0a06fabe\nW 14.763s run_tests_on_device(0a06fabe) No tombstones to clear.\nI 20.411s run_tests_on_device(0a06fabe) flags:\nI 20.411s run_tests_on_device(0a06fabe) Getting logdog client.\nI 20.530s TimeoutThread-1-for-run_tests_on_device(0a06fabe) Large shell command will be run from file: ( p=org.chromium.native_test;am instrument -w -e \"$p\".NativeTestInstrumentationTestRunner.ShardNanoTimeout 120000000000 -e \"$p\".NativeTestInstrumentationTestRunner.NativeTestActivity \"$p\".NativeUnitTestActivity -e \"$p\".NativeTest.RunInSubThread 1 -e \"$p\".NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-102da49ad0484 -e \"$p\".NativeTestInstrumentationTestRunner.StdoutFile /storage/emulated/legacy/temp_file-b4b7de31faf23.gtest_out \"$p\"/\"$p\".NativeTestInstrumentationTestRunner )>/data/loca ...\nI 80.616s run_tests_on_device(0a06fabe) Still working on StartInstrumentation(0a06fabe, org.chromium.native_test/org.chromium.native_test.NativeTestInstrumentationTestRunner, retries=0, extras={'org.chromium.native_test.NativeTestInstrumentationTestRunner.ShardNanoTimeout': 120000000000, 'org.chromium.native_test.NativeTestInstrumentationTestRunner.NativeTestActivity': 'org.chromium.native_test.NativeUnitTestActivity', 'org.chromium.native_test.NativeTest.RunInSubThread': 1, 'org.chromium.native_test.NativeTestInstrumentationTestRunner.TestList': '/data/local/tmp/temp_file-102da49ad0484', 'org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile': '/storage/emulated/legacy/temp_file-b4b7de31faf23.gtest_out'}, timeout=120.0, raw=False)\nE 134.677s run_tests_on_device(0a06fabe) gtest shard timed out.\nTraceback (most recent call last):\n File \"/b/swarming/w/ir/build/android/pylib/local/device/local_device_gtest_run.py\", line 186, in Run\n self._component, extras=extras, raw=False, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 57, in timeout_retry_wrapper\n retry_if_func=retry_if_func)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py\", line 158, in Run\n error_log_func=error_log_func)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 198, in JoinAll\n self._JoinAll(watcher, timeout)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 170, in _JoinAll\n thread.ReraiseIfException()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 93, in run\n self._ret = self._func(*self._args, **self._kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py\", line 151, in <lambda>\n child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1373, in StartInstrumentation\n large_output=True)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 51, in timeout_retry_wrapper\n return impl()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1192, in RunShellCommand\n output = handle_large_output(cmd, large_output)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1157, in handle_large_output\n handle_large_command(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1149, in handle_large_command\n return handle_check_return('sh %s' % script.name_quoted)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1134, in handle_check_return\n return run(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1130, in run\n return self.adb.Shell(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 533, in Shell\n output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 316, in _RunDeviceAdbCmd\n check_error=check_error)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 51, in timeout_retry_wrapper\n return impl()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 277, in _RunAdbCmd\n timeout, env=cls._ADB_ENV)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py\", line 425, in GetCmdStatusAndOutputWithTimeout\n raise TimeoutError(output.getvalue())\nCommandTimeoutError: Timeout\nI 134.744s run_tests_on_device(0a06fabe) /storage/emulated/legacy/temp_file-b4b7de31faf23.gtest_out size on device: 5003\nI 134.857s run_tests_on_device(0a06fabe) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43a03a2d998a1611%2F%2B%2Flogcat_logcat_-2539549519116039332_20190316T165008-UTC_0a06fabe\nI 134.859s archive Writing text to logdog stream, logcat_logcat_-2539549519116039332_20190316T165008-UTC_0a06fabe\nI 135.769s run_tests_on_device(0a06fabe) >>ScopedMainEntryLogger\nI 135.769s run_tests_on_device(0a06fabe) Note: Google Test filter = ChannelReaderTest.InvalidMessageSize:ChannelReaderTest.ResizeOverflowBuffer:ChannelReaderTest.TrimBuffer:IPCChannelBadMessageTest.BadMessage:IPCChannelMojoSharedMemoryRegionTypedTest/0.Send:IPCChannelMojoSharedMemoryRegionTypedTest/1.Send:IPCChannelMojoSharedMemoryRegionTypedTest/2.Send:IPCChannelMojoTest.ConnectedFromClient:IPCChannelMojoTest.NoImplicitChannelClosure:IPCChannelMojoTest.ParamTraitInvalidMessagePipe:IPCChannelMojoTest.ParamTraitValidMessagePipe:IPCChannelMojoTest.SendFailAfterClose:IPCChannelMojoTest.SendFailWithPendingMessages:IPCChannelMojoTest.SendMessagePipe:IPCChannelMojoTest.SendPlatformFile:IPCChannelMojoTest.SendPlatformFileAndMessagePipe:IPCChannelMojoTest.SendSharedMemory:IPCChannelMojoTest.SimpleAssociatedInterface:IPCChannelProxyMojoTest.AssociatedRequestClose:IPCChannelProxyMojoTest.Pause:IPCChannelProxyMojoTest.ProxyThreadAssociatedInterface:IPCChannelProxyMojoTest.ProxyThreadAssociatedInterfaceIndirect:IPCChannelProxyMojoTest.SyncAssociatedInterface:IPCChannelProxyTest.BadMessageOnIPCThread:IPCChannelProxyTest.BadMessageOnListenerThread:IPCChannelProxyTest.FilterRemoval:IPCChannelProxyTest.GlobalAndMessageClassFilters:IPCChannelProxyTest.MessageClassFilters:IPCFuzzingTest.MsgBadPayloadArgs:IPCFuzzingTest.MsgBadPayloadShort:IPCFuzzingTest.SanityTest:IPCMessageIntegrity.ReadBeyondBufferStr:IPCMessageIntegrity.ReadBeyondBufferStr16:IPCMessageIntegrity.ReadBytesBadIterator:IPCMessageIntegrity.ReadVectorNegativeSize:IPCMessageIntegrity.ReadVectorTooLarge2:IPCMessageParameterTest.EmptyDispatcherWithParam:IPCMessageRepeatedFieldUtilsTest.EmptyRepeatedFieldShouldBeSerialized:IPCMessageRepeatedFieldUtilsTest.InvalidPickleShouldNotCrashRepeatedFieldDeserialization:IPCMessageRepeatedFieldUtilsTest.PartialEmptyRepeatedFieldShouldBeSerialized:IPCMessageRepeatedFieldUtilsTest.RepeatedFieldShouldBeSerialized:IPCMessageTest.BasicMessageTest:IPCMessageTest.DictionaryValue:IPCMessageTest.FindNext:IPCMessageTest.FindNextOverflow:IPCMessageTest.ListValue:IPCMessageUtilsTest.FlatMap:IPCMessageUtilsTest.MojoChannelHandle:IPCMessageUtilsTest.NestedMessages:IPCMessageUtilsTest.OptionalSet:IPCMessageUtilsTest.OptionalUnset:IPCMessageUtilsTest.ParameterValidation:IPCMessageUtilsTest.SharedMemoryHandle:IPCMessageUtilsTest.StackVector:IPCMessageUtilsTest.UnguessableTokenTest:IPCMojoBootstrapTest.Connect:IPCMojoBootstrapTest.ReceiveEmptyMessage:IPCSendFdsTest.DescriptorTest:IPCSyncChannelTest.DelayReply:IPCSyncChannelTest.Multiple:IPCSyncChannelTest.NoHang:IPCSyncChannelTest.QueuedReply:IPCSyncChannelTest.Recursive:IPCSyncChannelTest.RecursiveNoHang:IPCSyncChannelTest.ReentrantReply:IPCSyncChannelTest.RestrictedDispatch:IPCSyncChannelTest.RestrictedDispatchDeadlock:IPCSyncChannelTest.SendAfterClose:IPCSyncChannelTest.SyncMessageFilter:IPCSyncChannelTest.TwoStepInitialization:IPCSyncChannelTest.Unblock:IPCSyncMessageTest.Main:MessageAttachmentSet.BasicAdd:MessageAttachmentSet.BasicAddAndClose:MessageAttachmentSet.DoClose:MessageAttachmentSet.MaxSize:MessageAttachmentSet.WalkInOrder:MessageAttachmentSet.WalkWrongOrder:SharedMemoryRegionTypedTest/0.InvalidRegion:SharedMemoryRegionTypedTest/0.WriteAndRead:SharedMemoryRegionTypedTest/1.InvalidRegion:SharedMemoryRegionTypedTest/1.WriteAndRead:SharedMemoryRegionTypedTest/2.InvalidRegion:SharedMemoryRegionTypedTest/2.WriteAndRead:SyncSocketTest.BlockingReceiveTest:SyncSocketTest.DisconnectTest:SyncSocketTest.NonBlockingWriteTest:SyncSocketTest.SanityTest\nI 135.770s run_tests_on_device(0a06fabe) [==========] Running 88 tests from 23 test suites.\nI 135.770s run_tests_on_device(0a06fabe) [----------] Global test environment set-up.\nI 135.770s run_tests_on_device(0a06fabe) [----------] 11 tests from IPCChannelMojoTest\nI 135.770s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.ConnectedFromClient\nI 135.770s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.ConnectedFromClient (195 ms)\nI 135.770s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendFailWithPendingMessages\nI 135.770s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendFailWithPendingMessages (2517 ms)\nI 135.770s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.NoImplicitChannelClosure\nI 135.770s run_tests_on_device(0a06fabe) [ERROR:validation_errors.cc(76)] Invalid message: VALIDATION_ERROR_UNEXPECTED_NULL_POINTER (null field 1)\nI 135.770s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.NoImplicitChannelClosure (154 ms)\nI 135.770s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendMessagePipe\nI 135.770s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendMessagePipe (159 ms)\nI 135.770s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.ParamTraitValidMessagePipe\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.ParamTraitValidMessagePipe (187 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.ParamTraitInvalidMessagePipe\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.ParamTraitInvalidMessagePipe (152 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendFailAfterClose\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendFailAfterClose (189 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SimpleAssociatedInterface\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SimpleAssociatedInterface (283 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendSharedMemory\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendSharedMemory (189 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendPlatformFile\nI 135.771s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendPlatformFile (171 ms)\nI 135.771s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendPlatformFileAndMessagePipe\nW 135.823s run_tests_on_device(0a06fabe) No tombstones to clear.\nI 141.447s run_tests_on_device(0a06fabe) flags:\nI 141.564s TimeoutThread-1-for-run_tests_on_device(0a06fabe) Large shell command will be run from file: ( p=org.chromium.native_test;am instrument -w -e \"$p\".NativeTestInstrumentationTestRunner.ShardNanoTimeout 120000000000 -e \"$p\".NativeTestInstrumentationTestRunner.NativeTestActivity \"$p\".NativeUnitTestActivity -e \"$p\".NativeTest.RunInSubThread 1 -e \"$p\".NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-79c5291f9789d -e \"$p\".NativeTestInstrumentationTestRunner.StdoutFile /storage/emulated/legacy/temp_file-32242a1c0e51d.gtest_out \"$p\"/\"$p\".NativeTestInstrumentationTestRunner )>/data/loca ...\nI 201.554s run_tests_on_device(0a06fabe) Still working on StartInstrumentation(0a06fabe, org.chromium.native_test/org.chromium.native_test.NativeTestInstrumentationTestRunner, retries=0, extras={'org.chromium.native_test.NativeTestInstrumentationTestRunner.ShardNanoTimeout': 120000000000, 'org.chromium.native_test.NativeTestInstrumentationTestRunner.NativeTestActivity': 'org.chromium.native_test.NativeUnitTestActivity', 'org.chromium.native_test.NativeTest.RunInSubThread': 1, 'org.chromium.native_test.NativeTestInstrumentationTestRunner.TestList': '/data/local/tmp/temp_file-79c5291f9789d', 'org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile': '/storage/emulated/legacy/temp_file-32242a1c0e51d.gtest_out'}, timeout=120.0, raw=False)\nE 255.709s run_tests_on_device(0a06fabe) gtest shard timed out.\nTraceback (most recent call last):\n File \"/b/swarming/w/ir/build/android/pylib/local/device/local_device_gtest_run.py\", line 186, in Run\n self._component, extras=extras, raw=False, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 57, in timeout_retry_wrapper\n retry_if_func=retry_if_func)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py\", line 158, in Run\n error_log_func=error_log_func)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 198, in JoinAll\n self._JoinAll(watcher, timeout)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 170, in _JoinAll\n thread.ReraiseIfException()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py\", line 93, in run\n self._ret = self._func(*self._args, **self._kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py\", line 151, in <lambda>\n child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1373, in StartInstrumentation\n large_output=True)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 51, in timeout_retry_wrapper\n return impl()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1192, in RunShellCommand\n output = handle_large_output(cmd, large_output)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1157, in handle_large_output\n handle_large_command(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1149, in handle_large_command\n return handle_check_return('sh %s' % script.name_quoted)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1134, in handle_check_return\n return run(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py\", line 1130, in run\n return self.adb.Shell(cmd)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 533, in Shell\n output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 316, in _RunDeviceAdbCmd\n check_error=check_error)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 51, in timeout_retry_wrapper\n return impl()\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py\", line 47, in impl\n return f(*args, **kwargs)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py\", line 277, in _RunAdbCmd\n timeout, env=cls._ADB_ENV)\n File \"/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py\", line 425, in GetCmdStatusAndOutputWithTimeout\n raise TimeoutError(output.getvalue())\nCommandTimeoutError: Timeout\nI 255.775s run_tests_on_device(0a06fabe) /storage/emulated/legacy/temp_file-32242a1c0e51d.gtest_out size on device: 5203\nI 255.879s run_tests_on_device(0a06fabe) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43a03a2d998a1611%2F%2B%2Flogcat_logcat_-4461937752809258231_20190316T165209-UTC_0a06fabe\nI 255.881s archive Writing text to logdog stream, logcat_logcat_-4461937752809258231_20190316T165209-UTC_0a06fabe\nI 256.688s run_tests_on_device(0a06fabe) >>ScopedMainEntryLogger\nI 256.688s run_tests_on_device(0a06fabe) Note: Google Test filter = SharedMemoryRegionTypedTest/2.InvalidRegion:SyncSocketTest.NonBlockingWriteTest:IPCChannelProxyTest.BadMessageOnIPCThread:IPCSyncChannelTest.Recursive:IPCMessageUtilsTest.MojoChannelHandle:IPCMojoBootstrapTest.ReceiveEmptyMessage:IPCMessageUtilsTest.OptionalSet:IPCChannelProxyMojoTest.SyncAssociatedInterface:IPCMessageUtilsTest.OptionalUnset:IPCMessageIntegrity.ReadVectorTooLarge2:IPCMessageRepeatedFieldUtilsTest.RepeatedFieldShouldBeSerialized:IPCMessageTest.DictionaryValue:IPCMessageUtilsTest.UnguessableTokenTest:IPCSyncChannelTest.DelayReply:IPCMojoBootstrapTest.Connect:IPCFuzzingTest.MsgBadPayloadShort:IPCChannelProxyTest.FilterRemoval:SharedMemoryRegionTypedTest/1.WriteAndRead:IPCChannelProxyTest.MessageClassFilters:IPCSyncChannelTest.RestrictedDispatch:IPCMessageTest.FindNext:IPCSyncChannelTest.Multiple:IPCMessageUtilsTest.StackVector:IPCSyncChannelTest.NoHang:IPCMessageRepeatedFieldUtilsTest.EmptyRepeatedFieldShouldBeSerialized:IPCSyncChannelTest.QueuedReply:MessageAttachmentSet.WalkInOrder:IPCChannelProxyMojoTest.ProxyThreadAssociatedInterface:IPCSyncChannelTest.ReentrantReply:IPCChannelProxyMojoTest.AssociatedRequestClose:IPCSyncChannelTest.RestrictedDispatchDeadlock:IPCMessageUtilsTest.ParameterValidation:IPCMessageTest.ListValue:MessageAttachmentSet.DoClose:IPCMessageRepeatedFieldUtilsTest.PartialEmptyRepeatedFieldShouldBeSerialized:IPCChannelProxyTest.BadMessageOnListenerThread:IPCMessageTest.BasicMessageTest:IPCFuzzingTest.SanityTest:IPCChannelMojoSharedMemoryRegionTypedTest/2.Send:IPCSendFdsTest.DescriptorTest:IPCMessageParameterTest.EmptyDispatcherWithParam:IPCMessageUtilsTest.NestedMessages:IPCSyncChannelTest.RecursiveNoHang:IPCMessageIntegrity.ReadBytesBadIterator:IPCMessageRepeatedFieldUtilsTest.InvalidPickleShouldNotCrashRepeatedFieldDeserialization:IPCSyncChannelTest.Unblock:IPCChannelProxyMojoTest.ProxyThreadAssociatedInterfaceIndirect:IPCSyncChannelTest.TwoStepInitialization:SharedMemoryRegionTypedTest/0.InvalidRegion:IPCMessageTest.FindNextOverflow:MessageAttachmentSet.BasicAdd:ChannelReaderTest.ResizeOverflowBuffer:SyncSocketTest.SanityTest:IPCChannelProxyMojoTest.Pause:IPCChannelProxyTest.GlobalAndMessageClassFilters:SharedMemoryRegionTypedTest/0.WriteAndRead:SharedMemoryRegionTypedTest/2.WriteAndRead:MessageAttachmentSet.BasicAddAndClose:MessageAttachmentSet.MaxSize:IPCMessageUtilsTest.FlatMap:SyncSocketTest.DisconnectTest:IPCChannelMojoSharedMemoryRegionTypedTest/1.Send:IPCSyncChannelTest.SyncMessageFilter:IPCSyncChannelTest.SendAfterClose:IPCFuzzingTest.MsgBadPayloadArgs:IPCSyncMessageTest.Main:ChannelReaderTest.TrimBuffer:SharedMemoryRegionTypedTest/1.InvalidRegion:ChannelReaderTest.InvalidMessageSize:IPCChannelMojoSharedMemoryRegionTypedTest/0.Send:SyncSocketTest.BlockingReceiveTest:MessageAttachmentSet.WalkWrongOrder:IPCMessageIntegrity.ReadVectorNegativeSize:IPCChannelBadMessageTest.BadMessage:IPCMessageIntegrity.ReadBeyondBufferStr16:IPCMessageUtilsTest.SharedMemoryHandle:IPCMessageIntegrity.ReadBeyondBufferStr\nI 256.688s run_tests_on_device(0a06fabe) [==========] Running 77 tests from 22 test suites.\nI 256.688s run_tests_on_device(0a06fabe) [----------] Global test environment set-up.\nI 256.688s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCChannelProxyMojoTest\nI 256.688s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyMojoTest.ProxyThreadAssociatedInterface\nI 256.688s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyMojoTest.ProxyThreadAssociatedInterface (387 ms)\nI 256.688s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyMojoTest.ProxyThreadAssociatedInterfaceIndirect\nI 256.688s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyMojoTest.ProxyThreadAssociatedInterfaceIndirect (256 ms)\nI 256.689s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyMojoTest.SyncAssociatedInterface\nI 256.689s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyMojoTest.SyncAssociatedInterface (196 ms)\nI 256.689s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyMojoTest.Pause\nI 256.689s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyMojoTest.Pause (152 ms)\nI 256.689s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyMojoTest.AssociatedRequestClose\nI 256.689s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyMojoTest.AssociatedRequestClose (199 ms)\nI 256.689s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCChannelProxyMojoTest (1200 ms total)\nI 256.689s run_tests_on_device(0a06fabe) \nI 256.689s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/0, where TypeParam = <type>\nI 256.689s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoSharedMemoryRegionTypedTest/0.Send\nI 256.689s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoSharedMemoryRegionTypedTest/0.Send (167 ms)\nI 256.689s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/0 (168 ms total)\nI 256.689s run_tests_on_device(0a06fabe) \nI 256.690s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/1, where TypeParam = <type>\nI 256.690s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoSharedMemoryRegionTypedTest/1.Send\nI 256.690s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoSharedMemoryRegionTypedTest/1.Send (156 ms)\nI 256.690s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/1 (156 ms total)\nI 256.690s run_tests_on_device(0a06fabe) \nI 256.690s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/2, where TypeParam = <type>\nI 256.690s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoSharedMemoryRegionTypedTest/2.Send\nI 256.690s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoSharedMemoryRegionTypedTest/2.Send (205 ms)\nI 256.690s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoSharedMemoryRegionTypedTest/2 (207 ms total)\nI 256.690s run_tests_on_device(0a06fabe) \nI 256.690s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCChannelProxyTest\nI 256.690s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.MessageClassFilters\nI 256.690s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyTest.MessageClassFilters (191 ms)\nI 256.690s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.GlobalAndMessageClassFilters\nI 256.691s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyTest.GlobalAndMessageClassFilters (171 ms)\nI 256.691s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.FilterRemoval\nW 256.791s run_tests_on_device(0a06fabe) No tombstones to clear.\nI 262.332s run_tests_on_device(0a06fabe) flags:\nI 262.451s TimeoutThread-1-for-run_tests_on_device(0a06fabe) Large shell command will be run from file: ( p=org.chromium.native_test;am instrument -w -e \"$p\".NativeTestInstrumentationTestRunner.ShardNanoTimeout 120000000000 -e \"$p\".NativeTestInstrumentationTestRunner.NativeTestActivity \"$p\".NativeUnitTestActivity -e \"$p\".NativeTest.RunInSubThread 1 -e \"$p\".NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-ccffde1e00c9e -e \"$p\".NativeTestInstrumentationTestRunner.StdoutFile /storage/emulated/legacy/temp_file-3790a98cebf8a.gtest_out \"$p\"/\"$p\".NativeTestInstrumentationTestRunner )>/data/loca ...\nI 266.515s run_tests_on_device(0a06fabe) /storage/emulated/legacy/temp_file-3790a98cebf8a.gtest_out size on device: 12444\nI 266.619s run_tests_on_device(0a06fabe) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43a03a2d998a1611%2F%2B%2Flogcat_logcat_-192216178872463385_20190316T165410-UTC_0a06fabe\nI 266.620s archive Writing text to logdog stream, logcat_logcat_-192216178872463385_20190316T165410-UTC_0a06fabe\nI 267.139s run_tests_on_device(0a06fabe) >>ScopedMainEntryLogger\nI 267.140s run_tests_on_device(0a06fabe) Note: Google Test filter = SharedMemoryRegionTypedTest/2.InvalidRegion:SyncSocketTest.NonBlockingWriteTest:IPCChannelProxyTest.BadMessageOnIPCThread:IPCSyncChannelTest.RestrictedDispatch:IPCMessageUtilsTest.MojoChannelHandle:IPCMojoBootstrapTest.ReceiveEmptyMessage:IPCMessageUtilsTest.OptionalSet:IPCMessageUtilsTest.OptionalUnset:IPCMessageRepeatedFieldUtilsTest.RepeatedFieldShouldBeSerialized:IPCMessageTest.DictionaryValue:IPCMessageUtilsTest.UnguessableTokenTest:IPCSyncChannelTest.DelayReply:IPCMessageUtilsTest.ParameterValidation:SharedMemoryRegionTypedTest/1.WriteAndRead:IPCSyncChannelTest.Recursive:IPCMessageTest.FindNext:IPCSyncChannelTest.Multiple:IPCMessageUtilsTest.StackVector:IPCMessageRepeatedFieldUtilsTest.EmptyRepeatedFieldShouldBeSerialized:IPCMojoBootstrapTest.Connect:MessageAttachmentSet.WalkInOrder:IPCSyncChannelTest.NoHang:IPCSyncChannelTest.RestrictedDispatchDeadlock:MessageAttachmentSet.BasicAddAndClose:SharedMemoryRegionTypedTest/1.InvalidRegion:MessageAttachmentSet.DoClose:IPCMessageRepeatedFieldUtilsTest.PartialEmptyRepeatedFieldShouldBeSerialized:IPCChannelProxyTest.BadMessageOnListenerThread:IPCMessageTest.BasicMessageTest:IPCFuzzingTest.SanityTest:IPCSyncChannelTest.ReentrantReply:IPCSendFdsTest.DescriptorTest:IPCMessageParameterTest.EmptyDispatcherWithParam:IPCMessageUtilsTest.NestedMessages:IPCMessageIntegrity.ReadBytesBadIterator:IPCMessageRepeatedFieldUtilsTest.InvalidPickleShouldNotCrashRepeatedFieldDeserialization:IPCSyncChannelTest.Unblock:IPCSyncChannelTest.QueuedReply:IPCSyncChannelTest.TwoStepInitialization:SharedMemoryRegionTypedTest/0.InvalidRegion:IPCMessageTest.FindNextOverflow:IPCFuzzingTest.MsgBadPayloadShort:SyncSocketTest.SanityTest:MessageAttachmentSet.MaxSize:MessageAttachmentSet.BasicAdd:SharedMemoryRegionTypedTest/0.WriteAndRead:SharedMemoryRegionTypedTest/2.WriteAndRead:ChannelReaderTest.ResizeOverflowBuffer:IPCMessageIntegrity.ReadVectorTooLarge2:IPCMessageUtilsTest.FlatMap:SyncSocketTest.DisconnectTest:IPCSyncChannelTest.SyncMessageFilter:IPCSyncChannelTest.SendAfterClose:IPCFuzzingTest.MsgBadPayloadArgs:IPCSyncMessageTest.Main:ChannelReaderTest.TrimBuffer:IPCMessageTest.ListValue:ChannelReaderTest.InvalidMessageSize:IPCSyncChannelTest.RecursiveNoHang:SyncSocketTest.BlockingReceiveTest:MessageAttachmentSet.WalkWrongOrder:IPCMessageIntegrity.ReadVectorNegativeSize:IPCChannelBadMessageTest.BadMessage:IPCMessageIntegrity.ReadBeyondBufferStr16:IPCMessageUtilsTest.SharedMemoryHandle:IPCMessageIntegrity.ReadBeyondBufferStr\nI 267.140s run_tests_on_device(0a06fabe) [==========] Running 66 tests from 18 test suites.\nI 267.140s run_tests_on_device(0a06fabe) [----------] Global test environment set-up.\nI 267.140s run_tests_on_device(0a06fabe) [----------] 2 tests from IPCChannelProxyTest\nI 267.140s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.BadMessageOnListenerThread\nI 267.140s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyTest.BadMessageOnListenerThread (144 ms)\nI 267.140s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.BadMessageOnIPCThread\nI 267.140s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyTest.BadMessageOnIPCThread (231 ms)\nI 267.140s run_tests_on_device(0a06fabe) [----------] 2 tests from IPCChannelProxyTest (376 ms total)\nI 267.140s run_tests_on_device(0a06fabe) \nI 267.140s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelBadMessageTest\nI 267.140s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelBadMessageTest.BadMessage\nI 267.141s run_tests_on_device(0a06fabe) [ OK ] IPCChannelBadMessageTest.BadMessage (189 ms)\nI 267.141s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelBadMessageTest (191 ms total)\nI 267.141s run_tests_on_device(0a06fabe) \nI 267.141s run_tests_on_device(0a06fabe) [----------] 3 tests from ChannelReaderTest\nI 267.141s run_tests_on_device(0a06fabe) [ RUN ] ChannelReaderTest.ResizeOverflowBuffer\nI 267.141s run_tests_on_device(0a06fabe) [ OK ] ChannelReaderTest.ResizeOverflowBuffer (1 ms)\nI 267.141s run_tests_on_device(0a06fabe) [ RUN ] ChannelReaderTest.InvalidMessageSize\nI 267.141s run_tests_on_device(0a06fabe) [ERROR:ipc_channel_reader.cc(210)] IPC message is too big: 134217749\nI 267.141s run_tests_on_device(0a06fabe) [ERROR:ipc_channel_reader.cc(210)] IPC message is too big: 4294967295\nI 267.141s run_tests_on_device(0a06fabe) [ERROR:ipc_channel_reader.cc(210)] IPC message is too big: 2147483667\nI 267.141s run_tests_on_device(0a06fabe) [ OK ] ChannelReaderTest.InvalidMessageSize (2 ms)\nI 267.141s run_tests_on_device(0a06fabe) [ RUN ] ChannelReaderTest.TrimBuffer\nI 267.141s run_tests_on_device(0a06fabe) [ OK ] ChannelReaderTest.TrimBuffer (13 ms)\nI 267.142s run_tests_on_device(0a06fabe) [----------] 3 tests from ChannelReaderTest (16 ms total)\nI 267.142s run_tests_on_device(0a06fabe) \nI 267.142s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCMessageIntegrity\nI 267.142s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageIntegrity.ReadBeyondBufferStr\nI 267.142s run_tests_on_device(0a06fabe) [ OK ] IPCMessageIntegrity.ReadBeyondBufferStr (1 ms)\nI 267.142s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageIntegrity.ReadBeyondBufferStr16\nI 267.142s run_tests_on_device(0a06fabe) [ OK ] IPCMessageIntegrity.ReadBeyondBufferStr16 (0 ms)\nI 267.142s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageIntegrity.ReadBytesBadIterator\nI 267.142s run_tests_on_device(0a06fabe) [ OK ] IPCMessageIntegrity.ReadBytesBadIterator (1 ms)\nI 267.142s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageIntegrity.ReadVectorNegativeSize\nI 267.142s run_tests_on_device(0a06fabe) [ OK ] IPCMessageIntegrity.ReadVectorNegativeSize (1 ms)\nI 267.142s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageIntegrity.ReadVectorTooLarge2\nI 267.142s run_tests_on_device(0a06fabe) [ OK ] IPCMessageIntegrity.ReadVectorTooLarge2 (1 ms)\nI 267.142s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCMessageIntegrity (5 ms total)\nI 267.143s run_tests_on_device(0a06fabe) \nI 267.143s run_tests_on_device(0a06fabe) [----------] 3 tests from IPCFuzzingTest\nI 267.143s run_tests_on_device(0a06fabe) [ RUN ] IPCFuzzingTest.SanityTest\nI 267.143s run_tests_on_device(0a06fabe) [ OK ] IPCFuzzingTest.SanityTest (254 ms)\nI 267.143s run_tests_on_device(0a06fabe) [ RUN ] IPCFuzzingTest.MsgBadPayloadShort\nI 267.143s run_tests_on_device(0a06fabe) [ OK ] IPCFuzzingTest.MsgBadPayloadShort (171 ms)\nI 267.143s run_tests_on_device(0a06fabe) [ RUN ] IPCFuzzingTest.MsgBadPayloadArgs\nI 267.143s run_tests_on_device(0a06fabe) [ OK ] IPCFuzzingTest.MsgBadPayloadArgs (156 ms)\nI 267.143s run_tests_on_device(0a06fabe) [----------] 3 tests from IPCFuzzingTest (584 ms total)\nI 267.143s run_tests_on_device(0a06fabe) \nI 267.143s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCMessageTest\nI 267.143s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageTest.BasicMessageTest\nI 267.143s run_tests_on_device(0a06fabe) [ OK ] IPCMessageTest.BasicMessageTest (3 ms)\nI 267.143s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageTest.ListValue\nI 267.143s run_tests_on_device(0a06fabe) [ OK ] IPCMessageTest.ListValue (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageTest.DictionaryValue\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageTest.DictionaryValue (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageTest.FindNext\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageTest.FindNext (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageTest.FindNextOverflow\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageTest.FindNextOverflow (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [----------] 5 tests from IPCMessageTest (7 ms total)\nI 267.144s run_tests_on_device(0a06fabe) \nI 267.144s run_tests_on_device(0a06fabe) [----------] 1 test from IPCMessageParameterTest\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageParameterTest.EmptyDispatcherWithParam\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageParameterTest.EmptyDispatcherWithParam (0 ms)\nI 267.144s run_tests_on_device(0a06fabe) [----------] 1 test from IPCMessageParameterTest (1 ms total)\nI 267.144s run_tests_on_device(0a06fabe) \nI 267.144s run_tests_on_device(0a06fabe) [----------] 9 tests from IPCMessageUtilsTest\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.NestedMessages\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.NestedMessages (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.ParameterValidation\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.ParameterValidation (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.StackVector\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.StackVector (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.MojoChannelHandle\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.MojoChannelHandle (1 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.OptionalUnset\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.OptionalUnset (0 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.OptionalSet\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.OptionalSet (0 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.SharedMemoryHandle\nI 267.144s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.SharedMemoryHandle (0 ms)\nI 267.144s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.UnguessableTokenTest\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.UnguessableTokenTest (0 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageUtilsTest.FlatMap\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCMessageUtilsTest.FlatMap (0 ms)\nI 267.145s run_tests_on_device(0a06fabe) [----------] 9 tests from IPCMessageUtilsTest (9 ms total)\nI 267.145s run_tests_on_device(0a06fabe) \nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/0, where TypeParam = <type>\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/0.WriteAndRead\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/0.WriteAndRead (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/0.InvalidRegion\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/0.InvalidRegion (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/0 (2 ms total)\nI 267.145s run_tests_on_device(0a06fabe) \nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/1, where TypeParam = <type>\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/1.WriteAndRead\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/1.WriteAndRead (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/1.InvalidRegion\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/1.InvalidRegion (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/1 (2 ms total)\nI 267.145s run_tests_on_device(0a06fabe) \nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/2, where TypeParam = <type>\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/2.WriteAndRead\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/2.WriteAndRead (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] SharedMemoryRegionTypedTest/2.InvalidRegion\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] SharedMemoryRegionTypedTest/2.InvalidRegion (1 ms)\nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from SharedMemoryRegionTypedTest/2 (2 ms total)\nI 267.145s run_tests_on_device(0a06fabe) \nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from IPCMojoBootstrapTest\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCMojoBootstrapTest.Connect\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCMojoBootstrapTest.Connect (282 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCMojoBootstrapTest.ReceiveEmptyMessage\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCMojoBootstrapTest.ReceiveEmptyMessage (176 ms)\nI 267.145s run_tests_on_device(0a06fabe) [----------] 2 tests from IPCMojoBootstrapTest (461 ms total)\nI 267.145s run_tests_on_device(0a06fabe) \nI 267.145s run_tests_on_device(0a06fabe) [----------] 13 tests from IPCSyncChannelTest\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.TwoStepInitialization\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.TwoStepInitialization (35 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.DelayReply\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.DelayReply (16 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.NoHang\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.NoHang (17 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.Unblock\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.Unblock (35 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.Recursive\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.Recursive (76 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.RecursiveNoHang\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.RecursiveNoHang (66 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.Multiple\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.Multiple (62 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.QueuedReply\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.QueuedReply (31 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.SyncMessageFilter\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.SyncMessageFilter (9 ms)\nI 267.145s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.SendAfterClose\nI 267.145s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.SendAfterClose (4 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.RestrictedDispatch\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.RestrictedDispatch (18 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.RestrictedDispatchDeadlock\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.RestrictedDispatchDeadlock (19 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncChannelTest.ReentrantReply\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCSyncChannelTest.ReentrantReply (14 ms)\nI 267.146s run_tests_on_device(0a06fabe) [----------] 13 tests from IPCSyncChannelTest (405 ms total)\nI 267.146s run_tests_on_device(0a06fabe) \nI 267.146s run_tests_on_device(0a06fabe) [----------] 1 test from IPCSyncMessageTest\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCSyncMessageTest.Main\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCSyncMessageTest.Main (1 ms)\nI 267.146s run_tests_on_device(0a06fabe) [----------] 1 test from IPCSyncMessageTest (1 ms total)\nI 267.146s run_tests_on_device(0a06fabe) \nI 267.146s run_tests_on_device(0a06fabe) [----------] 4 tests from SyncSocketTest\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] SyncSocketTest.SanityTest\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] SyncSocketTest.SanityTest (136 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] SyncSocketTest.DisconnectTest\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] SyncSocketTest.DisconnectTest (2 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] SyncSocketTest.BlockingReceiveTest\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] SyncSocketTest.BlockingReceiveTest (2 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] SyncSocketTest.NonBlockingWriteTest\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] SyncSocketTest.NonBlockingWriteTest (5 ms)\nI 267.146s run_tests_on_device(0a06fabe) [----------] 4 tests from SyncSocketTest (149 ms total)\nI 267.146s run_tests_on_device(0a06fabe) \nI 267.146s run_tests_on_device(0a06fabe) [----------] 6 tests from MessageAttachmentSet\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.BasicAdd\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.BasicAdd (0 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.BasicAddAndClose\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.BasicAddAndClose (0 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.MaxSize\nI 267.146s run_tests_on_device(0a06fabe) [WARNING:ipc_message_attachment_set.cc(68)] Cannot add file descriptor. MessageAttachmentSet full.\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.MaxSize (2 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.WalkInOrder\nI 267.146s run_tests_on_device(0a06fabe) [WARNING:ipc_message_attachment_set.cc(115)] Attempted to double-read a message attachment, returning a nullptr\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.WalkInOrder (2 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.WalkWrongOrder\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.WalkWrongOrder (1 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] MessageAttachmentSet.DoClose\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] MessageAttachmentSet.DoClose (1 ms)\nI 267.146s run_tests_on_device(0a06fabe) [----------] 6 tests from MessageAttachmentSet (8 ms total)\nI 267.146s run_tests_on_device(0a06fabe) \nI 267.146s run_tests_on_device(0a06fabe) [----------] 1 test from IPCSendFdsTest\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCSendFdsTest.DescriptorTest\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCSendFdsTest.DescriptorTest (274 ms)\nI 267.146s run_tests_on_device(0a06fabe) [----------] 1 test from IPCSendFdsTest (274 ms total)\nI 267.146s run_tests_on_device(0a06fabe) \nI 267.146s run_tests_on_device(0a06fabe) [----------] 4 tests from IPCMessageRepeatedFieldUtilsTest\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageRepeatedFieldUtilsTest.RepeatedFieldShouldBeSerialized\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCMessageRepeatedFieldUtilsTest.RepeatedFieldShouldBeSerialized (1 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageRepeatedFieldUtilsTest.PartialEmptyRepeatedFieldShouldBeSerialized\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCMessageRepeatedFieldUtilsTest.PartialEmptyRepeatedFieldShouldBeSerialized (1 ms)\nI 267.146s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageRepeatedFieldUtilsTest.EmptyRepeatedFieldShouldBeSerialized\nI 267.146s run_tests_on_device(0a06fabe) [ OK ] IPCMessageRepeatedFieldUtilsTest.EmptyRepeatedFieldShouldBeSerialized (1 ms)\nI 267.147s run_tests_on_device(0a06fabe) [ RUN ] IPCMessageRepeatedFieldUtilsTest.InvalidPickleShouldNotCrashRepeatedFieldDeserialization\nI 267.147s run_tests_on_device(0a06fabe) [ OK ] IPCMessageRepeatedFieldUtilsTest.InvalidPickleShouldNotCrashRepeatedFieldDeserialization (0 ms)\nI 267.147s run_tests_on_device(0a06fabe) [----------] 4 tests from IPCMessageRepeatedFieldUtilsTest (5 ms total)\nI 267.147s run_tests_on_device(0a06fabe) \nI 267.147s run_tests_on_device(0a06fabe) [----------] Global test environment tear-down\nI 267.147s run_tests_on_device(0a06fabe) [==========] 66 tests from 18 test suites ran. (2512 ms total)\nI 267.147s run_tests_on_device(0a06fabe) [ PASSED ] 66 tests.\nI 267.147s run_tests_on_device(0a06fabe) <<ScopedMainEntryLogger\nI 267.149s run_tests_on_device(0a06fabe) Finished running tests on this device.\nI 267.149s Main FINISHED TRY #1/3\nI 267.149s Main 2 failed tests remain.\nI 267.149s Main STARTING TRY #2/3\nI 267.150s Main Attempting to recover devices due to known issue on L MR1. See crbug.com/787056 for details.\nI 267.165s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'sd_card_ready' met (0.0s)\nI 267.608s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'pm_ready' met (0.5s)\nI 267.638s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'boot_completed' met (0.5s)\nI 268.033s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'device_offline' met (0.4s)\nI 283.826s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'sd_card_ready' met (15.8s)\nI 284.278s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'pm_ready' not met (16.2s)\nI 289.704s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'pm_ready' met (21.7s)\nI 289.738s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'boot_completed' not met (21.7s)\nI 294.770s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'boot_completed' not met (26.7s)\nI 299.814s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'boot_completed' not met (31.8s)\nI 304.849s TimeoutThread-1-for-RecoverDevice(0a06fabe) condition 'boot_completed' met (36.8s)\nI 304.868s Main Will run 2 tests on 1 devices: 0a06fabe\nW 305.037s run_tests_on_device(0a06fabe) No tombstones to clear.\nI 310.915s run_tests_on_device(0a06fabe) flags:\nI 311.041s TimeoutThread-1-for-run_tests_on_device(0a06fabe) Large shell command will be run from file: ( p=org.chromium.native_test;am instrument -w -e \"$p\".NativeTestInstrumentationTestRunner.ShardNanoTimeout 120000000000 -e \"$p\".NativeTestInstrumentationTestRunner.NativeTestActivity \"$p\".NativeUnitTestActivity -e \"$p\".NativeTest.RunInSubThread 1 -e \"$p\".NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-d19125125868e -e \"$p\".NativeTestInstrumentationTestRunner.StdoutFile /storage/emulated/legacy/temp_file-8f121af3a040e.gtest_out \"$p\"/\"$p\".NativeTestInstrumentationTestRunner )>/data/loca ...\nI 312.989s run_tests_on_device(0a06fabe) /storage/emulated/legacy/temp_file-8f121af3a040e.gtest_out size on device: 830\nI 313.174s run_tests_on_device(0a06fabe) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43a03a2d998a1611%2F%2B%2Flogcat_logcat_4284562490804322531_20190316T165458-UTC_0a06fabe\nI 313.175s archive Writing text to logdog stream, logcat_logcat_4284562490804322531_20190316T165458-UTC_0a06fabe\nI 313.796s run_tests_on_device(0a06fabe) >>ScopedMainEntryLogger\nI 313.796s run_tests_on_device(0a06fabe) Note: Google Test filter = IPCChannelMojoTest.SendPlatformFileAndMessagePipe:IPCChannelProxyTest.FilterRemoval\nI 313.796s run_tests_on_device(0a06fabe) [==========] Running 2 tests from 2 test suites.\nI 313.796s run_tests_on_device(0a06fabe) [----------] Global test environment set-up.\nI 313.796s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoTest\nI 313.796s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelMojoTest.SendPlatformFileAndMessagePipe\nI 313.796s run_tests_on_device(0a06fabe) [ OK ] IPCChannelMojoTest.SendPlatformFileAndMessagePipe (191 ms)\nI 313.797s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelMojoTest (198 ms total)\nI 313.797s run_tests_on_device(0a06fabe) \nI 313.797s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelProxyTest\nI 313.797s run_tests_on_device(0a06fabe) [ RUN ] IPCChannelProxyTest.FilterRemoval\nI 313.797s run_tests_on_device(0a06fabe) [ OK ] IPCChannelProxyTest.FilterRemoval (217 ms)\nI 313.797s run_tests_on_device(0a06fabe) [----------] 1 test from IPCChannelProxyTest (217 ms total)\nI 313.797s run_tests_on_device(0a06fabe) \nI 313.797s run_tests_on_device(0a06fabe) [----------] Global test environment tear-down\nI 313.797s run_tests_on_device(0a06fabe) [==========] 2 tests from 2 test suites ran. (417 ms total)\nI 313.797s run_tests_on_device(0a06fabe) [ PASSED ] 2 tests.\nI 313.797s run_tests_on_device(0a06fabe) <<ScopedMainEntryLogger\nI 313.799s run_tests_on_device(0a06fabe) Finished running tests on this device.\nI 313.801s Main FINISHED TRY #2/3\nI 313.801s Main All tests completed.\nC 313.802s Main ********************************************************************************\nC 313.802s Main Summary\nC 313.802s Main ********************************************************************************\nC 313.803s Main [==========] 88 tests ran.\nC 313.803s Main [ PASSED ] 88 tests.\nC 313.803s Main ********************************************************************************\nI 313.806s tear_down_device(0a06fabe) Wrote device cache: /b/swarming/w/ir/out/Debug/device_cache_0a06fabe.json\nI 313.814s Main Generated json results file at /b/swarming/w/itzF7S1w/tmpOjxqvR\nI 313.814s Main Finishing archiving output.\n[W2019-03-16T16:55:01.748470Z 24431 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-03-16T16:55:01.766512Z 24431 0 main.go:205] Butler terminated with error. {\"error\":\"context canceled\"}\n[E2019-03-16T16:55:01.766548Z 24431 0 main.go:233] Failed to serve.\noriginal error: context canceled\n\n[I2019-03-16T16:55:01.766642Z 24431 0 main.go:349] Terminating. {\"returnCode\":250}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' met\n", "outputs_ref": { "isolated": "180b12e12de886f85558866abed12f94ff0d32b2", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "43a03a2d998a1611", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-16T16:49:36.701675", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:Lollipop Tablet Tester", "buildnumber:13305", "data:666631b7f0eb6062aecbf7cdc0aacc1b18d8b7e5", "device_os:LMY49B", "device_type:flo", "master:chromium.android", "name:ipc_tests", "os:Android", "pool:Chrome", "priority:25", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm99-c4", "spec_name:chromium.ci:Lollipop Tablet Tester", "stepname:ipc_tests on Android device Nexus 7 [2013]", "swarming.pool.template:none", "swarming.pool.version:84dc2e055f380db17943d027893da36f2780b31c", "user:None" ], "task_id": "43aa3bb96a9df210" } ] }