[13:40:10.638] New invocation is queued and will start shortly
[13:40:11.731] Starting the invocation (attempt 1)
[13:40:11.772] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:40:11.772] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:40:11.772] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030892479144190640",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030892479144190640",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"gitiles_ref:refs/heads/master"
]
}
[13:40:13.183] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603633211864277",
"id": "8865462417195188368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603633212889437",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42243",
"builder:linux-chromeos-rel",
"buildset:commit/git/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030892479144190640",
"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/8865462417195188368/+/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": "1603633212889564",
"url": "https://ci.chromium.org/b/8865462417195188368",
"utcnow_ts": "1603633213174760"
}
}
[13:40:13.183] Task URL: https://ci.chromium.org/b/8865462417195188368
[13:40:13.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:2:0) after 1m0s
[13:41:13.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:2:0)
[13:41:13.207] Timer tick, asking Buildbucket for the build status
[13:41:13.331] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:41:13.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:3:0) after 1m0s
[13:42:13.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:3:0)
[13:42:13.417] Timer tick, asking Buildbucket for the build status
[13:42:13.486] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:13.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:4:0) after 1m0s
[13:43:13.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:4:0)
[13:43:13.499] Timer tick, asking Buildbucket for the build status
[13:43:13.598] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:13.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:5:0) after 1m0s
[13:44:13.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:5:0)
[13:44:13.637] Timer tick, asking Buildbucket for the build status
[13:44:13.701] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:6:0) after 1m0s
[13:45:13.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:6:0)
[13:45:13.687] Timer tick, asking Buildbucket for the build status
[13:45:13.783] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:7:0) after 1m0s
[13:46:13.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:7:0)
[13:46:13.882] Timer tick, asking Buildbucket for the build status
[13:46:14.035] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:14.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:8:0) after 1m0s
[13:47:14.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:8:0)
[13:47:14.225] Timer tick, asking Buildbucket for the build status
[13:47:14.328] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:14.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:9:0) after 1m0s
[13:48:14.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:9:0)
[13:48:14.305] Timer tick, asking Buildbucket for the build status
[13:48:14.388] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:14.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:10:0) after 1m0s
[13:49:14.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:10:0)
[13:49:14.495] Timer tick, asking Buildbucket for the build status
[13:49:14.566] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:11:0) after 1m0s
[13:50:14.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:11:0)
[13:50:14.673] Timer tick, asking Buildbucket for the build status
[13:50:15.018] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:12:0) after 1m0s
[13:51:15.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:12:0)
[13:51:15.074] Timer tick, asking Buildbucket for the build status
[13:51:15.285] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:15.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:13:0) after 1m0s
[13:52:15.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:13:0)
[13:52:15.412] Timer tick, asking Buildbucket for the build status
[13:52:15.480] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:15.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:14:0) after 1m0s
[13:53:15.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:14:0)
[13:53:15.495] Timer tick, asking Buildbucket for the build status
[13:53:15.563] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:15.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:15:0) after 1m0s
[13:54:15.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:15:0)
[13:54:15.575] Timer tick, asking Buildbucket for the build status
[13:54:15.674] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:15.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:16:0) after 1m0s
[13:55:15.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:16:0)
[13:55:15.699] Timer tick, asking Buildbucket for the build status
[13:55:15.844] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:15.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:17:0) after 1m0s
[13:56:15.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:17:0)
[13:56:15.890] Timer tick, asking Buildbucket for the build status
[13:56:15.965] Build 8865462417195188368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:15.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:18:0) after 1m0s
[13:56:21.438] Received PubSub notification, asking Buildbucket for the build status
[13:56:21.503] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:16.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:18:0)
[13:57:16.005] Timer tick, asking Buildbucket for the build status
[13:57:16.088] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:16.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:20:0) after 1m0s
[13:58:16.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:20:0)
[13:58:16.142] Timer tick, asking Buildbucket for the build status
[13:58:16.261] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:16.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:21:0) after 1m0s
[13:59:16.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:21:0)
[13:59:16.290] Timer tick, asking Buildbucket for the build status
[13:59:16.522] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:16.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:22:0) after 1m0s
[14:00:16.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:22:0)
[14:00:16.557] Timer tick, asking Buildbucket for the build status
[14:00:17.098] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:17.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:23:0) after 1m0s
[14:01:17.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:23:0)
[14:01:17.246] Timer tick, asking Buildbucket for the build status
[14:01:17.394] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:17.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:24:0) after 1m0s
[14:02:17.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:24:0)
[14:02:17.435] Timer tick, asking Buildbucket for the build status
[14:02:17.504] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:17.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:25:0) after 1m0s
[14:03:17.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:25:0)
[14:03:17.515] Timer tick, asking Buildbucket for the build status
[14:03:17.613] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:26:0) after 1m0s
[14:04:18.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:26:0)
[14:04:18.052] Timer tick, asking Buildbucket for the build status
[14:04:18.192] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:18.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:27:0) after 1m0s
[14:05:18.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:27:0)
[14:05:18.792] Timer tick, asking Buildbucket for the build status
[14:05:18.882] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:28:0) after 1m0s
[14:06:19.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:28:0)
[14:06:19.279] Timer tick, asking Buildbucket for the build status
[14:06:19.347] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:19.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:29:0) after 1m0s
[14:07:19.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:29:0)
[14:07:19.696] Timer tick, asking Buildbucket for the build status
[14:07:19.758] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:19.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:30:0) after 1m0s
[14:08:19.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:30:0)
[14:08:19.993] Timer tick, asking Buildbucket for the build status
[14:08:20.059] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:20.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:31:0) after 1m0s
[14:09:20.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:31:0)
[14:09:20.206] Timer tick, asking Buildbucket for the build status
[14:09:20.261] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:20.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:32:0) after 1m0s
[14:10:20.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:32:0)
[14:10:20.590] Timer tick, asking Buildbucket for the build status
[14:10:20.681] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:20.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:33:0) after 1m0s
[14:11:20.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:33:0)
[14:11:20.826] Timer tick, asking Buildbucket for the build status
[14:11:20.939] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:20.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:34:0) after 1m0s
[14:12:20.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:34:0)
[14:12:20.988] Timer tick, asking Buildbucket for the build status
[14:12:21.112] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:21.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:35:0) after 1m0s
[14:13:21.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:35:0)
[14:13:21.218] Timer tick, asking Buildbucket for the build status
[14:13:21.379] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:21.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:36:0) after 1m0s
[14:14:21.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:36:0)
[14:14:21.546] Timer tick, asking Buildbucket for the build status
[14:14:21.609] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:21.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:37:0) after 1m0s
[14:15:21.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:37:0)
[14:15:21.678] Timer tick, asking Buildbucket for the build status
[14:15:21.940] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:21.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:38:0) after 1m0s
[14:16:22.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:38:0)
[14:16:22.154] Timer tick, asking Buildbucket for the build status
[14:16:22.220] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:22.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:39:0) after 1m0s
[14:17:22.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:39:0)
[14:17:22.398] Timer tick, asking Buildbucket for the build status
[14:17:22.472] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:22.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:40:0) after 1m0s
[14:18:22.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:40:0)
[14:18:22.612] Timer tick, asking Buildbucket for the build status
[14:18:22.678] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:22.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:41:0) after 1m0s
[14:19:22.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:41:0)
[14:19:22.738] Timer tick, asking Buildbucket for the build status
[14:19:22.790] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:22.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:42:0) after 1m0s
[14:20:22.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:42:0)
[14:20:22.819] Timer tick, asking Buildbucket for the build status
[14:20:22.928] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:22.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:43:0) after 1m0s
[14:21:22.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:43:0)
[14:21:22.953] Timer tick, asking Buildbucket for the build status
[14:21:23.019] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:23.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:44:0) after 1m0s
[14:22:23.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:44:0)
[14:22:23.077] Timer tick, asking Buildbucket for the build status
[14:22:23.157] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:23.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:45:0) after 1m0s
[14:23:23.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:45:0)
[14:23:23.202] Timer tick, asking Buildbucket for the build status
[14:23:23.268] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:23.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:46:0) after 1m0s
[14:24:23.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:46:0)
[14:24:23.373] Timer tick, asking Buildbucket for the build status
[14:24:23.803] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:23.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:47:0) after 1m0s
[14:25:23.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:47:0)
[14:25:23.846] Timer tick, asking Buildbucket for the build status
[14:25:23.954] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:23.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:48:0) after 1m0s
[14:26:23.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:48:0)
[14:26:23.980] Timer tick, asking Buildbucket for the build status
[14:26:24.044] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:24.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:49:0) after 1m0s
[14:27:24.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:49:0)
[14:27:24.071] Timer tick, asking Buildbucket for the build status
[14:27:24.141] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:24.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:50:0) after 1m0s
[14:28:24.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:50:0)
[14:28:24.173] Timer tick, asking Buildbucket for the build status
[14:28:24.232] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:24.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:51:0) after 1m0s
[14:29:24.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:51:0)
[14:29:24.260] Timer tick, asking Buildbucket for the build status
[14:29:24.335] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:24.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:52:0) after 1m0s
[14:30:24.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:52:0)
[14:30:24.487] Timer tick, asking Buildbucket for the build status
[14:30:24.618] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:24.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:53:0) after 1m0s
[14:31:24.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:53:0)
[14:31:24.695] Timer tick, asking Buildbucket for the build status
[14:31:24.932] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:24.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:54:0) after 1m0s
[14:32:24.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:54:0)
[14:32:24.914] Timer tick, asking Buildbucket for the build status
[14:32:25.163] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:25.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:55:0) after 1m0s
[14:33:25.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:55:0)
[14:33:25.294] Timer tick, asking Buildbucket for the build status
[14:33:25.506] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:25.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:56:0) after 1m0s
[14:34:25.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:56:0)
[14:34:25.538] Timer tick, asking Buildbucket for the build status
[14:34:25.630] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:25.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:57:0) after 1m0s
[14:35:25.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:57:0)
[14:35:25.727] Timer tick, asking Buildbucket for the build status
[14:35:25.833] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:58:0) after 1m0s
[14:36:26.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:58:0)
[14:36:26.024] Timer tick, asking Buildbucket for the build status
[14:36:26.116] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:26.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:59:0) after 1m0s
[14:37:26.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:59:0)
[14:37:26.152] Timer tick, asking Buildbucket for the build status
[14:37:26.233] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:26.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:60:0) after 1m0s
[14:38:26.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:60:0)
[14:38:26.256] Timer tick, asking Buildbucket for the build status
[14:38:26.364] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:26.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:61:0) after 1m0s
[14:39:26.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:61:0)
[14:39:26.478] Timer tick, asking Buildbucket for the build status
[14:39:26.619] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:26.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:62:0) after 1m0s
[14:40:26.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:62:0)
[14:40:26.764] Timer tick, asking Buildbucket for the build status
[14:40:26.862] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:26.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:63:0) after 1m0s
[14:41:26.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:63:0)
[14:41:26.986] Timer tick, asking Buildbucket for the build status
[14:41:27.069] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:27.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:64:0) after 1m0s
[14:42:27.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:64:0)
[14:42:27.167] Timer tick, asking Buildbucket for the build status
[14:42:27.306] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:65:0) after 1m0s
[14:43:27.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:65:0)
[14:43:27.437] Timer tick, asking Buildbucket for the build status
[14:43:27.618] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:27.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:66:0) after 1m0s
[14:44:27.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:66:0)
[14:44:27.689] Timer tick, asking Buildbucket for the build status
[14:44:27.751] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:27.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:67:0) after 1m0s
[14:45:27.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:67:0)
[14:45:27.810] Timer tick, asking Buildbucket for the build status
[14:45:27.919] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:27.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:68:0) after 1m0s
[14:46:28.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:68:0)
[14:46:28.203] Timer tick, asking Buildbucket for the build status
[14:46:28.260] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:28.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:69:0) after 1m0s
[14:47:28.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:69:0)
[14:47:28.285] Timer tick, asking Buildbucket for the build status
[14:47:28.361] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:28.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:70:0) after 1m0s
[14:48:28.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:70:0)
[14:48:28.440] Timer tick, asking Buildbucket for the build status
[14:48:28.512] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:28.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:71:0) after 1m0s
[14:49:28.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:71:0)
[14:49:28.524] Timer tick, asking Buildbucket for the build status
[14:49:28.580] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:28.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:72:0) after 1m0s
[14:50:28.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:72:0)
[14:50:28.597] Timer tick, asking Buildbucket for the build status
[14:50:28.688] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:28.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:73:0) after 1m0s
[14:51:28.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:73:0)
[14:51:28.675] Timer tick, asking Buildbucket for the build status
[14:51:28.735] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:28.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:74:0) after 1m0s
[14:52:28.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:74:0)
[14:52:28.788] Timer tick, asking Buildbucket for the build status
[14:52:30.119] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:30.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:75:0) after 1m0s
[14:53:30.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:75:0)
[14:53:30.144] Timer tick, asking Buildbucket for the build status
[14:53:30.217] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:30.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:76:0) after 1m0s
[14:54:30.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:76:0)
[14:54:30.239] Timer tick, asking Buildbucket for the build status
[14:54:30.288] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:30.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:77:0) after 1m0s
[14:55:30.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:77:0)
[14:55:30.311] Timer tick, asking Buildbucket for the build status
[14:55:30.407] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:30.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:78:0) after 1m0s
[14:56:30.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:78:0)
[14:56:30.438] Timer tick, asking Buildbucket for the build status
[14:56:30.495] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:30.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:79:0) after 1m0s
[14:57:30.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:79:0)
[14:57:30.571] Timer tick, asking Buildbucket for the build status
[14:57:30.647] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:30.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:80:0) after 1m0s
[14:58:30.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:80:0)
[14:58:30.691] Timer tick, asking Buildbucket for the build status
[14:58:30.752] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:30.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:81:0) after 1m0s
[14:59:30.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:81:0)
[14:59:30.870] Timer tick, asking Buildbucket for the build status
[14:59:30.947] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:30.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:82:0) after 1m0s
[15:00:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:82:0)
[15:00:30.968] Timer tick, asking Buildbucket for the build status
[15:00:31.327] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:31.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:83:0) after 1m0s
[15:01:31.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:83:0)
[15:01:31.401] Timer tick, asking Buildbucket for the build status
[15:01:31.482] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:31.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:84:0) after 1m0s
[15:02:33.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:84:0)
[15:02:33.474] Timer tick, asking Buildbucket for the build status
[15:02:33.572] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:33.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:85:0) after 1m0s
[15:03:33.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:85:0)
[15:03:33.907] Timer tick, asking Buildbucket for the build status
[15:03:34.215] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:34.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:86:0) after 1m0s
[15:04:34.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:86:0)
[15:04:34.277] Timer tick, asking Buildbucket for the build status
[15:04:34.419] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:34.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:87:0) after 1m0s
[15:05:34.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:87:0)
[15:05:34.469] Timer tick, asking Buildbucket for the build status
[15:05:34.631] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:34.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:88:0) after 1m0s
[15:06:34.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:88:0)
[15:06:34.666] Timer tick, asking Buildbucket for the build status
[15:06:34.719] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:34.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:89:0) after 1m0s
[15:07:34.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:89:0)
[15:07:34.759] Timer tick, asking Buildbucket for the build status
[15:07:34.984] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:34.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:90:0) after 1m0s
[15:08:35.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:90:0)
[15:08:35.352] Timer tick, asking Buildbucket for the build status
[15:08:35.461] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:35.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:91:0) after 1m0s
[15:09:35.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:91:0)
[15:09:35.542] Timer tick, asking Buildbucket for the build status
[15:09:35.647] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:35.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:92:0) after 1m0s
[15:10:35.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:92:0)
[15:10:35.754] Timer tick, asking Buildbucket for the build status
[15:10:35.848] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:35.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:93:0) after 1m0s
[15:11:35.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:93:0)
[15:11:35.992] Timer tick, asking Buildbucket for the build status
[15:11:36.139] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:36.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:94:0) after 1m0s
[15:12:36.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:94:0)
[15:12:36.246] Timer tick, asking Buildbucket for the build status
[15:12:36.370] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:36.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:95:0) after 1m0s
[15:13:36.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:95:0)
[15:13:36.626] Timer tick, asking Buildbucket for the build status
[15:13:37.134] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:37.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:96:0) after 1m0s
[15:14:37.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:96:0)
[15:14:37.522] Timer tick, asking Buildbucket for the build status
[15:14:37.630] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:37.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:97:0) after 1m0s
[15:15:37.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:97:0)
[15:15:37.715] Timer tick, asking Buildbucket for the build status
[15:15:38.124] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:38.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:98:0) after 1m0s
[15:16:38.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:98:0)
[15:16:38.187] Timer tick, asking Buildbucket for the build status
[15:16:38.302] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:99:0) after 1m0s
[15:17:38.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:99:0)
[15:17:38.334] Timer tick, asking Buildbucket for the build status
[15:17:38.503] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:38.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:100:0) after 1m0s
[15:18:38.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:100:0)
[15:18:38.590] Timer tick, asking Buildbucket for the build status
[15:18:38.701] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:38.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:101:0) after 1m0s
[15:19:38.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:101:0)
[15:19:38.841] Timer tick, asking Buildbucket for the build status
[15:19:39.494] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:39.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:102:0) after 1m0s
[15:20:39.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:102:0)
[15:20:39.522] Timer tick, asking Buildbucket for the build status
[15:20:39.637] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:39.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:103:0) after 1m0s
[15:21:39.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:103:0)
[15:21:39.662] Timer tick, asking Buildbucket for the build status
[15:21:39.773] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:39.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:104:0) after 1m0s
[15:22:39.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:104:0)
[15:22:39.799] Timer tick, asking Buildbucket for the build status
[15:22:39.979] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:105:0) after 1m0s
[15:23:40.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:105:0)
[15:23:40.187] Timer tick, asking Buildbucket for the build status
[15:23:41.092] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:41.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:106:0) after 1m0s
[15:24:43.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:106:0)
[15:24:43.087] Timer tick, asking Buildbucket for the build status
[15:24:43.161] Build 8865462417195188368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030892479144190640:107:0) after 1m0s
[15:25:06.499] Received PubSub notification, asking Buildbucket for the build status
[15:25:06.568] Build 8865462417195188368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:25:06.568] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603639504135221",
"created_by": "project:chromium",
"created_ts": "1603633211864277",
"id": "8865462417195188368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\"}}",
"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\": \"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\", \"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-east1-d-8-3-8rzz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42243, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\", \"got_revision_cp\": \"refs/heads/master@{#820614}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f\", \"swarm_hashes_refs/heads/master(at){#820614}_without_patch\": {\"absl_hardening_tests\": \"688545d994f6532d7f0b85189d8f075c04666cf9\", \"accessibility_unittests\": \"3fd668c03d0b326bcee7017f62235b26b345e964\", \"angle_unittests\": \"edf535c474337c6c4dfe3adea646df621b9c5ee1\", \"app_list_unittests\": \"3ed70e3f5913cd404a0071c60327422e42059dee\", \"app_shell_unittests\": \"4a3641bbfd95457992a592777b99508b79d24d4f\", \"ash_unittests\": \"0caef93becb207a7a760dc82da142cca4016afc8\", \"aura_unittests\": \"aac96678a7aae39b10573296c1a0f41c4b9b3d11\", \"base_unittests\": \"b09c045939ac0f926d03a4cd13aea2a3e9399128\", \"base_util_unittests\": \"663d99147321ca41b0dc4bdd5e9016d09cd69722\", \"blink_common_unittests\": \"94dc8bc5e884f651a97c174a31855aebf2ca5456\", \"blink_fuzzer_unittests\": \"960cb38bcc71891a97ff551a1fa6d92ce38fc390\", \"blink_heap_unittests\": \"53d6ad7e3d5f4583845ff32fb1c34b46254edc3c\", \"blink_platform_unittests\": \"3a24630f51bb46d09093b1a34a83db5871bd43f9\", \"blink_unittests\": \"5e14d0077d2d7066471b82058e13fddd1be4e59a\", \"boringssl_crypto_tests\": \"5623290ab35bb3a9e56d9c02ef041d8399cb2408\", \"boringssl_ssl_tests\": \"890ac51bfa579d02ed27dbcd8425714c0af2ed42\", \"browser_tests\": \"bbe8fd6cb341a48e951390715b221163353f990e\", \"capture_unittests\": \"04bfe3c05f1a1d4cd2d11264f8c10ebcba1b543b\", \"cast_unittests\": \"4d5478da926fcfe829ba9aea65666298d03b1ed4\", \"cc_unittests\": \"e0807593ed743baf2fd49b6cbb78cae6d566e57c\", \"chrome_app_unittests\": \"8d6536664fefc90c7a6b37fb4bd3b3c29ae20790\", \"chromedriver_unittests\": \"f2bd3a147f7734bcc65969fc5df49d8341b0d28f\", \"chromeos_components_unittests\": \"58a5c83ce32f31cdc95b77b0a81ed57e5c4aa159\", \"chromeos_unittests\": \"ed5f687cabebd8b07eccd8cd3b936619809b033d\", \"components_browsertests\": \"60a5d096c3ede8d1bc906d3e4ae8fde3fce5684e\", \"components_unittests\": \"2ac06e7119e6ad4ba662d5cf93e367c8bd2583cb\", \"compositor_unittests\": \"4b0df5a5e60318ab6a184c758b461dbf7587f218\", \"content_browsertests\": \"ef67d0578b3fbe2c50d013a9c9080a7dc52af720\", \"content_unittests\": \"a3d96a10f7be57cb8357bf1fc2cbc3e0eb6bf8cb\", \"crypto_unittests\": \"1b5dd23cfac7a6653dad131544295ff13eba92c5\", \"dbus_unittests\": \"8eb7d227c09c9fa029fee5cb948fe3cca71708d8\", \"device_unittests\": \"1107ce1319a4e4a0345f91ab7eb492767193ca04\", \"display_unittests\": \"ca5bc9425fb7bc3959ba38e0ec687444c29d55db\", \"events_unittests\": \"b388d6e04ad5c8c35c709e2ea61e48dad37d32c6\", \"exo_unittests\": \"5077f4a041c20947cc307b70da57559997d5d8a3\", \"extensions_browsertests\": \"2d6dd898624cb6e62193066536fdd34a09072fdb\", \"extensions_unittests\": \"cf7519b0db8074bb442600b72e6daee6d7dfd377\", \"filesystem_service_unittests\": \"110cea0c2c474c12e8804765745c3297684ec362\", \"gcm_unit_tests\": \"e3fdee2867e650f1329e2f610ecaee59e2a4b75f\", \"gfx_unittests\": \"59752702bcb0e34b00d2c58bfa8f184402eb9ae9\", \"gin_unittests\": \"6b5f99ec5703e0e7e7dd1e745326042351302b7b\", \"gl_unittests_ozone\": \"a69d12785d5ce2acfe0f71bfa39a5f35a4d656b1\", \"google_apis_unittests\": \"3755fdba12a83b5e35a50ea12362ab3b38dc9498\", \"gpu_unittests\": \"219aed20a360d09b57fe4529123c0361ef5e2b75\", \"gwp_asan_unittests\": \"48e4085ea948aef88fec7f62fb96e8d5e9420e29\", \"interactive_ui_tests\": \"1dab2159a41207979157d0a8a5188147c81aed70\", \"ipc_tests\": \"3d79c078491eee4c48ed631d4fd4154808480700\", \"jingle_unittests\": \"450528fc7493d85aa692e4cd7cadcdc3bff3dcff\", \"keyboard_unittests\": \"98b9eeda4dda7b70e3937098d9b4298bbe0e609c\", \"latency_unittests\": \"13b1e20efd05c0c57537ddf5f28fb4d58acbf6ac\", \"libjingle_xmpp_unittests\": \"1266a0eede82b2671dd66a5417c7e1c8653b8c09\", \"media_blink_unittests\": \"458276a395183c8ad1be05e0c8fa93f9b14394ff\", \"media_unittests\": \"f05e2765b33dbe193c4e55efb5391d62f49fb604\", \"message_center_unittests\": \"d7ad8da7b96e9b8938cefa713a3c6d045e7ed0c1\", \"midi_unittests\": \"dab0b1ccfe5b85065c27d38555fb7e75352acd3d\", \"mojo_core_unittests\": \"3406d38dc4e359a1f573dd8b13b684c659cf2348\", \"mojo_unittests\": \"e6feed74142c41fbea99589845ab175452e34a5a\", \"nacl_helper_nonsfi_unittests\": \"66cb5a98a4c30875ec3e22118c472788989ba1c0\", \"nacl_loader_unittests\": \"8848eec90c71a9c70f62996a64a8955a13c2c889\", \"native_theme_unittests\": \"ef47cddf9401de3326f3af11516fb231a446a3f4\", \"net_unittests\": \"47f716b67dbb48bf6ddd412178b61a8359e7f5dc\", \"ozone_gl_unittests\": \"0bb0092976a43267aa82374bc7c4d1d4e81324fc\", \"ozone_unittests\": \"d7a43f8e83f4447e11070020a2ff7cc8916b1aa6\", \"ozone_x11_unittests\": \"f9863df7d6ccae17fef955b99895de3db278c429\", \"pdf_unittests\": \"148a0af0515180ce1d21ac25bf5b6a587ae592cf\", \"perfetto_unittests\": \"650ae8effb6795b98a4f3d8b73dc4e60efa21f83\", \"ppapi_unittests\": \"b64eb2b554a3209c8b4a21e2feabc40ba15afec4\", \"printing_unittests\": \"6b0ebc7b68847665c2911e0ee5a4ea858ab7e7fd\", \"remoting_unittests\": \"19e9b9a813cff51c4f23a4b2b4171278e2cb24a9\", \"sandbox_linux_unittests\": \"fea96530565e0495689ed51085234f0f4494f882\", \"service_manager_unittests\": \"f8b680c9320976df811c4bc44626524b93154985\", \"services_unittests\": \"315ff16f8ea9dfb261dc513521e4dfae932e2566\", \"shell_dialogs_unittests\": \"a8b70d8a6548f3836fd1761c7b840c281733f712\", \"skia_unittests\": \"c2ec6a33a7f7c4cad390c2583f32202342cdfba8\", \"snapshot_unittests\": \"869ae5a5128d8171fd6f691aa7ad7c6e2fa346d7\", \"sql_unittests\": \"7ff19f23e7da379c1e49c06030f603fe8169a7d3\", \"storage_unittests\": \"6869f87d0af2605ddab5e53e5ec70f65c0ec3f8b\", \"sync_integration_tests\": \"464883433a71b84f6f1ac9e20136f065112a45b2\", \"traffic_annotation_auditor_unittests\": \"cf2898cbd3f186471bc7ae6d318847db1881bdea\", \"ui_base_unittests\": \"6321f5d9586c5e05bca9bb25aca2384c0b9ad5b4\", \"ui_chromeos_unittests\": \"abb9252c0abd1b68a01cc3d6d6eb1c0309e4f996\", \"ui_touch_selection_unittests\": \"083b952cffac8c1327ed38adf2cf17a2e9016a77\", \"unit_tests\": \"39866b720e046992c6ebe14e730dda75bbea4bf6\", \"url_unittests\": \"ac74ef8e2bbb2e907ec44d67b2c5203cb61977a7\", \"usage_time_limit_unittests\": \"bc8678fde5f51ef189cc7dffad12397e2cb4445f\", \"views_unittests\": \"dd5776b203a50adce02edc86a4e6b9f9e53b47c5\", \"viz_unittests\": \"d10327e01e3b2530fd5dd82975f55f5b610cc87f\", \"wayland_client_perftests\": \"cfd87571e391fce58b935354178aaabd71c4f1f7\", \"wm_unittests\": \"299fee6d1190a42a4da4b03e486acbb200c20fa1\", \"wtf_unittests\": \"6249fa41e4798532b7772595d13b5f6b223ce02d\", \"zlib_unittests\": \"6ca90be974f4fe5e8a10d9ae601dea0e2dff5ec2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3b2af173bd6c7c2422ea21f333ca7959a40b63aa844e8561bdce050550b2b6b9_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_75bb63162a23d4b1c0ff37321417ec47e6c57c7535580350abbb418df2b18732_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_v2\", \"builder_b2e890d1c00928beb9cbf09b0cac016df4f27e0286d8bea059c166f6a7e78eea_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_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-east1-d-8-3-8rzz\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603634180011459",
"status": "COMPLETED",
"status_changed_ts": "1603639504597761",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42243",
"builder:linux-chromeos-rel",
"buildset:commit/git/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7d23aba5bfad50be4840ac1f7b9bb89ff76c28f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030892479144190640",
"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/8865462417195188368/+/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:4f78ce779afb5310",
"user_agent:luci-scheduler"
],
"updated_ts": "1603639504686127",
"url": "https://ci.chromium.org/b/8865462417195188368",
"utcnow_ts": "1603639506560482"
}
}
[15:25:06.568] Invocation finished in 1h44m55.947714504s with status SUCCEEDED