[05:31:56.554] New invocation is queued and will start shortly
[05:31:57.675] Starting the invocation (attempt 1)
[05:31:57.713] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:31:57.713] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:31:57.713] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021591708676927760",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021591708676927760",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"gitiles_ref:refs/heads/master"
]
}
[05:31:58.246] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612503117790338",
"id": "8856161646718040048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612503118132287",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45157",
"builder:linux-chromeos-rel",
"buildset:commit/git/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021591708676927760",
"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/8856161646718040048/+/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": "1612503118132400",
"url": "https://ci.chromium.org/b/8856161646718040048",
"utcnow_ts": "1612503118240084"
}
}
[05:31:58.246] Task URL: https://ci.chromium.org/b/8856161646718040048
[05:31:58.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:2:0) after 1m0s
[05:32:47.432] Received PubSub notification, asking Buildbucket for the build status
[05:32:47.528] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:58.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:2:0)
[05:32:58.246] Timer tick, asking Buildbucket for the build status
[05:32:58.319] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:58.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:4:0) after 1m0s
[05:33:58.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:4:0)
[05:33:58.405] Timer tick, asking Buildbucket for the build status
[05:33:58.485] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:58.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:5:0) after 1m0s
[05:34:58.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:5:0)
[05:34:58.661] Timer tick, asking Buildbucket for the build status
[05:34:58.729] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:58.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:6:0) after 1m0s
[05:35:58.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:6:0)
[05:35:58.855] Timer tick, asking Buildbucket for the build status
[05:35:58.973] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:58.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:7:0) after 1m0s
[05:36:58.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:7:0)
[05:36:58.992] Timer tick, asking Buildbucket for the build status
[05:36:59.484] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:59.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:8:0) after 1m0s
[05:37:59.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:8:0)
[05:37:59.515] Timer tick, asking Buildbucket for the build status
[05:37:59.633] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:59.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:9:0) after 1m0s
[05:38:59.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:9:0)
[05:38:59.652] Timer tick, asking Buildbucket for the build status
[05:38:59.989] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:59.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:10:0) after 1m0s
[05:40:00.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:10:0)
[05:40:00.065] Timer tick, asking Buildbucket for the build status
[05:40:00.140] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:00.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:11:0) after 1m0s
[05:41:00.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:11:0)
[05:41:00.163] Timer tick, asking Buildbucket for the build status
[05:41:00.316] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:00.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:12:0) after 1m0s
[05:42:00.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:12:0)
[05:42:00.393] Timer tick, asking Buildbucket for the build status
[05:42:00.595] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:00.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:13:0) after 1m0s
[05:43:01.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:13:0)
[05:43:01.188] Timer tick, asking Buildbucket for the build status
[05:43:01.323] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:01.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:14:0) after 1m0s
[05:44:01.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:14:0)
[05:44:01.368] Timer tick, asking Buildbucket for the build status
[05:44:01.441] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:01.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:15:0) after 1m0s
[05:45:01.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:15:0)
[05:45:01.497] Timer tick, asking Buildbucket for the build status
[05:45:01.589] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:01.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:16:0) after 1m0s
[05:46:01.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:16:0)
[05:46:01.587] Timer tick, asking Buildbucket for the build status
[05:46:01.839] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:01.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:17:0) after 1m0s
[05:47:01.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:17:0)
[05:47:01.956] Timer tick, asking Buildbucket for the build status
[05:47:02.057] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:02.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:18:0) after 1m0s
[05:48:02.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:18:0)
[05:48:02.213] Timer tick, asking Buildbucket for the build status
[05:48:02.579] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:02.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:19:0) after 1m0s
[05:49:02.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:19:0)
[05:49:02.703] Timer tick, asking Buildbucket for the build status
[05:49:02.922] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:02.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:20:0) after 1m0s
[05:50:03.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:20:0)
[05:50:03.056] Timer tick, asking Buildbucket for the build status
[05:50:03.246] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:03.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:21:0) after 1m0s
[05:51:03.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:21:0)
[05:51:03.332] Timer tick, asking Buildbucket for the build status
[05:51:03.543] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:03.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:22:0) after 1m0s
[05:52:03.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:22:0)
[05:52:03.658] Timer tick, asking Buildbucket for the build status
[05:52:03.956] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:03.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:23:0) after 1m0s
[05:53:04.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:23:0)
[05:53:04.175] Timer tick, asking Buildbucket for the build status
[05:53:04.293] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:04.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:24:0) after 1m0s
[05:54:04.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:24:0)
[05:54:04.397] Timer tick, asking Buildbucket for the build status
[05:54:04.454] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:04.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:25:0) after 1m0s
[05:55:04.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:25:0)
[05:55:04.644] Timer tick, asking Buildbucket for the build status
[05:55:04.705] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:04.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:26:0) after 1m0s
[05:56:04.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:26:0)
[05:56:04.938] Timer tick, asking Buildbucket for the build status
[05:56:05.039] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:05.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:27:0) after 1m0s
[05:57:05.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:27:0)
[05:57:05.429] Timer tick, asking Buildbucket for the build status
[05:57:05.570] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:05.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:28:0) after 1m0s
[05:58:05.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:28:0)
[05:58:05.636] Timer tick, asking Buildbucket for the build status
[05:58:05.689] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:05.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:29:0) after 1m0s
[05:59:05.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:29:0)
[05:59:05.805] Timer tick, asking Buildbucket for the build status
[05:59:05.941] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:05.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:30:0) after 1m0s
[06:00:06.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:30:0)
[06:00:06.052] Timer tick, asking Buildbucket for the build status
[06:00:06.129] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:06.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:31:0) after 1m0s
[06:01:07.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:31:0)
[06:01:07.512] Timer tick, asking Buildbucket for the build status
[06:01:07.579] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:07.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:32:0) after 1m0s
[06:02:07.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:32:0)
[06:02:07.620] Timer tick, asking Buildbucket for the build status
[06:02:07.841] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:07.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:33:0) after 1m0s
[06:03:07.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:33:0)
[06:03:07.853] Timer tick, asking Buildbucket for the build status
[06:03:08.097] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:08.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:34:0) after 1m0s
[06:04:08.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:34:0)
[06:04:08.140] Timer tick, asking Buildbucket for the build status
[06:04:08.282] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:08.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:35:0) after 1m0s
[06:05:08.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:35:0)
[06:05:08.305] Timer tick, asking Buildbucket for the build status
[06:05:08.405] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:08.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:36:0) after 1m0s
[06:06:08.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:36:0)
[06:06:08.446] Timer tick, asking Buildbucket for the build status
[06:06:08.628] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:08.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:37:0) after 1m0s
[06:07:08.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:37:0)
[06:07:08.686] Timer tick, asking Buildbucket for the build status
[06:07:08.786] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:08.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:38:0) after 1m0s
[06:08:08.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:38:0)
[06:08:08.809] Timer tick, asking Buildbucket for the build status
[06:08:09.079] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:09.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:39:0) after 1m0s
[06:09:09.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:39:0)
[06:09:09.087] Timer tick, asking Buildbucket for the build status
[06:09:09.142] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:09.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:40:0) after 1m0s
[06:10:09.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:40:0)
[06:10:09.190] Timer tick, asking Buildbucket for the build status
[06:10:09.509] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:09.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:41:0) after 1m0s
[06:11:09.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:41:0)
[06:11:09.506] Timer tick, asking Buildbucket for the build status
[06:11:09.603] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:09.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:42:0) after 1m0s
[06:12:09.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:42:0)
[06:12:09.693] Timer tick, asking Buildbucket for the build status
[06:12:09.779] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:09.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:43:0) after 1m0s
[06:13:09.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:43:0)
[06:13:09.936] Timer tick, asking Buildbucket for the build status
[06:13:10.022] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:10.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:44:0) after 1m0s
[06:14:10.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:44:0)
[06:14:10.066] Timer tick, asking Buildbucket for the build status
[06:14:10.181] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:10.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:45:0) after 1m0s
[06:15:10.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:45:0)
[06:15:10.243] Timer tick, asking Buildbucket for the build status
[06:15:10.383] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:10.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:46:0) after 1m0s
[06:16:10.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:46:0)
[06:16:10.428] Timer tick, asking Buildbucket for the build status
[06:16:10.535] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:10.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:47:0) after 1m0s
[06:17:10.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:47:0)
[06:17:10.559] Timer tick, asking Buildbucket for the build status
[06:17:11.197] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:11.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:48:0) after 1m0s
[06:18:11.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:48:0)
[06:18:11.240] Timer tick, asking Buildbucket for the build status
[06:18:11.375] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:49:0) after 1m0s
[06:19:11.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:49:0)
[06:19:11.411] Timer tick, asking Buildbucket for the build status
[06:19:11.731] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:11.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:50:0) after 1m0s
[06:20:11.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:50:0)
[06:20:11.787] Timer tick, asking Buildbucket for the build status
[06:20:11.882] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:11.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:51:0) after 1m0s
[06:21:11.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:51:0)
[06:21:11.890] Timer tick, asking Buildbucket for the build status
[06:21:11.992] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:11.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:52:0) after 1m0s
[06:22:11.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:52:0)
[06:22:11.997] Timer tick, asking Buildbucket for the build status
[06:22:12.719] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:12.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:53:0) after 1m0s
[06:23:12.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:53:0)
[06:23:12.741] Timer tick, asking Buildbucket for the build status
[06:23:12.850] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:12.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:54:0) after 1m0s
[06:24:12.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:54:0)
[06:24:12.868] Timer tick, asking Buildbucket for the build status
[06:24:12.988] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:12.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:55:0) after 1m0s
[06:25:13.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:55:0)
[06:25:13.019] Timer tick, asking Buildbucket for the build status
[06:25:13.114] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:13.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:56:0) after 1m0s
[06:26:13.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:56:0)
[06:26:13.158] Timer tick, asking Buildbucket for the build status
[06:26:13.285] Build 8856161646718040048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021591708676927760:57:0) after 1m0s
[06:26:39.970] Received PubSub notification, asking Buildbucket for the build status
[06:26:46.291] Build 8856161646718040048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:26:46.291] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612506399250461",
"created_by": "project:chromium",
"created_ts": "1612503117790338",
"id": "8856161646718040048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\"}}",
"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\": \"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-11-1hhh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45157, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"4846281d3680e1e34ffeebe556ca25c285bc1151\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\", \"got_revision_cp\": \"refs/heads/master@{#850987}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"3d9850164408ec1c4b4ea60c4515b85853853794\", \"got_v8_revision_cp\": \"refs/heads/9.0.134@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"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\": \"bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37\", \"swarm_hashes_refs/heads/master(at){#850987}_without_patch\": {\"absl_hardening_tests\": \"50ea55918d994efcc3c7442153a7269cb2d02a4c\", \"accessibility_unittests\": \"97355605dbf330d1ec095166241d42e22f9657ae\", \"angle_unittests\": \"475454449104a651e933f937f3d9a468e6f442eb\", \"app_list_unittests\": \"327f05d7a81f802154bc8a3cef6600bf27467804\", \"app_shell_unittests\": \"05cf62265245144aac576886d6d533eb3ec75707\", \"ash_unittests\": \"8a1569449eabc8364687e05fb71e9d0ac0761197\", \"aura_unittests\": \"6ee3c88329fd59b1f361518a6cf3f68bdf779567\", \"base_unittests\": \"747d5946bcc9409baa58b98d3e36e8b226c1e31c\", \"base_util_unittests\": \"a2d3f8e1bc33fc73a837832db8692c28e6e6cef9\", \"blink_common_unittests\": \"39188e0806e3476a54184e2e244b94a0a5f16886\", \"blink_fuzzer_unittests\": \"fc6469c3b3c819132bbbcfe51b18f4b6fb611bf2\", \"blink_heap_unittests\": \"d6620229809542f2b1ce02a300f04d7997680054\", \"blink_platform_unittests\": \"a2efd547a31f092ada5aa31c0fd491cacca6c320\", \"blink_unittests\": \"56a554288694a6536224fdb7089a8ab730cc72fd\", \"boringssl_crypto_tests\": \"9b048cd0c2ecbf4908dd7085b530fae1269d3e4e\", \"boringssl_ssl_tests\": \"513ac35d265fab0667489aae001a52f9db8d2d29\", \"browser_tests\": \"02bd9702b52df0cfcc92c63ce28ded452d8bbea9\", \"capture_unittests\": \"f8c10ef0e81bf33eebed8bcfff131c45915461d6\", \"cast_unittests\": \"6e2dbb4f616fe61070ca0b79ab762a42a39f3341\", \"cc_unittests\": \"1d79ef9ca61ae062802455b8823c231c69c25f09\", \"chrome_app_unittests\": \"ae1eaf3d286eea0ffab2e93f03b71643fc0d4be4\", \"chromedriver_unittests\": \"3d7d0f64ed5b75ceb78e4d833e6e6ccee67cba3f\", \"chromeos_components_unittests\": \"682becf03976a6e23a50712d5f5eb3bf51890d90\", \"chromeos_unittests\": \"5544307e1e43ae18d4050faae33c51df4c96514e\", \"components_browsertests\": \"3add46549d16d597233d59f4e2a2777399fb6560\", \"components_unittests\": \"d2df7e36fadefd0a5ab94037cbeddfb5fddd2baf\", \"compositor_unittests\": \"ec8ccb98275be3fc82fe4bd3b7099d987c058eca\", \"content_browsertests\": \"fb9221d4e5916cd77adf287ab7bd2bdc599f41fc\", \"content_unittests\": \"4aa8635ef8b47425b3d9e1394156bd50bdc3efad\", \"crashpad_tests\": \"4900d7528ce0a075865c27ae53ec1fe4ac50cbb1\", \"crypto_unittests\": \"acca23d291c25cadb5f9c7d9511f8840373af146\", \"dbus_unittests\": \"b5db0d44050b3527f81d039171bc15dd6b84c88b\", \"device_unittests\": \"a1886c8718a513dd677795e96973d8a7f1355950\", \"display_unittests\": \"7f4d8553041bb8239b9870785280db95a398ef62\", \"events_unittests\": \"e40c2de6f46cf97995df67ab7d9be500de2d20cc\", \"exo_unittests\": \"6083f35030a5b76ffde6d75c171f1f70fa6d65db\", \"extensions_browsertests\": \"a195eeb0604e65465c77313872ea4d067f40b350\", \"extensions_unittests\": \"d882b81bdbe7fc7a067477332efe01003f03e6de\", \"filesystem_service_unittests\": \"53972dbddaea0a808155338f0a1edb73078885ae\", \"gcm_unit_tests\": \"381e2d0b3ae50a214c16fabf0366a425ce1967b7\", \"gfx_unittests\": \"366abb2c783ada8928f26ee855c238fe27d8b6b6\", \"gin_unittests\": \"420082d2e04f7da2fddd5fe2d4fbdb12dd539aae\", \"gl_unittests_ozone\": \"39a90f74a68ac40c53fd246d21ccd296ca2d3f1d\", \"google_apis_unittests\": \"a741d76d439f5f0846012125c2edb9860617fc76\", \"gpu_unittests\": \"3bb9e36ee35de7c27c1de454786c05d11436c54b\", \"gwp_asan_unittests\": \"818651ba2fab79350197afdbd85ebe4f724cfec9\", \"interactive_ui_tests\": \"841a54774ca4fe5c6cce966715b452a0feefe386\", \"ipc_tests\": \"bba9521dc633dbe3ff41b3c4701895ee3bc02513\", \"jingle_unittests\": \"217a7b5c97626d02b793e63d6f498670cecf6d4c\", \"keyboard_unittests\": \"e8355ea7d93bc3169374d0e4cb671e645168880a\", \"latency_unittests\": \"be59e0202483f40d2e0913fbc78c39f2298dd715\", \"libjingle_xmpp_unittests\": \"b8b8c595093a94f597d9db752d8e9bb3c3c8d6e9\", \"liburlpattern_unittests\": \"18bfe530990bc618de084bfed0cd7b4249c73b62\", \"media_blink_unittests\": \"2efd3a4a2fdc3c5f93ede99a0e49e9dd952f93c8\", \"media_unittests\": \"a5c25f8e89c9a57f7ae5ec68e4a1a12719a2a7f5\", \"message_center_unittests\": \"d4a8b52190328294853da78d7fb9b5b6b23e220a\", \"midi_unittests\": \"5c52b3c2cce51f00b8364d46b0dc9be051de9698\", \"mojo_core_unittests\": \"a5f6942bf7f744444211bddf08876a1fdf03660a\", \"mojo_unittests\": \"9f89fff9a9f4d580ddec945a68d4861c6152cc35\", \"nacl_helper_nonsfi_unittests\": \"d236ef2b1c50e273d4cf59d9a14273f93717634e\", \"nacl_loader_unittests\": \"40daf822d899a7ce3ea731b2545e51adac848863\", \"native_theme_unittests\": \"ded3588c99cd516f5551305918d23c268c8e7fd3\", \"net_unittests\": \"2c6be8880af957cfa7674b118435e29c4c59eb3b\", \"ozone_gl_unittests\": \"c2df7c15672cb91f9190de7141c601a6d8e6c939\", \"ozone_unittests\": \"ec8b36f4511da0d2d7a5680069880b0e7fbc5611\", \"ozone_x11_unittests\": \"636d7071f5cc8a773c059a6931d4f78d7c74750e\", \"pdf_unittests\": \"0938eaade0a98425a3bb0cdf8c000d6a38dedc6d\", \"perfetto_unittests\": \"9d6bd69b472896e890951fe906315039a5d39da5\", \"ppapi_unittests\": \"2f715bd3f27ce8f466253f315ff1ca6d2d872065\", \"printing_unittests\": \"86e60809a51e4e70d30a5cd7c3074375e7276079\", \"remoting_unittests\": \"6b2ae33421a859baf77afb3e59991f27f3f428c0\", \"sandbox_linux_unittests\": \"a58570876302fbfb8d8d0a180f604eb66d903911\", \"service_manager_unittests\": \"58ff9eaa33146bfca5cbed26bd54f48460e0212a\", \"services_unittests\": \"4bfdeaf7d63389b5ff1babd2d402406aaf6ddab6\", \"shell_dialogs_unittests\": \"0157210adb5ff724b8f81d2593075d4a8c96f048\", \"shell_encryption_unittests\": \"fdc9b2b751956019423404d99bd1a7ba2111c695\", \"skia_unittests\": \"f284e1b3991c984aff1f215320bd1f71ccc26232\", \"snapshot_unittests\": \"cff25e5393805437a7e2d03145dbc4794cb4c200\", \"sql_unittests\": \"00f3b1e5fe1d254d0c2c3a3cee4fc6912e5f7fbb\", \"storage_unittests\": \"b51fccec53bcee652f07dc8f4454626516ee026b\", \"sync_integration_tests\": \"4757f67ca56a18a20e12b841b8851b32d4159f84\", \"traffic_annotation_auditor_unittests\": \"2b97d26cdf822134842f918b3db38fefcec7cdd9\", \"ui_base_unittests\": \"09768afc7168f9c58639374428ecb49eae882ca0\", \"ui_chromeos_unittests\": \"baf1055d8c5d0603b523e28b5cad11b4c1e8644a\", \"ui_touch_selection_unittests\": \"5d5736c50fe64cc46012e9b735653d30c341bc59\", \"unit_tests\": \"30ff9730a021c20836768b6296dda65595d7dfc6\", \"url_unittests\": \"ce26d0b4a9905bdcff7be34d607771a4c3085ed8\", \"usage_time_limit_unittests\": \"51ac3524824f74c2cf893192e441b55a82b2a612\", \"views_unittests\": \"addb9a392c0e8dea2bc944aa63a93ccee2dddecc\", \"viz_unittests\": \"98e2a005bd9c4455f30f034e849ca2927fb4e7fd\", \"wayland_client_perftests\": \"53d7daf8487175249278b02b9bf111997e4e7bfe\", \"wm_unittests\": \"4efbca37b258a9b4e51bbd9071ebf2a16463c181\", \"wtf_unittests\": \"8f046f544d255d331311289e2a114080278622d3\", \"zlib_unittests\": \"4b21db7097f316cf5bf67ceaffdb2abc527ca3a8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_b13f895f2fa532c56bcd54736f154d6ea330771f795358111cd0095a10831ab4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-11-1hhh\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612503166009423",
"status": "COMPLETED",
"status_changed_ts": "1612506399647900",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45157",
"builder:linux-chromeos-rel",
"buildset:commit/git/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd8cd53bcb369f5d5b5bdd6d87de3409242b1e37",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021591708676927760",
"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/8856161646718040048/+/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:51897e7ddea96410",
"user_agent:luci-scheduler"
],
"updated_ts": "1612506399652670",
"url": "https://ci.chromium.org/b/8856161646718040048",
"utcnow_ts": "1612506400236114"
}
}
[06:26:46.291] Invocation finished in 54m49.752761955s with status SUCCEEDED