[03:13:07.401] New invocation is queued and will start shortly
[03:13:08.993] Starting the invocation (attempt 1)
[03:13:09.069] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:13:09.069] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:13:09.069] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027217454347571840",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027217454347571840",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"gitiles_ref:refs/heads/master"
]
}
[03:13:09.831] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607137989240418",
"id": "8861787391753034064",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607137989712863",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43459",
"builder:linux-chromeos-rel",
"buildset:commit/git/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027217454347571840",
"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/8861787391753034064/+/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": "1607137989712970",
"url": "https://ci.chromium.org/b/8861787391753034064",
"utcnow_ts": "1607137989821252"
}
}
[03:13:09.831] Task URL: https://ci.chromium.org/b/8861787391753034064
[03:13:09.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:2:0) after 1m0s
[03:14:09.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:2:0)
[03:14:09.922] Timer tick, asking Buildbucket for the build status
[03:14:10.038] Build 8861787391753034064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:10.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:3:0) after 1m0s
[03:15:10.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:3:0)
[03:15:10.128] Timer tick, asking Buildbucket for the build status
[03:15:10.549] Build 8861787391753034064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:10.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:4:0) after 1m0s
[03:16:10.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:4:0)
[03:16:10.624] Timer tick, asking Buildbucket for the build status
[03:16:11.250] Build 8861787391753034064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:5:0) after 1m0s
[03:17:11.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:5:0)
[03:17:11.877] Timer tick, asking Buildbucket for the build status
[03:17:12.181] Build 8861787391753034064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:12.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:6:0) after 1m0s
[03:18:04.988] Received PubSub notification, asking Buildbucket for the build status
[03:18:05.066] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:12.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:6:0)
[03:18:12.380] Timer tick, asking Buildbucket for the build status
[03:18:12.570] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:12.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:8:0) after 1m0s
[03:19:12.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:8:0)
[03:19:12.700] Timer tick, asking Buildbucket for the build status
[03:19:12.804] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:12.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:9:0) after 1m0s
[03:20:12.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:9:0)
[03:20:12.855] Timer tick, asking Buildbucket for the build status
[03:20:13.181] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:13.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:10:0) after 1m0s
[03:21:13.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:10:0)
[03:21:13.177] Timer tick, asking Buildbucket for the build status
[03:21:13.513] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:13.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:11:0) after 1m0s
[03:22:13.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:11:0)
[03:22:13.532] Timer tick, asking Buildbucket for the build status
[03:22:13.593] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:13.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:12:0) after 1m0s
[03:23:13.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:12:0)
[03:23:13.638] Timer tick, asking Buildbucket for the build status
[03:23:13.795] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:13.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:13:0) after 1m0s
[03:24:13.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:13:0)
[03:24:13.838] Timer tick, asking Buildbucket for the build status
[03:24:13.902] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:13.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:14:0) after 1m0s
[03:25:13.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:14:0)
[03:25:13.933] Timer tick, asking Buildbucket for the build status
[03:25:14.186] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:14.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:15:0) after 1m0s
[03:26:14.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:15:0)
[03:26:14.428] Timer tick, asking Buildbucket for the build status
[03:26:14.881] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:14.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:16:0) after 1m0s
[03:27:15.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:16:0)
[03:27:15.095] Timer tick, asking Buildbucket for the build status
[03:27:15.234] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:15.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:17:0) after 1m0s
[03:28:15.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:17:0)
[03:28:15.272] Timer tick, asking Buildbucket for the build status
[03:28:15.442] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:15.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:18:0) after 1m0s
[03:29:15.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:18:0)
[03:29:15.481] Timer tick, asking Buildbucket for the build status
[03:29:15.620] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:19:0) after 1m0s
[03:30:15.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:19:0)
[03:30:15.703] Timer tick, asking Buildbucket for the build status
[03:30:15.755] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:20:0) after 1m0s
[03:31:16.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:20:0)
[03:31:16.023] Timer tick, asking Buildbucket for the build status
[03:31:16.243] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:16.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:21:0) after 1m0s
[03:32:16.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:21:0)
[03:32:16.370] Timer tick, asking Buildbucket for the build status
[03:32:16.602] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:16.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:22:0) after 1m0s
[03:33:16.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:22:0)
[03:33:16.753] Timer tick, asking Buildbucket for the build status
[03:33:16.917] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:16.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:23:0) after 1m0s
[03:34:16.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:23:0)
[03:34:16.962] Timer tick, asking Buildbucket for the build status
[03:34:17.056] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:17.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:24:0) after 1m0s
[03:35:17.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:24:0)
[03:35:17.392] Timer tick, asking Buildbucket for the build status
[03:35:17.632] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:17.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:25:0) after 1m0s
[03:36:17.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:25:0)
[03:36:17.689] Timer tick, asking Buildbucket for the build status
[03:36:17.776] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:17.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:26:0) after 1m0s
[03:37:17.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:26:0)
[03:37:17.874] Timer tick, asking Buildbucket for the build status
[03:37:18.133] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:18.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:27:0) after 1m0s
[03:38:18.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:27:0)
[03:38:18.235] Timer tick, asking Buildbucket for the build status
[03:38:18.502] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:18.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:28:0) after 1m0s
[03:39:18.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:28:0)
[03:39:18.551] Timer tick, asking Buildbucket for the build status
[03:39:18.688] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:18.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:29:0) after 1m0s
[03:40:18.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:29:0)
[03:40:18.719] Timer tick, asking Buildbucket for the build status
[03:40:18.816] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:18.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:30:0) after 1m0s
[03:41:18.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:30:0)
[03:41:18.850] Timer tick, asking Buildbucket for the build status
[03:41:18.917] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:18.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:31:0) after 1m0s
[03:42:18.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:31:0)
[03:42:18.923] Timer tick, asking Buildbucket for the build status
[03:42:19.000] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:19.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:32:0) after 1m0s
[03:43:19.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:32:0)
[03:43:19.022] Timer tick, asking Buildbucket for the build status
[03:43:19.138] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:19.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:33:0) after 1m0s
[03:44:19.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:33:0)
[03:44:19.158] Timer tick, asking Buildbucket for the build status
[03:44:19.248] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:19.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:34:0) after 1m0s
[03:45:19.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:34:0)
[03:45:19.276] Timer tick, asking Buildbucket for the build status
[03:45:19.336] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:19.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:35:0) after 1m0s
[03:46:19.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:35:0)
[03:46:19.365] Timer tick, asking Buildbucket for the build status
[03:46:19.447] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:19.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:36:0) after 1m0s
[03:47:19.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:36:0)
[03:47:19.504] Timer tick, asking Buildbucket for the build status
[03:47:19.805] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:19.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:37:0) after 1m0s
[03:48:19.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:37:0)
[03:48:19.837] Timer tick, asking Buildbucket for the build status
[03:48:19.940] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:19.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:38:0) after 1m0s
[03:49:19.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:38:0)
[03:49:19.961] Timer tick, asking Buildbucket for the build status
[03:49:20.159] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:20.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:39:0) after 1m0s
[03:50:20.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:39:0)
[03:50:20.222] Timer tick, asking Buildbucket for the build status
[03:50:20.278] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:20.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:40:0) after 1m0s
[03:51:20.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:40:0)
[03:51:20.255] Timer tick, asking Buildbucket for the build status
[03:51:20.337] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:20.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:41:0) after 1m0s
[03:52:20.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:41:0)
[03:52:20.392] Timer tick, asking Buildbucket for the build status
[03:52:20.520] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:20.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:42:0) after 1m0s
[03:53:21.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:42:0)
[03:53:21.009] Timer tick, asking Buildbucket for the build status
[03:53:21.109] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:21.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:43:0) after 1m0s
[03:54:21.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:43:0)
[03:54:21.381] Timer tick, asking Buildbucket for the build status
[03:54:21.444] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:44:0) after 1m0s
[03:55:21.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:44:0)
[03:55:21.512] Timer tick, asking Buildbucket for the build status
[03:55:21.660] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:21.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:45:0) after 1m0s
[03:56:21.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:45:0)
[03:56:21.727] Timer tick, asking Buildbucket for the build status
[03:56:21.816] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:21.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:46:0) after 1m0s
[03:57:21.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:46:0)
[03:57:21.955] Timer tick, asking Buildbucket for the build status
[03:57:22.017] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:22.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:47:0) after 1m0s
[03:58:22.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:47:0)
[03:58:22.217] Timer tick, asking Buildbucket for the build status
[03:58:22.331] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:48:0) after 1m0s
[03:59:22.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:48:0)
[03:59:22.455] Timer tick, asking Buildbucket for the build status
[03:59:22.512] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:22.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:49:0) after 1m0s
[04:00:22.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:49:0)
[04:00:22.841] Timer tick, asking Buildbucket for the build status
[04:00:24.227] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:24.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:50:0) after 1m0s
[04:01:24.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:50:0)
[04:01:24.302] Timer tick, asking Buildbucket for the build status
[04:01:24.430] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:24.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:51:0) after 1m0s
[04:02:24.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:51:0)
[04:02:24.678] Timer tick, asking Buildbucket for the build status
[04:02:25.006] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:25.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:52:0) after 1m0s
[04:03:25.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:52:0)
[04:03:25.186] Timer tick, asking Buildbucket for the build status
[04:03:25.300] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:25.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:53:0) after 1m0s
[04:04:25.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:53:0)
[04:04:25.395] Timer tick, asking Buildbucket for the build status
[04:04:25.470] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:25.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:54:0) after 1m0s
[04:05:25.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:54:0)
[04:05:25.595] Timer tick, asking Buildbucket for the build status
[04:05:25.948] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:25.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:55:0) after 1m0s
[04:06:26.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:55:0)
[04:06:26.087] Timer tick, asking Buildbucket for the build status
[04:06:26.192] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:26.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:56:0) after 1m0s
[04:07:26.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:56:0)
[04:07:26.308] Timer tick, asking Buildbucket for the build status
[04:07:26.470] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:26.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:57:0) after 1m0s
[04:08:26.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:57:0)
[04:08:26.467] Timer tick, asking Buildbucket for the build status
[04:08:27.012] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:27.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:58:0) after 1m0s
[04:09:27.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:58:0)
[04:09:27.108] Timer tick, asking Buildbucket for the build status
[04:09:27.234] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:27.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:59:0) after 1m0s
[04:10:27.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:59:0)
[04:10:27.264] Timer tick, asking Buildbucket for the build status
[04:10:27.314] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:27.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:60:0) after 1m0s
[04:11:27.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:60:0)
[04:11:27.337] Timer tick, asking Buildbucket for the build status
[04:11:27.447] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:27.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:61:0) after 1m0s
[04:12:27.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:61:0)
[04:12:27.519] Timer tick, asking Buildbucket for the build status
[04:12:27.580] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:27.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:62:0) after 1m0s
[04:13:27.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:62:0)
[04:13:27.655] Timer tick, asking Buildbucket for the build status
[04:13:27.747] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:27.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:63:0) after 1m0s
[04:14:27.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:63:0)
[04:14:27.770] Timer tick, asking Buildbucket for the build status
[04:14:28.012] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:28.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:64:0) after 1m0s
[04:15:28.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:64:0)
[04:15:28.162] Timer tick, asking Buildbucket for the build status
[04:15:29.540] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:29.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:65:0) after 1m0s
[04:16:29.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:65:0)
[04:16:29.649] Timer tick, asking Buildbucket for the build status
[04:16:29.717] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:29.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:66:0) after 1m0s
[04:17:29.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:66:0)
[04:17:29.778] Timer tick, asking Buildbucket for the build status
[04:17:30.082] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:30.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:67:0) after 1m0s
[04:18:30.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:67:0)
[04:18:30.118] Timer tick, asking Buildbucket for the build status
[04:18:30.236] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:30.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:68:0) after 1m0s
[04:19:30.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:68:0)
[04:19:30.288] Timer tick, asking Buildbucket for the build status
[04:19:30.346] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:30.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:69:0) after 1m0s
[04:20:30.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:69:0)
[04:20:30.398] Timer tick, asking Buildbucket for the build status
[04:20:30.634] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:30.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:70:0) after 1m0s
[04:21:30.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:70:0)
[04:21:30.702] Timer tick, asking Buildbucket for the build status
[04:21:30.763] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:30.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:71:0) after 1m0s
[04:22:30.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:71:0)
[04:22:30.849] Timer tick, asking Buildbucket for the build status
[04:22:31.673] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:31.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:72:0) after 1m0s
[04:23:31.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:72:0)
[04:23:31.709] Timer tick, asking Buildbucket for the build status
[04:23:31.854] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:73:0) after 1m0s
[04:24:31.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:73:0)
[04:24:31.875] Timer tick, asking Buildbucket for the build status
[04:24:31.952] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:74:0) after 1m0s
[04:25:32.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:74:0)
[04:25:32.009] Timer tick, asking Buildbucket for the build status
[04:25:32.301] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:75:0) after 1m0s
[04:26:32.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:75:0)
[04:26:32.395] Timer tick, asking Buildbucket for the build status
[04:26:32.480] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:32.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:76:0) after 1m0s
[04:27:32.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:76:0)
[04:27:32.568] Timer tick, asking Buildbucket for the build status
[04:27:32.940] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:32.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:77:0) after 1m0s
[04:28:32.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:77:0)
[04:28:32.960] Timer tick, asking Buildbucket for the build status
[04:28:33.238] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:33.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:78:0) after 1m0s
[04:29:33.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:78:0)
[04:29:33.229] Timer tick, asking Buildbucket for the build status
[04:29:33.308] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:33.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:79:0) after 1m0s
[04:30:33.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:79:0)
[04:30:33.354] Timer tick, asking Buildbucket for the build status
[04:30:33.438] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:33.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:80:0) after 1m0s
[04:31:33.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:80:0)
[04:31:33.518] Timer tick, asking Buildbucket for the build status
[04:31:33.725] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:33.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:81:0) after 1m0s
[04:32:33.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:81:0)
[04:32:33.733] Timer tick, asking Buildbucket for the build status
[04:32:33.787] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:33.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:82:0) after 1m0s
[04:33:33.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:82:0)
[04:33:33.855] Timer tick, asking Buildbucket for the build status
[04:33:33.961] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:33.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:83:0) after 1m0s
[04:34:34.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:83:0)
[04:34:34.062] Timer tick, asking Buildbucket for the build status
[04:34:34.116] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:34.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:84:0) after 1m0s
[04:35:34.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:84:0)
[04:35:34.159] Timer tick, asking Buildbucket for the build status
[04:35:34.251] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:34.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:85:0) after 1m0s
[04:36:34.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:85:0)
[04:36:34.338] Timer tick, asking Buildbucket for the build status
[04:36:34.717] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:34.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:86:0) after 1m0s
[04:37:34.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:86:0)
[04:37:34.867] Timer tick, asking Buildbucket for the build status
[04:37:34.956] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:34.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:87:0) after 1m0s
[04:38:35.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:87:0)
[04:38:35.206] Timer tick, asking Buildbucket for the build status
[04:38:35.373] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:35.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:88:0) after 1m0s
[04:39:35.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:88:0)
[04:39:35.403] Timer tick, asking Buildbucket for the build status
[04:39:35.505] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:35.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:89:0) after 1m0s
[04:40:35.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:89:0)
[04:40:35.556] Timer tick, asking Buildbucket for the build status
[04:40:36.129] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:36.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:90:0) after 1m0s
[04:41:36.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:90:0)
[04:41:36.317] Timer tick, asking Buildbucket for the build status
[04:41:36.441] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:91:0) after 1m0s
[04:42:36.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:91:0)
[04:42:36.525] Timer tick, asking Buildbucket for the build status
[04:42:36.696] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:92:0) after 1m0s
[04:43:36.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:92:0)
[04:43:36.729] Timer tick, asking Buildbucket for the build status
[04:43:37.202] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:93:0) after 1m0s
[04:44:37.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:93:0)
[04:44:37.234] Timer tick, asking Buildbucket for the build status
[04:44:37.372] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:37.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:94:0) after 1m0s
[04:45:37.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:94:0)
[04:45:37.478] Timer tick, asking Buildbucket for the build status
[04:45:37.572] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:37.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:95:0) after 1m0s
[04:46:37.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:95:0)
[04:46:37.718] Timer tick, asking Buildbucket for the build status
[04:46:38.374] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:38.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:96:0) after 1m0s
[04:47:38.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:96:0)
[04:47:38.518] Timer tick, asking Buildbucket for the build status
[04:47:38.628] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:38.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:97:0) after 1m0s
[04:48:38.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:97:0)
[04:48:38.757] Timer tick, asking Buildbucket for the build status
[04:48:39.106] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:39.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:98:0) after 1m0s
[04:49:39.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:98:0)
[04:49:39.162] Timer tick, asking Buildbucket for the build status
[04:49:39.630] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:39.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:99:0) after 1m0s
[04:50:39.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:99:0)
[04:50:39.692] Timer tick, asking Buildbucket for the build status
[04:50:39.832] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:39.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:100:0) after 1m0s
[04:51:39.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:100:0)
[04:51:39.920] Timer tick, asking Buildbucket for the build status
[04:51:40.101] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:40.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:101:0) after 1m0s
[04:52:40.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:101:0)
[04:52:40.161] Timer tick, asking Buildbucket for the build status
[04:52:40.524] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:40.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:102:0) after 1m0s
[04:53:40.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:102:0)
[04:53:40.542] Timer tick, asking Buildbucket for the build status
[04:53:40.851] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:40.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:103:0) after 1m0s
[04:54:40.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:103:0)
[04:54:40.885] Timer tick, asking Buildbucket for the build status
[04:54:41.007] Build 8861787391753034064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:41.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027217454347571840:104:0) after 1m0s
[04:55:38.503] Received PubSub notification, asking Buildbucket for the build status
[04:55:38.941] Build 8861787391753034064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:55:38.941] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607144136146028",
"created_by": "project:chromium",
"created_ts": "1607137989240418",
"id": "8861787391753034064",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\"}}",
"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\": \"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\", \"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-52-t3pm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43459, \"got_angle_revision\": \"c859c0ac81bbca2066fcaeb6efa48eece5c10103\", \"got_dawn_revision\": \"c532048062befdee8bb57d18f01d3a3c403d49de\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\", \"got_revision_cp\": \"refs/heads/master@{#833979}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"74335e5d59d2ecfe8e1c63509d0c2e4947d493d8\", \"swarm_hashes_refs/heads/master(at){#833979}_without_patch\": {\"absl_hardening_tests\": \"6d06764c2431c4875220577096afaa6c709f8332\", \"accessibility_unittests\": \"7689b14a045aee83f6fd5f5bc8ee618ed2951df4\", \"angle_unittests\": \"626a9e06a78e68d30282663e1f7011adf1ad8eed\", \"app_list_unittests\": \"cfa55314e94ba82a53f65bf8eb68a779f66a7f89\", \"app_shell_unittests\": \"ed2afd30d9d663f80a981cbcc4363eaf35c89c3a\", \"ash_unittests\": \"fb83dd48472bf62207b5327eade9ef916772445c\", \"aura_unittests\": \"031db4862ad220355cd750d1ec08a38fb8ad5376\", \"base_unittests\": \"33550542f5f4d612138ad8776f375fc57ceb4cf7\", \"base_util_unittests\": \"2e8be2d69133587afc998c3423a631d6546c4b62\", \"blink_common_unittests\": \"88583c165c6c3544933518657db21c3bf81661da\", \"blink_fuzzer_unittests\": \"00f0f06242bd262e8f57564a4890264e4debf49e\", \"blink_heap_unittests\": \"c146a481707004261436482f9b891f1e54fb80d2\", \"blink_platform_unittests\": \"6f03eef312e238795455bdc50d6bf8e0c481e524\", \"blink_unittests\": \"0ad9a87434b358fcd2b884b69ad69626e91930b1\", \"boringssl_crypto_tests\": \"049e786d677d2c3d67cd485881ca983eb5f374ef\", \"boringssl_ssl_tests\": \"67f17125db496d440235f2b7a1d398485a22677e\", \"browser_tests\": \"7761bb7efd540571ee00a01f514c6233b347708e\", \"capture_unittests\": \"48487257fe8c19351cc8722462d8d787946663ae\", \"cast_unittests\": \"63495456c7b642251fe4f296c53211207993f2bf\", \"cc_unittests\": \"e44f12876376886950bd8620466d41f832d7f85e\", \"chrome_app_unittests\": \"b0cde5a047e5a63185bc1470b32a40d2417e0af7\", \"chromedriver_unittests\": \"757350272d8e6d3b6727e664b1f88d81c2a537a1\", \"chromeos_components_unittests\": \"bc414cccbf53e8e4eb358870aeba4f84c4824186\", \"chromeos_unittests\": \"d7beb95fdde76a9b0918055c0fe61cc15108ea1d\", \"components_browsertests\": \"f9d518d349ff24b5edf40fa4137dd2d957470dac\", \"components_unittests\": \"ae700f87bbefbb247168c32db8d7448f0616d0a6\", \"compositor_unittests\": \"e189aa93b760a62f3a8e355a1379b2bc63b40d38\", \"content_browsertests\": \"17c3f9c256ae587672e79b3f24914c990fc57bc6\", \"content_unittests\": \"ab78778e3352220644d05ffbdfaf40c4eb971dea\", \"crashpad_tests\": \"63be958f8cdb8566e6a62bb9dc96485914758a02\", \"crypto_unittests\": \"4a56221996fc424edd008d1874ec6b0d5f2cbd8f\", \"dbus_unittests\": \"26c9bc7318d656d92f4114c8a7e79a7104a642fe\", \"device_unittests\": \"189dd2b1b66ee372dc1020a835f4e8f84347dff4\", \"display_unittests\": \"b6b23247cbb3efb48253c524d72699ea14ac20c6\", \"events_unittests\": \"529fcd874c96244f3723672730dd56655f8404ce\", \"exo_unittests\": \"9cc7bcc636cf7ef8857da6958154e5f3f353addd\", \"extensions_browsertests\": \"1286977237f65a4bd3317a98da1e85bf2b41cca3\", \"extensions_unittests\": \"3622c6d1dc718d10fe48705bbccb2effb22bbe49\", \"filesystem_service_unittests\": \"14d98e911bd890fa0e82b0931bfdddfdf6b28ab2\", \"gcm_unit_tests\": \"a36a54eaf2303fb7ff796759daf2a20e686685aa\", \"gfx_unittests\": \"8762152bf3a4d0ec1bc43f1caa8a6d596a0fdf9b\", \"gin_unittests\": \"24590cb2470635e64d58a11b90ccdc3ef9a6a8ce\", \"gl_unittests_ozone\": \"d7c96757b36b8a8b7a8d1f5463ea521aadca435b\", \"google_apis_unittests\": \"1723f0683a46c7a2397d81c2d362bfbda50afff8\", \"gpu_unittests\": \"50b3163c64d9ae30af8488b727a12b502e2c4524\", \"gwp_asan_unittests\": \"7cc6a64de41098c96d401e1cbb53c59f1dc669ec\", \"interactive_ui_tests\": \"f105b8d649155919c84915b301e484dfd72e43b1\", \"ipc_tests\": \"f3dcfd406da1e3ff61da80a5e49734af54efe535\", \"jingle_unittests\": \"b75259d18cb4a34197d3422f09c3a3af4baf5060\", \"keyboard_unittests\": \"1616fbb4cdededd8b08bfce984f88852eaf0b4d9\", \"latency_unittests\": \"48478afe8b520cd35b81cf7a76f991f56dd1a169\", \"libjingle_xmpp_unittests\": \"1479ecd1c01feb17dbc2f2c1298e39c57622dc4e\", \"liburlpattern_unittests\": \"88c1d773d027f8cb642ae0b597ee9201cdc53759\", \"media_blink_unittests\": \"44d83cd08ea1e293cdf94b3f803bad34188c655a\", \"media_unittests\": \"381e89628bdcc4d48e5365f7bcbac4dcaa775da7\", \"message_center_unittests\": \"0b459735ca2fb77f798ced94c8464afbb2c66770\", \"midi_unittests\": \"a91db25bd493154b235041cffb681a8c456e6113\", \"mojo_core_unittests\": \"d43b3498cfe1e7d077eeaa13361fe3d972f57aea\", \"mojo_unittests\": \"5eec74afc0fe78823ec0765fadb31658038ea4a3\", \"nacl_helper_nonsfi_unittests\": \"2c1ef58341ff106449306546e51708e7885584e7\", \"nacl_loader_unittests\": \"ca93b5e599e1721d6c85ecb14b35e863e98808ee\", \"native_theme_unittests\": \"39a6f49b794ed8e1dd9750e8ff5707e2518f992a\", \"net_unittests\": \"95eac12244fd8a58fd76761cf46dad2508e99a60\", \"ozone_gl_unittests\": \"d79f5ca87384e9740d194e3a057fa1a75a95207b\", \"ozone_unittests\": \"eef3eff2a2ddf0e14db06a321eeb0ed52f712c32\", \"ozone_x11_unittests\": \"b5bb0e0e987984574e607b642ad4ad1e4f0a75b8\", \"pdf_unittests\": \"d540ba05c9c574cf9a865f964e902edf468698ad\", \"perfetto_unittests\": \"d5e8fd00e704b1d16ddc1eda81de9c208d670a1a\", \"ppapi_unittests\": \"1ba59b2c6d02131033c6c2a744ac4f2fe9a76d5f\", \"printing_unittests\": \"eab588515d82aa534dfc68ccded40266640a64fe\", \"remoting_unittests\": \"5edf4bf0932fd60858509592ca9dcf39090b5ada\", \"sandbox_linux_unittests\": \"a4a3614355f5c1a2e341fac584f8f7b8a78237c8\", \"service_manager_unittests\": \"09b2cfa73b28d3d1d1a104b3e4c043494fc190c3\", \"services_unittests\": \"337f4ae81897c11bcab2edbdac2cdcd93977cf31\", \"shell_dialogs_unittests\": \"5902d3530a7fa26e3c17924446060f7981ca3f88\", \"shell_encryption_unittests\": \"c83859fef7b69e7ce05ea1f25fc45534d5b3a290\", \"skia_unittests\": \"fa4e7a449f817ddf579e4b831713ad9dbf96b3b1\", \"snapshot_unittests\": \"cc182713515c8707a2cfa746b86449e222dda777\", \"sql_unittests\": \"336c6b6d609f688633e14a938137cb1bc1426a88\", \"storage_unittests\": \"ab8e4afcf08ffed03a95e25023d51a1447b254b5\", \"sync_integration_tests\": \"cd10dd68e1d0de8d896de1a93d7cb9d5d1932111\", \"traffic_annotation_auditor_unittests\": \"64bc0ca4e12ae3d73af1f1fcf079f7607b441cbf\", \"ui_base_unittests\": \"3763d9e5fd53b42a95d52210f8fe8db16c81bd94\", \"ui_chromeos_unittests\": \"28460cd50fdaafbb64f055c7f9b77e0898d74e5b\", \"ui_touch_selection_unittests\": \"603fe35e1a2af3d8b64a8ea57e60561e8fd1aa55\", \"unit_tests\": \"9c8735b12bd7d20e73ffd6c9889da63bc81b5206\", \"url_unittests\": \"23231d68c3ccf0c19814bd5333386f7cefc1f49c\", \"usage_time_limit_unittests\": \"2e755c378a86de361f80e473b6a1cc8ec2b206a9\", \"views_unittests\": \"21bfdb965f6b5bb6b18917dd98f19957a0b34618\", \"viz_unittests\": \"efb67e483b38bd25a11be79ed52956ebd2b789ce\", \"wayland_client_perftests\": \"c6b83ceedf8b3de309a94f42d6ed47c3837598f7\", \"wm_unittests\": \"7e3773cd34136e8bc943cc24a06f662ac38deaab\", \"wtf_unittests\": \"47353affaf800d402d5acf86859e47949515891b\", \"zlib_unittests\": \"eaff9779b98c7fb14dd536444ca3c1a054cf45d1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"builder_f568157a4ec00fb9568da05a054c670841713183d1f68e80f18d1b79a7a19e1f_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-52-t3pm\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607138284303897",
"status": "COMPLETED",
"status_changed_ts": "1607144136705684",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43459",
"builder:linux-chromeos-rel",
"buildset:commit/git/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/74335e5d59d2ecfe8e1c63509d0c2e4947d493d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027217454347571840",
"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/8861787391753034064/+/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:5049b51d3f5bb710",
"user_agent:luci-scheduler"
],
"updated_ts": "1607144136784487",
"url": "https://ci.chromium.org/b/8861787391753034064",
"utcnow_ts": "1607144138920141"
}
}
[04:55:38.941] Invocation finished in 1h42m31.558482438s with status SUCCEEDED