[08:11:16.515] New invocation is queued and will start shortly
[08:11:17.768] Starting the invocation (attempt 1)
[08:11:17.814] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:11:17.814] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:11:17.814] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020403923768270416",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"67bb830af3896616dd6614c8b74971ee0ccf73ba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020403923768270416",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"gitiles_ref:refs/heads/master"
]
}
[08:11:18.441] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613635877891498",
"id": "8854973861663181104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"67bb830af3896616dd6614c8b74971ee0ccf73ba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613635878299944",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45523",
"builder:linux-chromeos-rel",
"buildset:commit/git/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020403923768270416",
"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/8854973861663181104/+/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": "1613635878300050",
"url": "https://ci.chromium.org/b/8854973861663181104",
"utcnow_ts": "1613635878434576"
}
}
[08:11:18.441] Task URL: https://ci.chromium.org/b/8854973861663181104
[08:11:18.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:2:0) after 1m0s
[08:12:18.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:2:0)
[08:12:18.497] Timer tick, asking Buildbucket for the build status
[08:12:18.597] Build 8854973861663181104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:18.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:3:0) after 1m0s
[08:13:18.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:3:0)
[08:13:18.645] Timer tick, asking Buildbucket for the build status
[08:13:18.732] Build 8854973861663181104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:18.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:4:0) after 1m0s
[08:14:18.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:4:0)
[08:14:18.774] Timer tick, asking Buildbucket for the build status
[08:14:18.882] Build 8854973861663181104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:5:0) after 1m0s
[08:15:18.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:5:0)
[08:15:18.978] Timer tick, asking Buildbucket for the build status
[08:15:19.142] Build 8854973861663181104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:19.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:6:0) after 1m0s
[08:16:09.647] Received PubSub notification, asking Buildbucket for the build status
[08:16:09.741] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:19.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:6:0)
[08:16:19.246] Timer tick, asking Buildbucket for the build status
[08:16:19.317] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:19.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:8:0) after 1m0s
[08:17:19.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:8:0)
[08:17:19.383] Timer tick, asking Buildbucket for the build status
[08:17:19.491] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:19.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:9:0) after 1m0s
[08:18:19.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:9:0)
[08:18:19.494] Timer tick, asking Buildbucket for the build status
[08:18:19.613] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:19.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:10:0) after 1m0s
[08:19:19.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:10:0)
[08:19:19.638] Timer tick, asking Buildbucket for the build status
[08:19:19.924] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:19.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:11:0) after 1m0s
[08:20:19.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:11:0)
[08:20:19.966] Timer tick, asking Buildbucket for the build status
[08:20:20.038] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:20.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:12:0) after 1m0s
[08:21:20.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:12:0)
[08:21:20.078] Timer tick, asking Buildbucket for the build status
[08:21:20.146] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:20.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:13:0) after 1m0s
[08:22:20.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:13:0)
[08:22:20.247] Timer tick, asking Buildbucket for the build status
[08:22:20.411] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:20.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:14:0) after 1m0s
[08:23:20.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:14:0)
[08:23:20.470] Timer tick, asking Buildbucket for the build status
[08:23:20.552] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:15:0) after 1m0s
[08:24:20.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:15:0)
[08:24:20.584] Timer tick, asking Buildbucket for the build status
[08:24:20.671] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:20.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:16:0) after 1m0s
[08:25:20.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:16:0)
[08:25:20.722] Timer tick, asking Buildbucket for the build status
[08:25:20.788] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:17:0) after 1m0s
[08:26:20.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:17:0)
[08:26:20.890] Timer tick, asking Buildbucket for the build status
[08:26:20.971] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:20.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:18:0) after 1m0s
[08:27:21.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:18:0)
[08:27:21.042] Timer tick, asking Buildbucket for the build status
[08:27:21.399] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:21.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:19:0) after 1m0s
[08:28:21.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:19:0)
[08:28:21.509] Timer tick, asking Buildbucket for the build status
[08:28:21.578] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:20:0) after 1m0s
[08:29:21.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:20:0)
[08:29:21.647] Timer tick, asking Buildbucket for the build status
[08:29:21.744] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:21.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:21:0) after 1m0s
[08:30:21.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:21:0)
[08:30:21.830] Timer tick, asking Buildbucket for the build status
[08:30:21.926] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:21.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:22:0) after 1m0s
[08:31:21.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:22:0)
[08:31:21.983] Timer tick, asking Buildbucket for the build status
[08:31:22.148] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:22.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:23:0) after 1m0s
[08:32:22.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:23:0)
[08:32:22.229] Timer tick, asking Buildbucket for the build status
[08:32:22.331] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:24:0) after 1m0s
[08:33:22.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:24:0)
[08:33:22.398] Timer tick, asking Buildbucket for the build status
[08:33:22.627] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:22.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:25:0) after 1m0s
[08:34:22.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:25:0)
[08:34:22.691] Timer tick, asking Buildbucket for the build status
[08:34:22.921] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:22.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:26:0) after 1m0s
[08:35:22.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:26:0)
[08:35:22.948] Timer tick, asking Buildbucket for the build status
[08:35:23.030] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:23.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:27:0) after 1m0s
[08:36:23.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:27:0)
[08:36:23.002] Timer tick, asking Buildbucket for the build status
[08:36:23.114] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:23.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:28:0) after 1m0s
[08:37:23.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:28:0)
[08:37:23.132] Timer tick, asking Buildbucket for the build status
[08:37:23.201] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:23.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:29:0) after 1m0s
[08:38:23.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:29:0)
[08:38:23.235] Timer tick, asking Buildbucket for the build status
[08:38:23.317] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:23.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:30:0) after 1m0s
[08:39:23.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:30:0)
[08:39:23.386] Timer tick, asking Buildbucket for the build status
[08:39:23.468] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:23.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:31:0) after 1m0s
[08:40:23.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:31:0)
[08:40:23.551] Timer tick, asking Buildbucket for the build status
[08:40:23.628] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:23.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:32:0) after 1m0s
[08:41:23.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:32:0)
[08:41:23.742] Timer tick, asking Buildbucket for the build status
[08:41:23.893] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:23.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:33:0) after 1m0s
[08:42:23.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:33:0)
[08:42:23.988] Timer tick, asking Buildbucket for the build status
[08:42:24.092] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:24.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:34:0) after 1m0s
[08:43:24.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:34:0)
[08:43:24.152] Timer tick, asking Buildbucket for the build status
[08:43:24.621] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:24.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:35:0) after 1m0s
[08:44:24.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:35:0)
[08:44:24.667] Timer tick, asking Buildbucket for the build status
[08:44:24.776] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:24.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:36:0) after 1m0s
[08:45:24.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:36:0)
[08:45:24.824] Timer tick, asking Buildbucket for the build status
[08:45:25.431] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:25.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:37:0) after 1m0s
[08:46:25.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:37:0)
[08:46:25.454] Timer tick, asking Buildbucket for the build status
[08:46:25.579] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:25.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:38:0) after 1m0s
[08:47:25.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:38:0)
[08:47:25.686] Timer tick, asking Buildbucket for the build status
[08:47:25.859] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:25.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:39:0) after 1m0s
[08:48:26.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:39:0)
[08:48:26.252] Timer tick, asking Buildbucket for the build status
[08:48:26.348] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:26.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:40:0) after 1m0s
[08:49:26.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:40:0)
[08:49:26.514] Timer tick, asking Buildbucket for the build status
[08:49:26.598] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:26.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:41:0) after 1m0s
[08:50:26.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:41:0)
[08:50:26.718] Timer tick, asking Buildbucket for the build status
[08:50:26.793] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:26.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:42:0) after 1m0s
[08:51:26.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:42:0)
[08:51:26.908] Timer tick, asking Buildbucket for the build status
[08:51:27.028] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:27.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:43:0) after 1m0s
[08:52:27.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:43:0)
[08:52:27.117] Timer tick, asking Buildbucket for the build status
[08:52:27.183] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:27.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:44:0) after 1m0s
[08:53:27.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:44:0)
[08:53:27.215] Timer tick, asking Buildbucket for the build status
[08:53:27.294] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:27.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:45:0) after 1m0s
[08:54:27.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:45:0)
[08:54:27.395] Timer tick, asking Buildbucket for the build status
[08:54:27.491] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:27.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:46:0) after 1m0s
[08:55:27.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:46:0)
[08:55:27.595] Timer tick, asking Buildbucket for the build status
[08:55:27.898] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:27.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:47:0) after 1m0s
[08:56:27.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:47:0)
[08:56:27.931] Timer tick, asking Buildbucket for the build status
[08:56:28.047] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:28.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:48:0) after 1m0s
[08:57:28.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:48:0)
[08:57:28.085] Timer tick, asking Buildbucket for the build status
[08:57:28.153] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:28.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:49:0) after 1m0s
[08:58:28.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:49:0)
[08:58:28.306] Timer tick, asking Buildbucket for the build status
[08:58:28.398] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:28.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:50:0) after 1m0s
[08:59:28.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:50:0)
[08:59:28.448] Timer tick, asking Buildbucket for the build status
[08:59:28.522] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:28.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:51:0) after 1m0s
[09:00:28.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:51:0)
[09:00:28.561] Timer tick, asking Buildbucket for the build status
[09:00:28.638] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:28.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:52:0) after 1m0s
[09:01:28.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:52:0)
[09:01:28.649] Timer tick, asking Buildbucket for the build status
[09:01:28.889] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:28.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:53:0) after 1m0s
[09:02:28.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:53:0)
[09:02:28.978] Timer tick, asking Buildbucket for the build status
[09:02:29.068] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:29.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:54:0) after 1m0s
[09:03:29.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:54:0)
[09:03:29.122] Timer tick, asking Buildbucket for the build status
[09:03:29.207] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:29.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:55:0) after 1m0s
[09:04:29.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:55:0)
[09:04:29.243] Timer tick, asking Buildbucket for the build status
[09:04:29.321] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:29.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:56:0) after 1m0s
[09:05:29.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:56:0)
[09:05:29.359] Timer tick, asking Buildbucket for the build status
[09:05:29.471] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:29.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:57:0) after 1m0s
[09:06:29.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:57:0)
[09:06:29.523] Timer tick, asking Buildbucket for the build status
[09:06:29.880] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:58:0) after 1m0s
[09:07:29.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:58:0)
[09:07:29.941] Timer tick, asking Buildbucket for the build status
[09:07:30.016] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:30.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:59:0) after 1m0s
[09:08:30.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:59:0)
[09:08:30.091] Timer tick, asking Buildbucket for the build status
[09:08:30.245] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:30.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:60:0) after 1m0s
[09:09:30.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:60:0)
[09:09:30.267] Timer tick, asking Buildbucket for the build status
[09:09:30.536] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:30.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:61:0) after 1m0s
[09:10:30.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:61:0)
[09:10:30.561] Timer tick, asking Buildbucket for the build status
[09:10:30.647] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:30.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:62:0) after 1m0s
[09:11:30.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:62:0)
[09:11:30.686] Timer tick, asking Buildbucket for the build status
[09:11:30.788] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:30.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:63:0) after 1m0s
[09:12:30.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:63:0)
[09:12:30.862] Timer tick, asking Buildbucket for the build status
[09:12:30.940] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:30.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:64:0) after 1m0s
[09:13:30.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:64:0)
[09:13:30.983] Timer tick, asking Buildbucket for the build status
[09:13:31.051] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:31.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:65:0) after 1m0s
[09:14:31.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:65:0)
[09:14:31.084] Timer tick, asking Buildbucket for the build status
[09:14:31.162] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:31.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:66:0) after 1m0s
[09:15:31.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:66:0)
[09:15:31.194] Timer tick, asking Buildbucket for the build status
[09:15:31.273] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:31.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:67:0) after 1m0s
[09:16:31.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:67:0)
[09:16:31.289] Timer tick, asking Buildbucket for the build status
[09:16:31.750] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:31.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:68:0) after 1m0s
[09:17:31.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:68:0)
[09:17:31.879] Timer tick, asking Buildbucket for the build status
[09:17:31.951] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:31.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:69:0) after 1m0s
[09:18:31.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:69:0)
[09:18:31.964] Timer tick, asking Buildbucket for the build status
[09:18:32.038] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:32.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:70:0) after 1m0s
[09:19:32.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:70:0)
[09:19:32.084] Timer tick, asking Buildbucket for the build status
[09:19:32.216] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:32.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:71:0) after 1m0s
[09:20:32.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:71:0)
[09:20:32.262] Timer tick, asking Buildbucket for the build status
[09:20:32.373] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:32.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:72:0) after 1m0s
[09:21:32.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:72:0)
[09:21:32.394] Timer tick, asking Buildbucket for the build status
[09:21:32.475] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:32.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:73:0) after 1m0s
[09:22:32.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:73:0)
[09:22:32.523] Timer tick, asking Buildbucket for the build status
[09:22:32.779] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:32.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:74:0) after 1m0s
[09:23:32.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:74:0)
[09:23:32.822] Timer tick, asking Buildbucket for the build status
[09:23:32.895] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:32.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:75:0) after 1m0s
[09:24:32.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:75:0)
[09:24:32.909] Timer tick, asking Buildbucket for the build status
[09:24:32.987] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:32.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:76:0) after 1m0s
[09:25:33.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:76:0)
[09:25:33.008] Timer tick, asking Buildbucket for the build status
[09:25:33.303] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:33.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:77:0) after 1m0s
[09:26:33.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:77:0)
[09:26:33.387] Timer tick, asking Buildbucket for the build status
[09:26:33.514] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:33.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:78:0) after 1m0s
[09:27:33.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:78:0)
[09:27:33.569] Timer tick, asking Buildbucket for the build status
[09:27:33.799] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:33.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:79:0) after 1m0s
[09:28:33.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:79:0)
[09:28:33.827] Timer tick, asking Buildbucket for the build status
[09:28:34.221] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:34.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:80:0) after 1m0s
[09:29:34.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:80:0)
[09:29:34.273] Timer tick, asking Buildbucket for the build status
[09:29:34.524] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:34.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:81:0) after 1m0s
[09:30:34.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:81:0)
[09:30:34.592] Timer tick, asking Buildbucket for the build status
[09:30:34.695] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:82:0) after 1m0s
[09:31:34.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:82:0)
[09:31:34.730] Timer tick, asking Buildbucket for the build status
[09:31:34.813] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:34.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:83:0) after 1m0s
[09:32:34.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:83:0)
[09:32:34.871] Timer tick, asking Buildbucket for the build status
[09:32:34.958] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:34.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:84:0) after 1m0s
[09:33:34.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:84:0)
[09:33:34.992] Timer tick, asking Buildbucket for the build status
[09:33:35.297] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:35.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:85:0) after 1m0s
[09:34:35.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:85:0)
[09:34:35.336] Timer tick, asking Buildbucket for the build status
[09:34:35.547] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:35.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:86:0) after 1m0s
[09:35:35.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:86:0)
[09:35:35.567] Timer tick, asking Buildbucket for the build status
[09:35:35.687] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:87:0) after 1m0s
[09:36:35.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:87:0)
[09:36:35.714] Timer tick, asking Buildbucket for the build status
[09:36:36.126] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:36.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:88:0) after 1m0s
[09:37:36.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:88:0)
[09:37:36.205] Timer tick, asking Buildbucket for the build status
[09:37:36.315] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:36.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:89:0) after 1m0s
[09:38:36.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:89:0)
[09:38:36.329] Timer tick, asking Buildbucket for the build status
[09:38:36.714] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:36.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:90:0) after 1m0s
[09:39:36.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:90:0)
[09:39:36.713] Timer tick, asking Buildbucket for the build status
[09:39:36.793] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:36.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:91:0) after 1m0s
[09:40:36.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:91:0)
[09:40:36.793] Timer tick, asking Buildbucket for the build status
[09:40:36.874] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:36.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:92:0) after 1m0s
[09:41:36.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:92:0)
[09:41:36.932] Timer tick, asking Buildbucket for the build status
[09:41:37.075] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:37.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:93:0) after 1m0s
[09:42:37.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:93:0)
[09:42:37.103] Timer tick, asking Buildbucket for the build status
[09:42:37.248] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:37.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:94:0) after 1m0s
[09:43:37.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:94:0)
[09:43:37.279] Timer tick, asking Buildbucket for the build status
[09:43:37.358] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:37.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:95:0) after 1m0s
[09:44:37.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:95:0)
[09:44:37.399] Timer tick, asking Buildbucket for the build status
[09:44:37.706] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:37.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:96:0) after 1m0s
[09:45:37.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:96:0)
[09:45:37.864] Timer tick, asking Buildbucket for the build status
[09:45:38.024] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:38.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:97:0) after 1m0s
[09:46:38.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:97:0)
[09:46:38.086] Timer tick, asking Buildbucket for the build status
[09:46:38.342] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:38.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:98:0) after 1m0s
[09:47:38.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:98:0)
[09:47:38.391] Timer tick, asking Buildbucket for the build status
[09:47:38.476] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:38.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:99:0) after 1m0s
[09:48:38.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:99:0)
[09:48:38.503] Timer tick, asking Buildbucket for the build status
[09:48:38.587] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:100:0) after 1m0s
[09:49:38.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:100:0)
[09:49:38.694] Timer tick, asking Buildbucket for the build status
[09:49:38.782] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:38.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:101:0) after 1m0s
[09:50:38.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:101:0)
[09:50:38.918] Timer tick, asking Buildbucket for the build status
[09:50:39.098] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:39.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:102:0) after 1m0s
[09:51:39.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:102:0)
[09:51:39.138] Timer tick, asking Buildbucket for the build status
[09:51:39.241] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:39.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:103:0) after 1m0s
[09:52:39.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:103:0)
[09:52:39.323] Timer tick, asking Buildbucket for the build status
[09:52:39.422] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:39.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:104:0) after 1m0s
[09:53:39.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:104:0)
[09:53:39.568] Timer tick, asking Buildbucket for the build status
[09:53:39.649] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:39.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:105:0) after 1m0s
[09:54:39.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:105:0)
[09:54:39.714] Timer tick, asking Buildbucket for the build status
[09:54:39.787] Build 8854973861663181104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:39.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020403923768270416:106:0) after 1m0s
[09:54:51.243] Received PubSub notification, asking Buildbucket for the build status
[09:54:51.357] Build 8854973861663181104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:54:51.357] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613642090314306",
"created_by": "project:chromium",
"created_ts": "1613635877891498",
"id": "8854973861663181104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"67bb830af3896616dd6614c8b74971ee0ccf73ba\"}}",
"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\": \"67bb830af3896616dd6614c8b74971ee0ccf73ba\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-166-b6ag\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45523, \"got_angle_revision\": \"0fa6c307ac7855a10ff95b661ca827add56e1576\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"67bb830af3896616dd6614c8b74971ee0ccf73ba\", \"got_revision_cp\": \"refs/heads/master@{#855164}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"b3177eb449cae97d92b18ffafe20dfcfce23683e\", \"got_v8_revision\": \"3fe2e9ec96b8da49a7cdeb2353c041ea3687ae2d\", \"got_v8_revision_cp\": \"refs/heads/9.0.211@{#1}\", \"got_webrtc_revision\": \"ebc563e927b0ea1db816021e83b20150c116e573\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33287}\", \"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\": \"67bb830af3896616dd6614c8b74971ee0ccf73ba\", \"swarm_hashes_refs/heads/master(at){#855164}_without_patch\": {\"absl_hardening_tests\": \"f1cc827bd2d06bc74d9371042178cbd0096107a5\", \"accessibility_unittests\": \"4e628aa6c270913636caf14d6379b03e56dc532b\", \"angle_unittests\": \"266903cb1a4aa24832e35c77d0007fa228a8aeb1\", \"app_list_unittests\": \"cc266b8b12bee3e5e2dddf09037c4da498df19ce\", \"app_shell_unittests\": \"735486ba93cd18180052c609e9198d90d2d83e93\", \"ash_unittests\": \"35b66555c88ebb77cc9030cffd7034aace0b45b9\", \"aura_unittests\": \"4089eb828e1f4bf61cde19fcca5b153de9d58c5f\", \"base_unittests\": \"bd3b0107bf14b193f4d19cc6e0e294a86873b954\", \"base_util_unittests\": \"3242eda11717254ef339adba6ab0e665f01caeaf\", \"blink_common_unittests\": \"b831e754068e476eb09f9bda9820f12e39b22f25\", \"blink_fuzzer_unittests\": \"049383596e7f71c1803e442005aacb72d04d0bc8\", \"blink_heap_unittests\": \"49e5367fc23f897a13200db9a38a6e1c45231060\", \"blink_platform_unittests\": \"d73f3115318b2f44f399ad12a747cd81c7a3f7ae\", \"blink_unittests\": \"a75ab2e7d1034e4b5960ef66540bbb0beec5884f\", \"boringssl_crypto_tests\": \"98057488342051870d6a11a6f92806c766f3313b\", \"boringssl_ssl_tests\": \"884c9fdedf5e63e11f30774df30d26c96caab268\", \"browser_tests\": \"5c95d8bd3ca3a54597291d0fcabf732fb7a2ba0e\", \"capture_unittests\": \"fa726b972148e1953a8701b5db917ce50c93eec2\", \"cast_unittests\": \"33fc26e235c464471867cd01b87015886b3df6c4\", \"cc_unittests\": \"a16e9bef1ef7c6233c4649ad2c4aa51368d37069\", \"chrome_app_unittests\": \"3675e75ffb09e0c0639def0372c84be09e3b3f38\", \"chromedriver_unittests\": \"d2e01f1aab06b351c9713c8f31a7130a0612c419\", \"chromeos_components_unittests\": \"b6831c70be8057c4f952090ba3c03c0c03fc62bf\", \"chromeos_unittests\": \"eb5dbcdc31e5af6349eb0214815a4f3116522b35\", \"components_browsertests\": \"e40e6023e5497d681c40196265a105eeb337fbd0\", \"components_unittests\": \"8339dc31b4c75eaea85aa65ced592f68f2b503aa\", \"compositor_unittests\": \"9aaa01750cd8aa067bbb4bf028983e996f9f2453\", \"content_browsertests\": \"347e905cd558e856981a9c6e23d3c1408a40aebc\", \"content_unittests\": \"c654e9dd7b094b6205f0efb65dfeb71ee353fe56\", \"crashpad_tests\": \"70dd34962cd8ec791b0562c84d2f9a778b28e2ab\", \"crypto_unittests\": \"365639d9d6f8fa0280975fb85a338c1d63e10dfa\", \"dbus_unittests\": \"ec0d97148fa040539ccc32a8ac185f122f6b11d8\", \"device_unittests\": \"6f9890b474f0b901857df1bf04b23d5592aa9ba4\", \"display_unittests\": \"377914f11fd787a4759f3f4715e3e96223c1af39\", \"events_unittests\": \"726f79737df473d2a3dfe67cf43976d6ef536046\", \"exo_unittests\": \"e41b5c24d85eccbb33f0cbf3b7268075949fb327\", \"extensions_browsertests\": \"20dee30cb06dc0be488e70836fd92d2c7ae40f65\", \"extensions_unittests\": \"a7069d0c63756668fd553e36bc1f0456acf16f7a\", \"filesystem_service_unittests\": \"29636a4d6e64e066b3e0e0ae346cf95d53c093b5\", \"gcm_unit_tests\": \"c561867c8ed1ae6b425b3ac254efed5504fc9f41\", \"gfx_unittests\": \"434013144b39e950814f789666367ee5522c47ea\", \"gin_unittests\": \"f2505f532d4ca40c53d093eb636169b67263870d\", \"gl_unittests_ozone\": \"774c807101d7d08d14ad42e3e20349f209907c10\", \"google_apis_unittests\": \"899511f2d38fdb01343b286c085969c7a36e30a6\", \"gpu_unittests\": \"ceff1707c81ff8bd626c52104c5b54aa9e77db28\", \"gwp_asan_unittests\": \"a06bed53720c6895bc53deb803979a6bac10874b\", \"interactive_ui_tests\": \"7ea18ed5c2e1544fffe5b7d8ec55978cfff94795\", \"ipc_tests\": \"c1b6bb2037d3236c590d1e848253d379bd43a488\", \"jingle_unittests\": \"4ecfe01ef451fa5f608e4e25862e735342c89ee0\", \"keyboard_unittests\": \"18520f4e6b3d542ac0a26f0a36504c5264263102\", \"latency_unittests\": \"22261c031a156378e42423e78bca132a28205721\", \"libjingle_xmpp_unittests\": \"2735260156c956df9d4a567212e9fa4035eeba19\", \"liburlpattern_unittests\": \"7078fa3405836aa1ac1b977fd659179e10309f92\", \"media_blink_unittests\": \"f5be8553cb07bc4252216b96965c6b7849d19813\", \"media_unittests\": \"bde3eb9855f0dfabe03c4e17344aaabfd3e6ddae\", \"message_center_unittests\": \"31803fdf91bb2a776450f2730c693fd5c75beedd\", \"midi_unittests\": \"da442638de69d074adb4e637f5bc5131e60c48db\", \"mojo_core_unittests\": \"1b895b5f7bcf75f6723175717a939ba69ca3dc73\", \"mojo_unittests\": \"0cbc33e824165781955ed0c0d8a03f144564953c\", \"nacl_helper_nonsfi_unittests\": \"8dcc87c5c4130b57c62d652bf35eca89af6b6ac7\", \"nacl_loader_unittests\": \"c4514eb3b6cbd2272bff899457cee79e13951a71\", \"native_theme_unittests\": \"0e0ebab1902c5b5cc2fbab33d54f50f8240dd8d2\", \"net_unittests\": \"8bc7ac321d31b6ab652320e37d912c7d66e59073\", \"ozone_gl_unittests\": \"f0bec4a346f773481d4a2bca1a89e332f3ef8f06\", \"ozone_unittests\": \"4fc47598052efdaffe4b4d2003bc4ad7a19254af\", \"ozone_x11_unittests\": \"30551afcc872a024d399f7cd5690891724ce0acd\", \"pdf_unittests\": \"4b47a9ea3e32987455893196600c97c5891c9f8e\", \"perfetto_unittests\": \"8b99151bdeeef787bfc41a283f8d385a24fd7c06\", \"ppapi_unittests\": \"4b370f66ea3e1996052310615058a4f87a4dae57\", \"printing_unittests\": \"0484e2b9c1ecf81b0d1c0df5c5f1d19f357a4e2f\", \"remoting_unittests\": \"3e7e8656973b0fcf96039db05a02a7cd7324a74d\", \"sandbox_linux_unittests\": \"f8018c7eafe873623a2df79e5d3ae85572603468\", \"service_manager_unittests\": \"683cb801af3afccc93c59ef799683796a888652f\", \"services_unittests\": \"4b3e4677329ae0be80b526f8a6b85ffcdfee29cf\", \"shell_dialogs_unittests\": \"cf46f2eb2960a0817f68246c031b65230776a09b\", \"shell_encryption_unittests\": \"5cbc6a353981f89e8a415172424e03bc4a2f2262\", \"skia_unittests\": \"fa0e36ec5b682218775b57a236602efa1c776a88\", \"snapshot_unittests\": \"abb07640ce17b30b6f701a1ac5b31d389dfaa0a6\", \"sql_unittests\": \"25cb186e495f9443d5e3a05c8d98d29213999b1a\", \"storage_unittests\": \"616a669a3add79e8927faec18192c6dbfd511887\", \"sync_integration_tests\": \"0664b32acf4b151e9bf6d8aa2cbed5715e5674af\", \"traffic_annotation_auditor_unittests\": \"b23cd96ae9f1f57fbded402b4be41ab5f46c961d\", \"ui_base_unittests\": \"339505da88f03f77f998eccd9bca61729d8a44a6\", \"ui_chromeos_unittests\": \"22d4bea88d1f826a6ba6ecfff66c5170e04a5a83\", \"ui_touch_selection_unittests\": \"c3fb3454c2d8353dbb486c3622f9b56c67c5310b\", \"unit_tests\": \"431219a8379a66afcfae1be5b12deff458f30ada\", \"url_unittests\": \"23222e4a54e9b6f4a8724cff8e5a353b0a6a50d8\", \"usage_time_limit_unittests\": \"ddfbca6c3a7d37bb794819498807bb231b9f38ad\", \"views_unittests\": \"ebd2ff04059f73725827ea78f25775ad9dce6c8a\", \"viz_unittests\": \"29b796733f438420b6a24039be97059ba173cc18\", \"wayland_client_perftests\": \"4a2026b0849eac8781326c71d513ceac59760201\", \"wm_unittests\": \"1c985603b548045cb417867fc319c2cb71b2823b\", \"wtf_unittests\": \"1921392875b8db8f943a8e9d4b92eae5c8e277ef\", \"zlib_unittests\": \"1211e596aa34b5af02db91cc86789a70f8682401\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-166-b6ag\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613636165126285",
"status": "COMPLETED",
"status_changed_ts": "1613642090812934",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45523",
"builder:linux-chromeos-rel",
"buildset:commit/git/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67bb830af3896616dd6614c8b74971ee0ccf73ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020403923768270416",
"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/8854973861663181104/+/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:51cd030c3fb7f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1613642090817425",
"url": "https://ci.chromium.org/b/8854973861663181104",
"utcnow_ts": "1613642091349032"
}
}
[09:54:51.357] Invocation finished in 1h43m34.85764881s with status SUCCEEDED