[10:52:01.614] New invocation is queued and will start shortly
[10:52:02.848] Starting the invocation (attempt 1)
[10:52:02.879] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:52:02.880] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:52:02.881] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020122019252237456",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020122019252237456",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master"
]
}
[10:52:03.667] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613904722957857",
"id": "8854691957179076624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613904723441135",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45597",
"builder:linux-chromeos-rel",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020122019252237456",
"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/8854691957179076624/+/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": "1613904723441327",
"url": "https://ci.chromium.org/b/8854691957179076624",
"utcnow_ts": "1613904723660322"
}
}
[10:52:03.667] Task URL: https://ci.chromium.org/b/8854691957179076624
[10:52:03.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:2:0) after 1m0s
[10:53:03.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:2:0)
[10:53:03.664] Timer tick, asking Buildbucket for the build status
[10:53:03.803] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:53:03.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:3:0) after 1m0s
[10:54:03.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:3:0)
[10:54:03.820] Timer tick, asking Buildbucket for the build status
[10:54:03.885] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:54:03.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:4:0) after 1m0s
[10:55:03.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:4:0)
[10:55:03.959] Timer tick, asking Buildbucket for the build status
[10:55:04.150] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:55:04.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:5:0) after 1m0s
[10:56:04.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:5:0)
[10:56:04.165] Timer tick, asking Buildbucket for the build status
[10:56:04.228] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:56:04.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:6:0) after 1m0s
[10:57:04.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:6:0)
[10:57:04.213] Timer tick, asking Buildbucket for the build status
[10:57:04.304] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:57:04.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:7:0) after 1m0s
[10:58:04.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:7:0)
[10:58:04.323] Timer tick, asking Buildbucket for the build status
[10:58:04.408] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:58:04.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:8:0) after 1m0s
[10:59:04.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:8:0)
[10:59:04.463] Timer tick, asking Buildbucket for the build status
[10:59:04.531] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:04.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:9:0) after 1m0s
[11:00:04.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:9:0)
[11:00:04.548] Timer tick, asking Buildbucket for the build status
[11:00:04.649] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:00:04.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:10:0) after 1m0s
[11:01:05.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:10:0)
[11:01:05.466] Timer tick, asking Buildbucket for the build status
[11:01:05.558] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:01:05.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:11:0) after 1m0s
[11:02:05.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:11:0)
[11:02:05.573] Timer tick, asking Buildbucket for the build status
[11:02:05.905] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:02:05.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:12:0) after 1m0s
[11:03:05.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:12:0)
[11:03:05.952] Timer tick, asking Buildbucket for the build status
[11:03:06.106] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:03:06.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:13:0) after 1m0s
[11:04:06.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:13:0)
[11:04:06.132] Timer tick, asking Buildbucket for the build status
[11:04:06.210] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:04:06.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:14:0) after 1m0s
[11:05:06.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:14:0)
[11:05:06.224] Timer tick, asking Buildbucket for the build status
[11:05:06.535] Build 8854691957179076624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:05:06.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:15:0) after 1m0s
[11:05:55.038] Received PubSub notification, asking Buildbucket for the build status
[11:05:55.103] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:06.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:15:0)
[11:06:06.540] Timer tick, asking Buildbucket for the build status
[11:06:06.617] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:06.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:17:0) after 1m0s
[11:07:06.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:17:0)
[11:07:06.635] Timer tick, asking Buildbucket for the build status
[11:07:06.783] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:06.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:18:0) after 1m0s
[11:08:06.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:18:0)
[11:08:06.801] Timer tick, asking Buildbucket for the build status
[11:08:07.039] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:07.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:19:0) after 1m0s
[11:09:07.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:19:0)
[11:09:07.056] Timer tick, asking Buildbucket for the build status
[11:09:07.112] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:07.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:20:0) after 1m0s
[11:10:07.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:20:0)
[11:10:07.805] Timer tick, asking Buildbucket for the build status
[11:10:07.872] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:21:0) after 1m0s
[11:11:09.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:21:0)
[11:11:09.252] Timer tick, asking Buildbucket for the build status
[11:11:09.339] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:09.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:22:0) after 1m0s
[11:12:09.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:22:0)
[11:12:09.354] Timer tick, asking Buildbucket for the build status
[11:12:09.489] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:09.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:23:0) after 1m0s
[11:13:09.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:23:0)
[11:13:09.555] Timer tick, asking Buildbucket for the build status
[11:13:09.921] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:09.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:24:0) after 1m0s
[11:14:09.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:24:0)
[11:14:09.940] Timer tick, asking Buildbucket for the build status
[11:14:10.215] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:10.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:25:0) after 1m0s
[11:15:10.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:25:0)
[11:15:10.205] Timer tick, asking Buildbucket for the build status
[11:15:10.288] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:26:0) after 1m0s
[11:16:10.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:26:0)
[11:16:10.309] Timer tick, asking Buildbucket for the build status
[11:16:10.417] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:10.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:27:0) after 1m0s
[11:17:10.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:27:0)
[11:17:10.441] Timer tick, asking Buildbucket for the build status
[11:17:10.543] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:28:0) after 1m0s
[11:18:10.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:28:0)
[11:18:10.731] Timer tick, asking Buildbucket for the build status
[11:18:10.819] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:10.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:29:0) after 1m0s
[11:19:10.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:29:0)
[11:19:10.838] Timer tick, asking Buildbucket for the build status
[11:19:10.916] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:10.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:30:0) after 1m0s
[11:20:10.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:30:0)
[11:20:10.962] Timer tick, asking Buildbucket for the build status
[11:20:11.061] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:31:0) after 1m0s
[11:21:11.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:31:0)
[11:21:11.110] Timer tick, asking Buildbucket for the build status
[11:21:11.234] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:11.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:32:0) after 1m0s
[11:22:11.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:32:0)
[11:22:11.252] Timer tick, asking Buildbucket for the build status
[11:22:11.324] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:11.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:33:0) after 1m0s
[11:23:11.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:33:0)
[11:23:11.332] Timer tick, asking Buildbucket for the build status
[11:23:11.401] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:11.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:34:0) after 1m0s
[11:24:11.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:34:0)
[11:24:11.524] Timer tick, asking Buildbucket for the build status
[11:24:11.621] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:35:0) after 1m0s
[11:25:11.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:35:0)
[11:25:11.825] Timer tick, asking Buildbucket for the build status
[11:25:11.913] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:36:0) after 1m0s
[11:26:11.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:36:0)
[11:26:11.936] Timer tick, asking Buildbucket for the build status
[11:26:12.303] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:12.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:37:0) after 1m0s
[11:27:12.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:37:0)
[11:27:12.324] Timer tick, asking Buildbucket for the build status
[11:27:12.598] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:12.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:38:0) after 1m0s
[11:28:12.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:38:0)
[11:28:12.677] Timer tick, asking Buildbucket for the build status
[11:28:12.742] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:12.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:39:0) after 1m0s
[11:29:12.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:39:0)
[11:29:12.773] Timer tick, asking Buildbucket for the build status
[11:29:13.118] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:13.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:40:0) after 1m0s
[11:30:13.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:40:0)
[11:30:13.166] Timer tick, asking Buildbucket for the build status
[11:30:13.307] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:13.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:41:0) after 1m0s
[11:31:13.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:41:0)
[11:31:13.353] Timer tick, asking Buildbucket for the build status
[11:31:13.418] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:13.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:42:0) after 1m0s
[11:32:13.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:42:0)
[11:32:13.433] Timer tick, asking Buildbucket for the build status
[11:32:13.519] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:43:0) after 1m0s
[11:33:13.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:43:0)
[11:33:13.529] Timer tick, asking Buildbucket for the build status
[11:33:13.622] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:13.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:44:0) after 1m0s
[11:34:13.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:44:0)
[11:34:13.660] Timer tick, asking Buildbucket for the build status
[11:34:14.009] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:14.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:45:0) after 1m0s
[11:35:14.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:45:0)
[11:35:14.028] Timer tick, asking Buildbucket for the build status
[11:35:14.231] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:14.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:46:0) after 1m0s
[11:36:14.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:46:0)
[11:36:14.229] Timer tick, asking Buildbucket for the build status
[11:36:14.323] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:14.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:47:0) after 1m0s
[11:37:14.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:47:0)
[11:37:14.339] Timer tick, asking Buildbucket for the build status
[11:37:14.422] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:14.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:48:0) after 1m0s
[11:38:14.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:48:0)
[11:38:14.441] Timer tick, asking Buildbucket for the build status
[11:38:14.507] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:14.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:49:0) after 1m0s
[11:39:14.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:49:0)
[11:39:14.562] Timer tick, asking Buildbucket for the build status
[11:39:14.746] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:14.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:50:0) after 1m0s
[11:40:14.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:50:0)
[11:40:14.743] Timer tick, asking Buildbucket for the build status
[11:40:14.924] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:14.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:51:0) after 1m0s
[11:41:15.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:51:0)
[11:41:15.042] Timer tick, asking Buildbucket for the build status
[11:41:15.129] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:15.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:52:0) after 1m0s
[11:42:15.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:52:0)
[11:42:15.238] Timer tick, asking Buildbucket for the build status
[11:42:15.345] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:53:0) after 1m0s
[11:43:15.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:53:0)
[11:43:15.363] Timer tick, asking Buildbucket for the build status
[11:43:15.515] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:54:0) after 1m0s
[11:44:15.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:54:0)
[11:44:15.539] Timer tick, asking Buildbucket for the build status
[11:44:15.701] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:15.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:55:0) after 1m0s
[11:45:15.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:55:0)
[11:45:15.723] Timer tick, asking Buildbucket for the build status
[11:45:15.793] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:15.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:56:0) after 1m0s
[11:46:15.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:56:0)
[11:46:15.865] Timer tick, asking Buildbucket for the build status
[11:46:15.928] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:15.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:57:0) after 1m0s
[11:47:15.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:57:0)
[11:47:15.975] Timer tick, asking Buildbucket for the build status
[11:47:16.146] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:58:0) after 1m0s
[11:48:16.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:58:0)
[11:48:16.177] Timer tick, asking Buildbucket for the build status
[11:48:16.408] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:16.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:59:0) after 1m0s
[11:49:16.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:59:0)
[11:49:16.388] Timer tick, asking Buildbucket for the build status
[11:49:16.536] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:16.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:60:0) after 1m0s
[11:50:16.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:60:0)
[11:50:16.558] Timer tick, asking Buildbucket for the build status
[11:50:16.728] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:16.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:61:0) after 1m0s
[11:51:16.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:61:0)
[11:51:16.790] Timer tick, asking Buildbucket for the build status
[11:51:16.850] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:16.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:62:0) after 1m0s
[11:52:16.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:62:0)
[11:52:16.877] Timer tick, asking Buildbucket for the build status
[11:52:17.137] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:17.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:63:0) after 1m0s
[11:53:17.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:63:0)
[11:53:17.205] Timer tick, asking Buildbucket for the build status
[11:53:17.283] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:17.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:64:0) after 1m0s
[11:54:17.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:64:0)
[11:54:17.299] Timer tick, asking Buildbucket for the build status
[11:54:17.420] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:65:0) after 1m0s
[11:55:17.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:65:0)
[11:55:17.438] Timer tick, asking Buildbucket for the build status
[11:55:17.742] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:17.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:66:0) after 1m0s
[11:56:17.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:66:0)
[11:56:17.812] Timer tick, asking Buildbucket for the build status
[11:56:18.050] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:18.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:67:0) after 1m0s
[11:57:18.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:67:0)
[11:57:18.102] Timer tick, asking Buildbucket for the build status
[11:57:18.198] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:18.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:68:0) after 1m0s
[11:58:18.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:68:0)
[11:58:18.297] Timer tick, asking Buildbucket for the build status
[11:58:18.368] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:18.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:69:0) after 1m0s
[11:59:18.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:69:0)
[11:59:18.387] Timer tick, asking Buildbucket for the build status
[11:59:18.686] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:18.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:70:0) after 1m0s
[12:00:18.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:70:0)
[12:00:18.721] Timer tick, asking Buildbucket for the build status
[12:00:18.875] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:18.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:71:0) after 1m0s
[12:01:19.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:71:0)
[12:01:19.037] Timer tick, asking Buildbucket for the build status
[12:01:19.140] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:19.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:72:0) after 1m0s
[12:02:19.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:72:0)
[12:02:19.151] Timer tick, asking Buildbucket for the build status
[12:02:19.316] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:19.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:73:0) after 1m0s
[12:03:19.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:73:0)
[12:03:19.474] Timer tick, asking Buildbucket for the build status
[12:03:19.551] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:19.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:74:0) after 1m0s
[12:04:19.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:74:0)
[12:04:19.656] Timer tick, asking Buildbucket for the build status
[12:04:19.734] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:19.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:75:0) after 1m0s
[12:05:19.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:75:0)
[12:05:19.833] Timer tick, asking Buildbucket for the build status
[12:05:19.955] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:19.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:76:0) after 1m0s
[12:06:20.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:76:0)
[12:06:20.041] Timer tick, asking Buildbucket for the build status
[12:06:20.110] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:20.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:77:0) after 1m0s
[12:07:20.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:77:0)
[12:07:20.261] Timer tick, asking Buildbucket for the build status
[12:07:20.342] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:20.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:78:0) after 1m0s
[12:08:20.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:78:0)
[12:08:20.411] Timer tick, asking Buildbucket for the build status
[12:08:20.493] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:20.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:79:0) after 1m0s
[12:09:20.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:79:0)
[12:09:20.512] Timer tick, asking Buildbucket for the build status
[12:09:20.583] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:20.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:80:0) after 1m0s
[12:10:20.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:80:0)
[12:10:20.612] Timer tick, asking Buildbucket for the build status
[12:10:20.684] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:20.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:81:0) after 1m0s
[12:11:20.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:81:0)
[12:11:20.711] Timer tick, asking Buildbucket for the build status
[12:11:20.832] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:20.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:82:0) after 1m0s
[12:12:20.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:82:0)
[12:12:20.915] Timer tick, asking Buildbucket for the build status
[12:12:21.024] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:21.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:83:0) after 1m0s
[12:13:21.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:83:0)
[12:13:21.103] Timer tick, asking Buildbucket for the build status
[12:13:21.324] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:21.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:84:0) after 1m0s
[12:14:21.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:84:0)
[12:14:21.368] Timer tick, asking Buildbucket for the build status
[12:14:21.452] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:21.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:85:0) after 1m0s
[12:15:21.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:85:0)
[12:15:21.474] Timer tick, asking Buildbucket for the build status
[12:15:21.609] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:21.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:86:0) after 1m0s
[12:16:21.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:86:0)
[12:16:21.740] Timer tick, asking Buildbucket for the build status
[12:16:21.816] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:21.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:87:0) after 1m0s
[12:17:21.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:87:0)
[12:17:21.852] Timer tick, asking Buildbucket for the build status
[12:17:22.095] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:22.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:88:0) after 1m0s
[12:18:22.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:88:0)
[12:18:22.089] Timer tick, asking Buildbucket for the build status
[12:18:22.184] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:22.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:89:0) after 1m0s
[12:19:22.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:89:0)
[12:19:22.259] Timer tick, asking Buildbucket for the build status
[12:19:22.339] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:22.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:90:0) after 1m0s
[12:20:22.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:90:0)
[12:20:22.361] Timer tick, asking Buildbucket for the build status
[12:20:22.437] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:22.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:91:0) after 1m0s
[12:21:22.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:91:0)
[12:21:22.455] Timer tick, asking Buildbucket for the build status
[12:21:22.556] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:22.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:92:0) after 1m0s
[12:22:22.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:92:0)
[12:22:22.941] Timer tick, asking Buildbucket for the build status
[12:22:23.103] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:23.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:93:0) after 1m0s
[12:23:23.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:93:0)
[12:23:23.351] Timer tick, asking Buildbucket for the build status
[12:23:23.716] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:23.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:94:0) after 1m0s
[12:24:24.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:94:0)
[12:24:24.057] Timer tick, asking Buildbucket for the build status
[12:24:24.195] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:24.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:95:0) after 1m0s
[12:25:24.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:95:0)
[12:25:24.333] Timer tick, asking Buildbucket for the build status
[12:25:24.837] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:24.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:96:0) after 1m0s
[12:26:24.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:96:0)
[12:26:24.821] Timer tick, asking Buildbucket for the build status
[12:26:24.898] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:24.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:97:0) after 1m0s
[12:27:24.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:97:0)
[12:27:24.990] Timer tick, asking Buildbucket for the build status
[12:27:25.185] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:25.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:98:0) after 1m0s
[12:28:25.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:98:0)
[12:28:25.321] Timer tick, asking Buildbucket for the build status
[12:28:25.423] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:99:0) after 1m0s
[12:29:25.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:99:0)
[12:29:25.514] Timer tick, asking Buildbucket for the build status
[12:29:25.595] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:25.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:100:0) after 1m0s
[12:30:25.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:100:0)
[12:30:25.738] Timer tick, asking Buildbucket for the build status
[12:30:25.817] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:101:0) after 1m0s
[12:31:25.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:101:0)
[12:31:25.917] Timer tick, asking Buildbucket for the build status
[12:31:26.012] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:26.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:102:0) after 1m0s
[12:32:26.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:102:0)
[12:32:26.138] Timer tick, asking Buildbucket for the build status
[12:32:26.286] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:26.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:103:0) after 1m0s
[12:33:26.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:103:0)
[12:33:26.484] Timer tick, asking Buildbucket for the build status
[12:33:26.577] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:26.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:104:0) after 1m0s
[12:34:26.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:104:0)
[12:34:26.724] Timer tick, asking Buildbucket for the build status
[12:34:26.810] Build 8854691957179076624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:26.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020122019252237456:105:0) after 1m0s
[12:35:24.677] Received PubSub notification, asking Buildbucket for the build status
[12:35:24.882] Build 8854691957179076624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:35:24.882] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613910924034292",
"created_by": "project:chromium",
"created_ts": "1613904722957857",
"id": "8854691957179076624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"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-23-98xn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45597, \"got_angle_revision\": \"6e8cdd39b19912e7fe6408b0318d0907dc7e4d21\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"got_revision_cp\": \"refs/heads/master@{#856142}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"swarm_hashes_refs/heads/master(at){#856142}_without_patch\": {\"absl_hardening_tests\": \"16744b70f9d590796d06d6906688edb675b743c4\", \"accessibility_unittests\": \"3af4f1dfcc022e28fc768c6420f245cadf5e3f59\", \"angle_unittests\": \"1e6cfcd699dadf443df1df1cfe3b9246584f8912\", \"app_list_unittests\": \"6a4bbf427e4acc0879508a8c7d7b921f883a2cd8\", \"app_shell_unittests\": \"18fce80e909dd3b6f78cbbaf952756c76d69ae30\", \"ash_unittests\": \"699141784012d403387b9320670aeb56205ba420\", \"aura_unittests\": \"c4726944ba1fc81cf72155fd2454af1e8055a950\", \"base_unittests\": \"893b25bec9c0205941ad491b6a94ce206e10d6d7\", \"base_util_unittests\": \"72c38111eea35fa040a86e0e2951f2af11c29f97\", \"blink_common_unittests\": \"3c53908519dc43fe85db3cc2b5b48da2249c51a2\", \"blink_fuzzer_unittests\": \"52d10a300ea23de93ee59e9495ab1c5500d3bdb3\", \"blink_heap_unittests\": \"729bb11de025f150abe88ea5511fda457dc365f8\", \"blink_platform_unittests\": \"5cd2d939136dcb1ca0fece7ccbb4d46b50bc437e\", \"blink_unittests\": \"7ef7da1a92da3089b8e398082563a2d75b6b12b9\", \"boringssl_crypto_tests\": \"cadccfb06ce1331dd7a96b2db1a6e3db28960cd6\", \"boringssl_ssl_tests\": \"c0e755952560d51141113456d829a577c2f255fa\", \"browser_tests\": \"014ace5d948f48bf9338239ef6d47291e394b395\", \"capture_unittests\": \"26d27e47b70b4284f94445e34a955580f3607cba\", \"cast_unittests\": \"6794ef0cd7cb2ec6004e268f4dbe2146b4b5f923\", \"cc_unittests\": \"10478019f0bd8e89a46db03909ac1e2062d671ef\", \"chrome_app_unittests\": \"9de0a114f8e9c3de30b2d80140c31484df22583f\", \"chromedriver_unittests\": \"63065367a31b38bb09ac516b196cfa9fed8e4a69\", \"chromeos_components_unittests\": \"9e0cc0803091a17c876665ee8ae49a6520dd0c0d\", \"chromeos_unittests\": \"4d36e95103031c9c8d76dacdf062eb01eece861c\", \"components_browsertests\": \"8a0918723267ced5af4f81c65bfc8b47a7da3f86\", \"components_unittests\": \"92d6deb895adf7c3d3f19889e4d688c14eed3d0c\", \"compositor_unittests\": \"b54399913be661b6f490aba75271a90c26d3d59e\", \"content_browsertests\": \"a4af28f2d0620566d567d998e86d9e9ceb7a36ca\", \"content_unittests\": \"567bef7ae64c4d61f248f860c62cc2812143c0bb\", \"crashpad_tests\": \"edef239b7220ee13332dd83d8cbea9d2c0ffd30c\", \"crypto_unittests\": \"f6cf178e1152d46b39e9ef5c40149f47716f782d\", \"dbus_unittests\": \"27ecb2f5c5cc26d774653b18a571d6e3138587ee\", \"device_unittests\": \"0fb911596bcab5a151ab14b274fa1d8b723c98e7\", \"display_unittests\": \"cf9246a58793b3616addff90c6dd95100da401c9\", \"events_unittests\": \"4f2102d3fd33e9b887eedd9a1ed02f5ce1799b74\", \"exo_unittests\": \"eec446fa86fbfad4e0f31cea4cc9296a2a94b0fc\", \"extensions_browsertests\": \"1455f43d3f8c9ff4e6b7383d5384d9a05de544b4\", \"extensions_unittests\": \"c9587bed4ff9a4cd66790637dcdbe9fb07c74a00\", \"filesystem_service_unittests\": \"0552aa03c7e5108ab2a2f436abd8ecfd9ddf194c\", \"gcm_unit_tests\": \"d3800131c0e827565316a00eabc31be517ab2316\", \"gfx_unittests\": \"bcbabac2e5a00f08dda56a7b0df950affb4879b8\", \"gin_unittests\": \"cd04425776775b4d34960bc71220cd211fa65ff8\", \"gl_unittests_ozone\": \"8c9c74dd69b3acebb122a0fbd12fc1a43cd0ac8b\", \"google_apis_unittests\": \"d808614b76c59e483fcdd12c8e2db483bdb28207\", \"gpu_unittests\": \"dff4c9fe2e508a98e89255629a50e545dc6d35d7\", \"gwp_asan_unittests\": \"911d337f2c9cbf3360419db8985c877ac370ca0f\", \"interactive_ui_tests\": \"e89b47b67327ee676b0e081339e34c9528d49da9\", \"ipc_tests\": \"1d17db001f6e344f0a69c2db26cdd9157726b2f4\", \"jingle_unittests\": \"da8502cdeae58fe412533cf54f8afdf0c991915b\", \"keyboard_unittests\": \"0991e8242a934e880c514ff5349f67c6526f5f6b\", \"latency_unittests\": \"3cfaacc38a948c810763fc75742ea03858d85adb\", \"libjingle_xmpp_unittests\": \"ac9be026873d936e877d4ca3f527568e24c6b116\", \"liburlpattern_unittests\": \"ba4d6d7253aa7d69a7ad683ffc047575a4f62667\", \"media_blink_unittests\": \"d76846664112081a8aac830e61fae9dde823d9e0\", \"media_unittests\": \"95243673c0bc599aa457c03470f57cbdac24b026\", \"message_center_unittests\": \"c9edcd7153d8236aa98412517053a3347e253af6\", \"midi_unittests\": \"8616d00722514e2f338c4d259f61623693a7739f\", \"mojo_core_unittests\": \"7ed46d38a39a3acf4b9a8ddcaa2934b79f2225a6\", \"mojo_unittests\": \"1f56281323adbdd7fdee4c39580f7df9be11bc0b\", \"nacl_helper_nonsfi_unittests\": \"144ebe766abe8553f2519dc028896d3440a12f68\", \"nacl_loader_unittests\": \"d9e56261719f58cffead705cbf403c66db8c9e47\", \"native_theme_unittests\": \"8b92bfee17599bd5c267ea234fcb44f26e84b39f\", \"net_unittests\": \"6ee6f9e15de5a952e8a6586c88ee91ad6d009168\", \"ozone_gl_unittests\": \"4462e5fc058e87b929d0746c6fcbec24af3ec374\", \"ozone_unittests\": \"0b08e030e566202946b43315b3ccdcf6fd78351e\", \"ozone_x11_unittests\": \"66d445c6b2110365f466ac59bc7d229124f4ade5\", \"pdf_unittests\": \"4da7909db4bf5307200aa528c9c505dab1f1ea08\", \"perfetto_unittests\": \"610f7baa0bdf0baa5413d9c99c1853446f315b44\", \"ppapi_unittests\": \"eea9d16159ad81d72e31a1da0572b51d2ddbeb91\", \"printing_unittests\": \"4738aef0ad0a3f1c5d781f0529e83f75ab196d0c\", \"remoting_unittests\": \"5c467b8ede03d514f4ecc9a61b54254871ba8ef3\", \"sandbox_linux_unittests\": \"f1d2d0f0479271de9b72c1393696ba415dc3629b\", \"service_manager_unittests\": \"89ea9f0806c113ede72ae92d05f86b919087a3a6\", \"services_unittests\": \"86bf698147711844677154de6024bcf844a7bbb6\", \"shell_dialogs_unittests\": \"573c15dec805774bac1e0ccabdc76e8078e38e52\", \"shell_encryption_unittests\": \"4bca1eea80133601aca7adf464cb7d52d0ad4494\", \"skia_unittests\": \"6cef7a8f0764ad89a992f9379773898a9bb6a3dc\", \"snapshot_unittests\": \"6d409562648e8fb62bc7a925422dc187bf2d9eab\", \"sql_unittests\": \"cd1b518066558e1dec7e859b94421a5507624fd7\", \"storage_unittests\": \"bf9dfcd42f824abd93345239e6c779b74290b412\", \"sync_integration_tests\": \"5f07a86d3828bee6ccb57df1100f80ed3a81b93a\", \"traffic_annotation_auditor_unittests\": \"1cbeee1bd112bd44e6b438ba422aad471b3bc521\", \"ui_base_unittests\": \"b175bbd941c3af209fdbebe0cba782fcc71c072f\", \"ui_chromeos_unittests\": \"c394837591868a37194bb6ca92139715615e9329\", \"ui_touch_selection_unittests\": \"c7ad478cbb7fb47d2242f385ff056d0f9f403ba6\", \"unit_tests\": \"2b03eac9d492c73f79373b751d48d7a3dae2e514\", \"url_unittests\": \"7f522d44de383b314c96a8fb54c0687bf69783cc\", \"usage_time_limit_unittests\": \"c97eb6f804bb4dc0ebbacbf9d4e208ae2d294886\", \"views_unittests\": \"eab07fcac8aaef57509ec5cd50bc1e7a45bca92d\", \"viz_unittests\": \"aff3d0190d7a966662fdb714c54eaead391d623a\", \"wayland_client_perftests\": \"39c1cb2e003847874ff43873d8665476a1f05e62\", \"wm_unittests\": \"38f2d45f46e1b6dd5a5b493e0a84181113662d7c\", \"wtf_unittests\": \"55b9783581442aaa6e87b19b74f54bb0b42b7bf7\", \"zlib_unittests\": \"37aedabe9ebe702bf855482fe1e4012f5477490e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_288b090d6274f2a2f913a0241f3e1a83c28ff98db6eccb4d2a91107c37eb954f_v2\", \"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_cb8f28a5d59bb80cbafed89b56af03ba2ea85f5e24941631d330b6bd1d886cb5_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_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-23-98xn\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613905554383047",
"status": "COMPLETED",
"status_changed_ts": "1613910924300360",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45597",
"builder:linux-chromeos-rel",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020122019252237456",
"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/8854691957179076624/+/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:51dd094726db1410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613910924305623",
"url": "https://ci.chromium.org/b/8854691957179076624",
"utcnow_ts": "1613910924868157"
}
}
[12:35:24.882] Invocation finished in 1h43m23.285942188s with status SUCCEEDED