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

{ "shards": [ { "bot_dimensions": [ { "key": "caches", "value": [ "swarming_module_cache_vpython", "xcode_ios_10l232m", "xcode_ios_10o45e" ] }, { "key": "cores", "value": [ "8" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-E5-2697_v2" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "gpu", "value": [ "none" ] }, { "key": "id", "value": [ "vm250-m9" ] }, { "key": "mac_model", "value": [ "VMware7,1" ] }, { "key": "machine_type", "value": [ "n1-highcpu-8" ] }, { "key": "os", "value": [ "Mac", "Mac-10.13", "Mac-10.13.6" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.10" ] }, { "key": "server_version", "value": [ "4158-1053c58" ] }, { "key": "ssd", "value": [ "1" ] }, { "key": "zone", "value": [ "us", "us-golo", "us-golo-9" ] } ], "bot_id": "vm250-m9", "bot_version": "f5b2d07c480a2126a31857b61a60d18e18ee20f70ee11f04cb2698a05ec4e2b7", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/mac-amd64", "version": "1vQ99wQk82cRyVYu18rqMpXtb7XZ3WHvL3HFXTcLHN4C" }, "packages": [ { "package_name": "infra/tools/mac_toolchain/mac-amd64", "path": ".", "version": "1065f97353165dfafa89b64bfdaf9b424d705bc7" }, { "package_name": "infra/python/cpython/mac-amd64", "path": ".swarming_module", "version": "6dd10e31dc5d4cbb3c8f42a6fbd9485aeeb9ef0c" }, { "package_name": "infra/tools/luci/logdog/butler/mac-amd64", "path": ".swarming_module", "version": "3138aa2054ab30eac6f7e1e589e590571ae44692" }, { "package_name": "infra/tools/luci/vpython-native/mac-amd64", "path": ".swarming_module", "version": "LH2D9eSe-sJImw8pxSsKdnKz9LueOAM77FFBJMvP8BwC" }, { "package_name": "infra/tools/luci/vpython/mac-amd64", "path": ".swarming_module", "version": "yhDQeJa8hj64DkPAcLKVNQmNTgYsirl5_wvmnHvOz9cC" } ] }, "completed_ts": "2019-03-09T00:48:12.887400", "costs_usd": [ 0.24585754500888884 ], "created_ts": "2019-03-09T00:04:14.504150", "duration": 1051.0896110534668, "modified_ts": "2019-03-09T00:48:12.887400", "name": "ios_showcase_egtests (iPhone X iOS 12.1)/Mac-10.13.6/cdb251ec57/ios-simulator-full-configs/14075", "output": "[I 2019-03-08 16:29:55] About to install Xcode 10b61 in Xcode.app for ios\n[P86966 16:29:56.074 action_plan.go:140 I] In root:\n[P86966 16:29:56.074 action_plan.go:146 I] to install:\n[P86966 16:29:56.074 action_plan.go:148 I] infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC\n[P86966 16:29:56.074 action_plan.go:148 I] infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC\n[P86966 16:29:56.074 client.go:1506 I] Dry run, not actually doing anything.\n[P86967 16:29:56.437 action_plan.go:140 I] In root:\n[P86967 16:29:56.437 action_plan.go:146 I] to install:\n[P86967 16:29:56.437 action_plan.go:148 I] infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC\n[P86967 16:29:56.437 action_plan.go:148 I] infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC\n[P86967 16:29:56.438 client.go:572 I] cipd: using instance cache at \"/b/s/cipd_cache/cache/instances\"\n[P86967 16:29:56.438 client.go:1383 I] cipd: resolving fetch URL for infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC\n[P86967 16:29:56.522 storage.go:308 I] cipd: initiating the fetch\n[P86967 16:29:56.589 storage.go:275 I] cipd: about to fetch 1623.1 MB\n[P86967 16:29:56.589 storage.go:256 I] cipd: fetching - 0% (?? KB/s)\n[P86967 16:30:01.589 storage.go:256 I] cipd: fetching - 33% (109551.8 KB/s)\n[P86967 16:30:06.657 storage.go:256 I] cipd: fetching - 67% (108398.5 KB/s)\n[P86967 16:30:11.391 storage.go:256 I] cipd: fetching - 100% (111083.4 KB/s)\n[P86967 16:30:11.391 storage.go:256 I] cipd: fetching - 100% (111083.4 KB/s)\n[P86967 16:30:11.391 client.go:1377 I] cipd: successfully fetched infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC in 15.0s\n[P86967 16:30:11.517 deployer.go:288 I] Deploying infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC into /b/s/w/ir/Xcode.app(/)\n[P86967 16:30:11.525 reader.go:325 I] cipd: about to extract 3145.8 MB (49726 files)\n[P86967 16:30:11.526 reader.go:364 I] cipd: extracting - 0%\n[P86967 16:30:13.526 reader.go:364 I] cipd: extracting - 2%\n[P86967 16:30:15.526 reader.go:364 I] cipd: extracting - 4%\n[P86967 16:30:17.526 reader.go:364 I] cipd: extracting - 5%\n[P86967 16:30:19.526 reader.go:364 I] cipd: extracting - 7%\n[P86967 16:30:21.526 reader.go:364 I] cipd: extracting - 9%\n[P86967 16:30:23.527 reader.go:364 I] cipd: extracting - 10%\n[P86967 16:30:25.528 reader.go:364 I] cipd: extracting - 12%\n[P86967 16:30:27.528 reader.go:364 I] cipd: extracting - 13%\n[P86967 16:30:30.546 reader.go:364 I] cipd: extracting - 26%\n[P86967 16:30:32.549 reader.go:364 I] cipd: extracting - 28%\n[P86967 16:30:34.575 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:30:36.576 reader.go:364 I] cipd: extracting - 37%\n[P86967 16:30:39.123 reader.go:364 I] cipd: extracting - 43%\n[P86967 16:30:41.548 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:30:43.612 reader.go:364 I] cipd: extracting - 52%\n[P86967 16:30:45.612 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:30:47.615 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:30:49.617 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:30:51.621 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:30:53.624 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:30:55.660 reader.go:364 I] cipd: extracting - 56%\n[P86967 16:30:58.173 reader.go:364 I] cipd: extracting - 60%\n[P86967 16:31:00.177 reader.go:364 I] cipd: extracting - 61%\n[P86967 16:31:02.301 reader.go:364 I] cipd: extracting - 62%\n[P86967 16:31:04.302 reader.go:364 I] cipd: extracting - 62%\n[P86967 16:31:06.302 reader.go:364 I] cipd: extracting - 68%\n[P86967 16:31:08.307 reader.go:364 I] cipd: extracting - 72%\n[P86967 16:31:10.308 reader.go:364 I] cipd: extracting - 76%\n[P86967 16:31:12.312 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:31:14.376 reader.go:364 I] cipd: extracting - 87%\n[P86967 16:31:17.009 reader.go:364 I] cipd: extracting - 94%\n[P86967 16:31:19.142 reader.go:364 I] cipd: extracting - 100%\n[P86967 16:31:19.388 deployer.go:361 I] Moving files to their final destination...\n[P86967 16:31:28.119 deployer.go:376 I] Cleaning up...\n[P86967 16:31:29.848 deployer.go:381 I] Deployed infra_internal/ios/xcode/mac:sczxB5Ollty99WXo7Uv0Wp8F112iYGRyuy1qaQH5UIkC\n[P86967 16:31:29.848 client.go:1383 I] cipd: resolving fetch URL for infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC\n[P86967 16:31:29.976 storage.go:308 I] cipd: initiating the fetch\n[P86967 16:31:30.053 storage.go:275 I] cipd: about to fetch 7032.5 MB\n[P86967 16:31:30.053 storage.go:256 I] cipd: fetching - 0% (?? KB/s)\n[P86967 16:31:35.053 storage.go:256 I] cipd: fetching - 8% (113766.6 KB/s)\n[P86967 16:31:40.053 storage.go:256 I] cipd: fetching - 15% (108415.1 KB/s)\n[P86967 16:31:45.053 storage.go:256 I] cipd: fetching - 23% (111211.1 KB/s)\n[P86967 16:31:50.053 storage.go:256 I] cipd: fetching - 31% (109629.9 KB/s)\n[P86967 16:31:55.053 storage.go:256 I] cipd: fetching - 39% (110175.1 KB/s)\n[P86967 16:32:00.053 storage.go:256 I] cipd: fetching - 47% (111855.6 KB/s)\n[P86967 16:32:05.053 storage.go:256 I] cipd: fetching - 55% (111734.6 KB/s)\n[P86967 16:32:10.053 storage.go:256 I] cipd: fetching - 62% (107874.0 KB/s)\n[P86967 16:32:15.053 storage.go:256 I] cipd: fetching - 70% (108098.9 KB/s)\n[P86967 16:32:20.053 storage.go:256 I] cipd: fetching - 78% (112940.1 KB/s)\n[P86967 16:32:25.053 storage.go:256 I] cipd: fetching - 86% (109893.1 KB/s)\n[P86967 16:32:30.053 storage.go:256 I] cipd: fetching - 94% (108730.1 KB/s)\n[P86967 16:32:33.640 storage.go:256 I] cipd: fetching - 100% (114478.2 KB/s)\n[P86967 16:32:33.640 storage.go:256 I] cipd: fetching - 100% (114478.2 KB/s)\n[P86967 16:32:33.640 client.go:1377 I] cipd: successfully fetched infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC in 63.8s\n[P86967 16:32:34.573 deployer.go:288 I] Deploying infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC into /b/s/w/ir/Xcode.app(/)\n[P86967 16:32:34.610 reader.go:325 I] cipd: about to extract 12769.8 MB (281814 files)\n[P86967 16:32:34.613 reader.go:364 I] cipd: extracting - 0%\n[P86967 16:32:36.613 reader.go:364 I] cipd: extracting - 0%\n[P86967 16:32:38.613 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:40.614 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:42.619 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:44.622 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:46.622 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:48.623 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:50.628 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:52.629 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:54.633 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:56.633 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:32:58.633 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:33:00.637 reader.go:364 I] cipd: extracting - 1%\n[P86967 16:33:02.637 reader.go:364 I] cipd: extracting - 2%\n[P86967 16:33:04.648 reader.go:364 I] cipd: extracting - 3%\n[P86967 16:33:07.953 reader.go:364 I] cipd: extracting - 4%\n[P86967 16:33:09.971 reader.go:364 I] cipd: extracting - 5%\n[P86967 16:33:11.971 reader.go:364 I] cipd: extracting - 6%\n[P86967 16:33:14.093 reader.go:364 I] cipd: extracting - 7%\n[P86967 16:33:16.242 reader.go:364 I] cipd: extracting - 8%\n[P86967 16:33:18.249 reader.go:364 I] cipd: extracting - 9%\n[P86967 16:33:20.289 reader.go:364 I] cipd: extracting - 10%\n[P86967 16:33:22.501 reader.go:364 I] cipd: extracting - 10%\n[P86967 16:33:24.638 reader.go:364 I] cipd: extracting - 11%\n[P86967 16:33:26.697 reader.go:364 I] cipd: extracting - 12%\n[P86967 16:33:28.698 reader.go:364 I] cipd: extracting - 13%\n[P86967 16:33:31.012 reader.go:364 I] cipd: extracting - 14%\n[P86967 16:33:33.136 reader.go:364 I] cipd: extracting - 15%\n[P86967 16:33:35.136 reader.go:364 I] cipd: extracting - 15%\n[P86967 16:33:37.142 reader.go:364 I] cipd: extracting - 15%\n[P86967 16:33:39.536 reader.go:364 I] cipd: extracting - 16%\n[P86967 16:33:41.544 reader.go:364 I] cipd: extracting - 17%\n[P86967 16:33:43.570 reader.go:364 I] cipd: extracting - 18%\n[P86967 16:33:45.570 reader.go:364 I] cipd: extracting - 19%\n[P86967 16:33:47.589 reader.go:364 I] cipd: extracting - 19%\n[P86967 16:33:49.589 reader.go:364 I] cipd: extracting - 19%\n[P86967 16:33:51.592 reader.go:364 I] cipd: extracting - 20%\n[P86967 16:33:53.624 reader.go:364 I] cipd: extracting - 21%\n[P86967 16:33:55.628 reader.go:364 I] cipd: extracting - 21%\n[P86967 16:33:57.760 reader.go:364 I] cipd: extracting - 22%\n[P86967 16:33:59.787 reader.go:364 I] cipd: extracting - 22%\n[P86967 16:34:01.787 reader.go:364 I] cipd: extracting - 23%\n[P86967 16:34:03.792 reader.go:364 I] cipd: extracting - 24%\n[P86967 16:34:05.792 reader.go:364 I] cipd: extracting - 24%\n[P86967 16:34:07.840 reader.go:364 I] cipd: extracting - 25%\n[P86967 16:34:09.840 reader.go:364 I] cipd: extracting - 26%\n[P86967 16:34:11.853 reader.go:364 I] cipd: extracting - 27%\n[P86967 16:34:14.219 reader.go:364 I] cipd: extracting - 28%\n[P86967 16:34:16.221 reader.go:364 I] cipd: extracting - 28%\n[P86967 16:34:18.225 reader.go:364 I] cipd: extracting - 28%\n[P86967 16:34:20.230 reader.go:364 I] cipd: extracting - 29%\n[P86967 16:34:22.230 reader.go:364 I] cipd: extracting - 29%\n[P86967 16:34:24.233 reader.go:364 I] cipd: extracting - 29%\n[P86967 16:34:26.235 reader.go:364 I] cipd: extracting - 29%\n[P86967 16:34:28.234 reader.go:364 I] cipd: extracting - 29%\n[P86967 16:34:30.235 reader.go:364 I] cipd: extracting - 30%\n[P86967 16:34:32.238 reader.go:364 I] cipd: extracting - 31%\n[P86967 16:34:34.239 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:36.248 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:38.248 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:40.249 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:42.250 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:44.293 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:46.293 reader.go:364 I] cipd: extracting - 32%\n[P86967 16:34:48.293 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:34:50.297 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:34:52.301 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:34:54.305 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:34:56.310 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:34:58.315 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:00.316 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:02.319 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:04.321 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:06.322 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:08.322 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:10.324 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:12.324 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:14.325 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:16.327 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:18.331 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:20.335 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:22.337 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:24.338 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:26.343 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:28.344 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:30.349 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:32.351 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:34.352 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:36.356 reader.go:364 I] cipd: extracting - 33%\n[P86967 16:35:38.356 reader.go:364 I] cipd: extracting - 34%\n[P86967 16:35:40.456 reader.go:364 I] cipd: extracting - 35%\n[P86967 16:35:42.470 reader.go:364 I] cipd: extracting - 35%\n[P86967 16:35:45.490 reader.go:364 I] cipd: extracting - 36%\n[P86967 16:35:47.490 reader.go:364 I] cipd: extracting - 37%\n[P86967 16:35:49.503 reader.go:364 I] cipd: extracting - 38%\n[P86967 16:35:51.538 reader.go:364 I] cipd: extracting - 38%\n[P86967 16:35:53.538 reader.go:364 I] cipd: extracting - 39%\n[P86967 16:35:55.556 reader.go:364 I] cipd: extracting - 40%\n[P86967 16:35:57.610 reader.go:364 I] cipd: extracting - 41%\n[P86967 16:35:59.652 reader.go:364 I] cipd: extracting - 41%\n[P86967 16:36:01.699 reader.go:364 I] cipd: extracting - 42%\n[P86967 16:36:03.852 reader.go:364 I] cipd: extracting - 43%\n[P86967 16:36:06.065 reader.go:364 I] cipd: extracting - 44%\n[P86967 16:36:08.255 reader.go:364 I] cipd: extracting - 45%\n[P86967 16:36:10.316 reader.go:364 I] cipd: extracting - 46%\n[P86967 16:36:12.324 reader.go:364 I] cipd: extracting - 47%\n[P86967 16:36:14.348 reader.go:364 I] cipd: extracting - 47%\n[P86967 16:36:16.349 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:36:18.349 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:36:20.349 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:36:22.352 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:36:24.357 reader.go:364 I] cipd: extracting - 48%\n[P86967 16:36:26.360 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:28.365 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:30.369 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:32.375 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:34.378 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:36.378 reader.go:364 I] cipd: extracting - 49%\n[P86967 16:36:38.450 reader.go:364 I] cipd: extracting - 50%\n[P86967 16:36:40.450 reader.go:364 I] cipd: extracting - 51%\n[P86967 16:36:42.450 reader.go:364 I] cipd: extracting - 51%\n[P86967 16:36:44.450 reader.go:364 I] cipd: extracting - 52%\n[P86967 16:36:46.450 reader.go:364 I] cipd: extracting - 53%\n[P86967 16:36:48.450 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:36:50.451 reader.go:364 I] cipd: extracting - 54%\n[P86967 16:36:52.451 reader.go:364 I] cipd: extracting - 55%\n[P86967 16:36:54.451 reader.go:364 I] cipd: extracting - 55%\n[P86967 16:36:56.467 reader.go:364 I] cipd: extracting - 56%\n[P86967 16:36:58.469 reader.go:364 I] cipd: extracting - 56%\n[P86967 16:37:00.481 reader.go:364 I] cipd: extracting - 57%\n[P86967 16:37:02.485 reader.go:364 I] cipd: extracting - 58%\n[P86967 16:37:04.485 reader.go:364 I] cipd: extracting - 58%\n[P86967 16:37:06.497 reader.go:364 I] cipd: extracting - 59%\n[P86967 16:37:08.504 reader.go:364 I] cipd: extracting - 60%\n[P86967 16:37:10.504 reader.go:364 I] cipd: extracting - 60%\n[P86967 16:37:12.505 reader.go:364 I] cipd: extracting - 61%\n[P86967 16:37:14.557 reader.go:364 I] cipd: extracting - 62%\n[P86967 16:37:16.558 reader.go:364 I] cipd: extracting - 63%\n[P86967 16:37:18.576 reader.go:364 I] cipd: extracting - 63%\n[P86967 16:37:20.578 reader.go:364 I] cipd: extracting - 64%\n[P86967 16:37:22.579 reader.go:364 I] cipd: extracting - 64%\n[P86967 16:37:24.579 reader.go:364 I] cipd: extracting - 64%\n[P86967 16:37:26.579 reader.go:364 I] cipd: extracting - 64%\n[P86967 16:37:28.581 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:30.581 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:32.582 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:34.585 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:36.585 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:38.585 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:40.586 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:42.588 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:44.592 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:46.592 reader.go:364 I] cipd: extracting - 65%\n[P86967 16:37:48.593 reader.go:364 I] cipd: extracting - 66%\n[P86967 16:37:50.606 reader.go:364 I] cipd: extracting - 66%\n[P86967 16:37:52.738 reader.go:364 I] cipd: extracting - 67%\n[P86967 16:37:56.535 reader.go:364 I] cipd: extracting - 68%\n[P86967 16:37:58.535 reader.go:364 I] cipd: extracting - 69%\n[P86967 16:38:00.536 reader.go:364 I] cipd: extracting - 70%\n[P86967 16:38:02.601 reader.go:364 I] cipd: extracting - 70%\n[P86967 16:38:04.786 reader.go:364 I] cipd: extracting - 71%\n[P86967 16:38:06.864 reader.go:364 I] cipd: extracting - 72%\n[P86967 16:38:08.893 reader.go:364 I] cipd: extracting - 72%\n[P86967 16:38:11.206 reader.go:364 I] cipd: extracting - 73%\n[P86967 16:38:13.207 reader.go:364 I] cipd: extracting - 73%\n[P86967 16:38:15.404 reader.go:364 I] cipd: extracting - 74%\n[P86967 16:38:17.409 reader.go:364 I] cipd: extracting - 75%\n[P86967 16:38:19.429 reader.go:364 I] cipd: extracting - 75%\n[P86967 16:38:21.430 reader.go:364 I] cipd: extracting - 76%\n[P86967 16:38:23.484 reader.go:364 I] cipd: extracting - 77%\n[P86967 16:38:25.657 reader.go:364 I] cipd: extracting - 78%\n[P86967 16:38:27.893 reader.go:364 I] cipd: extracting - 79%\n[P86967 16:38:29.956 reader.go:364 I] cipd: extracting - 80%\n[P86967 16:38:32.082 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:38:34.085 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:38:36.085 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:38:38.086 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:38:40.086 reader.go:364 I] cipd: extracting - 81%\n[P86967 16:38:42.086 reader.go:364 I] cipd: extracting - 82%\n[P86967 16:38:44.086 reader.go:364 I] cipd: extracting - 82%\n[P86967 16:38:46.101 reader.go:364 I] cipd: extracting - 83%\n[P86967 16:38:48.102 reader.go:364 I] cipd: extracting - 84%\n[P86967 16:38:50.102 reader.go:364 I] cipd: extracting - 84%\n[P86967 16:38:52.102 reader.go:364 I] cipd: extracting - 85%\n[P86967 16:38:54.104 reader.go:364 I] cipd: extracting - 86%\n[P86967 16:38:56.106 reader.go:364 I] cipd: extracting - 86%\n[P86967 16:38:58.124 reader.go:364 I] cipd: extracting - 87%\n[P86967 16:39:00.124 reader.go:364 I] cipd: extracting - 87%\n[P86967 16:39:02.124 reader.go:364 I] cipd: extracting - 88%\n[P86967 16:39:04.142 reader.go:364 I] cipd: extracting - 89%\n[P86967 16:39:06.152 reader.go:364 I] cipd: extracting - 89%\n[P86967 16:39:08.314 reader.go:364 I] cipd: extracting - 90%\n[P86967 16:39:10.320 reader.go:364 I] cipd: extracting - 91%\n[P86967 16:39:12.320 reader.go:364 I] cipd: extracting - 91%\n[P86967 16:39:17.532 reader.go:364 I] cipd: extracting - 93%\n[P86967 16:39:19.532 reader.go:364 I] cipd: extracting - 94%\n[P86967 16:39:21.533 reader.go:364 I] cipd: extracting - 94%\n[P86967 16:39:23.533 reader.go:364 I] cipd: extracting - 94%\n[P86967 16:39:25.577 reader.go:364 I] cipd: extracting - 95%\n[P86967 16:39:27.579 reader.go:364 I] cipd: extracting - 95%\n[P86967 16:39:29.962 reader.go:364 I] cipd: extracting - 96%\n[P86967 16:39:32.244 reader.go:364 I] cipd: extracting - 97%\n[P86967 16:39:34.244 reader.go:364 I] cipd: extracting - 97%\n[P86967 16:39:36.349 reader.go:364 I] cipd: extracting - 98%\n[P86967 16:39:38.349 reader.go:364 I] cipd: extracting - 99%\n[P86967 16:39:41.717 reader.go:364 I] cipd: extracting - 100%\n[P86967 16:39:43.743 deployer.go:361 I] Moving files to their final destination...\n[P86967 16:41:08.033 deployer.go:376 I] Cleaning up...\n[P86967 16:41:33.045 deployer.go:381 I] Deployed infra_internal/ios/xcode/ios:sjkOsoLa1AS7MMZsFyj8tgZuZipwXstTPd4JLXm3dNAC\n[P86967 16:41:33.045 client.go:1575 I] All changes applied.\n[04:41:49:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer\n[04:41:49:INFO] Erasing all simulators.\n[04:42:03:INFO] Start test attempt #0 for command [xcodebuild test-without-building -xctestrun /b/s/w/ioVbTUGC/run_1552092123.xctestrun -destination platform=iOS Simulator,OS=12.1,name=iPhone X -resultBundlePath /b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0 -parallel-testing-enabled YES -parallel-testing-worker-count 3]\n[04:42:03:INFO] Launching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioVbTUGC/run_1552092123.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '3'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/itNeVTs6', 'LOGNAME': 'chrome-bot', 'USER': 'chrome-bot', 'HOME': '/Users/chrome-bot', 'BOTO_CONFIG': '/Users/chrome-bot/.boto', 'PATH': '/b/s/w/ir/.swarming_module_cache/vpython/80b654/bin:/b/s/w/ir/.swarming_module:/b/s/w/ir/.swarming_module/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', 'SWARMING_BOT_ID': 'vm250-m9', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/80b654', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IUmmGGxIee/Render', 'SWARMING_SERVER': 'https://chromium-swarm.appspot.com', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'SWARMING_HEADLESS': '1', 'PYTHONNOUSERSITE': '1', 'LUCI_CONTEXT': '/b/s/w/itNeVTs6/luci_ctx.lDMz_e.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qaNS9YIIrQ/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '4378953a41480e11', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/itNeVTs6', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'}\n[04:42:03:INFO] User defaults from command line:\n[04:42:03:INFO] IDEBuildOperationResultBundlePath = /b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0\n[04:42:03:INFO] IDETestRunSpecificationPath = /b/s/w/ioVbTUGC/run_1552092123.xctestrun\n[04:42:03:INFO] \n[04:42:04:INFO] Testing started on 'iPhone X'\n[04:42:04:INFO] 2019-03-08 16:42:04.721 xcodebuild[87135:825023] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[04:42:04:INFO] /b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_showcase_egtests_module-69C87AB6-E287-4E2D-9AF9-E3362FB36CB3/ios_showcase_egtests_module-6868B118-1F99-4487-89B5-8422275DEDEA/Session-ios_showcase_egtests_module-2019-03-08_164204-L6rl9y.log\n[04:42:04:INFO] 2019-03-08 16:42:04.721 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: (FCB7C6FF-C835-4E50-83A6-D030FC16CDB2) Beginning test session ios_showcase_egtests_module-FCB7C6FF-C835-4E50-83A6-D030FC16CDB2 at 2019-03-08 16:42:04.721 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fcd5ac48d40> {\n[04:42:04:INFO] \t\tSimDevice: Clone 1 of iPhone X (6846C1AC-6863-4884-9F90-60DEB189FCD8, iOS 12.1, Shutdown)\n[04:42:04:INFO] } (12.1 (16B91))\n[04:42:25:INFO] 2019-03-08 16:42:25.995 xcodebuild[87135:826083] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[04:42:25:INFO] /b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_showcase_egtests_module-69C87AB6-E287-4E2D-9AF9-E3362FB36CB3/ios_showcase_egtests_module-2EFDB3F4-5AC2-4B8A-AF7C-D613F2F06288/Session-ios_showcase_egtests_module-2019-03-08_164225-rWEGJ2.log\n[04:42:25:INFO] 2019-03-08 16:42:25.996 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: (BB230014-0DEF-4BAA-9603-60205F8115F4) Beginning test session ios_showcase_egtests_module-BB230014-0DEF-4BAA-9603-60205F8115F4 at 2019-03-08 16:42:25.996 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fcd5fa18c30> {\n[04:42:25:INFO] \t\tSimDevice: Clone 2 of iPhone X (7E781196-4499-4EC1-94B4-210A6DCC8FE1, iOS 12.1, Shutdown)\n[04:42:25:INFO] } (12.1 (16B91))\n[04:42:26:INFO] 2019-03-08 16:42:26.006 xcodebuild[87135:826055] IDETestOperationsObserverDebug: Writing diagnostic log for test session to:\n[04:42:26:INFO] /b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_showcase_egtests_module-69C87AB6-E287-4E2D-9AF9-E3362FB36CB3/ios_showcase_egtests_module-13E5AC2D-F3EA-44CF-9A1F-9FB654C95EAE/Session-ios_showcase_egtests_module-2019-03-08_164226-uuFgBu.log\n[04:42:26:INFO] 2019-03-08 16:42:26.006 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: (CFA69933-5F49-4317-8EB3-F82275DA3230) Beginning test session ios_showcase_egtests_module-CFA69933-5F49-4317-8EB3-F82275DA3230 at 2019-03-08 16:42:26.006 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fcd5addd3e0> {\n[04:42:26:INFO] \t\tSimDevice: Clone 3 of iPhone X (70FE789B-0765-45D0-BD60-11E4770372B8, iOS 12.1, Shutdown)\n[04:42:26:INFO] } (12.1 (16B91))\n[04:42:28:INFO] Test suite 'SCContentSuggestionsTestCase' started on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)'\n[04:42:52:INFO] Test case '-[SCContentSuggestionsTestCase testLaunch]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (24.774 seconds)\n[04:43:00:INFO] Test suite 'SCBubbleTestCase' started on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)'\n[04:43:07:INFO] Test suite 'SCPaymentsEditorTestCase' started on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)'\n[04:43:13:INFO] Test case '-[SCContentSuggestionsTestCase testLongPressItem]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (20.576 seconds)\n[04:43:14:INFO] Test case '-[SCBubbleTestCase testTextBadgeAccessibilityLabel]' passed on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)' (13.819 seconds)\n[04:43:14:INFO] Test suite 'SCPaymentsPickerTestCase' started on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)'\n[04:43:14:INFO] Test case '-[SCContentSuggestionsTestCase testNoSwipeToDismissEmptyItem]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (1.658 seconds)\n[04:43:32:INFO] Test case '-[SCContentSuggestionsTestCase testOpenItem]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (17.479 seconds)\n[04:43:49:INFO] Test case '-[SCContentSuggestionsTestCase testSwipeToDismiss]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (17.458 seconds)\n[04:43:57:INFO] Test case '-[SCPaymentsEditorTestCase testInputAccessoryViewCloseButton]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (49.883 seconds)\n[04:44:08:INFO] Test case '-[SCContentSuggestionsTestCase testTapLearnMore]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (18.940 seconds)\n[04:44:08:INFO] Test suite 'SCPaymentsSelectorTestCase' started on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)'\n[04:44:23:INFO] Test case '-[SCPaymentsSelectorTestCase testCanAddItem]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (14.816 seconds)\n[04:44:49:INFO] Test case '-[SCPaymentsSelectorTestCase testCanSelectItems]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (25.655 seconds)\n[04:45:06:INFO] Test case '-[SCPaymentsSelectorTestCase testVerifyItems]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (16.761 seconds)\n[04:45:06:INFO] Test suite 'ShowcaseCoreTestCase' started on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)'\n[04:45:07:INFO] Test case '-[ShowcaseCoreTestCase testLaunch]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (1.604 seconds)\n[04:45:07:INFO] Test suite 'SCTextBadgeViewTestCase' started on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)'\n[04:45:12:INFO] Test case '-[SCPaymentsEditorTestCase testInputAccessoryViewNavigationButtons]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (75.097 seconds)\n[04:45:26:INFO] Test case '-[SCTextBadgeViewTestCase testTextBadgeAccessibilityLabel]' passed on 'Clone 1 of iPhone X - ios_showcase_egtests.app (87260)' (18.951 seconds)\n[04:45:33:INFO] Test case '-[SCPaymentsPickerTestCase testVerifyFiltering]' passed on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)' (139.172 seconds)\n[04:45:49:INFO] Test case '-[SCPaymentsEditorTestCase testNavigationByTappingReturn]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (37.040 seconds)\n[04:46:07:INFO] Test case '-[SCPaymentsEditorTestCase testVerifyLabelsAndFields]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (17.991 seconds)\n[04:46:16:INFO] Test case '-[SCPaymentsPickerTestCase testVerifyRowsAndSection]' passed on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)' (42.787 seconds)\n[04:46:33:INFO] Test case '-[SCPaymentsEditorTestCase testVerifyProvinceFieldInputView]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (26.666 seconds)\n[04:46:49:INFO] Test case '-[SCPaymentsPickerTestCase testVerifySelection]' passed on 'Clone 2 of iPhone X - ios_showcase_egtests.app (87481)' (32.540 seconds)\n[04:47:07:INFO] Test case '-[SCPaymentsEditorTestCase testVerifyTappingSelectorFieldNotifiesDelegate]' passed on 'Clone 3 of iPhone X - ios_showcase_egtests.app (87484)' (33.060 seconds)\n[04:47:07:INFO] 2019-03-08 16:47:07.488 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: 303.335 elapsed -- Testing started completed.\n[04:47:07:INFO] 2019-03-08 16:47:07.488 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start\n[04:47:07:INFO] 2019-03-08 16:47:07.489 xcodebuild[87135:825007] [MT] IDETestOperationsObserverDebug: 303.335 sec, +303.335 sec -- end\n[04:47:07:INFO] ** TEST EXECUTE SUCCEEDED **\n[04:47:07:INFO] \n[04:47:21:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioVbTUGC/run_1552092123.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioVbTUGC/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '3'] finished with 0\n[04:47:21:DEBUG] self.logs:\n[04:47:21:DEBUG] {'failed': [], 'flaked': [], 'passed': ['SCContentSuggestionsTestCase/testLaunch', 'SCContentSuggestionsTestCase/testLongPressItem', 'SCContentSuggestionsTestCase/testNoSwipeToDismissEmptyItem', 'SCContentSuggestionsTestCase/testOpenItem', 'SCContentSuggestionsTestCase/testSwipeToDismiss', 'SCContentSuggestionsTestCase/testTapLearnMore', 'SCBubbleTestCase/testTextBadgeAccessibilityLabel', 'SCPaymentsEditorTestCase/testInputAccessoryViewCloseButton', 'SCPaymentsEditorTestCase/testInputAccessoryViewNavigationButtons', 'SCPaymentsEditorTestCase/testNavigationByTappingReturn', 'SCPaymentsEditorTestCase/testVerifyLabelsAndFields', 'SCPaymentsEditorTestCase/testVerifyProvinceFieldInputView', 'SCPaymentsEditorTestCase/testVerifyTappingSelectorFieldNotifiesDelegate', 'SCPaymentsPickerTestCase/testVerifyFiltering', 'SCPaymentsPickerTestCase/testVerifyRowsAndSection', 'SCPaymentsPickerTestCase/testVerifySelection', 'SCPaymentsSelectorTestCase/testCanAddItem', 'SCPaymentsSelectorTestCase/testCanSelectItems', 'SCPaymentsSelectorTestCase/testVerifyItems', 'ShowcaseCoreTestCase/testLaunch', 'SCTextBadgeViewTestCase/testTextBadgeAccessibilityLabel']}\n", "outputs_ref": { "isolated": "8bec2ca4860419d3444f8fda4b0e77e34c586ed5", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "4378953a41480e11", "server_versions": [ "4158-1053c58" ], "started_ts": "2019-03-09T00:29:32.972237", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:ios-simulator-full-configs", "buildnumber:14075", "data:cdb251ec57984ed0d1a543b3f464496e19c9026f", "device_type:iPhone X", "gerrit:https://chromium-review.googlesource.com/c/1495440/36", "ios_version:12.1", "master:tryserver.chromium.mac", "name:ios_showcase_egtests", "os:Mac-10.13.6", "platform:simulator", "pool:Chrome", "priority:30", "service_account:ios-isolated-tester@chops-service-accounts.iam.gserviceaccount.com", "slavename:vm140-m9", "spec_name:chromium.try:ios-simulator-full-configs", "stepname:ios_showcase_egtests (iPhone X iOS 12.1) on Mac-10.13.6", "swarming.pool.template:none", "swarming.pool.version:5f2a35baa96d88e49308d5df596fd42fd826abaf", "test:ios_showcase_egtests", "user:None" ], "task_id": "4378953a41480e10", "try_number": "1" } ] }