[08:50:48.081] New invocation is queued and will start shortly
[08:50:49.325] Starting the invocation (attempt 1)
[08:50:49.367] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:50:49.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:50:49.367] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9046855751195041168",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4048c8f48b3e4bdd01932235f34b2c0e54c85281\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9046855751195041168",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"gitiles_ref:refs/heads/master"
]
}
[08:50:50.438] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1588409449480241",
"id": "8881425689060072464",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4048c8f48b3e4bdd01932235f34b2c0e54c85281\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1588409450094186",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/13917",
"builder:ToTiOS",
"buildset:commit/git/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046855751195041168",
"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/8881425689060072464/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1588409450114216",
"url": "https://ci.chromium.org/b/8881425689060072464",
"utcnow_ts": "1588409450416612"
}
}
[08:50:50.438] Task URL: https://ci.chromium.org/b/8881425689060072464
[08:50:50.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:2:0) after 1m0s
[08:50:56.006] Received PubSub notification, asking Buildbucket for the build status
[08:50:56.122] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:50.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:2:0)
[08:51:50.461] Timer tick, asking Buildbucket for the build status
[08:51:50.602] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:50.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:4:0) after 1m0s
[08:52:50.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:4:0)
[08:52:50.616] Timer tick, asking Buildbucket for the build status
[08:52:50.745] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:50.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:5:0) after 1m0s
[08:53:50.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:5:0)
[08:53:50.845] Timer tick, asking Buildbucket for the build status
[08:53:51.049] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:51.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:6:0) after 1m0s
[08:54:51.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:6:0)
[08:54:51.066] Timer tick, asking Buildbucket for the build status
[08:54:51.262] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:51.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:7:0) after 1m0s
[08:55:51.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:7:0)
[08:55:51.282] Timer tick, asking Buildbucket for the build status
[08:55:51.485] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:51.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:8:0) after 1m0s
[08:56:51.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:8:0)
[08:56:51.555] Timer tick, asking Buildbucket for the build status
[08:56:51.757] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:51.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:9:0) after 1m0s
[08:57:51.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:9:0)
[08:57:51.780] Timer tick, asking Buildbucket for the build status
[08:57:51.934] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:51.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:10:0) after 1m0s
[08:58:51.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:10:0)
[08:58:51.954] Timer tick, asking Buildbucket for the build status
[08:58:52.372] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:52.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:11:0) after 1m0s
[08:59:52.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:11:0)
[08:59:52.390] Timer tick, asking Buildbucket for the build status
[08:59:52.502] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:52.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:12:0) after 1m0s
[09:00:52.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:12:0)
[09:00:52.528] Timer tick, asking Buildbucket for the build status
[09:00:52.703] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:52.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:13:0) after 1m0s
[09:01:52.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:13:0)
[09:01:52.751] Timer tick, asking Buildbucket for the build status
[09:01:53.223] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:53.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:14:0) after 1m0s
[09:02:53.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:14:0)
[09:02:53.298] Timer tick, asking Buildbucket for the build status
[09:02:53.454] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:53.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:15:0) after 1m0s
[09:03:53.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:15:0)
[09:03:53.472] Timer tick, asking Buildbucket for the build status
[09:03:53.681] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:16:0) after 1m0s
[09:04:53.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:16:0)
[09:04:53.705] Timer tick, asking Buildbucket for the build status
[09:04:53.944] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:53.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:17:0) after 1m0s
[09:05:53.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:17:0)
[09:05:53.953] Timer tick, asking Buildbucket for the build status
[09:05:54.389] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:54.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:18:0) after 1m0s
[09:06:54.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:18:0)
[09:06:54.373] Timer tick, asking Buildbucket for the build status
[09:06:54.578] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:19:0) after 1m0s
[09:07:54.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:19:0)
[09:07:54.658] Timer tick, asking Buildbucket for the build status
[09:07:54.851] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:54.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:20:0) after 1m0s
[09:08:54.868] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:20:0)
[09:08:54.868] Timer tick, asking Buildbucket for the build status
[09:08:55.347] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:55.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:21:0) after 1m0s
[09:09:55.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:21:0)
[09:09:55.389] Timer tick, asking Buildbucket for the build status
[09:09:55.687] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:55.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:22:0) after 1m0s
[09:10:55.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:22:0)
[09:10:55.821] Timer tick, asking Buildbucket for the build status
[09:10:56.348] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:56.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:23:0) after 1m0s
[09:11:56.416] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:23:0)
[09:11:56.416] Timer tick, asking Buildbucket for the build status
[09:11:56.759] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:56.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:24:0) after 1m0s
[09:12:56.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:24:0)
[09:12:56.779] Timer tick, asking Buildbucket for the build status
[09:12:56.943] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:56.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:25:0) after 1m0s
[09:13:56.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:25:0)
[09:13:56.969] Timer tick, asking Buildbucket for the build status
[09:13:57.100] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:57.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:26:0) after 1m0s
[09:14:57.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:26:0)
[09:14:57.131] Timer tick, asking Buildbucket for the build status
[09:14:57.305] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:57.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:27:0) after 1m0s
[09:15:57.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:27:0)
[09:15:57.334] Timer tick, asking Buildbucket for the build status
[09:15:57.681] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:28:0) after 1m0s
[09:16:57.736] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:28:0)
[09:16:57.736] Timer tick, asking Buildbucket for the build status
[09:16:57.996] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:57.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:29:0) after 1m0s
[09:17:58.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:29:0)
[09:17:58.019] Timer tick, asking Buildbucket for the build status
[09:17:58.291] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:58.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:30:0) after 1m0s
[09:18:58.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:30:0)
[09:18:58.324] Timer tick, asking Buildbucket for the build status
[09:18:58.654] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:58.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:31:0) after 1m0s
[09:19:58.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:31:0)
[09:19:58.693] Timer tick, asking Buildbucket for the build status
[09:19:58.833] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:32:0) after 1m0s
[09:20:58.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:32:0)
[09:20:58.955] Timer tick, asking Buildbucket for the build status
[09:20:59.087] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:59.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:33:0) after 1m0s
[09:21:59.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:33:0)
[09:21:59.154] Timer tick, asking Buildbucket for the build status
[09:21:59.299] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:59.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:34:0) after 1m0s
[09:22:59.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:34:0)
[09:22:59.371] Timer tick, asking Buildbucket for the build status
[09:23:00.169] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:35:0) after 1m0s
[09:24:00.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:35:0)
[09:24:00.307] Timer tick, asking Buildbucket for the build status
[09:24:00.489] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:00.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:36:0) after 1m0s
[09:25:02.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:36:0)
[09:25:02.297] Timer tick, asking Buildbucket for the build status
[09:25:02.661] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:02.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:37:0) after 1m0s
[09:26:02.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:37:0)
[09:26:02.787] Timer tick, asking Buildbucket for the build status
[09:26:02.928] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:02.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:38:0) after 1m0s
[09:27:03.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:38:0)
[09:27:03.067] Timer tick, asking Buildbucket for the build status
[09:27:03.198] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:03.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:39:0) after 1m0s
[09:28:03.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:39:0)
[09:28:03.465] Timer tick, asking Buildbucket for the build status
[09:28:03.680] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:03.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:40:0) after 1m0s
[09:29:03.877] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:40:0)
[09:29:03.877] Timer tick, asking Buildbucket for the build status
[09:29:04.105] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:04.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:41:0) after 1m0s
[09:30:04.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:41:0)
[09:30:04.133] Timer tick, asking Buildbucket for the build status
[09:30:04.244] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:04.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:42:0) after 1m0s
[09:31:04.383] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:42:0)
[09:31:04.383] Timer tick, asking Buildbucket for the build status
[09:31:04.509] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:04.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:43:0) after 1m0s
[09:32:04.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:43:0)
[09:32:04.801] Timer tick, asking Buildbucket for the build status
[09:32:05.202] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:05.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:44:0) after 1m0s
[09:33:05.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:44:0)
[09:33:05.403] Timer tick, asking Buildbucket for the build status
[09:33:05.542] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:05.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:45:0) after 1m0s
[09:34:05.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:45:0)
[09:34:05.603] Timer tick, asking Buildbucket for the build status
[09:34:06.032] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:06.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:46:0) after 1m0s
[09:35:06.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:46:0)
[09:35:06.155] Timer tick, asking Buildbucket for the build status
[09:35:06.274] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:06.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:47:0) after 1m0s
[09:36:06.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:47:0)
[09:36:06.376] Timer tick, asking Buildbucket for the build status
[09:36:06.731] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:06.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:48:0) after 1m0s
[09:37:06.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:48:0)
[09:37:06.755] Timer tick, asking Buildbucket for the build status
[09:37:07.074] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:07.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:49:0) after 1m0s
[09:38:07.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:49:0)
[09:38:07.131] Timer tick, asking Buildbucket for the build status
[09:38:07.674] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:07.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:50:0) after 1m0s
[09:39:07.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:50:0)
[09:39:07.793] Timer tick, asking Buildbucket for the build status
[09:39:07.918] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:07.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:51:0) after 1m0s
[09:40:08.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:51:0)
[09:40:08.042] Timer tick, asking Buildbucket for the build status
[09:40:08.244] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:08.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:52:0) after 1m0s
[09:41:14.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:52:0)
[09:41:14.008] Timer tick, asking Buildbucket for the build status
[09:41:14.197] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:14.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:53:0) after 1m0s
[09:42:14.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:53:0)
[09:42:14.219] Timer tick, asking Buildbucket for the build status
[09:42:14.363] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:14.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:54:0) after 1m0s
[09:43:14.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:54:0)
[09:43:14.435] Timer tick, asking Buildbucket for the build status
[09:43:14.586] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:14.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:55:0) after 1m0s
[09:44:14.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:55:0)
[09:44:14.675] Timer tick, asking Buildbucket for the build status
[09:44:14.858] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:14.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:56:0) after 1m0s
[09:45:14.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:56:0)
[09:45:14.941] Timer tick, asking Buildbucket for the build status
[09:45:15.045] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:15.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:57:0) after 1m0s
[09:46:15.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:57:0)
[09:46:15.215] Timer tick, asking Buildbucket for the build status
[09:46:16.142] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:16.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:58:0) after 1m0s
[09:47:16.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:58:0)
[09:47:16.316] Timer tick, asking Buildbucket for the build status
[09:47:16.477] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:16.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:59:0) after 1m0s
[09:48:16.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:59:0)
[09:48:16.510] Timer tick, asking Buildbucket for the build status
[09:48:16.710] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:16.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:60:0) after 1m0s
[09:49:16.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:60:0)
[09:49:16.768] Timer tick, asking Buildbucket for the build status
[09:49:17.123] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:17.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:61:0) after 1m0s
[09:50:17.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:61:0)
[09:50:17.131] Timer tick, asking Buildbucket for the build status
[09:50:17.376] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:17.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:62:0) after 1m0s
[09:51:17.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:62:0)
[09:51:17.513] Timer tick, asking Buildbucket for the build status
[09:51:17.896] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:17.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:63:0) after 1m0s
[09:52:17.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:63:0)
[09:52:17.923] Timer tick, asking Buildbucket for the build status
[09:52:18.040] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:64:0) after 1m0s
[09:53:18.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:64:0)
[09:53:18.091] Timer tick, asking Buildbucket for the build status
[09:53:18.208] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:18.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:65:0) after 1m0s
[09:54:18.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:65:0)
[09:54:18.302] Timer tick, asking Buildbucket for the build status
[09:54:18.735] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:18.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:66:0) after 1m0s
[09:55:18.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:66:0)
[09:55:18.810] Timer tick, asking Buildbucket for the build status
[09:55:18.971] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:18.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:67:0) after 1m0s
[09:56:18.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:67:0)
[09:56:18.998] Timer tick, asking Buildbucket for the build status
[09:56:19.204] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:19.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:68:0) after 1m0s
[09:57:19.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:68:0)
[09:57:19.289] Timer tick, asking Buildbucket for the build status
[09:57:19.668] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:19.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:69:0) after 1m0s
[09:58:19.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:69:0)
[09:58:19.706] Timer tick, asking Buildbucket for the build status
[09:58:19.951] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:19.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:70:0) after 1m0s
[09:59:19.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:70:0)
[09:59:19.983] Timer tick, asking Buildbucket for the build status
[09:59:20.139] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:20.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:71:0) after 1m0s
[10:00:20.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:71:0)
[10:00:20.183] Timer tick, asking Buildbucket for the build status
[10:00:20.355] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:20.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:72:0) after 1m0s
[10:01:20.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:72:0)
[10:01:20.418] Timer tick, asking Buildbucket for the build status
[10:01:20.569] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:20.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:73:0) after 1m0s
[10:02:20.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:73:0)
[10:02:20.674] Timer tick, asking Buildbucket for the build status
[10:02:20.811] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:20.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:74:0) after 1m0s
[10:03:20.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:74:0)
[10:03:20.811] Timer tick, asking Buildbucket for the build status
[10:03:21.184] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:21.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:75:0) after 1m0s
[10:04:21.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:75:0)
[10:04:21.212] Timer tick, asking Buildbucket for the build status
[10:04:24.243] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:24.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:76:0) after 1m0s
[10:05:24.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:76:0)
[10:05:24.448] Timer tick, asking Buildbucket for the build status
[10:05:24.608] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:77:0) after 1m0s
[10:06:24.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:77:0)
[10:06:24.739] Timer tick, asking Buildbucket for the build status
[10:06:25.056] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:25.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:78:0) after 1m0s
[10:07:25.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:78:0)
[10:07:25.145] Timer tick, asking Buildbucket for the build status
[10:07:25.362] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:25.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:79:0) after 1m0s
[10:08:25.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:79:0)
[10:08:25.405] Timer tick, asking Buildbucket for the build status
[10:08:25.587] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:25.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:80:0) after 1m0s
[10:09:25.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:80:0)
[10:09:25.625] Timer tick, asking Buildbucket for the build status
[10:09:25.758] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:25.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:81:0) after 1m0s
[10:10:25.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:81:0)
[10:10:25.815] Timer tick, asking Buildbucket for the build status
[10:10:25.955] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:25.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:82:0) after 1m0s
[10:11:26.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:82:0)
[10:11:26.036] Timer tick, asking Buildbucket for the build status
[10:11:26.295] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:26.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:83:0) after 1m0s
[10:12:26.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:83:0)
[10:12:26.339] Timer tick, asking Buildbucket for the build status
[10:12:26.564] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:26.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:84:0) after 1m0s
[10:13:26.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:84:0)
[10:13:26.643] Timer tick, asking Buildbucket for the build status
[10:13:26.978] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:26.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:85:0) after 1m0s
[10:14:27.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:85:0)
[10:14:27.113] Timer tick, asking Buildbucket for the build status
[10:14:27.454] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:27.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:86:0) after 1m0s
[10:15:27.579] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:86:0)
[10:15:27.579] Timer tick, asking Buildbucket for the build status
[10:15:27.705] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:27.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:87:0) after 1m0s
[10:16:27.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:87:0)
[10:16:27.825] Timer tick, asking Buildbucket for the build status
[10:16:27.929] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:27.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:88:0) after 1m0s
[10:17:28.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:88:0)
[10:17:28.058] Timer tick, asking Buildbucket for the build status
[10:17:29.341] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:29.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:89:0) after 1m0s
[10:18:29.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:89:0)
[10:18:29.500] Timer tick, asking Buildbucket for the build status
[10:18:29.851] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:29.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:90:0) after 1m0s
[10:19:29.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:90:0)
[10:19:29.896] Timer tick, asking Buildbucket for the build status
[10:19:30.073] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:30.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:91:0) after 1m0s
[10:20:30.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:91:0)
[10:20:30.125] Timer tick, asking Buildbucket for the build status
[10:20:30.462] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:30.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:92:0) after 1m0s
[10:21:30.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:92:0)
[10:21:30.533] Timer tick, asking Buildbucket for the build status
[10:21:31.025] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:31.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:93:0) after 1m0s
[10:22:31.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:93:0)
[10:22:31.053] Timer tick, asking Buildbucket for the build status
[10:22:31.206] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:31.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:94:0) after 1m0s
[10:23:31.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:94:0)
[10:23:31.237] Timer tick, asking Buildbucket for the build status
[10:23:31.452] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:31.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:95:0) after 1m0s
[10:24:31.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:95:0)
[10:24:31.633] Timer tick, asking Buildbucket for the build status
[10:24:31.771] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:31.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:96:0) after 1m0s
[10:25:31.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:96:0)
[10:25:31.806] Timer tick, asking Buildbucket for the build status
[10:25:31.912] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:31.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:97:0) after 1m0s
[10:26:31.988] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:97:0)
[10:26:31.988] Timer tick, asking Buildbucket for the build status
[10:26:32.179] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:32.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:98:0) after 1m0s
[10:27:32.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:98:0)
[10:27:32.224] Timer tick, asking Buildbucket for the build status
[10:27:32.445] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:32.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:99:0) after 1m0s
[10:28:32.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:99:0)
[10:28:32.554] Timer tick, asking Buildbucket for the build status
[10:28:32.951] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:32.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:100:0) after 1m0s
[10:29:33.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:100:0)
[10:29:33.055] Timer tick, asking Buildbucket for the build status
[10:29:33.167] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:33.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:101:0) after 1m0s
[10:30:33.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:101:0)
[10:30:33.222] Timer tick, asking Buildbucket for the build status
[10:30:33.347] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:33.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:102:0) after 1m0s
[10:31:33.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:102:0)
[10:31:33.487] Timer tick, asking Buildbucket for the build status
[10:31:33.875] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:33.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:103:0) after 1m0s
[10:32:33.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:103:0)
[10:32:33.946] Timer tick, asking Buildbucket for the build status
[10:32:34.277] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:34.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:104:0) after 1m0s
[10:33:34.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:104:0)
[10:33:34.337] Timer tick, asking Buildbucket for the build status
[10:33:34.475] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:34.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:105:0) after 1m0s
[10:34:34.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:105:0)
[10:34:34.498] Timer tick, asking Buildbucket for the build status
[10:34:34.689] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:34.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:106:0) after 1m0s
[10:35:34.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:106:0)
[10:35:34.716] Timer tick, asking Buildbucket for the build status
[10:35:35.094] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:35.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:107:0) after 1m0s
[10:36:35.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:107:0)
[10:36:35.117] Timer tick, asking Buildbucket for the build status
[10:36:35.416] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:35.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:108:0) after 1m0s
[10:37:35.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:108:0)
[10:37:35.462] Timer tick, asking Buildbucket for the build status
[10:37:35.644] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:35.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:109:0) after 1m0s
[10:38:35.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:109:0)
[10:38:35.669] Timer tick, asking Buildbucket for the build status
[10:38:35.774] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:35.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:110:0) after 1m0s
[10:39:35.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:110:0)
[10:39:35.797] Timer tick, asking Buildbucket for the build status
[10:39:35.913] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:35.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:111:0) after 1m0s
[10:40:35.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:111:0)
[10:40:35.942] Timer tick, asking Buildbucket for the build status
[10:40:36.079] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:36.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:112:0) after 1m0s
[10:41:36.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:112:0)
[10:41:36.101] Timer tick, asking Buildbucket for the build status
[10:41:36.669] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:113:0) after 1m0s
[10:42:36.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:113:0)
[10:42:36.701] Timer tick, asking Buildbucket for the build status
[10:42:36.941] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:36.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:114:0) after 1m0s
[10:43:36.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:114:0)
[10:43:36.965] Timer tick, asking Buildbucket for the build status
[10:43:37.093] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:37.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:115:0) after 1m0s
[10:44:37.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:115:0)
[10:44:37.134] Timer tick, asking Buildbucket for the build status
[10:44:37.631] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:37.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:116:0) after 1m0s
[10:45:37.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:116:0)
[10:45:37.660] Timer tick, asking Buildbucket for the build status
[10:45:37.818] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:37.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:117:0) after 1m0s
[10:46:37.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:117:0)
[10:46:37.848] Timer tick, asking Buildbucket for the build status
[10:46:37.988] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:37.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:118:0) after 1m0s
[10:47:38.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:118:0)
[10:47:38.041] Timer tick, asking Buildbucket for the build status
[10:47:38.508] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:38.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:119:0) after 1m0s
[10:48:38.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:119:0)
[10:48:38.640] Timer tick, asking Buildbucket for the build status
[10:48:38.747] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:38.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:120:0) after 1m0s
[10:49:38.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:120:0)
[10:49:38.787] Timer tick, asking Buildbucket for the build status
[10:49:39.097] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:39.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:121:0) after 1m0s
[10:50:39.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:121:0)
[10:50:39.179] Timer tick, asking Buildbucket for the build status
[10:50:39.537] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:39.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:122:0) after 1m0s
[10:51:39.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:122:0)
[10:51:39.653] Timer tick, asking Buildbucket for the build status
[10:51:39.925] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:39.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:123:0) after 1m0s
[10:52:39.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:123:0)
[10:52:39.969] Timer tick, asking Buildbucket for the build status
[10:52:40.088] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:40.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:124:0) after 1m0s
[10:53:40.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:124:0)
[10:53:40.173] Timer tick, asking Buildbucket for the build status
[10:53:40.347] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:40.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:125:0) after 1m0s
[10:54:40.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:125:0)
[10:54:40.359] Timer tick, asking Buildbucket for the build status
[10:54:40.505] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:40.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:126:0) after 1m0s
[10:55:40.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:126:0)
[10:55:40.528] Timer tick, asking Buildbucket for the build status
[10:55:40.686] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:40.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:127:0) after 1m0s
[10:56:40.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:127:0)
[10:56:40.799] Timer tick, asking Buildbucket for the build status
[10:56:40.937] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:40.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:128:0) after 1m0s
[10:57:41.010] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:128:0)
[10:57:41.010] Timer tick, asking Buildbucket for the build status
[10:57:41.240] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:41.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:129:0) after 1m0s
[10:58:41.288] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:129:0)
[10:58:41.288] Timer tick, asking Buildbucket for the build status
[10:58:41.683] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:41.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:130:0) after 1m0s
[10:59:41.708] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:130:0)
[10:59:41.708] Timer tick, asking Buildbucket for the build status
[10:59:41.840] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:41.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:131:0) after 1m0s
[11:00:41.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:131:0)
[11:00:41.878] Timer tick, asking Buildbucket for the build status
[11:00:42.476] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:42.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:132:0) after 1m0s
[11:01:42.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:132:0)
[11:01:42.513] Timer tick, asking Buildbucket for the build status
[11:01:42.692] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:42.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:133:0) after 1m0s
[11:02:42.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:133:0)
[11:02:42.699] Timer tick, asking Buildbucket for the build status
[11:02:42.836] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:42.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:134:0) after 1m0s
[11:03:42.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:134:0)
[11:03:42.860] Timer tick, asking Buildbucket for the build status
[11:03:42.954] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:42.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:135:0) after 1m0s
[11:04:42.995] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:135:0)
[11:04:42.995] Timer tick, asking Buildbucket for the build status
[11:04:43.125] Build 8881425689060072464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:43.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9046855751195041168:136:0) after 1m0s
[11:05:30.371] Received PubSub notification, asking Buildbucket for the build status
[11:05:30.447] Build 8881425689060072464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:05:30.447] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1588417529341221",
"created_by": "project:chromium",
"created_ts": "1588409449480241",
"id": "8881425689060072464",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4048c8f48b3e4bdd01932235f34b2c0e54c85281\"}}",
"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\": \"build283-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 13917, \"got_angle_revision\": \"040e4f6fcf5428ff52f6c6cff19f8b3cb26e5eaf\", \"got_clang_revision\": \"n346557-4e0d9925-3\", \"got_dawn_revision\": \"303a3daf0decb8eaacb251346be317be00dda479\", \"got_nacl_revision\": \"08ef20f1933cc724a25911b4da99a9e7355cafa0\", \"got_revision\": \"4048c8f48b3e4bdd01932235f34b2c0e54c85281\", \"got_revision_cp\": \"refs/heads/master@{#764917}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"b798cfa374ebfaa04d08458b277f6c499a16b527\", \"got_v8_revision\": \"ffa14bc12c71f817f31eaeaa7dbe4c90871f67d6\", \"got_v8_revision_cp\": \"refs/heads/8.4.268@{#1}\", \"got_webrtc_revision\": \"3745d3fc9390fe6e8b1ab24d64820aa1402b47ae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31148}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4048c8f48b3e4bdd01932235f34b2c0e54c85281\", \"swarm_hashes\": {\"base_unittests\": \"4591ac961fc85e7ff9cc8f3ac8666ac9bd952390\", \"boringssl_crypto_tests\": \"f59f334c3bef9b3a2a37c54f865893a7f60f2722\", \"boringssl_ssl_tests\": \"49722241aebf563856d850ee4ee75e230781683d\", \"components_unittests\": \"f4fd06e3d1dcffc5abc30786ffef01594c973e56\", \"crypto_unittests\": \"6b0739754ce93300a174351aab0f4737ebf13a44\", \"gfx_unittests\": \"317146a3c8f196edd72f8394614e688fb33189d4\", \"google_apis_unittests\": \"2a03701a7bda87335203c220874946ad21bb33a1\", \"ios_chrome_unittests\": \"804d463f4f1f6a77ca8ca7d82c2fa0e058036cd7\", \"ios_net_unittests\": \"235379f2a1a7dab2cf548f2d74821cf8408fdf72\", \"ios_web_inttests\": \"c1d72afa4e80efe05a7ea1f3dcf142215c78ca1b\", \"ios_web_unittests\": \"05cb04e183943ec4c8591856eb01d29f0948d16c\", \"ios_web_view_inttests\": \"6802f41e072845918a8d78d9c32fcb8178ef7dc1\", \"net_unittests\": \"e230abb167c409b72c486aa867bd5c8fdda43ef1\", \"skia_unittests\": \"352a34087e6456a9ba4e456049b394b1a0427a2f\", \"sql_unittests\": \"b5ee54f65ff615f5c213281e6ca9cc7ab158d74c\", \"ui_base_unittests\": \"b8f0e3a57c9e00433bcb7a97ae48e46f9cdae2ff\", \"url_unittests\": \"97680941cc65328e2700767f832ddaf840c1f158\"}, \"swarm_hashes_refs/heads/master(at){#764917}_without_patch\": {\"base_unittests\": \"4591ac961fc85e7ff9cc8f3ac8666ac9bd952390\", \"boringssl_crypto_tests\": \"f59f334c3bef9b3a2a37c54f865893a7f60f2722\", \"boringssl_ssl_tests\": \"49722241aebf563856d850ee4ee75e230781683d\", \"components_unittests\": \"f4fd06e3d1dcffc5abc30786ffef01594c973e56\", \"crypto_unittests\": \"6b0739754ce93300a174351aab0f4737ebf13a44\", \"gfx_unittests\": \"317146a3c8f196edd72f8394614e688fb33189d4\", \"google_apis_unittests\": \"2a03701a7bda87335203c220874946ad21bb33a1\", \"ios_chrome_unittests\": \"804d463f4f1f6a77ca8ca7d82c2fa0e058036cd7\", \"ios_net_unittests\": \"235379f2a1a7dab2cf548f2d74821cf8408fdf72\", \"ios_web_inttests\": \"c1d72afa4e80efe05a7ea1f3dcf142215c78ca1b\", \"ios_web_unittests\": \"05cb04e183943ec4c8591856eb01d29f0948d16c\", \"ios_web_view_inttests\": \"6802f41e072845918a8d78d9c32fcb8178ef7dc1\", \"net_unittests\": \"e230abb167c409b72c486aa867bd5c8fdda43ef1\", \"skia_unittests\": \"352a34087e6456a9ba4e456049b394b1a0427a2f\", \"sql_unittests\": \"b5ee54f65ff615f5c213281e6ca9cc7ab158d74c\", \"ui_base_unittests\": \"b8f0e3a57c9e00433bcb7a97ae48e46f9cdae2ff\", \"url_unittests\": \"97680941cc65328e2700767f832ddaf840c1f158\"}, \"xcode_build_version\": \"11c29\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11c29\"], \"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\": [\"build283-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\": [\"5033-bf2739b\"], \"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": "1588409455236632",
"status": "COMPLETED",
"status_changed_ts": "1588417529723757",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/13917",
"builder:ToTiOS",
"buildset:commit/git/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4048c8f48b3e4bdd01932235f34b2c0e54c85281",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046855751195041168",
"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/8881425689060072464/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4bed6647e0d9a710",
"user_agent:luci-scheduler"
],
"updated_ts": "1588417529729459",
"url": "https://ci.chromium.org/b/8881425689060072464",
"utcnow_ts": "1588417530438740"
}
}
[11:05:30.447] Invocation finished in 2h14m42.385990934s with status SUCCEEDED