[17:04:40.072] New invocation is queued and will start shortly
[17:04:41.367] Starting the invocation (attempt 1)
[17:04:41.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:04:41.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:04:41.453] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024266035164125072",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9024266035164125072",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"gitiles_ref:refs/heads/master"
]
}
[17:04:42.546] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609952681600142",
"id": "8858835972896913856",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609952682240166",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22087",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024266035164125072",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858835972896913856/+/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": "1609952682240330",
"url": "https://ci.chromium.org/b/8858835972896913856",
"utcnow_ts": "1609952682528089"
}
}
[17:04:42.546] Task URL: https://ci.chromium.org/b/8858835972896913856
[17:04:42.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:2:0) after 1m0s
[17:05:42.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:2:0)
[17:05:42.583] Timer tick, asking Buildbucket for the build status
[17:05:42.881] Build 8858835972896913856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:42.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:3:0) after 1m0s
[17:06:42.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:3:0)
[17:06:42.951] Timer tick, asking Buildbucket for the build status
[17:06:43.383] Build 8858835972896913856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:43.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:4:0) after 1m0s
[17:07:43.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:4:0)
[17:07:43.447] Timer tick, asking Buildbucket for the build status
[17:07:43.531] Build 8858835972896913856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:43.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:5:0) after 1m0s
[17:08:43.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:5:0)
[17:08:43.559] Timer tick, asking Buildbucket for the build status
[17:08:43.657] Build 8858835972896913856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:43.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:6:0) after 1m0s
[17:09:03.908] Received PubSub notification, asking Buildbucket for the build status
[17:09:03.987] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:43.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:6:0)
[17:09:43.678] Timer tick, asking Buildbucket for the build status
[17:09:43.836] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:43.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:8:0) after 1m0s
[17:10:43.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:8:0)
[17:10:43.915] Timer tick, asking Buildbucket for the build status
[17:10:44.168] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:44.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:9:0) after 1m0s
[17:11:44.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:9:0)
[17:11:44.200] Timer tick, asking Buildbucket for the build status
[17:11:44.339] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:44.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:10:0) after 1m0s
[17:12:44.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:10:0)
[17:12:44.355] Timer tick, asking Buildbucket for the build status
[17:12:44.739] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:44.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:11:0) after 1m0s
[17:13:44.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:11:0)
[17:13:44.756] Timer tick, asking Buildbucket for the build status
[17:13:44.973] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:44.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:12:0) after 1m0s
[17:14:45.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:12:0)
[17:14:45.052] Timer tick, asking Buildbucket for the build status
[17:14:45.288] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:45.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:13:0) after 1m0s
[17:15:45.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:13:0)
[17:15:45.307] Timer tick, asking Buildbucket for the build status
[17:15:45.382] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:45.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:14:0) after 1m0s
[17:16:45.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:14:0)
[17:16:45.370] Timer tick, asking Buildbucket for the build status
[17:16:45.640] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:45.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:15:0) after 1m0s
[17:17:45.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:15:0)
[17:17:45.658] Timer tick, asking Buildbucket for the build status
[17:17:45.729] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:45.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:16:0) after 1m0s
[17:18:45.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:16:0)
[17:18:45.773] Timer tick, asking Buildbucket for the build status
[17:18:46.095] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:46.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:17:0) after 1m0s
[17:19:46.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:17:0)
[17:19:46.167] Timer tick, asking Buildbucket for the build status
[17:19:46.287] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:46.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:18:0) after 1m0s
[17:20:46.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:18:0)
[17:20:46.313] Timer tick, asking Buildbucket for the build status
[17:20:46.550] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:46.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:19:0) after 1m0s
[17:21:46.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:19:0)
[17:21:46.631] Timer tick, asking Buildbucket for the build status
[17:21:46.698] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:46.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:20:0) after 1m0s
[17:22:47.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:20:0)
[17:22:47.282] Timer tick, asking Buildbucket for the build status
[17:22:47.489] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:47.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:21:0) after 1m0s
[17:23:47.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:21:0)
[17:23:47.617] Timer tick, asking Buildbucket for the build status
[17:23:47.687] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:47.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:22:0) after 1m0s
[17:24:47.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:22:0)
[17:24:47.960] Timer tick, asking Buildbucket for the build status
[17:24:48.328] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:48.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:23:0) after 1m0s
[17:25:48.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:23:0)
[17:25:48.895] Timer tick, asking Buildbucket for the build status
[17:25:49.240] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:49.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:24:0) after 1m0s
[17:26:49.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:24:0)
[17:26:49.296] Timer tick, asking Buildbucket for the build status
[17:26:49.519] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:49.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:25:0) after 1m0s
[17:27:49.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:25:0)
[17:27:49.725] Timer tick, asking Buildbucket for the build status
[17:27:49.883] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:49.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:26:0) after 1m0s
[17:28:50.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:26:0)
[17:28:50.175] Timer tick, asking Buildbucket for the build status
[17:28:50.274] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:50.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:27:0) after 1m0s
[17:29:50.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:27:0)
[17:29:50.570] Timer tick, asking Buildbucket for the build status
[17:29:50.885] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:50.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:28:0) after 1m0s
[17:30:50.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:28:0)
[17:30:50.947] Timer tick, asking Buildbucket for the build status
[17:30:51.013] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:51.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:29:0) after 1m0s
[17:31:51.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:29:0)
[17:31:51.112] Timer tick, asking Buildbucket for the build status
[17:31:51.274] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:51.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:30:0) after 1m0s
[17:32:51.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:30:0)
[17:32:51.358] Timer tick, asking Buildbucket for the build status
[17:32:51.443] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:51.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:31:0) after 1m0s
[17:33:51.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:31:0)
[17:33:51.505] Timer tick, asking Buildbucket for the build status
[17:33:51.557] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:51.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:32:0) after 1m0s
[17:34:51.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:32:0)
[17:34:51.616] Timer tick, asking Buildbucket for the build status
[17:34:51.734] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:51.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:33:0) after 1m0s
[17:35:51.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:33:0)
[17:35:51.778] Timer tick, asking Buildbucket for the build status
[17:35:52.278] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:52.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:34:0) after 1m0s
[17:36:52.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:34:0)
[17:36:52.303] Timer tick, asking Buildbucket for the build status
[17:36:52.404] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:52.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:35:0) after 1m0s
[17:37:52.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:35:0)
[17:37:52.523] Timer tick, asking Buildbucket for the build status
[17:37:52.692] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:52.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:36:0) after 1m0s
[17:38:52.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:36:0)
[17:38:52.794] Timer tick, asking Buildbucket for the build status
[17:38:53.788] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:53.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:37:0) after 1m0s
[17:39:53.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:37:0)
[17:39:53.835] Timer tick, asking Buildbucket for the build status
[17:39:54.419] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:54.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:38:0) after 1m0s
[17:40:54.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:38:0)
[17:40:54.467] Timer tick, asking Buildbucket for the build status
[17:40:54.766] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:54.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:39:0) after 1m0s
[17:41:54.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:39:0)
[17:41:54.838] Timer tick, asking Buildbucket for the build status
[17:41:54.950] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:54.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:40:0) after 1m0s
[17:42:55.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:40:0)
[17:42:55.002] Timer tick, asking Buildbucket for the build status
[17:42:55.086] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:41:0) after 1m0s
[17:43:55.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:41:0)
[17:43:55.108] Timer tick, asking Buildbucket for the build status
[17:43:55.229] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:55.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:42:0) after 1m0s
[17:44:55.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:42:0)
[17:44:55.230] Timer tick, asking Buildbucket for the build status
[17:44:55.451] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:55.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:43:0) after 1m0s
[17:45:55.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:43:0)
[17:45:55.491] Timer tick, asking Buildbucket for the build status
[17:45:55.582] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:44:0) after 1m0s
[17:46:55.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:44:0)
[17:46:55.606] Timer tick, asking Buildbucket for the build status
[17:46:55.678] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:55.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:45:0) after 1m0s
[17:47:55.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:45:0)
[17:47:55.767] Timer tick, asking Buildbucket for the build status
[17:47:55.866] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:55.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:46:0) after 1m0s
[17:48:55.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:46:0)
[17:48:55.911] Timer tick, asking Buildbucket for the build status
[17:48:56.047] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:56.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:47:0) after 1m0s
[17:49:56.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:47:0)
[17:49:56.104] Timer tick, asking Buildbucket for the build status
[17:49:56.325] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:56.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:48:0) after 1m0s
[17:50:56.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:48:0)
[17:50:56.344] Timer tick, asking Buildbucket for the build status
[17:50:56.502] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:56.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:49:0) after 1m0s
[17:51:56.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:49:0)
[17:51:56.559] Timer tick, asking Buildbucket for the build status
[17:51:56.743] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:56.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:50:0) after 1m0s
[17:52:56.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:50:0)
[17:52:56.745] Timer tick, asking Buildbucket for the build status
[17:52:57.141] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:57.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:51:0) after 1m0s
[17:53:57.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:51:0)
[17:53:57.161] Timer tick, asking Buildbucket for the build status
[17:53:57.375] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:57.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:52:0) after 1m0s
[17:54:57.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:52:0)
[17:54:57.376] Timer tick, asking Buildbucket for the build status
[17:54:57.621] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:57.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:53:0) after 1m0s
[17:55:57.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:53:0)
[17:55:57.702] Timer tick, asking Buildbucket for the build status
[17:55:57.767] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:57.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:54:0) after 1m0s
[17:56:57.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:54:0)
[17:56:57.795] Timer tick, asking Buildbucket for the build status
[17:57:00.407] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:00.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:55:0) after 1m0s
[17:58:01.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:55:0)
[17:58:01.711] Timer tick, asking Buildbucket for the build status
[17:58:01.874] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:01.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:56:0) after 1m0s
[17:59:02.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:56:0)
[17:59:02.070] Timer tick, asking Buildbucket for the build status
[17:59:02.190] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:02.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:57:0) after 1m0s
[18:00:02.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:57:0)
[18:00:02.225] Timer tick, asking Buildbucket for the build status
[18:00:02.484] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:02.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:58:0) after 1m0s
[18:01:02.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:58:0)
[18:01:02.546] Timer tick, asking Buildbucket for the build status
[18:01:03.246] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:03.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:59:0) after 1m0s
[18:02:03.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:59:0)
[18:02:03.270] Timer tick, asking Buildbucket for the build status
[18:02:03.654] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:03.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:60:0) after 1m0s
[18:03:03.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:60:0)
[18:03:03.805] Timer tick, asking Buildbucket for the build status
[18:03:04.278] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:04.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:61:0) after 1m0s
[18:04:04.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:61:0)
[18:04:04.384] Timer tick, asking Buildbucket for the build status
[18:04:04.627] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:04.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:62:0) after 1m0s
[18:05:04.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:62:0)
[18:05:04.718] Timer tick, asking Buildbucket for the build status
[18:05:05.164] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:05.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:63:0) after 1m0s
[18:06:05.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:63:0)
[18:06:05.428] Timer tick, asking Buildbucket for the build status
[18:06:05.613] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:05.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:64:0) after 1m0s
[18:07:05.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:64:0)
[18:07:05.941] Timer tick, asking Buildbucket for the build status
[18:07:06.307] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:06.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:65:0) after 1m0s
[18:08:06.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:65:0)
[18:08:06.462] Timer tick, asking Buildbucket for the build status
[18:08:06.762] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:06.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:66:0) after 1m0s
[18:09:06.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:66:0)
[18:09:06.902] Timer tick, asking Buildbucket for the build status
[18:09:07.130] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:07.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:67:0) after 1m0s
[18:10:07.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:67:0)
[18:10:07.203] Timer tick, asking Buildbucket for the build status
[18:10:07.550] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:07.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:68:0) after 1m0s
[18:11:07.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:68:0)
[18:11:07.703] Timer tick, asking Buildbucket for the build status
[18:11:08.427] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:08.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:69:0) after 1m0s
[18:12:08.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:69:0)
[18:12:08.507] Timer tick, asking Buildbucket for the build status
[18:12:09.009] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:09.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:70:0) after 1m0s
[18:13:08.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:70:0)
[18:13:08.985] Timer tick, asking Buildbucket for the build status
[18:13:09.086] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:09.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:71:0) after 1m0s
[18:14:09.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:71:0)
[18:14:09.255] Timer tick, asking Buildbucket for the build status
[18:14:10.178] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:10.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:72:0) after 1m0s
[18:15:10.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:72:0)
[18:15:10.325] Timer tick, asking Buildbucket for the build status
[18:15:10.559] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:10.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:73:0) after 1m0s
[18:16:10.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:73:0)
[18:16:10.754] Timer tick, asking Buildbucket for the build status
[18:16:10.894] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:10.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:74:0) after 1m0s
[18:17:11.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:74:0)
[18:17:11.036] Timer tick, asking Buildbucket for the build status
[18:17:11.274] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:11.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:75:0) after 1m0s
[18:18:11.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:75:0)
[18:18:11.367] Timer tick, asking Buildbucket for the build status
[18:18:11.529] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:76:0) after 1m0s
[18:19:11.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:76:0)
[18:19:11.608] Timer tick, asking Buildbucket for the build status
[18:19:11.829] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:11.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:77:0) after 1m0s
[18:20:11.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:77:0)
[18:20:11.893] Timer tick, asking Buildbucket for the build status
[18:20:12.160] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:12.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:78:0) after 1m0s
[18:21:12.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:78:0)
[18:21:12.168] Timer tick, asking Buildbucket for the build status
[18:21:12.344] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:12.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:79:0) after 1m0s
[18:22:12.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:79:0)
[18:22:12.392] Timer tick, asking Buildbucket for the build status
[18:22:12.741] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:12.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:80:0) after 1m0s
[18:23:13.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:80:0)
[18:23:13.845] Timer tick, asking Buildbucket for the build status
[18:23:13.927] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:13.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:81:0) after 1m0s
[18:24:14.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:81:0)
[18:24:14.053] Timer tick, asking Buildbucket for the build status
[18:24:14.806] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:14.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:82:0) after 1m0s
[18:25:14.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:82:0)
[18:25:14.958] Timer tick, asking Buildbucket for the build status
[18:25:15.343] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:15.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:83:0) after 1m0s
[18:26:15.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:83:0)
[18:26:15.411] Timer tick, asking Buildbucket for the build status
[18:26:15.774] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:15.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:84:0) after 1m0s
[18:27:15.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:84:0)
[18:27:15.791] Timer tick, asking Buildbucket for the build status
[18:27:16.203] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:16.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:85:0) after 1m0s
[18:28:16.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:85:0)
[18:28:16.293] Timer tick, asking Buildbucket for the build status
[18:28:16.410] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:16.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:86:0) after 1m0s
[18:29:16.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:86:0)
[18:29:16.437] Timer tick, asking Buildbucket for the build status
[18:29:16.992] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:16.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:87:0) after 1m0s
[18:30:17.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:87:0)
[18:30:17.056] Timer tick, asking Buildbucket for the build status
[18:30:17.884] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:17.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:88:0) after 1m0s
[18:31:17.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:88:0)
[18:31:17.917] Timer tick, asking Buildbucket for the build status
[18:31:18.397] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:18.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:89:0) after 1m0s
[18:32:18.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:89:0)
[18:32:18.408] Timer tick, asking Buildbucket for the build status
[18:32:18.525] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:18.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:90:0) after 1m0s
[18:33:18.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:90:0)
[18:33:18.514] Timer tick, asking Buildbucket for the build status
[18:33:18.713] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:18.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:91:0) after 1m0s
[18:34:18.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:91:0)
[18:34:18.742] Timer tick, asking Buildbucket for the build status
[18:34:18.961] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:18.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:92:0) after 1m0s
[18:35:19.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:92:0)
[18:35:19.022] Timer tick, asking Buildbucket for the build status
[18:35:20.013] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:20.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:93:0) after 1m0s
[18:36:20.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:93:0)
[18:36:20.037] Timer tick, asking Buildbucket for the build status
[18:36:20.340] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:94:0) after 1m0s
[18:37:20.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:94:0)
[18:37:20.391] Timer tick, asking Buildbucket for the build status
[18:37:20.768] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:20.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:95:0) after 1m0s
[18:38:20.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:95:0)
[18:38:20.832] Timer tick, asking Buildbucket for the build status
[18:38:20.907] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:20.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:96:0) after 1m0s
[18:39:20.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:96:0)
[18:39:20.910] Timer tick, asking Buildbucket for the build status
[18:39:21.013] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:21.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:97:0) after 1m0s
[18:40:21.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:97:0)
[18:40:21.092] Timer tick, asking Buildbucket for the build status
[18:40:21.311] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:21.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:98:0) after 1m0s
[18:41:21.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:98:0)
[18:41:21.322] Timer tick, asking Buildbucket for the build status
[18:41:21.430] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:21.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:99:0) after 1m0s
[18:42:21.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:99:0)
[18:42:21.709] Timer tick, asking Buildbucket for the build status
[18:42:21.835] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:21.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:100:0) after 1m0s
[18:43:22.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:100:0)
[18:43:22.385] Timer tick, asking Buildbucket for the build status
[18:43:22.971] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:22.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:101:0) after 1m0s
[18:44:23.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:101:0)
[18:44:23.095] Timer tick, asking Buildbucket for the build status
[18:44:23.242] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:23.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:102:0) after 1m0s
[18:45:23.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:102:0)
[18:45:23.480] Timer tick, asking Buildbucket for the build status
[18:45:24.098] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:24.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:103:0) after 1m0s
[18:46:24.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:103:0)
[18:46:24.320] Timer tick, asking Buildbucket for the build status
[18:46:24.427] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:24.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:104:0) after 1m0s
[18:47:24.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:104:0)
[18:47:24.622] Timer tick, asking Buildbucket for the build status
[18:47:24.766] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:24.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:105:0) after 1m0s
[18:48:25.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:105:0)
[18:48:25.170] Timer tick, asking Buildbucket for the build status
[18:48:25.462] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:106:0) after 1m0s
[18:49:25.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:106:0)
[18:49:25.511] Timer tick, asking Buildbucket for the build status
[18:49:25.628] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:25.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:107:0) after 1m0s
[18:50:25.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:107:0)
[18:50:25.765] Timer tick, asking Buildbucket for the build status
[18:50:25.973] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:25.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:108:0) after 1m0s
[18:51:26.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:108:0)
[18:51:26.051] Timer tick, asking Buildbucket for the build status
[18:51:26.524] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:26.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:109:0) after 1m0s
[18:52:26.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:109:0)
[18:52:26.593] Timer tick, asking Buildbucket for the build status
[18:52:26.786] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:26.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:110:0) after 1m0s
[18:53:26.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:110:0)
[18:53:26.802] Timer tick, asking Buildbucket for the build status
[18:53:27.212] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:111:0) after 1m0s
[18:54:27.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:111:0)
[18:54:27.282] Timer tick, asking Buildbucket for the build status
[18:54:27.955] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:112:0) after 1m0s
[18:55:27.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:112:0)
[18:55:27.991] Timer tick, asking Buildbucket for the build status
[18:55:28.236] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:113:0) after 1m0s
[18:56:28.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:113:0)
[18:56:28.354] Timer tick, asking Buildbucket for the build status
[18:56:28.627] Build 8858835972896913856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024266035164125072:114:0) after 1m0s
[18:57:27.114] Received PubSub notification, asking Buildbucket for the build status
[18:57:27.189] Build 8858835972896913856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:57:27.189] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609959445795667",
"created_by": "project:chromium",
"created_ts": "1609952681600142",
"id": "8858835972896913856",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\", \"project\": \"chromium/src\"}], \"$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\": \"luci-chromium-ci-xenial-us-central1-b-8-0-9jvr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22087, \"got_angle_revision\": \"8ef860714479776778ae652047f86b383854eaf8\", \"got_dawn_revision\": \"a84acc4fcca80d80c379e3b02d8dc0f7b102ba9d\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\", \"got_revision_cp\": \"refs/heads/master@{#840640}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"8bf25fa0cda754dd0f8e0f8b7c9f8854eabfe72d\", \"got_v8_revision_cp\": \"refs/heads/8.9.213@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ce98df46f74a4245c8570ab9ce0655bb75ea22c0\", \"swarm_hashes_refs/heads/master(at){#840640}_without_patch\": {\"absl_hardening_tests\": \"e575b61fc6a97006ff04cd49a5075655a8ca8d7c\", \"accessibility_unittests\": \"97cf7a418b260e636d69822e3d5615e70c196d9f\", \"angle_unittests\": \"42020464adee90210492915c55422e0f7541105d\", \"app_list_unittests\": \"99a176f7ce4dab3e092e9d6edcf00f2661be8ae3\", \"app_shell_unittests\": \"c0dcfba9e6ed784ac623a1f74bfc2f38937df3f2\", \"ash_unittests\": \"ad280378bf8c68d6ffd00acabd7e7964de7a5d08\", \"aura_unittests\": \"fad42679cfcb4f4e789c211bcaf280242fca0a12\", \"base_unittests\": \"2819f49707c78322db4914215824e103f1f5fb24\", \"base_util_unittests\": \"da14743a754d18d9b65c3de76432b8e90e8c8739\", \"blink_common_unittests\": \"99e53022aaa14737aa9bc6752b2004b2abd7dd34\", \"blink_fuzzer_unittests\": \"aaf55811d9ffb7e081fbec710112f2e6ce1e9e23\", \"blink_heap_unittests\": \"9102ee830d77a4d8f57b2cb1f2b0481fea888f6d\", \"blink_platform_unittests\": \"566091f318234309e971870f3ffcde59a502a4c9\", \"blink_unittests\": \"6c3c1e535e09589065de723dabe92bf65c8f2c98\", \"boringssl_crypto_tests\": \"263ea6d8ab82672183369784eb0ea8792bd5b659\", \"boringssl_ssl_tests\": \"a3ea4da73250875d790d99169a3e916a68e19279\", \"browser_tests\": \"36b2e0930ff993e96491e4d21efc876d32500f46\", \"capture_unittests\": \"f13975e540eb39f02cfb73ad5a94c2a4eacf3dcc\", \"cast_unittests\": \"06804871930e040d6894e4585da75b904401dca1\", \"cc_unittests\": \"499209edad905f7d76ca4e54a6d25d45b9c2c634\", \"chrome_app_unittests\": \"480938b46d5f6585f9a2da4f8c2f81946856f8ae\", \"chromedriver_unittests\": \"63a4a9a7996ed0d2a2ec7df282a46f884feee9f3\", \"chromeos_components_unittests\": \"ce1deb37333ff97c38e79a87a8931ccb4831d9c3\", \"chromeos_unittests\": \"be4d5bcf9022cb7ec4b1cff857b293248499122a\", \"components_browsertests\": \"6202f98f32a78e5cdc8dbe500273593aedc3e73b\", \"components_unittests\": \"69871762a786b1bf4a79e5e1719d81413ef1df65\", \"compositor_unittests\": \"cdb5d67e9d415f819656bb6ab4e4aeb0b9ae0588\", \"content_browsertests\": \"ee4aad760882fbcb1b5445d630317b4155b7f573\", \"content_unittests\": \"920150ec3c03057cdd7ba142ce7b8da09c105a97\", \"crashpad_tests\": \"2f36a649efbc5283eeabab046aa211658cec020b\", \"crypto_unittests\": \"42dbf10dcf5574f83d9097086aecc6c59b4dfd93\", \"dbus_unittests\": \"0a855d4e8d0774c9c7ab98d5b2be1ff8d49e9489\", \"device_unittests\": \"015e15be567a3a14d678a2c19ff716c7096f282f\", \"display_unittests\": \"8ecf3c0ef3b60c29d696328c7ec07d7d64c8eff9\", \"events_unittests\": \"8613e1d63be628ebf8fab2f0ddc9ee6e41b634ba\", \"exo_unittests\": \"b42038c2b3c385bafa9887595cd2eec064ac7852\", \"extensions_browsertests\": \"b75da5bf50492acc6322845b811959500832c727\", \"extensions_unittests\": \"7a367ec23b8d9a011a4d30757b7ad76a80097881\", \"filesystem_service_unittests\": \"6d52a38fb3367c629bc46edd693686d1f14c2bc8\", \"gcm_unit_tests\": \"5e837766d48218b67fc8ed4cb8adbcdb01c7ae07\", \"gfx_unittests\": \"0f2c262b79296005789c6578eb274057ce66fbe0\", \"gin_unittests\": \"78c56922e965cc2e175fce119c32d5e19cc94e9c\", \"gl_unittests_ozone\": \"d7d2ec3e3df5a626c158772dcda7ac660febd4ab\", \"google_apis_unittests\": \"2b15be00411f0ce7a1878bbff3b01a8e4aacf377\", \"gpu_unittests\": \"15de3c04727191872fb2a0725f979138cc8af45d\", \"gwp_asan_unittests\": \"552172e3fe1f3f3e3340084a95224dc9264cf986\", \"interactive_ui_tests\": \"225366f988b0aafcd8e789b38cc256b9f218ce64\", \"ipc_tests\": \"bab7e1209890d7682e806c252ed7bde34312e70c\", \"jingle_unittests\": \"bd6f0078488a427f38f85fa13b232ae0210c9a3c\", \"keyboard_unittests\": \"39f1c92acc68fc909ba409fad05746a2bc1e386a\", \"latency_unittests\": \"e789f2eef3b2e5e98558dc8fa00a0a81f1ace834\", \"libjingle_xmpp_unittests\": \"37165fe1c8232c992b516bf2b9f6f07eb13efcb5\", \"liburlpattern_unittests\": \"7cf02e03e75380b41be0b9fdaf2cde0c46c07d6a\", \"media_blink_unittests\": \"4fb93922941c2a423d36768cb299b7fa32acb9d3\", \"media_unittests\": \"eecb49d982ff3d13df24a4c108e811aa26b55f8d\", \"message_center_unittests\": \"e3b782b49a357166fd719df5db55848172db1f2e\", \"midi_unittests\": \"5040395d26472738be0c51dcf220197fc7733e51\", \"mojo_core_unittests\": \"6a629043d5623a74d1aacf9b8b401fd9fc15c9d4\", \"mojo_unittests\": \"3fe6b9f2fe43e516c8adb53dfeb3c38833ddf238\", \"nacl_helper_nonsfi_unittests\": \"3d943e223f3fd2722bc8f8e7ed0590e43a85be46\", \"nacl_loader_unittests\": \"811b34e4630f49fe91a743eddf478173d124bdc2\", \"native_theme_unittests\": \"6d96045f4c59d43c78a981a4892528a5f7347256\", \"net_unittests\": \"74fb17b51a168571597d2e554ce79a6d9389ed41\", \"ozone_gl_unittests\": \"bc46d433c976c466119398183a8783e6d002dd04\", \"ozone_unittests\": \"f802f6ddb06c9087490585717aa8ae7a024f8819\", \"ozone_x11_unittests\": \"a39073d962a5ae155632dcd411d498b8e6af816c\", \"pdf_unittests\": \"21e4a1fc7257b81adc41f48b36f8cb4726961dea\", \"perfetto_unittests\": \"4fe277fbbec5011c9972ebb2d2325b52772221d1\", \"ppapi_unittests\": \"63c0a74ce26c6759e832c39fd1abb11251d6c071\", \"printing_unittests\": \"2813d1d90ce1a009821a5067f11707b7dea828bc\", \"remoting_unittests\": \"23229b30c80172833682b88d72e75067a9eaaf73\", \"sandbox_linux_unittests\": \"eb54654950a2fdf4ab251287f7ed1f2513b272dd\", \"service_manager_unittests\": \"5718ba379803263c886175f54320856fa215ef35\", \"services_unittests\": \"eb3201797fd69b442b34a65ffae2400f3173e034\", \"shell_dialogs_unittests\": \"0def4770be7927c2890f38457a17019829f1c2a3\", \"shell_encryption_unittests\": \"07c783489412d3c633c90c808f93b7de29d7d488\", \"skia_unittests\": \"825d39d9c7b46b9fde0ca1e1f0184ae1984f3448\", \"snapshot_unittests\": \"825acbd41ebc233986abc9a43686c54990b2004f\", \"sql_unittests\": \"9a892a4199f14d98d786863359364ff1f8e1dcdc\", \"storage_unittests\": \"0d2b1eefca1f04f0f944366aa616a3a2c40911fd\", \"sync_integration_tests\": \"8ed2d64938528cf04acef47b634e94e02ed7d734\", \"traffic_annotation_auditor_unittests\": \"80e4060cf6e075c887aecce5406fb277c2b13bf0\", \"ui_base_unittests\": \"a0292037893deb6bbe10bfbe14544a578abe7001\", \"ui_chromeos_unittests\": \"81829a0c4b018e35d05a7cb6f695315e38fb9e7d\", \"ui_touch_selection_unittests\": \"33b965869cf01816b86de48fab2c02a4d53c3512\", \"unit_tests\": \"9dbbb8a6c9aea13b82fc7dee549585526e9158be\", \"url_unittests\": \"746e31c2db2c440f73ce8d5e31bd760ad71f011b\", \"usage_time_limit_unittests\": \"020229823c887eedca40dee9f0d5be8ca7367523\", \"views_unittests\": \"545bf0b8489fca5b40f1ae050c1d976e1945d961\", \"viz_unittests\": \"9c1f64fc580c7477472550ea228d1bbb64935d0d\", \"wm_unittests\": \"a618a3a152b2853c18323d5f84b6761732e3055b\", \"wtf_unittests\": \"6112b50e23aa96015043110d680a9f72c586fda5\", \"zlib_unittests\": \"1de60334d45059fe75e9d4cfd5069cd3f85d9ade\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_112d55e69d4bf792454bf0bc343f5011325dc51aa46e2a4521a4a1f4a6d30164_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3ff20984f80f48d33e2b03ffc12bed5306b6d9761e5e01dd0c6daff69f57abc3_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-0-9jvr\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609952943212517",
"status": "COMPLETED",
"status_changed_ts": "1609959446161948",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22087",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ce98df46f74a4245c8570ab9ce0655bb75ea22c0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024266035164125072",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858835972896913856/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:50f179ec4d0ddf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609959446167097",
"url": "https://ci.chromium.org/b/8858835972896913856",
"utcnow_ts": "1609959447176847"
}
}
[18:57:27.189] Invocation finished in 1h52m47.134863961s with status SUCCEEDED