[19:35:58.529] New invocation is queued and will start shortly
[19:36:01.775] Starting the invocation (attempt 1)
[19:36:01.861] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:36:01.861] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:36:01.861] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028876961045451744",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c25c700a2a603deff803eaa8d3d8d94c0a053e91\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028876961045451744",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"gitiles_ref:refs/heads/master"
]
}
[19:36:03.066] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1605555362091380",
"id": "8863446896598359360",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c25c700a2a603deff803eaa8d3d8d94c0a053e91\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605555362727816",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42917",
"builder:linux-chromeos-rel",
"buildset:commit/git/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028876961045451744",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863446896598359360/+/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": "1605555362728315",
"url": "https://ci.chromium.org/b/8863446896598359360",
"utcnow_ts": "1605555363052997"
}
}
[19:36:03.066] Task URL: https://ci.chromium.org/b/8863446896598359360
[19:36:03.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:2:0) after 1m0s
[19:37:03.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:2:0)
[19:37:03.167] Timer tick, asking Buildbucket for the build status
[19:37:03.328] Build 8863446896598359360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:03.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:3:0) after 1m0s
[19:38:03.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:3:0)
[19:38:03.424] Timer tick, asking Buildbucket for the build status
[19:38:03.569] Build 8863446896598359360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:03.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:4:0) after 1m0s
[19:39:03.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:4:0)
[19:39:03.630] Timer tick, asking Buildbucket for the build status
[19:39:03.893] Build 8863446896598359360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:03.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:5:0) after 1m0s
[19:40:03.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:5:0)
[19:40:03.875] Timer tick, asking Buildbucket for the build status
[19:40:04.308] Build 8863446896598359360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:04.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:6:0) after 1m0s
[19:40:20.716] Received PubSub notification, asking Buildbucket for the build status
[19:40:20.946] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:04.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:6:0)
[19:41:04.393] Timer tick, asking Buildbucket for the build status
[19:41:04.498] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:8:0) after 1m0s
[19:42:04.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:8:0)
[19:42:04.550] Timer tick, asking Buildbucket for the build status
[19:42:04.955] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:04.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:9:0) after 1m0s
[19:43:05.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:9:0)
[19:43:05.016] Timer tick, asking Buildbucket for the build status
[19:43:05.094] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:05.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:10:0) after 1m0s
[19:44:05.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:10:0)
[19:44:05.172] Timer tick, asking Buildbucket for the build status
[19:44:05.375] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:05.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:11:0) after 1m0s
[19:45:05.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:11:0)
[19:45:05.399] Timer tick, asking Buildbucket for the build status
[19:45:05.475] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:05.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:12:0) after 1m0s
[19:46:05.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:12:0)
[19:46:05.713] Timer tick, asking Buildbucket for the build status
[19:46:06.257] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:06.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:13:0) after 1m0s
[19:47:06.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:13:0)
[19:47:06.302] Timer tick, asking Buildbucket for the build status
[19:47:06.530] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:06.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:14:0) after 1m0s
[19:48:06.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:14:0)
[19:48:06.596] Timer tick, asking Buildbucket for the build status
[19:48:06.767] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:06.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:15:0) after 1m0s
[19:49:06.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:15:0)
[19:49:06.830] Timer tick, asking Buildbucket for the build status
[19:49:06.902] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:06.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:16:0) after 1m0s
[19:50:07.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:16:0)
[19:50:07.233] Timer tick, asking Buildbucket for the build status
[19:50:07.478] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:07.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:17:0) after 1m0s
[19:51:07.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:17:0)
[19:51:07.500] Timer tick, asking Buildbucket for the build status
[19:51:07.670] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:07.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:18:0) after 1m0s
[19:52:07.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:18:0)
[19:52:07.740] Timer tick, asking Buildbucket for the build status
[19:52:07.841] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:07.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:19:0) after 1m0s
[19:53:07.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:19:0)
[19:53:07.908] Timer tick, asking Buildbucket for the build status
[19:53:08.041] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:08.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:20:0) after 1m0s
[19:54:08.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:20:0)
[19:54:08.107] Timer tick, asking Buildbucket for the build status
[19:54:08.183] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:08.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:21:0) after 1m0s
[19:55:08.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:21:0)
[19:55:08.238] Timer tick, asking Buildbucket for the build status
[19:55:08.432] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:22:0) after 1m0s
[19:56:08.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:22:0)
[19:56:08.584] Timer tick, asking Buildbucket for the build status
[19:56:08.823] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:23:0) after 1m0s
[19:57:08.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:23:0)
[19:57:08.994] Timer tick, asking Buildbucket for the build status
[19:57:09.119] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:09.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:24:0) after 1m0s
[19:58:09.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:24:0)
[19:58:09.363] Timer tick, asking Buildbucket for the build status
[19:58:09.848] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:09.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:25:0) after 1m0s
[19:59:10.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:25:0)
[19:59:10.066] Timer tick, asking Buildbucket for the build status
[19:59:10.141] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:10.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:26:0) after 1m0s
[20:00:10.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:26:0)
[20:00:10.224] Timer tick, asking Buildbucket for the build status
[20:00:10.413] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:10.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:27:0) after 1m0s
[20:01:10.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:27:0)
[20:01:10.515] Timer tick, asking Buildbucket for the build status
[20:01:10.649] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:10.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:28:0) after 1m0s
[20:02:10.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:28:0)
[20:02:10.715] Timer tick, asking Buildbucket for the build status
[20:02:10.820] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:10.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:29:0) after 1m0s
[20:03:10.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:29:0)
[20:03:10.917] Timer tick, asking Buildbucket for the build status
[20:03:11.428] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:11.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:30:0) after 1m0s
[20:04:11.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:30:0)
[20:04:11.507] Timer tick, asking Buildbucket for the build status
[20:04:11.631] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:11.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:31:0) after 1m0s
[20:05:11.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:31:0)
[20:05:11.673] Timer tick, asking Buildbucket for the build status
[20:05:11.748] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:11.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:32:0) after 1m0s
[20:06:11.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:32:0)
[20:06:11.786] Timer tick, asking Buildbucket for the build status
[20:06:11.917] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:11.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:33:0) after 1m0s
[20:07:11.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:33:0)
[20:07:11.910] Timer tick, asking Buildbucket for the build status
[20:07:11.971] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:11.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:34:0) after 1m0s
[20:08:12.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:34:0)
[20:08:12.017] Timer tick, asking Buildbucket for the build status
[20:08:13.303] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:13.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:35:0) after 1m0s
[20:09:13.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:35:0)
[20:09:13.471] Timer tick, asking Buildbucket for the build status
[20:09:15.413] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:15.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:36:0) after 1m0s
[20:10:15.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:36:0)
[20:10:15.437] Timer tick, asking Buildbucket for the build status
[20:10:15.715] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:15.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:37:0) after 1m0s
[20:11:15.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:37:0)
[20:11:15.819] Timer tick, asking Buildbucket for the build status
[20:11:16.222] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:16.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:38:0) after 1m0s
[20:12:16.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:38:0)
[20:12:16.314] Timer tick, asking Buildbucket for the build status
[20:12:16.420] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:16.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:39:0) after 1m0s
[20:13:16.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:39:0)
[20:13:16.520] Timer tick, asking Buildbucket for the build status
[20:13:16.977] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:16.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:40:0) after 1m0s
[20:14:17.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:40:0)
[20:14:17.104] Timer tick, asking Buildbucket for the build status
[20:14:17.250] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:17.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:41:0) after 1m0s
[20:15:17.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:41:0)
[20:15:17.267] Timer tick, asking Buildbucket for the build status
[20:15:17.322] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:17.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:42:0) after 1m0s
[20:16:17.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:42:0)
[20:16:17.305] Timer tick, asking Buildbucket for the build status
[20:16:17.567] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:17.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:43:0) after 1m0s
[20:17:17.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:43:0)
[20:17:17.571] Timer tick, asking Buildbucket for the build status
[20:17:17.697] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:17.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:44:0) after 1m0s
[20:18:17.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:44:0)
[20:18:17.802] Timer tick, asking Buildbucket for the build status
[20:18:18.012] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:18.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:45:0) after 1m0s
[20:19:18.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:45:0)
[20:19:18.063] Timer tick, asking Buildbucket for the build status
[20:19:18.406] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:18.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:46:0) after 1m0s
[20:20:18.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:46:0)
[20:20:18.827] Timer tick, asking Buildbucket for the build status
[20:20:18.940] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:18.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:47:0) after 1m0s
[20:21:19.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:47:0)
[20:21:19.108] Timer tick, asking Buildbucket for the build status
[20:21:19.207] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:48:0) after 1m0s
[20:22:19.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:48:0)
[20:22:19.838] Timer tick, asking Buildbucket for the build status
[20:22:19.906] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:19.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:49:0) after 1m0s
[20:23:20.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:49:0)
[20:23:20.203] Timer tick, asking Buildbucket for the build status
[20:23:20.277] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:20.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:50:0) after 1m0s
[20:24:20.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:50:0)
[20:24:20.305] Timer tick, asking Buildbucket for the build status
[20:24:20.531] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:20.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:51:0) after 1m0s
[20:25:20.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:51:0)
[20:25:20.629] Timer tick, asking Buildbucket for the build status
[20:25:20.698] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:20.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:52:0) after 1m0s
[20:26:20.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:52:0)
[20:26:20.807] Timer tick, asking Buildbucket for the build status
[20:26:20.913] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:20.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:53:0) after 1m0s
[20:27:20.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:53:0)
[20:27:20.973] Timer tick, asking Buildbucket for the build status
[20:27:21.097] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:54:0) after 1m0s
[20:28:21.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:54:0)
[20:28:21.161] Timer tick, asking Buildbucket for the build status
[20:28:21.519] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:21.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:55:0) after 1m0s
[20:29:21.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:55:0)
[20:29:21.613] Timer tick, asking Buildbucket for the build status
[20:29:21.698] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:21.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:56:0) after 1m0s
[20:30:21.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:56:0)
[20:30:21.715] Timer tick, asking Buildbucket for the build status
[20:30:21.840] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:21.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:57:0) after 1m0s
[20:31:22.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:57:0)
[20:31:22.023] Timer tick, asking Buildbucket for the build status
[20:31:22.152] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:22.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:58:0) after 1m0s
[20:32:22.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:58:0)
[20:32:22.249] Timer tick, asking Buildbucket for the build status
[20:32:22.402] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:22.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:59:0) after 1m0s
[20:33:22.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:59:0)
[20:33:22.441] Timer tick, asking Buildbucket for the build status
[20:33:22.509] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:22.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:60:0) after 1m0s
[20:34:22.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:60:0)
[20:34:22.626] Timer tick, asking Buildbucket for the build status
[20:34:22.698] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:22.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:61:0) after 1m0s
[20:35:22.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:61:0)
[20:35:22.822] Timer tick, asking Buildbucket for the build status
[20:35:22.896] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:22.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:62:0) after 1m0s
[20:36:22.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:62:0)
[20:36:22.907] Timer tick, asking Buildbucket for the build status
[20:36:23.643] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:23.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:63:0) after 1m0s
[20:37:23.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:63:0)
[20:37:23.748] Timer tick, asking Buildbucket for the build status
[20:37:23.808] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:23.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:64:0) after 1m0s
[20:38:23.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:64:0)
[20:38:23.884] Timer tick, asking Buildbucket for the build status
[20:38:23.946] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:23.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:65:0) after 1m0s
[20:39:24.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:65:0)
[20:39:24.001] Timer tick, asking Buildbucket for the build status
[20:39:24.078] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:24.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:66:0) after 1m0s
[20:40:24.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:66:0)
[20:40:24.134] Timer tick, asking Buildbucket for the build status
[20:40:24.189] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:24.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:67:0) after 1m0s
[20:41:24.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:67:0)
[20:41:24.297] Timer tick, asking Buildbucket for the build status
[20:41:24.416] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:24.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:68:0) after 1m0s
[20:42:24.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:68:0)
[20:42:24.474] Timer tick, asking Buildbucket for the build status
[20:42:24.547] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:24.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:69:0) after 1m0s
[20:43:24.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:69:0)
[20:43:24.584] Timer tick, asking Buildbucket for the build status
[20:43:24.805] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:24.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:70:0) after 1m0s
[20:44:24.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:70:0)
[20:44:24.782] Timer tick, asking Buildbucket for the build status
[20:44:25.034] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:25.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:71:0) after 1m0s
[20:45:25.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:71:0)
[20:45:25.119] Timer tick, asking Buildbucket for the build status
[20:45:25.210] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:25.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:72:0) after 1m0s
[20:46:25.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:72:0)
[20:46:25.243] Timer tick, asking Buildbucket for the build status
[20:46:25.371] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:25.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:73:0) after 1m0s
[20:47:25.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:73:0)
[20:47:25.435] Timer tick, asking Buildbucket for the build status
[20:47:25.503] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:25.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:74:0) after 1m0s
[20:48:25.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:74:0)
[20:48:25.497] Timer tick, asking Buildbucket for the build status
[20:48:25.598] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:25.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:75:0) after 1m0s
[20:49:25.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:75:0)
[20:49:25.621] Timer tick, asking Buildbucket for the build status
[20:49:25.722] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:25.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:76:0) after 1m0s
[20:50:25.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:76:0)
[20:50:25.715] Timer tick, asking Buildbucket for the build status
[20:50:25.818] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:77:0) after 1m0s
[20:51:25.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:77:0)
[20:51:25.895] Timer tick, asking Buildbucket for the build status
[20:51:26.016] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:26.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:78:0) after 1m0s
[20:52:26.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:78:0)
[20:52:26.076] Timer tick, asking Buildbucket for the build status
[20:52:26.204] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:26.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:79:0) after 1m0s
[20:53:26.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:79:0)
[20:53:26.304] Timer tick, asking Buildbucket for the build status
[20:53:26.393] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:26.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:80:0) after 1m0s
[20:54:26.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:80:0)
[20:54:26.492] Timer tick, asking Buildbucket for the build status
[20:54:26.637] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:26.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:81:0) after 1m0s
[20:55:26.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:81:0)
[20:55:26.829] Timer tick, asking Buildbucket for the build status
[20:55:26.899] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:26.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:82:0) after 1m0s
[20:56:26.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:82:0)
[20:56:26.963] Timer tick, asking Buildbucket for the build status
[20:56:27.661] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:27.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:83:0) after 1m0s
[20:57:27.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:83:0)
[20:57:27.699] Timer tick, asking Buildbucket for the build status
[20:57:27.847] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:27.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:84:0) after 1m0s
[20:58:27.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:84:0)
[20:58:27.941] Timer tick, asking Buildbucket for the build status
[20:58:28.064] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:28.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:85:0) after 1m0s
[20:59:28.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:85:0)
[20:59:28.056] Timer tick, asking Buildbucket for the build status
[20:59:28.132] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:28.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:86:0) after 1m0s
[21:00:28.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:86:0)
[21:00:28.331] Timer tick, asking Buildbucket for the build status
[21:00:29.583] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:29.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:87:0) after 1m0s
[21:01:29.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:87:0)
[21:01:29.623] Timer tick, asking Buildbucket for the build status
[21:01:30.101] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:30.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:88:0) after 1m0s
[21:02:30.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:88:0)
[21:02:30.251] Timer tick, asking Buildbucket for the build status
[21:02:30.533] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:30.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:89:0) after 1m0s
[21:03:30.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:89:0)
[21:03:30.660] Timer tick, asking Buildbucket for the build status
[21:03:30.801] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:90:0) after 1m0s
[21:04:30.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:90:0)
[21:04:30.992] Timer tick, asking Buildbucket for the build status
[21:04:31.130] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:31.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:91:0) after 1m0s
[21:05:31.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:91:0)
[21:05:31.271] Timer tick, asking Buildbucket for the build status
[21:05:31.392] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:31.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:92:0) after 1m0s
[21:06:31.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:92:0)
[21:06:31.476] Timer tick, asking Buildbucket for the build status
[21:06:31.718] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:93:0) after 1m0s
[21:07:31.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:93:0)
[21:07:31.752] Timer tick, asking Buildbucket for the build status
[21:07:31.881] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:94:0) after 1m0s
[21:08:31.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:94:0)
[21:08:31.885] Timer tick, asking Buildbucket for the build status
[21:08:32.024] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:32.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:95:0) after 1m0s
[21:09:32.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:95:0)
[21:09:32.028] Timer tick, asking Buildbucket for the build status
[21:09:33.841] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:96:0) after 1m0s
[21:10:33.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:96:0)
[21:10:33.942] Timer tick, asking Buildbucket for the build status
[21:10:34.310] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:34.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:97:0) after 1m0s
[21:11:34.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:97:0)
[21:11:34.374] Timer tick, asking Buildbucket for the build status
[21:11:37.088] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:37.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:98:0) after 1m0s
[21:12:37.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:98:0)
[21:12:37.216] Timer tick, asking Buildbucket for the build status
[21:12:37.857] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:37.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:99:0) after 1m0s
[21:13:37.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:99:0)
[21:13:37.906] Timer tick, asking Buildbucket for the build status
[21:13:38.256] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:38.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:100:0) after 1m0s
[21:14:38.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:100:0)
[21:14:38.319] Timer tick, asking Buildbucket for the build status
[21:14:38.614] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:38.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:101:0) after 1m0s
[21:15:38.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:101:0)
[21:15:38.769] Timer tick, asking Buildbucket for the build status
[21:15:38.968] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:38.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:102:0) after 1m0s
[21:16:39.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:102:0)
[21:16:39.054] Timer tick, asking Buildbucket for the build status
[21:16:39.186] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:103:0) after 1m0s
[21:17:39.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:103:0)
[21:17:39.217] Timer tick, asking Buildbucket for the build status
[21:17:39.569] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:39.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:104:0) after 1m0s
[21:18:39.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:104:0)
[21:18:39.582] Timer tick, asking Buildbucket for the build status
[21:18:39.716] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:39.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:105:0) after 1m0s
[21:19:39.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:105:0)
[21:19:39.772] Timer tick, asking Buildbucket for the build status
[21:19:39.889] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:39.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:106:0) after 1m0s
[21:20:39.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:106:0)
[21:20:39.941] Timer tick, asking Buildbucket for the build status
[21:20:40.132] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:107:0) after 1m0s
[21:21:40.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:107:0)
[21:21:40.216] Timer tick, asking Buildbucket for the build status
[21:21:40.635] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:40.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:108:0) after 1m0s
[21:22:40.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:108:0)
[21:22:40.707] Timer tick, asking Buildbucket for the build status
[21:22:40.842] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:40.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:109:0) after 1m0s
[21:23:40.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:109:0)
[21:23:40.895] Timer tick, asking Buildbucket for the build status
[21:23:41.007] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:41.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:110:0) after 1m0s
[21:24:41.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:110:0)
[21:24:41.050] Timer tick, asking Buildbucket for the build status
[21:24:41.171] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:111:0) after 1m0s
[21:25:41.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:111:0)
[21:25:41.239] Timer tick, asking Buildbucket for the build status
[21:25:41.375] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:112:0) after 1m0s
[21:26:41.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:112:0)
[21:26:41.380] Timer tick, asking Buildbucket for the build status
[21:26:41.545] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:41.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:113:0) after 1m0s
[21:27:41.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:113:0)
[21:27:41.571] Timer tick, asking Buildbucket for the build status
[21:27:41.699] Build 8863446896598359360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:41.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028876961045451744:114:0) after 1m0s
[21:28:00.659] Received PubSub notification, asking Buildbucket for the build status
[21:28:00.782] Build 8863446896598359360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:28:00.782] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1605562077936964",
"created_by": "project:chromium",
"created_ts": "1605555362091380",
"id": "8863446896598359360",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c25c700a2a603deff803eaa8d3d8d94c0a053e91\"}}",
"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\": \"c25c700a2a603deff803eaa8d3d8d94c0a053e91\", \"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-49-iyoq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42917, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"dd6b36e8801ebeee53342c295fb56812504db80d\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"c25c700a2a603deff803eaa8d3d8d94c0a053e91\", \"got_revision_cp\": \"refs/heads/master@{#827861}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"8dceaddf8503b9a83e07ff7788b3edfbb0d9665a\", \"got_v8_revision\": \"cfb8bc492eb44482518665f7d1013d3c2e8f5000\", \"got_v8_revision_cp\": \"refs/heads/8.9.1@{#1}\", \"got_webrtc_revision\": \"02736010cb171c3cc36ea2039911a6dadec9952d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32613}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c25c700a2a603deff803eaa8d3d8d94c0a053e91\", \"swarm_hashes_refs/heads/master(at){#827861}_without_patch\": {\"absl_hardening_tests\": \"0a7ed325f385abb22e45deed8cd1c121b719bba3\", \"accessibility_unittests\": \"aadebb9f4eabc7595b541844cf553cab42c4b3fa\", \"angle_unittests\": \"2e56b43b83ae58faf3baf59d92354c343a9d1549\", \"app_list_unittests\": \"19294f40034f6d4c0f04beb2a9b5d24bbbdbecb8\", \"app_shell_unittests\": \"175c6d96550e96850c758bd2d2d82cb9cfff771b\", \"ash_unittests\": \"f0afbd780140bf6568114b8fa56e08a8ee2f721a\", \"aura_unittests\": \"bf13e934463165550b25b4ba82ba4d8497f5c5d9\", \"base_unittests\": \"8053444cb6208421144ce2406744d3f22b9500cf\", \"base_util_unittests\": \"fa310b93176d728c4d4380ff386b5444fe4f5155\", \"blink_common_unittests\": \"ce1e43797b0dbdd5e4cfe778f55db91988cfc356\", \"blink_fuzzer_unittests\": \"cb181312062b99bfc4475c6243273cb5874a9f4e\", \"blink_heap_unittests\": \"626c961ff81ca9c80739ddf8068fa4c54e366106\", \"blink_platform_unittests\": \"bb17b7ebacdb62283adc4aa20f58b042b0b54fa0\", \"blink_unittests\": \"bc3ed3141471de3c81fa18eeaba436facb4d36e0\", \"boringssl_crypto_tests\": \"2b6f7fe50b3bc4e3934df0fbd17c8ff5aeaa08ef\", \"boringssl_ssl_tests\": \"3e5b35210200aeae0e91ed21ea27039529c4161c\", \"browser_tests\": \"b738eb76fb9bc3edb576ff2e02095e1f4cb07105\", \"capture_unittests\": \"f1876d5b3885eadf6ce499d75714a71c7472b213\", \"cast_unittests\": \"db0c25c2d54fa833aaf38b1b2e53019224404c1b\", \"cc_unittests\": \"b628a403b6122ffb672447bf61e93f8636e1e3ee\", \"chrome_app_unittests\": \"4afc83e25505246747b14d413059d1c65c83c6e4\", \"chromedriver_unittests\": \"569c544018aa365c472220a4c0af831a8a10d95a\", \"chromeos_components_unittests\": \"48b7bd7a5ad35c7ae544a024a3b5c6ee83878452\", \"chromeos_unittests\": \"9001e9c2ab08a493d92927d02532ffc8dc7b08ef\", \"components_browsertests\": \"dcb2aa3b84e166c1d4fa64f456f957d14de1dadb\", \"components_unittests\": \"b0a8f077badabdea8d374da23a8bd40e4b6b9f7e\", \"compositor_unittests\": \"a3eabcd1ba3a90da0bdc0aca2101f85a1fb1ec16\", \"content_browsertests\": \"d4dcdee8b0cd19a681617008ba21a9ea5e407ad2\", \"content_unittests\": \"3f4483282533ddd9203aa335cafe6f0b036b15d1\", \"crashpad_tests\": \"2a15c1b1e6eb172f3fba0975ed71eac8ea4ba214\", \"crypto_unittests\": \"3e2a49230c5ff7c5e62479b765a745dd8ed53e4c\", \"dbus_unittests\": \"a01cc5726d8df4163ea601647d1be126ae694ffb\", \"device_unittests\": \"20e09cb23af98a73ee43a171f08d45fd600388db\", \"display_unittests\": \"20e12c1bbdba1926a4b1ba3a28d8337a888805bc\", \"events_unittests\": \"c83c4baf8582f7d9f7ca38e8f27c57e14081b5a7\", \"exo_unittests\": \"f639d57da8c97554084b132620065826fd085f93\", \"extensions_browsertests\": \"3f53325a4193beca00a67d14f5b96c2852821b16\", \"extensions_unittests\": \"262ee3032d7a738e5bc024ffb9abbc672821aa85\", \"filesystem_service_unittests\": \"e4a2669c3d06340c0b73db9b30f4ec336341bc8d\", \"gcm_unit_tests\": \"fd27bca2cf2b292d1f263f0fdae80b4be9338f12\", \"gfx_unittests\": \"e440fcfeca9192595af96948580332d062bd8083\", \"gin_unittests\": \"777d5369fa81fdcc33302ddc4394250772744f43\", \"gl_unittests_ozone\": \"72c274aae9da141cd6c0d8086b84edd3cf11677d\", \"google_apis_unittests\": \"15c400c9c10f7f551552305494681db526e9d25e\", \"gpu_unittests\": \"0d1e82fee74f62aab044fa6aecb915b2bf8e00a7\", \"gwp_asan_unittests\": \"1d6d1ea7fea702eed250c9b756ee6bfad66c4312\", \"interactive_ui_tests\": \"6317e2508b8b831d3948baba4544db688ead3ae6\", \"ipc_tests\": \"1261a9a6a83b9f694d5fdda802dce60febaed020\", \"jingle_unittests\": \"75d6bdf151c98ac01b0aca2a8e0e084cc3ff061c\", \"keyboard_unittests\": \"39527c93e8fabc01f3a1c8b1a2769818067e4893\", \"latency_unittests\": \"d5b5b733a9dc05ef3e8db764a1be957594e755c8\", \"libjingle_xmpp_unittests\": \"5bd5242cde11bff3896005bf86191a8004ed8b24\", \"liburlpattern_unittests\": \"ae6e9a171b015aea2adebaa6885e2d6f9777ce90\", \"media_blink_unittests\": \"4d906cc74cc779fb48db87720cf6da249e22ef48\", \"media_unittests\": \"3962b1351405c19e26400fbf46fe21bc003ca130\", \"message_center_unittests\": \"9761808d3d4a603c75d85ce6a0248233259e87b4\", \"midi_unittests\": \"e365751727ed4e37d84dd02c1b343ef79090e041\", \"mojo_core_unittests\": \"bc9d162ae0b23c61f98b787c64f7230a483e9726\", \"mojo_unittests\": \"fbac888f75e11b564d0a309b916da04d5af436db\", \"nacl_helper_nonsfi_unittests\": \"8ca28756d52fe7b1b0b46cdd99eb03e480b5e60d\", \"nacl_loader_unittests\": \"135f78f107a3433c724683af99f304733a8143a4\", \"native_theme_unittests\": \"f95e4d3ff27efcb928e9ac51cc22c9dad41a161d\", \"net_unittests\": \"e2d9dd8d6c24c8bd435bfc05680b338e0014a28a\", \"ozone_gl_unittests\": \"194d4b55994500e2f4aa7c82a5ebf98668793cc4\", \"ozone_unittests\": \"90f9fe2e51d8a7bd8d60e278ef13afc2b61790c6\", \"ozone_x11_unittests\": \"b025094ba29fd07bcfe4d03703fe1d875d3ec495\", \"pdf_unittests\": \"56ac17d190a383b97803a57e16962baa00cf893d\", \"perfetto_unittests\": \"4e23c1e52e9b47999e6de6abc87d6fdf49b0cd46\", \"ppapi_unittests\": \"7c66b96945afdda0bfdadc3cd72af8a7a25e47d9\", \"printing_unittests\": \"f78f75aa39fc978914e736cf1a589760d11aa270\", \"remoting_unittests\": \"41bd939fb9201efcad97bf922da6527ccf34a0e0\", \"sandbox_linux_unittests\": \"4fa742d6be2669ab064376771d50619f61ac7479\", \"service_manager_unittests\": \"973d8300cca1bd504d19d871ffe29831a06e564c\", \"services_unittests\": \"7f1ba834a8425d0e906ab5851ca72768041d25d4\", \"shell_dialogs_unittests\": \"6f076b8a6ca9f7d145c74ee3e8332f6abef2cf09\", \"skia_unittests\": \"b5556e65a793a86232f50a1616eb53bbf7db67de\", \"snapshot_unittests\": \"060163a01b8d1925a72b5ebd64456ddec041ca68\", \"sql_unittests\": \"8c428cfbdd09d0a2cb3d8508d28ed2d04d5c5223\", \"storage_unittests\": \"6fcba9b5ecc294ce217a6174f07ce417eb78ed73\", \"sync_integration_tests\": \"afe9d6a35efcbf00497ac4e39d3c40e27d7afb51\", \"traffic_annotation_auditor_unittests\": \"33ec3b90f46f7633f01448a6ffaef4cbc5007761\", \"ui_base_unittests\": \"1895d1b97049c0fe3ea44de10986d9eeea331d52\", \"ui_chromeos_unittests\": \"faba36aacd8f9121db518cf3e1f2410fd31b81d4\", \"ui_touch_selection_unittests\": \"528de004850cdd8f8caa1f65c8595e867f52b232\", \"unit_tests\": \"16002d50015005a287cbe09726ea850198e88c4c\", \"url_unittests\": \"d68a57b657d436221700fafa047b0677d5b81450\", \"usage_time_limit_unittests\": \"d48247926d6222178c98027b05108554c3581a2c\", \"views_unittests\": \"ec6eaef9edbd50ff31b0a0891d46ca49c97d43d0\", \"viz_unittests\": \"48f1dfac423de665f146f5d76ac850de44c0e889\", \"wayland_client_perftests\": \"9c13e554ac004163557124241655014840651b6a\", \"wm_unittests\": \"00419911c7917448599cff14a608ec98315591ab\", \"wtf_unittests\": \"09adc3612fcb05e96ea4be18d3a7a618a6b6b6e4\", \"zlib_unittests\": \"6d709a8abccf0befc4478375943f759b7c65e9b9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_544ce64b59aa2a62f93b2d1058d8c643105c17650fa0dc2da4c94ddccafb95f6_v2\", \"builder_610249d4c77a3c22380a2d62e63da2e6a3b68e35e0d635af660df3bc7adf4210_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-49-iyoq\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605555619724250",
"status": "COMPLETED",
"status_changed_ts": "1605562078253930",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42917",
"builder:linux-chromeos-rel",
"buildset:commit/git/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c25c700a2a603deff803eaa8d3d8d94c0a053e91",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028876961045451744",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863446896598359360/+/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:4feb6026e2c6af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605562078259482",
"url": "https://ci.chromium.org/b/8863446896598359360",
"utcnow_ts": "1605562080763729"
}
}
[21:28:00.782] Invocation finished in 1h52m2.31583418s with status SUCCEEDED