[19:52:17.672] New invocation is queued and will start shortly
[19:52:18.845] Starting the invocation (attempt 1)
[19:52:18.881] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:52:18.881] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:52:18.881] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027063994962946912",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027063994962946912",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"gitiles_ref:refs/heads/master"
]
}
[19:52:20.178] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607284339053555",
"id": "8861633932851247968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607284339907059",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21631",
"builder:linux-chromeos-dbg",
"buildset:commit/git/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027063994962946912",
"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/8861633932851247968/+/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": "1607284339907636",
"url": "https://ci.chromium.org/b/8861633932851247968",
"utcnow_ts": "1607284340162985"
}
}
[19:52:20.178] Task URL: https://ci.chromium.org/b/8861633932851247968
[19:52:20.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:2:0) after 1m0s
[19:53:21.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:2:0)
[19:53:21.342] Timer tick, asking Buildbucket for the build status
[19:53:21.620] Build 8861633932851247968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:21.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:3:0) after 1m0s
[19:54:21.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:3:0)
[19:54:21.812] Timer tick, asking Buildbucket for the build status
[19:54:23.274] Build 8861633932851247968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:23.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:4:0) after 1m0s
[19:55:23.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:4:0)
[19:55:23.855] Timer tick, asking Buildbucket for the build status
[19:55:24.110] Build 8861633932851247968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:24.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:5:0) after 1m0s
[19:56:24.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:5:0)
[19:56:24.183] Timer tick, asking Buildbucket for the build status
[19:56:24.268] Build 8861633932851247968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:24.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:6:0) after 1m0s
[19:57:03.883] Received PubSub notification, asking Buildbucket for the build status
[19:57:04.148] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:24.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:6:0)
[19:57:24.369] Timer tick, asking Buildbucket for the build status
[19:57:24.525] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:24.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:8:0) after 1m0s
[19:58:24.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:8:0)
[19:58:24.707] Timer tick, asking Buildbucket for the build status
[19:58:24.835] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:24.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:9:0) after 1m0s
[19:59:24.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:9:0)
[19:59:24.852] Timer tick, asking Buildbucket for the build status
[19:59:26.677] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:26.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:10:0) after 1m0s
[20:00:26.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:10:0)
[20:00:26.705] Timer tick, asking Buildbucket for the build status
[20:00:26.990] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:26.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:11:0) after 1m0s
[20:01:27.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:11:0)
[20:01:27.013] Timer tick, asking Buildbucket for the build status
[20:01:27.125] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:27.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:12:0) after 1m0s
[20:02:27.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:12:0)
[20:02:27.152] Timer tick, asking Buildbucket for the build status
[20:02:27.225] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:27.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:13:0) after 1m0s
[20:03:27.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:13:0)
[20:03:27.345] Timer tick, asking Buildbucket for the build status
[20:03:27.724] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:27.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:14:0) after 1m0s
[20:04:27.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:14:0)
[20:04:27.781] Timer tick, asking Buildbucket for the build status
[20:04:30.679] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:30.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:15:0) after 1m0s
[20:05:30.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:15:0)
[20:05:30.700] Timer tick, asking Buildbucket for the build status
[20:05:31.062] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:31.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:16:0) after 1m0s
[20:06:31.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:16:0)
[20:06:31.188] Timer tick, asking Buildbucket for the build status
[20:06:31.362] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:17:0) after 1m0s
[20:07:31.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:17:0)
[20:07:31.383] Timer tick, asking Buildbucket for the build status
[20:07:31.522] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:31.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:18:0) after 1m0s
[20:08:31.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:18:0)
[20:08:31.609] Timer tick, asking Buildbucket for the build status
[20:08:31.678] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:31.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:19:0) after 1m0s
[20:09:31.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:19:0)
[20:09:31.691] Timer tick, asking Buildbucket for the build status
[20:09:33.052] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:33.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:20:0) after 1m0s
[20:10:33.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:20:0)
[20:10:33.083] Timer tick, asking Buildbucket for the build status
[20:10:33.363] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:33.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:21:0) after 1m0s
[20:11:33.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:21:0)
[20:11:33.446] Timer tick, asking Buildbucket for the build status
[20:11:34.767] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:34.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:22:0) after 1m0s
[20:12:34.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:22:0)
[20:12:34.821] Timer tick, asking Buildbucket for the build status
[20:12:34.918] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:23:0) after 1m0s
[20:13:34.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:23:0)
[20:13:34.952] Timer tick, asking Buildbucket for the build status
[20:13:35.066] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:35.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:24:0) after 1m0s
[20:14:35.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:24:0)
[20:14:35.084] Timer tick, asking Buildbucket for the build status
[20:14:35.428] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:35.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:25:0) after 1m0s
[20:15:35.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:25:0)
[20:15:35.478] Timer tick, asking Buildbucket for the build status
[20:15:35.532] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:35.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:26:0) after 1m0s
[20:16:35.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:26:0)
[20:16:35.553] Timer tick, asking Buildbucket for the build status
[20:16:35.635] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:27:0) after 1m0s
[20:17:35.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:27:0)
[20:17:35.655] Timer tick, asking Buildbucket for the build status
[20:17:35.887] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:28:0) after 1m0s
[20:18:35.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:28:0)
[20:18:35.947] Timer tick, asking Buildbucket for the build status
[20:18:36.074] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:36.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:29:0) after 1m0s
[20:19:36.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:29:0)
[20:19:36.195] Timer tick, asking Buildbucket for the build status
[20:19:38.195] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:38.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:30:0) after 1m0s
[20:20:38.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:30:0)
[20:20:38.314] Timer tick, asking Buildbucket for the build status
[20:20:38.447] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:38.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:31:0) after 1m0s
[20:21:38.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:31:0)
[20:21:38.466] Timer tick, asking Buildbucket for the build status
[20:21:38.705] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:38.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:32:0) after 1m0s
[20:22:38.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:32:0)
[20:22:38.726] Timer tick, asking Buildbucket for the build status
[20:22:38.818] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:38.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:33:0) after 1m0s
[20:23:38.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:33:0)
[20:23:38.856] Timer tick, asking Buildbucket for the build status
[20:23:38.926] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:34:0) after 1m0s
[20:24:38.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:34:0)
[20:24:38.979] Timer tick, asking Buildbucket for the build status
[20:24:39.040] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:39.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:35:0) after 1m0s
[20:25:39.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:35:0)
[20:25:39.086] Timer tick, asking Buildbucket for the build status
[20:25:39.165] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:39.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:36:0) after 1m0s
[20:26:39.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:36:0)
[20:26:39.208] Timer tick, asking Buildbucket for the build status
[20:26:39.282] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:39.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:37:0) after 1m0s
[20:27:39.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:37:0)
[20:27:39.303] Timer tick, asking Buildbucket for the build status
[20:27:39.420] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:39.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:38:0) after 1m0s
[20:28:39.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:38:0)
[20:28:39.430] Timer tick, asking Buildbucket for the build status
[20:28:40.038] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:39:0) after 1m0s
[20:29:40.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:39:0)
[20:29:40.132] Timer tick, asking Buildbucket for the build status
[20:29:40.232] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:40:0) after 1m0s
[20:30:40.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:40:0)
[20:30:40.250] Timer tick, asking Buildbucket for the build status
[20:30:40.464] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:40.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:41:0) after 1m0s
[20:31:40.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:41:0)
[20:31:40.536] Timer tick, asking Buildbucket for the build status
[20:31:40.608] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:40.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:42:0) after 1m0s
[20:32:40.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:42:0)
[20:32:40.635] Timer tick, asking Buildbucket for the build status
[20:32:41.098] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:41.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:43:0) after 1m0s
[20:33:41.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:43:0)
[20:33:41.206] Timer tick, asking Buildbucket for the build status
[20:33:41.283] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:41.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:44:0) after 1m0s
[20:34:41.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:44:0)
[20:34:41.305] Timer tick, asking Buildbucket for the build status
[20:34:41.358] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:41.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:45:0) after 1m0s
[20:35:41.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:45:0)
[20:35:41.391] Timer tick, asking Buildbucket for the build status
[20:35:41.555] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:41.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:46:0) after 1m0s
[20:36:41.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:46:0)
[20:36:41.576] Timer tick, asking Buildbucket for the build status
[20:36:41.634] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:41.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:47:0) after 1m0s
[20:37:41.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:47:0)
[20:37:41.667] Timer tick, asking Buildbucket for the build status
[20:37:41.751] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:41.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:48:0) after 1m0s
[20:38:41.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:48:0)
[20:38:41.754] Timer tick, asking Buildbucket for the build status
[20:38:41.836] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:41.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:49:0) after 1m0s
[20:39:41.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:49:0)
[20:39:41.824] Timer tick, asking Buildbucket for the build status
[20:39:41.949] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:41.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:50:0) after 1m0s
[20:40:41.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:50:0)
[20:40:41.977] Timer tick, asking Buildbucket for the build status
[20:40:42.039] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:51:0) after 1m0s
[20:41:42.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:51:0)
[20:41:42.064] Timer tick, asking Buildbucket for the build status
[20:41:42.269] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:42.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:52:0) after 1m0s
[20:42:42.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:52:0)
[20:42:42.294] Timer tick, asking Buildbucket for the build status
[20:42:42.412] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:42.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:53:0) after 1m0s
[20:43:42.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:53:0)
[20:43:42.476] Timer tick, asking Buildbucket for the build status
[20:43:42.745] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:42.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:54:0) after 1m0s
[20:44:42.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:54:0)
[20:44:42.748] Timer tick, asking Buildbucket for the build status
[20:44:42.829] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:55:0) after 1m0s
[20:45:42.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:55:0)
[20:45:42.859] Timer tick, asking Buildbucket for the build status
[20:45:42.922] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:42.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:56:0) after 1m0s
[20:46:42.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:56:0)
[20:46:42.943] Timer tick, asking Buildbucket for the build status
[20:46:43.042] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:43.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:57:0) after 1m0s
[20:47:43.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:57:0)
[20:47:43.067] Timer tick, asking Buildbucket for the build status
[20:47:43.286] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:43.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:58:0) after 1m0s
[20:48:43.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:58:0)
[20:48:43.311] Timer tick, asking Buildbucket for the build status
[20:48:43.466] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:43.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:59:0) after 1m0s
[20:49:43.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:59:0)
[20:49:43.479] Timer tick, asking Buildbucket for the build status
[20:49:45.577] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:45.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:60:0) after 1m0s
[20:50:45.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:60:0)
[20:50:45.660] Timer tick, asking Buildbucket for the build status
[20:50:45.729] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:45.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:61:0) after 1m0s
[20:51:45.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:61:0)
[20:51:45.764] Timer tick, asking Buildbucket for the build status
[20:51:45.824] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:45.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:62:0) after 1m0s
[20:52:45.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:62:0)
[20:52:45.862] Timer tick, asking Buildbucket for the build status
[20:52:46.328] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:46.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:63:0) after 1m0s
[20:53:46.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:63:0)
[20:53:46.369] Timer tick, asking Buildbucket for the build status
[20:53:46.473] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:46.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:64:0) after 1m0s
[20:54:46.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:64:0)
[20:54:46.534] Timer tick, asking Buildbucket for the build status
[20:54:46.642] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:65:0) after 1m0s
[20:55:46.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:65:0)
[20:55:46.713] Timer tick, asking Buildbucket for the build status
[20:55:46.830] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:46.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:66:0) after 1m0s
[20:56:46.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:66:0)
[20:56:46.915] Timer tick, asking Buildbucket for the build status
[20:56:47.193] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:47.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:67:0) after 1m0s
[20:57:47.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:67:0)
[20:57:47.169] Timer tick, asking Buildbucket for the build status
[20:57:48.460] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:48.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:68:0) after 1m0s
[20:58:48.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:68:0)
[20:58:48.638] Timer tick, asking Buildbucket for the build status
[20:58:49.018] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:49.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:69:0) after 1m0s
[20:59:49.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:69:0)
[20:59:49.146] Timer tick, asking Buildbucket for the build status
[20:59:49.263] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:49.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:70:0) after 1m0s
[21:00:49.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:70:0)
[21:00:49.490] Timer tick, asking Buildbucket for the build status
[21:00:49.802] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:49.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:71:0) after 1m0s
[21:01:49.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:71:0)
[21:01:49.882] Timer tick, asking Buildbucket for the build status
[21:01:50.016] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:50.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:72:0) after 1m0s
[21:02:50.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:72:0)
[21:02:50.080] Timer tick, asking Buildbucket for the build status
[21:02:50.494] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:50.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:73:0) after 1m0s
[21:03:50.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:73:0)
[21:03:50.562] Timer tick, asking Buildbucket for the build status
[21:03:50.686] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:50.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:74:0) after 1m0s
[21:04:50.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:74:0)
[21:04:50.759] Timer tick, asking Buildbucket for the build status
[21:04:50.863] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:75:0) after 1m0s
[21:05:50.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:75:0)
[21:05:50.853] Timer tick, asking Buildbucket for the build status
[21:05:50.911] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:50.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:76:0) after 1m0s
[21:06:51.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:76:0)
[21:06:51.025] Timer tick, asking Buildbucket for the build status
[21:06:51.141] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:51.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:77:0) after 1m0s
[21:07:51.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:77:0)
[21:07:51.305] Timer tick, asking Buildbucket for the build status
[21:07:51.454] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:51.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:78:0) after 1m0s
[21:08:51.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:78:0)
[21:08:51.488] Timer tick, asking Buildbucket for the build status
[21:08:51.599] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:51.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:79:0) after 1m0s
[21:09:51.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:79:0)
[21:09:51.707] Timer tick, asking Buildbucket for the build status
[21:09:52.022] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:80:0) after 1m0s
[21:10:52.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:80:0)
[21:10:52.521] Timer tick, asking Buildbucket for the build status
[21:10:52.583] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:52.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:81:0) after 1m0s
[21:11:52.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:81:0)
[21:11:52.609] Timer tick, asking Buildbucket for the build status
[21:11:52.919] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:52.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:82:0) after 1m0s
[21:12:52.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:82:0)
[21:12:52.977] Timer tick, asking Buildbucket for the build status
[21:12:53.112] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:83:0) after 1m0s
[21:13:53.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:83:0)
[21:13:53.148] Timer tick, asking Buildbucket for the build status
[21:13:53.229] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:53.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:84:0) after 1m0s
[21:14:53.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:84:0)
[21:14:53.274] Timer tick, asking Buildbucket for the build status
[21:14:53.417] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:53.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:85:0) after 1m0s
[21:15:53.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:85:0)
[21:15:53.475] Timer tick, asking Buildbucket for the build status
[21:15:53.678] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:53.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:86:0) after 1m0s
[21:16:53.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:86:0)
[21:16:53.713] Timer tick, asking Buildbucket for the build status
[21:16:53.828] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:53.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:87:0) after 1m0s
[21:17:53.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:87:0)
[21:17:53.877] Timer tick, asking Buildbucket for the build status
[21:17:54.433] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:54.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:88:0) after 1m0s
[21:18:54.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:88:0)
[21:18:54.456] Timer tick, asking Buildbucket for the build status
[21:18:54.520] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:54.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:89:0) after 1m0s
[21:19:54.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:89:0)
[21:19:54.653] Timer tick, asking Buildbucket for the build status
[21:19:54.725] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:54.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:90:0) after 1m0s
[21:20:54.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:90:0)
[21:20:54.772] Timer tick, asking Buildbucket for the build status
[21:20:54.965] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:54.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:91:0) after 1m0s
[21:21:55.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:91:0)
[21:21:55.035] Timer tick, asking Buildbucket for the build status
[21:21:55.143] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:55.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:92:0) after 1m0s
[21:22:55.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:92:0)
[21:22:55.213] Timer tick, asking Buildbucket for the build status
[21:22:55.367] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:55.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:93:0) after 1m0s
[21:23:55.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:93:0)
[21:23:55.426] Timer tick, asking Buildbucket for the build status
[21:23:55.554] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:55.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:94:0) after 1m0s
[21:24:55.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:94:0)
[21:24:55.581] Timer tick, asking Buildbucket for the build status
[21:24:55.692] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:55.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:95:0) after 1m0s
[21:25:55.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:95:0)
[21:25:55.714] Timer tick, asking Buildbucket for the build status
[21:25:55.809] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:96:0) after 1m0s
[21:26:55.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:96:0)
[21:26:55.905] Timer tick, asking Buildbucket for the build status
[21:26:55.985] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:55.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:97:0) after 1m0s
[21:27:56.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:97:0)
[21:27:56.057] Timer tick, asking Buildbucket for the build status
[21:27:56.335] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:56.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:98:0) after 1m0s
[21:28:56.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:98:0)
[21:28:56.437] Timer tick, asking Buildbucket for the build status
[21:28:57.313] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:57.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:99:0) after 1m0s
[21:29:57.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:99:0)
[21:29:57.332] Timer tick, asking Buildbucket for the build status
[21:29:57.420] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:57.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:100:0) after 1m0s
[21:30:57.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:100:0)
[21:30:57.438] Timer tick, asking Buildbucket for the build status
[21:30:57.520] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:57.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:101:0) after 1m0s
[21:31:57.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:101:0)
[21:31:57.643] Timer tick, asking Buildbucket for the build status
[21:31:58.004] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:102:0) after 1m0s
[21:32:58.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:102:0)
[21:32:58.069] Timer tick, asking Buildbucket for the build status
[21:32:58.640] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:58.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:103:0) after 1m0s
[21:33:58.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:103:0)
[21:33:58.708] Timer tick, asking Buildbucket for the build status
[21:33:58.843] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:58.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:104:0) after 1m0s
[21:34:58.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:104:0)
[21:34:58.896] Timer tick, asking Buildbucket for the build status
[21:34:59.201] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:105:0) after 1m0s
[21:35:59.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:105:0)
[21:35:59.312] Timer tick, asking Buildbucket for the build status
[21:35:59.372] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:59.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:106:0) after 1m0s
[21:36:59.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:106:0)
[21:36:59.425] Timer tick, asking Buildbucket for the build status
[21:36:59.490] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:59.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:107:0) after 1m0s
[21:37:59.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:107:0)
[21:37:59.577] Timer tick, asking Buildbucket for the build status
[21:37:59.786] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:59.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:108:0) after 1m0s
[21:38:59.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:108:0)
[21:38:59.875] Timer tick, asking Buildbucket for the build status
[21:39:00.137] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:00.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:109:0) after 1m0s
[21:40:00.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:109:0)
[21:40:00.488] Timer tick, asking Buildbucket for the build status
[21:40:00.552] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:00.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:110:0) after 1m0s
[21:41:00.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:110:0)
[21:41:00.808] Timer tick, asking Buildbucket for the build status
[21:41:00.887] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:00.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:111:0) after 1m0s
[21:42:01.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:111:0)
[21:42:01.000] Timer tick, asking Buildbucket for the build status
[21:42:01.134] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:01.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:112:0) after 1m0s
[21:43:01.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:112:0)
[21:43:01.637] Timer tick, asking Buildbucket for the build status
[21:43:01.851] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:01.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:113:0) after 1m0s
[21:44:01.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:113:0)
[21:44:01.921] Timer tick, asking Buildbucket for the build status
[21:44:02.002] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:02.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:114:0) after 1m0s
[21:45:02.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:114:0)
[21:45:02.004] Timer tick, asking Buildbucket for the build status
[21:45:02.088] Build 8861633932851247968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:02.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027063994962946912:115:0) after 1m0s
[21:45:26.359] Received PubSub notification, asking Buildbucket for the build status
[21:45:26.434] Build 8861633932851247968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:45:26.434] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607291124099708",
"created_by": "project:chromium",
"created_ts": "1607284339053555",
"id": "8861633932851247968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\"}}",
"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\": \"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\", \"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-67-7xnt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21631, \"got_angle_revision\": \"251ba5cb119ff2fed0e861cbc9b096c45004c1fa\", \"got_dawn_revision\": \"d63d562d1b26e01b369d9a58eddeaccfaa688a02\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\", \"got_revision_cp\": \"refs/heads/master@{#834077}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7c84426d2abe231f3087a2942fd831137eb3b0aa\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"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\": \"29886952c7dd50f9bd77b09d4f879e591c4b2fa8\", \"swarm_hashes_refs/heads/master(at){#834077}_without_patch\": {\"absl_hardening_tests\": \"296d23ba38017d8881c8c90b78a7eb5372b6b3f7\", \"accessibility_unittests\": \"69bc1d48622d1b8f39ac7c1b2c4fcd8474f48039\", \"angle_unittests\": \"3ca418952ea83c7775e7a49047c560805974d52b\", \"app_list_unittests\": \"677b3cc4d99baff69db47071e7546b18b0fdb1fd\", \"app_shell_unittests\": \"3d7e0e774938418a5c2c160bd0a2088b9cb9621d\", \"ash_unittests\": \"91b6ab1f0f2696fe8fca4c2cf7115eaed17a58ed\", \"aura_unittests\": \"039834624036f731b675d6f8cc3dc54b2a1d09bb\", \"base_unittests\": \"d3b67809d4c9963b693222151e639b39e2874e23\", \"base_util_unittests\": \"458fff88e62541a3acf77a6800b819bcde1d5288\", \"blink_common_unittests\": \"dd699a8c6e8b9de10bacb26ae1bbc61581d5ac1d\", \"blink_fuzzer_unittests\": \"60ba49750e22105570a2b0a3be40c73eb41636bd\", \"blink_heap_unittests\": \"c2758a93c217185941530c75d197b1f480db0b6f\", \"blink_platform_unittests\": \"594bc4b3dbfdcc1f7baeab641b383d1b1937b1ca\", \"blink_unittests\": \"495ccc52976f0ef1e61d769ad6290d002b14c51e\", \"boringssl_crypto_tests\": \"4a2c2f9f3029b6604fcb9f6f08419cba72cff18d\", \"boringssl_ssl_tests\": \"ac9a5d8bcc6d3113ef57526a8c42a7a6f7b15169\", \"browser_tests\": \"12c96a3911ac627914b79e47a5eceee7a8a2c6b6\", \"capture_unittests\": \"2f4e707588e13ba885ad84d6f22b59d4c2c0ca7c\", \"cast_unittests\": \"c7044ba25579e0d4cb3c9f04cba3e8d8c4c64025\", \"cc_unittests\": \"af88a0bbd996caa08a62a3470c4faeb4d545f085\", \"chrome_app_unittests\": \"fa406ca3e5f90c8d8f8b2ed2b44edb4ddac7fdaa\", \"chromedriver_unittests\": \"3c4f6bccd6b6bde8b6d3cde1a578ed82caa73033\", \"chromeos_components_unittests\": \"5ab6f321b567f3610cf2cb0f0d1ad80c597fb134\", \"chromeos_unittests\": \"935d8dc7ec50b5bb3d882aa5f9646aa79a79192a\", \"components_browsertests\": \"7f9d44565f27576ead7368fe55c0ec1eb5307c44\", \"components_unittests\": \"a9cbda8cca87f4841a37ae8eccbf9041ca164790\", \"compositor_unittests\": \"5e9e74feaf833db159ff3564d40febde6258de45\", \"content_browsertests\": \"1cccc1ba8c60c7163ac6bc4b9aca2146fe187c76\", \"content_unittests\": \"1b139733423a6d027a68eea57c42ef764355bdb4\", \"crashpad_tests\": \"8900ebb5fbb4abf604694a6d4b4d4ffd2716e6f4\", \"crypto_unittests\": \"02e8cf2d8e7b9fec7524670f351ec9b3bf496aa3\", \"dbus_unittests\": \"2fb22af4e6e92d8568d3751ad3e1870ed8aefeb3\", \"device_unittests\": \"bbe51bf60bc17cf044bce63066caf2d9416aa686\", \"display_unittests\": \"120e82c2fd599c9397798a1992e5c9c0f09a8a3d\", \"events_unittests\": \"8e08cdeefc075868b5dea65a09fb38d1fbced43d\", \"exo_unittests\": \"b044c62b94d43d398da7bddb747b1f84e6a6ab6a\", \"extensions_browsertests\": \"d9c5f27169391071f036bada9d154a9c9556e91e\", \"extensions_unittests\": \"fb7c23b7b8034165adb85178f614d5898e29f488\", \"filesystem_service_unittests\": \"35290f57a04902c2c5e2ca71fd811c9dc8554bfb\", \"gcm_unit_tests\": \"1f8538704a9f5d044a4df5f17da0d0ed85db6744\", \"gfx_unittests\": \"314e325970cf4672f94ed525b7368934642e9c37\", \"gin_unittests\": \"bea8957aafe87e2b457c1e0c903a2f2aa867754f\", \"gl_unittests_ozone\": \"4aa4f223b367c9b759b053b2aac10f883f541c0d\", \"google_apis_unittests\": \"d80c62fe9f602c17fb64460ed82e096a2a3d37f1\", \"gpu_unittests\": \"a226c8871213e8b0bbcc8a17b4ef88d491c6d6eb\", \"gwp_asan_unittests\": \"2133bf3c2bcc8a87a8070f1fec2dbd9729d17e77\", \"interactive_ui_tests\": \"c0ccbdb3ff15697e8aa2ab84c0aa2763860584d2\", \"ipc_tests\": \"6d8ba7c2596add5eebd6aee3c92bd98e1d4c30c6\", \"jingle_unittests\": \"b267b5f6c34597045f09929c28545112d09c77fc\", \"keyboard_unittests\": \"c2c3b3db6434e5f07ee0947d763c5c99bf5d073a\", \"latency_unittests\": \"7e49f308217294472a6cbfb4b69c5f6154269c78\", \"libjingle_xmpp_unittests\": \"63478aeccab2e7820f68d71828def39b0e64a377\", \"liburlpattern_unittests\": \"0faeb91a7c4dd5d001c5ce4422217d9aedff470a\", \"media_blink_unittests\": \"1da1e4423a390d42e025b8c56a1524c28684adf3\", \"media_unittests\": \"18dc7f5d2f59e5eec33d62af407fdf8b801824f2\", \"message_center_unittests\": \"1da3ff4f08a588590bc50e767217ca7d5dd92f50\", \"midi_unittests\": \"b545fa012c47cef81b59064f991edf13aa03cfbd\", \"mojo_core_unittests\": \"f4318df6768b483cc7a29b596880eebb106572c8\", \"mojo_unittests\": \"1fc87ee350ca65b71957d3a2e46e55bd697ae35a\", \"nacl_helper_nonsfi_unittests\": \"28a40e57a9f14127cba03c86e8f670c091d8f55f\", \"nacl_loader_unittests\": \"503ec8d2203089c8ba86aa564176561dcfe36895\", \"native_theme_unittests\": \"a5ef1f93608154cb0edefc96fd8d4ac7985a330d\", \"net_unittests\": \"52d7fd83304a4a2622e38b9fecb74e2eb01d124b\", \"ozone_gl_unittests\": \"2a22af385fdf923575037aa8c8fd42260aa6f958\", \"ozone_unittests\": \"6a2e1bbab5619aa9c408221a6f6ae8201bd6cc97\", \"ozone_x11_unittests\": \"4079da649d43b60bb763d2af33084384a455878d\", \"pdf_unittests\": \"1205a6152aec9348b13d7719b36a90000be0f926\", \"perfetto_unittests\": \"f3f61a00f00a59278ec14196d67f2565ccdd51b8\", \"ppapi_unittests\": \"2aa93863fe739c28706a362a7ee166a0bc226abb\", \"printing_unittests\": \"819a0a2a887b4f25cd6a847a7879a15fdb03a5ff\", \"remoting_unittests\": \"6066eb6344919d67436380d00f37cd381c928c24\", \"sandbox_linux_unittests\": \"2e3bc2d7525fc67f7d7f1d32fa3d2022ba39b22c\", \"service_manager_unittests\": \"3c52bf99d616be8c5638930ab16cd0847754585f\", \"services_unittests\": \"55758b121d1df9b8c0a809832325157441b8855b\", \"shell_dialogs_unittests\": \"cfca0ca73595d1568d160e8b6e18f51b3b1a20aa\", \"shell_encryption_unittests\": \"e170421dcea30f1111e71590559f4b2d72488306\", \"skia_unittests\": \"3808733c958c136bc1d1e7da04cdf6cabf4083a6\", \"snapshot_unittests\": \"e35bdf758d20f5bc91077e04db51b2e48db6ddde\", \"sql_unittests\": \"51d3365d29cf9537632e5ee17760832d887034f9\", \"storage_unittests\": \"9ecc57c5315dd37ff9069c62bc8690248f1e4100\", \"sync_integration_tests\": \"b839ffe7fe02505b4d6cd24162550553c0be8677\", \"traffic_annotation_auditor_unittests\": \"31a29e5df33cb08638dfc153ca9316c676d19087\", \"ui_base_unittests\": \"91077480f4c137de17eee68d65b59dbf0e468635\", \"ui_chromeos_unittests\": \"1ea6d7e9e4f79e74dc435a576cff0a5aec9a53a5\", \"ui_touch_selection_unittests\": \"98a32a6c17a737fbdd610b483c3a35d1beaf054b\", \"unit_tests\": \"23501e02baf87bf5b95a368330af25680c1a1b98\", \"url_unittests\": \"53213ad65491b179590e814c97f204d0a120ccd2\", \"usage_time_limit_unittests\": \"2f8b9dc0273c99d6614e135a0fde022e3fb41a83\", \"views_unittests\": \"b77004884c805da2b6726d6239e0d1e96d048837\", \"viz_unittests\": \"a1921867c1a45c55162a966910f429a1e2d56a3a\", \"wm_unittests\": \"392acdaf56506c3d2791d8fbdf31fa14e46588c5\", \"wtf_unittests\": \"0c24d9c1d7d52455b07e9b961561679eef216b4e\", \"zlib_unittests\": \"4b1e3fda89f59c8582c46cf6bdd054ac7428bdc7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_03684948df0f250a19c7b639204de5133dfe487bdadd877fd8990d1b9d0fd4b0_v2\", \"builder_9efb94071a208cb32f222f9589b2bf8c6e9d4ebc7884b1b49bd19cd2b21dc48e_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-67-7xnt\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607284623183331",
"status": "COMPLETED",
"status_changed_ts": "1607291124785341",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21631",
"builder:linux-chromeos-dbg",
"buildset:commit/git/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29886952c7dd50f9bd77b09d4f879e591c4b2fa8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027063994962946912",
"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/8861633932851247968/+/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:50526e5692b72510",
"user_agent:luci-scheduler"
],
"updated_ts": "1607291124791062",
"url": "https://ci.chromium.org/b/8861633932851247968",
"utcnow_ts": "1607291126424824"
}
}
[21:45:26.434] Invocation finished in 1h53m8.777494803s with status SUCCEEDED