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

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpDvkiOB.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0NycVbO --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpB3s__Ymerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpMhmfqF.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpIErehN.json in dir /b/s/w/ir/k: allow_subannotations: False cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpDvkiOB.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0NycVbO', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpB3s__Ymerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpMhmfqF.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpIErehN.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('cronet_unittests_ios (iPhone 5s iOS 9.3) on Mac-10.13.6',) ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.7FNNhJz6CM/Render BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 53461 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /Users/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918667360491294064 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/it307O00/luci_context.527260701 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.NKJJGlflGM/Listeners SWARMING_BOT_ID: build212-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43a874a2b3efe611 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VERSIONER_PYTHON_PREFER_32_BIT: no VERSIONER_PYTHON_VERSION: 2.7 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython XPC_FLAGS: 0x0 XPC_SERVICE_NAME: 0 _: /b/s/w/ir/cipd_bin_packages/vpython __CF_USER_TEXT_ENCODING: 0x1F4:0x0:0x0 Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-03-18 00:13:52,283 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0NycVbO' 2019-03-18 00:13:52,283 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/0NycVbO' already exists! 2019-03-18 00:13:52,283 - root: [WARNING] task_output_dir existing content: [] 2019-03-18 00:13:52,283 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpIErehN.json -output-dir /b/s/w/ir/k/recipe_cleanup/0NycVbO -task-summary-json /b/s/w/ir/tmp/t/tmpMhmfqF.json [D2019-03-18T00:13:52.299095-07:00 7850 0 auth.go:1265] Minting a new token {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:13:52.299175-07:00 7850 0 luci_ctx.go:138] POST http://127.0.0.1:53450/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:13:52.300685-07:00 7850 0 auth.go:1222] Token expires in 38m41.699333s {"key":"luci_ctx/31e255d9bae551d009b3eeaba1d73e6fb9bcdbd6406c6d4791c9aa9fe839bc38", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:13:53.837116-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:13:55.237111-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:13:56.678661-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:13:58.174073-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:13:59.753753-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:01.437301-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:03.107681-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:04.829016-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:06.587505-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:08.470721-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:10.364901-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:12.304159-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:14.454087-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:16.697984-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:18.866705-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:21.229404-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:23.687984-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:26.086821-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:28.585132-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:31.154667-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:33.772570-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:36.487089-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:39.295826-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:42.083019-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:45.082898-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:48.308411-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:51.519637-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:54.819857-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:14:58.423936-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:15:01.838833-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:15:05.532005-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:15:09.299253-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:15:13.322967-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 [D2019-03-18T00:15:17.379678-07:00 7850 0 collect.go:344] Waiting task_id: 43a877b0d8f88010 43a877b0d8f88010: exit 0 [I 2019-03-18 00:13:55] About to install Xcode 10b61 in Xcode.app for ios [12:13:56:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer Device wiped. [12:14:03:DEBUG] Setting sigterm handler. [12:14:05:INFO] User defaults from command line: [12:14:05:INFO] IDETestRunSpecificationPath = /var/folders/2j/22s2gz0s7hn48k32d47clxf80000gm/T/67DBF18B-4B8E-415F-8382-04A82EEE80C6 [12:14:05:INFO] [12:14:25:INFO] [==========] Running 61 tests from 19 test suites. [12:14:25:INFO] [----------] Global test environment set-up. [12:14:25:INFO] [----------] 1 test from HistogramManager [12:14:25:INFO] [ RUN ] HistogramManager.HistogramBucketFields [12:14:25:INFO] [ OK ] HistogramManager.HistogramBucketFields (16 ms) [12:14:25:INFO] [----------] 1 test from HistogramManager (17 ms total) [12:14:25:INFO] [12:14:25:INFO] [----------] 5 tests from HostCachePersistenceManagerTest [12:14:25:INFO] [ RUN ] HostCachePersistenceManagerTest.SeparateWrites [12:14:25:INFO] [ OK ] HostCachePersistenceManagerTest.SeparateWrites (26 ms) [12:14:25:INFO] [ RUN ] HostCachePersistenceManagerTest.MultipleWrites [12:14:25:INFO] [ OK ] HostCachePersistenceManagerTest.MultipleWrites (3 ms) [12:14:25:INFO] [ RUN ] HostCachePersistenceManagerTest.BatchedWrites [12:14:25:INFO] [ OK ] HostCachePersistenceManagerTest.BatchedWrites (4 ms) [12:14:25:INFO] [ RUN ] HostCachePersistenceManagerTest.InitAfterPrefs [12:14:25:INFO] [ OK ] HostCachePersistenceManagerTest.InitAfterPrefs (3 ms) [12:14:25:INFO] [ RUN ] HostCachePersistenceManagerTest.InitBeforePrefs [12:14:25:INFO] [ OK ] HostCachePersistenceManagerTest.InitBeforePrefs (2 ms) [12:14:25:INFO] [----------] 5 tests from HostCachePersistenceManagerTest (46 ms total) [12:14:25:INFO] [12:14:25:INFO] [----------] 14 tests from StaleHostResolverTest [12:14:25:INFO] [ RUN ] StaleHostResolverTest.Null [12:14:25:INFO] [ OK ] StaleHostResolverTest.Null (4 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.Create [12:14:25:INFO] [ OK ] StaleHostResolverTest.Create (2 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.Network [12:14:25:INFO] [ OK ] StaleHostResolverTest.Network (5 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.Hosts [12:14:25:INFO] [ OK ] StaleHostResolverTest.Hosts (3 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.FreshCache [12:14:25:INFO] [ OK ] StaleHostResolverTest.FreshCache (4 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.StaleCache [12:14:25:INFO] [ OK ] StaleHostResolverTest.StaleCache (4 ms) [12:14:25:INFO] [ RUN ] StaleHostResolverTest.StaleCache_DestroyedResolver [12:14:26:INFO] [ OK ] StaleHostResolverTest.StaleCache_DestroyedResolver (1005 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.StaleCacheNameNotResolvedEnabled [12:14:26:INFO] [ OK ] StaleHostResolverTest.StaleCacheNameNotResolvedEnabled (3 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.StaleCacheNameNotResolvedDisabled [12:14:26:INFO] [ OK ] StaleHostResolverTest.StaleCacheNameNotResolvedDisabled (3 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.NetworkWithStaleCache [12:14:26:INFO] [ OK ] StaleHostResolverTest.NetworkWithStaleCache (2 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.CancelWithNoCache [12:14:26:INFO] [ OK ] StaleHostResolverTest.CancelWithNoCache (2 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.CancelWithStaleCache [12:14:26:INFO] [ OK ] StaleHostResolverTest.CancelWithStaleCache (3 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.StaleUsability [12:14:26:INFO] [ OK ] StaleHostResolverTest.StaleUsability (31 ms) [12:14:26:INFO] [ RUN ] StaleHostResolverTest.CreatedByContext [12:14:26:INFO] [ OK ] StaleHostResolverTest.CreatedByContext (38 ms) [12:14:26:INFO] [----------] 14 tests from StaleHostResolverTest (1131 ms total) [12:14:26:INFO] [12:14:26:INFO] [----------] 10 tests from URLRequestContextConfigTest [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.TestExperimentalOptionParsing [12:14:26:INFO] [18783:771:0318/001426.944928:10477663486128:WARNING:url_request_context_config.cc(665)] Unrecognized Cronet experimental option "UnknownOption" with params "{ [12:14:26:INFO] "foo": true [12:14:26:INFO] } [12:14:26:INFO] [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.TestExperimentalOptionParsing (5 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetSupportedQuicVersion [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetSupportedQuicVersion (3 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetUnsupportedQuicVersion [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetUnsupportedQuicVersion (3 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicServerMigrationOptions [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicServerMigrationOptions (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicGoAwaySessionsOnIPChangeByDefault [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicGoAwaySessionsOnIPChangeByDefault (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.DisableQuicGoAwaySessionsOnIPChangeViaExperimentOptions [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.DisableQuicGoAwaySessionsOnIPChangeViaExperimentOptions (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicConnectionMigrationV2Options [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicConnectionMigrationV2Options (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicStaleDNSracing [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicStaleDNSracing (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicHostWhitelist [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicHostWhitelist (2 ms) [12:14:26:INFO] [ RUN ] URLRequestContextConfigTest.SetQuicMaxTimeBeforeCryptoHandshake [12:14:26:INFO] [ OK ] URLRequestContextConfigTest.SetQuicMaxTimeBeforeCryptoHandshake (3 ms) [12:14:26:INFO] [----------] 10 tests from URLRequestContextConfigTest (44 ms total) [12:14:26:INFO] [12:14:26:INFO] [----------] 2 tests from URLURLRequestContextConfigTest [12:14:26:INFO] [ RUN ] URLURLRequestContextConfigTest.SetQuicConnectionOptions [12:14:26:INFO] [ OK ] URLURLRequestContextConfigTest.SetQuicConnectionOptions (3 ms) [12:14:26:INFO] [ RUN ] URLURLRequestContextConfigTest.SetAcceptLanguageAndUserAgent [12:14:26:INFO] [ OK ] URLURLRequestContextConfigTest.SetAcceptLanguageAndUserAgent (2 ms) [12:14:26:INFO] [----------] 2 tests from URLURLRequestContextConfigTest (8 ms total) [12:14:26:INFO] [12:14:26:INFO] [----------] 5 tests from NativeMetricsUtilTest [12:14:26:INFO] [ RUN ] NativeMetricsUtilTest.ConvertsTimes [12:14:26:INFO] [ OK ] NativeMetricsUtilTest.ConvertsTimes (1 ms) [12:14:26:INFO] [ RUN ] NativeMetricsUtilTest.OverwritesOldOutParam [12:14:27:INFO] [ OK ] NativeMetricsUtilTest.OverwritesOldOutParam (0 ms) [12:14:27:INFO] [ RUN ] NativeMetricsUtilTest.NullTicks [12:14:27:INFO] [ OK ] NativeMetricsUtilTest.NullTicks (0 ms) [12:14:27:INFO] [ RUN ] NativeMetricsUtilTest.NullStartTicks [12:14:27:INFO] [ OK ] NativeMetricsUtilTest.NullStartTicks (0 ms) [12:14:27:INFO] [ RUN ] NativeMetricsUtilTest.NullStartTime [12:14:27:INFO] [12:14:27:INFO] [WARNING] ../../components/cronet/native/native_metrics_util_test.cc:69:: Death tests are not supported on this platform. [12:14:27:INFO] Statement 'ConvertTime(base::TimeTicks::UnixEpoch() + event_delta, base::TimeTicks::UnixEpoch() + start_delta, base::Time(), &converted)' cannot be verified. [12:14:27:INFO] [ OK ] NativeMetricsUtilTest.NullStartTime (0 ms) [12:14:27:INFO] [----------] 5 tests from NativeMetricsUtilTest (10 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 3 tests from RunnablesTest [12:14:27:INFO] [ RUN ] RunnablesTest.TestRunCallbackOnExecutor [12:14:27:INFO] [ OK ] RunnablesTest.TestRunCallbackOnExecutor (2 ms) [12:14:27:INFO] [ RUN ] RunnablesTest.TestRunOnceClosureOnExecutor [12:14:27:INFO] [ OK ] RunnablesTest.TestRunOnceClosureOnExecutor (2 ms) [12:14:27:INFO] [ RUN ] RunnablesTest.TestCronetBuffer [12:14:27:INFO] [ OK ] RunnablesTest.TestCronetBuffer (2 ms) [12:14:27:INFO] [----------] 3 tests from RunnablesTest (11 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_BufferTest [12:14:27:INFO] [ RUN ] Cronet_BufferTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_BufferTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_BufferTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_BufferCallbackTest [12:14:27:INFO] [ RUN ] Cronet_BufferCallbackTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_BufferCallbackTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_BufferCallbackTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_RunnableTest [12:14:27:INFO] [ RUN ] Cronet_RunnableTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_RunnableTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_RunnableTest (2 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_ExecutorTest [12:14:27:INFO] [ RUN ] Cronet_ExecutorTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_ExecutorTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_ExecutorTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_EngineTest [12:14:27:INFO] [ RUN ] Cronet_EngineTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_EngineTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_EngineTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestStatusListenerTest [12:14:27:INFO] [ RUN ] Cronet_UrlRequestStatusListenerTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_UrlRequestStatusListenerTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestStatusListenerTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestCallbackTest [12:14:27:INFO] [ RUN ] Cronet_UrlRequestCallbackTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_UrlRequestCallbackTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestCallbackTest (2 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_UploadDataSinkTest [12:14:27:INFO] [ RUN ] Cronet_UploadDataSinkTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_UploadDataSinkTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_UploadDataSinkTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_UploadDataProviderTest [12:14:27:INFO] [ RUN ] Cronet_UploadDataProviderTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_UploadDataProviderTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_UploadDataProviderTest (2 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestTest [12:14:27:INFO] [ RUN ] Cronet_UrlRequestTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_UrlRequestTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_UrlRequestTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 1 test from Cronet_RequestFinishedInfoListenerTest [12:14:27:INFO] [ RUN ] Cronet_RequestFinishedInfoListenerTest.TestCreate [12:14:27:INFO] [ OK ] Cronet_RequestFinishedInfoListenerTest.TestCreate (0 ms) [12:14:27:INFO] [----------] 1 test from Cronet_RequestFinishedInfoListenerTest (1 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] 10 tests from CronetStructTest [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_Error [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_Error (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_QuicHint [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_QuicHint (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_PublicKeyPins [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_PublicKeyPins (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_EngineParams [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_EngineParams (1 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_HttpHeader [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_HttpHeader (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_UrlResponseInfo [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_UrlResponseInfo (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_UrlRequestParams [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_UrlRequestParams (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_DateTime [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_DateTime (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_Metrics [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_Metrics (0 ms) [12:14:27:INFO] [ RUN ] CronetStructTest.TestCronet_RequestFinishedInfo [12:14:27:INFO] [ OK ] CronetStructTest.TestCronet_RequestFinishedInfo (0 ms) [12:14:27:INFO] [----------] 10 tests from CronetStructTest (14 ms total) [12:14:27:INFO] [12:14:27:INFO] [----------] Global test environment tear-down [12:14:27:INFO] [==========] 61 tests from 19 test suites ran. (1296 ms total) [12:14:27:INFO] [ PASSED ] 61 tests. [12:14:27:INFO] [12:14:27:INFO] YOU HAVE 1 DISABLED TEST [12:14:27:INFO] [12:14:42:INFO] Testing started on 'iPhone 5s' [12:14:42:INFO] 2019-03-18 00:14:05.708 xcodebuild[18687:319514] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [12:14:42:INFO] /Users/chrome-bot/Library/Developer/Xcode/DerivedData/temporary-dbhljtnudononzeipnwotzeuzxau/Logs/Test/Test-Transient Testing-2019.03.18_00-14-05--0700.xcresult/1_Test/Diagnostics/cronet_unittests_ios-DD65E208-6B4F-47A9-81E1-AB6F20B5F952/cronet_unittests_ios-939C48CF-6606-49DE-BDD4-84E16CFE31E8/Session-cronet_unittests_ios-2019-03-18_001405-yamwP0.log [12:14:42:INFO] 2019-03-18 00:14:05.708 xcodebuild[18687:319493] [MT] IDETestOperationsObserverDebug: (886C0904-7251-4E14-8BF4-1F1B7BE72B96) Beginning test session cronet_unittests_ios-886C0904-7251-4E14-8BF4-1F1B7BE72B96 at 2019-03-18 00:14:05.709 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7ff0687e1ca0> { [12:14:42:INFO] SimDevice: iPhone 5s (ED624B40-7879-445B-AFC2-3B347FD22DC9, iOS 9.3, Shutdown) [12:14:42:INFO] } (9.3 (13E233)) [12:14:42:INFO] 2019-03-18 00:14:36.569 xcodebuild[18687:319493] [MT] IDETestOperationsObserverDebug: 30.935 elapsed -- Testing started completed. [12:14:42:INFO] 2019-03-18 00:14:36.569 xcodebuild[18687:319493] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [12:14:42:INFO] 2019-03-18 00:14:36.569 xcodebuild[18687:319493] [MT] IDETestOperationsObserverDebug: 30.935 sec, +30.935 sec -- end [12:14:42:INFO] [12:14:42:INFO] Testing failed: [12:14:42:DEBUG] Finished print_process_output. [12:14:42:INFO] Waiting for test process to terminate. [12:14:42:INFO] Test process terminated. [12:14:42:DEBUG] Setting sigterm handler. [12:14:42:DEBUG] Stdout flushed after test process. [12:14:42:DEBUG] Processing test results. [12:14:42:INFO] /b/s/w/ir/src/out/Debug-iphonesimulator/iossim returned 65 [12:14:42:DEBUG] Extracting test data. [12:14:42:DEBUG] Retrieving crash reports. [12:14:42:DEBUG] Retrieving derived data. [12:14:42:DEBUG] Making desktop screenshots. [12:14:42:DEBUG] Killing simulators. [12:14:48:DEBUG] Wiping simulator. Device wiped. [12:14:49:DEBUG] End of tear_down. 2019-03-18 00:15:18,271 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/0NycVbO/43a877b0d8f88010'] 2019-03-18 00:15:18,272 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/0NycVbO/43a877b0d8f88010/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/0NycVbO/43a877b0d8f88010/output.json'] 2019-03-18 00:15:18,272 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0NycVbO' Found ['/b/s/w/ir/k/recipe_cleanup/0NycVbO/43a877b0d8f88010'] 2019-03-18 00:15:18,272 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/0NycVbO/43a877b0d8f88010/output.json'] 2019-03-18 00:15:18,272 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpMhmfqF.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0NycVbO -o /b/s/w/ir/tmp/t/tmpDvkiOB.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpMhmfqF.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0NycVbO', '-o', '/b/s/w/ir/tmp/t/tmpDvkiOB.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpMhmfqF.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0NycVbO', '-o', '/b/s/w/ir/tmp/t/tmpDvkiOB.json'] returned exit code 0