[00:12:21.191] New invocation is queued and will start shortly
[00:12:22.394] Starting the invocation (attempt 1)
[00:12:22.482] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:12:22.482] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:12:22.482] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061112092869994800",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"55972f22e8abba7d711247be66baa5a511dd2edf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9061112092869994800",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/55972f22e8abba7d711247be66baa5a511dd2edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/55972f22e8abba7d711247be66baa5a511dd2edf",
"gitiles_ref:refs/heads/master"
]
}
[00:12:23.789] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574813542853088",
"id": "8895682030447261616",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"55972f22e8abba7d711247be66baa5a511dd2edf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574813543546722",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11284",
"builder:ToTiOS",
"buildset:commit/git/55972f22e8abba7d711247be66baa5a511dd2edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/55972f22e8abba7d711247be66baa5a511dd2edf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061112092869994800",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8895682030447261616/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1574813543546865",
"url": "https://ci.chromium.org/b/8895682030447261616",
"utcnow_ts": "1574813543776673"
}
}
[00:12:23.789] Task URL: https://ci.chromium.org/b/8895682030447261616
[00:12:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:2:0) after 1m0s
[00:13:23.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:2:0)
[00:13:23.818] Timer tick, asking Buildbucket for the build status
[00:13:24.301] Build 8895682030447261616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:24.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:3:0) after 1m0s
[00:14:24.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:3:0)
[00:14:24.398] Timer tick, asking Buildbucket for the build status
[00:14:24.584] Build 8895682030447261616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:24.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:4:0) after 1m0s
[00:15:24.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:4:0)
[00:15:24.654] Timer tick, asking Buildbucket for the build status
[00:15:26.113] Build 8895682030447261616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:26.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:5:0) after 1m0s
[00:15:54.108] Received PubSub notification, asking Buildbucket for the build status
[00:15:54.833] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:26.263] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:5:0)
[00:16:26.263] Timer tick, asking Buildbucket for the build status
[00:16:26.827] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:26.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:7:0) after 1m0s
[00:17:26.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:7:0)
[00:17:26.943] Timer tick, asking Buildbucket for the build status
[00:17:27.478] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:27.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:8:0) after 1m0s
[00:18:27.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:8:0)
[00:18:27.537] Timer tick, asking Buildbucket for the build status
[00:18:27.719] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:9:0) after 1m0s
[00:19:27.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:9:0)
[00:19:27.826] Timer tick, asking Buildbucket for the build status
[00:19:28.596] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:28.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:10:0) after 1m0s
[00:20:28.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:10:0)
[00:20:28.720] Timer tick, asking Buildbucket for the build status
[00:20:30.374] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:30.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:11:0) after 1m0s
[00:21:30.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:11:0)
[00:21:30.501] Timer tick, asking Buildbucket for the build status
[00:21:30.691] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:30.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:12:0) after 1m0s
[00:22:30.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:12:0)
[00:22:30.723] Timer tick, asking Buildbucket for the build status
[00:22:30.927] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:30.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:13:0) after 1m0s
[00:23:30.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:13:0)
[00:23:30.971] Timer tick, asking Buildbucket for the build status
[00:23:31.821] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:14:0) after 1m0s
[00:24:31.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:14:0)
[00:24:31.855] Timer tick, asking Buildbucket for the build status
[00:24:32.334] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:32.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:15:0) after 1m0s
[00:25:32.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:15:0)
[00:25:32.402] Timer tick, asking Buildbucket for the build status
[00:25:33.653] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:33.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:16:0) after 1m0s
[00:26:33.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:16:0)
[00:26:33.752] Timer tick, asking Buildbucket for the build status
[00:26:33.929] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:33.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:17:0) after 1m0s
[00:27:33.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:17:0)
[00:27:33.977] Timer tick, asking Buildbucket for the build status
[00:27:34.195] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:34.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:18:0) after 1m0s
[00:28:34.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:18:0)
[00:28:34.238] Timer tick, asking Buildbucket for the build status
[00:28:34.929] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:34.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:19:0) after 1m0s
[00:29:35.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:19:0)
[00:29:35.227] Timer tick, asking Buildbucket for the build status
[00:29:35.409] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:35.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:20:0) after 1m0s
[00:30:35.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:20:0)
[00:30:35.542] Timer tick, asking Buildbucket for the build status
[00:30:35.803] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:35.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:21:0) after 1m0s
[00:31:35.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:21:0)
[00:31:35.849] Timer tick, asking Buildbucket for the build status
[00:31:36.133] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:36.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:22:0) after 1m0s
[00:32:36.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:22:0)
[00:32:36.350] Timer tick, asking Buildbucket for the build status
[00:32:36.543] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:36.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:23:0) after 1m0s
[00:33:36.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:23:0)
[00:33:36.605] Timer tick, asking Buildbucket for the build status
[00:33:37.628] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:37.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:24:0) after 1m0s
[00:34:37.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:24:0)
[00:34:37.671] Timer tick, asking Buildbucket for the build status
[00:34:37.966] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:37.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:25:0) after 1m0s
[00:35:38.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:25:0)
[00:35:38.156] Timer tick, asking Buildbucket for the build status
[00:35:38.318] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:26:0) after 1m0s
[00:36:38.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:26:0)
[00:36:38.423] Timer tick, asking Buildbucket for the build status
[00:36:38.570] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:38.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:27:0) after 1m0s
[00:37:38.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:27:0)
[00:37:38.567] Timer tick, asking Buildbucket for the build status
[00:37:41.599] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:41.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:28:0) after 1m0s
[00:38:41.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:28:0)
[00:38:41.632] Timer tick, asking Buildbucket for the build status
[00:38:41.784] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:41.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:29:0) after 1m0s
[00:39:41.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:29:0)
[00:39:41.796] Timer tick, asking Buildbucket for the build status
[00:39:42.529] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:42.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:30:0) after 1m0s
[00:40:42.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:30:0)
[00:40:42.634] Timer tick, asking Buildbucket for the build status
[00:40:45.962] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:45.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:31:0) after 1m0s
[00:41:46.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:31:0)
[00:41:46.081] Timer tick, asking Buildbucket for the build status
[00:41:46.688] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:46.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:32:0) after 1m0s
[00:42:46.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:32:0)
[00:42:46.815] Timer tick, asking Buildbucket for the build status
[00:42:47.124] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:47.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:33:0) after 1m0s
[00:43:47.189] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:33:0)
[00:43:47.189] Timer tick, asking Buildbucket for the build status
[00:43:47.847] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:47.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:34:0) after 1m0s
[00:44:47.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:34:0)
[00:44:47.937] Timer tick, asking Buildbucket for the build status
[00:44:48.554] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:48.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:35:0) after 1m0s
[00:45:48.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:35:0)
[00:45:48.700] Timer tick, asking Buildbucket for the build status
[00:45:48.898] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:48.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:36:0) after 1m0s
[00:46:48.926] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:36:0)
[00:46:48.926] Timer tick, asking Buildbucket for the build status
[00:46:49.318] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:49.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:37:0) after 1m0s
[00:47:49.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:37:0)
[00:47:49.367] Timer tick, asking Buildbucket for the build status
[00:47:49.897] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:49.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:38:0) after 1m0s
[00:48:50.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:38:0)
[00:48:50.009] Timer tick, asking Buildbucket for the build status
[00:48:50.166] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:50.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:39:0) after 1m0s
[00:49:50.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:39:0)
[00:49:50.179] Timer tick, asking Buildbucket for the build status
[00:49:51.126] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:51.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:40:0) after 1m0s
[00:50:51.163] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:40:0)
[00:50:51.163] Timer tick, asking Buildbucket for the build status
[00:50:51.351] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:51.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:41:0) after 1m0s
[00:51:51.416] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:41:0)
[00:51:51.416] Timer tick, asking Buildbucket for the build status
[00:51:51.701] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:51.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:42:0) after 1m0s
[00:52:51.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:42:0)
[00:52:51.741] Timer tick, asking Buildbucket for the build status
[00:52:51.924] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:51.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:43:0) after 1m0s
[00:53:51.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:43:0)
[00:53:51.960] Timer tick, asking Buildbucket for the build status
[00:53:52.317] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:52.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:44:0) after 1m0s
[00:54:52.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:44:0)
[00:54:52.380] Timer tick, asking Buildbucket for the build status
[00:54:52.641] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:52.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:45:0) after 1m0s
[00:55:52.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:45:0)
[00:55:52.716] Timer tick, asking Buildbucket for the build status
[00:55:52.867] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:52.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:46:0) after 1m0s
[00:56:52.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:46:0)
[00:56:52.996] Timer tick, asking Buildbucket for the build status
[00:56:53.248] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:53.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:47:0) after 1m0s
[00:57:53.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:47:0)
[00:57:53.221] Timer tick, asking Buildbucket for the build status
[00:57:53.494] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:53.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:48:0) after 1m0s
[00:58:53.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:48:0)
[00:58:53.505] Timer tick, asking Buildbucket for the build status
[00:58:54.012] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:49:0) after 1m0s
[00:59:54.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:49:0)
[00:59:54.127] Timer tick, asking Buildbucket for the build status
[00:59:54.282] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:54.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:50:0) after 1m0s
[01:00:54.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:50:0)
[01:00:54.394] Timer tick, asking Buildbucket for the build status
[01:00:54.603] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:54.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:51:0) after 1m0s
[01:01:54.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:51:0)
[01:01:54.697] Timer tick, asking Buildbucket for the build status
[01:01:55.226] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:55.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:52:0) after 1m0s
[01:02:55.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:52:0)
[01:02:55.329] Timer tick, asking Buildbucket for the build status
[01:02:55.910] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:55.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:53:0) after 1m0s
[01:03:56.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:53:0)
[01:03:56.031] Timer tick, asking Buildbucket for the build status
[01:03:56.654] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:56.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:54:0) after 1m0s
[01:04:56.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:54:0)
[01:04:56.705] Timer tick, asking Buildbucket for the build status
[01:04:57.794] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:57.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:55:0) after 1m0s
[01:05:57.924] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:55:0)
[01:05:57.924] Timer tick, asking Buildbucket for the build status
[01:05:58.904] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:58.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:56:0) after 1m0s
[01:06:59.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:56:0)
[01:06:59.068] Timer tick, asking Buildbucket for the build status
[01:06:59.299] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:59.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:57:0) after 1m0s
[01:07:59.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:57:0)
[01:07:59.330] Timer tick, asking Buildbucket for the build status
[01:07:59.509] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:59.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:58:0) after 1m0s
[01:08:59.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:58:0)
[01:08:59.537] Timer tick, asking Buildbucket for the build status
[01:09:03.336] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:03.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:59:0) after 1m0s
[01:10:03.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:59:0)
[01:10:03.374] Timer tick, asking Buildbucket for the build status
[01:10:04.106] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:04.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:60:0) after 1m0s
[01:11:04.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:60:0)
[01:11:04.139] Timer tick, asking Buildbucket for the build status
[01:11:04.656] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:04.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:61:0) after 1m0s
[01:12:04.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:61:0)
[01:12:04.641] Timer tick, asking Buildbucket for the build status
[01:12:05.932] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:62:0) after 1m0s
[01:13:05.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:62:0)
[01:13:05.992] Timer tick, asking Buildbucket for the build status
[01:13:06.524] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:63:0) after 1m0s
[01:14:06.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:63:0)
[01:14:06.645] Timer tick, asking Buildbucket for the build status
[01:14:08.035] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:08.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:64:0) after 1m0s
[01:15:08.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:64:0)
[01:15:08.177] Timer tick, asking Buildbucket for the build status
[01:15:08.388] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:08.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:65:0) after 1m0s
[01:16:08.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:65:0)
[01:16:08.539] Timer tick, asking Buildbucket for the build status
[01:16:08.731] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:08.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:66:0) after 1m0s
[01:17:08.807] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:66:0)
[01:17:08.807] Timer tick, asking Buildbucket for the build status
[01:17:09.103] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:09.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:67:0) after 1m0s
[01:18:09.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:67:0)
[01:18:09.144] Timer tick, asking Buildbucket for the build status
[01:18:09.372] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:09.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:68:0) after 1m0s
[01:19:09.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:68:0)
[01:19:09.420] Timer tick, asking Buildbucket for the build status
[01:19:10.303] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:10.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:69:0) after 1m0s
[01:20:10.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:69:0)
[01:20:10.385] Timer tick, asking Buildbucket for the build status
[01:20:11.107] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:11.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:70:0) after 1m0s
[01:21:11.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:70:0)
[01:21:11.146] Timer tick, asking Buildbucket for the build status
[01:21:11.303] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:11.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:71:0) after 1m0s
[01:22:11.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:71:0)
[01:22:11.346] Timer tick, asking Buildbucket for the build status
[01:22:12.110] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:72:0) after 1m0s
[01:23:12.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:72:0)
[01:23:12.215] Timer tick, asking Buildbucket for the build status
[01:23:12.939] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:12.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:73:0) after 1m0s
[01:24:13.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:73:0)
[01:24:13.079] Timer tick, asking Buildbucket for the build status
[01:24:13.800] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:74:0) after 1m0s
[01:25:13.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:74:0)
[01:25:13.882] Timer tick, asking Buildbucket for the build status
[01:25:14.317] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:14.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:75:0) after 1m0s
[01:26:14.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:75:0)
[01:26:14.386] Timer tick, asking Buildbucket for the build status
[01:26:15.227] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:76:0) after 1m0s
[01:27:15.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:76:0)
[01:27:15.290] Timer tick, asking Buildbucket for the build status
[01:27:15.475] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:15.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:77:0) after 1m0s
[01:28:15.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:77:0)
[01:28:15.494] Timer tick, asking Buildbucket for the build status
[01:28:15.662] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:15.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:78:0) after 1m0s
[01:29:15.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:78:0)
[01:29:15.692] Timer tick, asking Buildbucket for the build status
[01:29:16.129] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:16.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:79:0) after 1m0s
[01:30:16.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:79:0)
[01:30:16.193] Timer tick, asking Buildbucket for the build status
[01:30:16.439] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:16.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:80:0) after 1m0s
[01:31:16.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:80:0)
[01:31:16.523] Timer tick, asking Buildbucket for the build status
[01:31:16.802] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:16.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:81:0) after 1m0s
[01:32:16.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:81:0)
[01:32:16.920] Timer tick, asking Buildbucket for the build status
[01:32:17.088] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:17.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:82:0) after 1m0s
[01:33:17.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:82:0)
[01:33:17.229] Timer tick, asking Buildbucket for the build status
[01:33:18.676] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:18.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:83:0) after 1m0s
[01:34:18.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:83:0)
[01:34:18.916] Timer tick, asking Buildbucket for the build status
[01:34:19.095] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:19.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:84:0) after 1m0s
[01:35:19.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:84:0)
[01:35:19.284] Timer tick, asking Buildbucket for the build status
[01:35:19.587] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:19.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:85:0) after 1m0s
[01:36:19.710] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:85:0)
[01:36:19.710] Timer tick, asking Buildbucket for the build status
[01:36:20.884] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:20.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:86:0) after 1m0s
[01:37:20.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:86:0)
[01:37:20.917] Timer tick, asking Buildbucket for the build status
[01:37:22.385] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:22.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:87:0) after 1m0s
[01:38:22.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:87:0)
[01:38:22.564] Timer tick, asking Buildbucket for the build status
[01:38:22.740] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:22.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:88:0) after 1m0s
[01:39:22.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:88:0)
[01:39:22.953] Timer tick, asking Buildbucket for the build status
[01:39:23.903] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:23.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:89:0) after 1m0s
[01:40:23.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:89:0)
[01:40:23.965] Timer tick, asking Buildbucket for the build status
[01:40:24.839] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:24.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:90:0) after 1m0s
[01:41:25.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:90:0)
[01:41:25.035] Timer tick, asking Buildbucket for the build status
[01:41:25.251] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:91:0) after 1m0s
[01:42:25.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:91:0)
[01:42:25.404] Timer tick, asking Buildbucket for the build status
[01:42:26.590] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:26.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:92:0) after 1m0s
[01:43:26.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:92:0)
[01:43:26.696] Timer tick, asking Buildbucket for the build status
[01:43:28.060] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:93:0) after 1m0s
[01:44:28.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:93:0)
[01:44:28.143] Timer tick, asking Buildbucket for the build status
[01:44:28.343] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:28.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:94:0) after 1m0s
[01:45:28.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:94:0)
[01:45:28.387] Timer tick, asking Buildbucket for the build status
[01:45:28.660] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:28.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:95:0) after 1m0s
[01:46:28.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:95:0)
[01:46:28.725] Timer tick, asking Buildbucket for the build status
[01:46:29.396] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:29.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:96:0) after 1m0s
[01:47:29.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:96:0)
[01:47:29.435] Timer tick, asking Buildbucket for the build status
[01:47:29.663] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:29.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:97:0) after 1m0s
[01:48:29.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:97:0)
[01:48:29.721] Timer tick, asking Buildbucket for the build status
[01:48:30.180] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:30.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:98:0) after 1m0s
[01:49:30.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:98:0)
[01:49:30.343] Timer tick, asking Buildbucket for the build status
[01:49:30.650] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:30.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:99:0) after 1m0s
[01:50:31.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:99:0)
[01:50:31.012] Timer tick, asking Buildbucket for the build status
[01:50:31.196] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:31.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:100:0) after 1m0s
[01:51:31.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:100:0)
[01:51:31.329] Timer tick, asking Buildbucket for the build status
[01:51:32.185] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:32.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:101:0) after 1m0s
[01:52:32.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:101:0)
[01:52:32.415] Timer tick, asking Buildbucket for the build status
[01:52:32.682] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:32.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:102:0) after 1m0s
[01:53:32.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:102:0)
[01:53:32.859] Timer tick, asking Buildbucket for the build status
[01:53:33.062] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:33.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:103:0) after 1m0s
[01:54:33.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:103:0)
[01:54:33.407] Timer tick, asking Buildbucket for the build status
[01:54:33.556] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:33.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:104:0) after 1m0s
[01:55:33.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:104:0)
[01:55:33.919] Timer tick, asking Buildbucket for the build status
[01:55:34.085] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:34.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:105:0) after 1m0s
[01:56:34.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:105:0)
[01:56:34.248] Timer tick, asking Buildbucket for the build status
[01:56:34.476] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:34.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:106:0) after 1m0s
[01:57:34.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:106:0)
[01:57:34.739] Timer tick, asking Buildbucket for the build status
[01:57:34.924] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:34.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:107:0) after 1m0s
[01:58:35.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:107:0)
[01:58:35.043] Timer tick, asking Buildbucket for the build status
[01:58:35.894] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:35.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:108:0) after 1m0s
[01:59:36.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:108:0)
[01:59:36.020] Timer tick, asking Buildbucket for the build status
[01:59:36.157] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:36.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:109:0) after 1m0s
[02:00:36.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:109:0)
[02:00:36.443] Timer tick, asking Buildbucket for the build status
[02:00:36.803] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:110:0) after 1m0s
[02:01:36.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:110:0)
[02:01:36.855] Timer tick, asking Buildbucket for the build status
[02:01:37.596] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:37.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:111:0) after 1m0s
[02:02:37.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:111:0)
[02:02:37.687] Timer tick, asking Buildbucket for the build status
[02:02:37.831] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:112:0) after 1m0s
[02:03:37.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:112:0)
[02:03:37.999] Timer tick, asking Buildbucket for the build status
[02:03:38.200] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:38.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:113:0) after 1m0s
[02:04:38.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:113:0)
[02:04:38.291] Timer tick, asking Buildbucket for the build status
[02:04:38.582] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:38.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:114:0) after 1m0s
[02:05:38.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:114:0)
[02:05:38.717] Timer tick, asking Buildbucket for the build status
[02:05:39.121] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:39.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:115:0) after 1m0s
[02:06:39.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:115:0)
[02:06:39.273] Timer tick, asking Buildbucket for the build status
[02:06:39.554] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:39.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:116:0) after 1m0s
[02:07:39.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:116:0)
[02:07:39.616] Timer tick, asking Buildbucket for the build status
[02:07:39.753] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:39.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:117:0) after 1m0s
[02:08:39.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:117:0)
[02:08:39.838] Timer tick, asking Buildbucket for the build status
[02:08:40.004] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:40.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:118:0) after 1m0s
[02:09:40.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:118:0)
[02:09:40.115] Timer tick, asking Buildbucket for the build status
[02:09:41.082] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:119:0) after 1m0s
[02:10:41.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:119:0)
[02:10:41.194] Timer tick, asking Buildbucket for the build status
[02:10:42.523] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:42.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:120:0) after 1m0s
[02:11:42.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:120:0)
[02:11:42.583] Timer tick, asking Buildbucket for the build status
[02:11:43.097] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:43.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:121:0) after 1m0s
[02:12:43.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:121:0)
[02:12:43.127] Timer tick, asking Buildbucket for the build status
[02:12:43.573] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:43.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:122:0) after 1m0s
[02:13:43.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:122:0)
[02:13:43.662] Timer tick, asking Buildbucket for the build status
[02:13:43.827] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:43.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:123:0) after 1m0s
[02:14:43.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:123:0)
[02:14:43.857] Timer tick, asking Buildbucket for the build status
[02:14:44.036] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:44.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:124:0) after 1m0s
[02:15:44.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:124:0)
[02:15:44.138] Timer tick, asking Buildbucket for the build status
[02:15:44.432] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:125:0) after 1m0s
[02:16:44.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:125:0)
[02:16:44.532] Timer tick, asking Buildbucket for the build status
[02:16:44.712] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:44.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:126:0) after 1m0s
[02:17:44.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:126:0)
[02:17:44.784] Timer tick, asking Buildbucket for the build status
[02:17:45.047] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:45.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:127:0) after 1m0s
[02:18:45.158] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:127:0)
[02:18:45.158] Timer tick, asking Buildbucket for the build status
[02:18:45.582] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:45.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:128:0) after 1m0s
[02:19:45.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:128:0)
[02:19:45.608] Timer tick, asking Buildbucket for the build status
[02:19:47.561] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:47.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:129:0) after 1m0s
[02:20:47.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:129:0)
[02:20:47.633] Timer tick, asking Buildbucket for the build status
[02:20:47.777] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:47.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:130:0) after 1m0s
[02:21:47.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:130:0)
[02:21:47.832] Timer tick, asking Buildbucket for the build status
[02:21:48.315] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:48.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:131:0) after 1m0s
[02:22:48.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:131:0)
[02:22:48.396] Timer tick, asking Buildbucket for the build status
[02:22:48.744] Build 8895682030447261616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:48.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9061112092869994800:132:0) after 1m0s
[02:23:11.425] Received PubSub notification, asking Buildbucket for the build status
[02:23:11.547] Build 8895682030447261616: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:23:11.548] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574821390612609",
"created_by": "project:chromium",
"created_ts": "1574813542853088",
"failure_reason": "BUILD_FAILURE",
"id": "8895682030447261616",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"55972f22e8abba7d711247be66baa5a511dd2edf\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 11284, \"got_angle_revision\": \"88752889c721c4621dde3e9209dffd60f5fc8d1f\", \"got_dawn_revision\": \"74cebd68792d5788144f50511b3eb35134f9803e\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"55972f22e8abba7d711247be66baa5a511dd2edf\", \"got_revision_cp\": \"refs/heads/master@{#719430}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"663dcefa22ea5eec1b108feebaf40a683fb104ff\", \"got_v8_revision\": \"f1c7d33e17f4525debf020af2915a0d03821e352\", \"got_v8_revision_cp\": \"refs/heads/8.0.383@{#1}\", \"got_webrtc_revision\": \"7a9a092708f1f3abc45f9aabda2db205132cc4ac\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29923}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"55972f22e8abba7d711247be66baa5a511dd2edf\", \"swarm_hashes\": {\"0\": \"f5fbefd5f4378ae2c9b37add54c39c94c0eaee3c\", \"1\": \"60c720a6268dc455677661defc06463db6429de8\", \"10\": \"8d7aa96545c3b230d3d7c837dcc99068fbb771fe\", \"11\": \"654b57451a9a79752b7b50dd7484efd0dff99065\", \"12\": \"979e9aa0c9d1bb439fc8fb2bfc45dd91bf7e27bb\", \"13\": \"dbbea0993a86935929a2c86eac4f441cea44aef5\", \"14\": \"b2ac2049f301d685f7d30db75469f3d4648a6936\", \"15\": \"dfdd837dd878d141229cd2221128090ed092841c\", \"16\": \"0ad4ec3968ae6d5e4fe0cb9cda91d9a1d0617f44\", \"2\": \"e11ac9af2a4872a603a6a0ea085b6bc1fb39ea10\", \"3\": \"c66228431fa4ee7e9b50fff59b3b63ccee32faa7\", \"4\": \"dc4e3a6bbac2f4c13076f5d2622a8ac486e58ed2\", \"5\": \"558f268c5b50fe1a368abc6b1e070c77637fd437\", \"6\": \"5d7b0141b2ee85224dc2f0d907b383a48ea4682c\", \"7\": \"7f2014762944f3ab251c982b05928addc0140965\", \"8\": \"549d7ad46da69b5d728283ce4c7101401ec6852c\", \"9\": \"6df2d3e16072cdf843581d9067a24770df84c2d2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_a165fbc5f77948fe8465d1f67a1e4a103f195e4f29767b5fac0876e41f78e10e_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4656-a09e2f8\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574813752960794",
"status": "COMPLETED",
"status_changed_ts": "1574813753632156",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11284",
"builder:ToTiOS",
"buildset:commit/git/55972f22e8abba7d711247be66baa5a511dd2edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/55972f22e8abba7d711247be66baa5a511dd2edf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061112092869994800",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8895682030447261616/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:48c3054969f14c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1574821390744628",
"url": "https://ci.chromium.org/b/8895682030447261616",
"utcnow_ts": "1574821391538366"
}
}
[02:23:11.548] Invocation finished in 2h10m50.388569167s with status FAILED