[04:01:36.594] New invocation is queued and will start shortly
[04:01:37.843] Starting the invocation (attempt 1)
[04:01:37.893] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:01:37.894] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:01:37.894] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028663955301261568",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028663955301261568",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"gitiles_ref:refs/heads/master"
]
}
[04:01:38.478] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605758498002461",
"id": "8863233893156976784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605758498362011",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21376",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028663955301261568",
"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/8863233893156976784/+/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": "1605758498362181",
"url": "https://ci.chromium.org/b/8863233893156976784",
"utcnow_ts": "1605758498469756"
}
}
[04:01:38.478] Task URL: https://ci.chromium.org/b/8863233893156976784
[04:01:38.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:2:0) after 1m0s
[04:02:32.564] Received PubSub notification, asking Buildbucket for the build status
[04:02:32.814] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:38.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:2:0)
[04:02:38.524] Timer tick, asking Buildbucket for the build status
[04:02:38.593] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:38.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:4:0) after 1m0s
[04:03:38.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:4:0)
[04:03:38.685] Timer tick, asking Buildbucket for the build status
[04:03:38.826] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:38.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:5:0) after 1m0s
[04:04:38.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:5:0)
[04:04:38.843] Timer tick, asking Buildbucket for the build status
[04:04:39.014] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:39.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:6:0) after 1m0s
[04:05:39.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:6:0)
[04:05:39.150] Timer tick, asking Buildbucket for the build status
[04:05:39.226] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:39.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:7:0) after 1m0s
[04:06:39.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:7:0)
[04:06:39.228] Timer tick, asking Buildbucket for the build status
[04:06:39.305] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:39.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:8:0) after 1m0s
[04:07:39.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:8:0)
[04:07:39.297] Timer tick, asking Buildbucket for the build status
[04:07:39.426] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:39.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:9:0) after 1m0s
[04:08:39.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:9:0)
[04:08:39.486] Timer tick, asking Buildbucket for the build status
[04:08:39.602] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:39.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:10:0) after 1m0s
[04:09:39.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:10:0)
[04:09:39.655] Timer tick, asking Buildbucket for the build status
[04:09:39.717] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:11:0) after 1m0s
[04:10:39.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:11:0)
[04:10:39.798] Timer tick, asking Buildbucket for the build status
[04:10:39.947] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:39.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:12:0) after 1m0s
[04:11:40.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:12:0)
[04:11:40.003] Timer tick, asking Buildbucket for the build status
[04:11:40.135] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:40.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:13:0) after 1m0s
[04:12:40.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:13:0)
[04:12:40.136] Timer tick, asking Buildbucket for the build status
[04:12:40.197] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:40.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:14:0) after 1m0s
[04:13:40.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:14:0)
[04:13:40.249] Timer tick, asking Buildbucket for the build status
[04:13:40.547] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:40.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:15:0) after 1m0s
[04:14:40.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:15:0)
[04:14:40.573] Timer tick, asking Buildbucket for the build status
[04:14:40.636] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:40.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:16:0) after 1m0s
[04:15:40.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:16:0)
[04:15:40.656] Timer tick, asking Buildbucket for the build status
[04:15:40.722] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:40.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:17:0) after 1m0s
[04:16:40.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:17:0)
[04:16:40.766] Timer tick, asking Buildbucket for the build status
[04:16:40.965] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:40.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:18:0) after 1m0s
[04:17:40.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:18:0)
[04:17:40.997] Timer tick, asking Buildbucket for the build status
[04:17:41.238] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:41.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:19:0) after 1m0s
[04:18:41.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:19:0)
[04:18:41.313] Timer tick, asking Buildbucket for the build status
[04:18:41.564] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:41.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:20:0) after 1m0s
[04:19:41.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:20:0)
[04:19:41.586] Timer tick, asking Buildbucket for the build status
[04:19:41.669] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:41.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:21:0) after 1m0s
[04:20:41.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:21:0)
[04:20:41.705] Timer tick, asking Buildbucket for the build status
[04:20:42.132] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:42.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:22:0) after 1m0s
[04:21:42.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:22:0)
[04:21:42.235] Timer tick, asking Buildbucket for the build status
[04:21:42.475] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:42.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:23:0) after 1m0s
[04:22:42.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:23:0)
[04:22:42.539] Timer tick, asking Buildbucket for the build status
[04:22:43.092] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:43.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:24:0) after 1m0s
[04:23:43.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:24:0)
[04:23:43.221] Timer tick, asking Buildbucket for the build status
[04:23:43.284] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:43.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:25:0) after 1m0s
[04:24:43.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:25:0)
[04:24:43.353] Timer tick, asking Buildbucket for the build status
[04:24:43.634] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:43.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:26:0) after 1m0s
[04:25:43.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:26:0)
[04:25:43.668] Timer tick, asking Buildbucket for the build status
[04:25:44.126] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:44.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:27:0) after 1m0s
[04:26:44.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:27:0)
[04:26:44.198] Timer tick, asking Buildbucket for the build status
[04:26:44.299] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:44.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:28:0) after 1m0s
[04:27:44.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:28:0)
[04:27:44.397] Timer tick, asking Buildbucket for the build status
[04:27:44.693] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:44.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:29:0) after 1m0s
[04:28:44.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:29:0)
[04:28:44.744] Timer tick, asking Buildbucket for the build status
[04:28:45.120] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:45.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:30:0) after 1m0s
[04:29:45.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:30:0)
[04:29:45.151] Timer tick, asking Buildbucket for the build status
[04:29:45.249] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:45.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:31:0) after 1m0s
[04:30:45.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:31:0)
[04:30:45.327] Timer tick, asking Buildbucket for the build status
[04:30:45.416] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:45.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:32:0) after 1m0s
[04:31:45.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:32:0)
[04:31:45.534] Timer tick, asking Buildbucket for the build status
[04:31:45.624] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:45.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:33:0) after 1m0s
[04:32:45.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:33:0)
[04:32:45.723] Timer tick, asking Buildbucket for the build status
[04:32:45.951] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:45.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:34:0) after 1m0s
[04:33:46.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:34:0)
[04:33:46.095] Timer tick, asking Buildbucket for the build status
[04:33:46.275] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:46.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:35:0) after 1m0s
[04:34:46.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:35:0)
[04:34:46.613] Timer tick, asking Buildbucket for the build status
[04:34:46.692] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:46.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:36:0) after 1m0s
[04:35:46.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:36:0)
[04:35:46.720] Timer tick, asking Buildbucket for the build status
[04:35:47.031] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:47.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:37:0) after 1m0s
[04:36:47.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:37:0)
[04:36:47.059] Timer tick, asking Buildbucket for the build status
[04:36:47.171] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:47.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:38:0) after 1m0s
[04:37:47.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:38:0)
[04:37:47.226] Timer tick, asking Buildbucket for the build status
[04:37:47.334] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:47.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:39:0) after 1m0s
[04:38:47.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:39:0)
[04:38:47.439] Timer tick, asking Buildbucket for the build status
[04:38:47.547] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:47.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:40:0) after 1m0s
[04:39:47.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:40:0)
[04:39:47.665] Timer tick, asking Buildbucket for the build status
[04:39:47.722] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:47.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:41:0) after 1m0s
[04:40:47.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:41:0)
[04:40:47.803] Timer tick, asking Buildbucket for the build status
[04:40:47.929] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:47.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:42:0) after 1m0s
[04:41:47.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:42:0)
[04:41:47.989] Timer tick, asking Buildbucket for the build status
[04:41:48.084] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:48.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:43:0) after 1m0s
[04:42:48.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:43:0)
[04:42:48.261] Timer tick, asking Buildbucket for the build status
[04:42:48.441] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:48.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:44:0) after 1m0s
[04:43:48.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:44:0)
[04:43:48.487] Timer tick, asking Buildbucket for the build status
[04:43:48.548] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:48.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:45:0) after 1m0s
[04:44:48.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:45:0)
[04:44:48.705] Timer tick, asking Buildbucket for the build status
[04:44:48.807] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:48.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:46:0) after 1m0s
[04:45:48.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:46:0)
[04:45:48.986] Timer tick, asking Buildbucket for the build status
[04:45:49.115] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:49.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:47:0) after 1m0s
[04:46:49.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:47:0)
[04:46:49.379] Timer tick, asking Buildbucket for the build status
[04:46:49.488] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:49.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:48:0) after 1m0s
[04:47:49.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:48:0)
[04:47:49.585] Timer tick, asking Buildbucket for the build status
[04:47:49.639] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:49.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:49:0) after 1m0s
[04:48:49.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:49:0)
[04:48:49.717] Timer tick, asking Buildbucket for the build status
[04:48:50.058] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:50.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:50:0) after 1m0s
[04:49:50.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:50:0)
[04:49:50.078] Timer tick, asking Buildbucket for the build status
[04:49:50.175] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:50.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:51:0) after 1m0s
[04:50:50.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:51:0)
[04:50:50.281] Timer tick, asking Buildbucket for the build status
[04:50:50.353] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:50.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:52:0) after 1m0s
[04:51:50.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:52:0)
[04:51:50.425] Timer tick, asking Buildbucket for the build status
[04:51:50.585] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:50.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:53:0) after 1m0s
[04:52:50.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:53:0)
[04:52:50.660] Timer tick, asking Buildbucket for the build status
[04:52:50.772] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:50.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:54:0) after 1m0s
[04:53:50.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:54:0)
[04:53:50.868] Timer tick, asking Buildbucket for the build status
[04:53:50.962] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:50.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:55:0) after 1m0s
[04:54:50.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:55:0)
[04:54:50.978] Timer tick, asking Buildbucket for the build status
[04:54:51.338] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:51.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:56:0) after 1m0s
[04:55:51.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:56:0)
[04:55:51.348] Timer tick, asking Buildbucket for the build status
[04:55:51.483] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:51.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:57:0) after 1m0s
[04:56:51.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:57:0)
[04:56:51.526] Timer tick, asking Buildbucket for the build status
[04:56:51.633] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:51.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:58:0) after 1m0s
[04:57:51.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:58:0)
[04:57:51.998] Timer tick, asking Buildbucket for the build status
[04:57:52.135] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:52.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:59:0) after 1m0s
[04:58:52.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:59:0)
[04:58:52.264] Timer tick, asking Buildbucket for the build status
[04:58:52.335] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:52.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:60:0) after 1m0s
[04:59:52.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:60:0)
[04:59:52.593] Timer tick, asking Buildbucket for the build status
[04:59:52.808] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:52.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:61:0) after 1m0s
[05:00:52.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:61:0)
[05:00:52.908] Timer tick, asking Buildbucket for the build status
[05:00:55.505] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:55.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:62:0) after 1m0s
[05:01:55.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:62:0)
[05:01:55.706] Timer tick, asking Buildbucket for the build status
[05:01:56.081] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:56.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:63:0) after 1m0s
[05:02:56.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:63:0)
[05:02:56.097] Timer tick, asking Buildbucket for the build status
[05:02:56.178] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:56.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:64:0) after 1m0s
[05:03:56.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:64:0)
[05:03:56.193] Timer tick, asking Buildbucket for the build status
[05:03:56.262] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:56.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:65:0) after 1m0s
[05:04:56.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:65:0)
[05:04:56.425] Timer tick, asking Buildbucket for the build status
[05:04:56.508] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:56.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:66:0) after 1m0s
[05:05:56.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:66:0)
[05:05:56.624] Timer tick, asking Buildbucket for the build status
[05:05:56.775] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:67:0) after 1m0s
[05:06:56.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:67:0)
[05:06:56.867] Timer tick, asking Buildbucket for the build status
[05:06:57.005] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:57.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:68:0) after 1m0s
[05:07:57.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:68:0)
[05:07:57.043] Timer tick, asking Buildbucket for the build status
[05:07:57.146] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:57.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:69:0) after 1m0s
[05:08:57.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:69:0)
[05:08:57.307] Timer tick, asking Buildbucket for the build status
[05:08:57.582] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:57.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:70:0) after 1m0s
[05:09:57.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:70:0)
[05:09:57.650] Timer tick, asking Buildbucket for the build status
[05:09:57.725] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:57.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:71:0) after 1m0s
[05:10:58.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:71:0)
[05:10:58.301] Timer tick, asking Buildbucket for the build status
[05:10:58.434] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:58.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:72:0) after 1m0s
[05:11:58.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:72:0)
[05:11:58.592] Timer tick, asking Buildbucket for the build status
[05:11:58.773] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:58.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:73:0) after 1m0s
[05:12:58.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:73:0)
[05:12:58.900] Timer tick, asking Buildbucket for the build status
[05:12:59.013] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:59.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:74:0) after 1m0s
[05:13:59.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:74:0)
[05:13:59.104] Timer tick, asking Buildbucket for the build status
[05:13:59.710] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:59.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:75:0) after 1m0s
[05:14:59.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:75:0)
[05:14:59.858] Timer tick, asking Buildbucket for the build status
[05:14:59.949] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:59.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:76:0) after 1m0s
[05:16:00.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:76:0)
[05:16:00.330] Timer tick, asking Buildbucket for the build status
[05:16:00.399] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:00.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:77:0) after 1m0s
[05:17:00.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:77:0)
[05:17:00.643] Timer tick, asking Buildbucket for the build status
[05:17:01.229] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:78:0) after 1m0s
[05:18:01.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:78:0)
[05:18:01.808] Timer tick, asking Buildbucket for the build status
[05:18:01.986] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:01.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:79:0) after 1m0s
[05:19:02.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:79:0)
[05:19:02.003] Timer tick, asking Buildbucket for the build status
[05:19:02.108] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:02.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:80:0) after 1m0s
[05:20:02.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:80:0)
[05:20:02.449] Timer tick, asking Buildbucket for the build status
[05:20:02.722] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:02.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:81:0) after 1m0s
[05:21:02.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:81:0)
[05:21:02.915] Timer tick, asking Buildbucket for the build status
[05:21:02.990] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:02.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:82:0) after 1m0s
[05:22:03.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:82:0)
[05:22:03.075] Timer tick, asking Buildbucket for the build status
[05:22:03.197] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:03.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:83:0) after 1m0s
[05:23:03.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:83:0)
[05:23:03.303] Timer tick, asking Buildbucket for the build status
[05:23:03.632] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:03.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:84:0) after 1m0s
[05:24:03.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:84:0)
[05:24:03.726] Timer tick, asking Buildbucket for the build status
[05:24:04.231] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:04.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:85:0) after 1m0s
[05:25:04.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:85:0)
[05:25:04.278] Timer tick, asking Buildbucket for the build status
[05:25:04.970] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:04.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:86:0) after 1m0s
[05:26:04.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:86:0)
[05:26:04.964] Timer tick, asking Buildbucket for the build status
[05:26:05.034] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:05.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:87:0) after 1m0s
[05:27:05.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:87:0)
[05:27:05.097] Timer tick, asking Buildbucket for the build status
[05:27:05.232] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:05.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:88:0) after 1m0s
[05:28:05.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:88:0)
[05:28:05.271] Timer tick, asking Buildbucket for the build status
[05:28:05.415] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:05.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:89:0) after 1m0s
[05:29:05.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:89:0)
[05:29:05.518] Timer tick, asking Buildbucket for the build status
[05:29:05.630] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:05.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:90:0) after 1m0s
[05:30:05.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:90:0)
[05:30:05.777] Timer tick, asking Buildbucket for the build status
[05:30:05.963] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:05.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:91:0) after 1m0s
[05:31:06.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:91:0)
[05:31:06.378] Timer tick, asking Buildbucket for the build status
[05:31:06.450] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:06.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:92:0) after 1m0s
[05:32:06.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:92:0)
[05:32:06.578] Timer tick, asking Buildbucket for the build status
[05:32:06.727] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:06.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:93:0) after 1m0s
[05:33:06.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:93:0)
[05:33:06.849] Timer tick, asking Buildbucket for the build status
[05:33:06.942] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:06.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:94:0) after 1m0s
[05:34:06.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:94:0)
[05:34:06.958] Timer tick, asking Buildbucket for the build status
[05:34:07.437] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:07.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:95:0) after 1m0s
[05:35:07.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:95:0)
[05:35:07.434] Timer tick, asking Buildbucket for the build status
[05:35:07.775] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:07.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:96:0) after 1m0s
[05:36:07.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:96:0)
[05:36:07.842] Timer tick, asking Buildbucket for the build status
[05:36:08.898] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:08.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:97:0) after 1m0s
[05:37:09.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:97:0)
[05:37:09.123] Timer tick, asking Buildbucket for the build status
[05:37:09.259] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:09.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:98:0) after 1m0s
[05:38:09.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:98:0)
[05:38:09.356] Timer tick, asking Buildbucket for the build status
[05:38:09.437] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:09.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:99:0) after 1m0s
[05:39:09.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:99:0)
[05:39:09.511] Timer tick, asking Buildbucket for the build status
[05:39:09.776] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:09.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:100:0) after 1m0s
[05:40:09.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:100:0)
[05:40:09.914] Timer tick, asking Buildbucket for the build status
[05:40:10.104] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:10.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:101:0) after 1m0s
[05:41:10.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:101:0)
[05:41:10.228] Timer tick, asking Buildbucket for the build status
[05:41:10.373] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:10.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:102:0) after 1m0s
[05:42:10.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:102:0)
[05:42:10.416] Timer tick, asking Buildbucket for the build status
[05:42:10.545] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:10.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:103:0) after 1m0s
[05:43:10.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:103:0)
[05:43:10.570] Timer tick, asking Buildbucket for the build status
[05:43:10.656] Build 8863233893156976784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:10.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028663955301261568:104:0) after 1m0s
[05:43:36.668] Received PubSub notification, asking Buildbucket for the build status
[05:43:37.111] Build 8863233893156976784: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:43:37.111] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605764615527319",
"created_by": "project:chromium",
"created_ts": "1605758498002461",
"failure_reason": "BUILD_FAILURE",
"id": "8863233893156976784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SystemFeaturesPolicyTest.DisableCameraAfterInstall\\n\\n- SystemFeaturesPolicyTest.DisableCameraBeforeInstall\\n\\n- ExtensionPolicyTest.ExtensionInstallBlocklistComponentApps\\n\\n**ash_unittests** failed because of:\\n\\n- DesksGestureHandlerTest.HorizontalScrolls\\n\\n- ReverseGestureHandlerTest.SwitchDesk\"}, \"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\": \"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\", \"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-21-5opr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21376, \"got_angle_revision\": \"8a58e38bfd26672fe5d143a6f96a041f626bde33\", \"got_dawn_revision\": \"ce207be41fd6d9f1334ca6f251812511dc63faca\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\", \"got_revision_cp\": \"refs/heads/master@{#829080}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"060020166679a265a2bc8250f4d78a7a8c29de89\", \"got_v8_revision\": \"458ab69acb38af95d9d4eb5a7e0f692f3cfe81d0\", \"got_v8_revision_cp\": \"refs/heads/8.9.11@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"c4b68c9b3fb5f14d89ead2f63292428ec114ad15\", \"swarm_hashes_refs/heads/master(at){#829080}_without_patch\": {\"absl_hardening_tests\": \"78f90e657852173894beae75df7f163df9e406a9\", \"accessibility_unittests\": \"fe69426dffb96c81986e4cbf30c4ecda41c9ce61\", \"angle_unittests\": \"73d205af7b7f54d1c501cbf667e9453a8a49e1e2\", \"app_list_unittests\": \"d0d70c126a36b1f0a6fe397c71de506212361bb3\", \"app_shell_unittests\": \"aebe3c7b9aee432a253b47f882cce38b7847ebe6\", \"ash_unittests\": \"44c96918c2b2340de3b737ba3db496a0dac9667d\", \"aura_unittests\": \"3cdc5076ed9e9689441f80b22f4798bbc027a5a8\", \"base_unittests\": \"79ab774d03c518135d4493c0b19a92eec7603dc7\", \"base_util_unittests\": \"e2c7556271c7adfd8ce70c577906f605ab62100d\", \"blink_common_unittests\": \"8f6541af32937fa20c295b389371b1d8ac1e7f0e\", \"blink_fuzzer_unittests\": \"ebe9e8d5b07aa9a5974682927172be69fb470434\", \"blink_heap_unittests\": \"5e8795c3e36e2bba03cc9e4ccff88297ab70b92c\", \"blink_platform_unittests\": \"b2062659b6ae5c22abfaa9a024cc012c716bf003\", \"blink_unittests\": \"7107b452f3368163145c5ec77af54c6402803318\", \"boringssl_crypto_tests\": \"7dc8840006d197e1a35c7fe4b80f668ce6f15f3b\", \"boringssl_ssl_tests\": \"5404fa0359957eaba2217d1fd6011d863a4a0d3c\", \"browser_tests\": \"8b297230f7a3e391e015db3fdc63e77422cee040\", \"capture_unittests\": \"1f9b5103af29d65657658143f37c41e4da921f6d\", \"cast_unittests\": \"2da7a83b3cd45057752c4d0729df561aced6bd6f\", \"cc_unittests\": \"b277960392edd3255aaef8b7e3ed96173afd9b34\", \"chrome_app_unittests\": \"4a36f1dbc55dc60763011fbf16e8f4f39f572d97\", \"chromedriver_unittests\": \"f7b96683d1b314d9aadd48b0a4e73a508c307149\", \"chromeos_components_unittests\": \"e73f62de71ffe20c54aa0ff0768684282b1613dc\", \"chromeos_unittests\": \"ac3a57957b161b066eeab7a2db8aff338f8527b6\", \"components_browsertests\": \"e91d529085df0907830a5cd68a44eff50dc39d25\", \"components_unittests\": \"95c4685f29b8539e956a361bed030e0ae32d0db6\", \"compositor_unittests\": \"f50190f31abd9e88174c2ff478573afb15aa2adb\", \"content_browsertests\": \"c526a288ed5255e8c87fe45ffee071a6e098f243\", \"content_unittests\": \"691633a0d7f93e8313b3c43a06ea7fc8ae88b162\", \"crashpad_tests\": \"af01307d6615181ca685f468654d63623ca01ad0\", \"crypto_unittests\": \"8f80c5f65c4cc8395e083e2e96cae95d93741d8f\", \"dbus_unittests\": \"46537512e30ef159f29a2b9d41870fc00d8c2a2b\", \"device_unittests\": \"43b8bb728d6aff26d20a246b1640c5bd8c8cc9a4\", \"display_unittests\": \"8994f3b5a8b1208fb2dc5bfcd2dc87db7fa45eba\", \"events_unittests\": \"9404f14e8cbb18136576bbb554e6671ed4d0b2eb\", \"exo_unittests\": \"c805c70c530cb33a32d805df10758bf7f0c510d6\", \"extensions_browsertests\": \"9754936bd5aa386ac0f393dfda8c611d1ee149b8\", \"extensions_unittests\": \"824f05d0f956f1e98dc3ea29ce0c51813df5306e\", \"filesystem_service_unittests\": \"67adf2dce39d62a6de6296ae4fe0b174f6cbb805\", \"gcm_unit_tests\": \"fd5c8d583819b852c83a1e36356381215e253cdd\", \"gfx_unittests\": \"3dfbc7876b76d46a99ba88ceb884addb43d5b05b\", \"gin_unittests\": \"bc821bd5aeda29693539e98cb1ab19a07147fd4d\", \"gl_unittests_ozone\": \"4aabb0a754f88c7834a6e498fd32dce992475fb4\", \"google_apis_unittests\": \"a44f8fc4137686c7fde7ae71c5022f109f300c66\", \"gpu_unittests\": \"e90ca9100e97bc402180bf30052d4c1e379b9121\", \"gwp_asan_unittests\": \"548b3934784d927f70de3c1c5e4c9eecc5a41d40\", \"interactive_ui_tests\": \"49266dda16c4e0e0f483165f496dc8b507f4d2bb\", \"ipc_tests\": \"a19e288f408af9816276062bd8a8692cefceda2e\", \"jingle_unittests\": \"2a1d514befc17fc454344b7b422ed5ac73296736\", \"keyboard_unittests\": \"390160a1a3170cd8e978fda60eace23e1f33f28f\", \"latency_unittests\": \"4f11e3eaa5c1bd7be9c9dcc3a302da5d5c3efb71\", \"libjingle_xmpp_unittests\": \"f44eb45572661fea2b09a094e33a9c348d6965e6\", \"liburlpattern_unittests\": \"238296258cc91dd9258b32ec265eda6f10081858\", \"media_blink_unittests\": \"568df17abab345e0ed2c8c1320561ae07d118ae5\", \"media_unittests\": \"6e9376e6ff94402360b57705c36e5459554770b9\", \"message_center_unittests\": \"b3927c26cb12b11dea9b464372f0658649e2db45\", \"midi_unittests\": \"4e4657287941c4a8d1040e87da89b0864e774599\", \"mojo_core_unittests\": \"2bedaeac038f69248e7aa97e04838e95481b0816\", \"mojo_unittests\": \"b15b69126d119cd5d1a69af67a2d5d9a88a5636e\", \"nacl_helper_nonsfi_unittests\": \"a3a2e9df6a7b35a7d67342b8fec4c0dc77521b60\", \"nacl_loader_unittests\": \"0f2cf991a2e19c94e7bc852284931840d13fc3d3\", \"native_theme_unittests\": \"e27f50bfad3a80990f6a54c5d29673bba0b79ecf\", \"net_unittests\": \"b6d1243409949ffe5b9bb11ede8175fa79ad41f2\", \"ozone_gl_unittests\": \"420198f979ef8c31602f0827de9f3c9a0c56444e\", \"ozone_unittests\": \"44bd39c54c44d3059c84590f3b27ec97694c03fc\", \"ozone_x11_unittests\": \"8fe85483db63e0a56300a3824b38e1215eed265d\", \"pdf_unittests\": \"48fc533fe10bb613d31e8d161993c3981f08e710\", \"perfetto_unittests\": \"3d539f33a3c080704c17cd447b18a5b4a63dfa90\", \"ppapi_unittests\": \"f54619a23d6eae6150a6ef914fe027223ca8cd3f\", \"printing_unittests\": \"d9a44926b174473efe3ba6e7927ce33d15f3a6cb\", \"remoting_unittests\": \"2916e9e9880efbc6f35be74d78d3f83be0a7d3be\", \"sandbox_linux_unittests\": \"81e957aa41743efd6c8b3418131995124de307cf\", \"service_manager_unittests\": \"5a2ea0ab9fe4ee96a24b715d1a46258f3fbd4ee2\", \"services_unittests\": \"535186ba47302d17fa338edce61998eea534152a\", \"shell_dialogs_unittests\": \"bf323923a2291b6e56278258b6ce7491fe74b12e\", \"skia_unittests\": \"b1b9bb75eda0f97d5801d5b9d5feafe869b68a25\", \"snapshot_unittests\": \"6523337c813fd2af2d1354dc7dd42cb7ebaf0fd9\", \"sql_unittests\": \"c70b967e520de4028a192da3acabb7026b5e325e\", \"storage_unittests\": \"96525308ba9092e9d8dc24b5ec88c59eedf23941\", \"sync_integration_tests\": \"69bf1f20719617d0033d0e3f10b455cf7f2e4211\", \"traffic_annotation_auditor_unittests\": \"e82b29ae81e3229ceed231142f8ebf4a63d54cee\", \"ui_base_unittests\": \"8d43edf86db73b64fbbf5efee0bcc75bb920c249\", \"ui_chromeos_unittests\": \"b5fec2f864fe6e23962b90a0f92325abaf168151\", \"ui_touch_selection_unittests\": \"e28dedd715d6456bdb8be32226fea3014d78d521\", \"unit_tests\": \"e13f0f0684e41cf8f3c4b8baa13f2dbeb4f8089f\", \"url_unittests\": \"2cfa58d071125288f27dd97ae331fc4fc4bbe74f\", \"usage_time_limit_unittests\": \"a1e26bbadabec9b7e948c6c4d8ba67b502857cc4\", \"views_unittests\": \"061f42fb17e5da9c42602b9c2143b600bdea162b\", \"viz_unittests\": \"439d25e5a6d72fdb90dd6517fbb213f11d7f43a0\", \"wm_unittests\": \"f71e12f712eef9bde12b7a37b8be7e44023069f2\", \"wtf_unittests\": \"d309dbe744565d8d81deff646790872d7cdd7857\", \"zlib_unittests\": \"b5b270e500bb7351529c2f37284192cc1d9f05be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_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-21-5opr\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5635-1756fdb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SystemFeaturesPolicyTest.DisableCameraAfterInstall\\n\\n- SystemFeaturesPolicyTest.DisableCameraBeforeInstall\\n\\n- ExtensionPolicyTest.ExtensionInstallBlocklistComponentApps\\n\\n**ash_unittests** failed because of:\\n\\n- DesksGestureHandlerTest.HorizontalScrolls\\n\\n- ReverseGestureHandlerTest.SwitchDesk\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605758551672384",
"status": "COMPLETED",
"status_changed_ts": "1605758552135532",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21376",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4b68c9b3fb5f14d89ead2f63292428ec114ad15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028663955301261568",
"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/8863233893156976784/+/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:4ff77bbff58bf010",
"user_agent:luci-scheduler"
],
"updated_ts": "1605764616127567",
"url": "https://ci.chromium.org/b/8863233893156976784",
"utcnow_ts": "1605764617095858"
}
}
[05:43:37.111] Invocation finished in 1h42m0.53684118s with status FAILED