[06:20:09.346] New invocation is queued and will start shortly
[06:20:10.505] Starting the invocation (attempt 1)
[06:20:10.582] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:20:10.582] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:20:10.582] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020320317835005472",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"513124a464de38520ab14386d4983d0977a5e0b2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020320317835005472",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/513124a464de38520ab14386d4983d0977a5e0b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/513124a464de38520ab14386d4983d0977a5e0b2",
"gitiles_ref:refs/heads/master"
]
}
[06:20:12.500] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613715610716823",
"id": "8854890255736511152",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"513124a464de38520ab14386d4983d0977a5e0b2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613715612122009",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45550",
"builder:linux-chromeos-rel",
"buildset:commit/git/513124a464de38520ab14386d4983d0977a5e0b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/513124a464de38520ab14386d4983d0977a5e0b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020320317835005472",
"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/8854890255736511152/+/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": "1613715612122135",
"url": "https://ci.chromium.org/b/8854890255736511152",
"utcnow_ts": "1613715612436967"
}
}
[06:20:12.500] Task URL: https://ci.chromium.org/b/8854890255736511152
[06:20:12.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:2:0) after 1m0s
[06:20:34.219] Received PubSub notification, asking Buildbucket for the build status
[06:20:34.285] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:12.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:2:0)
[06:21:12.520] Timer tick, asking Buildbucket for the build status
[06:21:12.725] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:12.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:4:0) after 1m0s
[06:22:12.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:4:0)
[06:22:12.818] Timer tick, asking Buildbucket for the build status
[06:22:12.941] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:12.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:5:0) after 1m0s
[06:23:13.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:5:0)
[06:23:13.011] Timer tick, asking Buildbucket for the build status
[06:23:13.083] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:13.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:6:0) after 1m0s
[06:24:13.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:6:0)
[06:24:13.104] Timer tick, asking Buildbucket for the build status
[06:24:13.197] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:13.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:7:0) after 1m0s
[06:25:13.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:7:0)
[06:25:13.261] Timer tick, asking Buildbucket for the build status
[06:25:13.666] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:13.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:8:0) after 1m0s
[06:26:13.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:8:0)
[06:26:13.682] Timer tick, asking Buildbucket for the build status
[06:26:13.846] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:9:0) after 1m0s
[06:27:13.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:9:0)
[06:27:13.890] Timer tick, asking Buildbucket for the build status
[06:27:13.980] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:13.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:10:0) after 1m0s
[06:28:13.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:10:0)
[06:28:13.972] Timer tick, asking Buildbucket for the build status
[06:28:14.106] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:14.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:11:0) after 1m0s
[06:29:14.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:11:0)
[06:29:14.208] Timer tick, asking Buildbucket for the build status
[06:29:14.298] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:14.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:12:0) after 1m0s
[06:30:14.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:12:0)
[06:30:14.344] Timer tick, asking Buildbucket for the build status
[06:30:14.824] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:13:0) after 1m0s
[06:31:14.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:13:0)
[06:31:14.839] Timer tick, asking Buildbucket for the build status
[06:31:15.002] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:15.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:14:0) after 1m0s
[06:32:15.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:14:0)
[06:32:15.050] Timer tick, asking Buildbucket for the build status
[06:32:15.389] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:15.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:15:0) after 1m0s
[06:33:15.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:15:0)
[06:33:15.411] Timer tick, asking Buildbucket for the build status
[06:33:15.530] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:15.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:16:0) after 1m0s
[06:34:15.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:16:0)
[06:34:15.613] Timer tick, asking Buildbucket for the build status
[06:34:15.751] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:15.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:17:0) after 1m0s
[06:35:15.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:17:0)
[06:35:15.810] Timer tick, asking Buildbucket for the build status
[06:35:15.917] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:15.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:18:0) after 1m0s
[06:36:15.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:18:0)
[06:36:15.977] Timer tick, asking Buildbucket for the build status
[06:36:16.093] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:16.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:19:0) after 1m0s
[06:37:16.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:19:0)
[06:37:16.154] Timer tick, asking Buildbucket for the build status
[06:37:16.238] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:16.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:20:0) after 1m0s
[06:38:16.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:20:0)
[06:38:16.254] Timer tick, asking Buildbucket for the build status
[06:38:16.341] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:16.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:21:0) after 1m0s
[06:39:16.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:21:0)
[06:39:16.358] Timer tick, asking Buildbucket for the build status
[06:39:16.615] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:16.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:22:0) after 1m0s
[06:40:16.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:22:0)
[06:40:16.582] Timer tick, asking Buildbucket for the build status
[06:40:16.690] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:16.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:23:0) after 1m0s
[06:41:16.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:23:0)
[06:41:16.707] Timer tick, asking Buildbucket for the build status
[06:41:16.861] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:16.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:24:0) after 1m0s
[06:42:16.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:24:0)
[06:42:16.921] Timer tick, asking Buildbucket for the build status
[06:42:17.051] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:25:0) after 1m0s
[06:43:17.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:25:0)
[06:43:17.039] Timer tick, asking Buildbucket for the build status
[06:43:17.118] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:17.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:26:0) after 1m0s
[06:44:17.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:26:0)
[06:44:17.202] Timer tick, asking Buildbucket for the build status
[06:44:17.287] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:17.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:27:0) after 1m0s
[06:45:17.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:27:0)
[06:45:17.423] Timer tick, asking Buildbucket for the build status
[06:45:17.739] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:28:0) after 1m0s
[06:46:17.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:28:0)
[06:46:17.813] Timer tick, asking Buildbucket for the build status
[06:46:18.343] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:29:0) after 1m0s
[06:47:18.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:29:0)
[06:47:18.346] Timer tick, asking Buildbucket for the build status
[06:47:18.427] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:18.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:30:0) after 1m0s
[06:48:18.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:30:0)
[06:48:18.507] Timer tick, asking Buildbucket for the build status
[06:48:18.593] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:18.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:31:0) after 1m0s
[06:49:18.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:31:0)
[06:49:18.649] Timer tick, asking Buildbucket for the build status
[06:49:18.817] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:18.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:32:0) after 1m0s
[06:50:18.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:32:0)
[06:50:18.821] Timer tick, asking Buildbucket for the build status
[06:50:18.955] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:18.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:33:0) after 1m0s
[06:51:18.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:33:0)
[06:51:18.975] Timer tick, asking Buildbucket for the build status
[06:51:19.046] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:34:0) after 1m0s
[06:52:19.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:34:0)
[06:52:19.091] Timer tick, asking Buildbucket for the build status
[06:52:19.246] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:19.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:35:0) after 1m0s
[06:53:19.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:35:0)
[06:53:19.282] Timer tick, asking Buildbucket for the build status
[06:53:19.455] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:19.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:36:0) after 1m0s
[06:54:19.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:36:0)
[06:54:19.572] Timer tick, asking Buildbucket for the build status
[06:54:19.714] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:19.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:37:0) after 1m0s
[06:55:19.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:37:0)
[06:55:19.768] Timer tick, asking Buildbucket for the build status
[06:55:20.000] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:20.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:38:0) after 1m0s
[06:56:20.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:38:0)
[06:56:20.078] Timer tick, asking Buildbucket for the build status
[06:56:27.885] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:27.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:39:0) after 1m0s
[06:57:27.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:39:0)
[06:57:27.904] Timer tick, asking Buildbucket for the build status
[06:57:28.107] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:28.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:40:0) after 1m0s
[06:58:28.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:40:0)
[06:58:28.166] Timer tick, asking Buildbucket for the build status
[06:58:28.369] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:28.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:41:0) after 1m0s
[06:59:28.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:41:0)
[06:59:28.397] Timer tick, asking Buildbucket for the build status
[06:59:28.473] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:28.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:42:0) after 1m0s
[07:00:28.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:42:0)
[07:00:28.451] Timer tick, asking Buildbucket for the build status
[07:00:28.600] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:28.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:43:0) after 1m0s
[07:01:28.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:43:0)
[07:01:28.651] Timer tick, asking Buildbucket for the build status
[07:01:29.642] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:29.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:44:0) after 1m0s
[07:02:29.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:44:0)
[07:02:29.698] Timer tick, asking Buildbucket for the build status
[07:02:29.779] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:29.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:45:0) after 1m0s
[07:03:29.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:45:0)
[07:03:29.809] Timer tick, asking Buildbucket for the build status
[07:03:30.021] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:30.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:46:0) after 1m0s
[07:04:30.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:46:0)
[07:04:30.050] Timer tick, asking Buildbucket for the build status
[07:04:30.142] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:30.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:47:0) after 1m0s
[07:05:30.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:47:0)
[07:05:30.172] Timer tick, asking Buildbucket for the build status
[07:05:30.296] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:30.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:48:0) after 1m0s
[07:06:30.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:48:0)
[07:06:30.359] Timer tick, asking Buildbucket for the build status
[07:06:30.441] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:30.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:49:0) after 1m0s
[07:07:30.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:49:0)
[07:07:30.489] Timer tick, asking Buildbucket for the build status
[07:07:30.599] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:50:0) after 1m0s
[07:08:30.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:50:0)
[07:08:30.649] Timer tick, asking Buildbucket for the build status
[07:08:30.731] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:30.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:51:0) after 1m0s
[07:09:30.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:51:0)
[07:09:30.761] Timer tick, asking Buildbucket for the build status
[07:09:30.861] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:52:0) after 1m0s
[07:10:30.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:52:0)
[07:10:30.914] Timer tick, asking Buildbucket for the build status
[07:10:31.077] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:31.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:53:0) after 1m0s
[07:11:31.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:53:0)
[07:11:31.096] Timer tick, asking Buildbucket for the build status
[07:11:31.246] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:31.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:54:0) after 1m0s
[07:12:31.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:54:0)
[07:12:31.884] Timer tick, asking Buildbucket for the build status
[07:12:32.290] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:32.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:55:0) after 1m0s
[07:13:32.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:55:0)
[07:13:32.561] Timer tick, asking Buildbucket for the build status
[07:13:32.645] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:32.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:56:0) after 1m0s
[07:14:32.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:56:0)
[07:14:32.767] Timer tick, asking Buildbucket for the build status
[07:14:32.906] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:32.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:57:0) after 1m0s
[07:15:33.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:57:0)
[07:15:33.180] Timer tick, asking Buildbucket for the build status
[07:15:33.279] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:33.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:58:0) after 1m0s
[07:16:33.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:58:0)
[07:16:33.558] Timer tick, asking Buildbucket for the build status
[07:16:34.146] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:34.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:59:0) after 1m0s
[07:17:34.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:59:0)
[07:17:34.378] Timer tick, asking Buildbucket for the build status
[07:17:34.697] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:34.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:60:0) after 1m0s
[07:18:34.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:60:0)
[07:18:34.741] Timer tick, asking Buildbucket for the build status
[07:18:34.909] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:34.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:61:0) after 1m0s
[07:19:35.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:61:0)
[07:19:35.086] Timer tick, asking Buildbucket for the build status
[07:19:35.268] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:35.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:62:0) after 1m0s
[07:20:39.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:62:0)
[07:20:39.063] Timer tick, asking Buildbucket for the build status
[07:20:39.604] Build 8854890255736511152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:39.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020320317835005472:63:0) after 1m0s
[07:21:10.210] Received PubSub notification, asking Buildbucket for the build status
[07:21:10.283] Build 8854890255736511152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:21:10.283] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613719267699645",
"created_by": "project:chromium",
"created_ts": "1613715610716823",
"id": "8854890255736511152",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"513124a464de38520ab14386d4983d0977a5e0b2\"}}",
"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\": \"513124a464de38520ab14386d4983d0977a5e0b2\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-166-b6ag\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45550, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"513124a464de38520ab14386d4983d0977a5e0b2\", \"got_revision_cp\": \"refs/heads/master@{#855642}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"513124a464de38520ab14386d4983d0977a5e0b2\", \"swarm_hashes_refs/heads/master(at){#855642}_without_patch\": {\"absl_hardening_tests\": \"36364cf0673b65270fb4c3dbce8cfbce231de2b2\", \"accessibility_unittests\": \"51144338418c6e62613726234d842b6e20c352a6\", \"angle_unittests\": \"7c469cf4ff7078c902ba06f257dd87cc2e4abeed\", \"app_list_unittests\": \"818f0ef81af5d8a96f242541afaea56ae4fc9d74\", \"app_shell_unittests\": \"62e234a7d3ad211c2f51eb994199fd9deb736770\", \"ash_unittests\": \"609a08e806e434f361d9e123b0859ded67eefc00\", \"aura_unittests\": \"f60c70f89da28055e5922d070dc6c3b2e2670976\", \"base_unittests\": \"ea3a4a3819e7b9eaae148e38446182d0ccc88e36\", \"base_util_unittests\": \"735cf851e62dc8e44df24cdcacd5b71e5d7b680d\", \"blink_common_unittests\": \"1edc1c679fc116b3b4fc16ba0cb773ae9b4e8339\", \"blink_fuzzer_unittests\": \"9f6e455fb7043c35fd765ac9d697f6230f7164f6\", \"blink_heap_unittests\": \"5af9730c1db8171b868c3d0114581e333b105361\", \"blink_platform_unittests\": \"f377d434d00d9c15cd7964296e7d7f2f88864d25\", \"blink_unittests\": \"c43dd9f4b296d217e6efd5a21c1111ae573778aa\", \"boringssl_crypto_tests\": \"468edb643385571643f1411fb5183af10a1577f7\", \"boringssl_ssl_tests\": \"cdc630b509beb76d3051c5909c3478581d36a390\", \"browser_tests\": \"d85df14a28eb6d604bbb7249a6797bacb0d0f369\", \"capture_unittests\": \"2e2e826ba35b12866a1a749b404afb34b2e7cef2\", \"cast_unittests\": \"860a97bd22b419a0675c554f591c86d6761b94ef\", \"cc_unittests\": \"c3a9a628253d4496ab12aa4f35d5ea8e569af8bd\", \"chrome_app_unittests\": \"e5e6f6b52ff354e0296a622ca37664183801ac2c\", \"chromedriver_unittests\": \"91f5745072202ede6fec3e423f01ab42d4492b82\", \"chromeos_components_unittests\": \"cf030302d3d4744d14ef742594db6c03a23ca8e5\", \"chromeos_unittests\": \"62c8f9deba4e5695b0aca2bc77468f983f0ba00e\", \"components_browsertests\": \"0e939b1528040e28d4fcfb89a09e8ee59ed2c339\", \"components_unittests\": \"af09ef733ec90fff05d86e47c011062f6702d0fb\", \"compositor_unittests\": \"952d2fac486e23727702e1b9e5335995f0c13feb\", \"content_browsertests\": \"cb73f6e74bb254953292bfaae862d886bba55302\", \"content_unittests\": \"bd0c06b69f9bb80f2e8a5d789a1d9ea3b82f1e34\", \"crashpad_tests\": \"ca847c0cc278311fccc0bee4da8a196f7d423f3d\", \"crypto_unittests\": \"15c11a79e57b9d9d3dec71ec8821399ac0d31f71\", \"dbus_unittests\": \"e825827fb5e712bf97b99de4025a8a6ce9af0f48\", \"device_unittests\": \"4699cc5addebb281dc94243c804b5038300f5e6d\", \"display_unittests\": \"0818f73650eec9ee1fcc68353d83991ca04dd9fd\", \"events_unittests\": \"d0e15b305e6b60da2b0801e27d1f530122032221\", \"exo_unittests\": \"6edb7bc1b740d0489c6c80f2d9ee68dccb552961\", \"extensions_browsertests\": \"53d19268199267f969d9554230c1771bf3f2ae33\", \"extensions_unittests\": \"5df8f38325d5ed7cb528f5a94ab638194ae4ba15\", \"filesystem_service_unittests\": \"1dcb5c973266abffa16171c04237b0f17f7c4b92\", \"gcm_unit_tests\": \"04c03921ec0f605225521de780fba79283718133\", \"gfx_unittests\": \"d7678a8f8675fd2f3ae48a1d6a857fc04abb4bd5\", \"gin_unittests\": \"2b5ca8b2fba4d3b50dce35f841ff6ef56843d167\", \"gl_unittests_ozone\": \"4067b31d49e00b305c6f7f1fef9bdaaeba5a0be3\", \"google_apis_unittests\": \"381de5589e99c551b7dc3591334995cd89bff581\", \"gpu_unittests\": \"f2c4d818e2331a0ee1721fe557bd03c785f0c1d6\", \"gwp_asan_unittests\": \"f8abe933ae7a2953b7bf349bb5da0f1e44bc1ebc\", \"interactive_ui_tests\": \"bd646596a02185d81c5f30bdc50bc09283bde3bb\", \"ipc_tests\": \"e6d0b2042c58aec3a285d8f3138e290f8eef1366\", \"jingle_unittests\": \"6be5bac8aba2df4fa6b2f3a8432bf5d176a3aa12\", \"keyboard_unittests\": \"8aa948b04bdca576fb7e4865f55565804bdeda6d\", \"latency_unittests\": \"5b8264ec845f7020a4baa2a4227221e871c2fd96\", \"libjingle_xmpp_unittests\": \"3809262406382edfb2a3a08849caa91b9988d1b9\", \"liburlpattern_unittests\": \"3d6d4b58473df7b9b65bc7c93ba00a34b4eaf7ae\", \"media_blink_unittests\": \"844329850e892954a0ad85aae1c378f8358fb446\", \"media_unittests\": \"2aa95ed8676ea29a3d6e6bdb3e1b5b3c50098b49\", \"message_center_unittests\": \"d573fb3caf6373932080d4a22d0a26a9f9e9e61f\", \"midi_unittests\": \"d6890a24523e26a1a545cd08c302a32d07890820\", \"mojo_core_unittests\": \"6959229fad879bb242ce36ca58c840b2215bc603\", \"mojo_unittests\": \"82e53b5378e6a7c1e5d919993261030c1317212f\", \"nacl_helper_nonsfi_unittests\": \"4740b84427fc086fbedb742b1af94e7899c425d1\", \"nacl_loader_unittests\": \"bc365731e3bc5a0893a5a277302fb978bc95b091\", \"native_theme_unittests\": \"112cf8ef6461e789559f57f3f0f8186307111f07\", \"net_unittests\": \"9bc2339d8c50f4d92214b8affd20249ca004d921\", \"ozone_gl_unittests\": \"daf0f18b9d3496a0b9c18284e3efd635bb1633bc\", \"ozone_unittests\": \"24d8031eb5dbb2299359132ba3b6750b66f0d7f1\", \"ozone_x11_unittests\": \"e0e94e7043678768ba61fd8d5b0ebb7ed61df861\", \"pdf_unittests\": \"5c34299ae2527b2a0183be8591a57a45683aedb6\", \"perfetto_unittests\": \"d624baee5370838b4b102751ffc8626e55d70225\", \"ppapi_unittests\": \"b880de4479cc024eed9436a0b25a8b8986fcaee0\", \"printing_unittests\": \"2f8292ef848db02f0125906732849717790d2c9a\", \"remoting_unittests\": \"d37129fc832b194c36f96d5bbf27d53b31318be1\", \"sandbox_linux_unittests\": \"0df85c2154fa250dd8c9559501667dfd10e57912\", \"service_manager_unittests\": \"b15193beedec77a9b998569716462a0bcd1c152e\", \"services_unittests\": \"f7afbf57805e6b5c8f2b3948a624e291b8dd0297\", \"shell_dialogs_unittests\": \"a8f5b4e3957a9589397f5e702e077a9bb6cf6f41\", \"shell_encryption_unittests\": \"48e880cfd7e035bb98bcb97ec4e3a121b21efc44\", \"skia_unittests\": \"fd945c0675ffda4eeb01d993c1f3bd2db637b376\", \"snapshot_unittests\": \"4d7d59723f0deffc0809f438c215033c37b6c671\", \"sql_unittests\": \"16baf9e14325e66f01a5d36ca3d75b22486c0d0f\", \"storage_unittests\": \"a8257dbfc10dd5e1715e18a42dc27b84f2587e50\", \"sync_integration_tests\": \"02d5f33592f8458ac23b64b5b6ca25b8089b99c6\", \"traffic_annotation_auditor_unittests\": \"0bee205b7dfd7184a94c143c0f01204b0c18c3b8\", \"ui_base_unittests\": \"030cfeab3e235117c107c209ab936ed7d4a63c82\", \"ui_chromeos_unittests\": \"19947f1ddee403330ae61d3f83c767a5b17ef6f4\", \"ui_touch_selection_unittests\": \"061f4d785b1019419f67b61de6f2c003963f09d6\", \"unit_tests\": \"529b40c069ead5b0a935e6e45d7bcf414633b92b\", \"url_unittests\": \"125710731eaf71083f0ec863f607eb832ba6c689\", \"usage_time_limit_unittests\": \"e6abcd6d691b941d19e682095df0451bb6802912\", \"views_unittests\": \"1fb9561db0df28078809b4343492b7c42999213f\", \"viz_unittests\": \"4d029f31b31930a780ef70fc39986e50c01de22f\", \"wayland_client_perftests\": \"242387d9bcdb29bd6666090edd23b2106942a1b6\", \"wm_unittests\": \"fa5cbf312e475e20c6da222d52bb1e41d3e755b0\", \"wtf_unittests\": \"72338f8e19654b2a88b9f5ae3ecab50d57232d22\", \"zlib_unittests\": \"aec071b4f4525317caa184e806970b99927592ff\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-166-b6ag\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613715630186335",
"status": "COMPLETED",
"status_changed_ts": "1613719268322081",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45550",
"builder:linux-chromeos-rel",
"buildset:commit/git/513124a464de38520ab14386d4983d0977a5e0b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/513124a464de38520ab14386d4983d0977a5e0b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020320317835005472",
"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/8854890255736511152/+/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:51d1c3abb26ece10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613719268397370",
"url": "https://ci.chromium.org/b/8854890255736511152",
"utcnow_ts": "1613719270275667"
}
}
[07:21:10.283] Invocation finished in 1h1m0.952070287s with status SUCCEEDED