[06:26:40.848] New invocation is queued and will start shortly
[06:26:41.955] Starting the invocation (attempt 1)
[06:26:41.990] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:26:41.990] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:26:41.990] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023037816308236496",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f316cc5b2d73ae8d7363da8b76053d021ab79541\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023037816308236496",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"gitiles_ref:refs/heads/master"
]
}
[06:26:43.278] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611124002077386",
"id": "8857607754356073952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f316cc5b2d73ae8d7363da8b76053d021ab79541\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611124003061862",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22267",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023037816308236496",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857607754356073952/+/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": "1611124003061999",
"url": "https://ci.chromium.org/b/8857607754356073952",
"utcnow_ts": "1611124003264377"
}
}
[06:26:43.278] Task URL: https://ci.chromium.org/b/8857607754356073952
[06:26:43.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:2:0) after 1m0s
[06:26:45.532] Received PubSub notification, asking Buildbucket for the build status
[06:26:45.618] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:2:0)
[06:27:43.380] Timer tick, asking Buildbucket for the build status
[06:27:43.478] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:4:0) after 1m0s
[06:28:43.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:4:0)
[06:28:43.555] Timer tick, asking Buildbucket for the build status
[06:28:43.614] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:5:0) after 1m0s
[06:29:43.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:5:0)
[06:29:43.693] Timer tick, asking Buildbucket for the build status
[06:29:43.767] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:43.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:6:0) after 1m0s
[06:30:43.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:6:0)
[06:30:43.811] Timer tick, asking Buildbucket for the build status
[06:30:43.912] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:43.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:7:0) after 1m0s
[06:31:44.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:7:0)
[06:31:44.033] Timer tick, asking Buildbucket for the build status
[06:31:44.158] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:8:0) after 1m0s
[06:32:44.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:8:0)
[06:32:44.233] Timer tick, asking Buildbucket for the build status
[06:32:44.359] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:44.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:9:0) after 1m0s
[06:33:44.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:9:0)
[06:33:44.376] Timer tick, asking Buildbucket for the build status
[06:33:44.458] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:44.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:10:0) after 1m0s
[06:34:44.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:10:0)
[06:34:44.487] Timer tick, asking Buildbucket for the build status
[06:34:44.559] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:44.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:11:0) after 1m0s
[06:35:44.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:11:0)
[06:35:44.710] Timer tick, asking Buildbucket for the build status
[06:35:45.146] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:45.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:12:0) after 1m0s
[06:36:45.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:12:0)
[06:36:45.187] Timer tick, asking Buildbucket for the build status
[06:36:45.387] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:45.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:13:0) after 1m0s
[06:37:45.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:13:0)
[06:37:45.463] Timer tick, asking Buildbucket for the build status
[06:37:45.568] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:45.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:14:0) after 1m0s
[06:38:45.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:14:0)
[06:38:45.618] Timer tick, asking Buildbucket for the build status
[06:38:45.866] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:45.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:15:0) after 1m0s
[06:39:46.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:15:0)
[06:39:46.002] Timer tick, asking Buildbucket for the build status
[06:39:46.115] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:16:0) after 1m0s
[06:40:46.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:16:0)
[06:40:46.183] Timer tick, asking Buildbucket for the build status
[06:40:46.239] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:46.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:17:0) after 1m0s
[06:41:46.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:17:0)
[06:41:46.244] Timer tick, asking Buildbucket for the build status
[06:41:46.355] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:46.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:18:0) after 1m0s
[06:42:46.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:18:0)
[06:42:46.462] Timer tick, asking Buildbucket for the build status
[06:42:46.525] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:46.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:19:0) after 1m0s
[06:43:46.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:19:0)
[06:43:46.764] Timer tick, asking Buildbucket for the build status
[06:43:46.932] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:46.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:20:0) after 1m0s
[06:44:47.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:20:0)
[06:44:47.056] Timer tick, asking Buildbucket for the build status
[06:44:47.211] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:47.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:21:0) after 1m0s
[06:45:47.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:21:0)
[06:45:47.305] Timer tick, asking Buildbucket for the build status
[06:45:47.535] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:47.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:22:0) after 1m0s
[06:46:47.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:22:0)
[06:46:47.604] Timer tick, asking Buildbucket for the build status
[06:46:47.728] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:47.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:23:0) after 1m0s
[06:47:47.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:23:0)
[06:47:47.751] Timer tick, asking Buildbucket for the build status
[06:47:47.820] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:47.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:24:0) after 1m0s
[06:48:47.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:24:0)
[06:48:47.953] Timer tick, asking Buildbucket for the build status
[06:48:48.141] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:48.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:25:0) after 1m0s
[06:49:48.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:25:0)
[06:49:48.222] Timer tick, asking Buildbucket for the build status
[06:49:48.279] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:48.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:26:0) after 1m0s
[06:50:48.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:26:0)
[06:50:48.431] Timer tick, asking Buildbucket for the build status
[06:50:48.486] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:48.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:27:0) after 1m0s
[06:51:48.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:27:0)
[06:51:48.571] Timer tick, asking Buildbucket for the build status
[06:51:48.669] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:48.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:28:0) after 1m0s
[06:52:48.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:28:0)
[06:52:48.777] Timer tick, asking Buildbucket for the build status
[06:52:48.839] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:48.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:29:0) after 1m0s
[06:53:48.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:29:0)
[06:53:48.951] Timer tick, asking Buildbucket for the build status
[06:53:49.713] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:49.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:30:0) after 1m0s
[06:54:49.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:30:0)
[06:54:49.755] Timer tick, asking Buildbucket for the build status
[06:54:49.807] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:49.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:31:0) after 1m0s
[06:55:49.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:31:0)
[06:55:49.836] Timer tick, asking Buildbucket for the build status
[06:55:49.923] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:49.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:32:0) after 1m0s
[06:56:49.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:32:0)
[06:56:49.968] Timer tick, asking Buildbucket for the build status
[06:56:50.094] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:50.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:33:0) after 1m0s
[06:57:50.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:33:0)
[06:57:50.127] Timer tick, asking Buildbucket for the build status
[06:57:50.250] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:50.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:34:0) after 1m0s
[06:58:50.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:34:0)
[06:58:50.355] Timer tick, asking Buildbucket for the build status
[06:58:50.786] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:50.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:35:0) after 1m0s
[06:59:50.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:35:0)
[06:59:50.866] Timer tick, asking Buildbucket for the build status
[06:59:50.932] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:50.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:36:0) after 1m0s
[07:00:51.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:36:0)
[07:00:51.107] Timer tick, asking Buildbucket for the build status
[07:00:51.176] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:37:0) after 1m0s
[07:01:51.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:37:0)
[07:01:51.237] Timer tick, asking Buildbucket for the build status
[07:01:51.392] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:38:0) after 1m0s
[07:02:51.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:38:0)
[07:02:51.449] Timer tick, asking Buildbucket for the build status
[07:02:51.522] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:51.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:39:0) after 1m0s
[07:03:51.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:39:0)
[07:03:51.769] Timer tick, asking Buildbucket for the build status
[07:03:51.849] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:51.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:40:0) after 1m0s
[07:04:52.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:40:0)
[07:04:52.022] Timer tick, asking Buildbucket for the build status
[07:04:52.514] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:52.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:41:0) after 1m0s
[07:05:52.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:41:0)
[07:05:52.558] Timer tick, asking Buildbucket for the build status
[07:05:52.652] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:42:0) after 1m0s
[07:06:52.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:42:0)
[07:06:52.662] Timer tick, asking Buildbucket for the build status
[07:06:52.772] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:52.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:43:0) after 1m0s
[07:07:52.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:43:0)
[07:07:52.818] Timer tick, asking Buildbucket for the build status
[07:07:52.882] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:52.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:44:0) after 1m0s
[07:08:52.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:44:0)
[07:08:52.935] Timer tick, asking Buildbucket for the build status
[07:08:53.005] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:53.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:45:0) after 1m0s
[07:09:53.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:45:0)
[07:09:53.091] Timer tick, asking Buildbucket for the build status
[07:09:53.167] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:53.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:46:0) after 1m0s
[07:10:53.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:46:0)
[07:10:53.160] Timer tick, asking Buildbucket for the build status
[07:10:53.601] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:53.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:47:0) after 1m0s
[07:11:53.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:47:0)
[07:11:53.627] Timer tick, asking Buildbucket for the build status
[07:11:53.774] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:48:0) after 1m0s
[07:12:53.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:48:0)
[07:12:53.890] Timer tick, asking Buildbucket for the build status
[07:12:53.997] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:53.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:49:0) after 1m0s
[07:13:54.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:49:0)
[07:13:54.087] Timer tick, asking Buildbucket for the build status
[07:13:54.213] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:54.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:50:0) after 1m0s
[07:14:54.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:50:0)
[07:14:54.277] Timer tick, asking Buildbucket for the build status
[07:14:54.352] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:54.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:51:0) after 1m0s
[07:15:54.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:51:0)
[07:15:54.482] Timer tick, asking Buildbucket for the build status
[07:15:54.558] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:54.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:52:0) after 1m0s
[07:16:54.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:52:0)
[07:16:54.636] Timer tick, asking Buildbucket for the build status
[07:16:55.099] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:53:0) after 1m0s
[07:17:55.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:53:0)
[07:17:55.188] Timer tick, asking Buildbucket for the build status
[07:17:55.319] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:55.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:54:0) after 1m0s
[07:18:55.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:54:0)
[07:18:55.325] Timer tick, asking Buildbucket for the build status
[07:18:55.395] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:55.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:55:0) after 1m0s
[07:19:55.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:55:0)
[07:19:55.443] Timer tick, asking Buildbucket for the build status
[07:19:55.501] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:55.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:56:0) after 1m0s
[07:20:55.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:56:0)
[07:20:55.595] Timer tick, asking Buildbucket for the build status
[07:20:55.675] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:55.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:57:0) after 1m0s
[07:21:55.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:57:0)
[07:21:55.706] Timer tick, asking Buildbucket for the build status
[07:21:55.824] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:55.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:58:0) after 1m0s
[07:22:55.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:58:0)
[07:22:55.872] Timer tick, asking Buildbucket for the build status
[07:22:56.335] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:56.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:59:0) after 1m0s
[07:23:56.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:59:0)
[07:23:56.463] Timer tick, asking Buildbucket for the build status
[07:23:57.022] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:60:0) after 1m0s
[07:24:57.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:60:0)
[07:24:57.278] Timer tick, asking Buildbucket for the build status
[07:24:57.447] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:57.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:61:0) after 1m0s
[07:25:57.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:61:0)
[07:25:57.476] Timer tick, asking Buildbucket for the build status
[07:25:57.967] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:57.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:62:0) after 1m0s
[07:26:57.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:62:0)
[07:26:57.956] Timer tick, asking Buildbucket for the build status
[07:26:58.073] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:58.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:63:0) after 1m0s
[07:27:58.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:63:0)
[07:27:58.142] Timer tick, asking Buildbucket for the build status
[07:27:58.540] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:58.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:64:0) after 1m0s
[07:28:58.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:64:0)
[07:28:58.657] Timer tick, asking Buildbucket for the build status
[07:28:58.816] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:58.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:65:0) after 1m0s
[07:29:58.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:65:0)
[07:29:58.907] Timer tick, asking Buildbucket for the build status
[07:29:59.451] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:59.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:66:0) after 1m0s
[07:30:59.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:66:0)
[07:30:59.513] Timer tick, asking Buildbucket for the build status
[07:30:59.840] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:59.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:67:0) after 1m0s
[07:31:59.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:67:0)
[07:31:59.865] Timer tick, asking Buildbucket for the build status
[07:32:00.261] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:00.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:68:0) after 1m0s
[07:33:00.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:68:0)
[07:33:00.305] Timer tick, asking Buildbucket for the build status
[07:33:00.762] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:00.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:69:0) after 1m0s
[07:34:01.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:69:0)
[07:34:01.017] Timer tick, asking Buildbucket for the build status
[07:34:01.436] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:01.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:70:0) after 1m0s
[07:35:01.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:70:0)
[07:35:01.933] Timer tick, asking Buildbucket for the build status
[07:35:02.120] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:02.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:71:0) after 1m0s
[07:36:02.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:71:0)
[07:36:02.223] Timer tick, asking Buildbucket for the build status
[07:36:02.416] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:02.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:72:0) after 1m0s
[07:37:02.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:72:0)
[07:37:02.463] Timer tick, asking Buildbucket for the build status
[07:37:03.383] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:03.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:73:0) after 1m0s
[07:38:03.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:73:0)
[07:38:03.468] Timer tick, asking Buildbucket for the build status
[07:38:03.692] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:03.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:74:0) after 1m0s
[07:39:03.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:74:0)
[07:39:03.762] Timer tick, asking Buildbucket for the build status
[07:39:03.832] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:03.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:75:0) after 1m0s
[07:40:03.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:75:0)
[07:40:03.906] Timer tick, asking Buildbucket for the build status
[07:40:03.975] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:03.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:76:0) after 1m0s
[07:41:04.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:76:0)
[07:41:04.006] Timer tick, asking Buildbucket for the build status
[07:41:04.420] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:77:0) after 1m0s
[07:42:04.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:77:0)
[07:42:04.469] Timer tick, asking Buildbucket for the build status
[07:42:04.628] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:04.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:78:0) after 1m0s
[07:43:04.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:78:0)
[07:43:04.723] Timer tick, asking Buildbucket for the build status
[07:43:04.812] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:04.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:79:0) after 1m0s
[07:44:04.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:79:0)
[07:44:04.850] Timer tick, asking Buildbucket for the build status
[07:44:05.165] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:05.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:80:0) after 1m0s
[07:45:05.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:80:0)
[07:45:05.213] Timer tick, asking Buildbucket for the build status
[07:45:05.439] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:05.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:81:0) after 1m0s
[07:46:05.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:81:0)
[07:46:05.485] Timer tick, asking Buildbucket for the build status
[07:46:05.820] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:05.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:82:0) after 1m0s
[07:47:05.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:82:0)
[07:47:05.893] Timer tick, asking Buildbucket for the build status
[07:47:06.099] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:06.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:83:0) after 1m0s
[07:48:06.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:83:0)
[07:48:06.155] Timer tick, asking Buildbucket for the build status
[07:48:06.563] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:06.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:84:0) after 1m0s
[07:49:06.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:84:0)
[07:49:06.570] Timer tick, asking Buildbucket for the build status
[07:49:08.153] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:08.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:85:0) after 1m0s
[07:50:08.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:85:0)
[07:50:08.181] Timer tick, asking Buildbucket for the build status
[07:50:08.620] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:08.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:86:0) after 1m0s
[07:51:08.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:86:0)
[07:51:08.616] Timer tick, asking Buildbucket for the build status
[07:51:08.687] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:08.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:87:0) after 1m0s
[07:52:08.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:87:0)
[07:52:08.724] Timer tick, asking Buildbucket for the build status
[07:52:09.109] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:09.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:88:0) after 1m0s
[07:53:09.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:88:0)
[07:53:09.216] Timer tick, asking Buildbucket for the build status
[07:53:09.290] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:09.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:89:0) after 1m0s
[07:54:09.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:89:0)
[07:54:09.289] Timer tick, asking Buildbucket for the build status
[07:54:09.359] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:09.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:90:0) after 1m0s
[07:55:09.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:90:0)
[07:55:09.457] Timer tick, asking Buildbucket for the build status
[07:55:09.912] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:09.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:91:0) after 1m0s
[07:56:09.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:91:0)
[07:56:09.892] Timer tick, asking Buildbucket for the build status
[07:56:10.649] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:10.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:92:0) after 1m0s
[07:57:10.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:92:0)
[07:57:10.692] Timer tick, asking Buildbucket for the build status
[07:57:10.795] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:10.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:93:0) after 1m0s
[07:58:10.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:93:0)
[07:58:10.798] Timer tick, asking Buildbucket for the build status
[07:58:10.920] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:10.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:94:0) after 1m0s
[07:59:11.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:94:0)
[07:59:11.008] Timer tick, asking Buildbucket for the build status
[07:59:11.438] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:11.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:95:0) after 1m0s
[08:00:11.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:95:0)
[08:00:11.479] Timer tick, asking Buildbucket for the build status
[08:00:11.836] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:11.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:96:0) after 1m0s
[08:01:11.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:96:0)
[08:01:11.905] Timer tick, asking Buildbucket for the build status
[08:01:12.875] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:12.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:97:0) after 1m0s
[08:02:12.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:97:0)
[08:02:12.942] Timer tick, asking Buildbucket for the build status
[08:02:13.183] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:13.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:98:0) after 1m0s
[08:03:13.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:98:0)
[08:03:13.265] Timer tick, asking Buildbucket for the build status
[08:03:13.817] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:13.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:99:0) after 1m0s
[08:04:13.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:99:0)
[08:04:13.913] Timer tick, asking Buildbucket for the build status
[08:04:13.989] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:13.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:100:0) after 1m0s
[08:05:14.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:100:0)
[08:05:14.017] Timer tick, asking Buildbucket for the build status
[08:05:14.341] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:14.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:101:0) after 1m0s
[08:06:14.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:101:0)
[08:06:14.362] Timer tick, asking Buildbucket for the build status
[08:06:14.499] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:14.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:102:0) after 1m0s
[08:07:14.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:102:0)
[08:07:14.513] Timer tick, asking Buildbucket for the build status
[08:07:14.682] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:14.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:103:0) after 1m0s
[08:08:14.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:103:0)
[08:08:14.672] Timer tick, asking Buildbucket for the build status
[08:08:14.756] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:14.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:104:0) after 1m0s
[08:09:14.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:104:0)
[08:09:14.785] Timer tick, asking Buildbucket for the build status
[08:09:14.913] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:14.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:105:0) after 1m0s
[08:10:14.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:105:0)
[08:10:14.959] Timer tick, asking Buildbucket for the build status
[08:10:15.036] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:15.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:106:0) after 1m0s
[08:11:15.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:106:0)
[08:11:15.072] Timer tick, asking Buildbucket for the build status
[08:11:15.150] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:15.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:107:0) after 1m0s
[08:12:15.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:107:0)
[08:12:15.313] Timer tick, asking Buildbucket for the build status
[08:12:15.476] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:108:0) after 1m0s
[08:13:15.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:108:0)
[08:13:15.543] Timer tick, asking Buildbucket for the build status
[08:13:16.711] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:16.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:109:0) after 1m0s
[08:14:16.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:109:0)
[08:14:16.784] Timer tick, asking Buildbucket for the build status
[08:14:17.033] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:110:0) after 1m0s
[08:15:17.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:110:0)
[08:15:17.071] Timer tick, asking Buildbucket for the build status
[08:15:17.186] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:17.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:111:0) after 1m0s
[08:16:17.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:111:0)
[08:16:17.258] Timer tick, asking Buildbucket for the build status
[08:16:17.884] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:17.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:112:0) after 1m0s
[08:17:17.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:112:0)
[08:17:17.924] Timer tick, asking Buildbucket for the build status
[08:17:18.114] Build 8857607754356073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:18.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023037816308236496:113:0) after 1m0s
[08:17:57.738] Received PubSub notification, asking Buildbucket for the build status
[08:17:57.838] Build 8857607754356073952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:17:57.838] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611130675421370",
"created_by": "project:chromium",
"created_ts": "1611124002077386",
"failure_reason": "BUILD_FAILURE",
"id": "8857607754356073952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f316cc5b2d73ae8d7363da8b76053d021ab79541\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- InstallableManagerBrowserTest.CheckManifestOnly\"}, \"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\": \"f316cc5b2d73ae8d7363da8b76053d021ab79541\", \"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-86-wu7l\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22267, \"got_angle_revision\": \"192a0147c3fe465650b3a3ef45ea61c02b2de5a1\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"f316cc5b2d73ae8d7363da8b76053d021ab79541\", \"got_revision_cp\": \"refs/heads/master@{#845069}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"89fd1480b47e8c8668dfd3c24302c53b76ba4c88\", \"got_v8_revision\": \"69c461e9bd40c5c45d553d3d19bb2771e32b4d64\", \"got_v8_revision_cp\": \"refs/heads/9.0.18@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f316cc5b2d73ae8d7363da8b76053d021ab79541\", \"swarm_hashes_refs/heads/master(at){#845069}_without_patch\": {\"absl_hardening_tests\": \"f507254870a66da721d776f282bac06cce775a6f\", \"accessibility_unittests\": \"a9b7ad0c26ec6279dcbb80ecc9b46f3e6a99b142\", \"angle_unittests\": \"e7b2737c8ceebddc4ae54b2a528d87cb3f131a78\", \"app_list_unittests\": \"594cacd06a963b329585ad48823fbab2431f7fc5\", \"app_shell_unittests\": \"2654dac7cb9ab03f0aa6286f8cbf3be551292a26\", \"ash_unittests\": \"dde48edc5e2b0d44534eb084f56ec7f2a3ad3eb5\", \"aura_unittests\": \"2ae77bd6e8e686cf3035e1c3f0b6a514bca910fe\", \"base_unittests\": \"04f3ff4f58790fa8807f5221495b6b1efedcc624\", \"base_util_unittests\": \"35aef6ceb19f3396a357c8a445cfd070cf8e09f7\", \"blink_common_unittests\": \"aa341d882d9bdf0ab695e2f47dc1ab5c5098d91f\", \"blink_fuzzer_unittests\": \"d03fff6c2210b1c57891ba566b5f02f1c44c913f\", \"blink_heap_unittests\": \"3e5df08d371471d0114728bf8dfdeb8dbcee47c8\", \"blink_platform_unittests\": \"9d025ee2634cd821b3a54679079698b55e642f98\", \"blink_unittests\": \"6b9bcfccc7f355d6f56ad47a0d1f6de57b4150b5\", \"boringssl_crypto_tests\": \"e63aa6b4c7f5cbc8458ea033a0591f2abd071d66\", \"boringssl_ssl_tests\": \"39cd58b84d023b7afb91f19d5707f841b0752d57\", \"browser_tests\": \"e7080205dcc13dbf3b8c5eddacef83b784054b29\", \"capture_unittests\": \"65de15a26e1f4f9fb7d43725a87d2b57842c4dfc\", \"cast_unittests\": \"5191c3fa5bd7d10bdf99240435dee1ba953e6c4c\", \"cc_unittests\": \"474da7c9151e82d3bfdc70c91f515b15afaadeb5\", \"chrome_app_unittests\": \"9a3f2c5032327ca83d463214ec25e68f59dd832f\", \"chromedriver_unittests\": \"9283f0b091131f7f53f990bc72345b32f48aa216\", \"chromeos_components_unittests\": \"a69dc15497e770cc347bfd5da766d968fb906818\", \"chromeos_unittests\": \"f402284e199dbe92eb33bef2e3a3af7c64a4ffbb\", \"components_browsertests\": \"fe062b064d395792742123183b1826e82dbb759f\", \"components_unittests\": \"b0f272c1dab3b067530a1a41f3e70c34f79cf133\", \"compositor_unittests\": \"e13f5e3d0542abc35fea4aaf44f41386aa00c5d6\", \"content_browsertests\": \"43c5cc279a5ba3daf4b000edcf5da391c2184e11\", \"content_unittests\": \"afde63061268035ba5e55a08548adcf81cf3cfa1\", \"crashpad_tests\": \"1cb6801e3fdf3bee55646957dd21e5bfffdbb465\", \"crypto_unittests\": \"96d6979e9f18369ad034ba9d3b1341fa0fc1375d\", \"dbus_unittests\": \"9a79654461ee96f2770aaa215e284be5762ad01c\", \"device_unittests\": \"7f3e65d34bf262ccc7a85cb1b18ed93ac6360453\", \"display_unittests\": \"a3b1566de774779fbfd266d5ec0403b622e26f9d\", \"events_unittests\": \"44b1bb97e81d99ae4cf0cbf3c738614786dcafc8\", \"exo_unittests\": \"36b3a5f7fe2d639ac12bf6eba2db3121d062c9af\", \"extensions_browsertests\": \"ea263a9e62ea41ae5a37382d4adfec7962d05f80\", \"extensions_unittests\": \"b38aa170482cd5d66df4a85b9668d9b15a200217\", \"filesystem_service_unittests\": \"b5516a03468d3e19bef64393893d742acd62030e\", \"gcm_unit_tests\": \"8151dfd15a958862d44d7e4c7888c95cd07de6a5\", \"gfx_unittests\": \"b1a6464b584b6a8b3cdb05cd9dffa951e9dfad9a\", \"gin_unittests\": \"3c09ab6115ac84a2db3118be087efeca2a86d276\", \"gl_unittests_ozone\": \"ad92270a55568464e9677f073ba6c65f9dbcb7f5\", \"google_apis_unittests\": \"581ee22db2069f27f00c595e2756e0e0adca48f4\", \"gpu_unittests\": \"9b4e89a6ba585ea4f663f321865ce5012f1f94d0\", \"gwp_asan_unittests\": \"c7a8437fe89b5fec2179176b83fc85729f74ca2d\", \"interactive_ui_tests\": \"a5fb74b644a790b108c4cb5e1e20011f513a18c3\", \"ipc_tests\": \"8dd2cc1e9ce0cf94f016c0e2f4cce25d09943ec0\", \"jingle_unittests\": \"74bbb75a135c3126471fe65336d0ac75fcf6e609\", \"keyboard_unittests\": \"31e763f357bf139c41e9af6ace23fce0f8964653\", \"latency_unittests\": \"ca99cdbdcf69938989a79a146fa957736d54cd0b\", \"libjingle_xmpp_unittests\": \"3f51a210474accb00cb182b2a950534a5855118b\", \"liburlpattern_unittests\": \"cf0162613240a2dcb8563cec669e5d6e513b3c5c\", \"media_blink_unittests\": \"731a9c51e014eaa69a334003a1d1ee900d1e3e52\", \"media_unittests\": \"719e0fc8ca5bcb37c5dc72fcac68fbcaaa07694e\", \"message_center_unittests\": \"199914a0765943de0254e4078c3a769c9a137aab\", \"midi_unittests\": \"6e259027fc3e897472aa25c935c205d1f7f43d84\", \"mojo_core_unittests\": \"93bfa3357c41140bebc8215f43976b878074a8ab\", \"mojo_unittests\": \"a64a070d628d99fb71b2923a2338a7be3cf8d2f8\", \"nacl_helper_nonsfi_unittests\": \"27d0d7725516ff7440dca9a897b9c7e3c3b3a5f0\", \"nacl_loader_unittests\": \"94459e94ae3001895790f17c134bca2dc86886bf\", \"native_theme_unittests\": \"0a577df317b4ffd38376ffe14441253b94fe66e1\", \"net_unittests\": \"1f6f55ee955d9a1f63d79f3e48a55c36ccc7b180\", \"ozone_gl_unittests\": \"c94c0b453d009a3070eb52ffb22b4a5b8c078c06\", \"ozone_unittests\": \"afa74baab9dac2560d4bf38fa0fabb22da0384f6\", \"ozone_x11_unittests\": \"fb3659986deb9fe324c9c63bb8d5d7fbf828712d\", \"pdf_unittests\": \"56c5b1c9e6f020db3fa74550965f1e430961d792\", \"perfetto_unittests\": \"37a236427588a0f1320c373bae8c224bee4f77f7\", \"ppapi_unittests\": \"257209093a17b450df7241ab1d426f629d050b32\", \"printing_unittests\": \"b56abbcc2d83430b6fe968b340066c7525a555e3\", \"remoting_unittests\": \"fba4b755b75adc7626a5f7e6389600b919424329\", \"sandbox_linux_unittests\": \"4acb8130c64e89793a6db26e6904966030a7e258\", \"service_manager_unittests\": \"5686322d036b9420da4452a8b9eb737dbec7301e\", \"services_unittests\": \"4a7346d87182410531c11641b8cd15760919db52\", \"shell_dialogs_unittests\": \"42917d0ed1aba0cf0b68605b3a0b0297a66eecc9\", \"shell_encryption_unittests\": \"6d31eaa8538792da637fca0035a1d3e899cd8d82\", \"skia_unittests\": \"1b532de65f397498a5656147eaee95c17f1097e8\", \"snapshot_unittests\": \"04d080ebc8b01faf8a2dd6c61b5dc3087aeb9bb8\", \"sql_unittests\": \"42a479e020e26e8d5260fd6969ec45f1b7c2c559\", \"storage_unittests\": \"77616740af9df3de52a570875446098640693470\", \"sync_integration_tests\": \"f2d2ebf8a9a546c1a1a086502963604bbed49e71\", \"traffic_annotation_auditor_unittests\": \"8c868e16c4d4b71d39108dc91aa2f023b584d31e\", \"ui_base_unittests\": \"4cf6e3de31cfca19f2974102fa1edf9e0b9c1e56\", \"ui_chromeos_unittests\": \"40dd2e8ecc2a95cf75cd17c3f0f42c93a129d832\", \"ui_touch_selection_unittests\": \"98cc20683a63d5a3a8cfa437ccea10e8e314a98f\", \"unit_tests\": \"7bb446fda8da5acbbc155734d5645812c4565c1a\", \"url_unittests\": \"09649d9809a76fc3df65d04ef0b9c0c1463754dd\", \"usage_time_limit_unittests\": \"641ed45ab5cf99b4aa69080b838fde30fa0feb61\", \"views_unittests\": \"714090d7f96d18286b46e320309cb9ba46ca3a55\", \"viz_unittests\": \"fdcd27657c86d7678cbb05b6629bc5d6f134385c\", \"wm_unittests\": \"9bd12430cfb5be5d8035aa847ae92d289da6d620\", \"wtf_unittests\": \"ca361c80b74e07a6583a06682eb0dd589d471095\", \"zlib_unittests\": \"20605de5845071bf4391eb184015ceedc544ddb1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-86-wu7l\"], \"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\": [\"5666-679c9bd\"], \"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- InstallableManagerBrowserTest.CheckManifestOnly\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611124004721300",
"status": "COMPLETED",
"status_changed_ts": "1611124005166465",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22267",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f316cc5b2d73ae8d7363da8b76053d021ab79541",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023037816308236496",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857607754356073952/+/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:51374adb79c4d010",
"user_agent:luci-scheduler"
],
"updated_ts": "1611130677206091",
"url": "https://ci.chromium.org/b/8857607754356073952",
"utcnow_ts": "1611130677827108"
}
}
[08:17:57.838] Invocation finished in 1h51m17.005699386s with status FAILED