[13:20:14.168] New invocation is queued and will start shortly
[13:20:15.245] Starting the invocation (attempt 1)
[13:20:15.286] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:20:15.286] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:20:15.286] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027541645976235376",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"120641d9818fcb58c764b8aa540d5eef5fb78229\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027541645976235376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/120641d9818fcb58c764b8aa540d5eef5fb78229",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/120641d9818fcb58c764b8aa540d5eef5fb78229",
"gitiles_ref:refs/heads/master"
]
}
[13:20:16.162] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606828815382213",
"id": "8862111584040113584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"120641d9818fcb58c764b8aa540d5eef5fb78229\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606828815838347",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21556",
"builder:linux-chromeos-dbg",
"buildset:commit/git/120641d9818fcb58c764b8aa540d5eef5fb78229",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/120641d9818fcb58c764b8aa540d5eef5fb78229",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027541645976235376",
"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/8862111584040113584/+/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": "1606828815838461",
"url": "https://ci.chromium.org/b/8862111584040113584",
"utcnow_ts": "1606828816150552"
}
}
[13:20:16.162] Task URL: https://ci.chromium.org/b/8862111584040113584
[13:20:16.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:2:0) after 1m0s
[13:20:20.320] Received PubSub notification, asking Buildbucket for the build status
[13:20:20.431] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:16.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:2:0)
[13:21:16.212] Timer tick, asking Buildbucket for the build status
[13:21:16.756] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:16.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:4:0) after 1m0s
[13:22:16.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:4:0)
[13:22:16.957] Timer tick, asking Buildbucket for the build status
[13:22:17.035] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:17.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:5:0) after 1m0s
[13:23:17.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:5:0)
[13:23:17.226] Timer tick, asking Buildbucket for the build status
[13:23:17.347] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:17.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:6:0) after 1m0s
[13:24:17.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:6:0)
[13:24:17.355] Timer tick, asking Buildbucket for the build status
[13:24:17.466] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:17.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:7:0) after 1m0s
[13:25:17.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:7:0)
[13:25:17.503] Timer tick, asking Buildbucket for the build status
[13:25:17.616] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:17.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:8:0) after 1m0s
[13:26:17.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:8:0)
[13:26:17.616] Timer tick, asking Buildbucket for the build status
[13:26:17.745] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:17.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:9:0) after 1m0s
[13:27:17.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:9:0)
[13:27:17.886] Timer tick, asking Buildbucket for the build status
[13:27:18.205] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:18.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:10:0) after 1m0s
[13:28:18.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:10:0)
[13:28:18.208] Timer tick, asking Buildbucket for the build status
[13:28:18.400] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:18.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:11:0) after 1m0s
[13:29:18.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:11:0)
[13:29:18.423] Timer tick, asking Buildbucket for the build status
[13:29:18.498] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:18.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:12:0) after 1m0s
[13:30:18.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:12:0)
[13:30:18.534] Timer tick, asking Buildbucket for the build status
[13:30:18.734] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:18.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:13:0) after 1m0s
[13:31:18.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:13:0)
[13:31:18.767] Timer tick, asking Buildbucket for the build status
[13:31:18.977] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:18.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:14:0) after 1m0s
[13:32:19.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:14:0)
[13:32:19.014] Timer tick, asking Buildbucket for the build status
[13:32:19.229] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:19.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:15:0) after 1m0s
[13:33:19.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:15:0)
[13:33:19.211] Timer tick, asking Buildbucket for the build status
[13:33:19.283] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:19.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:16:0) after 1m0s
[13:34:19.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:16:0)
[13:34:19.340] Timer tick, asking Buildbucket for the build status
[13:34:19.536] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:19.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:17:0) after 1m0s
[13:35:19.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:17:0)
[13:35:19.568] Timer tick, asking Buildbucket for the build status
[13:35:19.626] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:19.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:18:0) after 1m0s
[13:36:19.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:18:0)
[13:36:19.637] Timer tick, asking Buildbucket for the build status
[13:36:19.762] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:19.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:19:0) after 1m0s
[13:37:19.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:19:0)
[13:37:19.822] Timer tick, asking Buildbucket for the build status
[13:37:19.886] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:19.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:20:0) after 1m0s
[13:38:19.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:20:0)
[13:38:19.916] Timer tick, asking Buildbucket for the build status
[13:38:19.986] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:19.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:21:0) after 1m0s
[13:39:20.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:21:0)
[13:39:20.070] Timer tick, asking Buildbucket for the build status
[13:39:20.339] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:20.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:22:0) after 1m0s
[13:40:20.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:22:0)
[13:40:20.383] Timer tick, asking Buildbucket for the build status
[13:40:20.486] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:20.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:23:0) after 1m0s
[13:41:20.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:23:0)
[13:41:20.507] Timer tick, asking Buildbucket for the build status
[13:41:20.673] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:20.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:24:0) after 1m0s
[13:42:20.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:24:0)
[13:42:20.712] Timer tick, asking Buildbucket for the build status
[13:42:20.793] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:20.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:25:0) after 1m0s
[13:43:20.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:25:0)
[13:43:20.849] Timer tick, asking Buildbucket for the build status
[13:43:20.914] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:20.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:26:0) after 1m0s
[13:44:20.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:26:0)
[13:44:20.954] Timer tick, asking Buildbucket for the build status
[13:44:21.026] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:21.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:27:0) after 1m0s
[13:45:21.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:27:0)
[13:45:21.072] Timer tick, asking Buildbucket for the build status
[13:45:21.172] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:21.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:28:0) after 1m0s
[13:46:21.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:28:0)
[13:46:21.265] Timer tick, asking Buildbucket for the build status
[13:46:21.335] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:21.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:29:0) after 1m0s
[13:47:21.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:29:0)
[13:47:21.329] Timer tick, asking Buildbucket for the build status
[13:47:21.392] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:21.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:30:0) after 1m0s
[13:48:21.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:30:0)
[13:48:21.438] Timer tick, asking Buildbucket for the build status
[13:48:21.745] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:21.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:31:0) after 1m0s
[13:49:21.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:31:0)
[13:49:21.801] Timer tick, asking Buildbucket for the build status
[13:49:21.950] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:21.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:32:0) after 1m0s
[13:50:21.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:32:0)
[13:50:21.974] Timer tick, asking Buildbucket for the build status
[13:50:22.187] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:22.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:33:0) after 1m0s
[13:51:22.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:33:0)
[13:51:22.212] Timer tick, asking Buildbucket for the build status
[13:51:22.279] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:22.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:34:0) after 1m0s
[13:52:22.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:34:0)
[13:52:22.291] Timer tick, asking Buildbucket for the build status
[13:52:22.418] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:22.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:35:0) after 1m0s
[13:53:22.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:35:0)
[13:53:22.447] Timer tick, asking Buildbucket for the build status
[13:53:22.707] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:22.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:36:0) after 1m0s
[13:54:22.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:36:0)
[13:54:22.735] Timer tick, asking Buildbucket for the build status
[13:54:22.794] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:37:0) after 1m0s
[13:55:22.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:37:0)
[13:55:22.831] Timer tick, asking Buildbucket for the build status
[13:55:23.105] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:23.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:38:0) after 1m0s
[13:56:23.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:38:0)
[13:56:23.139] Timer tick, asking Buildbucket for the build status
[13:56:23.194] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:23.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:39:0) after 1m0s
[13:57:23.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:39:0)
[13:57:23.227] Timer tick, asking Buildbucket for the build status
[13:57:23.532] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:23.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:40:0) after 1m0s
[13:58:23.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:40:0)
[13:58:23.683] Timer tick, asking Buildbucket for the build status
[13:58:24.660] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:24.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:41:0) after 1m0s
[13:59:24.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:41:0)
[13:59:24.691] Timer tick, asking Buildbucket for the build status
[13:59:24.806] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:24.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:42:0) after 1m0s
[14:00:24.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:42:0)
[14:00:24.935] Timer tick, asking Buildbucket for the build status
[14:00:25.354] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:25.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:43:0) after 1m0s
[14:01:25.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:43:0)
[14:01:25.336] Timer tick, asking Buildbucket for the build status
[14:01:25.448] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:44:0) after 1m0s
[14:02:25.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:44:0)
[14:02:25.470] Timer tick, asking Buildbucket for the build status
[14:02:25.600] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:25.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:45:0) after 1m0s
[14:03:25.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:45:0)
[14:03:25.640] Timer tick, asking Buildbucket for the build status
[14:03:25.840] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:25.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:46:0) after 1m0s
[14:04:25.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:46:0)
[14:04:25.923] Timer tick, asking Buildbucket for the build status
[14:04:26.045] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:26.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:47:0) after 1m0s
[14:05:26.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:47:0)
[14:05:26.143] Timer tick, asking Buildbucket for the build status
[14:05:26.289] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:26.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:48:0) after 1m0s
[14:06:26.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:48:0)
[14:06:26.565] Timer tick, asking Buildbucket for the build status
[14:06:26.654] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:49:0) after 1m0s
[14:07:26.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:49:0)
[14:07:26.779] Timer tick, asking Buildbucket for the build status
[14:07:26.883] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:26.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:50:0) after 1m0s
[14:08:27.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:50:0)
[14:08:27.729] Timer tick, asking Buildbucket for the build status
[14:08:27.865] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:27.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:51:0) after 1m0s
[14:09:27.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:51:0)
[14:09:27.911] Timer tick, asking Buildbucket for the build status
[14:09:28.010] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:28.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:52:0) after 1m0s
[14:10:28.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:52:0)
[14:10:28.034] Timer tick, asking Buildbucket for the build status
[14:10:28.161] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:28.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:53:0) after 1m0s
[14:11:28.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:53:0)
[14:11:28.202] Timer tick, asking Buildbucket for the build status
[14:11:28.269] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:54:0) after 1m0s
[14:12:28.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:54:0)
[14:12:28.312] Timer tick, asking Buildbucket for the build status
[14:12:28.466] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:28.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:55:0) after 1m0s
[14:13:28.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:55:0)
[14:13:28.549] Timer tick, asking Buildbucket for the build status
[14:13:28.692] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:56:0) after 1m0s
[14:14:28.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:56:0)
[14:14:28.768] Timer tick, asking Buildbucket for the build status
[14:14:28.985] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:28.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:57:0) after 1m0s
[14:15:29.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:57:0)
[14:15:29.234] Timer tick, asking Buildbucket for the build status
[14:15:29.405] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:29.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:58:0) after 1m0s
[14:16:29.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:58:0)
[14:16:29.499] Timer tick, asking Buildbucket for the build status
[14:16:29.651] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:29.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:59:0) after 1m0s
[14:17:29.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:59:0)
[14:17:29.760] Timer tick, asking Buildbucket for the build status
[14:17:29.837] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:29.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:60:0) after 1m0s
[14:18:29.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:60:0)
[14:18:29.894] Timer tick, asking Buildbucket for the build status
[14:18:29.971] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:29.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:61:0) after 1m0s
[14:19:29.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:61:0)
[14:19:29.994] Timer tick, asking Buildbucket for the build status
[14:19:30.315] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:30.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:62:0) after 1m0s
[14:20:30.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:62:0)
[14:20:30.289] Timer tick, asking Buildbucket for the build status
[14:20:30.424] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:30.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:63:0) after 1m0s
[14:21:30.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:63:0)
[14:21:30.469] Timer tick, asking Buildbucket for the build status
[14:21:30.577] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:30.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:64:0) after 1m0s
[14:22:30.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:64:0)
[14:22:30.627] Timer tick, asking Buildbucket for the build status
[14:22:31.182] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:31.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:65:0) after 1m0s
[14:23:31.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:65:0)
[14:23:31.381] Timer tick, asking Buildbucket for the build status
[14:23:31.456] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:31.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:66:0) after 1m0s
[14:24:31.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:66:0)
[14:24:31.604] Timer tick, asking Buildbucket for the build status
[14:24:31.873] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:31.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:67:0) after 1m0s
[14:25:31.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:67:0)
[14:25:31.984] Timer tick, asking Buildbucket for the build status
[14:25:32.104] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:32.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:68:0) after 1m0s
[14:26:32.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:68:0)
[14:26:32.147] Timer tick, asking Buildbucket for the build status
[14:26:32.318] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:32.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:69:0) after 1m0s
[14:27:32.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:69:0)
[14:27:32.794] Timer tick, asking Buildbucket for the build status
[14:27:33.073] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:33.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:70:0) after 1m0s
[14:28:33.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:70:0)
[14:28:33.319] Timer tick, asking Buildbucket for the build status
[14:28:33.419] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:33.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:71:0) after 1m0s
[14:29:33.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:71:0)
[14:29:33.601] Timer tick, asking Buildbucket for the build status
[14:29:33.731] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:33.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:72:0) after 1m0s
[14:30:33.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:72:0)
[14:30:33.983] Timer tick, asking Buildbucket for the build status
[14:30:34.154] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:34.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:73:0) after 1m0s
[14:31:34.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:73:0)
[14:31:34.263] Timer tick, asking Buildbucket for the build status
[14:31:34.447] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:34.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:74:0) after 1m0s
[14:32:34.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:74:0)
[14:32:34.543] Timer tick, asking Buildbucket for the build status
[14:32:34.825] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:34.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:75:0) after 1m0s
[14:33:34.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:75:0)
[14:33:34.941] Timer tick, asking Buildbucket for the build status
[14:33:35.042] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:35.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:76:0) after 1m0s
[14:34:35.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:76:0)
[14:34:35.191] Timer tick, asking Buildbucket for the build status
[14:34:35.274] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:35.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:77:0) after 1m0s
[14:35:35.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:77:0)
[14:35:35.358] Timer tick, asking Buildbucket for the build status
[14:35:35.470] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:35.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:78:0) after 1m0s
[14:36:35.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:78:0)
[14:36:35.729] Timer tick, asking Buildbucket for the build status
[14:36:35.853] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:35.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:79:0) after 1m0s
[14:37:36.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:79:0)
[14:37:36.028] Timer tick, asking Buildbucket for the build status
[14:37:36.109] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:36.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:80:0) after 1m0s
[14:38:36.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:80:0)
[14:38:36.160] Timer tick, asking Buildbucket for the build status
[14:38:36.421] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:36.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:81:0) after 1m0s
[14:39:37.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:81:0)
[14:39:37.238] Timer tick, asking Buildbucket for the build status
[14:39:37.316] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:37.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:82:0) after 1m0s
[14:40:37.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:82:0)
[14:40:37.537] Timer tick, asking Buildbucket for the build status
[14:40:37.862] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:37.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:83:0) after 1m0s
[14:41:38.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:83:0)
[14:41:38.244] Timer tick, asking Buildbucket for the build status
[14:41:38.331] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:38.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:84:0) after 1m0s
[14:42:38.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:84:0)
[14:42:38.602] Timer tick, asking Buildbucket for the build status
[14:42:38.665] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:38.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:85:0) after 1m0s
[14:43:38.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:85:0)
[14:43:38.761] Timer tick, asking Buildbucket for the build status
[14:43:38.860] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:38.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:86:0) after 1m0s
[14:44:38.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:86:0)
[14:44:38.946] Timer tick, asking Buildbucket for the build status
[14:44:39.863] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:39.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:87:0) after 1m0s
[14:45:40.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:87:0)
[14:45:40.011] Timer tick, asking Buildbucket for the build status
[14:45:40.149] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:40.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:88:0) after 1m0s
[14:46:40.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:88:0)
[14:46:40.259] Timer tick, asking Buildbucket for the build status
[14:46:40.345] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:40.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:89:0) after 1m0s
[14:47:40.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:89:0)
[14:47:40.433] Timer tick, asking Buildbucket for the build status
[14:47:40.540] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:40.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:90:0) after 1m0s
[14:48:40.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:90:0)
[14:48:40.571] Timer tick, asking Buildbucket for the build status
[14:48:40.670] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:40.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:91:0) after 1m0s
[14:49:40.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:91:0)
[14:49:40.747] Timer tick, asking Buildbucket for the build status
[14:49:40.817] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:40.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:92:0) after 1m0s
[14:50:40.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:92:0)
[14:50:40.868] Timer tick, asking Buildbucket for the build status
[14:50:41.117] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:41.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:93:0) after 1m0s
[14:51:41.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:93:0)
[14:51:41.162] Timer tick, asking Buildbucket for the build status
[14:51:41.260] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:94:0) after 1m0s
[14:52:41.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:94:0)
[14:52:41.360] Timer tick, asking Buildbucket for the build status
[14:52:41.770] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:41.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:95:0) after 1m0s
[14:53:41.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:95:0)
[14:53:41.836] Timer tick, asking Buildbucket for the build status
[14:53:41.922] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:41.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:96:0) after 1m0s
[14:54:41.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:96:0)
[14:54:41.945] Timer tick, asking Buildbucket for the build status
[14:54:42.011] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:42.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:97:0) after 1m0s
[14:55:42.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:97:0)
[14:55:42.046] Timer tick, asking Buildbucket for the build status
[14:55:42.155] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:42.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:98:0) after 1m0s
[14:56:42.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:98:0)
[14:56:42.167] Timer tick, asking Buildbucket for the build status
[14:56:42.281] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:42.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:99:0) after 1m0s
[14:57:42.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:99:0)
[14:57:42.345] Timer tick, asking Buildbucket for the build status
[14:57:42.634] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:42.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:100:0) after 1m0s
[14:58:42.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:100:0)
[14:58:42.661] Timer tick, asking Buildbucket for the build status
[14:58:42.992] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:42.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:101:0) after 1m0s
[14:59:43.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:101:0)
[14:59:43.020] Timer tick, asking Buildbucket for the build status
[14:59:43.409] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:43.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:102:0) after 1m0s
[15:00:43.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:102:0)
[15:00:43.426] Timer tick, asking Buildbucket for the build status
[15:00:43.701] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:43.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:103:0) after 1m0s
[15:01:43.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:103:0)
[15:01:43.689] Timer tick, asking Buildbucket for the build status
[15:01:43.769] Build 8862111584040113584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:43.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027541645976235376:104:0) after 1m0s
[15:02:35.265] Received PubSub notification, asking Buildbucket for the build status
[15:02:35.349] Build 8862111584040113584: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:02:35.349] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606834953552417",
"created_by": "project:chromium",
"created_ts": "1606828815382213",
"failure_reason": "BUILD_FAILURE",
"id": "8862111584040113584",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"120641d9818fcb58c764b8aa540d5eef5fb78229\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PageLoadMetricsBrowserTest.PaintInMainAndChildFrame\\n\\n- GetUpdateStatusApiTest.Progress\\n\\n- ExtensionIncomingNativeMessagingTest.SingleRequestResponse\\n\\n- PasswordAutofillAgentTest.NoAction_NoPromptForAJAXSubmitWithoutNavigationAndNewElementAppeared_2\\n\\n- ...580 more failure(s) (584 total)...\"}, \"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\": \"120641d9818fcb58c764b8aa540d5eef5fb78229\", \"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-50-n15r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21556, \"got_angle_revision\": \"df873e5fa6d33d5d402cf90dc6106e6812bc71f7\", \"got_dawn_revision\": \"a6a7e46e54518bd730caf47ef4d4a01ff81f9123\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"120641d9818fcb58c764b8aa540d5eef5fb78229\", \"got_revision_cp\": \"refs/heads/master@{#832313}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"1eadcfb3be99c2eca944774a78c4e3c16132958b\", \"got_v8_revision\": \"f1e2bbd80f2e2eacf7e043e18ee55f0b8cf22171\", \"got_v8_revision_cp\": \"refs/heads/8.9.71@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"120641d9818fcb58c764b8aa540d5eef5fb78229\", \"swarm_hashes_refs/heads/master(at){#832313}_without_patch\": {\"absl_hardening_tests\": \"4c910f34e3e174e67e55ddbd71996d4e97633607\", \"accessibility_unittests\": \"84abb4b52a1fa3768199d7782f53dc9b3179c81b\", \"angle_unittests\": \"b0f5f0b596f179aabd3d2c6cdc27f0c97098d7ff\", \"app_list_unittests\": \"d7d8196c50770b65f2d0fa59ee5220c53afa79b2\", \"app_shell_unittests\": \"42ee9431e41d30fe8cbea08347edd38fc52ad6d2\", \"ash_unittests\": \"e9adb323a764c3b45dc6aee99a4a037c3cff3756\", \"aura_unittests\": \"6c7a93f956c67eb8ee490e57c761ee2075e52936\", \"base_unittests\": \"8c21ffe637cf8035780aeac356b448fd366e6713\", \"base_util_unittests\": \"836908b20eabd299a0def9062e47f2c4afe1abda\", \"blink_common_unittests\": \"f36c343b526581000e41679ba49e94a2ff69e1df\", \"blink_fuzzer_unittests\": \"8b6bfb433df4e537ea943fcb534f13b081b999cb\", \"blink_heap_unittests\": \"ff915c52678be9da278b3ccbcb0790f07bfd7329\", \"blink_platform_unittests\": \"2f10a39513deb20bb544b42a416abaeb57787e1c\", \"blink_unittests\": \"91a3273e634959d94a5e883e10b007c75c5c16a0\", \"boringssl_crypto_tests\": \"429845e215cab5b95feff5d0cd465cdfe876265d\", \"boringssl_ssl_tests\": \"d72799e41aa03714b9a425583d768e65a3a355f1\", \"browser_tests\": \"8a4e9113db731f1e02993b3d7d236071d25c2619\", \"capture_unittests\": \"efbc5cc27354712ed98e1c853d8a06de86945c70\", \"cast_unittests\": \"4a78a3a0f295c630b29190850ebf125b31dd006d\", \"cc_unittests\": \"d9a71f9d224fdd693f15cb139a85988768d01f40\", \"chrome_app_unittests\": \"99a567552d0ee4f0776239f75df2c512be6fc586\", \"chromedriver_unittests\": \"e373b3b750c79b71693d60bae48e18675ccdcabb\", \"chromeos_components_unittests\": \"7cc285f01c47ee45e66873cc35bfbdb688cd2639\", \"chromeos_unittests\": \"456e3f30402f08b23f888c84fbec9fb2c39d1212\", \"components_browsertests\": \"574af3c2e07b21b603e9947fc5f19153c99c8717\", \"components_unittests\": \"4364264a9f2b026433c6f399462ba054bbc1c3a8\", \"compositor_unittests\": \"b5a2c0e5216aefdbe94ad0a93175629419d6af7d\", \"content_browsertests\": \"4041310b34e935420bc369d18f10567598711fb7\", \"content_unittests\": \"9b42c1af8b0e600bca0b6e139109d1c4fc346883\", \"crashpad_tests\": \"b7af72a825e710fd8d00088413c5b002f7bbc43f\", \"crypto_unittests\": \"dad4cf9770a3f209de1431860c02c7fc56f0810e\", \"dbus_unittests\": \"2f8f45d28eb2ea312afff1f80c1b87dbebf40541\", \"device_unittests\": \"ed132ae3f80a2a57185b3851cd53ee401c9f45fb\", \"display_unittests\": \"7ec9a29dbec5d44161b1aa11b5b4a235c942aeaa\", \"events_unittests\": \"1cbdcc36560e4d08c3f2b11696e9f58161424012\", \"exo_unittests\": \"477f442cfa51e8cecb548b6103a3e65e4d45e972\", \"extensions_browsertests\": \"beffffd1185dc5ea3e3f87eeee81870dc49393c7\", \"extensions_unittests\": \"c7d019651793eddea75393e2fe3e38f4131150c0\", \"filesystem_service_unittests\": \"5601464ccb06ec04145c6987b027c0fc2e88e2b9\", \"gcm_unit_tests\": \"7c21d89fd64eddb6044a53f797ff95a373c67e7d\", \"gfx_unittests\": \"13e723f591d684402194a5e33a3c92c8090e92b9\", \"gin_unittests\": \"a9aef87b8b5480112064acde063982dfd716fa9a\", \"gl_unittests_ozone\": \"b760d81e1333e164d1204f58b43b437f2a1da0bf\", \"google_apis_unittests\": \"e5c080fba359614ca00bf77d73fe278a80efb111\", \"gpu_unittests\": \"340db0b45fade78bd26b7cc756d82104ee4adc14\", \"gwp_asan_unittests\": \"7ab7b846be40578f9276a8f864dea07fcbd8cb5a\", \"interactive_ui_tests\": \"5cd27997ebdd13272c0ad8f58b89e76be80bead4\", \"ipc_tests\": \"0cc11279af79b1a1b0b3f878c183cea225fb48cf\", \"jingle_unittests\": \"4e2cd36983e026aeae587301b11f97a08a6f61cb\", \"keyboard_unittests\": \"a35a2220da2847ed998472e24233af6c7fd9de5f\", \"latency_unittests\": \"f3edfb218755b4a6f9249556795305785b959e7b\", \"libjingle_xmpp_unittests\": \"5a44a357b7a0962b14c69aa604bbde47ed4f6c6b\", \"liburlpattern_unittests\": \"d65f29755f5989fa18aef03c5d61b4af6ca95fa2\", \"media_blink_unittests\": \"d6d739faed3378a3ccf569d0490b1b0b10e14351\", \"media_unittests\": \"4dd5952afc605dcf5270b42512df7e1108c610ef\", \"message_center_unittests\": \"56ff6eab6cb526062897b41422771af33a044853\", \"midi_unittests\": \"0a5542dd1099e23361904dcccddad72d0b459721\", \"mojo_core_unittests\": \"20ca0ac56944938278af1409e04f355039362394\", \"mojo_unittests\": \"d91ae9186dc6280e33cb3f8aaa5874b98a79a39f\", \"nacl_helper_nonsfi_unittests\": \"dd909b074c67e0f07e48691a01b654d8cdbf8798\", \"nacl_loader_unittests\": \"623b52c80b3c22602fef4c7df9fa4bac6e1c1481\", \"native_theme_unittests\": \"29420ece4c16bda0abe3d9be82ca37fa3ed7fec5\", \"net_unittests\": \"17173e06217abf1b1105194077ede95208a7be39\", \"ozone_gl_unittests\": \"0ab0dc18d8c2d6294190ab35b05f5d36c6f23e9d\", \"ozone_unittests\": \"25eaaca733bd59d1017d47626dabec0f4aca6a38\", \"ozone_x11_unittests\": \"033abbcb91b650ccde662d1440cb4dc21035058b\", \"pdf_unittests\": \"901406ada9a5f89017acacabd64a3cd2aa749b79\", \"perfetto_unittests\": \"3feead3f72d9979f99798d42a938f19bf84eb594\", \"ppapi_unittests\": \"fe63a91a226f28af1629bd32d25cccb4791290ec\", \"printing_unittests\": \"4b56cc94db13faed3bccb705543891f71be21e90\", \"remoting_unittests\": \"3b0f217657f3891d7f7706fa6db54443e9aae2cb\", \"sandbox_linux_unittests\": \"0d7b5c583a0d3b506399540eafd0a5379909627e\", \"service_manager_unittests\": \"b8e03b6da967b7ad09736f2393cb94f63a050ac5\", \"services_unittests\": \"b9bcba8eb40b3de2ac9ea7489ce73d0d677af87b\", \"shell_dialogs_unittests\": \"68284d0bdfe959466d78a36963946030c998d125\", \"skia_unittests\": \"c94468cf798e0f3544d376c8f40105bb17cf0a11\", \"snapshot_unittests\": \"65ac76d1f47fafd56f7ebae47a13bbb79f187900\", \"sql_unittests\": \"45fcd35c694aa54d35edd2e6620e7d58ee85d9c3\", \"storage_unittests\": \"ce29bbc8531b351ce649a12ac64719e5e36d2e4b\", \"sync_integration_tests\": \"9cf40694a41a272bbd081513ae0a43d25871a0e7\", \"traffic_annotation_auditor_unittests\": \"88d26e355ba98e92f59413bab366619acb3100a8\", \"ui_base_unittests\": \"f4e624f39af9b0b6e0f6bc698c9946f3ae469113\", \"ui_chromeos_unittests\": \"f5a2bd97e7053a7e3d6fb660433e26c38d83246f\", \"ui_touch_selection_unittests\": \"38426833793c4bdff88bf4492f7b29892315d47a\", \"unit_tests\": \"a1e6bf5ca17370d56dc7e951a5fe957f57e6878f\", \"url_unittests\": \"3b8c11653f167f4a6565b0a33aeffb4302b8d151\", \"usage_time_limit_unittests\": \"d7e478ccf8ad26ba8d186209fe8d0f83fc5dd306\", \"views_unittests\": \"8bdc7056183c8604210e4564763d0f38a67e5bc8\", \"viz_unittests\": \"6053d26b199c389f2711800cfcdcf4240cc15688\", \"wm_unittests\": \"abc0151c366a4ed702b054d110ac2a436cd65bfe\", \"wtf_unittests\": \"d025f26753957c2548f6773c0e50400b8cb69c8e\", \"zlib_unittests\": \"73c6e59f993b1172c3ee05dc0984e79783ec4fb4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"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-50-n15r\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"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- PageLoadMetricsBrowserTest.PaintInMainAndChildFrame\\n\\n- GetUpdateStatusApiTest.Progress\\n\\n- ExtensionIncomingNativeMessagingTest.SingleRequestResponse\\n\\n- PasswordAutofillAgentTest.NoAction_NoPromptForAJAXSubmitWithoutNavigationAndNewElementAppeared_2\\n\\n- ...580 more failure(s) (584 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606828819402493",
"status": "COMPLETED",
"status_changed_ts": "1606828820083640",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21556",
"builder:linux-chromeos-dbg",
"buildset:commit/git/120641d9818fcb58c764b8aa540d5eef5fb78229",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/120641d9818fcb58c764b8aa540d5eef5fb78229",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027541645976235376",
"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/8862111584040113584/+/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:5037478214667310",
"user_agent:luci-scheduler"
],
"updated_ts": "1606834954881617",
"url": "https://ci.chromium.org/b/8862111584040113584",
"utcnow_ts": "1606834955340873"
}
}
[15:02:35.349] Invocation finished in 1h42m21.197888327s with status FAILED