[23:28:28.524] New invocation is queued and will start shortly
[23:28:29.576] Starting the invocation (attempt 1)
[23:28:29.620] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:28:29.620] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:28:29.621] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019168457967318464",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bba3e95fb194671dda3a74353b20510fcbc85610\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019168457967318464",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/bba3e95fb194671dda3a74353b20510fcbc85610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bba3e95fb194671dda3a74353b20510fcbc85610",
"gitiles_ref:refs/heads/master"
]
}
[23:28:30.928] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614814109740395",
"id": "8853738396023450848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bba3e95fb194671dda3a74353b20510fcbc85610\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614814110694307",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45890",
"builder:linux-chromeos-rel",
"buildset:commit/git/bba3e95fb194671dda3a74353b20510fcbc85610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bba3e95fb194671dda3a74353b20510fcbc85610",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019168457967318464",
"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/8853738396023450848/+/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": "1614814110694504",
"url": "https://ci.chromium.org/b/8853738396023450848",
"utcnow_ts": "1614814110912748"
}
}
[23:28:30.928] Task URL: https://ci.chromium.org/b/8853738396023450848
[23:28:30.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:2:0) after 1m0s
[23:29:30.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:2:0)
[23:29:30.919] Timer tick, asking Buildbucket for the build status
[23:29:31.265] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:31.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:3:0) after 1m0s
[23:30:31.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:3:0)
[23:30:31.323] Timer tick, asking Buildbucket for the build status
[23:30:31.452] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:31.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:4:0) after 1m0s
[23:31:31.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:4:0)
[23:31:31.680] Timer tick, asking Buildbucket for the build status
[23:31:31.747] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:31.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:5:0) after 1m0s
[23:32:31.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:5:0)
[23:32:31.936] Timer tick, asking Buildbucket for the build status
[23:32:32.003] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:32.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:6:0) after 1m0s
[23:33:32.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:6:0)
[23:33:32.061] Timer tick, asking Buildbucket for the build status
[23:33:32.147] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:32.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:7:0) after 1m0s
[23:34:32.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:7:0)
[23:34:32.124] Timer tick, asking Buildbucket for the build status
[23:34:32.237] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:32.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:8:0) after 1m0s
[23:35:32.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:8:0)
[23:35:32.473] Timer tick, asking Buildbucket for the build status
[23:35:32.771] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:9:0) after 1m0s
[23:36:32.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:9:0)
[23:36:32.809] Timer tick, asking Buildbucket for the build status
[23:36:32.954] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:32.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:10:0) after 1m0s
[23:37:33.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:10:0)
[23:37:33.082] Timer tick, asking Buildbucket for the build status
[23:37:33.143] Build 8853738396023450848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:33.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:11:0) after 1m0s
[23:37:47.553] Received PubSub notification, asking Buildbucket for the build status
[23:37:47.641] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:33.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:11:0)
[23:38:33.277] Timer tick, asking Buildbucket for the build status
[23:38:33.443] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:33.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:13:0) after 1m0s
[23:39:33.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:13:0)
[23:39:33.629] Timer tick, asking Buildbucket for the build status
[23:39:33.794] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:33.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:14:0) after 1m0s
[23:40:33.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:14:0)
[23:40:33.828] Timer tick, asking Buildbucket for the build status
[23:40:33.906] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:33.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:15:0) after 1m0s
[23:41:33.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:15:0)
[23:41:33.980] Timer tick, asking Buildbucket for the build status
[23:41:34.241] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:34.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:16:0) after 1m0s
[23:42:34.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:16:0)
[23:42:34.330] Timer tick, asking Buildbucket for the build status
[23:42:34.394] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:34.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:17:0) after 1m0s
[23:43:34.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:17:0)
[23:43:34.437] Timer tick, asking Buildbucket for the build status
[23:43:34.506] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:34.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:18:0) after 1m0s
[23:44:34.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:18:0)
[23:44:34.563] Timer tick, asking Buildbucket for the build status
[23:44:34.665] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:34.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:19:0) after 1m0s
[23:45:34.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:19:0)
[23:45:34.748] Timer tick, asking Buildbucket for the build status
[23:45:36.328] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:36.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:20:0) after 1m0s
[23:46:36.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:20:0)
[23:46:36.451] Timer tick, asking Buildbucket for the build status
[23:46:37.082] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:37.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:21:0) after 1m0s
[23:47:37.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:21:0)
[23:47:37.105] Timer tick, asking Buildbucket for the build status
[23:47:37.171] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:37.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:22:0) after 1m0s
[23:48:37.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:22:0)
[23:48:37.229] Timer tick, asking Buildbucket for the build status
[23:48:37.418] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:37.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:23:0) after 1m0s
[23:49:37.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:23:0)
[23:49:37.433] Timer tick, asking Buildbucket for the build status
[23:49:37.612] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:37.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:24:0) after 1m0s
[23:50:37.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:24:0)
[23:50:37.798] Timer tick, asking Buildbucket for the build status
[23:50:37.892] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:37.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:25:0) after 1m0s
[23:51:37.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:25:0)
[23:51:37.949] Timer tick, asking Buildbucket for the build status
[23:51:38.020] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:38.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:26:0) after 1m0s
[23:52:38.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:26:0)
[23:52:38.060] Timer tick, asking Buildbucket for the build status
[23:52:38.232] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:38.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:27:0) after 1m0s
[23:53:38.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:27:0)
[23:53:38.265] Timer tick, asking Buildbucket for the build status
[23:53:38.363] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:38.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:28:0) after 1m0s
[23:54:38.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:28:0)
[23:54:38.395] Timer tick, asking Buildbucket for the build status
[23:54:38.845] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:29:0) after 1m0s
[23:55:38.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:29:0)
[23:55:38.816] Timer tick, asking Buildbucket for the build status
[23:55:38.949] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:38.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:30:0) after 1m0s
[23:56:38.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:30:0)
[23:56:38.967] Timer tick, asking Buildbucket for the build status
[23:56:39.047] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:39.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:31:0) after 1m0s
[23:57:39.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:31:0)
[23:57:39.054] Timer tick, asking Buildbucket for the build status
[23:57:39.119] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:39.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:32:0) after 1m0s
[23:58:39.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:32:0)
[23:58:39.123] Timer tick, asking Buildbucket for the build status
[23:58:39.271] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:39.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:33:0) after 1m0s
[23:59:39.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:33:0)
[23:59:39.305] Timer tick, asking Buildbucket for the build status
[23:59:39.369] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:39.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:34:0) after 1m0s
[00:00:39.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:34:0)
[00:00:39.391] Timer tick, asking Buildbucket for the build status
[00:00:39.483] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:39.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:35:0) after 1m0s
[00:01:39.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:35:0)
[00:01:39.493] Timer tick, asking Buildbucket for the build status
[00:01:39.572] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:39.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:36:0) after 1m0s
[00:02:39.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:36:0)
[00:02:39.819] Timer tick, asking Buildbucket for the build status
[00:02:39.936] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:39.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:37:0) after 1m0s
[00:03:40.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:37:0)
[00:03:40.016] Timer tick, asking Buildbucket for the build status
[00:03:40.128] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:40.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:38:0) after 1m0s
[00:04:40.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:38:0)
[00:04:40.218] Timer tick, asking Buildbucket for the build status
[00:04:40.302] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:39:0) after 1m0s
[00:05:40.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:39:0)
[00:05:40.343] Timer tick, asking Buildbucket for the build status
[00:05:40.432] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:40.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:40:0) after 1m0s
[00:06:40.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:40:0)
[00:06:40.642] Timer tick, asking Buildbucket for the build status
[00:06:40.717] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:40.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:41:0) after 1m0s
[00:07:41.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:41:0)
[00:07:41.901] Timer tick, asking Buildbucket for the build status
[00:07:41.995] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:41.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:42:0) after 1m0s
[00:08:42.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:42:0)
[00:08:42.396] Timer tick, asking Buildbucket for the build status
[00:08:42.486] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:42.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:43:0) after 1m0s
[00:09:42.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:43:0)
[00:09:42.704] Timer tick, asking Buildbucket for the build status
[00:09:43.030] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:43.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:44:0) after 1m0s
[00:10:43.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:44:0)
[00:10:43.193] Timer tick, asking Buildbucket for the build status
[00:10:43.435] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:43.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:45:0) after 1m0s
[00:11:43.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:45:0)
[00:11:43.613] Timer tick, asking Buildbucket for the build status
[00:11:43.744] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:46:0) after 1m0s
[00:12:43.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:46:0)
[00:12:43.903] Timer tick, asking Buildbucket for the build status
[00:12:43.997] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:43.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:47:0) after 1m0s
[00:13:44.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:47:0)
[00:13:44.006] Timer tick, asking Buildbucket for the build status
[00:13:44.133] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:44.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:48:0) after 1m0s
[00:14:44.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:48:0)
[00:14:44.151] Timer tick, asking Buildbucket for the build status
[00:14:44.268] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:44.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:49:0) after 1m0s
[00:15:44.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:49:0)
[00:15:44.285] Timer tick, asking Buildbucket for the build status
[00:15:44.341] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:44.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:50:0) after 1m0s
[00:16:44.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:50:0)
[00:16:44.398] Timer tick, asking Buildbucket for the build status
[00:16:44.468] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:44.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:51:0) after 1m0s
[00:17:44.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:51:0)
[00:17:44.598] Timer tick, asking Buildbucket for the build status
[00:17:44.670] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:44.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:52:0) after 1m0s
[00:18:44.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:52:0)
[00:18:44.662] Timer tick, asking Buildbucket for the build status
[00:18:44.774] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:44.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:53:0) after 1m0s
[00:19:44.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:53:0)
[00:19:44.829] Timer tick, asking Buildbucket for the build status
[00:19:44.947] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:44.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:54:0) after 1m0s
[00:20:44.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:54:0)
[00:20:44.961] Timer tick, asking Buildbucket for the build status
[00:20:45.164] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:45.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:55:0) after 1m0s
[00:21:45.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:55:0)
[00:21:45.145] Timer tick, asking Buildbucket for the build status
[00:21:45.222] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:45.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:56:0) after 1m0s
[00:22:45.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:56:0)
[00:22:45.532] Timer tick, asking Buildbucket for the build status
[00:22:45.646] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:45.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:57:0) after 1m0s
[00:23:45.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:57:0)
[00:23:45.873] Timer tick, asking Buildbucket for the build status
[00:23:48.452] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:48.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:58:0) after 1m0s
[00:24:48.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:58:0)
[00:24:48.804] Timer tick, asking Buildbucket for the build status
[00:24:48.936] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:59:0) after 1m0s
[00:25:49.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:59:0)
[00:25:49.194] Timer tick, asking Buildbucket for the build status
[00:25:49.356] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:49.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:60:0) after 1m0s
[00:26:49.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:60:0)
[00:26:49.517] Timer tick, asking Buildbucket for the build status
[00:26:50.044] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:50.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:61:0) after 1m0s
[00:27:50.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:61:0)
[00:27:50.024] Timer tick, asking Buildbucket for the build status
[00:27:50.083] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:50.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:62:0) after 1m0s
[00:28:50.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:62:0)
[00:28:50.146] Timer tick, asking Buildbucket for the build status
[00:28:50.250] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:50.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:63:0) after 1m0s
[00:29:50.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:63:0)
[00:29:50.294] Timer tick, asking Buildbucket for the build status
[00:29:50.384] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:50.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:64:0) after 1m0s
[00:30:50.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:64:0)
[00:30:50.545] Timer tick, asking Buildbucket for the build status
[00:30:50.613] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:50.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:65:0) after 1m0s
[00:31:50.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:65:0)
[00:31:50.787] Timer tick, asking Buildbucket for the build status
[00:31:50.875] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:50.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:66:0) after 1m0s
[00:32:51.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:66:0)
[00:32:51.006] Timer tick, asking Buildbucket for the build status
[00:32:52.585] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:52.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:67:0) after 1m0s
[00:33:52.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:67:0)
[00:33:52.691] Timer tick, asking Buildbucket for the build status
[00:33:52.835] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:68:0) after 1m0s
[00:34:52.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:68:0)
[00:34:52.921] Timer tick, asking Buildbucket for the build status
[00:34:53.029] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:53.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:69:0) after 1m0s
[00:35:53.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:69:0)
[00:35:53.090] Timer tick, asking Buildbucket for the build status
[00:35:53.456] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:53.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:70:0) after 1m0s
[00:36:53.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:70:0)
[00:36:53.568] Timer tick, asking Buildbucket for the build status
[00:36:53.684] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:53.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:71:0) after 1m0s
[00:37:53.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:71:0)
[00:37:53.715] Timer tick, asking Buildbucket for the build status
[00:37:53.828] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:53.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:72:0) after 1m0s
[00:38:53.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:72:0)
[00:38:53.903] Timer tick, asking Buildbucket for the build status
[00:38:53.992] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:53.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:73:0) after 1m0s
[00:39:53.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:73:0)
[00:39:53.990] Timer tick, asking Buildbucket for the build status
[00:39:54.091] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:54.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:74:0) after 1m0s
[00:40:54.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:74:0)
[00:40:54.161] Timer tick, asking Buildbucket for the build status
[00:40:54.242] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:54.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:75:0) after 1m0s
[00:41:54.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:75:0)
[00:41:54.262] Timer tick, asking Buildbucket for the build status
[00:41:54.363] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:76:0) after 1m0s
[00:42:55.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:76:0)
[00:42:55.004] Timer tick, asking Buildbucket for the build status
[00:42:55.081] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:55.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:77:0) after 1m0s
[00:43:55.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:77:0)
[00:43:55.305] Timer tick, asking Buildbucket for the build status
[00:43:55.418] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:55.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:78:0) after 1m0s
[00:44:55.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:78:0)
[00:44:55.474] Timer tick, asking Buildbucket for the build status
[00:44:55.707] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:55.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:79:0) after 1m0s
[00:45:55.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:79:0)
[00:45:55.798] Timer tick, asking Buildbucket for the build status
[00:45:56.035] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:80:0) after 1m0s
[00:46:56.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:80:0)
[00:46:56.181] Timer tick, asking Buildbucket for the build status
[00:46:56.274] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:56.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:81:0) after 1m0s
[00:47:56.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:81:0)
[00:47:56.378] Timer tick, asking Buildbucket for the build status
[00:47:56.459] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:56.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:82:0) after 1m0s
[00:48:56.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:82:0)
[00:48:56.516] Timer tick, asking Buildbucket for the build status
[00:48:56.637] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:56.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:83:0) after 1m0s
[00:49:56.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:83:0)
[00:49:56.676] Timer tick, asking Buildbucket for the build status
[00:49:56.752] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:56.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:84:0) after 1m0s
[00:50:56.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:84:0)
[00:50:56.772] Timer tick, asking Buildbucket for the build status
[00:50:56.955] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:56.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:85:0) after 1m0s
[00:51:56.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:85:0)
[00:51:56.992] Timer tick, asking Buildbucket for the build status
[00:51:57.336] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:57.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:86:0) after 1m0s
[00:52:57.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:86:0)
[00:52:57.363] Timer tick, asking Buildbucket for the build status
[00:52:57.467] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:57.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:87:0) after 1m0s
[00:53:57.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:87:0)
[00:53:57.508] Timer tick, asking Buildbucket for the build status
[00:53:57.591] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:57.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:88:0) after 1m0s
[00:54:57.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:88:0)
[00:54:57.611] Timer tick, asking Buildbucket for the build status
[00:54:58.100] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:58.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:89:0) after 1m0s
[00:55:58.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:89:0)
[00:55:58.258] Timer tick, asking Buildbucket for the build status
[00:55:59.610] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:59.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:90:0) after 1m0s
[00:56:59.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:90:0)
[00:56:59.639] Timer tick, asking Buildbucket for the build status
[00:56:59.717] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:59.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:91:0) after 1m0s
[00:57:59.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:91:0)
[00:57:59.760] Timer tick, asking Buildbucket for the build status
[00:57:59.831] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:59.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:92:0) after 1m0s
[00:58:59.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:92:0)
[00:58:59.853] Timer tick, asking Buildbucket for the build status
[00:59:00.210] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:00.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:93:0) after 1m0s
[01:00:00.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:93:0)
[01:00:00.253] Timer tick, asking Buildbucket for the build status
[01:00:00.327] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:00.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:94:0) after 1m0s
[01:01:00.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:94:0)
[01:01:00.587] Timer tick, asking Buildbucket for the build status
[01:01:00.748] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:00.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:95:0) after 1m0s
[01:02:00.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:95:0)
[01:02:00.923] Timer tick, asking Buildbucket for the build status
[01:02:01.019] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:01.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:96:0) after 1m0s
[01:03:01.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:96:0)
[01:03:01.518] Timer tick, asking Buildbucket for the build status
[01:03:01.882] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:01.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:97:0) after 1m0s
[01:04:01.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:97:0)
[01:04:01.997] Timer tick, asking Buildbucket for the build status
[01:04:02.102] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:02.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:98:0) after 1m0s
[01:05:02.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:98:0)
[01:05:02.421] Timer tick, asking Buildbucket for the build status
[01:05:03.300] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:03.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:99:0) after 1m0s
[01:06:03.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:99:0)
[01:06:03.414] Timer tick, asking Buildbucket for the build status
[01:06:03.515] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:03.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:100:0) after 1m0s
[01:07:03.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:100:0)
[01:07:03.624] Timer tick, asking Buildbucket for the build status
[01:07:03.925] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:03.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:101:0) after 1m0s
[01:08:03.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:101:0)
[01:08:03.931] Timer tick, asking Buildbucket for the build status
[01:08:04.021] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:102:0) after 1m0s
[01:09:04.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:102:0)
[01:09:04.132] Timer tick, asking Buildbucket for the build status
[01:09:04.256] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:04.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:103:0) after 1m0s
[01:10:04.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:103:0)
[01:10:04.260] Timer tick, asking Buildbucket for the build status
[01:10:05.311] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:104:0) after 1m0s
[01:11:05.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:104:0)
[01:11:05.474] Timer tick, asking Buildbucket for the build status
[01:11:05.552] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:105:0) after 1m0s
[01:12:05.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:105:0)
[01:12:05.601] Timer tick, asking Buildbucket for the build status
[01:12:05.805] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:106:0) after 1m0s
[01:13:05.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:106:0)
[01:13:05.798] Timer tick, asking Buildbucket for the build status
[01:13:05.918] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:05.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:107:0) after 1m0s
[01:14:06.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:107:0)
[01:14:06.031] Timer tick, asking Buildbucket for the build status
[01:14:06.118] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:108:0) after 1m0s
[01:15:06.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:108:0)
[01:15:06.136] Timer tick, asking Buildbucket for the build status
[01:15:06.236] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:109:0) after 1m0s
[01:16:06.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:109:0)
[01:16:06.283] Timer tick, asking Buildbucket for the build status
[01:16:06.621] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:110:0) after 1m0s
[01:17:06.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:110:0)
[01:17:06.824] Timer tick, asking Buildbucket for the build status
[01:17:07.357] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:07.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:111:0) after 1m0s
[01:18:07.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:111:0)
[01:18:07.659] Timer tick, asking Buildbucket for the build status
[01:18:07.783] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:112:0) after 1m0s
[01:19:07.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:112:0)
[01:19:07.879] Timer tick, asking Buildbucket for the build status
[01:19:07.986] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:113:0) after 1m0s
[01:20:08.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:113:0)
[01:20:08.049] Timer tick, asking Buildbucket for the build status
[01:20:08.428] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:08.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:114:0) after 1m0s
[01:21:08.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:114:0)
[01:21:08.443] Timer tick, asking Buildbucket for the build status
[01:21:08.537] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:115:0) after 1m0s
[01:22:08.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:115:0)
[01:22:08.816] Timer tick, asking Buildbucket for the build status
[01:22:08.965] Build 8853738396023450848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019168457967318464:116:0) after 1m0s
[01:22:16.950] Received PubSub notification, asking Buildbucket for the build status
[01:22:17.057] Build 8853738396023450848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:22:17.057] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614820934759177",
"created_by": "project:chromium",
"created_ts": "1614814109740395",
"id": "8853738396023450848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bba3e95fb194671dda3a74353b20510fcbc85610\"}}",
"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\": \"bba3e95fb194671dda3a74353b20510fcbc85610\", \"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-203-yawm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45890, \"got_angle_revision\": \"9946051ae3d5eded5851c8a9f1709676076c38bc\", \"got_dawn_revision\": \"c36a9e8579a17d1afb730a3de6af12fb0a3c210d\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"bba3e95fb194671dda3a74353b20510fcbc85610\", \"got_revision_cp\": \"refs/heads/master@{#859573}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"1bf9a25b8165c205ba4ed305e8e84bc4a8e54fbc\", \"got_v8_revision_cp\": \"refs/heads/9.1.31@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bba3e95fb194671dda3a74353b20510fcbc85610\", \"swarm_hashes_refs/heads/master(at){#859573}_without_patch\": {\"absl_hardening_tests\": \"74156c66f8c757fb089d38c358d40430370b6813\", \"accessibility_unittests\": \"851b03a28625b339f2459a5b3712c06c121338c1\", \"angle_unittests\": \"21da75b80b59348468473578e31a67cc7abd43e7\", \"app_list_unittests\": \"6b29be06d77a2f6b25624fb9cca770ec3cbce3bd\", \"app_shell_unittests\": \"c72f1217b74275a547f137cb40a3a9577c4c35a4\", \"ash_unittests\": \"af907a1d8f14d0ae30f77df7720e4d5cfeed75f5\", \"aura_unittests\": \"37e3cbcbea2d312918df5a7a67b982eccad7feac\", \"base_unittests\": \"2d836f0bc4e82f1871660836db5c87c0288b7042\", \"base_util_unittests\": \"72228ae7e99e7cbdd9b1a156bd6bd2f59343004f\", \"blink_common_unittests\": \"8acbadd42adaff8808e7d91c2f06aebe3daf77fd\", \"blink_fuzzer_unittests\": \"1ea6cfb568b469dc995b8e800265897807c66408\", \"blink_heap_unittests\": \"15f3482e56fdfb27308af25e99848383c83164bc\", \"blink_platform_unittests\": \"d9e91fa76fb5eab3860654af5f24ec20abc7087d\", \"blink_unittests\": \"d1c20c8510a25ec8fd2e088a2defba0b8273941f\", \"boringssl_crypto_tests\": \"ccd71a8b2e0fd434c419aa7a3952433b680d17c0\", \"boringssl_ssl_tests\": \"60099910fde29901b34e0f235bceae1736615b8e\", \"browser_tests\": \"f1aba1cff40eba4ae467e5d935bf0a315e58e3e9\", \"capture_unittests\": \"e78f03f505d26f7031d5eb99d0974dfcd01fc017\", \"cast_unittests\": \"437e7986624f3b2817746a7484c614a63ad8801f\", \"cc_unittests\": \"39cfa1c54658c05cd126e829adf03fe43d3b8a16\", \"chrome_app_unittests\": \"4378d11c09d24cf5cefde196cf71b80054ddbad8\", \"chromedriver_unittests\": \"0c5057b47ead737cf0d2dc427761492ce127f591\", \"chromeos_components_unittests\": \"665474bfbbaa355a07ab76b2dd59588087517fa6\", \"chromeos_unittests\": \"5c9ee5485700facb324cff1ce405012bc89a0382\", \"color_unittests\": \"20963644f07afcac7e9ccd51e477687f9b10c36f\", \"components_browsertests\": \"7031bc6107ed43d5957128be62e7a2863b24338c\", \"components_unittests\": \"b6999519090430a70eb910388f71a8221abc1a50\", \"compositor_unittests\": \"510322445c887816a7393f2fd45f4f9b86ef5260\", \"content_browsertests\": \"4fca53b213874ba0673e43dbb16f2ee37ccca5ae\", \"content_unittests\": \"e1eb952e9df2a3b0d5e7f12c0c93d5decec4be98\", \"crashpad_tests\": \"138d8e483698979282b5c6e6aaa763a8a242a2aa\", \"crypto_unittests\": \"3b906656f8fb75bc71875c21fe56373e2e6aa75b\", \"dbus_unittests\": \"c86cd32044b64610fe9f1a4a975ad0d7aef58423\", \"device_unittests\": \"f1bbbac825a477cacfca4b28758fe062f7ff6a8e\", \"display_unittests\": \"1e47c91473f6fd2dd621fa7b766664713bb94d27\", \"events_unittests\": \"85f871f064b10b78983c184663c078a37bda6724\", \"exo_unittests\": \"488d214b48ca15df85bb1ba6171b07c014b526ac\", \"extensions_browsertests\": \"49ef66e215448b2f57c1b2b24a8c6d487dbce19b\", \"extensions_unittests\": \"ada5bc48bdd47f6e2ff5e15e454b893f1eee809e\", \"filesystem_service_unittests\": \"c8b0f3d327f7bc75a59d00a810d1f66b5dd8a4bf\", \"gcm_unit_tests\": \"03138518c4f83c6065ee32b1f28a27222fc0e00c\", \"gfx_unittests\": \"e1b61a622ea112d0b1b3128d798cb855b32765ad\", \"gin_unittests\": \"0decefb6918fce7aea49bbe8b5433def02daa242\", \"gl_unittests_ozone\": \"9c59b6aea3f08e71c341aef362a519b1afba2a92\", \"google_apis_unittests\": \"a6586a1c3a800c891f938a296f6ac98e924f0f70\", \"gpu_unittests\": \"56e086ff9280f034921b60e0c608271e6d9e1109\", \"gwp_asan_unittests\": \"6f8e5f546adde34e44356948edd046bad584a86e\", \"interactive_ui_tests\": \"6f4993ddf5b79b05da5fafe25e8a46f0b9e1354f\", \"ipc_tests\": \"7ecf3cd0af9a47741529e612be60d9dfabf6b785\", \"jingle_unittests\": \"655347160aa2a1a8dd40b3ab24f9e5d461bae1cc\", \"keyboard_unittests\": \"e766801b1c424e0eec3f670ffd736c690920e0bc\", \"latency_unittests\": \"a8999bac1d7f107db89e1bf21d746242741aeb92\", \"libjingle_xmpp_unittests\": \"e8cf040b8c8342650ac9597e251141fbe889f4a0\", \"liburlpattern_unittests\": \"a83548cd1725a0e111f6ac079a2b45bc1aed8bef\", \"media_blink_unittests\": \"df0f71252b8e66d53268a4d85b9af6418987a0e2\", \"media_unittests\": \"5bcaefa47a87c992a8dbcab366af169cba7f8b97\", \"message_center_unittests\": \"515e4be252fb50fb10fbc7d47ebec73323bb68f3\", \"midi_unittests\": \"2c3f8e2be7a13c0b7646e6d57f8d36523194e4b4\", \"mojo_core_unittests\": \"0cf6addcb006351ea0994dfb7b8caf6874598f66\", \"mojo_unittests\": \"5a6cd55ce62eb0395907b036332454f078daffd5\", \"nacl_helper_nonsfi_unittests\": \"2fa781e0d8e33b3b19a681794590a142f0e78774\", \"nacl_loader_unittests\": \"3007d31090dddb1beefd809a0c5e2bd34a8df9a2\", \"native_theme_unittests\": \"076de4594eb9e3719201fdb01c032020ba15e1e6\", \"net_unittests\": \"2c58c49cc52acfdb79b9b98ad3bbb657652d35bc\", \"ozone_gl_unittests\": \"38b07f5048b09abfa80991dd9ea276f6d289d2e5\", \"ozone_unittests\": \"320d733407d5012696db70508ac94d3e0c764c11\", \"ozone_x11_unittests\": \"7881b423a8f854c1f55614c3512235e819c00a8a\", \"pdf_unittests\": \"ac49029b3bc6fd6f09d7034c90e900b72de78e7a\", \"perfetto_unittests\": \"d5b653e01329b24136b9e0122721ae1388ba9cf5\", \"ppapi_unittests\": \"ccb480654ff9b74d4f4d5e7481d72a297de674a2\", \"printing_unittests\": \"85ed8b87c1cfccdbdd2eab6796388b500ae4d7c5\", \"remoting_unittests\": \"e56aed0f4dc26156d747d8840c6e086923290d35\", \"sandbox_linux_unittests\": \"2d8f8595f77f6f48199567a472fb4e8f4ff26c76\", \"service_manager_unittests\": \"8cdff59b8eb053365e6225febbf04e995be09c8b\", \"services_unittests\": \"ad6b52a976f0c4800259f7847bbfccc99bd4b2d4\", \"shell_dialogs_unittests\": \"becaea6b3504b1a3c5bfcfc6adedebb6f65d1414\", \"shell_encryption_unittests\": \"54a954d04c4093cec8655f1a66308bb34098459d\", \"skia_unittests\": \"dc4301023e4f59e6a503fd0858f871b533a78628\", \"snapshot_unittests\": \"476ebb64081ea3fa35e9068c5271c35c8dfb9e99\", \"sql_unittests\": \"268f7f889e84185a5b4d9e7a7064630bbb59d534\", \"storage_unittests\": \"7c3c59042f5e82568a67ea2deb330fa8946294b1\", \"sync_integration_tests\": \"1f17ebf1107cd5b5dceb81bee6ea656635e5ae9f\", \"traffic_annotation_auditor_unittests\": \"63dc975fd3685d54e84e5388a987ecb7451dcc90\", \"ui_base_unittests\": \"19d79f62f5d5a61c96c7455e0c36472b02976b93\", \"ui_chromeos_unittests\": \"4d57797a4cf28bbda569d6d1e5bbf43c876f83f0\", \"ui_touch_selection_unittests\": \"602222cd782a0e76d87e0ffbac324ba1c0f8d8ef\", \"unit_tests\": \"811b4c3b415b87578c0d07adbd0d7811cc7de078\", \"url_unittests\": \"67c5cfe3e06f9347d774eb05e136fab01f954dc4\", \"usage_time_limit_unittests\": \"552ee4a73ba38f8e9cb8efdbf94c65e26ac309a7\", \"views_unittests\": \"de3d0d1be43574c8856a9cd1be8039d0b78afba1\", \"viz_unittests\": \"b9c4fea214883d539b21c67e649e0010e209655f\", \"wayland_client_perftests\": \"5d67a5d5478aaf8d6195a698351d35da49e1e445\", \"wayland_client_tests\": \"7adc3df032bb1e1b3d73159acce717d3b4a85cf0\", \"wm_unittests\": \"6e1b3fa8f01112a5cfe9c31521395e0d32fb4a25\", \"wtf_unittests\": \"08643a740385f597927db2d469c6669b9348465b\", \"zlib_unittests\": \"44d1e273942a1a1442bd05c826d668f410ce7648\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_4051ab4278f6ca75915d3c38e2bb35c4a0543f27c6cfbc0a6a6d184f05d219d0_v2\", \"builder_4500df524e03abdc7ff29c0f916c0f69df935ae1f41d97a45c59dd04b0afce26_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_9bfd7171a3bbd1a8f2af02f1311f913ecc6693b330c40ec1ccf845ae76a71675_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-203-yawm\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614814666623478",
"status": "COMPLETED",
"status_changed_ts": "1614820935153530",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45890",
"builder:linux-chromeos-rel",
"buildset:commit/git/bba3e95fb194671dda3a74353b20510fcbc85610",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bba3e95fb194671dda3a74353b20510fcbc85610",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019168457967318464",
"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/8853738396023450848/+/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:52133d6d68660e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614820935244843",
"url": "https://ci.chromium.org/b/8853738396023450848",
"utcnow_ts": "1614820937019393"
}
}
[01:22:17.057] Invocation finished in 1h53m48.554785796s with status SUCCEEDED