[00:28:03.014] New invocation is queued and will start shortly
[00:28:04.135] Starting the invocation (attempt 1)
[00:28:04.196] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:28:04.196] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:28:04.196] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018621128037702192",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"612565978308dba6ff6a41d47e3f5e77b0bbb94e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018621128037702192",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"gitiles_ref:refs/heads/master"
]
}
[00:28:05.751] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615336084344965",
"id": "8853191065981659776",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"612565978308dba6ff6a41d47e3f5e77b0bbb94e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615336085434808",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46032",
"builder:linux-chromeos-rel",
"buildset:commit/git/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018621128037702192",
"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/8853191065981659776/+/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": "1615336085434904",
"url": "https://ci.chromium.org/b/8853191065981659776",
"utcnow_ts": "1615336085734404"
}
}
[00:28:05.751] Task URL: https://ci.chromium.org/b/8853191065981659776
[00:28:05.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:2:0) after 1m0s
[00:29:05.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:2:0)
[00:29:05.768] Timer tick, asking Buildbucket for the build status
[00:29:05.955] Build 8853191065981659776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:05.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:3:0) after 1m0s
[00:30:05.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:3:0)
[00:30:05.971] Timer tick, asking Buildbucket for the build status
[00:30:06.040] Build 8853191065981659776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:06.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:4:0) after 1m0s
[00:31:06.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:4:0)
[00:31:06.065] Timer tick, asking Buildbucket for the build status
[00:31:06.628] Build 8853191065981659776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:06.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:5:0) after 1m0s
[00:32:06.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:5:0)
[00:32:06.676] Timer tick, asking Buildbucket for the build status
[00:32:07.224] Build 8853191065981659776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:07.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:6:0) after 1m0s
[00:33:07.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:6:0)
[00:33:07.317] Timer tick, asking Buildbucket for the build status
[00:33:07.398] Build 8853191065981659776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:07.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:7:0) after 1m0s
[00:33:08.460] Received PubSub notification, asking Buildbucket for the build status
[00:33:08.535] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:07.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:7:0)
[00:34:07.532] Timer tick, asking Buildbucket for the build status
[00:34:07.596] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:07.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:9:0) after 1m0s
[00:35:07.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:9:0)
[00:35:07.753] Timer tick, asking Buildbucket for the build status
[00:35:07.843] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:07.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:10:0) after 1m0s
[00:36:08.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:10:0)
[00:36:08.020] Timer tick, asking Buildbucket for the build status
[00:36:08.093] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:08.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:11:0) after 1m0s
[00:37:08.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:11:0)
[00:37:08.227] Timer tick, asking Buildbucket for the build status
[00:37:08.530] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:08.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:12:0) after 1m0s
[00:38:08.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:12:0)
[00:38:08.742] Timer tick, asking Buildbucket for the build status
[00:38:08.836] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:13:0) after 1m0s
[00:39:08.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:13:0)
[00:39:08.934] Timer tick, asking Buildbucket for the build status
[00:39:09.165] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:09.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:14:0) after 1m0s
[00:40:09.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:14:0)
[00:40:09.204] Timer tick, asking Buildbucket for the build status
[00:40:09.348] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:09.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:15:0) after 1m0s
[00:41:09.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:15:0)
[00:41:09.370] Timer tick, asking Buildbucket for the build status
[00:41:09.428] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:09.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:16:0) after 1m0s
[00:42:10.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:16:0)
[00:42:10.093] Timer tick, asking Buildbucket for the build status
[00:42:10.165] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:10.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:17:0) after 1m0s
[00:43:10.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:17:0)
[00:43:10.203] Timer tick, asking Buildbucket for the build status
[00:43:10.281] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:10.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:18:0) after 1m0s
[00:44:10.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:18:0)
[00:44:10.304] Timer tick, asking Buildbucket for the build status
[00:44:11.062] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:11.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:19:0) after 1m0s
[00:45:11.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:19:0)
[00:45:11.113] Timer tick, asking Buildbucket for the build status
[00:45:11.262] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:11.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:20:0) after 1m0s
[00:46:11.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:20:0)
[00:46:11.337] Timer tick, asking Buildbucket for the build status
[00:46:11.408] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:11.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:21:0) after 1m0s
[00:47:11.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:21:0)
[00:47:11.473] Timer tick, asking Buildbucket for the build status
[00:47:11.540] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:11.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:22:0) after 1m0s
[00:48:11.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:22:0)
[00:48:11.560] Timer tick, asking Buildbucket for the build status
[00:48:11.836] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:11.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:23:0) after 1m0s
[00:49:11.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:23:0)
[00:49:11.878] Timer tick, asking Buildbucket for the build status
[00:49:11.941] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:11.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:24:0) after 1m0s
[00:50:12.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:24:0)
[00:50:12.016] Timer tick, asking Buildbucket for the build status
[00:50:12.144] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:12.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:25:0) after 1m0s
[00:51:12.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:25:0)
[00:51:12.242] Timer tick, asking Buildbucket for the build status
[00:51:12.306] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:12.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:26:0) after 1m0s
[00:52:12.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:26:0)
[00:52:12.367] Timer tick, asking Buildbucket for the build status
[00:52:12.870] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:12.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:27:0) after 1m0s
[00:53:12.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:27:0)
[00:53:12.922] Timer tick, asking Buildbucket for the build status
[00:53:13.006] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:13.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:28:0) after 1m0s
[00:54:13.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:28:0)
[00:54:13.074] Timer tick, asking Buildbucket for the build status
[00:54:13.173] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:13.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:29:0) after 1m0s
[00:55:13.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:29:0)
[00:55:13.333] Timer tick, asking Buildbucket for the build status
[00:55:13.452] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:13.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:30:0) after 1m0s
[00:56:13.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:30:0)
[00:56:13.583] Timer tick, asking Buildbucket for the build status
[00:56:13.663] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:13.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:31:0) after 1m0s
[00:57:13.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:31:0)
[00:57:13.689] Timer tick, asking Buildbucket for the build status
[00:57:13.935] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:13.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:32:0) after 1m0s
[00:58:14.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:32:0)
[00:58:14.012] Timer tick, asking Buildbucket for the build status
[00:58:14.311] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:14.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:33:0) after 1m0s
[00:59:14.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:33:0)
[00:59:14.404] Timer tick, asking Buildbucket for the build status
[00:59:14.494] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:14.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:34:0) after 1m0s
[01:00:14.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:34:0)
[01:00:14.679] Timer tick, asking Buildbucket for the build status
[01:00:15.136] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:15.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:35:0) after 1m0s
[01:01:15.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:35:0)
[01:01:15.220] Timer tick, asking Buildbucket for the build status
[01:01:15.545] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:15.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:36:0) after 1m0s
[01:02:15.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:36:0)
[01:02:15.658] Timer tick, asking Buildbucket for the build status
[01:02:15.721] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:15.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:37:0) after 1m0s
[01:03:15.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:37:0)
[01:03:15.789] Timer tick, asking Buildbucket for the build status
[01:03:15.985] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:15.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:38:0) after 1m0s
[01:04:16.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:38:0)
[01:04:16.107] Timer tick, asking Buildbucket for the build status
[01:04:16.229] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:16.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:39:0) after 1m0s
[01:05:16.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:39:0)
[01:05:16.254] Timer tick, asking Buildbucket for the build status
[01:05:16.330] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:16.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:40:0) after 1m0s
[01:06:16.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:40:0)
[01:06:16.512] Timer tick, asking Buildbucket for the build status
[01:06:16.653] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:41:0) after 1m0s
[01:07:16.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:41:0)
[01:07:16.755] Timer tick, asking Buildbucket for the build status
[01:07:16.924] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:16.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:42:0) after 1m0s
[01:08:16.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:42:0)
[01:08:16.934] Timer tick, asking Buildbucket for the build status
[01:08:17.054] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:17.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:43:0) after 1m0s
[01:09:17.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:43:0)
[01:09:17.108] Timer tick, asking Buildbucket for the build status
[01:09:17.188] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:44:0) after 1m0s
[01:10:17.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:44:0)
[01:10:17.269] Timer tick, asking Buildbucket for the build status
[01:10:17.352] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:45:0) after 1m0s
[01:11:17.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:45:0)
[01:11:17.508] Timer tick, asking Buildbucket for the build status
[01:11:17.902] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:17.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:46:0) after 1m0s
[01:12:18.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:46:0)
[01:12:18.063] Timer tick, asking Buildbucket for the build status
[01:12:18.214] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:18.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:47:0) after 1m0s
[01:13:18.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:47:0)
[01:13:18.298] Timer tick, asking Buildbucket for the build status
[01:13:18.556] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:18.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:48:0) after 1m0s
[01:14:18.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:48:0)
[01:14:18.648] Timer tick, asking Buildbucket for the build status
[01:14:18.907] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:49:0) after 1m0s
[01:15:19.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:49:0)
[01:15:19.219] Timer tick, asking Buildbucket for the build status
[01:15:19.341] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:19.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:50:0) after 1m0s
[01:16:19.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:50:0)
[01:16:19.389] Timer tick, asking Buildbucket for the build status
[01:16:19.566] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:19.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:51:0) after 1m0s
[01:17:19.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:51:0)
[01:17:19.625] Timer tick, asking Buildbucket for the build status
[01:17:19.681] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:19.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:52:0) after 1m0s
[01:18:19.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:52:0)
[01:18:19.799] Timer tick, asking Buildbucket for the build status
[01:18:19.875] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:53:0) after 1m0s
[01:19:19.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:53:0)
[01:19:19.998] Timer tick, asking Buildbucket for the build status
[01:19:20.087] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:54:0) after 1m0s
[01:20:20.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:54:0)
[01:20:20.154] Timer tick, asking Buildbucket for the build status
[01:20:20.229] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:55:0) after 1m0s
[01:21:20.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:55:0)
[01:21:20.338] Timer tick, asking Buildbucket for the build status
[01:21:20.403] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:20.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:56:0) after 1m0s
[01:22:20.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:56:0)
[01:22:20.616] Timer tick, asking Buildbucket for the build status
[01:22:20.843] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:20.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:57:0) after 1m0s
[01:23:20.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:57:0)
[01:23:20.960] Timer tick, asking Buildbucket for the build status
[01:23:21.065] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:21.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:58:0) after 1m0s
[01:24:21.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:58:0)
[01:24:21.110] Timer tick, asking Buildbucket for the build status
[01:24:21.173] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:21.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:59:0) after 1m0s
[01:25:21.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:59:0)
[01:25:21.265] Timer tick, asking Buildbucket for the build status
[01:25:21.326] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:21.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:60:0) after 1m0s
[01:26:21.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:60:0)
[01:26:21.349] Timer tick, asking Buildbucket for the build status
[01:26:21.411] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:21.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:61:0) after 1m0s
[01:27:21.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:61:0)
[01:27:21.442] Timer tick, asking Buildbucket for the build status
[01:27:21.592] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:21.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:62:0) after 1m0s
[01:28:21.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:62:0)
[01:28:21.693] Timer tick, asking Buildbucket for the build status
[01:28:21.771] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:21.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:63:0) after 1m0s
[01:29:21.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:63:0)
[01:29:21.813] Timer tick, asking Buildbucket for the build status
[01:29:21.885] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:64:0) after 1m0s
[01:30:21.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:64:0)
[01:30:21.990] Timer tick, asking Buildbucket for the build status
[01:30:22.082] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:22.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:65:0) after 1m0s
[01:31:22.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:65:0)
[01:31:22.110] Timer tick, asking Buildbucket for the build status
[01:31:22.187] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:22.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:66:0) after 1m0s
[01:32:22.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:66:0)
[01:32:22.215] Timer tick, asking Buildbucket for the build status
[01:32:22.507] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:22.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:67:0) after 1m0s
[01:33:22.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:67:0)
[01:33:22.506] Timer tick, asking Buildbucket for the build status
[01:33:22.604] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:22.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:68:0) after 1m0s
[01:34:22.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:68:0)
[01:34:22.727] Timer tick, asking Buildbucket for the build status
[01:34:22.794] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:69:0) after 1m0s
[01:35:22.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:69:0)
[01:35:22.839] Timer tick, asking Buildbucket for the build status
[01:35:22.937] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:22.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:70:0) after 1m0s
[01:36:23.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:70:0)
[01:36:23.110] Timer tick, asking Buildbucket for the build status
[01:36:23.185] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:23.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:71:0) after 1m0s
[01:37:23.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:71:0)
[01:37:23.237] Timer tick, asking Buildbucket for the build status
[01:37:23.613] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:23.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:72:0) after 1m0s
[01:38:23.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:72:0)
[01:38:23.633] Timer tick, asking Buildbucket for the build status
[01:38:23.727] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:23.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:73:0) after 1m0s
[01:39:23.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:73:0)
[01:39:23.818] Timer tick, asking Buildbucket for the build status
[01:39:23.896] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:74:0) after 1m0s
[01:40:23.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:74:0)
[01:40:23.928] Timer tick, asking Buildbucket for the build status
[01:40:24.211] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:24.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:75:0) after 1m0s
[01:41:24.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:75:0)
[01:41:24.319] Timer tick, asking Buildbucket for the build status
[01:41:24.461] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:24.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:76:0) after 1m0s
[01:42:24.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:76:0)
[01:42:24.685] Timer tick, asking Buildbucket for the build status
[01:42:24.830] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:24.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:77:0) after 1m0s
[01:43:24.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:77:0)
[01:43:24.966] Timer tick, asking Buildbucket for the build status
[01:43:25.057] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:25.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:78:0) after 1m0s
[01:44:25.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:78:0)
[01:44:25.095] Timer tick, asking Buildbucket for the build status
[01:44:25.168] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:25.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:79:0) after 1m0s
[01:45:25.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:79:0)
[01:45:25.217] Timer tick, asking Buildbucket for the build status
[01:45:25.389] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:25.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:80:0) after 1m0s
[01:46:25.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:80:0)
[01:46:25.452] Timer tick, asking Buildbucket for the build status
[01:46:25.623] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:25.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:81:0) after 1m0s
[01:47:25.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:81:0)
[01:47:25.744] Timer tick, asking Buildbucket for the build status
[01:47:25.803] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:25.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:82:0) after 1m0s
[01:48:25.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:82:0)
[01:48:25.892] Timer tick, asking Buildbucket for the build status
[01:48:25.980] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:25.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:83:0) after 1m0s
[01:49:26.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:83:0)
[01:49:26.141] Timer tick, asking Buildbucket for the build status
[01:49:26.206] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:84:0) after 1m0s
[01:50:26.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:84:0)
[01:50:26.233] Timer tick, asking Buildbucket for the build status
[01:50:26.334] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:26.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:85:0) after 1m0s
[01:51:26.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:85:0)
[01:51:26.355] Timer tick, asking Buildbucket for the build status
[01:51:26.619] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:26.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:86:0) after 1m0s
[01:52:26.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:86:0)
[01:52:26.672] Timer tick, asking Buildbucket for the build status
[01:52:26.839] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:26.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:87:0) after 1m0s
[01:53:26.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:87:0)
[01:53:26.933] Timer tick, asking Buildbucket for the build status
[01:53:27.229] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:27.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:88:0) after 1m0s
[01:54:27.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:88:0)
[01:54:27.214] Timer tick, asking Buildbucket for the build status
[01:54:27.296] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:27.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:89:0) after 1m0s
[01:55:27.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:89:0)
[01:55:27.327] Timer tick, asking Buildbucket for the build status
[01:55:27.410] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:27.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:90:0) after 1m0s
[01:56:27.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:90:0)
[01:56:27.428] Timer tick, asking Buildbucket for the build status
[01:56:27.708] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:27.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:91:0) after 1m0s
[01:57:27.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:91:0)
[01:57:27.732] Timer tick, asking Buildbucket for the build status
[01:57:27.944] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:27.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:92:0) after 1m0s
[01:58:28.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:92:0)
[01:58:28.002] Timer tick, asking Buildbucket for the build status
[01:58:28.094] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:28.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:93:0) after 1m0s
[01:59:28.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:93:0)
[01:59:28.122] Timer tick, asking Buildbucket for the build status
[01:59:28.436] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:28.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:94:0) after 1m0s
[02:00:28.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:94:0)
[02:00:28.441] Timer tick, asking Buildbucket for the build status
[02:00:28.536] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:28.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:95:0) after 1m0s
[02:01:28.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:95:0)
[02:01:28.575] Timer tick, asking Buildbucket for the build status
[02:01:28.678] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:28.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:96:0) after 1m0s
[02:02:28.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:96:0)
[02:02:28.690] Timer tick, asking Buildbucket for the build status
[02:02:29.016] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:29.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:97:0) after 1m0s
[02:03:29.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:97:0)
[02:03:29.037] Timer tick, asking Buildbucket for the build status
[02:03:29.539] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:29.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:98:0) after 1m0s
[02:04:29.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:98:0)
[02:04:29.551] Timer tick, asking Buildbucket for the build status
[02:04:29.871] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:29.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:99:0) after 1m0s
[02:05:29.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:99:0)
[02:05:29.940] Timer tick, asking Buildbucket for the build status
[02:05:30.548] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:30.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:100:0) after 1m0s
[02:06:30.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:100:0)
[02:06:30.594] Timer tick, asking Buildbucket for the build status
[02:06:30.717] Build 8853191065981659776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:30.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018621128037702192:101:0) after 1m0s
[02:06:33.150] Received PubSub notification, asking Buildbucket for the build status
[02:06:33.224] Build 8853191065981659776: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:06:33.224] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615341991868645",
"created_by": "project:chromium",
"created_ts": "1615336084344965",
"failure_reason": "BUILD_FAILURE",
"id": "8853191065981659776",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"612565978308dba6ff6a41d47e3f5e77b0bbb94e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/PrerenderBrowserTest.PrerenderedPageCrossSiteNavigation/WebContents\"}, \"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\": \"612565978308dba6ff6a41d47e3f5e77b0bbb94e\", \"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-115-iywj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46032, \"got_angle_revision\": \"2b7fdb62837eb5de4fede39f62c2d554b16cdbd5\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"612565978308dba6ff6a41d47e3f5e77b0bbb94e\", \"got_revision_cp\": \"refs/heads/master@{#861356}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"b3b47599bf78d3b7869f92c17edc5cd0ec216acf\", \"got_v8_revision_cp\": \"refs/heads/9.1.84@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"612565978308dba6ff6a41d47e3f5e77b0bbb94e\", \"swarm_hashes_refs/heads/master(at){#861356}_without_patch\": {\"absl_hardening_tests\": \"faa6c6e2ca8272e71da8d84adcae20a98b34f383\", \"accessibility_unittests\": \"fc8039a0bda3fe473eb255883cd7595bc509c5fe\", \"angle_unittests\": \"ba4a3d338bc6472a528a30d99920739357e83697\", \"app_list_unittests\": \"50a2926c1c9fd7bc4b1c7a7ca5d0d7ec5596cd01\", \"app_shell_unittests\": \"5d30ad09984aac9cbc09a09588d878d24d5e88bd\", \"ash_unittests\": \"4b840b55b3d01f6127c5c99c8a756c94279b74d0\", \"aura_unittests\": \"3a1e623eed505a63e475c120acf9f08b2d6abcbd\", \"base_unittests\": \"76ec76b99fd89d736b0abf9e02541178881c259b\", \"base_util_unittests\": \"730530b4266280db377facc948ab98bdf8398088\", \"blink_common_unittests\": \"8614576a2d83eb0acfeddc924b7f626c0f131b28\", \"blink_fuzzer_unittests\": \"6b3fe46c2acf2a4bfd429b469340b2b9dc756f87\", \"blink_heap_unittests\": \"4510f6582048d772755fabace7f4e5384fcf314f\", \"blink_platform_unittests\": \"322693539d5883d2a84f9a6728edbad78af711bc\", \"blink_unittests\": \"0f9d8a8e1f0d5b055fc1606c5ae3c1ee947e3a0b\", \"boringssl_crypto_tests\": \"b0f358aab8631a11468f6db1959dedbd2a043426\", \"boringssl_ssl_tests\": \"e76c85eaa906057c8e520fdb714d1e1ae40bff71\", \"browser_tests\": \"ff10144a590f6914a928c79d6c489af6fa3f2857\", \"capture_unittests\": \"7b99691ec2c162a27e79237796a2dc94ad7e90b4\", \"cast_unittests\": \"354c68034c7fe21fdb38ffc8f76bd4c5cf45ce7c\", \"cc_unittests\": \"f4ef11c1533569bde3f54a4899e6f56c06f88d06\", \"chrome_app_unittests\": \"e2c5559029288d91b3bcf7803de3147aa04eb485\", \"chromedriver_unittests\": \"ee7ef7069578d9c171b27a8a7770b0978c406ab7\", \"chromeos_components_unittests\": \"1da0d6097836fa6ec77c33afadb32baebe74a34c\", \"chromeos_unittests\": \"41f45f27755efcbc0baf42a0dae358ff77210020\", \"color_unittests\": \"7b2dff9d2c351e928fff371c6979ba910beee5c4\", \"components_browsertests\": \"cd26cc3e6f2672716632830755809f205c93bf3b\", \"components_unittests\": \"200a95934e25772930a34c3a8e5ac7822f326634\", \"compositor_unittests\": \"0ff86f5a10fa65413818cdbcb126d044f1543c73\", \"content_browsertests\": \"a1297c6e5ca9ce970bcae32130f8a02eb0f98e2b\", \"content_unittests\": \"202d43d83d0901d26335bad8f3d851d2a1223ea3\", \"crashpad_tests\": \"b146284e02e7e1ae707fd78adc892e9e3e4f9735\", \"crypto_unittests\": \"23c880be37f2352b81ac2067c27beb6c876dbacc\", \"dbus_unittests\": \"e0ad501b055a18c80bce87ee105a9d5e688ebae5\", \"device_unittests\": \"5f745503d6fcf050555a9e6ad0eaf77b93bcc975\", \"display_unittests\": \"9de0bb7a666b353ac84392bb770cca3defca13b2\", \"events_unittests\": \"b09a5bd34e9a54ee6ed6fae336a7d4380c271d82\", \"exo_unittests\": \"9b6c7e3492437dfc2e17130efd26d25fb309d04a\", \"extensions_browsertests\": \"a7dcbecfd9e37f548f50eea5c50d3a83cb09661a\", \"extensions_unittests\": \"0684100520309f3b3f3fe84a105c5acbc0697ffe\", \"filesystem_service_unittests\": \"646241f486cad25a351675554edceb53924d4e50\", \"gcm_unit_tests\": \"66fa9dda6c36b14d9f4c936c882ddbab54b7852e\", \"gfx_unittests\": \"e43eff477bd67a45f26d5e1332b7fd8f4acf6668\", \"gin_unittests\": \"88698a650df630a197cbdc189ae5ec002ca2f619\", \"gl_unittests_ozone\": \"51a1c9607d3210f2d745441843656a15561fcd8e\", \"google_apis_unittests\": \"5cd8dbed4aac772aefd10b00b8cb32f73377632f\", \"gpu_unittests\": \"009e93fb03c78f6112374714b7cf44f370791efb\", \"gwp_asan_unittests\": \"30579af2875f808adeed519005d45d08c2f29106\", \"interactive_ui_tests\": \"ababb2765ba9141e202659cd757777a2f311d368\", \"ipc_tests\": \"9a6a21180304e35922cb8738d40313a80ef763da\", \"jingle_unittests\": \"0626a84695e51f3d6920cbb9d762c5be4e61f2f9\", \"keyboard_unittests\": \"084ab4aabd038ac0b44dfbe126a01f60bac62fc5\", \"latency_unittests\": \"294114989c8610cf9a6bd6f1f3a18399d66c889e\", \"libjingle_xmpp_unittests\": \"642027b586d25084640e249827242f3344e5a0bb\", \"liburlpattern_unittests\": \"19a6ec1b58325db8491040b011c8ff2a44baa504\", \"media_blink_unittests\": \"3fb08e97f07835b2e32bc3932da5b36824594aea\", \"media_unittests\": \"91ffff3a58f3a30b02eb05ce9b5db10b26373a57\", \"message_center_unittests\": \"57dfa1b1979a9775368697c4ebfc8f4419eb1ec6\", \"midi_unittests\": \"ecbc7857f3022a0577cd4a15af4550d5fb3407a3\", \"mojo_core_unittests\": \"a2cb9ead7e1cc496436d010d6ffa181ff48beddf\", \"mojo_unittests\": \"23bcc530f3c6d22249eacea8b0bf0dce1b467916\", \"nacl_helper_nonsfi_unittests\": \"0ab2cfb6b1ef426c0e1bdcaf911ef3dfac961eef\", \"nacl_loader_unittests\": \"351a48072f4f94101ab1d796ad0163d2c95ab969\", \"native_theme_unittests\": \"d3ba49b0da8a50d11d901050acc17dc0a033e675\", \"net_unittests\": \"ae72828f1aecc31e013cd0046a7b3978fe409f21\", \"ozone_gl_unittests\": \"1b5d4558b6a97a3a0c52f10a15d76ae75fcdce87\", \"ozone_unittests\": \"fa971232d1966e54cd41aee827c33cae7bbb023e\", \"ozone_x11_unittests\": \"95c6ba8b96cc3b98160a782bc0859970961d3f02\", \"pdf_unittests\": \"2bc05a2a5c9da6a63b6deaf5bc0cbed429e20d71\", \"perfetto_unittests\": \"65528b4e690d6659fb4440ce032403f587114a74\", \"ppapi_unittests\": \"4cb2458f94ee998fe15a1d63fe48baf283b61b33\", \"printing_unittests\": \"fd9f4081afb25ec1fc08bfeecd42894729c29c1a\", \"remoting_unittests\": \"b8d6c57e5a0dc09adcb0887ede4f4a70218b84a4\", \"sandbox_linux_unittests\": \"3b511d38367116256eb4c0f2feee761c7f355a8f\", \"service_manager_unittests\": \"c830c4f458ea90706c991773493c0c320088c28c\", \"services_unittests\": \"ca6b0b8eeb3ea750e965c23855d04e3b53ea583e\", \"shell_dialogs_unittests\": \"a9c32f7a8a9210d3a3ecd8097e394a1f7434df6a\", \"shell_encryption_unittests\": \"4767caebdfd057a1c2911ebbc6a4a9d6830acf51\", \"skia_unittests\": \"97adec9d5c83ea52b6d6c4a7d82af4eb67fcdb64\", \"snapshot_unittests\": \"8d1d37c8600be9219e5219b0b1046430b45783f1\", \"sql_unittests\": \"73a6af295144e7200cdab3206a176277e99693bb\", \"storage_unittests\": \"a11c005053ab1bddffad308d7dba9c869f5f8687\", \"sync_integration_tests\": \"33a7d8a227ae1f6d1f8610301cf6bf11fbbafd1f\", \"traffic_annotation_auditor_unittests\": \"4e31d2588c96758e1078ae5372f121361652b74f\", \"ui_base_unittests\": \"1d3e421c3edf5f52af2ad7d9d5ebb6bc21c4fd82\", \"ui_chromeos_unittests\": \"358ba9e7c87c290606fb1bfb69c5c896a91a8a45\", \"ui_touch_selection_unittests\": \"b56150dbd32faa47248e545d92dfc9a02df21f7a\", \"unit_tests\": \"2c335c202b9caf07b2bddfbb9d87acd54b0c4569\", \"url_unittests\": \"afbc951bcc54c1aa290a5a1c90481daf0e94c3ec\", \"usage_time_limit_unittests\": \"a8a696c64a4cd539e847e4122f126b652c4ba921\", \"views_unittests\": \"5e820932d8f90236ab49e3377c2377473db98969\", \"viz_unittests\": \"58b5c2238ffcdf01306c02738be4da965a83bf7b\", \"wayland_client_perftests\": \"9f06f5c5e22d80fa7a538b505dfc850d59bc76c3\", \"wayland_client_tests\": \"46099a266d9367e446ed060183ccea33c515e5e5\", \"wm_unittests\": \"5b7bedbdb119e7a1bed4f20087a01a124816ebc7\", \"wtf_unittests\": \"21e140b7206e8cef1bc6a69039fd108109337e88\", \"zlib_unittests\": \"989411b0dafe488ab1f75bfe6f119c0a4857a528\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_256f5ddd0fd0dc12b292dc06910d383b36d434fcd402039f959c9b6741115c5c_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_99ff1ef652ee1a099e982d95872de1fdd74468ee6a8079168e46d4cfc0b2cfdf_v2\", \"builder_bbe6c22469d6b45d8f49350e3da0912e9331dc294c727d05ae5755d0a8b95710_v2\", \"builder_dcbea5b82ec4a83dbdaa91009ef51243214ea218662e823950f8dce6b7b19a0b_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-115-iywj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/PrerenderBrowserTest.PrerenderedPageCrossSiteNavigation/WebContents\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615336387692168",
"status": "COMPLETED",
"status_changed_ts": "1615336388137088",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46032",
"builder:linux-chromeos-rel",
"buildset:commit/git/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/612565978308dba6ff6a41d47e3f5e77b0bbb94e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018621128037702192",
"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/8853191065981659776/+/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:52325a20ca218010",
"user_agent:luci-scheduler"
],
"updated_ts": "1615341991869051",
"url": "https://ci.chromium.org/b/8853191065981659776",
"utcnow_ts": "1615341993209263"
}
}
[02:06:33.224] Invocation finished in 1h38m30.225574057s with status FAILED