[00:47:14.737] New invocation is queued and will start shortly
[00:47:16.322] Starting the invocation (attempt 1)
[00:47:16.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:16.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:16.365] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056942437157395696",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cae2b6cce9eb6e17cc29479f119f095b9d4b8149\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9056942437157395696",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"gitiles_ref:refs/heads/master"
]
}
[00:47:17.584] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578790036643392",
"id": "8891512374495234624",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cae2b6cce9eb6e17cc29479f119f095b9d4b8149\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578790037432814",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11882",
"builder:ToTiOS",
"buildset:commit/git/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056942437157395696",
"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/8891512374495234624/+/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": "1578790037432943",
"url": "https://ci.chromium.org/b/8891512374495234624",
"utcnow_ts": "1578790037576055"
}
}
[00:47:17.584] Task URL: https://ci.chromium.org/b/8891512374495234624
[00:47:17.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:2:0) after 1m0s
[00:48:18.823] Received PubSub notification, asking Buildbucket for the build status
[00:48:19.091] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:29.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:2:0)
[00:48:29.387] Timer tick, asking Buildbucket for the build status
[00:48:30.077] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:30.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:4:0) after 1m0s
[00:49:30.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:4:0)
[00:49:30.096] Timer tick, asking Buildbucket for the build status
[00:49:30.366] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:30.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:5:0) after 1m0s
[00:50:30.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:5:0)
[00:50:30.421] Timer tick, asking Buildbucket for the build status
[00:50:30.615] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:30.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:6:0) after 1m0s
[00:51:30.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:6:0)
[00:51:30.644] Timer tick, asking Buildbucket for the build status
[00:51:33.688] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:33.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:7:0) after 1m0s
[00:52:33.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:7:0)
[00:52:33.711] Timer tick, asking Buildbucket for the build status
[00:52:34.005] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:34.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:8:0) after 1m0s
[00:53:34.084] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:8:0)
[00:53:34.084] Timer tick, asking Buildbucket for the build status
[00:53:36.950] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:9:0) after 1m0s
[00:54:36.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:9:0)
[00:54:36.969] Timer tick, asking Buildbucket for the build status
[00:54:37.200] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:37.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:10:0) after 1m0s
[00:55:37.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:10:0)
[00:55:37.221] Timer tick, asking Buildbucket for the build status
[00:55:37.575] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:37.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:11:0) after 1m0s
[00:56:37.615] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:11:0)
[00:56:37.615] Timer tick, asking Buildbucket for the build status
[00:56:37.916] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:37.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:12:0) after 1m0s
[00:57:37.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:12:0)
[00:57:37.983] Timer tick, asking Buildbucket for the build status
[00:57:38.422] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:38.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:13:0) after 1m0s
[00:58:38.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:13:0)
[00:58:38.535] Timer tick, asking Buildbucket for the build status
[00:58:38.920] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:38.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:14:0) after 1m0s
[00:59:38.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:14:0)
[00:59:38.993] Timer tick, asking Buildbucket for the build status
[00:59:39.764] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:15:0) after 1m0s
[01:00:39.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:15:0)
[01:00:39.780] Timer tick, asking Buildbucket for the build status
[01:00:40.029] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:40.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:16:0) after 1m0s
[01:01:40.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:16:0)
[01:01:40.055] Timer tick, asking Buildbucket for the build status
[01:01:40.297] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:40.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:17:0) after 1m0s
[01:02:40.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:17:0)
[01:02:40.324] Timer tick, asking Buildbucket for the build status
[01:02:43.288] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:43.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:18:0) after 1m0s
[01:03:43.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:18:0)
[01:03:43.319] Timer tick, asking Buildbucket for the build status
[01:03:43.574] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:43.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:19:0) after 1m0s
[01:04:43.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:19:0)
[01:04:43.580] Timer tick, asking Buildbucket for the build status
[01:04:43.936] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:43.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:20:0) after 1m0s
[01:05:44.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:20:0)
[01:05:44.006] Timer tick, asking Buildbucket for the build status
[01:05:44.332] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:44.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:21:0) after 1m0s
[01:06:44.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:21:0)
[01:06:44.401] Timer tick, asking Buildbucket for the build status
[01:06:44.686] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:44.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:22:0) after 1m0s
[01:07:44.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:22:0)
[01:07:44.805] Timer tick, asking Buildbucket for the build status
[01:07:45.258] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:45.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:23:0) after 1m0s
[01:08:45.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:23:0)
[01:08:45.322] Timer tick, asking Buildbucket for the build status
[01:08:45.503] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:45.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:24:0) after 1m0s
[01:09:45.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:24:0)
[01:09:45.649] Timer tick, asking Buildbucket for the build status
[01:09:45.928] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:45.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:25:0) after 1m0s
[01:10:45.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:25:0)
[01:10:45.944] Timer tick, asking Buildbucket for the build status
[01:10:46.505] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:46.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:26:0) after 1m0s
[01:11:46.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:26:0)
[01:11:46.643] Timer tick, asking Buildbucket for the build status
[01:11:46.866] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:46.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:27:0) after 1m0s
[01:12:46.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:27:0)
[01:12:46.935] Timer tick, asking Buildbucket for the build status
[01:12:47.214] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:47.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:28:0) after 1m0s
[01:13:47.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:28:0)
[01:13:47.232] Timer tick, asking Buildbucket for the build status
[01:13:48.269] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:48.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:29:0) after 1m0s
[01:14:48.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:29:0)
[01:14:48.312] Timer tick, asking Buildbucket for the build status
[01:14:49.131] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:49.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:30:0) after 1m0s
[01:15:49.152] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:30:0)
[01:15:49.152] Timer tick, asking Buildbucket for the build status
[01:15:49.439] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:49.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:31:0) after 1m0s
[01:16:49.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:31:0)
[01:16:49.549] Timer tick, asking Buildbucket for the build status
[01:16:49.892] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:49.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:32:0) after 1m0s
[01:17:49.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:32:0)
[01:17:49.966] Timer tick, asking Buildbucket for the build status
[01:17:50.777] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:50.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:33:0) after 1m0s
[01:18:50.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:33:0)
[01:18:50.800] Timer tick, asking Buildbucket for the build status
[01:18:51.103] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:51.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:34:0) after 1m0s
[01:19:51.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:34:0)
[01:19:51.125] Timer tick, asking Buildbucket for the build status
[01:19:51.342] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:51.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:35:0) after 1m0s
[01:20:51.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:35:0)
[01:20:51.371] Timer tick, asking Buildbucket for the build status
[01:20:51.557] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:51.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:36:0) after 1m0s
[01:21:51.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:36:0)
[01:21:51.632] Timer tick, asking Buildbucket for the build status
[01:21:51.881] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:51.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:37:0) after 1m0s
[01:22:51.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:37:0)
[01:22:51.966] Timer tick, asking Buildbucket for the build status
[01:22:52.501] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:52.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:38:0) after 1m0s
[01:23:52.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:38:0)
[01:23:52.535] Timer tick, asking Buildbucket for the build status
[01:23:52.754] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:52.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:39:0) after 1m0s
[01:24:53.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:39:0)
[01:24:53.161] Timer tick, asking Buildbucket for the build status
[01:24:53.387] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:53.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:40:0) after 1m0s
[01:25:53.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:40:0)
[01:25:53.767] Timer tick, asking Buildbucket for the build status
[01:25:54.012] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:41:0) after 1m0s
[01:26:54.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:41:0)
[01:26:54.301] Timer tick, asking Buildbucket for the build status
[01:26:54.496] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:54.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:42:0) after 1m0s
[01:27:54.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:42:0)
[01:27:54.700] Timer tick, asking Buildbucket for the build status
[01:27:54.923] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:54.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:43:0) after 1m0s
[01:28:55.084] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:43:0)
[01:28:55.084] Timer tick, asking Buildbucket for the build status
[01:28:55.716] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:55.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:44:0) after 1m0s
[01:29:55.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:44:0)
[01:29:55.923] Timer tick, asking Buildbucket for the build status
[01:29:56.573] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:56.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:45:0) after 1m0s
[01:30:56.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:45:0)
[01:30:56.598] Timer tick, asking Buildbucket for the build status
[01:30:56.804] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:56.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:46:0) after 1m0s
[01:31:56.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:46:0)
[01:31:56.824] Timer tick, asking Buildbucket for the build status
[01:31:57.056] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:57.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:47:0) after 1m0s
[01:32:57.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:47:0)
[01:32:57.202] Timer tick, asking Buildbucket for the build status
[01:32:57.523] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:48:0) after 1m0s
[01:33:57.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:48:0)
[01:33:57.744] Timer tick, asking Buildbucket for the build status
[01:33:58.394] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:58.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:49:0) after 1m0s
[01:34:58.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:49:0)
[01:34:58.529] Timer tick, asking Buildbucket for the build status
[01:34:58.783] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:58.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:50:0) after 1m0s
[01:35:58.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:50:0)
[01:35:58.936] Timer tick, asking Buildbucket for the build status
[01:35:59.127] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:59.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:51:0) after 1m0s
[01:36:59.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:51:0)
[01:36:59.208] Timer tick, asking Buildbucket for the build status
[01:36:59.757] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:59.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:52:0) after 1m0s
[01:37:59.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:52:0)
[01:37:59.801] Timer tick, asking Buildbucket for the build status
[01:38:00.095] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:00.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:53:0) after 1m0s
[01:39:00.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:53:0)
[01:39:00.126] Timer tick, asking Buildbucket for the build status
[01:39:00.864] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:00.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:54:0) after 1m0s
[01:40:00.933] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:54:0)
[01:40:00.933] Timer tick, asking Buildbucket for the build status
[01:40:01.114] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:01.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:55:0) after 1m0s
[01:41:01.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:55:0)
[01:41:01.134] Timer tick, asking Buildbucket for the build status
[01:41:01.438] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:01.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:56:0) after 1m0s
[01:42:01.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:56:0)
[01:42:01.473] Timer tick, asking Buildbucket for the build status
[01:42:01.863] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:01.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:57:0) after 1m0s
[01:43:01.931] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:57:0)
[01:43:01.931] Timer tick, asking Buildbucket for the build status
[01:43:02.796] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:02.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:58:0) after 1m0s
[01:44:02.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:58:0)
[01:44:02.960] Timer tick, asking Buildbucket for the build status
[01:44:03.493] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:59:0) after 1m0s
[01:45:03.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:59:0)
[01:45:03.519] Timer tick, asking Buildbucket for the build status
[01:45:03.747] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:03.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:60:0) after 1m0s
[01:46:03.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:60:0)
[01:46:03.776] Timer tick, asking Buildbucket for the build status
[01:46:03.976] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:03.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:61:0) after 1m0s
[01:47:04.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:61:0)
[01:47:04.101] Timer tick, asking Buildbucket for the build status
[01:47:04.536] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:04.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:62:0) after 1m0s
[01:48:04.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:62:0)
[01:48:04.650] Timer tick, asking Buildbucket for the build status
[01:48:05.086] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:05.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:63:0) after 1m0s
[01:49:05.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:63:0)
[01:49:05.156] Timer tick, asking Buildbucket for the build status
[01:49:06.820] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:06.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:64:0) after 1m0s
[01:50:06.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:64:0)
[01:50:06.943] Timer tick, asking Buildbucket for the build status
[01:50:07.240] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:07.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:65:0) after 1m0s
[01:51:07.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:65:0)
[01:51:07.275] Timer tick, asking Buildbucket for the build status
[01:51:07.446] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:07.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:66:0) after 1m0s
[01:52:07.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:66:0)
[01:52:07.507] Timer tick, asking Buildbucket for the build status
[01:52:07.726] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:07.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:67:0) after 1m0s
[01:53:07.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:67:0)
[01:53:07.700] Timer tick, asking Buildbucket for the build status
[01:53:08.264] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:08.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:68:0) after 1m0s
[01:54:08.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:68:0)
[01:54:08.298] Timer tick, asking Buildbucket for the build status
[01:54:08.509] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:08.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:69:0) after 1m0s
[01:55:08.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:69:0)
[01:55:08.528] Timer tick, asking Buildbucket for the build status
[01:55:08.762] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:08.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:70:0) after 1m0s
[01:56:08.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:70:0)
[01:56:08.790] Timer tick, asking Buildbucket for the build status
[01:56:09.162] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:09.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:71:0) after 1m0s
[01:57:09.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:71:0)
[01:57:09.197] Timer tick, asking Buildbucket for the build status
[01:57:10.230] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:10.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:72:0) after 1m0s
[01:58:10.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:72:0)
[01:58:10.271] Timer tick, asking Buildbucket for the build status
[01:58:10.956] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:73:0) after 1m0s
[01:59:11.075] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:73:0)
[01:59:11.075] Timer tick, asking Buildbucket for the build status
[01:59:11.283] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:11.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:74:0) after 1m0s
[02:00:11.287] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:74:0)
[02:00:11.287] Timer tick, asking Buildbucket for the build status
[02:00:11.892] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:11.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:75:0) after 1m0s
[02:01:12.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:75:0)
[02:01:12.564] Timer tick, asking Buildbucket for the build status
[02:01:12.990] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:12.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:76:0) after 1m0s
[02:02:13.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:76:0)
[02:02:13.523] Timer tick, asking Buildbucket for the build status
[02:02:13.899] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:13.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:77:0) after 1m0s
[02:03:14.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:77:0)
[02:03:14.017] Timer tick, asking Buildbucket for the build status
[02:03:14.374] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:14.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:78:0) after 1m0s
[02:04:14.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:78:0)
[02:04:14.656] Timer tick, asking Buildbucket for the build status
[02:04:14.898] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:14.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:79:0) after 1m0s
[02:05:15.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:79:0)
[02:05:15.229] Timer tick, asking Buildbucket for the build status
[02:05:15.920] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:80:0) after 1m0s
[02:06:16.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:80:0)
[02:06:16.190] Timer tick, asking Buildbucket for the build status
[02:06:16.893] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:16.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:81:0) after 1m0s
[02:07:16.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:81:0)
[02:07:16.911] Timer tick, asking Buildbucket for the build status
[02:07:17.117] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:17.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:82:0) after 1m0s
[02:08:17.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:82:0)
[02:08:17.143] Timer tick, asking Buildbucket for the build status
[02:08:17.603] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:17.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:83:0) after 1m0s
[02:09:17.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:83:0)
[02:09:17.669] Timer tick, asking Buildbucket for the build status
[02:09:17.962] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:84:0) after 1m0s
[02:10:17.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:84:0)
[02:10:17.986] Timer tick, asking Buildbucket for the build status
[02:10:18.194] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:18.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:85:0) after 1m0s
[02:11:18.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:85:0)
[02:11:18.504] Timer tick, asking Buildbucket for the build status
[02:11:19.458] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:19.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:86:0) after 1m0s
[02:12:19.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:86:0)
[02:12:19.625] Timer tick, asking Buildbucket for the build status
[02:12:19.894] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:19.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:87:0) after 1m0s
[02:13:19.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:87:0)
[02:13:19.936] Timer tick, asking Buildbucket for the build status
[02:13:21.083] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:21.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:88:0) after 1m0s
[02:14:21.111] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:88:0)
[02:14:21.111] Timer tick, asking Buildbucket for the build status
[02:14:21.483] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:21.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:89:0) after 1m0s
[02:15:21.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:89:0)
[02:15:21.572] Timer tick, asking Buildbucket for the build status
[02:15:22.268] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:22.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:90:0) after 1m0s
[02:16:22.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:90:0)
[02:16:22.319] Timer tick, asking Buildbucket for the build status
[02:16:22.644] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:22.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:91:0) after 1m0s
[02:17:22.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:91:0)
[02:17:22.832] Timer tick, asking Buildbucket for the build status
[02:17:23.147] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:23.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:92:0) after 1m0s
[02:18:23.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:92:0)
[02:18:23.385] Timer tick, asking Buildbucket for the build status
[02:18:25.180] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:25.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:93:0) after 1m0s
[02:19:25.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:93:0)
[02:19:25.243] Timer tick, asking Buildbucket for the build status
[02:19:26.481] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:26.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:94:0) after 1m0s
[02:20:26.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:94:0)
[02:20:26.508] Timer tick, asking Buildbucket for the build status
[02:20:27.200] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:95:0) after 1m0s
[02:21:27.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:95:0)
[02:21:27.473] Timer tick, asking Buildbucket for the build status
[02:21:27.679] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:27.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:96:0) after 1m0s
[02:22:27.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:96:0)
[02:22:27.722] Timer tick, asking Buildbucket for the build status
[02:22:27.893] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:27.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:97:0) after 1m0s
[02:23:27.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:97:0)
[02:23:27.979] Timer tick, asking Buildbucket for the build status
[02:23:28.367] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:28.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:98:0) after 1m0s
[02:24:28.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:98:0)
[02:24:28.534] Timer tick, asking Buildbucket for the build status
[02:24:28.885] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:28.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:99:0) after 1m0s
[02:25:28.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:99:0)
[02:25:28.914] Timer tick, asking Buildbucket for the build status
[02:25:29.392] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:29.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:100:0) after 1m0s
[02:26:29.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:100:0)
[02:26:29.586] Timer tick, asking Buildbucket for the build status
[02:26:30.662] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:30.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:101:0) after 1m0s
[02:27:30.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:101:0)
[02:27:30.706] Timer tick, asking Buildbucket for the build status
[02:27:31.547] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:102:0) after 1m0s
[02:28:31.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:102:0)
[02:28:31.606] Timer tick, asking Buildbucket for the build status
[02:28:32.586] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:32.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:103:0) after 1m0s
[02:29:32.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:103:0)
[02:29:32.603] Timer tick, asking Buildbucket for the build status
[02:29:32.795] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:104:0) after 1m0s
[02:30:32.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:104:0)
[02:30:32.822] Timer tick, asking Buildbucket for the build status
[02:30:32.996] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:32.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:105:0) after 1m0s
[02:31:33.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:105:0)
[02:31:33.040] Timer tick, asking Buildbucket for the build status
[02:31:33.310] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:33.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:106:0) after 1m0s
[02:32:33.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:106:0)
[02:32:33.329] Timer tick, asking Buildbucket for the build status
[02:32:33.543] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:33.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:107:0) after 1m0s
[02:33:33.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:107:0)
[02:33:33.635] Timer tick, asking Buildbucket for the build status
[02:33:33.916] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:33.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:108:0) after 1m0s
[02:34:33.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:108:0)
[02:34:33.961] Timer tick, asking Buildbucket for the build status
[02:34:34.371] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:34.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:109:0) after 1m0s
[02:35:34.428] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:109:0)
[02:35:34.428] Timer tick, asking Buildbucket for the build status
[02:35:35.291] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:35.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:110:0) after 1m0s
[02:36:35.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:110:0)
[02:36:35.312] Timer tick, asking Buildbucket for the build status
[02:36:36.886] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:36.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:111:0) after 1m0s
[02:37:36.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:111:0)
[02:37:36.993] Timer tick, asking Buildbucket for the build status
[02:37:37.478] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:37.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:112:0) after 1m0s
[02:38:37.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:112:0)
[02:38:37.627] Timer tick, asking Buildbucket for the build status
[02:38:38.076] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:113:0) after 1m0s
[02:39:38.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:113:0)
[02:39:38.341] Timer tick, asking Buildbucket for the build status
[02:39:38.597] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:38.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:114:0) after 1m0s
[02:40:38.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:114:0)
[02:40:38.638] Timer tick, asking Buildbucket for the build status
[02:40:39.685] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:39.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:115:0) after 1m0s
[02:41:39.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:115:0)
[02:41:39.824] Timer tick, asking Buildbucket for the build status
[02:41:41.564] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:116:0) after 1m0s
[02:42:41.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:116:0)
[02:42:41.679] Timer tick, asking Buildbucket for the build status
[02:42:42.388] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:42.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:117:0) after 1m0s
[02:43:42.369] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:117:0)
[02:43:42.369] Timer tick, asking Buildbucket for the build status
[02:43:42.586] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:118:0) after 1m0s
[02:44:42.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:118:0)
[02:44:42.716] Timer tick, asking Buildbucket for the build status
[02:44:42.961] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:119:0) after 1m0s
[02:45:42.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:119:0)
[02:45:42.984] Timer tick, asking Buildbucket for the build status
[02:45:43.206] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:43.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:120:0) after 1m0s
[02:46:43.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:120:0)
[02:46:43.232] Timer tick, asking Buildbucket for the build status
[02:46:43.469] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:43.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:121:0) after 1m0s
[02:47:43.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:121:0)
[02:47:43.494] Timer tick, asking Buildbucket for the build status
[02:47:43.801] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:43.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:122:0) after 1m0s
[02:48:43.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:122:0)
[02:48:43.842] Timer tick, asking Buildbucket for the build status
[02:48:43.999] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:123:0) after 1m0s
[02:49:44.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:123:0)
[02:49:44.034] Timer tick, asking Buildbucket for the build status
[02:49:44.221] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:44.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:124:0) after 1m0s
[02:50:44.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:124:0)
[02:50:44.332] Timer tick, asking Buildbucket for the build status
[02:50:44.904] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:125:0) after 1m0s
[02:51:45.084] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:125:0)
[02:51:45.084] Timer tick, asking Buildbucket for the build status
[02:51:45.271] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:45.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:126:0) after 1m0s
[02:52:45.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:126:0)
[02:52:45.296] Timer tick, asking Buildbucket for the build status
[02:52:45.461] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:45.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:127:0) after 1m0s
[02:53:45.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:127:0)
[02:53:45.531] Timer tick, asking Buildbucket for the build status
[02:53:45.756] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:45.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:128:0) after 1m0s
[02:54:45.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:128:0)
[02:54:45.977] Timer tick, asking Buildbucket for the build status
[02:54:46.142] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:129:0) after 1m0s
[02:55:46.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:129:0)
[02:55:46.301] Timer tick, asking Buildbucket for the build status
[02:55:46.670] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:130:0) after 1m0s
[02:56:47.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:130:0)
[02:56:47.060] Timer tick, asking Buildbucket for the build status
[02:56:47.480] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:47.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:131:0) after 1m0s
[02:57:47.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:131:0)
[02:57:47.632] Timer tick, asking Buildbucket for the build status
[02:57:47.957] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:47.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:132:0) after 1m0s
[02:58:48.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:132:0)
[02:58:48.344] Timer tick, asking Buildbucket for the build status
[02:58:48.546] Build 8891512374495234624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:48.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056942437157395696:133:0) after 1m0s
[02:59:31.463] Received PubSub notification, asking Buildbucket for the build status
[02:59:31.708] Build 8891512374495234624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:59:31.708] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578797970656224",
"created_by": "project:chromium",
"created_ts": "1578790036643392",
"id": "8891512374495234624",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cae2b6cce9eb6e17cc29479f119f095b9d4b8149\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": 11882, \"got_angle_revision\": \"ed074852bf075546232c438cd095a1845462ff40\", \"got_dawn_revision\": \"69c68d01b2420e77283166ffcc7ddb4b0fbc2505\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"cae2b6cce9eb6e17cc29479f119f095b9d4b8149\", \"got_revision_cp\": \"refs/heads/master@{#730437}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b0ca2a89e255446237d92ffbd76ef3bf97bfd6cd\", \"got_v8_revision\": \"5cc27b0cdcd62fc7dc702cb7769e8bed2d5c1355\", \"got_v8_revision_cp\": \"refs/heads/8.1.158@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"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\": \"cae2b6cce9eb6e17cc29479f119f095b9d4b8149\", \"swarm_hashes\": {\"0\": \"15d0a8ff5bcf7927fadf720552621e848aa11b1b\", \"1\": \"3c2515d7dffb224f3eed231860b8b1f9e0e8a1f9\", \"10\": \"01e3b05487ceff437e389f5e499db9b43069a05a\", \"11\": \"ad7b2e7d0531add643255fa7e7a6355a74535b73\", \"12\": \"3553b051b4d73021d124d4f4f8692c10b8797ff9\", \"13\": \"13677f74085d178d5daf33ae4ec31325baec0a91\", \"14\": \"61cebc4c0d0d04945aa371c68c7511df5e943998\", \"15\": \"9bf2ed7f77732c856b32ef69b9958e3b4ca4bdf5\", \"16\": \"b1c5e678a4cc3e5131dab27740fabe18026db369\", \"2\": \"33a772da26267837982577da1717371de8cda14f\", \"3\": \"b189839e729ebe9a45f5382e4f36a60fa713fda6\", \"4\": \"cbd1ca3744db9592e9987646d92fcf95298c6862\", \"5\": \"f9653dbd1ec5903955fb38b44979d26352cdccc2\", \"6\": \"baafeeccb2eff380c9e485c69171034ac5aa44dd\", \"7\": \"822aae150d2915c015d42c060b36a48ca09c057a\", \"8\": \"bba053466d2a85e59e58c59db8b58591d51a95e0\", \"9\": \"1d9be117ab4c99a03defefa2f76ee256de9c25e0\"}}, \"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\": [\"4752-73c7603\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578790083651428",
"status": "COMPLETED",
"status_changed_ts": "1578797970917788",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11882",
"builder:ToTiOS",
"buildset:commit/git/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cae2b6cce9eb6e17cc29479f119f095b9d4b8149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056942437157395696",
"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/8891512374495234624/+/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:49b009b0f123ca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1578797970922486",
"url": "https://ci.chromium.org/b/8891512374495234624",
"utcnow_ts": "1578797971679560"
}
}
[02:59:31.708] Invocation finished in 2h12m16.986342475s with status SUCCEEDED