[03:53:00.206] New invocation is queued and will start shortly
[03:53:01.757] Starting the invocation (attempt 1)
[03:53:01.793] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:53:01.793] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:53:01.793] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026399572606373216",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026399572606373216",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"gitiles_ref:refs/heads/master"
]
}
[03:53:03.215] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607917981997961",
"id": "8860969510067911344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607917982942390",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21736",
"builder:linux-chromeos-dbg",
"buildset:commit/git/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026399572606373216",
"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/8860969510067911344/+/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": "1607917982942529",
"url": "https://ci.chromium.org/b/8860969510067911344",
"utcnow_ts": "1607917983198140"
}
}
[03:53:03.215] Task URL: https://ci.chromium.org/b/8860969510067911344
[03:53:03.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:2:0) after 1m0s
[03:54:03.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:2:0)
[03:54:03.232] Timer tick, asking Buildbucket for the build status
[03:54:03.493] Build 8860969510067911344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:3:0) after 1m0s
[03:55:03.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:3:0)
[03:55:03.459] Timer tick, asking Buildbucket for the build status
[03:55:03.653] Build 8860969510067911344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:03.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:4:0) after 1m0s
[03:56:03.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:4:0)
[03:56:03.671] Timer tick, asking Buildbucket for the build status
[03:56:03.837] Build 8860969510067911344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:03.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:5:0) after 1m0s
[03:57:03.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:5:0)
[03:57:03.860] Timer tick, asking Buildbucket for the build status
[03:57:03.938] Build 8860969510067911344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:03.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:6:0) after 1m0s
[03:58:03.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:6:0)
[03:58:03.959] Timer tick, asking Buildbucket for the build status
[03:58:04.071] Build 8860969510067911344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:04.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:7:0) after 1m0s
[03:58:12.064] Received PubSub notification, asking Buildbucket for the build status
[03:58:12.216] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:04.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:7:0)
[03:59:04.085] Timer tick, asking Buildbucket for the build status
[03:59:04.227] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:04.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:9:0) after 1m0s
[04:00:04.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:9:0)
[04:00:04.310] Timer tick, asking Buildbucket for the build status
[04:00:04.501] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:04.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:10:0) after 1m0s
[04:01:04.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:10:0)
[04:01:04.825] Timer tick, asking Buildbucket for the build status
[04:01:05.043] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:05.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:11:0) after 1m0s
[04:02:05.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:11:0)
[04:02:05.087] Timer tick, asking Buildbucket for the build status
[04:02:05.161] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:05.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:12:0) after 1m0s
[04:03:05.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:12:0)
[04:03:05.178] Timer tick, asking Buildbucket for the build status
[04:03:05.277] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:05.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:13:0) after 1m0s
[04:04:05.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:13:0)
[04:04:05.356] Timer tick, asking Buildbucket for the build status
[04:04:05.416] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:05.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:14:0) after 1m0s
[04:05:05.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:14:0)
[04:05:05.515] Timer tick, asking Buildbucket for the build status
[04:05:05.659] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:05.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:15:0) after 1m0s
[04:06:05.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:15:0)
[04:06:05.666] Timer tick, asking Buildbucket for the build status
[04:06:05.732] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:05.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:16:0) after 1m0s
[04:07:05.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:16:0)
[04:07:05.927] Timer tick, asking Buildbucket for the build status
[04:07:06.023] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:06.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:17:0) after 1m0s
[04:08:06.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:17:0)
[04:08:06.181] Timer tick, asking Buildbucket for the build status
[04:08:06.294] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:06.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:18:0) after 1m0s
[04:09:06.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:18:0)
[04:09:06.348] Timer tick, asking Buildbucket for the build status
[04:09:06.405] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:06.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:19:0) after 1m0s
[04:10:06.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:19:0)
[04:10:06.420] Timer tick, asking Buildbucket for the build status
[04:10:06.483] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:06.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:20:0) after 1m0s
[04:11:06.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:20:0)
[04:11:06.589] Timer tick, asking Buildbucket for the build status
[04:11:06.722] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:06.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:21:0) after 1m0s
[04:12:06.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:21:0)
[04:12:06.729] Timer tick, asking Buildbucket for the build status
[04:12:06.853] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:06.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:22:0) after 1m0s
[04:13:06.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:22:0)
[04:13:06.922] Timer tick, asking Buildbucket for the build status
[04:13:07.114] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:07.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:23:0) after 1m0s
[04:14:07.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:23:0)
[04:14:07.174] Timer tick, asking Buildbucket for the build status
[04:14:07.238] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:07.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:24:0) after 1m0s
[04:15:07.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:24:0)
[04:15:07.282] Timer tick, asking Buildbucket for the build status
[04:15:07.350] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:07.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:25:0) after 1m0s
[04:16:07.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:25:0)
[04:16:07.332] Timer tick, asking Buildbucket for the build status
[04:16:07.394] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:07.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:26:0) after 1m0s
[04:17:07.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:26:0)
[04:17:07.415] Timer tick, asking Buildbucket for the build status
[04:17:07.480] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:07.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:27:0) after 1m0s
[04:18:07.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:27:0)
[04:18:07.530] Timer tick, asking Buildbucket for the build status
[04:18:07.664] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:07.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:28:0) after 1m0s
[04:19:07.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:28:0)
[04:19:07.685] Timer tick, asking Buildbucket for the build status
[04:19:07.804] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:07.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:29:0) after 1m0s
[04:20:07.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:29:0)
[04:20:07.878] Timer tick, asking Buildbucket for the build status
[04:20:07.947] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:07.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:30:0) after 1m0s
[04:21:07.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:30:0)
[04:21:07.970] Timer tick, asking Buildbucket for the build status
[04:21:08.022] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:08.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:31:0) after 1m0s
[04:22:08.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:31:0)
[04:22:08.042] Timer tick, asking Buildbucket for the build status
[04:22:08.137] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:08.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:32:0) after 1m0s
[04:23:08.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:32:0)
[04:23:08.190] Timer tick, asking Buildbucket for the build status
[04:23:08.282] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:08.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:33:0) after 1m0s
[04:24:08.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:33:0)
[04:24:08.321] Timer tick, asking Buildbucket for the build status
[04:24:08.384] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:08.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:34:0) after 1m0s
[04:25:08.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:34:0)
[04:25:08.403] Timer tick, asking Buildbucket for the build status
[04:25:08.467] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:08.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:35:0) after 1m0s
[04:26:08.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:35:0)
[04:26:08.513] Timer tick, asking Buildbucket for the build status
[04:26:08.591] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:08.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:36:0) after 1m0s
[04:27:08.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:36:0)
[04:27:08.608] Timer tick, asking Buildbucket for the build status
[04:27:08.668] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:08.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:37:0) after 1m0s
[04:28:08.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:37:0)
[04:28:08.684] Timer tick, asking Buildbucket for the build status
[04:28:08.867] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:38:0) after 1m0s
[04:29:08.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:38:0)
[04:29:08.906] Timer tick, asking Buildbucket for the build status
[04:29:08.960] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:08.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:39:0) after 1m0s
[04:30:09.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:39:0)
[04:30:09.013] Timer tick, asking Buildbucket for the build status
[04:30:09.085] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:09.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:40:0) after 1m0s
[04:31:09.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:40:0)
[04:31:09.097] Timer tick, asking Buildbucket for the build status
[04:31:09.530] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:09.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:41:0) after 1m0s
[04:32:09.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:41:0)
[04:32:09.599] Timer tick, asking Buildbucket for the build status
[04:32:09.659] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:09.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:42:0) after 1m0s
[04:33:09.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:42:0)
[04:33:09.757] Timer tick, asking Buildbucket for the build status
[04:33:09.864] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:09.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:43:0) after 1m0s
[04:34:11.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:43:0)
[04:34:11.291] Timer tick, asking Buildbucket for the build status
[04:34:11.592] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:11.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:44:0) after 1m0s
[04:35:11.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:44:0)
[04:35:11.675] Timer tick, asking Buildbucket for the build status
[04:35:11.737] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:11.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:45:0) after 1m0s
[04:36:11.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:45:0)
[04:36:11.796] Timer tick, asking Buildbucket for the build status
[04:36:11.907] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:11.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:46:0) after 1m0s
[04:37:11.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:46:0)
[04:37:11.966] Timer tick, asking Buildbucket for the build status
[04:37:12.316] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:47:0) after 1m0s
[04:38:12.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:47:0)
[04:38:12.360] Timer tick, asking Buildbucket for the build status
[04:38:12.476] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:12.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:48:0) after 1m0s
[04:39:12.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:48:0)
[04:39:12.654] Timer tick, asking Buildbucket for the build status
[04:39:13.252] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:13.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:49:0) after 1m0s
[04:40:13.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:49:0)
[04:40:13.327] Timer tick, asking Buildbucket for the build status
[04:40:13.388] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:13.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:50:0) after 1m0s
[04:41:13.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:50:0)
[04:41:13.465] Timer tick, asking Buildbucket for the build status
[04:41:13.632] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:13.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:51:0) after 1m0s
[04:42:13.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:51:0)
[04:42:13.630] Timer tick, asking Buildbucket for the build status
[04:42:13.701] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:52:0) after 1m0s
[04:43:13.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:52:0)
[04:43:13.749] Timer tick, asking Buildbucket for the build status
[04:43:13.851] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:13.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:53:0) after 1m0s
[04:44:13.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:53:0)
[04:44:13.893] Timer tick, asking Buildbucket for the build status
[04:44:13.960] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:13.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:54:0) after 1m0s
[04:45:13.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:54:0)
[04:45:13.975] Timer tick, asking Buildbucket for the build status
[04:45:14.238] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:14.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:55:0) after 1m0s
[04:46:14.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:55:0)
[04:46:14.252] Timer tick, asking Buildbucket for the build status
[04:46:14.382] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:14.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:56:0) after 1m0s
[04:47:14.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:56:0)
[04:47:14.404] Timer tick, asking Buildbucket for the build status
[04:47:14.465] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:14.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:57:0) after 1m0s
[04:48:14.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:57:0)
[04:48:14.460] Timer tick, asking Buildbucket for the build status
[04:48:14.595] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:14.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:58:0) after 1m0s
[04:49:14.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:58:0)
[04:49:14.612] Timer tick, asking Buildbucket for the build status
[04:49:14.717] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:59:0) after 1m0s
[04:50:14.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:59:0)
[04:50:14.738] Timer tick, asking Buildbucket for the build status
[04:50:14.794] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:14.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:60:0) after 1m0s
[04:51:14.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:60:0)
[04:51:14.812] Timer tick, asking Buildbucket for the build status
[04:51:14.876] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:14.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:61:0) after 1m0s
[04:52:14.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:61:0)
[04:52:14.926] Timer tick, asking Buildbucket for the build status
[04:52:14.993] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:14.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:62:0) after 1m0s
[04:53:15.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:62:0)
[04:53:15.018] Timer tick, asking Buildbucket for the build status
[04:53:15.147] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:15.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:63:0) after 1m0s
[04:54:15.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:63:0)
[04:54:15.161] Timer tick, asking Buildbucket for the build status
[04:54:15.620] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:64:0) after 1m0s
[04:55:15.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:64:0)
[04:55:15.627] Timer tick, asking Buildbucket for the build status
[04:55:16.321] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:65:0) after 1m0s
[04:56:16.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:65:0)
[04:56:16.388] Timer tick, asking Buildbucket for the build status
[04:56:16.514] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:16.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:66:0) after 1m0s
[04:57:16.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:66:0)
[04:57:16.612] Timer tick, asking Buildbucket for the build status
[04:57:16.720] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:16.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:67:0) after 1m0s
[04:58:16.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:67:0)
[04:58:16.746] Timer tick, asking Buildbucket for the build status
[04:58:16.849] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:16.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:68:0) after 1m0s
[04:59:16.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:68:0)
[04:59:16.906] Timer tick, asking Buildbucket for the build status
[04:59:17.033] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:69:0) after 1m0s
[05:00:17.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:69:0)
[05:00:17.059] Timer tick, asking Buildbucket for the build status
[05:00:17.299] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:17.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:70:0) after 1m0s
[05:01:17.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:70:0)
[05:01:17.308] Timer tick, asking Buildbucket for the build status
[05:01:17.425] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:17.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:71:0) after 1m0s
[05:02:17.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:71:0)
[05:02:17.449] Timer tick, asking Buildbucket for the build status
[05:02:17.534] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:17.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:72:0) after 1m0s
[05:03:17.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:72:0)
[05:03:17.539] Timer tick, asking Buildbucket for the build status
[05:03:17.644] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:17.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:73:0) after 1m0s
[05:04:17.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:73:0)
[05:04:17.657] Timer tick, asking Buildbucket for the build status
[05:04:17.739] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:74:0) after 1m0s
[05:05:17.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:74:0)
[05:05:17.770] Timer tick, asking Buildbucket for the build status
[05:05:17.907] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:17.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:75:0) after 1m0s
[05:06:17.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:75:0)
[05:06:17.930] Timer tick, asking Buildbucket for the build status
[05:06:18.071] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:18.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:76:0) after 1m0s
[05:07:18.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:76:0)
[05:07:18.113] Timer tick, asking Buildbucket for the build status
[05:07:18.181] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:18.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:77:0) after 1m0s
[05:08:18.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:77:0)
[05:08:18.187] Timer tick, asking Buildbucket for the build status
[05:08:18.315] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:18.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:78:0) after 1m0s
[05:09:18.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:78:0)
[05:09:18.319] Timer tick, asking Buildbucket for the build status
[05:09:18.402] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:18.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:79:0) after 1m0s
[05:10:18.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:79:0)
[05:10:18.500] Timer tick, asking Buildbucket for the build status
[05:10:18.990] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:80:0) after 1m0s
[05:11:19.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:80:0)
[05:11:19.052] Timer tick, asking Buildbucket for the build status
[05:11:19.162] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:19.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:81:0) after 1m0s
[05:12:19.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:81:0)
[05:12:19.214] Timer tick, asking Buildbucket for the build status
[05:12:19.324] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:19.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:82:0) after 1m0s
[05:13:19.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:82:0)
[05:13:19.330] Timer tick, asking Buildbucket for the build status
[05:13:19.627] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:19.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:83:0) after 1m0s
[05:14:19.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:83:0)
[05:14:19.674] Timer tick, asking Buildbucket for the build status
[05:14:19.741] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:19.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:84:0) after 1m0s
[05:15:19.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:84:0)
[05:15:19.769] Timer tick, asking Buildbucket for the build status
[05:15:19.942] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:19.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:85:0) after 1m0s
[05:16:19.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:85:0)
[05:16:19.988] Timer tick, asking Buildbucket for the build status
[05:16:20.167] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:20.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:86:0) after 1m0s
[05:17:20.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:86:0)
[05:17:20.228] Timer tick, asking Buildbucket for the build status
[05:17:20.297] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:20.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:87:0) after 1m0s
[05:18:20.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:87:0)
[05:18:20.393] Timer tick, asking Buildbucket for the build status
[05:18:20.575] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:20.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:88:0) after 1m0s
[05:19:20.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:88:0)
[05:19:20.743] Timer tick, asking Buildbucket for the build status
[05:19:20.924] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:89:0) after 1m0s
[05:20:20.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:89:0)
[05:20:20.960] Timer tick, asking Buildbucket for the build status
[05:20:21.195] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:21.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:90:0) after 1m0s
[05:21:21.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:90:0)
[05:21:21.267] Timer tick, asking Buildbucket for the build status
[05:21:21.338] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:21.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:91:0) after 1m0s
[05:22:21.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:91:0)
[05:22:21.348] Timer tick, asking Buildbucket for the build status
[05:22:21.426] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:21.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:92:0) after 1m0s
[05:23:21.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:92:0)
[05:23:21.506] Timer tick, asking Buildbucket for the build status
[05:23:21.817] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:93:0) after 1m0s
[05:24:21.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:93:0)
[05:24:21.836] Timer tick, asking Buildbucket for the build status
[05:24:22.098] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:22.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:94:0) after 1m0s
[05:25:22.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:94:0)
[05:25:22.118] Timer tick, asking Buildbucket for the build status
[05:25:22.226] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:22.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:95:0) after 1m0s
[05:26:22.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:95:0)
[05:26:22.251] Timer tick, asking Buildbucket for the build status
[05:26:22.342] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:22.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:96:0) after 1m0s
[05:27:22.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:96:0)
[05:27:22.365] Timer tick, asking Buildbucket for the build status
[05:27:22.430] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:22.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:97:0) after 1m0s
[05:28:22.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:97:0)
[05:28:22.461] Timer tick, asking Buildbucket for the build status
[05:28:22.595] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:22.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:98:0) after 1m0s
[05:29:22.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:98:0)
[05:29:22.647] Timer tick, asking Buildbucket for the build status
[05:29:22.918] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:99:0) after 1m0s
[05:30:23.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:99:0)
[05:30:23.005] Timer tick, asking Buildbucket for the build status
[05:30:23.456] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:23.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:100:0) after 1m0s
[05:31:23.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:100:0)
[05:31:23.512] Timer tick, asking Buildbucket for the build status
[05:31:23.589] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:101:0) after 1m0s
[05:32:23.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:101:0)
[05:32:23.579] Timer tick, asking Buildbucket for the build status
[05:32:25.108] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:25.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:102:0) after 1m0s
[05:33:25.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:102:0)
[05:33:25.197] Timer tick, asking Buildbucket for the build status
[05:33:25.326] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:25.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:103:0) after 1m0s
[05:34:25.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:103:0)
[05:34:25.348] Timer tick, asking Buildbucket for the build status
[05:34:25.424] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:25.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:104:0) after 1m0s
[05:35:25.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:104:0)
[05:35:25.448] Timer tick, asking Buildbucket for the build status
[05:35:25.531] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:105:0) after 1m0s
[05:36:25.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:105:0)
[05:36:25.584] Timer tick, asking Buildbucket for the build status
[05:36:25.707] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:25.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:106:0) after 1m0s
[05:37:25.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:106:0)
[05:37:25.721] Timer tick, asking Buildbucket for the build status
[05:37:25.818] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:25.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:107:0) after 1m0s
[05:38:25.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:107:0)
[05:38:25.838] Timer tick, asking Buildbucket for the build status
[05:38:26.619] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:26.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:108:0) after 1m0s
[05:39:26.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:108:0)
[05:39:26.680] Timer tick, asking Buildbucket for the build status
[05:39:27.119] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:27.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:109:0) after 1m0s
[05:40:27.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:109:0)
[05:40:27.134] Timer tick, asking Buildbucket for the build status
[05:40:27.205] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:27.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:110:0) after 1m0s
[05:41:27.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:110:0)
[05:41:27.227] Timer tick, asking Buildbucket for the build status
[05:41:27.291] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:27.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:111:0) after 1m0s
[05:42:27.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:111:0)
[05:42:27.306] Timer tick, asking Buildbucket for the build status
[05:42:27.646] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:27.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:112:0) after 1m0s
[05:43:27.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:112:0)
[05:43:27.684] Timer tick, asking Buildbucket for the build status
[05:43:28.027] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:28.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:113:0) after 1m0s
[05:44:28.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:113:0)
[05:44:28.105] Timer tick, asking Buildbucket for the build status
[05:44:28.163] Build 8860969510067911344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:28.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026399572606373216:114:0) after 1m0s
[05:45:11.562] Received PubSub notification, asking Buildbucket for the build status
[05:45:11.641] Build 8860969510067911344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:45:11.641] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607924709427472",
"created_by": "project:chromium",
"created_ts": "1607917981997961",
"id": "8860969510067911344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\", \"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-140-35x4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21736, \"got_angle_revision\": \"da8c22614051f43cd4d44d6809eafb150310361a\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\", \"got_revision_cp\": \"refs/heads/master@{#836520}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"fdc632431816ab61fd53d15e4beec259eb07e6b6\", \"got_v8_revision_cp\": \"refs/heads/8.9.144@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6\", \"swarm_hashes_refs/heads/master(at){#836520}_without_patch\": {\"absl_hardening_tests\": \"3d98a7931552c97a2be053056c9068c82b29422a\", \"accessibility_unittests\": \"273daf2a2f271695acf0962c4543a86b859b8f68\", \"angle_unittests\": \"caccdfdbf4ea63e0b5b905ac7a19e9cf0777d3c4\", \"app_list_unittests\": \"302650a678e47c4e93d23215c484d452dbab6d50\", \"app_shell_unittests\": \"90f7fb6fb8bdac94bc4b01e57c41e32ff2e15875\", \"ash_unittests\": \"5ca34965514e47705e66d7ddb3ffbc016f13abf3\", \"aura_unittests\": \"c439ba01493a3e56c3a13651265ced909a9a2a4f\", \"base_unittests\": \"14ff044b8552b7f33b49b081b69874b7bbdeb0fa\", \"base_util_unittests\": \"35751627f05ce0b55c3ee608a14f307e36a7e681\", \"blink_common_unittests\": \"e85e7589585957dd991d6f19ecc5ba4ebc81df61\", \"blink_fuzzer_unittests\": \"fb1cfd586003d3b7d7829b9c41fc2e624af22dbc\", \"blink_heap_unittests\": \"5bb2b31a25426c42350af81e5c8134b376b455d4\", \"blink_platform_unittests\": \"7e8b063671f5cf73546c98de56bd7239007ba96e\", \"blink_unittests\": \"ff87dec43372810bb6258bd57796cf9c3829eea6\", \"boringssl_crypto_tests\": \"e98650c0faef1545381c8241bb88c81ead3cafc2\", \"boringssl_ssl_tests\": \"e94fb8c575ce66ec21ff9839996e4ad0e37170d9\", \"browser_tests\": \"24f40108b596e14115d30a364f8f8187b1cdf891\", \"capture_unittests\": \"1b413028f7290d4586a5647b9780100fc89e89f7\", \"cast_unittests\": \"db061e319f7ced0c2d9f079e09311d5095654020\", \"cc_unittests\": \"287c7dd72a652396ef2fac0d16bf020698b6f588\", \"chrome_app_unittests\": \"dd8a4e5ee2e0717918f4e4f725ccc9f4e53b1bdc\", \"chromedriver_unittests\": \"803a3cba75ed378b9c60be52673a4ff9617f8913\", \"chromeos_components_unittests\": \"05061abfb512a473efef608321580d10d17e0a69\", \"chromeos_unittests\": \"a954f5e411eefcaf3f5b0db4a5af6fc32501c569\", \"components_browsertests\": \"da4aec8f604cad811073790c87a77ab331f28ee8\", \"components_unittests\": \"3a5c81b61855cb346d3abe132e33121ff32e1d7c\", \"compositor_unittests\": \"7cbe9ea9168abf84f60b4b3416f8c422dad5da6e\", \"content_browsertests\": \"d1e81a163f1d60b57b6cb458a0ed5cfb62bfde80\", \"content_unittests\": \"d8d922856ae5ca28d89d1d779326a16c8e362842\", \"crashpad_tests\": \"1ad7d7d514706581108c85e91d51c5bf5157bd88\", \"crypto_unittests\": \"d88c93177aa30087fbaa16961e6e7e472c9a9d85\", \"dbus_unittests\": \"9492bae93dfcd58bc6190ce5558a806a7e3bd90f\", \"device_unittests\": \"f1fa69f816ecd09ef301020bf9c9a5b34c6522d0\", \"display_unittests\": \"caa434dc089975e7141c4759e62b6782c676f14b\", \"events_unittests\": \"0a908f5a71c27d216019264eb7a0eac55f73d21a\", \"exo_unittests\": \"d56a316914531fa3a064bb40eada72b6a1b4221d\", \"extensions_browsertests\": \"2d8b3af047fff28aacad321c1acd9fbdc19954b5\", \"extensions_unittests\": \"33204539519cc6288dd77e30420ed66622ba568b\", \"filesystem_service_unittests\": \"4e992359a19fb3c131c89f85a597a44866f942dd\", \"gcm_unit_tests\": \"77c19cdd703f542d1c478a567d2763f655f879eb\", \"gfx_unittests\": \"ee05a9738665c862693c83960c9b131ee7d25e23\", \"gin_unittests\": \"6f1566f14e7c119a5984cfc5a32a0cad609516af\", \"gl_unittests_ozone\": \"424d938e3ec4ea4974d4059603956c3e24bf7200\", \"google_apis_unittests\": \"fda319c3146d0bb33740b4c1b231e38a1e168493\", \"gpu_unittests\": \"eedd7f3c6dbd75bf1b8bb11680262a6106df5bd2\", \"gwp_asan_unittests\": \"6613f7a716602fd80826d3020620f63ed3eb258b\", \"interactive_ui_tests\": \"56d353e24002f1f81395831f0ce83f4e9ff926c6\", \"ipc_tests\": \"85f6046ff1ebf4c5524f914f531d5e02846c1606\", \"jingle_unittests\": \"3bbed2642e1b7624c16968b62de02addb326f1b1\", \"keyboard_unittests\": \"e5c38ef46bdae2250935bd687c33c68bd089d689\", \"latency_unittests\": \"60e4152aa5a83056b873f2e5a64386d81fcefd61\", \"libjingle_xmpp_unittests\": \"f454c6c9d38829dc83ddaf49f94ecc4b87c8abb5\", \"liburlpattern_unittests\": \"3492fbc09c855a4574df1965c95c8c547f84ac80\", \"media_blink_unittests\": \"7037ffd51c61a39b8ebee50473f68b45debb15d6\", \"media_unittests\": \"5be9320501e65032d76ac9e4ad50b3b845dbfcb9\", \"message_center_unittests\": \"1dbbb83200f2d923eb9b767bb1e3230e9e752afe\", \"midi_unittests\": \"7c70bec0506eafcdb18a92cd4fd0f7fa3c406001\", \"mojo_core_unittests\": \"1e3c4caff035a39f417a8f36ab328005e50875b6\", \"mojo_unittests\": \"44e5fd77176ff74b9ab14cf83227cf0e0ac566aa\", \"nacl_helper_nonsfi_unittests\": \"8729acfde2c804700271a02ee0e0dc65a4bcf2db\", \"nacl_loader_unittests\": \"43a37a6acedc5b18423a2ad132b021f87de6479d\", \"native_theme_unittests\": \"21621bdf2916be1febdd1884eb3193033ad383b6\", \"net_unittests\": \"54e8080a5fc07a4f5cd9505994d2cb2e090360c4\", \"ozone_gl_unittests\": \"3d628cec649ba146bddcdb33c263ffadca3e39c6\", \"ozone_unittests\": \"53f3a1fcc0984f1e3a4daafde827a4c7e91d7324\", \"ozone_x11_unittests\": \"272605fc5419d832af3e12281002fddc3b9612df\", \"pdf_unittests\": \"eb9f391f90a243fa1767777433572205fe5056e8\", \"perfetto_unittests\": \"14b76f8b99f31601a57e22121d9c4dd7c7a1cb64\", \"ppapi_unittests\": \"7c81627437141835a6f9a328559d0222da553b63\", \"printing_unittests\": \"065558a8df8c7160ab4756c5e3367c1fd2a3c1a5\", \"remoting_unittests\": \"35626124894cd94fd3f8800daa54ccdef76321c8\", \"sandbox_linux_unittests\": \"352333b3d4d27a5370d197bd4a0a95989a73bd6f\", \"service_manager_unittests\": \"dc7b499fba3886cf561c74230fe8d0c838689f6f\", \"services_unittests\": \"af3ffd6baa064e3c252cc526cebf99b8e438ba22\", \"shell_dialogs_unittests\": \"917c8723242d8538864979864090c6caa62ed80d\", \"shell_encryption_unittests\": \"6c3f3b6fdf9d8c204c6ef0028343082aa4e11ae7\", \"skia_unittests\": \"eb6b26ad514228d05435125e0af2b51b70b89b63\", \"snapshot_unittests\": \"7556a82d99557de6b004229aae36f94569ca8e5a\", \"sql_unittests\": \"d2ddc5fe45cd98e77cf51ebffec00aefcc9e9733\", \"storage_unittests\": \"215317ce97ce8a32f633a565da0634ffeea3f72c\", \"sync_integration_tests\": \"9676d78882a34102405fa109f068d0d613689a54\", \"traffic_annotation_auditor_unittests\": \"28b6f2f4db50a6bc8a9aea29b3981daf04225c97\", \"ui_base_unittests\": \"bee48a6d7386b0bd06dcd6dba4e8de0871beedcc\", \"ui_chromeos_unittests\": \"815ea2b179d9c24c7f10086e7fcfc66bfe3cbd43\", \"ui_touch_selection_unittests\": \"3d444ae229f3266d60b551410b93568555743b01\", \"unit_tests\": \"afebb99534ae99d90a0b60a73a1e7ff653f6436d\", \"url_unittests\": \"aff9bc35b94f3c2941395343ddf0b98750921cbe\", \"usage_time_limit_unittests\": \"a10b30cb78b1556ffc49b081f20f83af7d1a5cc6\", \"views_unittests\": \"86af6234c98075f35abb00ad7d6f26b458f791ce\", \"viz_unittests\": \"66083a712f81fa907a8d670532d8fec86c5be29f\", \"wm_unittests\": \"6802888ba3db3af73f7cfea100f74184b1d10d06\", \"wtf_unittests\": \"b97c5286f302e47a89e8e25be7c2986ad7afd613\", \"zlib_unittests\": \"f33e8ba2833b71c4c7c0074f9dbac3f5e72d198a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_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-140-35x4\"], \"image\": [\"chrome-xenial-20120600-c5cfbe11ce8\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607918291264562",
"status": "COMPLETED",
"status_changed_ts": "1607924709845239",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21736",
"builder:linux-chromeos-dbg",
"buildset:commit/git/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d7e47f4e775ac2d1104b7d3b7a0de9ea7791dc6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026399572606373216",
"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/8860969510067911344/+/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:507832de1ff11b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607924709849569",
"url": "https://ci.chromium.org/b/8860969510067911344",
"utcnow_ts": "1607924711630808"
}
}
[05:45:11.641] Invocation finished in 1h52m11.44906294s with status SUCCEEDED