[13:44:38.262] New invocation is queued and will start shortly
[13:44:39.348] Starting the invocation (attempt 1)
[13:44:39.385] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:44:39.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:44:39.385] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030982795485599792",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a6d19a03d2212f71500d14d9de44ac0414bc9566\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030982795485599792",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"gitiles_ref:refs/heads/master"
]
}
[13:44:40.085] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603547079476319",
"id": "8865552733549443712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6d19a03d2212f71500d14d9de44ac0414bc9566\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603547079932181",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42230",
"builder:linux-chromeos-rel",
"buildset:commit/git/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030982795485599792",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865552733549443712/+/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": "1603547079932340",
"url": "https://ci.chromium.org/b/8865552733549443712",
"utcnow_ts": "1603547080076954"
}
}
[13:44:40.085] Task URL: https://ci.chromium.org/b/8865552733549443712
[13:44:40.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:2:0) after 1m0s
[13:45:40.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:2:0)
[13:45:40.122] Timer tick, asking Buildbucket for the build status
[13:45:40.223] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:3:0) after 1m0s
[13:46:40.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:3:0)
[13:46:40.287] Timer tick, asking Buildbucket for the build status
[13:46:40.369] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:40.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:4:0) after 1m0s
[13:47:40.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:4:0)
[13:47:40.426] Timer tick, asking Buildbucket for the build status
[13:47:40.718] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:40.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:5:0) after 1m0s
[13:48:40.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:5:0)
[13:48:40.712] Timer tick, asking Buildbucket for the build status
[13:48:40.808] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:40.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:6:0) after 1m0s
[13:49:40.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:6:0)
[13:49:40.875] Timer tick, asking Buildbucket for the build status
[13:49:41.004] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:41.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:7:0) after 1m0s
[13:50:41.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:7:0)
[13:50:41.095] Timer tick, asking Buildbucket for the build status
[13:50:41.231] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:41.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:8:0) after 1m0s
[13:51:41.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:8:0)
[13:51:41.272] Timer tick, asking Buildbucket for the build status
[13:51:41.346] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:9:0) after 1m0s
[13:52:41.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:9:0)
[13:52:41.466] Timer tick, asking Buildbucket for the build status
[13:52:41.547] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:41.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:10:0) after 1m0s
[13:53:41.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:10:0)
[13:53:41.571] Timer tick, asking Buildbucket for the build status
[13:53:41.761] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:41.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:11:0) after 1m0s
[13:54:41.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:11:0)
[13:54:41.816] Timer tick, asking Buildbucket for the build status
[13:54:42.018] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:42.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:12:0) after 1m0s
[13:55:42.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:12:0)
[13:55:42.034] Timer tick, asking Buildbucket for the build status
[13:55:42.139] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:42.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:13:0) after 1m0s
[13:56:42.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:13:0)
[13:56:42.177] Timer tick, asking Buildbucket for the build status
[13:56:42.261] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:42.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:14:0) after 1m0s
[13:57:42.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:14:0)
[13:57:42.282] Timer tick, asking Buildbucket for the build status
[13:57:42.572] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:42.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:15:0) after 1m0s
[13:58:42.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:15:0)
[13:58:42.644] Timer tick, asking Buildbucket for the build status
[13:58:42.723] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:42.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:16:0) after 1m0s
[13:59:42.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:16:0)
[13:59:42.778] Timer tick, asking Buildbucket for the build status
[13:59:42.891] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:42.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:17:0) after 1m0s
[14:00:42.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:17:0)
[14:00:42.941] Timer tick, asking Buildbucket for the build status
[14:00:43.117] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:43.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:18:0) after 1m0s
[14:01:43.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:18:0)
[14:01:43.146] Timer tick, asking Buildbucket for the build status
[14:01:43.264] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:43.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:19:0) after 1m0s
[14:02:43.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:19:0)
[14:02:43.319] Timer tick, asking Buildbucket for the build status
[14:02:43.489] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:43.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:20:0) after 1m0s
[14:03:43.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:20:0)
[14:03:43.551] Timer tick, asking Buildbucket for the build status
[14:03:43.626] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:43.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:21:0) after 1m0s
[14:04:43.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:21:0)
[14:04:43.765] Timer tick, asking Buildbucket for the build status
[14:04:43.945] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:43.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:22:0) after 1m0s
[14:05:43.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:22:0)
[14:05:43.990] Timer tick, asking Buildbucket for the build status
[14:05:44.096] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:44.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:23:0) after 1m0s
[14:06:44.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:23:0)
[14:06:44.168] Timer tick, asking Buildbucket for the build status
[14:06:44.291] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:44.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:24:0) after 1m0s
[14:07:44.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:24:0)
[14:07:44.398] Timer tick, asking Buildbucket for the build status
[14:07:44.963] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:44.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:25:0) after 1m0s
[14:08:45.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:25:0)
[14:08:45.116] Timer tick, asking Buildbucket for the build status
[14:08:45.213] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:45.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:26:0) after 1m0s
[14:09:45.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:26:0)
[14:09:45.267] Timer tick, asking Buildbucket for the build status
[14:09:45.374] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:45.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:27:0) after 1m0s
[14:10:45.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:27:0)
[14:10:45.402] Timer tick, asking Buildbucket for the build status
[14:10:45.480] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:45.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:28:0) after 1m0s
[14:11:45.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:28:0)
[14:11:45.502] Timer tick, asking Buildbucket for the build status
[14:11:45.581] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:45.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:29:0) after 1m0s
[14:12:45.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:29:0)
[14:12:45.604] Timer tick, asking Buildbucket for the build status
[14:12:48.860] Build 8865552733549443712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:48.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:30:0) after 1m0s
[14:13:21.862] Received PubSub notification, asking Buildbucket for the build status
[14:13:21.940] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:49.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:30:0)
[14:13:49.009] Timer tick, asking Buildbucket for the build status
[14:13:49.101] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:49.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:32:0) after 1m0s
[14:14:49.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:32:0)
[14:14:49.236] Timer tick, asking Buildbucket for the build status
[14:14:49.331] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:49.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:33:0) after 1m0s
[14:15:49.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:33:0)
[14:15:49.477] Timer tick, asking Buildbucket for the build status
[14:15:49.811] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:49.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:34:0) after 1m0s
[14:16:49.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:34:0)
[14:16:49.930] Timer tick, asking Buildbucket for the build status
[14:16:50.036] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:50.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:35:0) after 1m0s
[14:17:50.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:35:0)
[14:17:50.228] Timer tick, asking Buildbucket for the build status
[14:17:50.368] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:50.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:36:0) after 1m0s
[14:18:50.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:36:0)
[14:18:50.575] Timer tick, asking Buildbucket for the build status
[14:18:50.761] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:50.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:37:0) after 1m0s
[14:19:50.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:37:0)
[14:19:50.980] Timer tick, asking Buildbucket for the build status
[14:19:51.113] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:51.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:38:0) after 1m0s
[14:20:51.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:38:0)
[14:20:51.146] Timer tick, asking Buildbucket for the build status
[14:20:51.219] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:51.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:39:0) after 1m0s
[14:21:51.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:39:0)
[14:21:51.342] Timer tick, asking Buildbucket for the build status
[14:21:51.435] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:51.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:40:0) after 1m0s
[14:22:51.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:40:0)
[14:22:51.495] Timer tick, asking Buildbucket for the build status
[14:22:51.867] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:51.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:41:0) after 1m0s
[14:23:51.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:41:0)
[14:23:51.916] Timer tick, asking Buildbucket for the build status
[14:23:52.025] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:42:0) after 1m0s
[14:24:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:42:0)
[14:24:52.111] Timer tick, asking Buildbucket for the build status
[14:24:52.362] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:52.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:43:0) after 1m0s
[14:25:52.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:43:0)
[14:25:52.380] Timer tick, asking Buildbucket for the build status
[14:25:52.755] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:52.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:44:0) after 1m0s
[14:26:52.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:44:0)
[14:26:52.825] Timer tick, asking Buildbucket for the build status
[14:26:53.141] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:53.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:45:0) after 1m0s
[14:27:53.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:45:0)
[14:27:53.181] Timer tick, asking Buildbucket for the build status
[14:27:54.608] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:54.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:46:0) after 1m0s
[14:28:54.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:46:0)
[14:28:54.629] Timer tick, asking Buildbucket for the build status
[14:28:54.795] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:54.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:47:0) after 1m0s
[14:29:54.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:47:0)
[14:29:54.782] Timer tick, asking Buildbucket for the build status
[14:29:55.640] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:55.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:48:0) after 1m0s
[14:30:55.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:48:0)
[14:30:55.663] Timer tick, asking Buildbucket for the build status
[14:30:55.773] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:55.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:49:0) after 1m0s
[14:31:55.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:49:0)
[14:31:55.797] Timer tick, asking Buildbucket for the build status
[14:31:55.863] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:55.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:50:0) after 1m0s
[14:32:55.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:50:0)
[14:32:55.879] Timer tick, asking Buildbucket for the build status
[14:32:56.180] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:56.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:51:0) after 1m0s
[14:33:56.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:51:0)
[14:33:56.238] Timer tick, asking Buildbucket for the build status
[14:33:56.505] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:56.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:52:0) after 1m0s
[14:34:56.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:52:0)
[14:34:56.617] Timer tick, asking Buildbucket for the build status
[14:34:56.748] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:56.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:53:0) after 1m0s
[14:35:56.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:53:0)
[14:35:56.867] Timer tick, asking Buildbucket for the build status
[14:35:57.131] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:57.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:54:0) after 1m0s
[14:36:57.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:54:0)
[14:36:57.153] Timer tick, asking Buildbucket for the build status
[14:36:57.235] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:55:0) after 1m0s
[14:37:57.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:55:0)
[14:37:57.283] Timer tick, asking Buildbucket for the build status
[14:37:57.348] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:57.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:56:0) after 1m0s
[14:38:57.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:56:0)
[14:38:57.372] Timer tick, asking Buildbucket for the build status
[14:38:57.675] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:57.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:57:0) after 1m0s
[14:39:57.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:57:0)
[14:39:57.691] Timer tick, asking Buildbucket for the build status
[14:39:57.830] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:57.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:58:0) after 1m0s
[14:40:57.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:58:0)
[14:40:57.889] Timer tick, asking Buildbucket for the build status
[14:40:57.963] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:57.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:59:0) after 1m0s
[14:41:57.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:59:0)
[14:41:57.984] Timer tick, asking Buildbucket for the build status
[14:41:58.086] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:58.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:60:0) after 1m0s
[14:42:58.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:60:0)
[14:42:58.146] Timer tick, asking Buildbucket for the build status
[14:42:58.317] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:61:0) after 1m0s
[14:43:58.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:61:0)
[14:43:58.373] Timer tick, asking Buildbucket for the build status
[14:43:58.810] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:62:0) after 1m0s
[14:44:58.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:62:0)
[14:44:58.897] Timer tick, asking Buildbucket for the build status
[14:44:58.999] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:63:0) after 1m0s
[14:45:59.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:63:0)
[14:45:59.076] Timer tick, asking Buildbucket for the build status
[14:45:59.147] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:59.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:64:0) after 1m0s
[14:46:59.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:64:0)
[14:46:59.314] Timer tick, asking Buildbucket for the build status
[14:46:59.402] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:59.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:65:0) after 1m0s
[14:47:59.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:65:0)
[14:47:59.420] Timer tick, asking Buildbucket for the build status
[14:47:59.478] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:59.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:66:0) after 1m0s
[14:48:59.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:66:0)
[14:48:59.503] Timer tick, asking Buildbucket for the build status
[14:48:59.568] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:67:0) after 1m0s
[14:49:59.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:67:0)
[14:49:59.588] Timer tick, asking Buildbucket for the build status
[14:49:59.928] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:59.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:68:0) after 1m0s
[14:51:00.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:68:0)
[14:51:00.012] Timer tick, asking Buildbucket for the build status
[14:51:00.419] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:00.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:69:0) after 1m0s
[14:52:00.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:69:0)
[14:52:00.525] Timer tick, asking Buildbucket for the build status
[14:52:00.752] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:00.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:70:0) after 1m0s
[14:53:01.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:70:0)
[14:53:01.863] Timer tick, asking Buildbucket for the build status
[14:53:01.946] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:01.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:71:0) after 1m0s
[14:54:01.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:71:0)
[14:54:01.993] Timer tick, asking Buildbucket for the build status
[14:54:02.072] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:02.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:72:0) after 1m0s
[14:55:02.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:72:0)
[14:55:02.420] Timer tick, asking Buildbucket for the build status
[14:55:02.602] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:02.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:73:0) after 1m0s
[14:56:02.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:73:0)
[14:56:02.692] Timer tick, asking Buildbucket for the build status
[14:56:03.024] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:03.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:74:0) after 1m0s
[14:57:03.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:74:0)
[14:57:03.163] Timer tick, asking Buildbucket for the build status
[14:57:03.230] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:03.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:75:0) after 1m0s
[14:58:03.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:75:0)
[14:58:03.255] Timer tick, asking Buildbucket for the build status
[14:58:03.476] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:03.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:76:0) after 1m0s
[14:59:03.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:76:0)
[14:59:03.520] Timer tick, asking Buildbucket for the build status
[14:59:03.591] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:03.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:77:0) after 1m0s
[15:00:03.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:77:0)
[15:00:03.592] Timer tick, asking Buildbucket for the build status
[15:00:03.786] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:03.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:78:0) after 1m0s
[15:01:03.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:78:0)
[15:01:03.813] Timer tick, asking Buildbucket for the build status
[15:01:03.888] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:03.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:79:0) after 1m0s
[15:02:03.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:79:0)
[15:02:03.873] Timer tick, asking Buildbucket for the build status
[15:02:04.070] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:04.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:80:0) after 1m0s
[15:03:04.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:80:0)
[15:03:04.094] Timer tick, asking Buildbucket for the build status
[15:03:04.172] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:04.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:81:0) after 1m0s
[15:04:04.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:81:0)
[15:04:04.227] Timer tick, asking Buildbucket for the build status
[15:04:04.319] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:04.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:82:0) after 1m0s
[15:05:04.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:82:0)
[15:05:04.342] Timer tick, asking Buildbucket for the build status
[15:05:04.612] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:04.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:83:0) after 1m0s
[15:06:04.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:83:0)
[15:06:04.634] Timer tick, asking Buildbucket for the build status
[15:06:04.830] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:04.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:84:0) after 1m0s
[15:07:04.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:84:0)
[15:07:04.966] Timer tick, asking Buildbucket for the build status
[15:07:05.041] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:05.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:85:0) after 1m0s
[15:08:05.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:85:0)
[15:08:05.268] Timer tick, asking Buildbucket for the build status
[15:08:05.337] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:05.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:86:0) after 1m0s
[15:09:05.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:86:0)
[15:09:05.446] Timer tick, asking Buildbucket for the build status
[15:09:06.252] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:06.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:87:0) after 1m0s
[15:10:06.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:87:0)
[15:10:06.413] Timer tick, asking Buildbucket for the build status
[15:10:14.898] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:14.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:88:0) after 1m0s
[15:11:15.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:88:0)
[15:11:15.052] Timer tick, asking Buildbucket for the build status
[15:11:15.144] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:15.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:89:0) after 1m0s
[15:12:15.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:89:0)
[15:12:15.336] Timer tick, asking Buildbucket for the build status
[15:12:15.712] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:15.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:90:0) after 1m0s
[15:13:15.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:90:0)
[15:13:15.943] Timer tick, asking Buildbucket for the build status
[15:13:16.022] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:91:0) after 1m0s
[15:14:16.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:91:0)
[15:14:16.109] Timer tick, asking Buildbucket for the build status
[15:14:16.178] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:16.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:92:0) after 1m0s
[15:15:16.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:92:0)
[15:15:16.325] Timer tick, asking Buildbucket for the build status
[15:15:16.433] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:16.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:93:0) after 1m0s
[15:16:16.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:93:0)
[15:16:16.560] Timer tick, asking Buildbucket for the build status
[15:16:16.641] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:16.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:94:0) after 1m0s
[15:17:16.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:94:0)
[15:17:16.680] Timer tick, asking Buildbucket for the build status
[15:17:16.758] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:16.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:95:0) after 1m0s
[15:18:16.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:95:0)
[15:18:16.851] Timer tick, asking Buildbucket for the build status
[15:18:16.911] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:16.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:96:0) after 1m0s
[15:19:17.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:96:0)
[15:19:17.032] Timer tick, asking Buildbucket for the build status
[15:19:17.103] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:17.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:97:0) after 1m0s
[15:20:17.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:97:0)
[15:20:17.316] Timer tick, asking Buildbucket for the build status
[15:20:17.433] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:17.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:98:0) after 1m0s
[15:21:17.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:98:0)
[15:21:17.506] Timer tick, asking Buildbucket for the build status
[15:21:17.614] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:17.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:99:0) after 1m0s
[15:22:17.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:99:0)
[15:22:17.685] Timer tick, asking Buildbucket for the build status
[15:22:17.808] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:17.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:100:0) after 1m0s
[15:23:17.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:100:0)
[15:23:17.965] Timer tick, asking Buildbucket for the build status
[15:23:18.124] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:18.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:101:0) after 1m0s
[15:24:18.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:101:0)
[15:24:18.196] Timer tick, asking Buildbucket for the build status
[15:24:18.318] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:18.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:102:0) after 1m0s
[15:25:18.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:102:0)
[15:25:18.382] Timer tick, asking Buildbucket for the build status
[15:25:18.510] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:18.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:103:0) after 1m0s
[15:26:18.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:103:0)
[15:26:18.724] Timer tick, asking Buildbucket for the build status
[15:26:19.271] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:19.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:104:0) after 1m0s
[15:27:19.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:104:0)
[15:27:19.467] Timer tick, asking Buildbucket for the build status
[15:27:19.984] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:19.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:105:0) after 1m0s
[15:28:20.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:105:0)
[15:28:20.124] Timer tick, asking Buildbucket for the build status
[15:28:20.229] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:20.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:106:0) after 1m0s
[15:29:20.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:106:0)
[15:29:20.253] Timer tick, asking Buildbucket for the build status
[15:29:20.356] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:20.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:107:0) after 1m0s
[15:30:20.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:107:0)
[15:30:20.421] Timer tick, asking Buildbucket for the build status
[15:30:20.548] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:20.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:108:0) after 1m0s
[15:31:20.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:108:0)
[15:31:20.695] Timer tick, asking Buildbucket for the build status
[15:31:20.811] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:20.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:109:0) after 1m0s
[15:32:20.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:109:0)
[15:32:20.914] Timer tick, asking Buildbucket for the build status
[15:32:21.226] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:21.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:110:0) after 1m0s
[15:33:21.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:110:0)
[15:33:21.273] Timer tick, asking Buildbucket for the build status
[15:33:21.472] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:21.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:111:0) after 1m0s
[15:34:21.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:111:0)
[15:34:21.541] Timer tick, asking Buildbucket for the build status
[15:34:21.767] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:21.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:112:0) after 1m0s
[15:35:21.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:112:0)
[15:35:21.794] Timer tick, asking Buildbucket for the build status
[15:35:21.927] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:113:0) after 1m0s
[15:36:22.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:113:0)
[15:36:22.047] Timer tick, asking Buildbucket for the build status
[15:36:22.125] Build 8865552733549443712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:22.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030982795485599792:114:0) after 1m0s
[15:36:30.367] Received PubSub notification, asking Buildbucket for the build status
[15:36:30.625] Build 8865552733549443712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:36:30.625] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603553789062741",
"created_by": "project:chromium",
"created_ts": "1603547079476319",
"id": "8865552733549443712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6d19a03d2212f71500d14d9de44ac0414bc9566\"}}",
"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\": \"a6d19a03d2212f71500d14d9de44ac0414bc9566\", \"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-60-a9u8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42230, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"a6d19a03d2212f71500d14d9de44ac0414bc9566\", \"got_revision_cp\": \"refs/heads/master@{#820566}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6d19a03d2212f71500d14d9de44ac0414bc9566\", \"swarm_hashes_refs/heads/master(at){#820566}_without_patch\": {\"absl_hardening_tests\": \"688545d994f6532d7f0b85189d8f075c04666cf9\", \"accessibility_unittests\": \"7b81131be03d6270f77edaba7716931a10daa0ba\", \"angle_unittests\": \"edf535c474337c6c4dfe3adea646df621b9c5ee1\", \"app_list_unittests\": \"9193141f244b2aa242187f27a798e49fbcd88386\", \"app_shell_unittests\": \"17dd5af2a94534e8d9617e60d980b24ce48a6fa0\", \"ash_unittests\": \"b99360143de938fcc1655567d9f8e5fa9f4eac0e\", \"aura_unittests\": \"5bee71415f8dc7d00854c59cf06c2399ffa34de1\", \"base_unittests\": \"56c4bc2c66e6b7472c6d21ff121a76d0133e2d5c\", \"base_util_unittests\": \"663d99147321ca41b0dc4bdd5e9016d09cd69722\", \"blink_common_unittests\": \"3ee3a41a0532f4220d235580bfdf9ca1165bf084\", \"blink_fuzzer_unittests\": \"322d56ff9bed3b2cffc67f940c6fb2db766ab33b\", \"blink_heap_unittests\": \"daf1ced4536497d9b8ef7d1c4af1d61600af1b08\", \"blink_platform_unittests\": \"58911793b207bc3dc7b912dd90d7f07126d9bad9\", \"blink_unittests\": \"35dd8bc471e69311cd7f0e94fe9dbec659ce7216\", \"boringssl_crypto_tests\": \"5623290ab35bb3a9e56d9c02ef041d8399cb2408\", \"boringssl_ssl_tests\": \"890ac51bfa579d02ed27dbcd8425714c0af2ed42\", \"browser_tests\": \"b86b45dcbc0802d03ac33de7d548b0a8b2879be5\", \"capture_unittests\": \"98b4f2bb25a8c4e9f2949e584e260481b2237e87\", \"cast_unittests\": \"c238dbb0b0aa74b9a687cd934f0f60aa815cfd5f\", \"cc_unittests\": \"97a0fe6bc9888065d58775199d3fb15420cba870\", \"chrome_app_unittests\": \"573e25f35f7d0f52a0e52370ca47728c349b6c33\", \"chromedriver_unittests\": \"c806a7c978a9f0f8000c71edc09dcf6864dc6544\", \"chromeos_components_unittests\": \"5d89be04e53789f532386571f736e0b8a3002286\", \"chromeos_unittests\": \"dd0a4f7ce51b75e109e07a6fbffc68db44172ee7\", \"components_browsertests\": \"73e2810628dbb483625043872ef0d19af0d4b366\", \"components_unittests\": \"58cd5a951e3aaa8d804397004bd8562d243202ad\", \"compositor_unittests\": \"e96d8ab22edb582f05e15b245e09e8d319c4af89\", \"content_browsertests\": \"3fd9dc61c5062126b61a55ca6db4d013911188f7\", \"content_unittests\": \"edb66b66836abdad0ed777296389f5df055cdbad\", \"crypto_unittests\": \"1b5dd23cfac7a6653dad131544295ff13eba92c5\", \"dbus_unittests\": \"8eb7d227c09c9fa029fee5cb948fe3cca71708d8\", \"device_unittests\": \"bc222ceff9e1a227ac8394ecd71366c80e9ba914\", \"display_unittests\": \"f0a32454d726d35a02bdfad8a80928abe0fae772\", \"events_unittests\": \"46b8ec172ebca08b06f05c4db01b27d40d267b49\", \"exo_unittests\": \"da826955e4b1726249850f69c4968646c693a0ba\", \"extensions_browsertests\": \"fb6e2e1d5724f8c5cb2c6a0d3de6eca7573c3ef6\", \"extensions_unittests\": \"3d6decd614d2f717c30c2501863fcb3ed7a5affd\", \"filesystem_service_unittests\": \"110cea0c2c474c12e8804765745c3297684ec362\", \"gcm_unit_tests\": \"e3fdee2867e650f1329e2f610ecaee59e2a4b75f\", \"gfx_unittests\": \"84d04029a30134561b18428cc4afafda0513e8f8\", \"gin_unittests\": \"6b5f99ec5703e0e7e7dd1e745326042351302b7b\", \"gl_unittests_ozone\": \"a8aa909d9b28726c4276810544befbc5e334ac98\", \"google_apis_unittests\": \"3755fdba12a83b5e35a50ea12362ab3b38dc9498\", \"gpu_unittests\": \"3b23cc914a99476c9aec5598fe7abff74e0bfce9\", \"gwp_asan_unittests\": \"48e4085ea948aef88fec7f62fb96e8d5e9420e29\", \"interactive_ui_tests\": \"bf7c67c743c51c9587805c83b25c89dd43e0d34f\", \"ipc_tests\": \"3d79c078491eee4c48ed631d4fd4154808480700\", \"jingle_unittests\": \"450528fc7493d85aa692e4cd7cadcdc3bff3dcff\", \"keyboard_unittests\": \"7ada5883844a1de53d281c7a527951eeb6127eba\", \"latency_unittests\": \"b62ec4807a9414ff9d979f0ab3cad4b862d321e2\", \"libjingle_xmpp_unittests\": \"1266a0eede82b2671dd66a5417c7e1c8653b8c09\", \"media_blink_unittests\": \"6788b119eb2252368f44af20e5fa26f3f7b291f7\", \"media_unittests\": \"6d75326038c8b037929b19ee033b921639926893\", \"message_center_unittests\": \"f02648629bf760fbf24489cbbd45a6486e83ed57\", \"midi_unittests\": \"dab0b1ccfe5b85065c27d38555fb7e75352acd3d\", \"mojo_core_unittests\": \"b52cc33e904567a6e6a8428deb0b4a57f2a29a7b\", \"mojo_unittests\": \"414e626fef013764dfb8af934fe89c19345f8561\", \"nacl_helper_nonsfi_unittests\": \"66cb5a98a4c30875ec3e22118c472788989ba1c0\", \"nacl_loader_unittests\": \"124868265086d9d0badd950eea2b954b176e7a0d\", \"native_theme_unittests\": \"368549d8c65077ea7b1bf3cdfb1167d13da124f4\", \"net_unittests\": \"47f716b67dbb48bf6ddd412178b61a8359e7f5dc\", \"ozone_gl_unittests\": \"81e3bbcbdf6b8afe801c192dbb98e43326a8b3f1\", \"ozone_unittests\": \"59b7f13976600a0b4c9aa0b7b2a5218d8030bcb7\", \"ozone_x11_unittests\": \"7eafd913791e78c4e906b1e7a6db63b0d9e48e4b\", \"pdf_unittests\": \"329717a4a74250e5af5769e91f857d48feded214\", \"perfetto_unittests\": \"650ae8effb6795b98a4f3d8b73dc4e60efa21f83\", \"ppapi_unittests\": \"af7128809f7abb026d3d65a343e015d184265966\", \"printing_unittests\": \"c6a23547bd28750bae7fd37928fcacd5409a9fb8\", \"remoting_unittests\": \"ad6ed245eb1c51328f2a0decb0dbd835f0d24eb1\", \"sandbox_linux_unittests\": \"fea96530565e0495689ed51085234f0f4494f882\", \"service_manager_unittests\": \"ed54c6918a4b387b59549a43cf83f84fa33ad976\", \"services_unittests\": \"f2a0218c7026137fbf4dddfb6a2388f46336859b\", \"shell_dialogs_unittests\": \"7cc006f3414cc9d53ec5d6c419a775cadc3000d2\", \"skia_unittests\": \"6c1db6e3f6ba983e6023522a6570f1a8253ed5cc\", \"snapshot_unittests\": \"a6b8e356ee49bb1a813531a171e26b6be19d0ae6\", \"sql_unittests\": \"7ff19f23e7da379c1e49c06030f603fe8169a7d3\", \"storage_unittests\": \"31e8e2481fafc1e65673241eb4f384a6a10df4cd\", \"sync_integration_tests\": \"ce72efc534ab77cae3a6efc115d877e71077cbd2\", \"traffic_annotation_auditor_unittests\": \"b524696d432752955843976049f7393a8b279415\", \"ui_base_unittests\": \"766d147b7fc6562780e13d09e0ee09a6a39482b1\", \"ui_chromeos_unittests\": \"cd05c50443559671b8b16c10f8cf9fd79c99a2e4\", \"ui_touch_selection_unittests\": \"a41f379eec6a84125e51bc88a3f2e45e812545bd\", \"unit_tests\": \"ff497aa02a42748ee0303a9905be92494e1b5c92\", \"url_unittests\": \"ac74ef8e2bbb2e907ec44d67b2c5203cb61977a7\", \"usage_time_limit_unittests\": \"bc8678fde5f51ef189cc7dffad12397e2cb4445f\", \"views_unittests\": \"80e75ddab1c45f903a4583513524b0988eaa60a3\", \"viz_unittests\": \"cf22d04b9530061df901c5c0e0ef492fc46bbd70\", \"wayland_client_perftests\": \"f597f57ee552f5c80b34a3ab0e809978899d22f1\", \"wm_unittests\": \"be8c69f02ecd50b190be09658810aea40553151a\", \"wtf_unittests\": \"7ba72d5e102f6010b2b180fdb55c2ad5b3577898\", \"zlib_unittests\": \"6ca90be974f4fe5e8a10d9ae601dea0e2dff5ec2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_f9f2734650081c8f035f462d2587d0f0f9b67c047824fda9ebe98bcfe42a9ba7_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-60-a9u8\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603548801303671",
"status": "COMPLETED",
"status_changed_ts": "1603553789568471",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42230",
"builder:linux-chromeos-rel",
"buildset:commit/git/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6d19a03d2212f71500d14d9de44ac0414bc9566",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030982795485599792",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865552733549443712/+/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:4f73ac2dfe9ea210",
"user_agent:luci-scheduler"
],
"updated_ts": "1603553789587014",
"url": "https://ci.chromium.org/b/8865552733549443712",
"utcnow_ts": "1603553790565172"
}
}
[15:36:30.625] Invocation finished in 1h51m52.379333645s with status SUCCEEDED