[14:21:18.935] New invocation is queued and will start shortly
[14:21:20.057] Starting the invocation (attempt 1)
[14:21:20.096] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:21:20.096] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:21:20.096] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027809594089975696",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027809594089975696",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"gitiles_ref:refs/heads/master"
]
}
[14:21:20.788] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606573280182025",
"id": "8862379532117607280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606573280597826",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43270",
"builder:linux-chromeos-rel",
"buildset:commit/git/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027809594089975696",
"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/8862379532117607280/+/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": "1606573280597927",
"url": "https://ci.chromium.org/b/8862379532117607280",
"utcnow_ts": "1606573280774597"
}
}
[14:21:20.788] Task URL: https://ci.chromium.org/b/8862379532117607280
[14:21:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:2:0) after 1m0s
[14:22:20.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:2:0)
[14:22:20.832] Timer tick, asking Buildbucket for the build status
[14:22:20.946] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:3:0) after 1m0s
[14:23:21.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:3:0)
[14:23:21.068] Timer tick, asking Buildbucket for the build status
[14:23:21.247] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:21.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:4:0) after 1m0s
[14:24:21.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:4:0)
[14:24:21.296] Timer tick, asking Buildbucket for the build status
[14:24:21.634] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:21.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:5:0) after 1m0s
[14:25:21.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:5:0)
[14:25:21.659] Timer tick, asking Buildbucket for the build status
[14:25:21.783] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:6:0) after 1m0s
[14:26:22.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:6:0)
[14:26:22.115] Timer tick, asking Buildbucket for the build status
[14:26:22.208] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:22.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:7:0) after 1m0s
[14:27:22.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:7:0)
[14:27:22.325] Timer tick, asking Buildbucket for the build status
[14:27:22.852] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:22.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:8:0) after 1m0s
[14:28:22.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:8:0)
[14:28:22.961] Timer tick, asking Buildbucket for the build status
[14:28:23.292] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:23.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:9:0) after 1m0s
[14:29:23.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:9:0)
[14:29:23.459] Timer tick, asking Buildbucket for the build status
[14:29:23.717] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:23.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:10:0) after 1m0s
[14:30:23.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:10:0)
[14:30:23.783] Timer tick, asking Buildbucket for the build status
[14:30:23.852] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:23.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:11:0) after 1m0s
[14:31:23.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:11:0)
[14:31:23.887] Timer tick, asking Buildbucket for the build status
[14:31:24.106] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:24.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:12:0) after 1m0s
[14:32:24.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:12:0)
[14:32:24.170] Timer tick, asking Buildbucket for the build status
[14:32:24.283] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:24.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:13:0) after 1m0s
[14:33:24.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:13:0)
[14:33:24.315] Timer tick, asking Buildbucket for the build status
[14:33:25.961] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:25.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:14:0) after 1m0s
[14:34:26.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:14:0)
[14:34:26.117] Timer tick, asking Buildbucket for the build status
[14:34:26.195] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:34:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:15:0) after 1m0s
[14:35:26.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:15:0)
[14:35:26.232] Timer tick, asking Buildbucket for the build status
[14:35:26.439] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:26.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:16:0) after 1m0s
[14:36:26.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:16:0)
[14:36:26.520] Timer tick, asking Buildbucket for the build status
[14:36:26.666] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:26.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:17:0) after 1m0s
[14:37:26.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:17:0)
[14:37:26.735] Timer tick, asking Buildbucket for the build status
[14:37:26.944] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:37:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:18:0) after 1m0s
[14:38:27.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:18:0)
[14:38:27.015] Timer tick, asking Buildbucket for the build status
[14:38:27.098] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:38:27.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:19:0) after 1m0s
[14:39:27.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:19:0)
[14:39:27.190] Timer tick, asking Buildbucket for the build status
[14:39:28.031] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:28.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:20:0) after 1m0s
[14:40:28.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:20:0)
[14:40:28.094] Timer tick, asking Buildbucket for the build status
[14:40:28.371] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:40:28.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:21:0) after 1m0s
[14:41:28.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:21:0)
[14:41:28.420] Timer tick, asking Buildbucket for the build status
[14:41:28.607] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:41:28.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:22:0) after 1m0s
[14:42:28.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:22:0)
[14:42:28.627] Timer tick, asking Buildbucket for the build status
[14:42:28.852] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:42:28.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:23:0) after 1m0s
[14:43:28.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:23:0)
[14:43:28.923] Timer tick, asking Buildbucket for the build status
[14:43:29.094] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:43:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:24:0) after 1m0s
[14:44:29.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:24:0)
[14:44:29.179] Timer tick, asking Buildbucket for the build status
[14:44:29.252] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:44:29.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:25:0) after 1m0s
[14:45:29.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:25:0)
[14:45:29.274] Timer tick, asking Buildbucket for the build status
[14:45:29.374] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:45:29.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:26:0) after 1m0s
[14:46:29.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:26:0)
[14:46:29.396] Timer tick, asking Buildbucket for the build status
[14:46:29.497] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:29.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:27:0) after 1m0s
[14:47:29.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:27:0)
[14:47:29.514] Timer tick, asking Buildbucket for the build status
[14:47:29.592] Build 8862379532117607280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:29.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:28:0) after 1m0s
[14:47:31.592] Received PubSub notification, asking Buildbucket for the build status
[14:47:31.676] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:29.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:28:0)
[14:48:29.598] Timer tick, asking Buildbucket for the build status
[14:48:29.672] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:29.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:30:0) after 1m0s
[14:49:29.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:30:0)
[14:49:29.718] Timer tick, asking Buildbucket for the build status
[14:49:29.849] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:29.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:31:0) after 1m0s
[14:50:29.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:31:0)
[14:50:29.887] Timer tick, asking Buildbucket for the build status
[14:50:30.027] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:30.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:32:0) after 1m0s
[14:51:30.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:32:0)
[14:51:30.140] Timer tick, asking Buildbucket for the build status
[14:51:30.432] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:30.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:33:0) after 1m0s
[14:52:30.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:33:0)
[14:52:30.597] Timer tick, asking Buildbucket for the build status
[14:52:30.690] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:30.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:34:0) after 1m0s
[14:53:30.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:34:0)
[14:53:30.689] Timer tick, asking Buildbucket for the build status
[14:53:30.943] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:30.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:35:0) after 1m0s
[14:54:30.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:35:0)
[14:54:30.914] Timer tick, asking Buildbucket for the build status
[14:54:31.141] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:31.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:36:0) after 1m0s
[14:55:31.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:36:0)
[14:55:31.163] Timer tick, asking Buildbucket for the build status
[14:55:31.216] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:31.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:37:0) after 1m0s
[14:56:31.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:37:0)
[14:56:31.331] Timer tick, asking Buildbucket for the build status
[14:56:31.426] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:31.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:38:0) after 1m0s
[14:57:31.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:38:0)
[14:57:31.417] Timer tick, asking Buildbucket for the build status
[14:57:31.657] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:31.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:39:0) after 1m0s
[14:58:31.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:39:0)
[14:58:31.772] Timer tick, asking Buildbucket for the build status
[14:58:32.045] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:40:0) after 1m0s
[14:59:32.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:40:0)
[14:59:32.214] Timer tick, asking Buildbucket for the build status
[14:59:32.299] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:32.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:41:0) after 1m0s
[15:00:32.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:41:0)
[15:00:32.318] Timer tick, asking Buildbucket for the build status
[15:00:32.382] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:32.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:42:0) after 1m0s
[15:01:32.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:42:0)
[15:01:32.404] Timer tick, asking Buildbucket for the build status
[15:01:33.195] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:33.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:43:0) after 1m0s
[15:02:33.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:43:0)
[15:02:33.422] Timer tick, asking Buildbucket for the build status
[15:02:33.528] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:33.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:44:0) after 1m0s
[15:03:33.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:44:0)
[15:03:33.564] Timer tick, asking Buildbucket for the build status
[15:03:33.713] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:33.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:45:0) after 1m0s
[15:04:33.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:45:0)
[15:04:33.743] Timer tick, asking Buildbucket for the build status
[15:04:33.842] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:33.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:46:0) after 1m0s
[15:05:33.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:46:0)
[15:05:33.925] Timer tick, asking Buildbucket for the build status
[15:05:33.997] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:33.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:47:0) after 1m0s
[15:06:34.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:47:0)
[15:06:34.102] Timer tick, asking Buildbucket for the build status
[15:06:34.230] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:34.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:48:0) after 1m0s
[15:07:34.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:48:0)
[15:07:34.261] Timer tick, asking Buildbucket for the build status
[15:07:34.373] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:34.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:49:0) after 1m0s
[15:08:34.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:49:0)
[15:08:34.398] Timer tick, asking Buildbucket for the build status
[15:08:34.485] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:34.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:50:0) after 1m0s
[15:09:34.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:50:0)
[15:09:34.602] Timer tick, asking Buildbucket for the build status
[15:09:34.679] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:34.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:51:0) after 1m0s
[15:10:34.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:51:0)
[15:10:34.803] Timer tick, asking Buildbucket for the build status
[15:10:34.966] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:34.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:52:0) after 1m0s
[15:11:34.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:52:0)
[15:11:34.985] Timer tick, asking Buildbucket for the build status
[15:11:35.118] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:35.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:53:0) after 1m0s
[15:12:35.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:53:0)
[15:12:35.177] Timer tick, asking Buildbucket for the build status
[15:12:35.782] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:35.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:54:0) after 1m0s
[15:13:35.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:54:0)
[15:13:35.808] Timer tick, asking Buildbucket for the build status
[15:13:36.012] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:36.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:55:0) after 1m0s
[15:14:36.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:55:0)
[15:14:36.043] Timer tick, asking Buildbucket for the build status
[15:14:36.124] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:56:0) after 1m0s
[15:15:36.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:56:0)
[15:15:36.198] Timer tick, asking Buildbucket for the build status
[15:15:36.377] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:36.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:57:0) after 1m0s
[15:16:36.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:57:0)
[15:16:36.401] Timer tick, asking Buildbucket for the build status
[15:16:37.253] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:37.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:58:0) after 1m0s
[15:17:37.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:58:0)
[15:17:37.312] Timer tick, asking Buildbucket for the build status
[15:17:37.508] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:37.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:59:0) after 1m0s
[15:18:37.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:59:0)
[15:18:37.529] Timer tick, asking Buildbucket for the build status
[15:18:37.847] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:60:0) after 1m0s
[15:19:37.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:60:0)
[15:19:37.877] Timer tick, asking Buildbucket for the build status
[15:19:38.058] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:38.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:61:0) after 1m0s
[15:20:38.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:61:0)
[15:20:38.176] Timer tick, asking Buildbucket for the build status
[15:20:38.311] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:38.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:62:0) after 1m0s
[15:21:38.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:62:0)
[15:21:38.375] Timer tick, asking Buildbucket for the build status
[15:21:38.523] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:38.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:63:0) after 1m0s
[15:22:38.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:63:0)
[15:22:38.611] Timer tick, asking Buildbucket for the build status
[15:22:39.205] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:64:0) after 1m0s
[15:23:39.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:64:0)
[15:23:39.387] Timer tick, asking Buildbucket for the build status
[15:23:39.564] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:39.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:65:0) after 1m0s
[15:24:39.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:65:0)
[15:24:39.547] Timer tick, asking Buildbucket for the build status
[15:24:39.644] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:66:0) after 1m0s
[15:25:39.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:66:0)
[15:25:39.667] Timer tick, asking Buildbucket for the build status
[15:25:41.178] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:41.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:67:0) after 1m0s
[15:26:41.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:67:0)
[15:26:41.311] Timer tick, asking Buildbucket for the build status
[15:26:41.660] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:41.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:68:0) after 1m0s
[15:27:41.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:68:0)
[15:27:41.747] Timer tick, asking Buildbucket for the build status
[15:27:42.082] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:42.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:69:0) after 1m0s
[15:28:42.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:69:0)
[15:28:42.239] Timer tick, asking Buildbucket for the build status
[15:28:42.333] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:42.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:70:0) after 1m0s
[15:29:42.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:70:0)
[15:29:42.448] Timer tick, asking Buildbucket for the build status
[15:29:42.575] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:42.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:71:0) after 1m0s
[15:30:42.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:71:0)
[15:30:42.645] Timer tick, asking Buildbucket for the build status
[15:30:42.746] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:42.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:72:0) after 1m0s
[15:31:42.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:72:0)
[15:31:42.770] Timer tick, asking Buildbucket for the build status
[15:31:42.869] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:42.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:73:0) after 1m0s
[15:32:42.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:73:0)
[15:32:42.908] Timer tick, asking Buildbucket for the build status
[15:32:42.976] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:42.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:74:0) after 1m0s
[15:33:43.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:74:0)
[15:33:43.047] Timer tick, asking Buildbucket for the build status
[15:33:43.159] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:43.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:75:0) after 1m0s
[15:34:43.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:75:0)
[15:34:43.188] Timer tick, asking Buildbucket for the build status
[15:34:43.502] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:43.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:76:0) after 1m0s
[15:35:43.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:76:0)
[15:35:43.491] Timer tick, asking Buildbucket for the build status
[15:35:43.573] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:43.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:77:0) after 1m0s
[15:36:43.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:77:0)
[15:36:43.733] Timer tick, asking Buildbucket for the build status
[15:36:44.024] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:44.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:78:0) after 1m0s
[15:37:44.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:78:0)
[15:37:44.152] Timer tick, asking Buildbucket for the build status
[15:37:44.284] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:44.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:79:0) after 1m0s
[15:38:44.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:79:0)
[15:38:44.310] Timer tick, asking Buildbucket for the build status
[15:38:44.450] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:44.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:80:0) after 1m0s
[15:39:44.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:80:0)
[15:39:44.426] Timer tick, asking Buildbucket for the build status
[15:39:44.617] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:44.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:81:0) after 1m0s
[15:40:44.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:81:0)
[15:40:44.606] Timer tick, asking Buildbucket for the build status
[15:40:44.692] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:44.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:82:0) after 1m0s
[15:41:44.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:82:0)
[15:41:44.734] Timer tick, asking Buildbucket for the build status
[15:41:45.058] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:45.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:83:0) after 1m0s
[15:42:45.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:83:0)
[15:42:45.135] Timer tick, asking Buildbucket for the build status
[15:42:45.234] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:45.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:84:0) after 1m0s
[15:43:45.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:84:0)
[15:43:45.263] Timer tick, asking Buildbucket for the build status
[15:43:45.341] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:45.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:85:0) after 1m0s
[15:44:45.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:85:0)
[15:44:45.369] Timer tick, asking Buildbucket for the build status
[15:44:45.916] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:45.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:86:0) after 1m0s
[15:45:45.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:86:0)
[15:45:45.976] Timer tick, asking Buildbucket for the build status
[15:45:46.045] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:46.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:87:0) after 1m0s
[15:46:46.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:87:0)
[15:46:46.118] Timer tick, asking Buildbucket for the build status
[15:46:46.366] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:46.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:88:0) after 1m0s
[15:47:46.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:88:0)
[15:47:46.419] Timer tick, asking Buildbucket for the build status
[15:47:46.828] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:46.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:89:0) after 1m0s
[15:48:46.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:89:0)
[15:48:46.954] Timer tick, asking Buildbucket for the build status
[15:48:47.083] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:47.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:90:0) after 1m0s
[15:49:47.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:90:0)
[15:49:47.149] Timer tick, asking Buildbucket for the build status
[15:49:47.356] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:47.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:91:0) after 1m0s
[15:50:47.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:91:0)
[15:50:47.389] Timer tick, asking Buildbucket for the build status
[15:50:47.515] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:47.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:92:0) after 1m0s
[15:51:47.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:92:0)
[15:51:47.555] Timer tick, asking Buildbucket for the build status
[15:51:47.904] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:47.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:93:0) after 1m0s
[15:52:47.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:93:0)
[15:52:47.950] Timer tick, asking Buildbucket for the build status
[15:52:48.077] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:48.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:94:0) after 1m0s
[15:53:50.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:94:0)
[15:53:50.823] Timer tick, asking Buildbucket for the build status
[15:53:50.897] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:50.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:95:0) after 1m0s
[15:54:51.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:95:0)
[15:54:51.177] Timer tick, asking Buildbucket for the build status
[15:54:51.247] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:51.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:96:0) after 1m0s
[15:55:51.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:96:0)
[15:55:51.514] Timer tick, asking Buildbucket for the build status
[15:55:51.692] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:51.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:97:0) after 1m0s
[15:56:51.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:97:0)
[15:56:51.918] Timer tick, asking Buildbucket for the build status
[15:56:52.132] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:52.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:98:0) after 1m0s
[15:57:52.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:98:0)
[15:57:52.465] Timer tick, asking Buildbucket for the build status
[15:57:52.555] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:52.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:99:0) after 1m0s
[15:58:53.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:99:0)
[15:58:53.736] Timer tick, asking Buildbucket for the build status
[15:58:55.034] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:55.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:100:0) after 1m0s
[15:59:55.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:100:0)
[15:59:55.333] Timer tick, asking Buildbucket for the build status
[15:59:55.809] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:101:0) after 1m0s
[16:00:55.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:101:0)
[16:00:55.846] Timer tick, asking Buildbucket for the build status
[16:00:55.976] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:55.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:102:0) after 1m0s
[16:01:56.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:102:0)
[16:01:56.160] Timer tick, asking Buildbucket for the build status
[16:01:56.313] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:56.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:103:0) after 1m0s
[16:02:56.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:103:0)
[16:02:56.449] Timer tick, asking Buildbucket for the build status
[16:02:56.582] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:56.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:104:0) after 1m0s
[16:03:57.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:104:0)
[16:03:57.017] Timer tick, asking Buildbucket for the build status
[16:03:57.139] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:57.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:105:0) after 1m0s
[16:04:57.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:105:0)
[16:04:57.433] Timer tick, asking Buildbucket for the build status
[16:04:57.577] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:57.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:106:0) after 1m0s
[16:05:57.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:106:0)
[16:05:57.936] Timer tick, asking Buildbucket for the build status
[16:05:58.262] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:58.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:107:0) after 1m0s
[16:06:58.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:107:0)
[16:06:58.288] Timer tick, asking Buildbucket for the build status
[16:06:58.614] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:58.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:108:0) after 1m0s
[16:07:58.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:108:0)
[16:07:58.665] Timer tick, asking Buildbucket for the build status
[16:07:58.814] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:58.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:109:0) after 1m0s
[16:08:58.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:109:0)
[16:08:58.884] Timer tick, asking Buildbucket for the build status
[16:08:59.008] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:59.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:110:0) after 1m0s
[16:09:59.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:110:0)
[16:09:59.042] Timer tick, asking Buildbucket for the build status
[16:09:59.266] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:59.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:111:0) after 1m0s
[16:10:59.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:111:0)
[16:10:59.296] Timer tick, asking Buildbucket for the build status
[16:10:59.407] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:112:0) after 1m0s
[16:11:59.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:112:0)
[16:11:59.472] Timer tick, asking Buildbucket for the build status
[16:11:59.928] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:59.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:113:0) after 1m0s
[16:13:00.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:113:0)
[16:13:00.103] Timer tick, asking Buildbucket for the build status
[16:13:01.382] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:01.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:114:0) after 1m0s
[16:14:01.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:114:0)
[16:14:01.452] Timer tick, asking Buildbucket for the build status
[16:14:01.738] Build 8862379532117607280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:01.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027809594089975696:115:0) after 1m0s
[16:14:05.240] Received PubSub notification, asking Buildbucket for the build status
[16:14:05.940] Build 8862379532117607280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:14:05.940] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606580044218567",
"created_by": "project:chromium",
"created_ts": "1606573280182025",
"id": "8862379532117607280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\"}}",
"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\": \"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\", \"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-38-28as\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43270, \"got_angle_revision\": \"59aa1ef1975ae2d263da864f111eaaa7cdb4f9f2\", \"got_dawn_revision\": \"d88a86c2061da58f21f1b654a5af668f340662a7\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\", \"got_revision_cp\": \"refs/heads/master@{#831684}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"8d791670ba247239ef6ce9091183f11f8c5f0825\", \"got_v8_revision_cp\": \"refs/heads/8.9.65@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1\", \"swarm_hashes_refs/heads/master(at){#831684}_without_patch\": {\"absl_hardening_tests\": \"9b0d71c9b3791f07bd2c9890aff17f76f18cad2b\", \"accessibility_unittests\": \"59d4c3e5c2f773db34e374a1c8115e04e9a938e2\", \"angle_unittests\": \"6e790af9059652c0ebfd1313e993c796fad6734b\", \"app_list_unittests\": \"b119740fcf04f268a125d8b3cde6dfd094245a6d\", \"app_shell_unittests\": \"f96ab808932a4ee28d497ab6eead87af5487814b\", \"ash_unittests\": \"a5182586f0c83759a74cd69baab2046041833959\", \"aura_unittests\": \"ceab988598862617776ac69fcb30f74c2614421b\", \"base_unittests\": \"b374808513ed8cc4283c0938f899ceec45fd7d4a\", \"base_util_unittests\": \"378a9569e4f52a040106b8d857b7b237feef94f4\", \"blink_common_unittests\": \"a6c6bdb35239db5f63dcfaf948eeba717eb8cf6c\", \"blink_fuzzer_unittests\": \"ef714aa3f320b9ef632439263a75e83a82cfb5ab\", \"blink_heap_unittests\": \"5a927a97bc0c935e9afa1278b5904d07de5c2032\", \"blink_platform_unittests\": \"2b7bbb719990464d08b11c282be8c7d0e9383077\", \"blink_unittests\": \"9a1c98c0dc727fe7106c27230bdf5d3ad7b41791\", \"boringssl_crypto_tests\": \"db7f48dfe70d407137512476f673348f2d3f034b\", \"boringssl_ssl_tests\": \"7cbfa3d76c74cdb9511b790053719f1116f5fc9d\", \"browser_tests\": \"b5c9f45c5166b0edd00842092740d75369973c44\", \"capture_unittests\": \"1ea52f26518cd098e8687b3402d667aa2050629e\", \"cast_unittests\": \"4c806e2e0ab73d6f33356cdbe0b9cec1e16ba997\", \"cc_unittests\": \"c13e82051e8c5ef1516a5a4fcd12d784dbc962fc\", \"chrome_app_unittests\": \"a560371436428a8d948ecbdebab5d6ca1f6bd5ab\", \"chromedriver_unittests\": \"0fad824531acf18e393e9cf612a8f05d9518ab2a\", \"chromeos_components_unittests\": \"4a4885c87872cecbc2b73044401e63e88c371639\", \"chromeos_unittests\": \"60575dbc866a285be8de2086f8ca53381f739557\", \"components_browsertests\": \"d50067797e457c42c9a03d097ac80978ab147d9a\", \"components_unittests\": \"f586e66a4df5e2330f859a057c1ca8abac1681de\", \"compositor_unittests\": \"9f7eb60a5f25b37d13bfc702eae68770cc386d2d\", \"content_browsertests\": \"8af87e26946f3ba27045e628c1a797f1639da85f\", \"content_unittests\": \"ab3c2f03e7080c98d830a5351f7111a1f6556ead\", \"crashpad_tests\": \"abcb1ed7390474088ff0eade371ff14600ee99f0\", \"crypto_unittests\": \"bc9c8e0fd65732ccd5cc5c4855bec821c39b2ca4\", \"dbus_unittests\": \"2a5ed01058a7763341eab95946fbf0fec3fa7ff3\", \"device_unittests\": \"13720810fcfccb2cf34a93ad1059b56bcabb10ff\", \"display_unittests\": \"d2b51b8843164e12b3409b978376a241947bc42e\", \"events_unittests\": \"7983aceec27ae5a279783f13e22fcd2c25dc85f4\", \"exo_unittests\": \"a00d5f3fa6db4edb8f215e917eedb2fa4fc6f89b\", \"extensions_browsertests\": \"8abdc035d97ea48958b672c6dba043788925a9ef\", \"extensions_unittests\": \"77a82d20ac84df08c3559c74cc3a7d7dcdb15a2c\", \"filesystem_service_unittests\": \"71203ffa5b0a08385376af80320f85273693eb3a\", \"gcm_unit_tests\": \"059d7d86eb65611ace4be87b0d158c688dfabe35\", \"gfx_unittests\": \"57c83ce5d61377b08c014b41e2777b5f27db5a29\", \"gin_unittests\": \"656d70106d4c4652ec17778118cc755007fcc7aa\", \"gl_unittests_ozone\": \"225306690870281304427e44961dce50695c1a10\", \"google_apis_unittests\": \"96eb19e21a3de1740fc9b4e7f5b43ba0a3399d86\", \"gpu_unittests\": \"47d76954a83ab195b08548c445bb2ca7d2704215\", \"gwp_asan_unittests\": \"67ab34b02a73c36638873bbb9d0d5fefe648a965\", \"interactive_ui_tests\": \"d4857186262248f336071ffa1e3a88bc63ad15ba\", \"ipc_tests\": \"e64ba4977430a36b9d1ed36ff37e60b79c7fe4b3\", \"jingle_unittests\": \"2f8ef16df62d4eb7dc283ed7f8225b81059e08f0\", \"keyboard_unittests\": \"e539baee9743c3be8ff7d20171d0739c3aab114c\", \"latency_unittests\": \"e58b53eaf3ac52d7d781e44d2cdbe603dcf2a8fd\", \"libjingle_xmpp_unittests\": \"b19ca2676c0f62f9274600d5335b95e779a90cdc\", \"liburlpattern_unittests\": \"8f8f2b0c5ffaa0be0895dca21fca4516b904f118\", \"media_blink_unittests\": \"098929acdc6eedab52dd71425172d6b094a339df\", \"media_unittests\": \"72514cf3cfdcebdcdde567389248f835f05d1e0f\", \"message_center_unittests\": \"005265edba0bb6aa3e0497ec1b35721e88cefc84\", \"midi_unittests\": \"0061f1b71d6ef663640156ff8af6149718adaf37\", \"mojo_core_unittests\": \"0c7de22a3e7c4f490b8f7abb88c262b9bcca861e\", \"mojo_unittests\": \"505061db961be1c4335021df34aed563484dca4f\", \"nacl_helper_nonsfi_unittests\": \"b76370972dcd5e86c5b2f69d7772f5be583a1a6a\", \"nacl_loader_unittests\": \"36750d41daa57ef92013b7fd377c313fb44fe583\", \"native_theme_unittests\": \"03e6f889534c35c6ba4843a1f7425bebedaf9845\", \"net_unittests\": \"0cfe30330de595f3a177baf91793585f1ba96a7e\", \"ozone_gl_unittests\": \"8ed46effd5fc2d71bc45d8d308caf8783fc5f239\", \"ozone_unittests\": \"f739926e57ad652fdda8224f82d55c9a03af5b2d\", \"ozone_x11_unittests\": \"0da2d9df0a0b7bfb7535d853f21bf1b4a249e9eb\", \"pdf_unittests\": \"5492e8d830cd70ec3792efc71775b266a809e2da\", \"perfetto_unittests\": \"d80096f35bcf109df4cadd4544a3c9e19dcc6f2b\", \"ppapi_unittests\": \"7a0f760bf3e30649037cd4592fd323ee4ace473b\", \"printing_unittests\": \"6db13858f765b123139de41f80295091864b61c2\", \"remoting_unittests\": \"ae16b6dd9c42dbc333e3f664559fa94f2deb5c11\", \"sandbox_linux_unittests\": \"0ed5deced38d61cf258b0243af07710178b6032d\", \"service_manager_unittests\": \"fab9975f1d4b731f2afc5bcab9da9344339b9d45\", \"services_unittests\": \"06cdd309b1740af172303ea8f619da6eaa2cdafb\", \"shell_dialogs_unittests\": \"67bd1bce72a80e32a020f63ab03fd64039583c7a\", \"skia_unittests\": \"41a73804bce2925d12c14f86d5655adae6c2db67\", \"snapshot_unittests\": \"a9a87e400940ba899e539f9a27cce74f1efd46e9\", \"sql_unittests\": \"88f30eeb8a26080ab8616621b7b1e76bae095371\", \"storage_unittests\": \"da47c86075fba27e378894da6d2ff5cd9a2a7199\", \"sync_integration_tests\": \"5c0aeb9f12dde696ad3c6d3524a30046fde2b8ab\", \"traffic_annotation_auditor_unittests\": \"073cb4b92540ea8668e4e5aa04b25a8211a2a189\", \"ui_base_unittests\": \"7ebfcbfe6c4e68f5775bbc85941cf6e02c1c34db\", \"ui_chromeos_unittests\": \"599e51c5b64691b0ee84e7fc8c85c32598585634\", \"ui_touch_selection_unittests\": \"8034e4f98dbbfe7d19d3301d7c81a77c01980b3a\", \"unit_tests\": \"c422fd665dc90ca3278fe25acdc0c9627fb75b86\", \"url_unittests\": \"84b5450da94fcba7cd8d2df6b6809418ebed116b\", \"usage_time_limit_unittests\": \"0cab644f4e0558057971d54cdf5b7d4eb9fb53a3\", \"views_unittests\": \"212a85c402505a52a64f1b23d1e7af4364dda7d3\", \"viz_unittests\": \"ac93ea274f7ff26f8dbe459f6ab037de96295b18\", \"wayland_client_perftests\": \"bdc96a886ad97c3f21d32b5f9cf1ed697e781f0e\", \"wm_unittests\": \"460a862eb69e539086227e1c77c7cc22d17fbf33\", \"wtf_unittests\": \"240e364442eabdea357dd5d879fd446428f74ff6\", \"zlib_unittests\": \"f444b41f9947dcebaaae517413aacd223b52fc88\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_7038f72a8497d99b8274809a89493d066575b874ae7ab7a985f73ba6942472f2_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-38-28as\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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": "1606574850758129",
"status": "COMPLETED",
"status_changed_ts": "1606580044641365",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43270",
"builder:linux-chromeos-rel",
"buildset:commit/git/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c86c5e5d3eebf6ee76c66ffb4bc2d6480793d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027809594089975696",
"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/8862379532117607280/+/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:50280c5622da7110",
"user_agent:luci-scheduler"
],
"updated_ts": "1606580044648186",
"url": "https://ci.chromium.org/b/8862379532117607280",
"utcnow_ts": "1606580045861057"
}
}
[16:14:05.940] Invocation finished in 1h52m47.022537462s with status SUCCEEDED