[17:28:48.882] New invocation is queued and will start shortly
[17:28:50.335] Starting the invocation (attempt 1)
[17:28:50.406] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:28:50.406] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:28:50.406] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069472402221804512",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"93cbcb5e44ae6d21071a3e0995337ecb22117f63\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9069472402221804512",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"gitiles_ref:refs/heads/master"
]
}
[17:28:52.420] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1566840531233782",
"id": "8904042339080494000",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"93cbcb5e44ae6d21071a3e0995337ecb22117f63\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566840531768297",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9619",
"builder:ToTiOS",
"buildset:commit/git/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069472402221804512",
"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/8904042339080494000/+/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": "1566840531768414",
"url": "https://ci.chromium.org/b/8904042339080494000",
"utcnow_ts": "1566840532389259"
}
}
[17:28:52.420] Task URL: https://ci.chromium.org/b/8904042339080494000
[17:28:52.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:2:0) after 1m0s
[17:29:52.484] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:2:0)
[17:29:52.484] Timer tick, asking Buildbucket for the build status
[17:29:52.874] Build 8904042339080494000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:52.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:3:0) after 1m0s
[17:30:53.005] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:3:0)
[17:30:53.005] Timer tick, asking Buildbucket for the build status
[17:30:54.363] Build 8904042339080494000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:4:0) after 1m0s
[17:31:42.670] Received PubSub notification, asking Buildbucket for the build status
[17:31:43.111] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:54.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:4:0)
[17:31:54.738] Timer tick, asking Buildbucket for the build status
[17:31:54.959] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:54.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:6:0) after 1m0s
[17:32:55.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:6:0)
[17:32:55.015] Timer tick, asking Buildbucket for the build status
[17:32:55.374] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:55.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:7:0) after 1m0s
[17:33:55.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:7:0)
[17:33:55.770] Timer tick, asking Buildbucket for the build status
[17:33:56.014] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:56.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:8:0) after 1m0s
[17:34:56.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:8:0)
[17:34:56.198] Timer tick, asking Buildbucket for the build status
[17:34:58.174] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:58.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:9:0) after 1m0s
[17:35:58.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:9:0)
[17:35:58.670] Timer tick, asking Buildbucket for the build status
[17:36:01.063] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:01.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:10:0) after 1m0s
[17:37:01.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:10:0)
[17:37:01.465] Timer tick, asking Buildbucket for the build status
[17:37:01.994] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:01.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:11:0) after 1m0s
[17:38:02.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:11:0)
[17:38:02.078] Timer tick, asking Buildbucket for the build status
[17:38:05.447] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:12:0) after 1m0s
[17:39:05.522] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:12:0)
[17:39:05.522] Timer tick, asking Buildbucket for the build status
[17:39:06.822] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:06.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:13:0) after 1m0s
[17:40:06.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:13:0)
[17:40:06.912] Timer tick, asking Buildbucket for the build status
[17:40:07.283] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:14:0) after 1m0s
[17:41:07.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:14:0)
[17:41:07.318] Timer tick, asking Buildbucket for the build status
[17:41:07.707] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:07.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:15:0) after 1m0s
[17:42:07.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:15:0)
[17:42:07.802] Timer tick, asking Buildbucket for the build status
[17:42:09.496] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:09.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:16:0) after 1m0s
[17:43:09.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:16:0)
[17:43:09.554] Timer tick, asking Buildbucket for the build status
[17:43:10.327] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:10.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:17:0) after 1m0s
[17:44:10.366] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:17:0)
[17:44:10.366] Timer tick, asking Buildbucket for the build status
[17:44:11.073] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:11.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:18:0) after 1m0s
[17:45:11.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:18:0)
[17:45:11.087] Timer tick, asking Buildbucket for the build status
[17:45:13.615] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:13.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:19:0) after 1m0s
[17:46:13.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:19:0)
[17:46:13.834] Timer tick, asking Buildbucket for the build status
[17:46:14.477] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:14.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:20:0) after 1m0s
[17:47:14.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:20:0)
[17:47:14.552] Timer tick, asking Buildbucket for the build status
[17:47:15.005] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:15.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:21:0) after 1m0s
[17:48:15.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:21:0)
[17:48:15.012] Timer tick, asking Buildbucket for the build status
[17:48:16.505] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:16.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:22:0) after 1m0s
[17:49:16.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:22:0)
[17:49:16.584] Timer tick, asking Buildbucket for the build status
[17:49:18.045] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:23:0) after 1m0s
[17:50:18.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:23:0)
[17:50:18.296] Timer tick, asking Buildbucket for the build status
[17:50:21.508] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:21.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:24:0) after 1m0s
[17:51:21.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:24:0)
[17:51:21.519] Timer tick, asking Buildbucket for the build status
[17:51:24.827] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:24.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:25:0) after 1m0s
[17:52:25.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:25:0)
[17:52:25.091] Timer tick, asking Buildbucket for the build status
[17:52:25.817] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:26:0) after 1m0s
[17:53:25.989] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:26:0)
[17:53:25.989] Timer tick, asking Buildbucket for the build status
[17:53:26.338] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:26.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:27:0) after 1m0s
[17:54:26.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:27:0)
[17:54:26.398] Timer tick, asking Buildbucket for the build status
[17:54:27.032] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:27.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:28:0) after 1m0s
[17:55:27.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:28:0)
[17:55:27.216] Timer tick, asking Buildbucket for the build status
[17:55:27.481] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:27.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:29:0) after 1m0s
[17:56:27.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:29:0)
[17:56:27.582] Timer tick, asking Buildbucket for the build status
[17:56:27.873] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:30:0) after 1m0s
[17:57:27.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:30:0)
[17:57:27.930] Timer tick, asking Buildbucket for the build status
[17:57:28.172] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:28.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:31:0) after 1m0s
[17:58:28.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:31:0)
[17:58:28.258] Timer tick, asking Buildbucket for the build status
[17:58:28.470] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:28.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:32:0) after 1m0s
[17:59:28.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:32:0)
[17:59:28.544] Timer tick, asking Buildbucket for the build status
[17:59:28.791] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:28.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:33:0) after 1m0s
[18:00:28.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:33:0)
[18:00:28.940] Timer tick, asking Buildbucket for the build status
[18:00:29.136] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:29.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:34:0) after 1m0s
[18:01:29.210] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:34:0)
[18:01:29.210] Timer tick, asking Buildbucket for the build status
[18:01:32.409] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:32.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:35:0) after 1m0s
[18:02:32.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:35:0)
[18:02:32.485] Timer tick, asking Buildbucket for the build status
[18:02:32.926] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:32.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:36:0) after 1m0s
[18:03:33.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:36:0)
[18:03:33.037] Timer tick, asking Buildbucket for the build status
[18:03:33.281] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:33.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:37:0) after 1m0s
[18:04:33.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:37:0)
[18:04:33.438] Timer tick, asking Buildbucket for the build status
[18:04:33.652] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:33.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:38:0) after 1m0s
[18:05:33.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:38:0)
[18:05:33.776] Timer tick, asking Buildbucket for the build status
[18:05:35.714] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:35.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:39:0) after 1m0s
[18:06:35.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:39:0)
[18:06:35.758] Timer tick, asking Buildbucket for the build status
[18:06:36.071] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:36.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:40:0) after 1m0s
[18:07:36.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:40:0)
[18:07:36.118] Timer tick, asking Buildbucket for the build status
[18:07:36.674] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:36.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:41:0) after 1m0s
[18:08:36.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:41:0)
[18:08:36.825] Timer tick, asking Buildbucket for the build status
[18:08:38.521] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:38.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:42:0) after 1m0s
[18:09:38.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:42:0)
[18:09:38.576] Timer tick, asking Buildbucket for the build status
[18:09:39.650] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:39.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:43:0) after 1m0s
[18:10:39.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:43:0)
[18:10:39.743] Timer tick, asking Buildbucket for the build status
[18:10:40.253] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:40.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:44:0) after 1m0s
[18:11:40.410] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:44:0)
[18:11:40.410] Timer tick, asking Buildbucket for the build status
[18:11:41.329] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:41.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:45:0) after 1m0s
[18:12:41.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:45:0)
[18:12:41.343] Timer tick, asking Buildbucket for the build status
[18:12:42.091] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:42.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:46:0) after 1m0s
[18:13:42.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:46:0)
[18:13:42.182] Timer tick, asking Buildbucket for the build status
[18:13:42.395] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:42.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:47:0) after 1m0s
[18:14:42.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:47:0)
[18:14:42.574] Timer tick, asking Buildbucket for the build status
[18:14:42.734] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:42.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:48:0) after 1m0s
[18:15:42.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:48:0)
[18:15:42.835] Timer tick, asking Buildbucket for the build status
[18:15:44.130] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:44.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:49:0) after 1m0s
[18:16:44.207] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:49:0)
[18:16:44.207] Timer tick, asking Buildbucket for the build status
[18:16:44.394] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:44.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:50:0) after 1m0s
[18:17:44.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:50:0)
[18:17:44.517] Timer tick, asking Buildbucket for the build status
[18:17:45.129] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:45.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:51:0) after 1m0s
[18:18:45.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:51:0)
[18:18:45.173] Timer tick, asking Buildbucket for the build status
[18:18:45.523] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:45.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:52:0) after 1m0s
[18:19:45.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:52:0)
[18:19:45.626] Timer tick, asking Buildbucket for the build status
[18:19:46.143] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:46.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:53:0) after 1m0s
[18:20:46.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:53:0)
[18:20:46.209] Timer tick, asking Buildbucket for the build status
[18:20:46.746] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:46.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:54:0) after 1m0s
[18:21:46.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:54:0)
[18:21:46.781] Timer tick, asking Buildbucket for the build status
[18:21:47.508] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:47.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:55:0) after 1m0s
[18:22:47.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:55:0)
[18:22:47.601] Timer tick, asking Buildbucket for the build status
[18:22:47.791] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:47.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:56:0) after 1m0s
[18:23:47.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:56:0)
[18:23:47.885] Timer tick, asking Buildbucket for the build status
[18:23:49.098] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:49.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:57:0) after 1m0s
[18:24:49.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:57:0)
[18:24:49.157] Timer tick, asking Buildbucket for the build status
[18:24:49.527] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:49.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:58:0) after 1m0s
[18:25:49.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:58:0)
[18:25:49.572] Timer tick, asking Buildbucket for the build status
[18:25:49.866] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:49.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:59:0) after 1m0s
[18:26:49.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:59:0)
[18:26:49.895] Timer tick, asking Buildbucket for the build status
[18:26:50.335] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:50.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:60:0) after 1m0s
[18:27:50.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:60:0)
[18:27:50.402] Timer tick, asking Buildbucket for the build status
[18:27:50.933] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:50.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:61:0) after 1m0s
[18:28:51.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:61:0)
[18:28:51.023] Timer tick, asking Buildbucket for the build status
[18:28:51.274] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:51.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:62:0) after 1m0s
[18:29:51.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:62:0)
[18:29:51.341] Timer tick, asking Buildbucket for the build status
[18:29:51.577] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:51.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:63:0) after 1m0s
[18:30:51.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:63:0)
[18:30:51.655] Timer tick, asking Buildbucket for the build status
[18:30:51.990] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:51.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:64:0) after 1m0s
[18:31:51.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:64:0)
[18:31:51.992] Timer tick, asking Buildbucket for the build status
[18:31:52.207] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:52.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:65:0) after 1m0s
[18:32:52.400] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:65:0)
[18:32:52.400] Timer tick, asking Buildbucket for the build status
[18:32:52.600] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:52.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:66:0) after 1m0s
[18:33:52.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:66:0)
[18:33:52.701] Timer tick, asking Buildbucket for the build status
[18:33:53.120] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:53.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:67:0) after 1m0s
[18:34:53.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:67:0)
[18:34:53.349] Timer tick, asking Buildbucket for the build status
[18:34:53.531] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:53.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:68:0) after 1m0s
[18:35:53.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:68:0)
[18:35:53.608] Timer tick, asking Buildbucket for the build status
[18:35:54.840] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:54.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:69:0) after 1m0s
[18:36:54.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:69:0)
[18:36:54.906] Timer tick, asking Buildbucket for the build status
[18:36:55.244] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:55.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:70:0) after 1m0s
[18:37:55.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:70:0)
[18:37:55.418] Timer tick, asking Buildbucket for the build status
[18:37:56.123] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:56.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:71:0) after 1m0s
[18:38:56.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:71:0)
[18:38:56.668] Timer tick, asking Buildbucket for the build status
[18:38:56.897] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:72:0) after 1m0s
[18:39:57.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:72:0)
[18:39:57.027] Timer tick, asking Buildbucket for the build status
[18:39:57.374] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:57.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:73:0) after 1m0s
[18:40:57.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:73:0)
[18:40:57.803] Timer tick, asking Buildbucket for the build status
[18:40:58.426] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:58.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:74:0) after 1m0s
[18:41:58.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:74:0)
[18:41:58.576] Timer tick, asking Buildbucket for the build status
[18:41:59.055] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:59.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:75:0) after 1m0s
[18:42:59.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:75:0)
[18:42:59.137] Timer tick, asking Buildbucket for the build status
[18:42:59.731] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:59.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:76:0) after 1m0s
[18:43:59.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:76:0)
[18:43:59.834] Timer tick, asking Buildbucket for the build status
[18:44:00.189] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:00.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:77:0) after 1m0s
[18:45:00.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:77:0)
[18:45:00.519] Timer tick, asking Buildbucket for the build status
[18:45:00.799] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:00.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:78:0) after 1m0s
[18:46:00.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:78:0)
[18:46:00.828] Timer tick, asking Buildbucket for the build status
[18:46:02.260] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:02.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:79:0) after 1m0s
[18:47:02.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:79:0)
[18:47:02.385] Timer tick, asking Buildbucket for the build status
[18:47:02.737] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:02.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:80:0) after 1m0s
[18:48:02.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:80:0)
[18:48:02.934] Timer tick, asking Buildbucket for the build status
[18:48:03.372] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:81:0) after 1m0s
[18:49:03.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:81:0)
[18:49:03.590] Timer tick, asking Buildbucket for the build status
[18:49:03.890] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:03.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:82:0) after 1m0s
[18:50:04.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:82:0)
[18:50:04.007] Timer tick, asking Buildbucket for the build status
[18:50:04.719] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:83:0) after 1m0s
[18:51:04.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:83:0)
[18:51:04.920] Timer tick, asking Buildbucket for the build status
[18:51:05.128] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:05.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:84:0) after 1m0s
[18:52:05.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:84:0)
[18:52:05.365] Timer tick, asking Buildbucket for the build status
[18:52:06.144] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:06.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:85:0) after 1m0s
[18:53:06.326] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:85:0)
[18:53:06.326] Timer tick, asking Buildbucket for the build status
[18:53:06.508] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:06.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:86:0) after 1m0s
[18:54:06.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:86:0)
[18:54:06.532] Timer tick, asking Buildbucket for the build status
[18:54:08.582] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:87:0) after 1m0s
[18:55:08.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:87:0)
[18:55:08.700] Timer tick, asking Buildbucket for the build status
[18:55:09.912] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:09.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:88:0) after 1m0s
[18:56:09.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:88:0)
[18:56:09.938] Timer tick, asking Buildbucket for the build status
[18:56:10.443] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:10.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:89:0) after 1m0s
[18:57:10.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:89:0)
[18:57:10.570] Timer tick, asking Buildbucket for the build status
[18:57:11.379] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:11.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:90:0) after 1m0s
[18:58:11.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:90:0)
[18:58:11.422] Timer tick, asking Buildbucket for the build status
[18:58:12.722] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:12.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:91:0) after 1m0s
[18:59:12.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:91:0)
[18:59:12.828] Timer tick, asking Buildbucket for the build status
[18:59:14.087] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:14.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:92:0) after 1m0s
[19:00:14.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:92:0)
[19:00:14.257] Timer tick, asking Buildbucket for the build status
[19:00:14.721] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:14.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:93:0) after 1m0s
[19:01:14.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:93:0)
[19:01:14.757] Timer tick, asking Buildbucket for the build status
[19:01:14.934] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:14.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:94:0) after 1m0s
[19:02:15.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:94:0)
[19:02:15.034] Timer tick, asking Buildbucket for the build status
[19:02:15.429] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:15.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:95:0) after 1m0s
[19:03:15.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:95:0)
[19:03:15.489] Timer tick, asking Buildbucket for the build status
[19:03:15.692] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:96:0) after 1m0s
[19:04:15.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:96:0)
[19:04:15.726] Timer tick, asking Buildbucket for the build status
[19:04:17.292] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:17.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:97:0) after 1m0s
[19:05:17.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:97:0)
[19:05:17.541] Timer tick, asking Buildbucket for the build status
[19:05:17.812] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:17.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:98:0) after 1m0s
[19:06:17.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:98:0)
[19:06:17.925] Timer tick, asking Buildbucket for the build status
[19:06:18.223] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:18.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:99:0) after 1m0s
[19:07:18.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:99:0)
[19:07:18.388] Timer tick, asking Buildbucket for the build status
[19:07:19.257] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:19.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:100:0) after 1m0s
[19:08:19.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:100:0)
[19:08:19.292] Timer tick, asking Buildbucket for the build status
[19:08:19.887] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:19.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:101:0) after 1m0s
[19:09:19.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:101:0)
[19:09:19.944] Timer tick, asking Buildbucket for the build status
[19:09:20.643] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:102:0) after 1m0s
[19:10:20.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:102:0)
[19:10:20.680] Timer tick, asking Buildbucket for the build status
[19:10:20.892] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:103:0) after 1m0s
[19:11:20.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:103:0)
[19:11:20.936] Timer tick, asking Buildbucket for the build status
[19:11:21.139] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:104:0) after 1m0s
[19:12:21.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:104:0)
[19:12:21.300] Timer tick, asking Buildbucket for the build status
[19:12:21.525] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:21.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:105:0) after 1m0s
[19:13:21.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:105:0)
[19:13:21.528] Timer tick, asking Buildbucket for the build status
[19:13:21.940] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:21.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:106:0) after 1m0s
[19:14:22.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:106:0)
[19:14:22.021] Timer tick, asking Buildbucket for the build status
[19:14:22.485] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:22.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:107:0) after 1m0s
[19:15:22.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:107:0)
[19:15:22.533] Timer tick, asking Buildbucket for the build status
[19:15:22.983] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:22.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:108:0) after 1m0s
[19:16:23.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:108:0)
[19:16:23.138] Timer tick, asking Buildbucket for the build status
[19:16:23.401] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:23.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:109:0) after 1m0s
[19:17:23.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:109:0)
[19:17:23.455] Timer tick, asking Buildbucket for the build status
[19:17:24.194] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:24.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:110:0) after 1m0s
[19:18:24.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:110:0)
[19:18:24.273] Timer tick, asking Buildbucket for the build status
[19:18:24.622] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:24.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:111:0) after 1m0s
[19:19:24.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:111:0)
[19:19:24.701] Timer tick, asking Buildbucket for the build status
[19:19:25.408] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:25.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:112:0) after 1m0s
[19:20:25.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:112:0)
[19:20:25.535] Timer tick, asking Buildbucket for the build status
[19:20:25.771] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:25.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:113:0) after 1m0s
[19:21:25.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:113:0)
[19:21:25.863] Timer tick, asking Buildbucket for the build status
[19:21:28.475] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:28.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:114:0) after 1m0s
[19:22:28.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:114:0)
[19:22:28.696] Timer tick, asking Buildbucket for the build status
[19:22:29.257] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:29.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:115:0) after 1m0s
[19:23:29.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:115:0)
[19:23:29.372] Timer tick, asking Buildbucket for the build status
[19:23:29.593] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:29.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:116:0) after 1m0s
[19:24:29.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:116:0)
[19:24:29.613] Timer tick, asking Buildbucket for the build status
[19:24:30.365] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:30.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:117:0) after 1m0s
[19:25:30.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:117:0)
[19:25:30.421] Timer tick, asking Buildbucket for the build status
[19:25:30.654] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:30.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:118:0) after 1m0s
[19:26:30.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:118:0)
[19:26:30.663] Timer tick, asking Buildbucket for the build status
[19:26:30.856] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:30.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:119:0) after 1m0s
[19:27:30.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:119:0)
[19:27:30.890] Timer tick, asking Buildbucket for the build status
[19:27:31.304] Build 8904042339080494000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:31.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069472402221804512:120:0) after 1m0s
[19:27:42.712] Received PubSub notification, asking Buildbucket for the build status
[19:27:43.182] Build 8904042339080494000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:27:43.182] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1566847661900114",
"created_by": "project:chromium",
"created_ts": "1566840531233782",
"id": "8904042339080494000",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"93cbcb5e44ae6d21071a3e0995337ecb22117f63\"}}",
"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\": 9619, \"got_angle_revision\": \"f2f111d77fa813f9660489f6e1ad130b6e0010c0\", \"got_dawn_revision\": \"25cc723823e3aa9bf6d7edfcd308bb82ab05b0fc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"93cbcb5e44ae6d21071a3e0995337ecb22117f63\", \"got_revision_cp\": \"refs/heads/master@{#690396}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"678bea7ec1d9078566015914653c22d154df1773\", \"got_v8_revision_cp\": \"refs/heads/7.8.193@{#1}\", \"got_webrtc_revision\": \"4869bd6309bbe2e9e038451e9549f5a9d12e4a38\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28957}\", \"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\": \"93cbcb5e44ae6d21071a3e0995337ecb22117f63\", \"swarm_hashes\": {\"0\": \"89e8d06224346287f1c7e8543e1406287708ff87\", \"1\": \"9e67540efd1df64c1ebccd047f71648cfac74e7c\", \"10\": \"415c3ad232ae3e0ae9971811446d2635b149a408\", \"11\": \"627192c69d295997f23b61a606724cdd5d5429d4\", \"12\": \"68a5ac91a6ee556ce1a940c21117bf474a77c430\", \"13\": \"3dc0f2aedae132854f8c6bb0d7fed15c017feb29\", \"14\": \"65df674248148e825a2481f40e87ee89b165c419\", \"15\": \"634a5258949508cfa9010223933d1892f8772aff\", \"16\": \"355b3605f9df1f66c43cc478aab613f4e2221b56\", \"2\": \"e52587ec5e07dd5a5e92739275a1a5733cf74dce\", \"3\": \"b3873c674fa945dbb2d622636c4a9bd5f3d55450\", \"4\": \"4649bb95d51c352e8538106f3565de3a9477878b\", \"5\": \"aa31c3baf7ab294451d475d83794261fa5a7be64\", \"6\": \"214fa6228bfc882bf22d17bce680ac4b103afa7b\", \"7\": \"1f36eeddff0e56284c5ad75cfdba1f5edb3f9ac5\", \"8\": \"af6fd23eead2cce2914e1ad4643d0084cf1373a3\", \"9\": \"bce0f02643829421da0caca27b55e7beaaaede77\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\"], \"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\": [\"4397-8786906\"], \"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": "1566840701737020",
"status": "COMPLETED",
"status_changed_ts": "1566847662141308",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9619",
"builder:ToTiOS",
"buildset:commit/git/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93cbcb5e44ae6d21071a3e0995337ecb22117f63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069472402221804512",
"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/8904042339080494000/+/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:46e7cab890e96a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1566847662145240",
"url": "https://ci.chromium.org/b/8904042339080494000",
"utcnow_ts": "1566847663167305"
}
}
[19:27:43.182] Invocation finished in 1h58m54.329576262s with status SUCCEEDED