[04:19:46.498] New invocation is queued and will start shortly
[04:19:47.702] Starting the invocation (attempt 1)
[04:19:47.762] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:19:47.762] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:19:47.762] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024314158061563088",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8c59296cebe49fbddf92616809656de7042326ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9024314158061563088",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/8c59296cebe49fbddf92616809656de7042326ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c59296cebe49fbddf92616809656de7042326ee",
"gitiles_ref:refs/heads/master"
]
}
[04:19:49.601] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609906788904630",
"id": "8858884094876210992",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8c59296cebe49fbddf92616809656de7042326ee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609906789422196",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44365",
"builder:linux-chromeos-rel",
"buildset:commit/git/8c59296cebe49fbddf92616809656de7042326ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c59296cebe49fbddf92616809656de7042326ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024314158061563088",
"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/8858884094876210992/+/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": "1609906789422345",
"url": "https://ci.chromium.org/b/8858884094876210992",
"utcnow_ts": "1609906789590181"
}
}
[04:19:49.601] Task URL: https://ci.chromium.org/b/8858884094876210992
[04:19:49.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:2:0) after 1m0s
[04:20:16.999] Received PubSub notification, asking Buildbucket for the build status
[04:20:17.082] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:2:0)
[04:20:49.637] Timer tick, asking Buildbucket for the build status
[04:20:49.765] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:4:0) after 1m0s
[04:21:49.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:4:0)
[04:21:49.831] Timer tick, asking Buildbucket for the build status
[04:21:49.949] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:49.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:5:0) after 1m0s
[04:22:49.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:5:0)
[04:22:49.980] Timer tick, asking Buildbucket for the build status
[04:22:50.334] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:50.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:6:0) after 1m0s
[04:23:50.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:6:0)
[04:23:50.381] Timer tick, asking Buildbucket for the build status
[04:23:50.635] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:50.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:7:0) after 1m0s
[04:24:50.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:7:0)
[04:24:50.611] Timer tick, asking Buildbucket for the build status
[04:24:50.733] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:50.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:8:0) after 1m0s
[04:25:50.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:8:0)
[04:25:50.772] Timer tick, asking Buildbucket for the build status
[04:25:51.022] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:51.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:9:0) after 1m0s
[04:26:51.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:9:0)
[04:26:51.009] Timer tick, asking Buildbucket for the build status
[04:26:51.177] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:51.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:10:0) after 1m0s
[04:27:51.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:10:0)
[04:27:51.244] Timer tick, asking Buildbucket for the build status
[04:27:51.710] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:51.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:11:0) after 1m0s
[04:28:51.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:11:0)
[04:28:51.717] Timer tick, asking Buildbucket for the build status
[04:28:51.796] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:51.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:12:0) after 1m0s
[04:29:51.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:12:0)
[04:29:51.811] Timer tick, asking Buildbucket for the build status
[04:29:51.889] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:51.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:13:0) after 1m0s
[04:30:51.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:13:0)
[04:30:51.974] Timer tick, asking Buildbucket for the build status
[04:30:52.129] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:52.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:14:0) after 1m0s
[04:31:52.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:14:0)
[04:31:52.203] Timer tick, asking Buildbucket for the build status
[04:31:52.266] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:52.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:15:0) after 1m0s
[04:32:52.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:15:0)
[04:32:52.315] Timer tick, asking Buildbucket for the build status
[04:32:52.418] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:52.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:16:0) after 1m0s
[04:33:52.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:16:0)
[04:33:52.403] Timer tick, asking Buildbucket for the build status
[04:33:52.517] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:52.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:17:0) after 1m0s
[04:34:52.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:17:0)
[04:34:52.544] Timer tick, asking Buildbucket for the build status
[04:34:52.725] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:52.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:18:0) after 1m0s
[04:35:52.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:18:0)
[04:35:52.824] Timer tick, asking Buildbucket for the build status
[04:35:52.966] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:52.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:19:0) after 1m0s
[04:36:52.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:19:0)
[04:36:52.988] Timer tick, asking Buildbucket for the build status
[04:36:53.061] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:53.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:20:0) after 1m0s
[04:37:53.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:20:0)
[04:37:53.132] Timer tick, asking Buildbucket for the build status
[04:37:53.739] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:53.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:21:0) after 1m0s
[04:38:53.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:21:0)
[04:38:53.735] Timer tick, asking Buildbucket for the build status
[04:38:53.944] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:53.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:22:0) after 1m0s
[04:39:53.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:22:0)
[04:39:53.964] Timer tick, asking Buildbucket for the build status
[04:39:54.078] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:54.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:23:0) after 1m0s
[04:40:54.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:23:0)
[04:40:54.089] Timer tick, asking Buildbucket for the build status
[04:40:54.227] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:54.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:24:0) after 1m0s
[04:41:54.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:24:0)
[04:41:54.263] Timer tick, asking Buildbucket for the build status
[04:41:54.320] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:54.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:25:0) after 1m0s
[04:42:54.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:25:0)
[04:42:54.326] Timer tick, asking Buildbucket for the build status
[04:42:54.386] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:54.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:26:0) after 1m0s
[04:43:54.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:26:0)
[04:43:54.472] Timer tick, asking Buildbucket for the build status
[04:43:54.612] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:54.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:27:0) after 1m0s
[04:44:54.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:27:0)
[04:44:54.631] Timer tick, asking Buildbucket for the build status
[04:44:54.696] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:54.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:28:0) after 1m0s
[04:45:55.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:28:0)
[04:45:55.117] Timer tick, asking Buildbucket for the build status
[04:45:55.264] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:55.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:29:0) after 1m0s
[04:46:55.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:29:0)
[04:46:55.356] Timer tick, asking Buildbucket for the build status
[04:46:55.425] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:55.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:30:0) after 1m0s
[04:47:55.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:30:0)
[04:47:55.818] Timer tick, asking Buildbucket for the build status
[04:47:55.903] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:55.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:31:0) after 1m0s
[04:48:56.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:31:0)
[04:48:56.008] Timer tick, asking Buildbucket for the build status
[04:48:56.135] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:56.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:32:0) after 1m0s
[04:49:56.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:32:0)
[04:49:56.562] Timer tick, asking Buildbucket for the build status
[04:49:56.691] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:56.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:33:0) after 1m0s
[04:50:56.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:33:0)
[04:50:56.775] Timer tick, asking Buildbucket for the build status
[04:50:56.881] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:56.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:34:0) after 1m0s
[04:51:57.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:34:0)
[04:51:57.682] Timer tick, asking Buildbucket for the build status
[04:51:57.734] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:57.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:35:0) after 1m0s
[04:52:57.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:35:0)
[04:52:57.923] Timer tick, asking Buildbucket for the build status
[04:52:58.069] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:58.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:36:0) after 1m0s
[04:53:58.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:36:0)
[04:53:58.132] Timer tick, asking Buildbucket for the build status
[04:53:58.258] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:58.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:37:0) after 1m0s
[04:54:58.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:37:0)
[04:54:58.319] Timer tick, asking Buildbucket for the build status
[04:54:58.470] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:58.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:38:0) after 1m0s
[04:55:58.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:38:0)
[04:55:58.517] Timer tick, asking Buildbucket for the build status
[04:55:58.661] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:58.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:39:0) after 1m0s
[04:56:58.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:39:0)
[04:56:58.689] Timer tick, asking Buildbucket for the build status
[04:56:58.839] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:58.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:40:0) after 1m0s
[04:57:58.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:40:0)
[04:57:58.857] Timer tick, asking Buildbucket for the build status
[04:57:59.035] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:59.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:41:0) after 1m0s
[04:58:59.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:41:0)
[04:58:59.062] Timer tick, asking Buildbucket for the build status
[04:58:59.178] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:59.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:42:0) after 1m0s
[04:59:59.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:42:0)
[04:59:59.207] Timer tick, asking Buildbucket for the build status
[04:59:59.379] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:59.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:43:0) after 1m0s
[05:00:59.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:43:0)
[05:00:59.399] Timer tick, asking Buildbucket for the build status
[05:00:59.703] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:59.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:44:0) after 1m0s
[05:01:59.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:44:0)
[05:01:59.749] Timer tick, asking Buildbucket for the build status
[05:02:00.361] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:00.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:45:0) after 1m0s
[05:03:00.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:45:0)
[05:03:00.389] Timer tick, asking Buildbucket for the build status
[05:03:00.951] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:00.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:46:0) after 1m0s
[05:04:00.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:46:0)
[05:04:00.996] Timer tick, asking Buildbucket for the build status
[05:04:01.315] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:01.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:47:0) after 1m0s
[05:05:01.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:47:0)
[05:05:01.344] Timer tick, asking Buildbucket for the build status
[05:05:02.005] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:02.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:48:0) after 1m0s
[05:06:02.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:48:0)
[05:06:02.031] Timer tick, asking Buildbucket for the build status
[05:06:02.184] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:02.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:49:0) after 1m0s
[05:07:02.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:49:0)
[05:07:02.240] Timer tick, asking Buildbucket for the build status
[05:07:02.410] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:02.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:50:0) after 1m0s
[05:08:02.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:50:0)
[05:08:02.400] Timer tick, asking Buildbucket for the build status
[05:08:03.129] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:03.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:51:0) after 1m0s
[05:09:03.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:51:0)
[05:09:03.147] Timer tick, asking Buildbucket for the build status
[05:09:03.345] Build 8858884094876210992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:03.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024314158061563088:52:0) after 1m0s
[05:09:19.902] Received PubSub notification, asking Buildbucket for the build status
[05:09:19.963] Build 8858884094876210992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:09:19.963] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609909758903598",
"created_by": "project:chromium",
"created_ts": "1609906788904630",
"id": "8858884094876210992",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8c59296cebe49fbddf92616809656de7042326ee\"}}",
"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\": \"8c59296cebe49fbddf92616809656de7042326ee\", \"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-89-lrfl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44365, \"got_angle_revision\": \"e91097bf3a24895f23b928ed12087dcbb1d54d7b\", \"got_dawn_revision\": \"200941c797512895039e9f0315fc18fd9d9734ad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"8c59296cebe49fbddf92616809656de7042326ee\", \"got_revision_cp\": \"refs/heads/master@{#840474}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"c8d1d1cbceae8f59975b2ec7d86981ec3fabb11b\", \"got_v8_revision_cp\": \"refs/heads/8.9.212@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"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\": \"8c59296cebe49fbddf92616809656de7042326ee\", \"swarm_hashes_refs/heads/master(at){#840474}_without_patch\": {\"absl_hardening_tests\": \"5c205f9be0615a77b1f51bc8b65c4c489f311f24\", \"accessibility_unittests\": \"7a68be990ca674dc0247113832bb05be562ba8b6\", \"angle_unittests\": \"5c256b6f058fa23f55f87e33f10684f32bc8415d\", \"app_list_unittests\": \"a08947241aded0fd074839265ef34c447f4fd75f\", \"app_shell_unittests\": \"d2484a939bc54f5d1fbe7c1b9631b7f1e54ab9e2\", \"ash_unittests\": \"68d36b95cd800ecf4d46c9a6a705ea38dc66ffc5\", \"aura_unittests\": \"66370d7c9115109a09a850cd4aa27784b20accb7\", \"base_unittests\": \"802d56924cbaa80a2f831a365d0c24e62d888b02\", \"base_util_unittests\": \"d32e8d4744d9d6a2bb65c5393699c03a183a4438\", \"blink_common_unittests\": \"6b92d762fb87ca7d98d947474bcdc37de566b651\", \"blink_fuzzer_unittests\": \"e30aa0e5b776a4c95d80e6a25e2966497e344aad\", \"blink_heap_unittests\": \"036b6d4aa15100398bf730dbe0e2ca01c16e97af\", \"blink_platform_unittests\": \"b8db6f1350d7d35cb59e1cc17b37b4c14cbcf4f8\", \"blink_unittests\": \"bfca71bd03a89e774240bd908c59a99367b2ef37\", \"boringssl_crypto_tests\": \"71721f0cce3b5960b4ff3a71bc9252e38ea29228\", \"boringssl_ssl_tests\": \"d8f1232826915469dd21c6be866d0a95569f6441\", \"browser_tests\": \"8b93c53b1f5f7584072a58d3129c89b9d7d0326d\", \"capture_unittests\": \"9e8b786551eded1113200a2f990c9aa4511f09b4\", \"cast_unittests\": \"4ab62dd60696f3be1db04df32b55995eea3631df\", \"cc_unittests\": \"45614621318b5e54bc181d21630a12ef513db329\", \"chrome_app_unittests\": \"82f9608a48b4941ee0697eeb7c7e082e3b5fe681\", \"chromedriver_unittests\": \"12ed3afc82f3e4475f97ab66a280b78e72122d1e\", \"chromeos_components_unittests\": \"134ab7255fb5464c98277769a6982aa656afc831\", \"chromeos_unittests\": \"ae39939916f23343161b7109557187b55fd6c35e\", \"components_browsertests\": \"b7d56680152013c629d352e2c37dff2341e683ee\", \"components_unittests\": \"67259f1c62e8661e36501ccb6d19032c6b2e5967\", \"compositor_unittests\": \"cefdb3fb1bafcd11b64b29e0c65439ea5a06f452\", \"content_browsertests\": \"45a4e12a6d8e3f1dcd827b2a6d98820fd8d8f917\", \"content_unittests\": \"6484a1f6191c0d311c0b2ba3ca28c1ba5e43acb7\", \"crashpad_tests\": \"f27603a6abc653fd2690dfe4b0915491dd424be2\", \"crypto_unittests\": \"9f19d87a625ceab937780f1ca5541f011776c295\", \"dbus_unittests\": \"9b80f6793b43f3867d68c197b932165b259ca8b9\", \"device_unittests\": \"3dab3b7523e75622fdf75883ba9f1b5363226452\", \"display_unittests\": \"8ca433546936e2949194cffbe49209031cab7763\", \"events_unittests\": \"9e688877179088560821cadc181c7929a3b7bfef\", \"exo_unittests\": \"1c070b08925675bf59c7e6656d2e7dc477eaa441\", \"extensions_browsertests\": \"398bede256094288cce2f2f7ea97147a0b728fb3\", \"extensions_unittests\": \"175350a8ae0f4caac1287fc1c713a6358e2281a2\", \"filesystem_service_unittests\": \"b84a4a14bc2691c32c62d957227f5926f9f57be0\", \"gcm_unit_tests\": \"cdcc07b0beb3a883ea6ae9aab4b312d904d7ade0\", \"gfx_unittests\": \"c9231b1e100d967c5348e670390df00c34b00567\", \"gin_unittests\": \"9b3563b0e04a79b1a90e5b6db787e1b4276731bc\", \"gl_unittests_ozone\": \"44b7dbe4de566202b2ebdbd53aa29bb44735cfda\", \"google_apis_unittests\": \"ead08596a85bb8d7928ab152e8458011fb8898dd\", \"gpu_unittests\": \"76e48a08818d1dfefacb80e0d1052829c70be7e0\", \"gwp_asan_unittests\": \"f7d76d5a579d16b057b7c8f49ca78a845eaf46ec\", \"interactive_ui_tests\": \"f0d800b5fcf87c9cc21d22b8d1a750d652a59f74\", \"ipc_tests\": \"1e972685bb3a6ccc058871e60e5fd072d679b664\", \"jingle_unittests\": \"f49dcc5d6748c3c7b735e793eea1553300b41806\", \"keyboard_unittests\": \"803e0e3e296b1abceb690176c8658bc5956b3a8a\", \"latency_unittests\": \"e4e54a632d4fc9f6b82e1722e5912ea313531bda\", \"libjingle_xmpp_unittests\": \"043e185cc09d126d5a046c0a18c7e2bda052f1a0\", \"liburlpattern_unittests\": \"bd069934601f87ca1faee4100cb93153532a3466\", \"media_blink_unittests\": \"fcecb1a2d2536317b3506dd83cf17ff1a809da04\", \"media_unittests\": \"3fa137ce052d7b2288474b8f15fc4c5ce4f48064\", \"message_center_unittests\": \"2fe3e4a5caa0041cd660dee9126c9e589f1bc86a\", \"midi_unittests\": \"1ee870779e7067ae72ee6d71b0ae9b4721f53a01\", \"mojo_core_unittests\": \"76b1f8a077ae8efed14d0e45d61cf8fbc73f66a8\", \"mojo_unittests\": \"50799a94590f9cb8fc63c43a913af4fe8483dad7\", \"nacl_helper_nonsfi_unittests\": \"c3a1e768607f552bd238fc86b34127dbe73c1d7d\", \"nacl_loader_unittests\": \"4af4603a2001339af60805622c9eacfdcf00ac40\", \"native_theme_unittests\": \"98f85da98a79480a160f9f1920ff9167e3be6d0a\", \"net_unittests\": \"1a8c620306b4d92330685a7a957f424e333f139d\", \"ozone_gl_unittests\": \"58f5ac26be083e0baab7c6ce99c9b164b8570c4e\", \"ozone_unittests\": \"8bfc77b1b2a3dc2a2ca2d9db1c7348b4535662de\", \"ozone_x11_unittests\": \"6746391878ea52e5aa9f410a369064c8af3b9fdf\", \"pdf_unittests\": \"54e5aea801005285a4006c4fad85c6d1243e194c\", \"perfetto_unittests\": \"dbd9e1842a7a54b6f52e6ced2b6c1d19d279589c\", \"ppapi_unittests\": \"201c8de98b183030a93a3db113dc7181ef69b4d4\", \"printing_unittests\": \"82ed0d535983ab58767810988a8d2ca78a4767fa\", \"remoting_unittests\": \"13d8738a5c60f3018668513afbf8b9cf4fd1bf80\", \"sandbox_linux_unittests\": \"02e7b3fa3fd9b6279e104a7540e4815837c76469\", \"service_manager_unittests\": \"6f3002f71c6cb16bbf3c8247fdb51ff5a9d6dd6d\", \"services_unittests\": \"086cf2fe9e2e3cb9dd8bcdc4c9c045c469bc142c\", \"shell_dialogs_unittests\": \"6d10e2a44b06f49f45628383614363e4f897dd65\", \"shell_encryption_unittests\": \"43cf0baebf8e7e5132384372cdeb78da50de48ce\", \"skia_unittests\": \"7c34832ae58354720a6831f9a59be0d2bec3714a\", \"snapshot_unittests\": \"c882e9b2d333cbb7dce8491149a60abe2ecd20ad\", \"sql_unittests\": \"2b58b91083b5e3f00588dadd2055a8234ee643d2\", \"storage_unittests\": \"3e31be282776aafea66055a578abec9914886e67\", \"sync_integration_tests\": \"d5bd4dfd28685a58193b05687fa81d2f2ad03eb3\", \"traffic_annotation_auditor_unittests\": \"b88af9a308a0ee221bc433771c060e5fb990e2e7\", \"ui_base_unittests\": \"39f9e4737a3ec8256698731f462a844432d6229d\", \"ui_chromeos_unittests\": \"427bf9f8ad28cf77fad2738c944c1ad9057144e6\", \"ui_touch_selection_unittests\": \"57cfb54be54a1b20c14c6c6e9e4be7cad6bef2ef\", \"unit_tests\": \"6aed2c258ba23006a67c5530ef569d75db57a8f0\", \"url_unittests\": \"a8c865d276153127cead6bbae6249d2d169bca9f\", \"usage_time_limit_unittests\": \"a36db6bb0f0d5eef845901083c9a1ebb37203985\", \"views_unittests\": \"8bc65f2e9a302c98b0a88a7749e9a0a428ff92af\", \"viz_unittests\": \"e230d1f2ea092a9f3170083707ec3c7e2e1ccf83\", \"wayland_client_perftests\": \"532f5509eb33e4d4bfe6f036fd5ec09b0e7afaae\", \"wm_unittests\": \"7f24e7b5629eb4184a1d5a5c8468f64ae3663db3\", \"wtf_unittests\": \"236995eca0ac38c8170b973f4416b7919bc614d0\", \"zlib_unittests\": \"e523607ab2c0094bae752dc3122facddfffb96e0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0fb1f456593ae2600bf9c9616e0e5dcc3c87ffc9d4d6fb93e9350aac8ae4516c_v2\", \"builder_321a2ce955953920551fc69856a295b9c48a1a2350c0055b827d09f10d75e261_v2\", \"builder_61893a5c8ae9b884bb20ec7e5a61377525a63e6bcd3c290923a393e48475e916_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-89-lrfl\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609906815937858",
"status": "COMPLETED",
"status_changed_ts": "1609909759538569",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44365",
"builder:linux-chromeos-rel",
"buildset:commit/git/8c59296cebe49fbddf92616809656de7042326ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8c59296cebe49fbddf92616809656de7042326ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024314158061563088",
"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/8858884094876210992/+/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:50eebdfcd6cb8a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609909759543303",
"url": "https://ci.chromium.org/b/8858884094876210992",
"utcnow_ts": "1609909759954156"
}
}
[05:09:19.963] Invocation finished in 49m33.480269643s with status SUCCEEDED