[10:57:30.959] New invocation is queued and will start shortly
[10:57:32.045] Starting the invocation (attempt 1)
[10:57:32.077] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:57:32.077] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:57:32.078] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020484061771323056",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"146dfde2cce3035f859add52831550962f371e41\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020484061771323056",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/146dfde2cce3035f859add52831550962f371e41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/146dfde2cce3035f859add52831550962f371e41",
"gitiles_ref:refs/heads/master"
]
}
[10:57:32.888] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613559452189053",
"id": "8855053999820144928",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"146dfde2cce3035f859add52831550962f371e41\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613559452746578",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45492",
"builder:linux-chromeos-rel",
"buildset:commit/git/146dfde2cce3035f859add52831550962f371e41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/146dfde2cce3035f859add52831550962f371e41",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020484061771323056",
"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/8855053999820144928/+/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": "1613559452746722",
"url": "https://ci.chromium.org/b/8855053999820144928",
"utcnow_ts": "1613559452872855"
}
}
[10:57:32.888] Task URL: https://ci.chromium.org/b/8855053999820144928
[10:57:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:2:0) after 1m0s
[10:57:36.283] Received PubSub notification, asking Buildbucket for the build status
[10:57:36.536] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:32.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:2:0)
[10:58:32.954] Timer tick, asking Buildbucket for the build status
[10:58:33.082] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:33.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:4:0) after 1m0s
[10:59:33.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:4:0)
[10:59:33.105] Timer tick, asking Buildbucket for the build status
[10:59:33.198] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:33.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:5:0) after 1m0s
[11:00:33.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:5:0)
[11:00:33.308] Timer tick, asking Buildbucket for the build status
[11:00:33.447] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:33.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:6:0) after 1m0s
[11:01:33.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:6:0)
[11:01:33.462] Timer tick, asking Buildbucket for the build status
[11:01:33.546] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:33.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:7:0) after 1m0s
[11:02:33.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:7:0)
[11:02:33.671] Timer tick, asking Buildbucket for the build status
[11:02:33.898] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:33.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:8:0) after 1m0s
[11:03:33.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:8:0)
[11:03:33.958] Timer tick, asking Buildbucket for the build status
[11:03:34.090] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:34.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:9:0) after 1m0s
[11:04:34.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:9:0)
[11:04:34.123] Timer tick, asking Buildbucket for the build status
[11:04:34.303] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:34.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:10:0) after 1m0s
[11:05:34.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:10:0)
[11:05:34.360] Timer tick, asking Buildbucket for the build status
[11:05:34.492] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:34.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:11:0) after 1m0s
[11:06:34.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:11:0)
[11:06:34.580] Timer tick, asking Buildbucket for the build status
[11:06:34.693] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:34.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:12:0) after 1m0s
[11:07:34.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:12:0)
[11:07:34.749] Timer tick, asking Buildbucket for the build status
[11:07:34.862] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:34.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:13:0) after 1m0s
[11:08:34.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:13:0)
[11:08:34.927] Timer tick, asking Buildbucket for the build status
[11:08:35.095] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:35.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:14:0) after 1m0s
[11:09:35.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:14:0)
[11:09:35.154] Timer tick, asking Buildbucket for the build status
[11:09:35.254] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:35.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:15:0) after 1m0s
[11:10:35.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:15:0)
[11:10:35.268] Timer tick, asking Buildbucket for the build status
[11:10:35.609] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:35.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:16:0) after 1m0s
[11:11:35.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:16:0)
[11:11:35.665] Timer tick, asking Buildbucket for the build status
[11:11:35.775] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:35.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:17:0) after 1m0s
[11:12:35.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:17:0)
[11:12:35.863] Timer tick, asking Buildbucket for the build status
[11:12:36.224] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:36.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:18:0) after 1m0s
[11:13:36.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:18:0)
[11:13:36.296] Timer tick, asking Buildbucket for the build status
[11:13:36.407] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:36.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:19:0) after 1m0s
[11:14:36.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:19:0)
[11:14:36.405] Timer tick, asking Buildbucket for the build status
[11:14:36.550] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:36.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:20:0) after 1m0s
[11:15:36.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:20:0)
[11:15:36.616] Timer tick, asking Buildbucket for the build status
[11:15:36.696] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:36.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:21:0) after 1m0s
[11:16:36.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:21:0)
[11:16:36.714] Timer tick, asking Buildbucket for the build status
[11:16:36.789] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:36.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:22:0) after 1m0s
[11:17:37.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:22:0)
[11:17:37.197] Timer tick, asking Buildbucket for the build status
[11:17:37.293] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:37.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:23:0) after 1m0s
[11:18:37.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:23:0)
[11:18:37.311] Timer tick, asking Buildbucket for the build status
[11:18:37.416] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:37.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:24:0) after 1m0s
[11:19:37.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:24:0)
[11:19:37.441] Timer tick, asking Buildbucket for the build status
[11:19:37.535] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:37.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:25:0) after 1m0s
[11:20:37.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:25:0)
[11:20:37.560] Timer tick, asking Buildbucket for the build status
[11:20:37.869] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:37.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:26:0) after 1m0s
[11:21:38.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:26:0)
[11:21:38.002] Timer tick, asking Buildbucket for the build status
[11:21:38.300] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:38.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:27:0) after 1m0s
[11:22:38.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:27:0)
[11:22:38.308] Timer tick, asking Buildbucket for the build status
[11:22:38.373] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:38.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:28:0) after 1m0s
[11:23:38.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:28:0)
[11:23:38.405] Timer tick, asking Buildbucket for the build status
[11:23:38.520] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:38.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:29:0) after 1m0s
[11:24:38.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:29:0)
[11:24:38.568] Timer tick, asking Buildbucket for the build status
[11:24:38.658] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:38.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:30:0) after 1m0s
[11:25:38.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:30:0)
[11:25:38.677] Timer tick, asking Buildbucket for the build status
[11:25:38.751] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:38.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:31:0) after 1m0s
[11:26:38.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:31:0)
[11:26:38.780] Timer tick, asking Buildbucket for the build status
[11:26:38.945] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:38.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:32:0) after 1m0s
[11:27:39.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:32:0)
[11:27:39.058] Timer tick, asking Buildbucket for the build status
[11:27:39.168] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:39.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:33:0) after 1m0s
[11:28:39.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:33:0)
[11:28:39.213] Timer tick, asking Buildbucket for the build status
[11:28:39.587] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:39.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:34:0) after 1m0s
[11:29:39.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:34:0)
[11:29:39.578] Timer tick, asking Buildbucket for the build status
[11:29:39.709] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:39.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:35:0) after 1m0s
[11:30:39.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:35:0)
[11:30:39.771] Timer tick, asking Buildbucket for the build status
[11:30:39.859] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:39.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:36:0) after 1m0s
[11:31:39.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:36:0)
[11:31:39.888] Timer tick, asking Buildbucket for the build status
[11:31:40.026] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:40.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:37:0) after 1m0s
[11:32:40.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:37:0)
[11:32:40.045] Timer tick, asking Buildbucket for the build status
[11:32:40.140] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:40.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:38:0) after 1m0s
[11:33:40.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:38:0)
[11:33:40.157] Timer tick, asking Buildbucket for the build status
[11:33:40.256] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:40.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:39:0) after 1m0s
[11:34:40.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:39:0)
[11:34:40.275] Timer tick, asking Buildbucket for the build status
[11:34:40.470] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:40.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:40:0) after 1m0s
[11:35:40.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:40:0)
[11:35:40.509] Timer tick, asking Buildbucket for the build status
[11:35:40.632] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:40.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:41:0) after 1m0s
[11:36:40.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:41:0)
[11:36:40.620] Timer tick, asking Buildbucket for the build status
[11:36:40.752] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:40.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:42:0) after 1m0s
[11:37:40.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:42:0)
[11:37:40.867] Timer tick, asking Buildbucket for the build status
[11:37:41.200] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:43:0) after 1m0s
[11:38:41.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:43:0)
[11:38:41.240] Timer tick, asking Buildbucket for the build status
[11:38:41.441] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:41.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:44:0) after 1m0s
[11:39:41.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:44:0)
[11:39:41.510] Timer tick, asking Buildbucket for the build status
[11:39:41.592] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:41.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:45:0) after 1m0s
[11:40:42.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:45:0)
[11:40:42.144] Timer tick, asking Buildbucket for the build status
[11:40:42.220] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:46:0) after 1m0s
[11:41:42.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:46:0)
[11:41:42.392] Timer tick, asking Buildbucket for the build status
[11:41:42.484] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:42.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:47:0) after 1m0s
[11:42:42.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:47:0)
[11:42:42.612] Timer tick, asking Buildbucket for the build status
[11:42:42.758] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:42.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:48:0) after 1m0s
[11:43:42.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:48:0)
[11:43:42.813] Timer tick, asking Buildbucket for the build status
[11:43:42.915] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:42.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:49:0) after 1m0s
[11:44:43.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:49:0)
[11:44:43.003] Timer tick, asking Buildbucket for the build status
[11:44:43.138] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:43.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:50:0) after 1m0s
[11:45:43.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:50:0)
[11:45:43.229] Timer tick, asking Buildbucket for the build status
[11:45:43.613] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:43.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:51:0) after 1m0s
[11:46:43.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:51:0)
[11:46:43.665] Timer tick, asking Buildbucket for the build status
[11:46:43.827] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:43.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:52:0) after 1m0s
[11:47:43.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:52:0)
[11:47:43.983] Timer tick, asking Buildbucket for the build status
[11:47:44.081] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:44.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:53:0) after 1m0s
[11:48:44.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:53:0)
[11:48:44.124] Timer tick, asking Buildbucket for the build status
[11:48:44.523] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:44.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:54:0) after 1m0s
[11:49:44.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:54:0)
[11:49:44.604] Timer tick, asking Buildbucket for the build status
[11:49:44.776] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:44.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:55:0) after 1m0s
[11:50:44.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:55:0)
[11:50:44.823] Timer tick, asking Buildbucket for the build status
[11:50:44.918] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:44.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:56:0) after 1m0s
[11:51:44.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:56:0)
[11:51:44.987] Timer tick, asking Buildbucket for the build status
[11:51:45.104] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:45.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:57:0) after 1m0s
[11:52:45.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:57:0)
[11:52:45.188] Timer tick, asking Buildbucket for the build status
[11:52:45.280] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:45.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:58:0) after 1m0s
[11:53:45.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:58:0)
[11:53:45.299] Timer tick, asking Buildbucket for the build status
[11:53:45.407] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:45.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:59:0) after 1m0s
[11:54:45.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:59:0)
[11:54:45.445] Timer tick, asking Buildbucket for the build status
[11:54:45.773] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:45.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:60:0) after 1m0s
[11:55:45.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:60:0)
[11:55:45.797] Timer tick, asking Buildbucket for the build status
[11:55:46.196] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:61:0) after 1m0s
[11:56:46.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:61:0)
[11:56:46.221] Timer tick, asking Buildbucket for the build status
[11:56:46.303] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:46.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:62:0) after 1m0s
[11:57:46.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:62:0)
[11:57:46.373] Timer tick, asking Buildbucket for the build status
[11:57:46.781] Build 8855053999820144928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:46.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020484061771323056:63:0) after 1m0s
[11:58:40.584] Received PubSub notification, asking Buildbucket for the build status
[11:58:40.839] Build 8855053999820144928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:58:40.839] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613563119444073",
"created_by": "project:chromium",
"created_ts": "1613559452189053",
"id": "8855053999820144928",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"146dfde2cce3035f859add52831550962f371e41\"}}",
"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\": \"146dfde2cce3035f859add52831550962f371e41\", \"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-46-gttn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45492, \"got_angle_revision\": \"3c28b2a0b4813f94730b2e8ca29d490bfb5d4c41\", \"got_dawn_revision\": \"a5ba2827f5810b7b1cd6ee046e8df6e109bb02b6\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"146dfde2cce3035f859add52831550962f371e41\", \"got_revision_cp\": \"refs/heads/master@{#854713}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"bb04803b8daf08e186b327d18e14c78378f44e37\", \"got_v8_revision\": \"972f21b5ed71a418e8ed86f3b39bb7c2b7f175ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.197@{#1}\", \"got_webrtc_revision\": \"8408c9938cb543a7cd5e7127927f3b4d0834ad59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33272}\", \"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\": \"146dfde2cce3035f859add52831550962f371e41\", \"swarm_hashes_refs/heads/master(at){#854713}_without_patch\": {\"absl_hardening_tests\": \"f9554b60caf1be57078c92c06e17e39edc81d87b\", \"accessibility_unittests\": \"f73f906b2ac015b0ca3a897f72501751738cb2a2\", \"angle_unittests\": \"591df7f8cf9ebbc983e7ed7d401dbe121d409379\", \"app_list_unittests\": \"d4498f74a7adf38c8ddc572c53e60a5098ef73cd\", \"app_shell_unittests\": \"bf241526f4668a9377fa658bf8818b4bb8fd6221\", \"ash_unittests\": \"02fb5dc5a14324e723e7a9bbed480c11b7d4351e\", \"aura_unittests\": \"97274745157a03fdc0a56b5246596d10ef0bb5a9\", \"base_unittests\": \"d2ee78141f40761c2fcd22dea08dda40c32154ff\", \"base_util_unittests\": \"90768e5edcdcfa6c7aae0ee525ec05182efecba0\", \"blink_common_unittests\": \"2c3314a504d7de7b1a183256e8308620b7a018ce\", \"blink_fuzzer_unittests\": \"6953d4601aa41064c1ef1455d9b702fe7519f05a\", \"blink_heap_unittests\": \"54bb75b61f429904c3ec2808e4de36b890ea135b\", \"blink_platform_unittests\": \"9215a47096e6a6e229a590a00e13d22663bcf333\", \"blink_unittests\": \"a2c8d8c349ee66afaddc040b99c5c8f889df6d7b\", \"boringssl_crypto_tests\": \"e86d39447ab260b00f7e69b45da8014143e7144b\", \"boringssl_ssl_tests\": \"d5e0752133f5108ff35510174d94ffbd01077c61\", \"browser_tests\": \"6c2df4fc46a89c2f60730857766b37581f83275d\", \"capture_unittests\": \"0f976ffe4e263ef6a80211b5c5554b2009ca4024\", \"cast_unittests\": \"2f859cd27c6df06f81b56d223432e309e3885512\", \"cc_unittests\": \"c74b0b36288333f2e802065a7e9cca107f541d34\", \"chrome_app_unittests\": \"229408cf4128fd44171b1a8bc135c6e88db97dc7\", \"chromedriver_unittests\": \"17895ecfd0baba226b18a68064fd8c843473db76\", \"chromeos_components_unittests\": \"d96047e1ec5553ddf6a9befb1a16e703fb20ee42\", \"chromeos_unittests\": \"4074a39094cce857eddaf4342ae3a7b857f5a8e2\", \"components_browsertests\": \"faa6f6edf3d19bdcd6852cada3ab6b2d3e1fec06\", \"components_unittests\": \"a544371bc1171b54faa2b9bcb4f9fd8458ea351e\", \"compositor_unittests\": \"f9440ec9a10fb01454ce876e89edec0d7ae81b9a\", \"content_browsertests\": \"6cba0fc68e77a79a0c57f6ab51444b4fd2bff4e5\", \"content_unittests\": \"3992746696c3c569127cc28eb5f8ccbdbec28a38\", \"crashpad_tests\": \"bb09a84fdab8ac20f9cebc9ca5aa1b5ac02fb984\", \"crypto_unittests\": \"2e83371d467ece9e5717d3a7b33b776099dc6131\", \"dbus_unittests\": \"bd4072eec795df9c2fe1d502ebd21e8a2bb6da25\", \"device_unittests\": \"79cc5105dc9859236c3ad5ec4ac98a9ab5b4142a\", \"display_unittests\": \"2ff1c540c918a1ceb30a487806c3c2212bf32076\", \"events_unittests\": \"b8f4a83482a37fc814c06890ed53bd9423e3201a\", \"exo_unittests\": \"6736949ae7a8b3c5bcd8c44fb3ead9328dfcb429\", \"extensions_browsertests\": \"16663aee5f398214d31ae832286041f601c5a437\", \"extensions_unittests\": \"537b782a79bdbdd4104c26be35db47f9501cc4c1\", \"filesystem_service_unittests\": \"19a213e0734b51c1eccc4d657ed22f1b09ef1b16\", \"gcm_unit_tests\": \"0735dfb995b11bafe6c87c38b25332c6865342cb\", \"gfx_unittests\": \"f74605dab3d31f34a199d13d33270bc88eb8b819\", \"gin_unittests\": \"503f76001f9bb34f9cb5eb889388fe5d219abaae\", \"gl_unittests_ozone\": \"46ece986e8297ec67dffe4f32d09cd99f2cac2fb\", \"google_apis_unittests\": \"54803d380b1bf302aecb7735205d334d61806c22\", \"gpu_unittests\": \"05954362d82b9af341ed76a804d76e0de34b3691\", \"gwp_asan_unittests\": \"8ff716a2c7e13ae1250510ce8eca41f7e031ace2\", \"interactive_ui_tests\": \"7deb6e3dd13a494890f65c4ca431e9863100dfdc\", \"ipc_tests\": \"38b7038be71f672980f7072aea6b5358ed902108\", \"jingle_unittests\": \"3cad61e066999f935b8930fa83144be81888559b\", \"keyboard_unittests\": \"30d7f703f8f15228c16037fcb1a02e88f07524ce\", \"latency_unittests\": \"f332f4b173ada885055b5bd1fafe95395a147fb2\", \"libjingle_xmpp_unittests\": \"4866a7c3978d602ba5f56354ef2a6e839d56c8cd\", \"liburlpattern_unittests\": \"046838455d79bdb04f0be18f1b9ee7dae540d758\", \"media_blink_unittests\": \"3172a4c9e70d3f55e15615cbe882e9e6cc983214\", \"media_unittests\": \"75e4af18493085983b6bbe2f8cd489bffc7e4d3b\", \"message_center_unittests\": \"e103d0ec0f7117eddcdc803670e08aef3009b8d5\", \"midi_unittests\": \"325189a94ec0659ffc6d8c62ec31d8b2cd11e111\", \"mojo_core_unittests\": \"965a876ec6b210d67c82c3a65135c073ffd457fa\", \"mojo_unittests\": \"2b28c55fdb0fac0aecf4ccf968f5f522d6b7ace7\", \"nacl_helper_nonsfi_unittests\": \"d7142525c426a61081ad5c14658efcdd2bcdd783\", \"nacl_loader_unittests\": \"c54e540282fdf67ed714ad21e81208cb49e122d8\", \"native_theme_unittests\": \"621548dbddf6a1385654f6d6093adeb87a0b28e3\", \"net_unittests\": \"bbbd5ee7265361eac7dfc77df4215672d4ff9849\", \"ozone_gl_unittests\": \"4c0deeb17adaf2931ab3bddfa5ba344d5b142ec3\", \"ozone_unittests\": \"60284647e8b8dcaf894480fbb0a149458697b3a6\", \"ozone_x11_unittests\": \"ea060b3bb95ec4040c1c821a2c2b6635e77ffcf6\", \"pdf_unittests\": \"5d5f5dab3dcd72347d4df34e3d68d25b75c913dc\", \"perfetto_unittests\": \"4b3129dcf5943c2ce46cfae0e5cc3965bbdd2647\", \"ppapi_unittests\": \"1598a68f234ec2d3ed81acdc556586f7d1cd0c1e\", \"printing_unittests\": \"0eace90b398b521a834c77af05d75b87b1ba6f8e\", \"remoting_unittests\": \"20b8e40f1b0a5e96c3266032c9ca44c1184aaf4a\", \"sandbox_linux_unittests\": \"d4885585a89e868a166588a75d0d28c62f9e4186\", \"service_manager_unittests\": \"5950b2e2f61d6c0d8e87be3bb0593fee0b552762\", \"services_unittests\": \"ca3a2d2427c7f1011ec113f478987dce558468ce\", \"shell_dialogs_unittests\": \"98f6eb8f035535800fa5a0b93a67cdd90ba0e299\", \"shell_encryption_unittests\": \"d1abbb8f3c898ccd831a671a31f7e4467709507e\", \"skia_unittests\": \"88ba7e9ba2ac07513f32b6a5e7907d517e4c36b1\", \"snapshot_unittests\": \"d6561ce0af691c41c164dfaff278142656872d79\", \"sql_unittests\": \"f254b93dad4e2ac7661f2943ce92fe5312e4b6dd\", \"storage_unittests\": \"9ca3e2aa6a07ce9b5a18c9e4736dc2b478348703\", \"sync_integration_tests\": \"2e4868e336f436d960cbf66b6eef1cbd30bad36a\", \"traffic_annotation_auditor_unittests\": \"f7ae736c17e345911b64d3b2c7780971259c80c1\", \"ui_base_unittests\": \"b987d7dfc6238a00fa33a0a3aa5d98608608fc4e\", \"ui_chromeos_unittests\": \"53996b17529682148373ff07fc4042cdc96a130e\", \"ui_touch_selection_unittests\": \"0a4b7359e0d39a6b62c708824a281020add85965\", \"unit_tests\": \"6df50f3887b0a2ead3aa875169e1b178a63f0d42\", \"url_unittests\": \"75cf23fbd4a695f1e7dbbe80e3275a607b3bafbe\", \"usage_time_limit_unittests\": \"4f58763c72fba04d22262e0500f2fa3b4d5a78e0\", \"views_unittests\": \"8c63229dfd86d9389be6c53a0094589ab963b12a\", \"viz_unittests\": \"6d81653009be1d62d1f0e683dec47108fa909b5d\", \"wayland_client_perftests\": \"b360025aef636d70cb73b98c498d65313cfa63d2\", \"wm_unittests\": \"e90bf85d628f399f8d38f3eab672a5ec8f5570ed\", \"wtf_unittests\": \"a590d252b1cf927d5fc05c2821402d39a07bfef5\", \"zlib_unittests\": \"97b5145583350dcf232fe6d24e76fd01872f975a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-46-gttn\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613559454946992",
"status": "COMPLETED",
"status_changed_ts": "1613563119784951",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45492",
"builder:linux-chromeos-rel",
"buildset:commit/git/146dfde2cce3035f859add52831550962f371e41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/146dfde2cce3035f859add52831550962f371e41",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020484061771323056",
"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/8855053999820144928/+/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:51c874dd2f9fca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613563119799176",
"url": "https://ci.chromium.org/b/8855053999820144928",
"utcnow_ts": "1613563120827543"
}
}
[11:58:40.839] Invocation finished in 1h1m9.8948608s with status SUCCEEDED