[13:54:06.198] New invocation is queued and will start shortly
[13:54:07.317] Starting the invocation (attempt 1)
[13:54:07.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:54:07.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:54:07.364] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071207253044179296",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"310fa8b7093a9438c97dcf778aa6a8485d23b1b6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9071207253044179296",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"gitiles_ref:refs/heads/master"
]
}
[13:54:14.132] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565186049053949",
"id": "8905777189386062336",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"310fa8b7093a9438c97dcf778aa6a8485d23b1b6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565186053490642",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9022",
"builder:ToTiOS",
"buildset:commit/git/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071207253044179296",
"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/8905777189386062336/+/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": "1565186053490742",
"url": "https://ci.chromium.org/b/8905777189386062336",
"utcnow_ts": "1565186054094196"
}
}
[13:54:14.132] Task URL: https://ci.chromium.org/b/8905777189386062336
[13:54:14.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:2:0) after 1m0s
[13:54:18.069] Received PubSub notification, asking Buildbucket for the build status
[13:54:18.411] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:14.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:2:0)
[13:55:14.187] Timer tick, asking Buildbucket for the build status
[13:55:14.358] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:14.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:4:0) after 1m0s
[13:56:14.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:4:0)
[13:56:14.337] Timer tick, asking Buildbucket for the build status
[13:56:14.736] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:14.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:5:0) after 1m0s
[13:57:14.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:5:0)
[13:57:14.758] Timer tick, asking Buildbucket for the build status
[13:57:14.971] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:14.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:6:0) after 1m0s
[13:58:15.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:6:0)
[13:58:15.033] Timer tick, asking Buildbucket for the build status
[13:58:15.226] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:15.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:7:0) after 1m0s
[13:59:15.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:7:0)
[13:59:15.389] Timer tick, asking Buildbucket for the build status
[13:59:15.635] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:8:0) after 1m0s
[14:00:15.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:8:0)
[14:00:15.643] Timer tick, asking Buildbucket for the build status
[14:00:16.987] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:16.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:9:0) after 1m0s
[14:01:17.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:9:0)
[14:01:17.070] Timer tick, asking Buildbucket for the build status
[14:01:17.263] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:17.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:10:0) after 1m0s
[14:02:17.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:10:0)
[14:02:17.367] Timer tick, asking Buildbucket for the build status
[14:02:17.569] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:11:0) after 1m0s
[14:03:17.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:11:0)
[14:03:17.602] Timer tick, asking Buildbucket for the build status
[14:03:17.754] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:17.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:12:0) after 1m0s
[14:04:17.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:12:0)
[14:04:17.961] Timer tick, asking Buildbucket for the build status
[14:04:18.629] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:18.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:13:0) after 1m0s
[14:05:18.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:13:0)
[14:05:18.816] Timer tick, asking Buildbucket for the build status
[14:05:19.301] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:19.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:14:0) after 1m0s
[14:06:20.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:14:0)
[14:06:20.651] Timer tick, asking Buildbucket for the build status
[14:06:21.223] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:21.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:15:0) after 1m0s
[14:07:21.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:15:0)
[14:07:21.662] Timer tick, asking Buildbucket for the build status
[14:07:22.086] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:22.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:16:0) after 1m0s
[14:08:22.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:16:0)
[14:08:22.500] Timer tick, asking Buildbucket for the build status
[14:08:24.702] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:24.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:17:0) after 1m0s
[14:09:24.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:17:0)
[14:09:24.722] Timer tick, asking Buildbucket for the build status
[14:09:25.610] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:25.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:18:0) after 1m0s
[14:10:25.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:18:0)
[14:10:25.634] Timer tick, asking Buildbucket for the build status
[14:10:26.027] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:26.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:19:0) after 1m0s
[14:11:26.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:19:0)
[14:11:26.113] Timer tick, asking Buildbucket for the build status
[14:11:26.352] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:26.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:20:0) after 1m0s
[14:12:26.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:20:0)
[14:12:26.547] Timer tick, asking Buildbucket for the build status
[14:12:26.690] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:21:0) after 1m0s
[14:13:26.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:21:0)
[14:13:26.771] Timer tick, asking Buildbucket for the build status
[14:13:26.949] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:26.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:22:0) after 1m0s
[14:14:27.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:22:0)
[14:14:27.224] Timer tick, asking Buildbucket for the build status
[14:14:27.501] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:27.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:23:0) after 1m0s
[14:15:27.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:23:0)
[14:15:27.521] Timer tick, asking Buildbucket for the build status
[14:15:27.915] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:27.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:24:0) after 1m0s
[14:16:27.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:24:0)
[14:16:27.992] Timer tick, asking Buildbucket for the build status
[14:16:29.136] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:25:0) after 1m0s
[14:17:30.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:25:0)
[14:17:30.165] Timer tick, asking Buildbucket for the build status
[14:17:33.326] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:33.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:26:0) after 1m0s
[14:18:33.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:26:0)
[14:18:33.650] Timer tick, asking Buildbucket for the build status
[14:18:33.949] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:33.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:27:0) after 1m0s
[14:19:33.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:27:0)
[14:19:33.986] Timer tick, asking Buildbucket for the build status
[14:19:36.211] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:36.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:28:0) after 1m0s
[14:20:36.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:28:0)
[14:20:36.273] Timer tick, asking Buildbucket for the build status
[14:20:36.517] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:36.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:29:0) after 1m0s
[14:21:36.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:29:0)
[14:21:36.548] Timer tick, asking Buildbucket for the build status
[14:21:36.927] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:30:0) after 1m0s
[14:22:36.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:30:0)
[14:22:36.936] Timer tick, asking Buildbucket for the build status
[14:22:38.453] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:38.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:31:0) after 1m0s
[14:23:38.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:31:0)
[14:23:38.472] Timer tick, asking Buildbucket for the build status
[14:23:42.074] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:42.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:32:0) after 1m0s
[14:24:42.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:32:0)
[14:24:42.108] Timer tick, asking Buildbucket for the build status
[14:24:42.303] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:42.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:33:0) after 1m0s
[14:25:42.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:33:0)
[14:25:42.354] Timer tick, asking Buildbucket for the build status
[14:25:42.744] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:42.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:34:0) after 1m0s
[14:26:42.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:34:0)
[14:26:42.768] Timer tick, asking Buildbucket for the build status
[14:26:42.915] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:42.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:35:0) after 1m0s
[14:27:43.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:35:0)
[14:27:43.004] Timer tick, asking Buildbucket for the build status
[14:27:43.212] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:43.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:36:0) after 1m0s
[14:28:43.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:36:0)
[14:28:43.242] Timer tick, asking Buildbucket for the build status
[14:28:44.754] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:37:0) after 1m0s
[14:29:44.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:37:0)
[14:29:44.777] Timer tick, asking Buildbucket for the build status
[14:29:45.084] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:45.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:38:0) after 1m0s
[14:30:45.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:38:0)
[14:30:45.125] Timer tick, asking Buildbucket for the build status
[14:30:48.238] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:39:0) after 1m0s
[14:31:48.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:39:0)
[14:31:48.415] Timer tick, asking Buildbucket for the build status
[14:31:48.831] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:48.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:40:0) after 1m0s
[14:32:48.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:40:0)
[14:32:48.864] Timer tick, asking Buildbucket for the build status
[14:32:49.147] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:49.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:41:0) after 1m0s
[14:33:49.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:41:0)
[14:33:49.219] Timer tick, asking Buildbucket for the build status
[14:33:51.102] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:51.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:42:0) after 1m0s
[14:34:51.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:42:0)
[14:34:51.146] Timer tick, asking Buildbucket for the build status
[14:34:55.627] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:55.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:43:0) after 1m0s
[14:35:55.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:43:0)
[14:35:55.738] Timer tick, asking Buildbucket for the build status
[14:35:55.972] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:55.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:44:0) after 1m0s
[14:36:56.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:44:0)
[14:36:56.322] Timer tick, asking Buildbucket for the build status
[14:36:57.711] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:57.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:45:0) after 1m0s
[14:37:57.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:45:0)
[14:37:57.929] Timer tick, asking Buildbucket for the build status
[14:37:58.264] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:58.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:46:0) after 1m0s
[14:38:58.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:46:0)
[14:38:58.445] Timer tick, asking Buildbucket for the build status
[14:38:58.675] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:58.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:47:0) after 1m0s
[14:39:58.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:47:0)
[14:39:58.850] Timer tick, asking Buildbucket for the build status
[14:40:01.349] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:01.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:48:0) after 1m0s
[14:41:01.395] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:48:0)
[14:41:01.395] Timer tick, asking Buildbucket for the build status
[14:41:02.018] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:02.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:49:0) after 1m0s
[14:42:02.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:49:0)
[14:42:02.105] Timer tick, asking Buildbucket for the build status
[14:42:02.327] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:02.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:50:0) after 1m0s
[14:43:02.391] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:50:0)
[14:43:02.391] Timer tick, asking Buildbucket for the build status
[14:43:02.782] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:02.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:51:0) after 1m0s
[14:44:02.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:51:0)
[14:44:02.849] Timer tick, asking Buildbucket for the build status
[14:44:03.123] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:03.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:52:0) after 1m0s
[14:45:03.171] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:52:0)
[14:45:03.171] Timer tick, asking Buildbucket for the build status
[14:45:06.183] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:06.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:53:0) after 1m0s
[14:46:06.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:53:0)
[14:46:06.385] Timer tick, asking Buildbucket for the build status
[14:46:07.053] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:07.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:54:0) after 1m0s
[14:47:07.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:54:0)
[14:47:07.234] Timer tick, asking Buildbucket for the build status
[14:47:11.775] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:11.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:55:0) after 1m0s
[14:48:11.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:55:0)
[14:48:11.776] Timer tick, asking Buildbucket for the build status
[14:48:13.905] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:13.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:56:0) after 1m0s
[14:49:13.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:56:0)
[14:49:13.965] Timer tick, asking Buildbucket for the build status
[14:49:14.823] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:57:0) after 1m0s
[14:50:14.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:57:0)
[14:50:14.916] Timer tick, asking Buildbucket for the build status
[14:50:15.405] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:15.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:58:0) after 1m0s
[14:51:15.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:58:0)
[14:51:15.547] Timer tick, asking Buildbucket for the build status
[14:51:16.332] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:16.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:59:0) after 1m0s
[14:52:16.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:59:0)
[14:52:16.411] Timer tick, asking Buildbucket for the build status
[14:52:16.704] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:16.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:60:0) after 1m0s
[14:53:16.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:60:0)
[14:53:16.793] Timer tick, asking Buildbucket for the build status
[14:53:17.859] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:17.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:61:0) after 1m0s
[14:54:17.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:61:0)
[14:54:17.920] Timer tick, asking Buildbucket for the build status
[14:54:18.133] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:18.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:62:0) after 1m0s
[14:55:18.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:62:0)
[14:55:18.265] Timer tick, asking Buildbucket for the build status
[14:55:18.526] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:18.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:63:0) after 1m0s
[14:56:18.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:63:0)
[14:56:18.605] Timer tick, asking Buildbucket for the build status
[14:56:18.946] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:18.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:64:0) after 1m0s
[14:57:18.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:64:0)
[14:57:18.978] Timer tick, asking Buildbucket for the build status
[14:57:19.189] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:19.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:65:0) after 1m0s
[14:58:19.210] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:65:0)
[14:58:19.210] Timer tick, asking Buildbucket for the build status
[14:58:19.481] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:19.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:66:0) after 1m0s
[14:59:19.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:66:0)
[14:59:19.505] Timer tick, asking Buildbucket for the build status
[14:59:20.425] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:67:0) after 1m0s
[15:00:20.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:67:0)
[15:00:20.518] Timer tick, asking Buildbucket for the build status
[15:00:21.325] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:21.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:68:0) after 1m0s
[15:01:21.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:68:0)
[15:01:21.574] Timer tick, asking Buildbucket for the build status
[15:01:21.916] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:21.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:69:0) after 1m0s
[15:02:21.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:69:0)
[15:02:21.936] Timer tick, asking Buildbucket for the build status
[15:02:23.162] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:23.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:70:0) after 1m0s
[15:03:23.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:70:0)
[15:03:23.212] Timer tick, asking Buildbucket for the build status
[15:03:25.984] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:25.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:71:0) after 1m0s
[15:04:25.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:71:0)
[15:04:25.980] Timer tick, asking Buildbucket for the build status
[15:04:26.127] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:26.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:72:0) after 1m0s
[15:05:26.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:72:0)
[15:05:26.166] Timer tick, asking Buildbucket for the build status
[15:05:26.497] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:26.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:73:0) after 1m0s
[15:06:26.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:73:0)
[15:06:26.521] Timer tick, asking Buildbucket for the build status
[15:06:26.705] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:26.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:74:0) after 1m0s
[15:07:26.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:74:0)
[15:07:26.791] Timer tick, asking Buildbucket for the build status
[15:07:27.033] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:27.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:75:0) after 1m0s
[15:08:27.095] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:75:0)
[15:08:27.095] Timer tick, asking Buildbucket for the build status
[15:08:27.616] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:27.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:76:0) after 1m0s
[15:09:27.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:76:0)
[15:09:27.656] Timer tick, asking Buildbucket for the build status
[15:09:27.857] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:27.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:77:0) after 1m0s
[15:10:27.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:77:0)
[15:10:27.969] Timer tick, asking Buildbucket for the build status
[15:10:28.826] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:28.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:78:0) after 1m0s
[15:11:28.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:78:0)
[15:11:28.883] Timer tick, asking Buildbucket for the build status
[15:11:30.048] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:30.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:79:0) after 1m0s
[15:12:30.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:79:0)
[15:12:30.082] Timer tick, asking Buildbucket for the build status
[15:12:31.399] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:31.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:80:0) after 1m0s
[15:13:31.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:80:0)
[15:13:31.534] Timer tick, asking Buildbucket for the build status
[15:13:33.862] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:33.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:81:0) after 1m0s
[15:14:34.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:81:0)
[15:14:34.041] Timer tick, asking Buildbucket for the build status
[15:14:34.453] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:34.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:82:0) after 1m0s
[15:15:34.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:82:0)
[15:15:34.537] Timer tick, asking Buildbucket for the build status
[15:15:35.104] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:35.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:83:0) after 1m0s
[15:16:35.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:83:0)
[15:16:35.232] Timer tick, asking Buildbucket for the build status
[15:16:35.779] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:35.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:84:0) after 1m0s
[15:17:35.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:84:0)
[15:17:35.809] Timer tick, asking Buildbucket for the build status
[15:17:36.607] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:36.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:85:0) after 1m0s
[15:18:36.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:85:0)
[15:18:36.693] Timer tick, asking Buildbucket for the build status
[15:18:37.026] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:86:0) after 1m0s
[15:19:37.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:86:0)
[15:19:37.162] Timer tick, asking Buildbucket for the build status
[15:19:37.739] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:87:0) after 1m0s
[15:20:37.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:87:0)
[15:20:37.790] Timer tick, asking Buildbucket for the build status
[15:20:38.016] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:38.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:88:0) after 1m0s
[15:21:38.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:88:0)
[15:21:38.038] Timer tick, asking Buildbucket for the build status
[15:21:38.625] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:38.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:89:0) after 1m0s
[15:22:38.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:89:0)
[15:22:38.687] Timer tick, asking Buildbucket for the build status
[15:22:39.270] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:90:0) after 1m0s
[15:23:39.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:90:0)
[15:23:39.356] Timer tick, asking Buildbucket for the build status
[15:23:41.279] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:41.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:91:0) after 1m0s
[15:24:41.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:91:0)
[15:24:41.315] Timer tick, asking Buildbucket for the build status
[15:24:42.697] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:42.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:92:0) after 1m0s
[15:25:42.794] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:92:0)
[15:25:42.794] Timer tick, asking Buildbucket for the build status
[15:25:43.045] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:43.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:93:0) after 1m0s
[15:26:43.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:93:0)
[15:26:43.079] Timer tick, asking Buildbucket for the build status
[15:26:43.339] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:43.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:94:0) after 1m0s
[15:27:43.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:94:0)
[15:27:43.420] Timer tick, asking Buildbucket for the build status
[15:27:46.783] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:46.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:95:0) after 1m0s
[15:28:46.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:95:0)
[15:28:46.800] Timer tick, asking Buildbucket for the build status
[15:28:47.142] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:47.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:96:0) after 1m0s
[15:29:47.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:96:0)
[15:29:47.218] Timer tick, asking Buildbucket for the build status
[15:29:47.505] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:47.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:97:0) after 1m0s
[15:30:47.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:97:0)
[15:30:47.675] Timer tick, asking Buildbucket for the build status
[15:30:48.650] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:98:0) after 1m0s
[15:31:48.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:98:0)
[15:31:48.732] Timer tick, asking Buildbucket for the build status
[15:31:50.424] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:50.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:99:0) after 1m0s
[15:32:50.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:99:0)
[15:32:50.455] Timer tick, asking Buildbucket for the build status
[15:32:50.890] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:50.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:100:0) after 1m0s
[15:33:50.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:100:0)
[15:33:50.944] Timer tick, asking Buildbucket for the build status
[15:33:51.912] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:101:0) after 1m0s
[15:34:51.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:101:0)
[15:34:51.967] Timer tick, asking Buildbucket for the build status
[15:34:52.465] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:52.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:102:0) after 1m0s
[15:35:52.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:102:0)
[15:35:52.507] Timer tick, asking Buildbucket for the build status
[15:35:52.816] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:52.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:103:0) after 1m0s
[15:36:52.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:103:0)
[15:36:52.897] Timer tick, asking Buildbucket for the build status
[15:36:54.878] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:54.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:104:0) after 1m0s
[15:37:54.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:104:0)
[15:37:54.969] Timer tick, asking Buildbucket for the build status
[15:37:55.260] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:55.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:105:0) after 1m0s
[15:38:55.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:105:0)
[15:38:55.313] Timer tick, asking Buildbucket for the build status
[15:38:55.581] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:55.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:106:0) after 1m0s
[15:39:55.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:106:0)
[15:39:55.613] Timer tick, asking Buildbucket for the build status
[15:39:57.277] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:57.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:107:0) after 1m0s
[15:40:57.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:107:0)
[15:40:57.298] Timer tick, asking Buildbucket for the build status
[15:40:59.439] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:59.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:108:0) after 1m0s
[15:41:59.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:108:0)
[15:41:59.463] Timer tick, asking Buildbucket for the build status
[15:41:59.707] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:109:0) after 1m0s
[15:42:59.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:109:0)
[15:42:59.770] Timer tick, asking Buildbucket for the build status
[15:43:02.000] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:02.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:110:0) after 1m0s
[15:44:02.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:110:0)
[15:44:02.024] Timer tick, asking Buildbucket for the build status
[15:44:04.069] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:04.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:111:0) after 1m0s
[15:45:04.207] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:111:0)
[15:45:04.207] Timer tick, asking Buildbucket for the build status
[15:45:04.392] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:04.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:112:0) after 1m0s
[15:46:04.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:112:0)
[15:46:04.387] Timer tick, asking Buildbucket for the build status
[15:46:04.656] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:04.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:113:0) after 1m0s
[15:47:04.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:113:0)
[15:47:04.699] Timer tick, asking Buildbucket for the build status
[15:47:05.655] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:05.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:114:0) after 1m0s
[15:48:05.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:114:0)
[15:48:05.729] Timer tick, asking Buildbucket for the build status
[15:48:06.242] Build 8905777189386062336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071207253044179296:115:0) after 1m0s
[15:48:55.228] Received PubSub notification, asking Buildbucket for the build status
[15:48:58.540] Build 8905777189386062336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:48:58.540] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565192933253372",
"created_by": "project:chromium",
"created_ts": "1565186049053949",
"id": "8905777189386062336",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"310fa8b7093a9438c97dcf778aa6a8485d23b1b6\"}}",
"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9022, \"got_angle_revision\": \"415bb0cdb057f60f684b3c01731a4f0e93e3630d\", \"got_dawn_revision\": \"6de5baa17b8acb7100094548a57c541d182fb78b\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"310fa8b7093a9438c97dcf778aa6a8485d23b1b6\", \"got_revision_cp\": \"refs/heads/master@{#684736}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"c760764140d5b95cf53a6b39e4c151c7578e3a59\", \"got_v8_revision_cp\": \"refs/heads/7.8.66@{#1}\", \"got_webrtc_revision\": \"d23f67e6beb55b030cdb564b5980f8b8b1f7883f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28786}\", \"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.git\", \"revision\": \"310fa8b7093a9438c97dcf778aa6a8485d23b1b6\", \"swarm_hashes\": {\"0\": \"48cd935f97f7bfcc096cc72b0cc385eddfbd5a3c\", \"1\": \"2ec0ed1f85153944ed3efb58b4c8836da57651ff\", \"10\": \"a70a104cd90b4a963b4ddea77fbe583b274102ab\", \"11\": \"5ced82a64774a08dc7ad1b102e9ec2c06fd70c43\", \"12\": \"2423ce552dbca48ce515e83edaea1e953555c028\", \"13\": \"8f88827919f7080865bb7a69a1286c17478dc1c9\", \"14\": \"deac8b26647df0d6f15ee23c179bd30142f2897c\", \"15\": \"eb672cd440c39299630e768d47c8cc5852cf16b8\", \"16\": \"bfbbaa6551c8334c30ad04ea5e790ad0cddeb640\", \"2\": \"38be4fb6923583139d2f7bcbc3b5ca868847bc0c\", \"3\": \"59b3ef6da16148b8121a7a5a6220992a38cb29cd\", \"4\": \"ddabcf56f901e6859c2cd3bf32a6ea0d045af3a5\", \"5\": \"a44e0c74cf4c7835fcaa715d7d89e3a39935e229\", \"6\": \"206fb51a449103888940d36caf7f3f53eb30d97a\", \"7\": \"1cfbf8a28fcd5208ee9d6747b555404b668fd1b5\", \"8\": \"68c20182c0ee7ad382a8a6289dc944dc81a0bca5\", \"9\": \"b8006a76c8928c90266104149b7b5afb740e138c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"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\": [\"build281-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4382-5929880\"], \"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": "1565186055318599",
"status": "COMPLETED",
"status_changed_ts": "1565192934261233",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9022",
"builder:ToTiOS",
"buildset:commit/git/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/310fa8b7093a9438c97dcf778aa6a8485d23b1b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071207253044179296",
"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/8905777189386062336/+/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:46852d61c2a0cc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1565192934427345",
"url": "https://ci.chromium.org/b/8905777189386062336",
"utcnow_ts": "1565192938473381"
}
}
[15:48:58.540] Invocation finished in 1h54m52.359303324s with status SUCCEEDED