[17:42:58.655] New invocation is queued and will start shortly
[17:43:05.042] Starting the invocation (attempt 1)
[17:43:05.079] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:05.079] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:05.079] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022270491661996032",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022270491661996032",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"gitiles_ref:refs/heads/master"
]
}
[17:43:06.369] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611855785225681",
"id": "8856840424110423120",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611855786084599",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22386",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022270491661996032",
"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/8856840424110423120/+/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": "1611855786084781",
"url": "https://ci.chromium.org/b/8856840424110423120",
"utcnow_ts": "1611855786350013"
}
}
[17:43:06.369] Task URL: https://ci.chromium.org/b/8856840424110423120
[17:43:06.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:2:0) after 1m0s
[17:43:38.634] Received PubSub notification, asking Buildbucket for the build status
[17:43:38.711] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:06.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:2:0)
[17:44:06.467] Timer tick, asking Buildbucket for the build status
[17:44:06.699] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:06.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:4:0) after 1m0s
[17:45:06.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:4:0)
[17:45:06.762] Timer tick, asking Buildbucket for the build status
[17:45:07.675] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:07.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:5:0) after 1m0s
[17:46:07.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:5:0)
[17:46:07.871] Timer tick, asking Buildbucket for the build status
[17:46:09.112] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:09.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:6:0) after 1m0s
[17:47:09.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:6:0)
[17:47:09.476] Timer tick, asking Buildbucket for the build status
[17:47:09.646] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:09.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:7:0) after 1m0s
[17:48:09.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:7:0)
[17:48:09.903] Timer tick, asking Buildbucket for the build status
[17:48:10.206] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:10.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:8:0) after 1m0s
[17:49:10.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:8:0)
[17:49:10.520] Timer tick, asking Buildbucket for the build status
[17:49:10.802] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:10.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:9:0) after 1m0s
[17:50:10.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:9:0)
[17:50:10.816] Timer tick, asking Buildbucket for the build status
[17:50:10.972] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:10.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:10:0) after 1m0s
[17:51:11.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:10:0)
[17:51:11.080] Timer tick, asking Buildbucket for the build status
[17:51:11.201] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:11.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:11:0) after 1m0s
[17:52:11.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:11:0)
[17:52:11.243] Timer tick, asking Buildbucket for the build status
[17:52:11.447] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:11.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:12:0) after 1m0s
[17:53:11.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:12:0)
[17:53:11.469] Timer tick, asking Buildbucket for the build status
[17:53:12.046] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:12.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:13:0) after 1m0s
[17:54:12.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:13:0)
[17:54:12.102] Timer tick, asking Buildbucket for the build status
[17:54:14.543] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:14:0) after 1m0s
[17:55:14.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:14:0)
[17:55:14.564] Timer tick, asking Buildbucket for the build status
[17:55:14.671] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:14.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:15:0) after 1m0s
[17:56:14.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:15:0)
[17:56:14.733] Timer tick, asking Buildbucket for the build status
[17:56:14.890] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:14.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:16:0) after 1m0s
[17:57:14.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:16:0)
[17:57:14.888] Timer tick, asking Buildbucket for the build status
[17:57:14.953] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:17:0) after 1m0s
[17:58:14.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:17:0)
[17:58:14.979] Timer tick, asking Buildbucket for the build status
[17:58:15.102] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:15.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:18:0) after 1m0s
[17:59:15.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:18:0)
[17:59:15.150] Timer tick, asking Buildbucket for the build status
[17:59:15.245] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:15.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:19:0) after 1m0s
[18:00:15.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:19:0)
[18:00:15.414] Timer tick, asking Buildbucket for the build status
[18:00:15.662] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:15.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:20:0) after 1m0s
[18:01:15.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:20:0)
[18:01:15.725] Timer tick, asking Buildbucket for the build status
[18:01:15.819] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:15.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:21:0) after 1m0s
[18:02:15.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:21:0)
[18:02:15.925] Timer tick, asking Buildbucket for the build status
[18:02:16.087] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:22:0) after 1m0s
[18:03:16.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:22:0)
[18:03:16.111] Timer tick, asking Buildbucket for the build status
[18:03:16.422] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:16.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:23:0) after 1m0s
[18:04:16.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:23:0)
[18:04:16.453] Timer tick, asking Buildbucket for the build status
[18:04:16.515] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:16.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:24:0) after 1m0s
[18:05:16.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:24:0)
[18:05:16.552] Timer tick, asking Buildbucket for the build status
[18:05:16.661] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:16.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:25:0) after 1m0s
[18:06:16.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:25:0)
[18:06:16.685] Timer tick, asking Buildbucket for the build status
[18:06:16.772] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:16.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:26:0) after 1m0s
[18:07:16.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:26:0)
[18:07:16.796] Timer tick, asking Buildbucket for the build status
[18:07:17.046] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:17.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:27:0) after 1m0s
[18:08:17.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:27:0)
[18:08:17.028] Timer tick, asking Buildbucket for the build status
[18:08:17.152] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:28:0) after 1m0s
[18:09:17.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:28:0)
[18:09:17.184] Timer tick, asking Buildbucket for the build status
[18:09:17.278] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:17.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:29:0) after 1m0s
[18:10:17.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:29:0)
[18:10:17.302] Timer tick, asking Buildbucket for the build status
[18:10:17.573] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:17.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:30:0) after 1m0s
[18:11:17.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:30:0)
[18:11:17.693] Timer tick, asking Buildbucket for the build status
[18:11:18.080] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:18.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:31:0) after 1m0s
[18:12:18.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:31:0)
[18:12:18.135] Timer tick, asking Buildbucket for the build status
[18:12:18.205] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:18.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:32:0) after 1m0s
[18:13:18.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:32:0)
[18:13:18.257] Timer tick, asking Buildbucket for the build status
[18:13:18.375] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:18.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:33:0) after 1m0s
[18:14:18.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:33:0)
[18:14:18.422] Timer tick, asking Buildbucket for the build status
[18:14:18.723] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:18.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:34:0) after 1m0s
[18:15:18.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:34:0)
[18:15:18.825] Timer tick, asking Buildbucket for the build status
[18:15:18.978] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:18.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:35:0) after 1m0s
[18:16:19.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:35:0)
[18:16:19.055] Timer tick, asking Buildbucket for the build status
[18:16:19.197] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:19.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:36:0) after 1m0s
[18:17:19.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:36:0)
[18:17:19.234] Timer tick, asking Buildbucket for the build status
[18:17:19.307] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:19.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:37:0) after 1m0s
[18:18:19.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:37:0)
[18:18:19.472] Timer tick, asking Buildbucket for the build status
[18:18:19.639] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:19.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:38:0) after 1m0s
[18:19:19.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:38:0)
[18:19:19.698] Timer tick, asking Buildbucket for the build status
[18:19:19.762] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:19.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:39:0) after 1m0s
[18:20:19.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:39:0)
[18:20:19.969] Timer tick, asking Buildbucket for the build status
[18:20:20.603] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:40:0) after 1m0s
[18:21:20.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:40:0)
[18:21:20.673] Timer tick, asking Buildbucket for the build status
[18:21:21.240] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:21.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:41:0) after 1m0s
[18:22:22.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:41:0)
[18:22:22.148] Timer tick, asking Buildbucket for the build status
[18:22:22.312] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:22.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:42:0) after 1m0s
[18:23:22.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:42:0)
[18:23:22.358] Timer tick, asking Buildbucket for the build status
[18:23:22.740] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:22.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:43:0) after 1m0s
[18:24:22.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:43:0)
[18:24:22.798] Timer tick, asking Buildbucket for the build status
[18:24:23.077] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:23.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:44:0) after 1m0s
[18:25:23.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:44:0)
[18:25:23.186] Timer tick, asking Buildbucket for the build status
[18:25:23.512] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:23.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:45:0) after 1m0s
[18:26:23.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:45:0)
[18:26:23.569] Timer tick, asking Buildbucket for the build status
[18:26:23.644] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:46:0) after 1m0s
[18:27:23.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:46:0)
[18:27:23.732] Timer tick, asking Buildbucket for the build status
[18:27:23.868] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:23.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:47:0) after 1m0s
[18:28:23.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:47:0)
[18:28:23.918] Timer tick, asking Buildbucket for the build status
[18:28:24.151] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:24.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:48:0) after 1m0s
[18:29:24.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:48:0)
[18:29:24.200] Timer tick, asking Buildbucket for the build status
[18:29:24.301] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:24.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:49:0) after 1m0s
[18:30:24.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:49:0)
[18:30:24.376] Timer tick, asking Buildbucket for the build status
[18:30:24.613] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:24.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:50:0) after 1m0s
[18:31:24.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:50:0)
[18:31:24.727] Timer tick, asking Buildbucket for the build status
[18:31:24.926] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:24.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:51:0) after 1m0s
[18:32:24.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:51:0)
[18:32:24.917] Timer tick, asking Buildbucket for the build status
[18:32:25.718] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:25.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:52:0) after 1m0s
[18:33:25.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:52:0)
[18:33:25.783] Timer tick, asking Buildbucket for the build status
[18:33:25.902] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:25.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:53:0) after 1m0s
[18:34:25.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:53:0)
[18:34:25.948] Timer tick, asking Buildbucket for the build status
[18:34:26.424] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:26.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:54:0) after 1m0s
[18:35:26.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:54:0)
[18:35:26.450] Timer tick, asking Buildbucket for the build status
[18:35:26.645] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:26.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:55:0) after 1m0s
[18:36:26.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:55:0)
[18:36:26.718] Timer tick, asking Buildbucket for the build status
[18:36:26.986] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:56:0) after 1m0s
[18:37:26.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:56:0)
[18:37:26.999] Timer tick, asking Buildbucket for the build status
[18:37:27.135] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:27.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:57:0) after 1m0s
[18:38:27.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:57:0)
[18:38:27.160] Timer tick, asking Buildbucket for the build status
[18:38:27.269] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:27.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:58:0) after 1m0s
[18:39:27.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:58:0)
[18:39:27.311] Timer tick, asking Buildbucket for the build status
[18:39:27.645] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:59:0) after 1m0s
[18:40:27.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:59:0)
[18:40:27.729] Timer tick, asking Buildbucket for the build status
[18:40:27.882] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:27.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:60:0) after 1m0s
[18:41:28.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:60:0)
[18:41:28.006] Timer tick, asking Buildbucket for the build status
[18:41:28.125] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:28.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:61:0) after 1m0s
[18:42:28.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:61:0)
[18:42:28.200] Timer tick, asking Buildbucket for the build status
[18:42:28.269] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:62:0) after 1m0s
[18:43:28.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:62:0)
[18:43:28.312] Timer tick, asking Buildbucket for the build status
[18:43:28.461] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:28.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:63:0) after 1m0s
[18:44:28.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:63:0)
[18:44:28.497] Timer tick, asking Buildbucket for the build status
[18:44:28.967] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:28.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:64:0) after 1m0s
[18:45:30.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:64:0)
[18:45:30.229] Timer tick, asking Buildbucket for the build status
[18:45:30.999] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:65:0) after 1m0s
[18:46:31.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:65:0)
[18:46:31.370] Timer tick, asking Buildbucket for the build status
[18:46:31.512] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:31.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:66:0) after 1m0s
[18:47:31.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:66:0)
[18:47:31.872] Timer tick, asking Buildbucket for the build status
[18:47:32.109] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:32.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:67:0) after 1m0s
[18:48:32.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:67:0)
[18:48:32.171] Timer tick, asking Buildbucket for the build status
[18:48:32.345] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:32.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:68:0) after 1m0s
[18:49:33.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:68:0)
[18:49:33.771] Timer tick, asking Buildbucket for the build status
[18:49:33.875] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:33.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:69:0) after 1m0s
[18:50:33.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:69:0)
[18:50:33.977] Timer tick, asking Buildbucket for the build status
[18:50:34.184] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:34.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:70:0) after 1m0s
[18:51:34.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:70:0)
[18:51:34.281] Timer tick, asking Buildbucket for the build status
[18:51:34.346] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:34.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:71:0) after 1m0s
[18:52:34.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:71:0)
[18:52:34.417] Timer tick, asking Buildbucket for the build status
[18:52:34.650] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:34.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:72:0) after 1m0s
[18:53:34.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:72:0)
[18:53:34.730] Timer tick, asking Buildbucket for the build status
[18:53:35.018] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:73:0) after 1m0s
[18:54:35.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:73:0)
[18:54:35.046] Timer tick, asking Buildbucket for the build status
[18:54:35.509] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:35.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:74:0) after 1m0s
[18:55:35.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:74:0)
[18:55:35.577] Timer tick, asking Buildbucket for the build status
[18:55:36.106] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:36.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:75:0) after 1m0s
[18:56:36.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:75:0)
[18:56:36.135] Timer tick, asking Buildbucket for the build status
[18:56:36.760] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:36.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:76:0) after 1m0s
[18:57:36.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:76:0)
[18:57:36.832] Timer tick, asking Buildbucket for the build status
[18:57:37.011] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:37.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:77:0) after 1m0s
[18:58:37.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:77:0)
[18:58:37.056] Timer tick, asking Buildbucket for the build status
[18:58:37.588] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:37.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:78:0) after 1m0s
[18:59:37.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:78:0)
[18:59:37.598] Timer tick, asking Buildbucket for the build status
[18:59:37.974] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:37.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:79:0) after 1m0s
[19:00:38.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:79:0)
[19:00:38.102] Timer tick, asking Buildbucket for the build status
[19:00:38.817] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:38.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:80:0) after 1m0s
[19:01:38.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:80:0)
[19:01:38.875] Timer tick, asking Buildbucket for the build status
[19:01:39.259] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:39.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:81:0) after 1m0s
[19:02:39.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:81:0)
[19:02:39.319] Timer tick, asking Buildbucket for the build status
[19:02:39.565] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:39.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:82:0) after 1m0s
[19:03:39.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:82:0)
[19:03:39.636] Timer tick, asking Buildbucket for the build status
[19:03:39.864] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:39.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:83:0) after 1m0s
[19:04:39.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:83:0)
[19:04:39.888] Timer tick, asking Buildbucket for the build status
[19:04:40.028] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:40.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:84:0) after 1m0s
[19:05:40.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:84:0)
[19:05:40.089] Timer tick, asking Buildbucket for the build status
[19:05:40.685] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:85:0) after 1m0s
[19:06:40.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:85:0)
[19:06:40.711] Timer tick, asking Buildbucket for the build status
[19:06:41.005] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:41.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:86:0) after 1m0s
[19:07:41.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:86:0)
[19:07:41.053] Timer tick, asking Buildbucket for the build status
[19:07:41.304] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:41.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:87:0) after 1m0s
[19:08:41.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:87:0)
[19:08:41.332] Timer tick, asking Buildbucket for the build status
[19:08:41.946] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:41.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:88:0) after 1m0s
[19:09:41.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:88:0)
[19:09:41.967] Timer tick, asking Buildbucket for the build status
[19:09:44.458] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:44.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:89:0) after 1m0s
[19:10:44.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:89:0)
[19:10:44.507] Timer tick, asking Buildbucket for the build status
[19:10:44.679] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:44.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:90:0) after 1m0s
[19:11:44.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:90:0)
[19:11:44.798] Timer tick, asking Buildbucket for the build status
[19:11:46.353] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:46.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:91:0) after 1m0s
[19:12:46.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:91:0)
[19:12:46.390] Timer tick, asking Buildbucket for the build status
[19:12:46.485] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:46.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:92:0) after 1m0s
[19:13:46.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:92:0)
[19:13:46.751] Timer tick, asking Buildbucket for the build status
[19:13:47.373] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:47.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:93:0) after 1m0s
[19:14:47.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:93:0)
[19:14:47.523] Timer tick, asking Buildbucket for the build status
[19:14:48.379] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:48.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:94:0) after 1m0s
[19:15:48.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:94:0)
[19:15:48.455] Timer tick, asking Buildbucket for the build status
[19:15:48.698] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:48.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:95:0) after 1m0s
[19:16:48.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:95:0)
[19:16:48.749] Timer tick, asking Buildbucket for the build status
[19:16:49.329] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:96:0) after 1m0s
[19:17:49.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:96:0)
[19:17:49.409] Timer tick, asking Buildbucket for the build status
[19:17:49.522] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:49.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:97:0) after 1m0s
[19:18:49.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:97:0)
[19:18:49.522] Timer tick, asking Buildbucket for the build status
[19:18:49.733] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:49.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:98:0) after 1m0s
[19:19:49.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:98:0)
[19:19:49.781] Timer tick, asking Buildbucket for the build status
[19:19:49.881] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:49.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:99:0) after 1m0s
[19:20:49.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:99:0)
[19:20:49.953] Timer tick, asking Buildbucket for the build status
[19:20:50.683] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:50.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:100:0) after 1m0s
[19:21:50.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:100:0)
[19:21:50.784] Timer tick, asking Buildbucket for the build status
[19:21:50.904] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:50.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:101:0) after 1m0s
[19:22:50.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:101:0)
[19:22:50.926] Timer tick, asking Buildbucket for the build status
[19:22:51.043] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:51.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:102:0) after 1m0s
[19:23:51.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:102:0)
[19:23:51.116] Timer tick, asking Buildbucket for the build status
[19:23:51.292] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:51.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:103:0) after 1m0s
[19:24:51.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:103:0)
[19:24:51.363] Timer tick, asking Buildbucket for the build status
[19:24:51.485] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:51.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:104:0) after 1m0s
[19:25:51.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:104:0)
[19:25:51.568] Timer tick, asking Buildbucket for the build status
[19:25:51.901] Build 8856840424110423120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:51.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022270491661996032:105:0) after 1m0s
[19:26:49.173] Received PubSub notification, asking Buildbucket for the build status
[19:26:49.319] Build 8856840424110423120: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:26:49.319] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611862007270486",
"created_by": "project:chromium",
"created_ts": "1611855785225681",
"id": "8856840424110423120",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\"}}",
"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\": \"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\", \"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-214-1slc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22386, \"got_angle_revision\": \"4ce2e2135123407e09e37eb2f3400fd263febecc\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\", \"got_revision_cp\": \"refs/heads/master@{#848159}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"f569a18017889537012ab0775ec21101f1b2f7c6\", \"got_v8_revision_cp\": \"refs/heads/9.0.97@{#1}\", \"got_webrtc_revision\": \"b70c9531ee0c00d5d8aa104a3e5b76e6bc1412b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33084}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"prev_got_revision\": \"84faf63625376560b7ca9697d09564cd537a1323\", \"prev_got_revision_cp\": \"refs/heads/master@{#848093}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a72084e865022b09ca41fbc4a571f6dbf3c3bd3f\", \"swarm_hashes_refs/heads/master(at){#848159}_without_patch\": {\"absl_hardening_tests\": \"c17e3300284539d2731b926498266758563aadf7\", \"accessibility_unittests\": \"9b0074220779402557e22b72cb6384831714e132\", \"angle_unittests\": \"4425347f076711752ff5a6180b99f88a9ea9a54e\", \"app_list_unittests\": \"0f59bc9c3b107bb9600e38aa4eec1bc6ef86eaa0\", \"app_shell_unittests\": \"0775149e18b4b1c88406f2302a211f483ffbf9d0\", \"ash_unittests\": \"4e58ecb625556573bb775da371b08e2ecd5bb912\", \"aura_unittests\": \"6d02e89d2aa5add70203b2f7c273c65ed805f7b5\", \"base_unittests\": \"b8e02d5cc4162bdd37592a6b9a0cc3c62f5399b2\", \"base_util_unittests\": \"ae683c51f5314345d810c8a9e5c01c65b1f1741d\", \"blink_common_unittests\": \"4f0eb28e982f675739dfe7bb0b678bef0bbac178\", \"blink_fuzzer_unittests\": \"88c10ea9095668b62a97aad3d79978f696015976\", \"blink_heap_unittests\": \"138bef89f6118372295bab33422a8a759faacdca\", \"blink_platform_unittests\": \"f51f2578129a7e8f3db40a5fbd1eae115e1da076\", \"blink_unittests\": \"f6246f7b20528ae5aaeb7978291edf38a753b653\", \"boringssl_crypto_tests\": \"008213224aeb0f542c366e2a0e260c6280215b31\", \"boringssl_ssl_tests\": \"011d863911e5d3a00607d1e3caf79e6fdc7c3b04\", \"browser_tests\": \"20f61529a6f59d5fc51cdc45d6e6c72ba1562d96\", \"capture_unittests\": \"c93cf8b9e2fdb3a5ef0f2a457d46691d26d15191\", \"cast_unittests\": \"0ee97df7639aa7dcc649b0017b8bd5c5309344c6\", \"cc_unittests\": \"d13b5a7e7b744f6dfc9a730d6bc04a0130fb3e7c\", \"chrome_app_unittests\": \"cd647e72755d08b015c7571b0013112e6f812f56\", \"chromedriver_unittests\": \"f750b0e6f3188bcbf97e6c5c921fd9ff1e8189f2\", \"chromeos_components_unittests\": \"47d0e03c274f3ccaa5675aac1cf87f990d5c8e31\", \"chromeos_unittests\": \"fe88b019281bf6f6079b5e2afbcfc8bd75c26122\", \"components_browsertests\": \"553aef0bef308e0408f9c42152e359f515ac591f\", \"components_unittests\": \"4322ffdaa16c2122f809ea43ee149d94cf3dc50f\", \"compositor_unittests\": \"bfd3946fb83ce5ea39809409132cc905f9ebec3b\", \"content_browsertests\": \"2ea139f57e47596d320ea4cb22c65157e245d11a\", \"content_unittests\": \"2348ec026466999415b5234979faea36cf060337\", \"crashpad_tests\": \"cde3f5e6486a8c3f6874de3c8807561ebc1b851d\", \"crypto_unittests\": \"b253e872e0765c4bb0aa030c7f9106ea079547e2\", \"dbus_unittests\": \"4147fa04b700a1655ff1b5430fc35748235d4cc0\", \"device_unittests\": \"01629ba06d2e28dbb773b641b7da151f3dac3bb2\", \"display_unittests\": \"0abc19e3e8776547fad54543d837a0197434874b\", \"events_unittests\": \"e1a96663a20e5f2e5747d75029ef9eb5d404ad16\", \"exo_unittests\": \"d48c1196c9943940095bd8bba03ca1ed84a0d27f\", \"extensions_browsertests\": \"276e7559589110729c9abac2f09491e149a69b0b\", \"extensions_unittests\": \"40aaa14685bdc9a65973b09b2db6860c2c093d97\", \"filesystem_service_unittests\": \"cb6de3bc31085c0a1498b9dfc7368da06a7c4c21\", \"gcm_unit_tests\": \"60707293676f11a9eaccfed5af7e62b9511ca4a6\", \"gfx_unittests\": \"5566dc017ce706923623fab99dd623c20e4308d4\", \"gin_unittests\": \"b3807c25ded16e5ca43c669104e052127db3faf8\", \"gl_unittests_ozone\": \"3bce9f43d8caa3ea3598a0d017c2320f226c10cb\", \"google_apis_unittests\": \"45923f31f473ecbc2ea09e08baf778b02eaf83d7\", \"gpu_unittests\": \"b226fd06d48f853c60e999e5034608f745623ea1\", \"gwp_asan_unittests\": \"de9678a014e19dc6d376026f832f4337ef444daa\", \"interactive_ui_tests\": \"c33bb6c2a61747a345b5ae291b138989749216ec\", \"ipc_tests\": \"22da24c956689b888856720d8543f2b3219f6db3\", \"jingle_unittests\": \"4e94b908578ab32a8ee24584e1ac7d38ad6a0299\", \"keyboard_unittests\": \"dab69bd0981922f18b58e2adfbb7b89eca160b8c\", \"latency_unittests\": \"8f7c155420edd8f87f14cb69a184818d3250becb\", \"libjingle_xmpp_unittests\": \"aab9be884f4103cdd67de61bc8e9b379abf739a4\", \"liburlpattern_unittests\": \"a30e4d93c07436a7becfc4ffbcac16e127c73694\", \"media_blink_unittests\": \"8e4f46f5de2db2ac2cde831d2126b108c1ab4dac\", \"media_unittests\": \"72a17dbc6e000429d7e4ad6e170c231dbae2b055\", \"message_center_unittests\": \"e08ae5caa93a5bc5daefbe7e5b4869fbe8507171\", \"midi_unittests\": \"6d59f9736272f4babf7292e1f21197651e7fa081\", \"mojo_core_unittests\": \"0f1045928e43c2e5bd403ca038990c7257f2ee59\", \"mojo_unittests\": \"548c2d67edc883ebbf2401192f714c69322c278d\", \"nacl_helper_nonsfi_unittests\": \"11ee7c8c0379aa67fec9aace0bab91be89d47a3e\", \"nacl_loader_unittests\": \"e0600d1059370da6b812457abecce67f513dd807\", \"native_theme_unittests\": \"94aac87b5a032534519d0c23214bdbf8b723f759\", \"net_unittests\": \"3afdebb2e9586b4405124e898abae9b212056fe1\", \"ozone_gl_unittests\": \"0fee1f163b2919cb15f9b2545434db28637dba51\", \"ozone_unittests\": \"c4951cadfb9fc5e157c5b5aa35cc85ce1c16602d\", \"ozone_x11_unittests\": \"b2e8ee30fc1cb20b91139e2b1a91a550717d6c04\", \"pdf_unittests\": \"023f9d348fa099b195c44645056003e92c7d0d6a\", \"perfetto_unittests\": \"616497fb7150dd214c29adc02d4bf14a53e021cf\", \"ppapi_unittests\": \"12fc9e992f69380e39399811928e2c142290df35\", \"printing_unittests\": \"1e71c94320c78be314c9c84d8dbd98d17e03a1ef\", \"remoting_unittests\": \"d430eeb40814b9381eac8804782daa10a7921ac8\", \"sandbox_linux_unittests\": \"e66d8c909f4ac7d96248c931d5a2a736650df7a3\", \"service_manager_unittests\": \"cccfbd1afed9ff2e0e76fe82bb8d0017fba50827\", \"services_unittests\": \"fc52c0feefcf942a88c611130be45b432806ae26\", \"shell_dialogs_unittests\": \"9d793e61b7931ba98da22ddb2ddfc58c11d42288\", \"shell_encryption_unittests\": \"e68b850e67f5c3054baecf213fcfa5481e562ae8\", \"skia_unittests\": \"dba8edcebdb4ddd62143a1b66123bf1aea5ad4a3\", \"snapshot_unittests\": \"06af0848ed687e1cc3fe5836ff2f8aed7756aad0\", \"sql_unittests\": \"98ca26ada54196718e514c9766bf40ef07909bbd\", \"storage_unittests\": \"f0ceb0d9f34930032b5fa7f3fa9cef535b16d6a2\", \"sync_integration_tests\": \"64e4c43a68b9959e0971ea6f422b2570c9891785\", \"traffic_annotation_auditor_unittests\": \"7eef85b96c74009a6e554f0c3911f7183a003778\", \"ui_base_unittests\": \"d87285effca04b80f2b79b843375510dae769644\", \"ui_chromeos_unittests\": \"2bfe6a6829dd340b3f9b84567e6548541317664a\", \"ui_touch_selection_unittests\": \"f51362bc569f9f75ba102687ec302cfe445b6780\", \"unit_tests\": \"dcb88ec005beefd6afe60c70a4df895c017139df\", \"url_unittests\": \"3f34aee68bb149f5fc5e1595c3007b6c517292d9\", \"usage_time_limit_unittests\": \"fa4107bfe6f2d6e257af8c397ce71ecd28f9ed7f\", \"views_unittests\": \"eef4229d0324af8b2120dcee0bf2c5a6322c1a12\", \"viz_unittests\": \"b3b14d619c9aa8f967801eeaaea93222e2eb8d1b\", \"wm_unittests\": \"948cec91e75f3ee495e385893344062ab1053741\", \"wtf_unittests\": \"216f55e4ff4c1779074e40bc7d25f21c7d7e4ab2\", \"zlib_unittests\": \"615a36fec630d4ebcff2e031d78b6d4818288070\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_158d0f10fa5d87b7b90de0551ce233e88e46559602c021beec49ce89728c3318_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_b6367afba840c5eef309d6435187ce32d936dc893e5a665719688ecda1f7847e_v2\", \"builder_c49efc2b6fcfe67b72a35f6b436282fc6c4393b61b532dfc8ddacf832f201b2b_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-214-1slc\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611855817706497",
"status": "COMPLETED",
"status_changed_ts": "1611862007754936",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22386",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a72084e865022b09ca41fbc4a571f6dbf3c3bd3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022270491661996032",
"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/8856840424110423120/+/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:5162e8fb30119d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611862007760188",
"url": "https://ci.chromium.org/b/8856840424110423120",
"utcnow_ts": "1611862009306230"
}
}
[19:26:49.319] Invocation finished in 1h43m50.680077189s with status SUCCEEDED