[22:29:39.449] New invocation is queued and will start shortly
[22:29:40.590] Starting the invocation (attempt 1)
[22:29:40.654] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:29:40.654] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:29:40.654] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017813203967976368",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9017813203967976368",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"gitiles_ref:refs/heads/master"
]
}
[22:29:41.736] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616106580814400",
"id": "8852383141874502304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616106581553908",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46258",
"builder:linux-chromeos-rel",
"buildset:commit/git/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017813203967976368",
"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/8852383141874502304/+/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": "1616106581554026",
"url": "https://ci.chromium.org/b/8852383141874502304",
"utcnow_ts": "1616106581728861"
}
}
[22:29:41.736] Task URL: https://ci.chromium.org/b/8852383141874502304
[22:29:41.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:2:0) after 1m0s
[22:30:41.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:2:0)
[22:30:41.827] Timer tick, asking Buildbucket for the build status
[22:30:41.911] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:41.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:3:0) after 1m0s
[22:31:41.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:3:0)
[22:31:41.923] Timer tick, asking Buildbucket for the build status
[22:31:41.998] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:41.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:4:0) after 1m0s
[22:32:42.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:4:0)
[22:32:42.065] Timer tick, asking Buildbucket for the build status
[22:32:42.133] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:42.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:5:0) after 1m0s
[22:33:42.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:5:0)
[22:33:42.130] Timer tick, asking Buildbucket for the build status
[22:33:42.347] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:42.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:6:0) after 1m0s
[22:34:42.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:6:0)
[22:34:42.476] Timer tick, asking Buildbucket for the build status
[22:34:42.722] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:42.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:7:0) after 1m0s
[22:35:42.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:7:0)
[22:35:42.721] Timer tick, asking Buildbucket for the build status
[22:35:42.798] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:42.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:8:0) after 1m0s
[22:36:42.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:8:0)
[22:36:42.856] Timer tick, asking Buildbucket for the build status
[22:36:42.925] Build 8852383141874502304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:42.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:9:0) after 1m0s
[22:36:58.633] Received PubSub notification, asking Buildbucket for the build status
[22:36:58.700] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:43.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:9:0)
[22:37:43.073] Timer tick, asking Buildbucket for the build status
[22:37:43.133] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:43.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:11:0) after 1m0s
[22:38:43.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:11:0)
[22:38:43.348] Timer tick, asking Buildbucket for the build status
[22:38:43.624] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:43.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:12:0) after 1m0s
[22:39:43.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:12:0)
[22:39:43.686] Timer tick, asking Buildbucket for the build status
[22:39:43.756] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:43.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:13:0) after 1m0s
[22:40:43.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:13:0)
[22:40:43.774] Timer tick, asking Buildbucket for the build status
[22:40:43.913] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:43.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:14:0) after 1m0s
[22:41:44.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:14:0)
[22:41:44.001] Timer tick, asking Buildbucket for the build status
[22:41:44.077] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:44.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:15:0) after 1m0s
[22:42:44.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:15:0)
[22:42:44.149] Timer tick, asking Buildbucket for the build status
[22:42:44.219] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:44.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:16:0) after 1m0s
[22:43:44.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:16:0)
[22:43:44.328] Timer tick, asking Buildbucket for the build status
[22:43:44.388] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:44.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:17:0) after 1m0s
[22:44:44.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:17:0)
[22:44:44.386] Timer tick, asking Buildbucket for the build status
[22:44:44.451] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:44.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:18:0) after 1m0s
[22:45:44.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:18:0)
[22:45:44.485] Timer tick, asking Buildbucket for the build status
[22:45:44.643] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:44.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:19:0) after 1m0s
[22:46:44.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:19:0)
[22:46:44.736] Timer tick, asking Buildbucket for the build status
[22:46:44.924] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:44.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:20:0) after 1m0s
[22:47:44.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:20:0)
[22:47:44.927] Timer tick, asking Buildbucket for the build status
[22:47:44.995] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:44.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:21:0) after 1m0s
[22:48:45.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:21:0)
[22:48:45.027] Timer tick, asking Buildbucket for the build status
[22:48:45.105] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:45.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:22:0) after 1m0s
[22:49:45.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:22:0)
[22:49:45.178] Timer tick, asking Buildbucket for the build status
[22:49:45.257] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:45.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:23:0) after 1m0s
[22:50:45.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:23:0)
[22:50:45.350] Timer tick, asking Buildbucket for the build status
[22:50:45.437] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:45.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:24:0) after 1m0s
[22:51:45.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:24:0)
[22:51:45.723] Timer tick, asking Buildbucket for the build status
[22:51:45.793] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:45.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:25:0) after 1m0s
[22:52:46.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:25:0)
[22:52:46.023] Timer tick, asking Buildbucket for the build status
[22:52:46.098] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:46.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:26:0) after 1m0s
[22:53:46.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:26:0)
[22:53:46.150] Timer tick, asking Buildbucket for the build status
[22:53:49.561] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:49.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:27:0) after 1m0s
[22:54:49.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:27:0)
[22:54:49.908] Timer tick, asking Buildbucket for the build status
[22:54:49.992] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:49.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:28:0) after 1m0s
[22:55:50.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:28:0)
[22:55:50.123] Timer tick, asking Buildbucket for the build status
[22:55:50.196] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:50.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:29:0) after 1m0s
[22:56:50.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:29:0)
[22:56:50.308] Timer tick, asking Buildbucket for the build status
[22:56:50.385] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:30:0) after 1m0s
[22:57:50.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:30:0)
[22:57:50.638] Timer tick, asking Buildbucket for the build status
[22:57:50.744] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:31:0) after 1m0s
[22:58:50.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:31:0)
[22:58:50.758] Timer tick, asking Buildbucket for the build status
[22:58:50.823] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:32:0) after 1m0s
[22:59:50.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:32:0)
[22:59:50.923] Timer tick, asking Buildbucket for the build status
[22:59:51.139] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:51.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:33:0) after 1m0s
[23:00:51.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:33:0)
[23:00:51.202] Timer tick, asking Buildbucket for the build status
[23:00:51.391] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:51.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:34:0) after 1m0s
[23:01:51.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:34:0)
[23:01:51.509] Timer tick, asking Buildbucket for the build status
[23:01:51.866] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:51.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:35:0) after 1m0s
[23:02:52.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:35:0)
[23:02:52.036] Timer tick, asking Buildbucket for the build status
[23:02:52.112] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:52.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:36:0) after 1m0s
[23:03:52.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:36:0)
[23:03:52.300] Timer tick, asking Buildbucket for the build status
[23:03:52.560] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:52.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:37:0) after 1m0s
[23:04:52.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:37:0)
[23:04:52.680] Timer tick, asking Buildbucket for the build status
[23:04:52.776] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:52.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:38:0) after 1m0s
[23:05:52.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:38:0)
[23:05:52.886] Timer tick, asking Buildbucket for the build status
[23:05:52.946] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:52.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:39:0) after 1m0s
[23:06:53.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:39:0)
[23:06:53.042] Timer tick, asking Buildbucket for the build status
[23:06:53.112] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:40:0) after 1m0s
[23:07:53.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:40:0)
[23:07:53.171] Timer tick, asking Buildbucket for the build status
[23:07:53.231] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:53.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:41:0) after 1m0s
[23:08:53.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:41:0)
[23:08:53.326] Timer tick, asking Buildbucket for the build status
[23:08:53.397] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:53.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:42:0) after 1m0s
[23:09:53.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:42:0)
[23:09:53.421] Timer tick, asking Buildbucket for the build status
[23:09:53.510] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:53.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:43:0) after 1m0s
[23:10:53.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:43:0)
[23:10:53.674] Timer tick, asking Buildbucket for the build status
[23:10:53.965] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:53.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:44:0) after 1m0s
[23:11:53.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:44:0)
[23:11:53.955] Timer tick, asking Buildbucket for the build status
[23:11:54.064] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:54.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:45:0) after 1m0s
[23:12:54.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:45:0)
[23:12:54.134] Timer tick, asking Buildbucket for the build status
[23:12:54.202] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:54.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:46:0) after 1m0s
[23:13:54.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:46:0)
[23:13:54.278] Timer tick, asking Buildbucket for the build status
[23:13:54.350] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:54.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:47:0) after 1m0s
[23:14:54.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:47:0)
[23:14:54.524] Timer tick, asking Buildbucket for the build status
[23:14:54.624] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:54.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:48:0) after 1m0s
[23:15:54.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:48:0)
[23:15:54.905] Timer tick, asking Buildbucket for the build status
[23:15:54.977] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:54.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:49:0) after 1m0s
[23:16:55.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:49:0)
[23:16:55.027] Timer tick, asking Buildbucket for the build status
[23:16:55.095] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:55.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:50:0) after 1m0s
[23:17:55.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:50:0)
[23:17:55.139] Timer tick, asking Buildbucket for the build status
[23:17:55.316] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:55.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:51:0) after 1m0s
[23:18:55.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:51:0)
[23:18:55.334] Timer tick, asking Buildbucket for the build status
[23:18:55.401] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:55.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:52:0) after 1m0s
[23:19:55.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:52:0)
[23:19:55.442] Timer tick, asking Buildbucket for the build status
[23:19:55.805] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:55.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:53:0) after 1m0s
[23:20:55.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:53:0)
[23:20:55.826] Timer tick, asking Buildbucket for the build status
[23:20:55.893] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:55.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:54:0) after 1m0s
[23:21:55.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:54:0)
[23:21:55.928] Timer tick, asking Buildbucket for the build status
[23:21:56.066] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:56.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:55:0) after 1m0s
[23:22:56.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:55:0)
[23:22:56.101] Timer tick, asking Buildbucket for the build status
[23:22:56.244] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:56.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:56:0) after 1m0s
[23:23:56.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:56:0)
[23:23:56.250] Timer tick, asking Buildbucket for the build status
[23:23:56.407] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:56.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:57:0) after 1m0s
[23:24:56.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:57:0)
[23:24:56.448] Timer tick, asking Buildbucket for the build status
[23:24:56.554] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:56.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:58:0) after 1m0s
[23:25:56.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:58:0)
[23:25:56.573] Timer tick, asking Buildbucket for the build status
[23:25:56.738] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:56.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:59:0) after 1m0s
[23:26:56.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:59:0)
[23:26:56.757] Timer tick, asking Buildbucket for the build status
[23:26:57.063] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:57.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:60:0) after 1m0s
[23:27:57.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:60:0)
[23:27:57.351] Timer tick, asking Buildbucket for the build status
[23:27:57.417] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:57.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:61:0) after 1m0s
[23:28:57.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:61:0)
[23:28:57.523] Timer tick, asking Buildbucket for the build status
[23:28:57.665] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:57.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:62:0) after 1m0s
[23:29:57.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:62:0)
[23:29:57.768] Timer tick, asking Buildbucket for the build status
[23:29:58.270] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:58.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:63:0) after 1m0s
[23:30:58.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:63:0)
[23:30:58.432] Timer tick, asking Buildbucket for the build status
[23:30:58.807] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:58.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:64:0) after 1m0s
[23:31:58.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:64:0)
[23:31:58.928] Timer tick, asking Buildbucket for the build status
[23:31:59.072] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:59.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:65:0) after 1m0s
[23:32:59.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:65:0)
[23:32:59.135] Timer tick, asking Buildbucket for the build status
[23:32:59.203] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:59.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:66:0) after 1m0s
[23:33:59.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:66:0)
[23:33:59.435] Timer tick, asking Buildbucket for the build status
[23:33:59.515] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:59.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:67:0) after 1m0s
[23:34:59.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:67:0)
[23:34:59.881] Timer tick, asking Buildbucket for the build status
[23:34:59.990] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:59.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:68:0) after 1m0s
[23:36:00.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:68:0)
[23:36:00.110] Timer tick, asking Buildbucket for the build status
[23:36:00.407] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:00.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:69:0) after 1m0s
[23:37:00.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:69:0)
[23:37:00.439] Timer tick, asking Buildbucket for the build status
[23:37:00.519] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:00.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:70:0) after 1m0s
[23:38:00.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:70:0)
[23:38:00.539] Timer tick, asking Buildbucket for the build status
[23:38:01.008] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:01.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:71:0) after 1m0s
[23:39:01.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:71:0)
[23:39:01.058] Timer tick, asking Buildbucket for the build status
[23:39:01.248] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:01.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:72:0) after 1m0s
[23:40:01.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:72:0)
[23:40:01.366] Timer tick, asking Buildbucket for the build status
[23:40:01.466] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:01.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:73:0) after 1m0s
[23:41:01.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:73:0)
[23:41:01.531] Timer tick, asking Buildbucket for the build status
[23:41:01.595] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:01.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:74:0) after 1m0s
[23:42:01.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:74:0)
[23:42:01.809] Timer tick, asking Buildbucket for the build status
[23:42:01.891] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:01.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:75:0) after 1m0s
[23:43:01.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:75:0)
[23:43:01.917] Timer tick, asking Buildbucket for the build status
[23:43:02.131] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:02.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:76:0) after 1m0s
[23:44:02.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:76:0)
[23:44:02.162] Timer tick, asking Buildbucket for the build status
[23:44:02.398] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:02.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:77:0) after 1m0s
[23:45:02.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:77:0)
[23:45:02.429] Timer tick, asking Buildbucket for the build status
[23:45:02.524] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:02.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:78:0) after 1m0s
[23:46:02.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:78:0)
[23:46:02.609] Timer tick, asking Buildbucket for the build status
[23:46:02.855] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:02.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:79:0) after 1m0s
[23:47:02.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:79:0)
[23:47:02.950] Timer tick, asking Buildbucket for the build status
[23:47:03.073] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:03.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:80:0) after 1m0s
[23:48:03.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:80:0)
[23:48:03.094] Timer tick, asking Buildbucket for the build status
[23:48:03.166] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:03.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:81:0) after 1m0s
[23:49:03.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:81:0)
[23:49:03.247] Timer tick, asking Buildbucket for the build status
[23:49:03.393] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:03.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:82:0) after 1m0s
[23:50:03.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:82:0)
[23:50:03.436] Timer tick, asking Buildbucket for the build status
[23:50:03.652] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:03.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:83:0) after 1m0s
[23:51:03.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:83:0)
[23:51:03.718] Timer tick, asking Buildbucket for the build status
[23:51:03.915] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:03.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:84:0) after 1m0s
[23:52:03.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:84:0)
[23:52:03.998] Timer tick, asking Buildbucket for the build status
[23:52:04.092] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:85:0) after 1m0s
[23:53:04.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:85:0)
[23:53:04.286] Timer tick, asking Buildbucket for the build status
[23:53:04.369] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:04.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:86:0) after 1m0s
[23:54:04.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:86:0)
[23:54:04.591] Timer tick, asking Buildbucket for the build status
[23:54:04.679] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:04.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:87:0) after 1m0s
[23:55:04.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:87:0)
[23:55:04.807] Timer tick, asking Buildbucket for the build status
[23:55:05.399] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:05.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:88:0) after 1m0s
[23:56:05.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:88:0)
[23:56:05.518] Timer tick, asking Buildbucket for the build status
[23:56:05.712] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:05.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:89:0) after 1m0s
[23:57:05.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:89:0)
[23:57:05.747] Timer tick, asking Buildbucket for the build status
[23:57:05.926] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:05.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:90:0) after 1m0s
[23:58:05.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:90:0)
[23:58:05.975] Timer tick, asking Buildbucket for the build status
[23:58:06.072] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:06.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:91:0) after 1m0s
[23:59:06.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:91:0)
[23:59:06.091] Timer tick, asking Buildbucket for the build status
[23:59:06.154] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:06.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:92:0) after 1m0s
[00:00:06.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:92:0)
[00:00:06.367] Timer tick, asking Buildbucket for the build status
[00:00:06.470] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:06.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:93:0) after 1m0s
[00:01:07.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:93:0)
[00:01:07.162] Timer tick, asking Buildbucket for the build status
[00:01:07.685] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:07.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:94:0) after 1m0s
[00:02:07.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:94:0)
[00:02:07.701] Timer tick, asking Buildbucket for the build status
[00:02:07.831] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:07.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:95:0) after 1m0s
[00:03:07.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:95:0)
[00:03:07.946] Timer tick, asking Buildbucket for the build status
[00:03:08.122] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:96:0) after 1m0s
[00:04:08.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:96:0)
[00:04:08.222] Timer tick, asking Buildbucket for the build status
[00:04:08.596] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:08.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:97:0) after 1m0s
[00:05:08.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:97:0)
[00:05:08.828] Timer tick, asking Buildbucket for the build status
[00:05:09.003] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:98:0) after 1m0s
[00:06:09.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:98:0)
[00:06:09.114] Timer tick, asking Buildbucket for the build status
[00:06:09.222] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:09.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:99:0) after 1m0s
[00:07:09.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:99:0)
[00:07:09.289] Timer tick, asking Buildbucket for the build status
[00:07:09.561] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:09.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:100:0) after 1m0s
[00:08:09.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:100:0)
[00:08:09.734] Timer tick, asking Buildbucket for the build status
[00:08:09.856] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:09.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:101:0) after 1m0s
[00:09:09.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:101:0)
[00:09:09.945] Timer tick, asking Buildbucket for the build status
[00:09:10.032] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:10.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:102:0) after 1m0s
[00:10:10.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:102:0)
[00:10:10.113] Timer tick, asking Buildbucket for the build status
[00:10:10.311] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:103:0) after 1m0s
[00:11:10.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:103:0)
[00:11:10.336] Timer tick, asking Buildbucket for the build status
[00:11:10.444] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:10.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:104:0) after 1m0s
[00:12:10.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:104:0)
[00:12:10.464] Timer tick, asking Buildbucket for the build status
[00:12:10.557] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:10.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:105:0) after 1m0s
[00:13:10.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:105:0)
[00:13:10.565] Timer tick, asking Buildbucket for the build status
[00:13:10.907] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:10.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:106:0) after 1m0s
[00:14:10.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:106:0)
[00:14:10.998] Timer tick, asking Buildbucket for the build status
[00:14:11.207] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:107:0) after 1m0s
[00:15:11.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:107:0)
[00:15:11.388] Timer tick, asking Buildbucket for the build status
[00:15:12.040] Build 8852383141874502304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:12.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017813203967976368:108:0) after 1m0s
[00:16:07.572] Received PubSub notification, asking Buildbucket for the build status
[00:16:08.180] Build 8852383141874502304: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:16:08.180] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616112966143625",
"created_by": "project:chromium",
"created_ts": "1616106580814400",
"failure_reason": "BUILD_FAILURE",
"id": "8852383141874502304",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- LazyBackgroundPageApiTest.Messaging\\n\\n- PageLoadMetricsBrowserTest.MainFrameIntersectionCrossOrigin\\n\\n- AdsPageLoadMetricsObserverBrowserTest.OriginStatusMetricCross\"}, \"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\": \"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\", \"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-190-zw8x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46258, \"got_angle_revision\": \"1f1b4ffeff1356cc474dd8b4f55189ade357c855\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\", \"got_revision_cp\": \"refs/heads/master@{#864446}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"10c783109050db482a0b7e7f7b31d6befa0848fa\", \"got_v8_revision_cp\": \"refs/heads/9.1.156@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"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\": \"72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82\", \"swarm_hashes_refs/heads/master(at){#864446}_without_patch\": {\"absl_hardening_tests\": \"44ea98563fd5b6948a892c7c4ef9c6ea21e7c72d\", \"accessibility_unittests\": \"07858ff53bc82c6facaf6d2b5802e5da32096dac\", \"angle_unittests\": \"8d452596d67de67968c144589d2ac971bd4af5bd\", \"app_list_unittests\": \"9a87a272921e3a3b8979821ab9b212b622531fec\", \"app_shell_unittests\": \"7d7d0a3005a57ce7f51b296ee47d4f59e7362c2d\", \"ash_unittests\": \"d4cd16df7ae1b3085fe4a3caf7c8da8cfba933db\", \"aura_unittests\": \"b47b943639f0468fdfa7ac187b1ecca64115e1bb\", \"base_unittests\": \"81c7e988a00236325983751fd7517dc451a65eb7\", \"base_util_unittests\": \"2122b367d386b032964da1a95f8ce8762d4b6c2f\", \"blink_common_unittests\": \"85ac6083299a718dce8dde2ec16942242eb72126\", \"blink_fuzzer_unittests\": \"0f4680c56a1300e9e9ea2b5841c90e72cb3ff54d\", \"blink_heap_unittests\": \"6de9a56c37d8868c93a72641ab73f09217fea754\", \"blink_platform_unittests\": \"8433858aa6162e5ee55ee05897c0e2f16d950b04\", \"blink_unittests\": \"d74c3f28a550d67d915a1237ca054b00c60049d1\", \"boringssl_crypto_tests\": \"11a45fcfcf7938a66789ca84f440e16e100a6ac2\", \"boringssl_ssl_tests\": \"24857397c6ed8e57ca021ed31bd57f89ef78c511\", \"browser_tests\": \"6dd7d83915760b0fdceaa58a52472b55041bc391\", \"capture_unittests\": \"e2429f5a819c6aa40f64642b87fc93f9d154439e\", \"cast_unittests\": \"ec8c722f0056dbbb73d364c57b0a919c87b14781\", \"cc_unittests\": \"ee57dd52a671daa542a92f5c966658b51e6f5820\", \"chrome_app_unittests\": \"3c4e4f62650a61f4663e3b95f3a7e44b44d63391\", \"chromedriver_unittests\": \"8a75bc411ff765b1f008b10d1be7435a0fe4129d\", \"chromeos_components_unittests\": \"59df1e82483de26c768804935310f37e8bf0f2ff\", \"chromeos_unittests\": \"aaa583448fdd2a84e682b638762193933ded761c\", \"color_unittests\": \"cb9cf9f422c6811c5133e000531b47b6ee01168f\", \"components_browsertests\": \"49512297eb5d9d2302ed6e5bd7dc66a1cba0c54b\", \"components_unittests\": \"7db56445de617c5e1586db960df186699508e9ba\", \"compositor_unittests\": \"fa11c11089c5f5139b1bd076290e4d14359a2036\", \"content_browsertests\": \"33d96b40e3a9e94c75fcdd9571ed207d282b07d2\", \"content_unittests\": \"da5600d10ca1857a9da7776bd6567337a57d78d0\", \"crashpad_tests\": \"ad4c78c2f3ad76ea54ddb47fe589bd09d45cfe4e\", \"crypto_unittests\": \"7bbaffcc0f030bf3bba86bfe782514a92f945417\", \"dbus_unittests\": \"3afa231500e03ae37d2a2febc9d0c01927641b80\", \"device_unittests\": \"9533cf6b4974b3beb12c91af63c92d3813ff849e\", \"display_unittests\": \"9c1d8eb41e08f4eda2a48c00b3af04bdae5b7cce\", \"events_unittests\": \"968acb7043c243be8c20476904edf99d889234a4\", \"exo_unittests\": \"054d8f181a5afec859cae66c76fbdeecef1bb1a0\", \"extensions_browsertests\": \"ffc5463b005aadc7f5f8c984d404d2bfb959d36c\", \"extensions_unittests\": \"b451169f9724294a548f3a16cc519fd225735c26\", \"filesystem_service_unittests\": \"4b27ede728a06b09f04745d3a4dbcb483e952ca4\", \"gcm_unit_tests\": \"e7a5fced72dd7746d0db507d4ebbeb1e0262b94a\", \"gfx_unittests\": \"bfd51b1f1313fdc067a3d71fc4b8d7a22a77ad7b\", \"gin_unittests\": \"9feda03d2a3d62783e8be93e380097ee498e5018\", \"gl_unittests_ozone\": \"3b02a1efe9a765e7d57d01ef17fcedbcc203b335\", \"google_apis_unittests\": \"e9ad7b03b356b10b72f4abebf0bca19c489ae70f\", \"gpu_unittests\": \"ad297c817ab41607ea41366495da346737fcb1b5\", \"gwp_asan_unittests\": \"3fc2ff1cfb863653810745ebbe97186573cc6b81\", \"interactive_ui_tests\": \"70f9cf8198e32d064425d1c41e6acf7fec400309\", \"ipc_tests\": \"137ba23b91dd2941c4e16a8b24fdbc7cc7359356\", \"jingle_unittests\": \"2283ce32a432e210db5ca9f325975c433c81c1ab\", \"keyboard_unittests\": \"907ffe946fcc9f9631a5d97fe78f258cea4a378f\", \"latency_unittests\": \"c6e8ef691a8d8b439eff8f06a9b58f14e71dd4cd\", \"libjingle_xmpp_unittests\": \"466755f78f22d66bf4be13d94d8b85f8ce38823f\", \"liburlpattern_unittests\": \"fd4e911fce6b6713ea354baacf0b77768f2d9c4e\", \"media_blink_unittests\": \"063b87e4a6fe049bc88cba97fe259fe6733ebace\", \"media_unittests\": \"55ebb674f44226385a0bb12a84d1f8e4f2fe62fe\", \"message_center_unittests\": \"7115106c3281de9acbe7ac387b6e3285ee2de915\", \"midi_unittests\": \"55aa2c926d30cd4992ec2760f72bc5418765e024\", \"mojo_core_unittests\": \"4b4295891b72974b22b667b107ff88524a21205c\", \"mojo_unittests\": \"8f151ea46e7245c54d270339a4c20f2181e67125\", \"nacl_helper_nonsfi_unittests\": \"a98645286725581e1c787b383eedcdfddc19651c\", \"nacl_loader_unittests\": \"16617bef789854fd60321eabecb3a0c5f7667035\", \"native_theme_unittests\": \"45227216b35e2eedb57580e45b0b8f53250d883b\", \"net_unittests\": \"7092b5b9392b4c948df903b697b57536820eb81b\", \"ozone_gl_unittests\": \"4299833c455d9e053acf1cba4fff1ab475e06594\", \"ozone_unittests\": \"de6aa1bd7471f16d37c82b63da6a52511b067ec7\", \"ozone_x11_unittests\": \"183d0d95d2e54875d7dbdf04725159e254a73897\", \"pdf_unittests\": \"6e4af791ab6b567624fdb9ab14716e4e9b8f0ab7\", \"perfetto_unittests\": \"8a32085e26c37bc766c65cde14bdaf8a892844e4\", \"ppapi_unittests\": \"8a644a729181d959ece58fe06c6239c6ee14d5d5\", \"printing_unittests\": \"8aede47fc695a16471dea5f0074f0f90650bd00f\", \"remoting_unittests\": \"a6467c582390db2f3f1ed3834fbe115f3f1376be\", \"sandbox_linux_unittests\": \"43e63bc852d63564d2df05a385f9b1827bd19f26\", \"service_manager_unittests\": \"4313e0117631cd39a84919ff2fb6e239c067cd78\", \"services_unittests\": \"58c29a37cb00cf1b83c1048643be46ed6b677742\", \"shell_dialogs_unittests\": \"7f1e899e95557eb088a26788334989c0ea593b1f\", \"shell_encryption_unittests\": \"e5f74f5fe847a51b9f2d18647bd2d7f81acc628d\", \"skia_unittests\": \"6c0043f1f1fc8d81dc5e6e0335454d653c272ef3\", \"snapshot_unittests\": \"fc21c34218d96d53388d4ab96cb83b6e15929e61\", \"sql_unittests\": \"b0a7dee26d0cda45bfd7313fc9b363fb1b7b832a\", \"storage_unittests\": \"b8ab0ae456576b40a79829a2615916d7ae97c02e\", \"sync_integration_tests\": \"729b3e5b61fb061e25f638cb3f3e106cbe09aca8\", \"traffic_annotation_auditor_unittests\": \"4a4149117c54605fb15fc6e963ca28f3024766e3\", \"ui_base_unittests\": \"41b8832f394c5a93d64f846b178b467d9883a2fa\", \"ui_chromeos_unittests\": \"66b32c765358bf657d3a7bf21365673936dce99e\", \"ui_touch_selection_unittests\": \"50a64ebd48fb742e5abc4f2d9b2e716c5a1fddef\", \"unit_tests\": \"c3b124a15535c74954d5b4b10c3bf29f1253e6de\", \"url_unittests\": \"3ad9190ccc7a4d26027f40a78206f58df2b74f0e\", \"usage_time_limit_unittests\": \"50335261908ceb9c2b3ccafa90c23266d7d628c2\", \"views_unittests\": \"bbba6f3a15910af3166ad7e3fa64ea62f450ca26\", \"viz_unittests\": \"bfcd3761d7e4226fbcaabf30e579480951c84ed8\", \"wayland_client_perftests\": \"2051f09e34aaa6d01ff195f87f22ef33c15958d4\", \"wayland_client_tests\": \"0898e3697373271d9e6b0f3dc28ff65a584c2534\", \"wm_unittests\": \"7c0a4fff065d38aec272532abb53f776715dbffc\", \"wtf_unittests\": \"8365f71b9150f9bf1e82a1ffa5acc0f2bff22e64\", \"zlib_unittests\": \"ee1cc520567e66538027b7f3605f0bb00ed271eb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_000e1c4f189e74dd1a526f6a0536d3e0149cd531063dba85a70e270d680dde3a_v2\", \"builder_5165e2de7796d7dcb4f0b4d7ef826fa605d2b1188c14fc8becf427ca962c0c8e_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_6012964051d5021e7307eb12ad598b318c657120f21d3654d81218fef56916e6_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_9d891a598cf8ebf0ae5ddfdbe2fc0861535c9a49467e7412fefe4675a15b7f18_v2\", \"builder_ce22d0fc5c297d03141230de59f52ebaf9005395a667e8b14df59e499796620f_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-190-zw8x\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- LazyBackgroundPageApiTest.Messaging\\n\\n- PageLoadMetricsBrowserTest.MainFrameIntersectionCrossOrigin\\n\\n- AdsPageLoadMetricsObserverBrowserTest.OriginStatusMetricCross\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616107017663615",
"status": "COMPLETED",
"status_changed_ts": "1616107018280635",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46258",
"builder:linux-chromeos-rel",
"buildset:commit/git/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72c9bdc42d84a41171a2805a4b6a3d5ef9ea9c82",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017813203967976368",
"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/8852383141874502304/+/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:5260470110f76010",
"user_agent:luci-scheduler"
],
"updated_ts": "1616112966144520",
"url": "https://ci.chromium.org/b/8852383141874502304",
"utcnow_ts": "1616112968122833"
}
}
[00:16:08.180] Invocation finished in 1h46m28.746323465s with status FAILED