[10:40:43.214] New invocation is queued and will start shortly
[10:40:44.490] Starting the invocation (attempt 1)
[10:40:44.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:40:44.525] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:40:44.525] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019035567004957536",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019035567004957536",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"gitiles_ref:refs/heads/master"
]
}
[10:40:45.227] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614940844696155",
"id": "8853605504790568624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614940845110864",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22874",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019035567004957536",
"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/8853605504790568624/+/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": "1614940845110976",
"url": "https://ci.chromium.org/b/8853605504790568624",
"utcnow_ts": "1614940845220309"
}
}
[10:40:45.227] Task URL: https://ci.chromium.org/b/8853605504790568624
[10:40:45.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:2:0) after 1m0s
[10:41:45.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:2:0)
[10:41:45.302] Timer tick, asking Buildbucket for the build status
[10:41:45.479] Build 8853605504790568624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:41:45.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:3:0) after 1m0s
[10:42:46.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:3:0)
[10:42:46.577] Timer tick, asking Buildbucket for the build status
[10:42:46.658] Build 8853605504790568624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:42:46.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:4:0) after 1m0s
[10:43:46.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:4:0)
[10:43:46.815] Timer tick, asking Buildbucket for the build status
[10:43:46.876] Build 8853605504790568624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:43:46.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:5:0) after 1m0s
[10:44:28.488] Received PubSub notification, asking Buildbucket for the build status
[10:44:28.547] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:46.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:5:0)
[10:44:46.999] Timer tick, asking Buildbucket for the build status
[10:44:47.065] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:47.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:7:0) after 1m0s
[10:45:47.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:7:0)
[10:45:47.239] Timer tick, asking Buildbucket for the build status
[10:45:47.305] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:47.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:8:0) after 1m0s
[10:46:47.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:8:0)
[10:46:47.557] Timer tick, asking Buildbucket for the build status
[10:46:47.671] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:47.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:9:0) after 1m0s
[10:47:47.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:9:0)
[10:47:47.815] Timer tick, asking Buildbucket for the build status
[10:47:47.878] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:47.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:10:0) after 1m0s
[10:48:48.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:10:0)
[10:48:48.053] Timer tick, asking Buildbucket for the build status
[10:48:48.519] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:48.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:11:0) after 1m0s
[10:49:48.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:11:0)
[10:49:48.715] Timer tick, asking Buildbucket for the build status
[10:49:48.799] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:48.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:12:0) after 1m0s
[10:50:48.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:12:0)
[10:50:48.878] Timer tick, asking Buildbucket for the build status
[10:50:48.951] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:48.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:13:0) after 1m0s
[10:51:49.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:13:0)
[10:51:49.001] Timer tick, asking Buildbucket for the build status
[10:51:50.250] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:50.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:14:0) after 1m0s
[10:52:50.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:14:0)
[10:52:50.960] Timer tick, asking Buildbucket for the build status
[10:52:51.027] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:51.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:15:0) after 1m0s
[10:53:51.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:15:0)
[10:53:51.523] Timer tick, asking Buildbucket for the build status
[10:53:51.584] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:51.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:16:0) after 1m0s
[10:54:51.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:16:0)
[10:54:51.761] Timer tick, asking Buildbucket for the build status
[10:54:51.852] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:51.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:17:0) after 1m0s
[10:55:51.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:17:0)
[10:55:51.957] Timer tick, asking Buildbucket for the build status
[10:55:52.025] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:18:0) after 1m0s
[10:56:52.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:18:0)
[10:56:52.349] Timer tick, asking Buildbucket for the build status
[10:56:52.445] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:52.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:19:0) after 1m0s
[10:57:52.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:19:0)
[10:57:52.581] Timer tick, asking Buildbucket for the build status
[10:57:52.859] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:52.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:20:0) after 1m0s
[10:58:53.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:20:0)
[10:58:53.023] Timer tick, asking Buildbucket for the build status
[10:58:53.096] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:53.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:21:0) after 1m0s
[10:59:53.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:21:0)
[10:59:53.349] Timer tick, asking Buildbucket for the build status
[10:59:53.440] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:53.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:22:0) after 1m0s
[11:00:53.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:22:0)
[11:00:53.680] Timer tick, asking Buildbucket for the build status
[11:00:53.791] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:53.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:23:0) after 1m0s
[11:01:53.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:23:0)
[11:01:53.853] Timer tick, asking Buildbucket for the build status
[11:01:54.195] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:54.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:24:0) after 1m0s
[11:02:54.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:24:0)
[11:02:54.339] Timer tick, asking Buildbucket for the build status
[11:02:54.451] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:54.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:25:0) after 1m0s
[11:03:54.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:25:0)
[11:03:54.536] Timer tick, asking Buildbucket for the build status
[11:03:54.605] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:54.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:26:0) after 1m0s
[11:04:54.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:26:0)
[11:04:54.698] Timer tick, asking Buildbucket for the build status
[11:04:54.770] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:54.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:27:0) after 1m0s
[11:05:54.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:27:0)
[11:05:54.961] Timer tick, asking Buildbucket for the build status
[11:05:55.065] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:55.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:28:0) after 1m0s
[11:06:55.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:28:0)
[11:06:55.129] Timer tick, asking Buildbucket for the build status
[11:06:55.203] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:55.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:29:0) after 1m0s
[11:07:55.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:29:0)
[11:07:55.237] Timer tick, asking Buildbucket for the build status
[11:07:55.309] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:55.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:30:0) after 1m0s
[11:08:55.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:30:0)
[11:08:55.377] Timer tick, asking Buildbucket for the build status
[11:08:55.615] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:55.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:31:0) after 1m0s
[11:09:55.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:31:0)
[11:09:55.594] Timer tick, asking Buildbucket for the build status
[11:09:55.673] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:55.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:32:0) after 1m0s
[11:10:55.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:32:0)
[11:10:55.815] Timer tick, asking Buildbucket for the build status
[11:10:56.344] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:56.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:33:0) after 1m0s
[11:11:56.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:33:0)
[11:11:56.428] Timer tick, asking Buildbucket for the build status
[11:11:56.555] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:56.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:34:0) after 1m0s
[11:12:56.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:34:0)
[11:12:56.575] Timer tick, asking Buildbucket for the build status
[11:12:56.655] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:56.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:35:0) after 1m0s
[11:13:56.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:35:0)
[11:13:56.697] Timer tick, asking Buildbucket for the build status
[11:13:56.758] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:36:0) after 1m0s
[11:14:56.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:36:0)
[11:14:56.853] Timer tick, asking Buildbucket for the build status
[11:14:56.969] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:56.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:37:0) after 1m0s
[11:15:57.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:37:0)
[11:15:57.029] Timer tick, asking Buildbucket for the build status
[11:15:57.349] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:57.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:38:0) after 1m0s
[11:16:57.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:38:0)
[11:16:57.392] Timer tick, asking Buildbucket for the build status
[11:16:57.543] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:57.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:39:0) after 1m0s
[11:17:57.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:39:0)
[11:17:57.634] Timer tick, asking Buildbucket for the build status
[11:17:57.721] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:57.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:40:0) after 1m0s
[11:18:57.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:40:0)
[11:18:57.742] Timer tick, asking Buildbucket for the build status
[11:18:57.938] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:57.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:41:0) after 1m0s
[11:19:57.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:41:0)
[11:19:57.919] Timer tick, asking Buildbucket for the build status
[11:19:58.231] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:58.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:42:0) after 1m0s
[11:20:58.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:42:0)
[11:20:58.262] Timer tick, asking Buildbucket for the build status
[11:20:58.542] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:58.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:43:0) after 1m0s
[11:21:58.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:43:0)
[11:21:58.565] Timer tick, asking Buildbucket for the build status
[11:21:58.816] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:58.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:44:0) after 1m0s
[11:22:58.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:44:0)
[11:22:58.863] Timer tick, asking Buildbucket for the build status
[11:22:58.991] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:58.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:45:0) after 1m0s
[11:23:59.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:45:0)
[11:23:59.009] Timer tick, asking Buildbucket for the build status
[11:23:59.148] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:59.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:46:0) after 1m0s
[11:24:59.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:46:0)
[11:24:59.168] Timer tick, asking Buildbucket for the build status
[11:24:59.416] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:59.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:47:0) after 1m0s
[11:25:59.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:47:0)
[11:25:59.441] Timer tick, asking Buildbucket for the build status
[11:25:59.557] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:59.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:48:0) after 1m0s
[11:26:59.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:48:0)
[11:26:59.676] Timer tick, asking Buildbucket for the build status
[11:26:59.765] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:59.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:49:0) after 1m0s
[11:27:59.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:49:0)
[11:27:59.797] Timer tick, asking Buildbucket for the build status
[11:27:59.874] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:59.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:50:0) after 1m0s
[11:28:59.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:50:0)
[11:28:59.888] Timer tick, asking Buildbucket for the build status
[11:28:59.968] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:59.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:51:0) after 1m0s
[11:30:00.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:51:0)
[11:30:00.239] Timer tick, asking Buildbucket for the build status
[11:30:00.349] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:52:0) after 1m0s
[11:31:00.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:52:0)
[11:31:00.499] Timer tick, asking Buildbucket for the build status
[11:31:00.770] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:00.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:53:0) after 1m0s
[11:32:00.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:53:0)
[11:32:00.925] Timer tick, asking Buildbucket for the build status
[11:32:01.015] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:01.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:54:0) after 1m0s
[11:33:01.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:54:0)
[11:33:01.044] Timer tick, asking Buildbucket for the build status
[11:33:01.140] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:01.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:55:0) after 1m0s
[11:34:01.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:55:0)
[11:34:01.191] Timer tick, asking Buildbucket for the build status
[11:34:01.297] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:01.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:56:0) after 1m0s
[11:35:01.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:56:0)
[11:35:01.420] Timer tick, asking Buildbucket for the build status
[11:35:01.508] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:01.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:57:0) after 1m0s
[11:36:01.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:57:0)
[11:36:01.822] Timer tick, asking Buildbucket for the build status
[11:36:01.927] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:01.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:58:0) after 1m0s
[11:37:02.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:58:0)
[11:37:02.033] Timer tick, asking Buildbucket for the build status
[11:37:02.170] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:02.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:59:0) after 1m0s
[11:38:02.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:59:0)
[11:38:02.205] Timer tick, asking Buildbucket for the build status
[11:38:02.277] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:02.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:60:0) after 1m0s
[11:39:02.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:60:0)
[11:39:02.349] Timer tick, asking Buildbucket for the build status
[11:39:02.428] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:02.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:61:0) after 1m0s
[11:40:02.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:61:0)
[11:40:02.602] Timer tick, asking Buildbucket for the build status
[11:40:02.699] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:02.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:62:0) after 1m0s
[11:41:02.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:62:0)
[11:41:02.705] Timer tick, asking Buildbucket for the build status
[11:41:02.866] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:02.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:63:0) after 1m0s
[11:42:02.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:63:0)
[11:42:02.949] Timer tick, asking Buildbucket for the build status
[11:42:03.115] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:03.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:64:0) after 1m0s
[11:43:03.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:64:0)
[11:43:03.170] Timer tick, asking Buildbucket for the build status
[11:43:03.414] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:03.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:65:0) after 1m0s
[11:44:03.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:65:0)
[11:44:03.458] Timer tick, asking Buildbucket for the build status
[11:44:03.556] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:03.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:66:0) after 1m0s
[11:45:03.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:66:0)
[11:45:03.565] Timer tick, asking Buildbucket for the build status
[11:45:03.653] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:03.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:67:0) after 1m0s
[11:46:03.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:67:0)
[11:46:03.696] Timer tick, asking Buildbucket for the build status
[11:46:03.800] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:03.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:68:0) after 1m0s
[11:47:03.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:68:0)
[11:47:03.924] Timer tick, asking Buildbucket for the build status
[11:47:04.017] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:04.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:69:0) after 1m0s
[11:48:04.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:69:0)
[11:48:04.011] Timer tick, asking Buildbucket for the build status
[11:48:04.090] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:04.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:70:0) after 1m0s
[11:49:04.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:70:0)
[11:49:04.140] Timer tick, asking Buildbucket for the build status
[11:49:04.209] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:04.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:71:0) after 1m0s
[11:50:04.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:71:0)
[11:50:04.308] Timer tick, asking Buildbucket for the build status
[11:50:04.420] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:72:0) after 1m0s
[11:51:04.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:72:0)
[11:51:04.591] Timer tick, asking Buildbucket for the build status
[11:51:04.723] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:04.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:73:0) after 1m0s
[11:52:04.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:73:0)
[11:52:04.867] Timer tick, asking Buildbucket for the build status
[11:52:05.055] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:05.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:74:0) after 1m0s
[11:53:05.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:74:0)
[11:53:05.074] Timer tick, asking Buildbucket for the build status
[11:53:05.409] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:05.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:75:0) after 1m0s
[11:54:05.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:75:0)
[11:54:05.403] Timer tick, asking Buildbucket for the build status
[11:54:05.483] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:05.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:76:0) after 1m0s
[11:55:05.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:76:0)
[11:55:05.515] Timer tick, asking Buildbucket for the build status
[11:55:05.592] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:05.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:77:0) after 1m0s
[11:56:05.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:77:0)
[11:56:05.646] Timer tick, asking Buildbucket for the build status
[11:56:05.745] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:05.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:78:0) after 1m0s
[11:57:05.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:78:0)
[11:57:05.763] Timer tick, asking Buildbucket for the build status
[11:57:05.859] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:05.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:79:0) after 1m0s
[11:58:06.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:79:0)
[11:58:06.964] Timer tick, asking Buildbucket for the build status
[11:58:07.049] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:07.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:80:0) after 1m0s
[11:59:07.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:80:0)
[11:59:07.488] Timer tick, asking Buildbucket for the build status
[11:59:07.772] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:07.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:81:0) after 1m0s
[12:00:07.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:81:0)
[12:00:07.806] Timer tick, asking Buildbucket for the build status
[12:00:08.827] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:08.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:82:0) after 1m0s
[12:01:09.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:82:0)
[12:01:09.258] Timer tick, asking Buildbucket for the build status
[12:01:09.403] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:83:0) after 1m0s
[12:02:09.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:83:0)
[12:02:09.483] Timer tick, asking Buildbucket for the build status
[12:02:09.560] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:09.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:84:0) after 1m0s
[12:03:09.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:84:0)
[12:03:09.778] Timer tick, asking Buildbucket for the build status
[12:03:09.865] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:09.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:85:0) after 1m0s
[12:04:09.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:85:0)
[12:04:09.907] Timer tick, asking Buildbucket for the build status
[12:04:10.053] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:10.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:86:0) after 1m0s
[12:05:10.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:86:0)
[12:05:10.643] Timer tick, asking Buildbucket for the build status
[12:05:10.848] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:10.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:87:0) after 1m0s
[12:06:11.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:87:0)
[12:06:11.078] Timer tick, asking Buildbucket for the build status
[12:06:11.216] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:88:0) after 1m0s
[12:07:11.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:88:0)
[12:07:11.242] Timer tick, asking Buildbucket for the build status
[12:07:11.331] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:11.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:89:0) after 1m0s
[12:08:11.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:89:0)
[12:08:11.445] Timer tick, asking Buildbucket for the build status
[12:08:11.542] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:90:0) after 1m0s
[12:09:11.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:90:0)
[12:09:11.787] Timer tick, asking Buildbucket for the build status
[12:09:11.888] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:91:0) after 1m0s
[12:10:12.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:91:0)
[12:10:12.064] Timer tick, asking Buildbucket for the build status
[12:10:12.165] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:12.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:92:0) after 1m0s
[12:11:12.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:92:0)
[12:11:12.272] Timer tick, asking Buildbucket for the build status
[12:11:12.444] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:93:0) after 1m0s
[12:12:12.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:93:0)
[12:12:12.491] Timer tick, asking Buildbucket for the build status
[12:12:12.567] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:94:0) after 1m0s
[12:13:12.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:94:0)
[12:13:12.737] Timer tick, asking Buildbucket for the build status
[12:13:12.816] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:95:0) after 1m0s
[12:14:12.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:95:0)
[12:14:12.874] Timer tick, asking Buildbucket for the build status
[12:14:13.117] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:13.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:96:0) after 1m0s
[12:15:13.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:96:0)
[12:15:13.722] Timer tick, asking Buildbucket for the build status
[12:15:13.799] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:13.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:97:0) after 1m0s
[12:16:13.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:97:0)
[12:16:13.863] Timer tick, asking Buildbucket for the build status
[12:16:14.319] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:14.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:98:0) after 1m0s
[12:17:14.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:98:0)
[12:17:14.359] Timer tick, asking Buildbucket for the build status
[12:17:14.439] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:14.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:99:0) after 1m0s
[12:18:14.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:99:0)
[12:18:14.526] Timer tick, asking Buildbucket for the build status
[12:18:14.602] Build 8853605504790568624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019035567004957536:100:0) after 1m0s
[12:19:06.077] Received PubSub notification, asking Buildbucket for the build status
[12:19:06.215] Build 8853605504790568624: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:19:06.215] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614946745627099",
"created_by": "project:chromium",
"created_ts": "1614940844696155",
"failure_reason": "BUILD_FAILURE",
"id": "8853605504790568624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PolicyPrefsTest.PolicyToPrefsMapping\"}, \"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\": \"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\", \"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-6-fov3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22874, \"got_angle_revision\": \"fe2efefac498b56334ad167f174c32dff8914f48\", \"got_dawn_revision\": \"80915849ce7d5f4c0fe834924ed420ed0002b210\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\", \"got_revision_cp\": \"refs/heads/master@{#860181}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"6846389f25cad4233a4bd04fd3fc6c60ae30ff35\", \"got_v8_revision\": \"3ada4ab958536c310f49288abe197d79f1bfec9a\", \"got_v8_revision_cp\": \"refs/heads/9.1.51@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"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\": \"ceede3d3a3a9b761380decd57e2b938abcc8b0d3\", \"swarm_hashes_refs/heads/master(at){#860181}_without_patch\": {\"absl_hardening_tests\": \"215877ef0c85a6eab1c3bd7178452a91d0ba98e5\", \"accessibility_unittests\": \"9e9c9bee5e50fe74fca4794a0f3cec4197cc073e\", \"angle_unittests\": \"e90e08433c61ec789367421aa3cab4530a2b443b\", \"app_list_unittests\": \"906f37e31258fba5a768542a13bc2cfe8dfa4157\", \"app_shell_unittests\": \"64a65752fd9e8e0f1da993db0656566edcdccb61\", \"ash_unittests\": \"79b7f48b68716493f1518ee8f178e2f80285b9db\", \"aura_unittests\": \"fee112b286b093ad1b90ad4cd6bcd87afb32fc20\", \"base_unittests\": \"4c0e760a8a801c6b2789bb6294abda4b7d78a7d7\", \"base_util_unittests\": \"3b67b602466dd11f6ce0b1f98252d1c4a33c20a4\", \"blink_common_unittests\": \"a1699f4dd3e0ffa84447ddbe36158363e135e0a3\", \"blink_fuzzer_unittests\": \"c61a7e2befca9db569a7a59218499a6be66f39e1\", \"blink_heap_unittests\": \"90ae0d2e82fd6062306f6eda0c2e6c4edc78932a\", \"blink_platform_unittests\": \"31b17ffacdba7ba4113b39bf6c3eb673ca600285\", \"blink_unittests\": \"b75a4c62bb34cd3b66c3323a2d95f08a93e18c21\", \"boringssl_crypto_tests\": \"38089ab162374bbd688e3fa46e06e661347c40d6\", \"boringssl_ssl_tests\": \"9e73536e1f38c8252e5a3a664374c014175f1f7c\", \"browser_tests\": \"28b9cc283af34e54c42aa3734275c089fc79d1f3\", \"capture_unittests\": \"dbf6fc3dccb2a6b70ceac3398ec2532e9807fed7\", \"cast_unittests\": \"c37959e3183adaaafb30fde46f00a3561e92b741\", \"cc_unittests\": \"91183d92d1f48fe80ac4fc24915ae0ba34b8d204\", \"chrome_app_unittests\": \"b26a5f1faa1ed93d5f29157e664dcba1fe6a8542\", \"chromedriver_unittests\": \"6fb8d2ec648ee9ce125481be83037fa424abee5d\", \"chromeos_components_unittests\": \"ca9983801e73710c75dcf9bf8d0ce18f87e453ae\", \"chromeos_unittests\": \"5bbd93008b8728a494b7af4d41d67a2c78f3b1c1\", \"color_unittests\": \"ec45757dfb1a8b6c2ce5de31f0fe1e7725a507b0\", \"components_browsertests\": \"3e102a4c51c6c5fb239be4dd149bddceb44f0d45\", \"components_unittests\": \"d1cf047a7c0a923e30840ebf9f68565d37138180\", \"compositor_unittests\": \"f240e8d8220092478400bc5313d8b2c5e50825e2\", \"content_browsertests\": \"464e48bffedb36d7e4b5ec7c85b0e78c33bdb8f0\", \"content_unittests\": \"ddcefbc049424f7173f67ad802fdd0fe177bab42\", \"crashpad_tests\": \"3db1eb467ff9ce4ed96540bbe2cf4db21d2bae61\", \"crypto_unittests\": \"065f8d9c0788e469842b45801c6645a0eaecd4d0\", \"dbus_unittests\": \"97967f5d4f4f5ebb4b4afec8406318acfbdd433f\", \"device_unittests\": \"3f698eaa45b5d74f68f434f4e62e634e1ba88f0e\", \"display_unittests\": \"004ee1c3da521bbff2531eccde9afee152ed3922\", \"events_unittests\": \"07f69e3b20f2a2064b20c7a4ea6a703ccf86d113\", \"exo_unittests\": \"109b3e3a0843e7a0a8d9f39db5bc01552bfd5551\", \"extensions_browsertests\": \"390c2c364efd13069dd00be300fcc5a21c8f1d1d\", \"extensions_unittests\": \"d2e5acf17dbbef11710bc43d8d6b66b77e12d33c\", \"filesystem_service_unittests\": \"a2498a52eb6a9cacfb2f7d7933dad81b866d5d26\", \"gcm_unit_tests\": \"dd9f034f67f65c6eee9fb12e19fa48b80a21d47c\", \"gfx_unittests\": \"a01675ddbb31391d4d3a5beaa3a9cb25af238091\", \"gin_unittests\": \"3c808bb5c0bd139b77eeed1b64caa1270d3c8614\", \"gl_unittests_ozone\": \"46ce9d3b9e81498fc6a1671b8c0e30bac917cb3c\", \"google_apis_unittests\": \"013adcc26d7741ac1a816245049193b3604d0229\", \"gpu_unittests\": \"e12bf862ae31353e632e2358a42b6b2f4cf04172\", \"gwp_asan_unittests\": \"b2792d65581de3f7c6028b90bd093d413ecf2997\", \"interactive_ui_tests\": \"6f9c064cb0c4db12d4e2baaf70fa44382ed03d5f\", \"ipc_tests\": \"6612ca11d3e2145d22912dcaa3aaeb4f521d34a0\", \"jingle_unittests\": \"8b675f09119161a78fc3fac55da52ebb220e3467\", \"keyboard_unittests\": \"e6f642bbbb22245f08fe324a610a4883074c3011\", \"latency_unittests\": \"29a8e13f3a1c3e0b730fccbdf06e2d2b26d44b27\", \"libjingle_xmpp_unittests\": \"06c2ba07b5ad21d5a693ede5778af122ce6848e2\", \"liburlpattern_unittests\": \"0b52e48d52a259c27a53bdf5302135c5628e3f3c\", \"media_blink_unittests\": \"87cf8f767ffa3110d8c73346fcb04499cf872209\", \"media_unittests\": \"1a21bafeeb1294db703e08ac08c464d42b3c6de3\", \"message_center_unittests\": \"632b73ee4bbbdae82d14e2ba1f3d85001e50aaf1\", \"midi_unittests\": \"e01bf78b33062d189510d2c1851b25b3dd7b6fec\", \"mojo_core_unittests\": \"d1d0b4cc3f076d71c3e547a800280cf19b2b5eed\", \"mojo_unittests\": \"7a929119de91759436ec3d6e2068ce9786c773a1\", \"nacl_helper_nonsfi_unittests\": \"faca9eeb3dad93894aace0623e3281419a1f1112\", \"nacl_loader_unittests\": \"155bbf7e7a529dc8e2115f34cbae76f85e34821e\", \"native_theme_unittests\": \"bb150a67c72e969c44622a376e2332641d2a8603\", \"net_unittests\": \"11b1e019f9f431f969f91c304ebdcdf443a11ce4\", \"ozone_gl_unittests\": \"d85dfc75f50002001fbb6610d328842de13643d5\", \"ozone_unittests\": \"9186c6385e89d1a46d5d2b46c5ea45d3069b7d59\", \"ozone_x11_unittests\": \"922b64f7cbd10fed69efddd60a4ae7cd32d8c73c\", \"pdf_unittests\": \"a6b11260422f957eda30424335db89aa7c5eaad6\", \"perfetto_unittests\": \"debfa228b28275dfd529c2ca557210362f445d73\", \"ppapi_unittests\": \"23490e821fc098f7c0ac070c4e6021deca9f4d94\", \"printing_unittests\": \"930ccafa6f3d1258cfe153a37edd23c0a2286bfe\", \"remoting_unittests\": \"2749b47f92336d9fc22c5bb3bce6398d2d7557a8\", \"sandbox_linux_unittests\": \"24715028ab6c2d269dd98c43968289f420e435a4\", \"service_manager_unittests\": \"066d0c1a8af29f801c03dd27bd075254724516fe\", \"services_unittests\": \"d3ed81220d15bb7853f45d5f2c135d488a1dca53\", \"shell_dialogs_unittests\": \"b425c19655107ca394351a901cc7891be06e0bd5\", \"shell_encryption_unittests\": \"bdd084d066b0938d5a13a4349ad607afb358b324\", \"skia_unittests\": \"fd7549a3b2c9d0536f8a8d49b254914cb754bbac\", \"snapshot_unittests\": \"3977a67fda09421be466b0386a49844720c580f5\", \"sql_unittests\": \"0d5ad8e40c2ac8fbd4c3d13deaaacab4bf3c0068\", \"storage_unittests\": \"1fa0cbe4430273f03378765687e6f977550f23e5\", \"sync_integration_tests\": \"6ad99fb71fcb94bd6f45ae48f75f6082bfcfa57d\", \"traffic_annotation_auditor_unittests\": \"4e0d6cbcf05d6c3720515916aa6297a71349d4f2\", \"ui_base_unittests\": \"2c66d466de88450a24048ec51e69beb4fbdc7f55\", \"ui_chromeos_unittests\": \"59976d651e1e87c231c6bdc5ee5950f5c896dbe4\", \"ui_touch_selection_unittests\": \"e3a00d304e18a7c0ae0a58c77210d0f21d4a84ba\", \"unit_tests\": \"d682dd868b23969003340d5bd7544b10b00da741\", \"url_unittests\": \"0830f075e5c655922869d44103722e0e8de3a007\", \"usage_time_limit_unittests\": \"ad5929cf10db35aa8fd84b39458dbfed92a90284\", \"views_unittests\": \"46059e739e76965820019f38c4bb718e5d234892\", \"viz_unittests\": \"34e766c4f9ea3da20c6add90c312663ac39ef95e\", \"wayland_client_tests\": \"314ebf85d817573bdd5f211d9daba9ef3378a1a0\", \"wm_unittests\": \"9ad7ef432ed58fc95a2a335e1919bafe4096f5f8\", \"wtf_unittests\": \"d27959f0270a103af2abc5144b318919c6e86572\", \"zlib_unittests\": \"7daad23873795f2881ceb12c15cf72bc7eccc3fe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_d3fe653fa02e678f703fbad4f78e35ab8fe92cd792b6bec3c883269900c0c087_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_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-6-fov3\"], \"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\": [\"5725-1a0d85e\"], \"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- PolicyPrefsTest.PolicyToPrefsMapping\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614941067726931",
"status": "COMPLETED",
"status_changed_ts": "1614941068185353",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22874",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ceede3d3a3a9b761380decd57e2b938abcc8b0d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019035567004957536",
"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/8853605504790568624/+/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:521acb4fa729cd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614946745627439",
"url": "https://ci.chromium.org/b/8853605504790568624",
"utcnow_ts": "1614946746207226"
}
}
[12:19:06.215] Invocation finished in 1h38m23.01559536s with status FAILED