[20:59:22.518] New invocation is queued and will start shortly
[20:59:23.689] Starting the invocation (attempt 1)
[20:59:23.740] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:59:23.740] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:59:23.740] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022529926312102160",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2e097d19d02172d36388b178b62a725de1d53262\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022529926312102160",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2e097d19d02172d36388b178b62a725de1d53262",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e097d19d02172d36388b178b62a725de1d53262",
"gitiles_ref:refs/heads/master"
]
}
[20:59:24.313] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611608363830639",
"id": "8857099864246663264",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e097d19d02172d36388b178b62a725de1d53262\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611608364185289",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44894",
"builder:linux-chromeos-rel",
"buildset:commit/git/2e097d19d02172d36388b178b62a725de1d53262",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e097d19d02172d36388b178b62a725de1d53262",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022529926312102160",
"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/8857099864246663264/+/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": "1611608364185397",
"url": "https://ci.chromium.org/b/8857099864246663264",
"utcnow_ts": "1611608364306190"
}
}
[20:59:24.313] Task URL: https://ci.chromium.org/b/8857099864246663264
[20:59:24.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:2:0) after 1m0s
[20:59:40.884] Received PubSub notification, asking Buildbucket for the build status
[20:59:41.034] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:24.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:2:0)
[21:00:24.348] Timer tick, asking Buildbucket for the build status
[21:00:24.462] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:24.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:4:0) after 1m0s
[21:01:24.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:4:0)
[21:01:24.715] Timer tick, asking Buildbucket for the build status
[21:01:24.887] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:5:0) after 1m0s
[21:02:25.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:5:0)
[21:02:25.685] Timer tick, asking Buildbucket for the build status
[21:02:25.753] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:25.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:6:0) after 1m0s
[21:03:26.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:6:0)
[21:03:26.206] Timer tick, asking Buildbucket for the build status
[21:03:26.268] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:26.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:7:0) after 1m0s
[21:04:26.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:7:0)
[21:04:26.384] Timer tick, asking Buildbucket for the build status
[21:04:26.563] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:26.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:8:0) after 1m0s
[21:05:26.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:8:0)
[21:05:26.877] Timer tick, asking Buildbucket for the build status
[21:05:27.143] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:27.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:9:0) after 1m0s
[21:06:27.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:9:0)
[21:06:27.195] Timer tick, asking Buildbucket for the build status
[21:06:28.128] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:28.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:10:0) after 1m0s
[21:07:28.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:10:0)
[21:07:28.174] Timer tick, asking Buildbucket for the build status
[21:07:28.605] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:11:0) after 1m0s
[21:08:28.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:11:0)
[21:08:28.623] Timer tick, asking Buildbucket for the build status
[21:08:28.843] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:28.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:12:0) after 1m0s
[21:09:28.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:12:0)
[21:09:28.835] Timer tick, asking Buildbucket for the build status
[21:09:29.276] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:29.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:13:0) after 1m0s
[21:10:29.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:13:0)
[21:10:29.298] Timer tick, asking Buildbucket for the build status
[21:10:29.393] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:29.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:14:0) after 1m0s
[21:11:29.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:14:0)
[21:11:29.421] Timer tick, asking Buildbucket for the build status
[21:11:30.140] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:30.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:15:0) after 1m0s
[21:12:30.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:15:0)
[21:12:30.167] Timer tick, asking Buildbucket for the build status
[21:12:30.273] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:30.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:16:0) after 1m0s
[21:13:30.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:16:0)
[21:13:30.271] Timer tick, asking Buildbucket for the build status
[21:13:32.383] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:32.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:17:0) after 1m0s
[21:14:32.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:17:0)
[21:14:32.466] Timer tick, asking Buildbucket for the build status
[21:14:32.721] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:18:0) after 1m0s
[21:15:32.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:18:0)
[21:15:32.741] Timer tick, asking Buildbucket for the build status
[21:15:32.813] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:32.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:19:0) after 1m0s
[21:16:32.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:19:0)
[21:16:32.908] Timer tick, asking Buildbucket for the build status
[21:16:33.077] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:33.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:20:0) after 1m0s
[21:17:33.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:20:0)
[21:17:33.127] Timer tick, asking Buildbucket for the build status
[21:17:33.174] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:33.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:21:0) after 1m0s
[21:18:33.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:21:0)
[21:18:33.225] Timer tick, asking Buildbucket for the build status
[21:18:33.278] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:33.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:22:0) after 1m0s
[21:19:33.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:22:0)
[21:19:33.312] Timer tick, asking Buildbucket for the build status
[21:19:33.432] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:33.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:23:0) after 1m0s
[21:20:33.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:23:0)
[21:20:33.495] Timer tick, asking Buildbucket for the build status
[21:20:33.587] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:33.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:24:0) after 1m0s
[21:21:33.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:24:0)
[21:21:33.588] Timer tick, asking Buildbucket for the build status
[21:21:36.713] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:36.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:25:0) after 1m0s
[21:22:36.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:25:0)
[21:22:36.821] Timer tick, asking Buildbucket for the build status
[21:22:36.954] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:36.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:26:0) after 1m0s
[21:23:37.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:26:0)
[21:23:37.267] Timer tick, asking Buildbucket for the build status
[21:23:37.362] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:37.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:27:0) after 1m0s
[21:24:37.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:27:0)
[21:24:37.510] Timer tick, asking Buildbucket for the build status
[21:24:37.719] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:37.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:28:0) after 1m0s
[21:25:38.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:28:0)
[21:25:38.068] Timer tick, asking Buildbucket for the build status
[21:25:39.263] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:39.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:29:0) after 1m0s
[21:26:39.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:29:0)
[21:26:39.538] Timer tick, asking Buildbucket for the build status
[21:26:39.608] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:39.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:30:0) after 1m0s
[21:27:39.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:30:0)
[21:27:39.632] Timer tick, asking Buildbucket for the build status
[21:27:39.727] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:39.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:31:0) after 1m0s
[21:28:39.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:31:0)
[21:28:39.800] Timer tick, asking Buildbucket for the build status
[21:28:39.896] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:39.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:32:0) after 1m0s
[21:29:39.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:32:0)
[21:29:39.966] Timer tick, asking Buildbucket for the build status
[21:29:40.069] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:40.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:33:0) after 1m0s
[21:30:40.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:33:0)
[21:30:40.130] Timer tick, asking Buildbucket for the build status
[21:30:40.207] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:40.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:34:0) after 1m0s
[21:31:40.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:34:0)
[21:31:40.329] Timer tick, asking Buildbucket for the build status
[21:31:40.412] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:40.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:35:0) after 1m0s
[21:32:40.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:35:0)
[21:32:40.460] Timer tick, asking Buildbucket for the build status
[21:32:40.883] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:40.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:36:0) after 1m0s
[21:33:40.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:36:0)
[21:33:40.930] Timer tick, asking Buildbucket for the build status
[21:33:40.983] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:37:0) after 1m0s
[21:34:40.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:37:0)
[21:34:40.983] Timer tick, asking Buildbucket for the build status
[21:34:41.136] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:41.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:38:0) after 1m0s
[21:35:41.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:38:0)
[21:35:41.112] Timer tick, asking Buildbucket for the build status
[21:35:41.562] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:41.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:39:0) after 1m0s
[21:36:41.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:39:0)
[21:36:41.608] Timer tick, asking Buildbucket for the build status
[21:36:42.736] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:42.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:40:0) after 1m0s
[21:37:42.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:40:0)
[21:37:42.758] Timer tick, asking Buildbucket for the build status
[21:37:42.808] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:41:0) after 1m0s
[21:38:42.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:41:0)
[21:38:42.832] Timer tick, asking Buildbucket for the build status
[21:38:43.242] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:43.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:42:0) after 1m0s
[21:39:43.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:42:0)
[21:39:43.262] Timer tick, asking Buildbucket for the build status
[21:39:43.482] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:43.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:43:0) after 1m0s
[21:40:43.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:43:0)
[21:40:43.507] Timer tick, asking Buildbucket for the build status
[21:40:43.606] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:43.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:44:0) after 1m0s
[21:41:43.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:44:0)
[21:41:43.645] Timer tick, asking Buildbucket for the build status
[21:41:43.859] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:43.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:45:0) after 1m0s
[21:42:43.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:45:0)
[21:42:43.908] Timer tick, asking Buildbucket for the build status
[21:42:44.042] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:46:0) after 1m0s
[21:43:44.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:46:0)
[21:43:44.064] Timer tick, asking Buildbucket for the build status
[21:43:44.192] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:47:0) after 1m0s
[21:44:44.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:47:0)
[21:44:44.214] Timer tick, asking Buildbucket for the build status
[21:44:44.904] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:48:0) after 1m0s
[21:45:44.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:48:0)
[21:45:44.947] Timer tick, asking Buildbucket for the build status
[21:45:45.059] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:49:0) after 1m0s
[21:46:45.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:49:0)
[21:46:45.114] Timer tick, asking Buildbucket for the build status
[21:46:46.060] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:46.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:50:0) after 1m0s
[21:47:46.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:50:0)
[21:47:46.146] Timer tick, asking Buildbucket for the build status
[21:47:46.608] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:46.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:51:0) after 1m0s
[21:48:46.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:51:0)
[21:48:46.700] Timer tick, asking Buildbucket for the build status
[21:48:46.917] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:46.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:52:0) after 1m0s
[21:49:46.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:52:0)
[21:49:46.946] Timer tick, asking Buildbucket for the build status
[21:49:47.426] Build 8857099864246663264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:47.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022529926312102160:53:0) after 1m0s
[21:49:53.399] Received PubSub notification, asking Buildbucket for the build status
[21:49:53.477] Build 8857099864246663264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:49:53.477] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611611391899066",
"created_by": "project:chromium",
"created_ts": "1611608363830639",
"id": "8857099864246663264",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e097d19d02172d36388b178b62a725de1d53262\"}}",
"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\": \"2e097d19d02172d36388b178b62a725de1d53262\", \"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-120-8ubm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44894, \"got_angle_revision\": \"3623868e656d0685f0ec3f7d13a2e9c1e348ba53\", \"got_dawn_revision\": \"c00276b2029b85b0cca43ced05173993beaf43e7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"2e097d19d02172d36388b178b62a725de1d53262\", \"got_revision_cp\": \"refs/heads/master@{#846872}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"07aeb34c380e82877710ad10e53596c41c49abd3\", \"got_v8_revision_cp\": \"refs/heads/9.0.61@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"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\": \"2e097d19d02172d36388b178b62a725de1d53262\", \"swarm_hashes_refs/heads/master(at){#846872}_without_patch\": {\"absl_hardening_tests\": \"96593f3862d26d163aafe9539849b76ad196c80e\", \"accessibility_unittests\": \"6b6187296a9ebbfb612d976ca47250079f35676a\", \"angle_unittests\": \"e34f54a055f0bc748adf488019ba3d3b8984df22\", \"app_list_unittests\": \"1f224a79c6bceeb8d1ae18db100110985b7517ad\", \"app_shell_unittests\": \"69edd936e99d1e2a33777d2002d433bde83616a5\", \"ash_unittests\": \"7dcda75db262e05e54e6d872bb6e550e57dd3470\", \"aura_unittests\": \"20edf6d6bd18aaba9e48ab481e03d05fb1d61805\", \"base_unittests\": \"7b50cef5a86f812ab9e66256b2ecfa503bf097b1\", \"base_util_unittests\": \"a26a9bbd2890d76a4a2ac3c6ada67dbab1b5d341\", \"blink_common_unittests\": \"c1772b10095f8c5ae33d192bc4b5d61fc9da0917\", \"blink_fuzzer_unittests\": \"845823043949f6433a81a76146bce96df1e2d440\", \"blink_heap_unittests\": \"4e0c6d301fdcdf3a7494ae4574d2a90f2c8061a1\", \"blink_platform_unittests\": \"de72a83f37bcb07c7dbeb0221d8125c62c786b36\", \"blink_unittests\": \"cf53a2624d66c824658027a579439a345ede7b9a\", \"boringssl_crypto_tests\": \"433b055cbbb6f7a6071874dcf6f0a8d1c7ad9d64\", \"boringssl_ssl_tests\": \"b39f93e4797cf80f0a5e3d5d8ecb0a9bc7d39636\", \"browser_tests\": \"768c449d82fa9200424d5e3014397d2c0fa7532c\", \"capture_unittests\": \"1ab3411ba69f5bafb9271f073528f236526aea22\", \"cast_unittests\": \"912e718d6bfdf128ba60613ee72c54e3b4b7ea1a\", \"cc_unittests\": \"b1e1a7e371c175fa35a8ea246274a79f73323bf3\", \"chrome_app_unittests\": \"88c7b0d3f8aac4eae01706738af75dc9bc7b588a\", \"chromedriver_unittests\": \"d306bd40f757bd95d092af7b6f68db40390f725e\", \"chromeos_components_unittests\": \"552f1309c98f26d9c0632c0d2ea750c65e324dc2\", \"chromeos_unittests\": \"95d78aa01dbda5db1b82518ec1f1e810bc1d1f55\", \"components_browsertests\": \"1afa1cc7870f56aa3fe2c5116b8c697c05bbc0bd\", \"components_unittests\": \"c8c05f2988586139d1751e378e5eeed19b4428f0\", \"compositor_unittests\": \"bef1ad283f96fbb83b13f8b29a376cfe2498c143\", \"content_browsertests\": \"0e28197fae92f46f351f8bab63ea18fdb045ce19\", \"content_unittests\": \"357ea0597e599add4e234630b1cb33343f393a6f\", \"crashpad_tests\": \"506c39980e06dd000967b2a8ee061e2527bcbfbb\", \"crypto_unittests\": \"f080103480aa6cffa5f199ce2028d31b4cddea67\", \"dbus_unittests\": \"24d7bed5f77ebd1824d04bc573b5f8f141e2e2e0\", \"device_unittests\": \"200b4d67aa19286ac3ac602cd0800c53e4fe51b6\", \"display_unittests\": \"72dbba05b5f12d46ea1c66f0d595d3429cc570cf\", \"events_unittests\": \"3630de168f1e1cd40730ee551b45b1533dfbef86\", \"exo_unittests\": \"2ff0b85a40f3c108073f70229a3c324d774b3715\", \"extensions_browsertests\": \"9c3418d970b782a6d34fc734cdda54da46befe5c\", \"extensions_unittests\": \"8048888a902c85021774007f2410cf50c68fb7b8\", \"filesystem_service_unittests\": \"f5656a6dda3772344c0fc5559c027784a74dc61b\", \"gcm_unit_tests\": \"001d391e71638ef62ee9657cacfcea418cc60cfe\", \"gfx_unittests\": \"c64a0111f2e17c1e3be447b1afd054f65b6e3300\", \"gin_unittests\": \"9f3079985528fcf8173418bdb243a97fcd6d5931\", \"gl_unittests_ozone\": \"5c475fb747d459ec5fdfab764ef1541cc3067901\", \"google_apis_unittests\": \"e873ebdbafdf481d35f66b21ebdd0235d5dd7e4a\", \"gpu_unittests\": \"8826fb2ade819db0c3054bfc4e93bbff0f66c758\", \"gwp_asan_unittests\": \"ceceaeabb503eabcb1d79a88e1f5627395d49fd2\", \"interactive_ui_tests\": \"fc65c34760923e6808166f15a4d0c6416bbf2e42\", \"ipc_tests\": \"5866ee72ca97f2da528d78a9a780a80b8f41c57f\", \"jingle_unittests\": \"2e56d04340a4ecb6f5315294af901511c316af88\", \"keyboard_unittests\": \"b5b758215ae9cb790a3f59d5ccd41d781ad7de32\", \"latency_unittests\": \"8d3ac8c9258650f41079c3f9dfc18f2510e32037\", \"libjingle_xmpp_unittests\": \"686f2e602b908eae362eac186b6bfdd224b6f7d5\", \"liburlpattern_unittests\": \"242ef21377740dcbf59c4fe4f2ad13b903e5e0b1\", \"media_blink_unittests\": \"1ac807b04dd8cd437db18e8451bc9e8c81049ad3\", \"media_unittests\": \"9481582c634a21465d571aa7c32851f4986cd35d\", \"message_center_unittests\": \"de0766be1d2cfe03f781f8407c694983703dd9b4\", \"midi_unittests\": \"3511a78e6cd58177883532a556fb1583ae9e6f01\", \"mojo_core_unittests\": \"ca95b0613eb4070e10e5b52c2992cf30b94d36e0\", \"mojo_unittests\": \"c048e7b91c389189ce08eff8e5a41b9c7cee40ee\", \"nacl_helper_nonsfi_unittests\": \"0b8cacbd8e0c8407c1b8a94f88dfb39f63022e49\", \"nacl_loader_unittests\": \"0d62da934c4c40a5bc29055323f72be3b7b38c43\", \"native_theme_unittests\": \"d7851f00a1d5e77775c94132b8984de4c547511e\", \"net_unittests\": \"8d8cb593015188201cb70778ff2bee9b9abad5cd\", \"ozone_gl_unittests\": \"d6031cf4b5d2496ccaa2af3324ad3dea91f0aa1a\", \"ozone_unittests\": \"1b4f74c313ed33b4bd1ce6cb7522f00f9ee44fec\", \"ozone_x11_unittests\": \"a2e0e12524951af1598e6b616234a02f6463810e\", \"pdf_unittests\": \"23bd9d16e759c6a72832386177e4c148dab9c69b\", \"perfetto_unittests\": \"52ee783aa9364cf2480a940ecbf8f465b78a0da7\", \"ppapi_unittests\": \"84bbcef1a76daa9e9153c6e4af81e950935215f7\", \"printing_unittests\": \"2c42333b9771dcf6d8fbdfda92a141aff8aeb044\", \"remoting_unittests\": \"3e71f04764858d7a43b21fbe167cadaadc5c91fd\", \"sandbox_linux_unittests\": \"daf8415fab74362a2a941da2c16d6bb71feed773\", \"service_manager_unittests\": \"66dc92267d2c4ac7a311b9fa3a8ff35027c17555\", \"services_unittests\": \"fa2fd9d4906b75791595ce7ddfc6effd933bbafb\", \"shell_dialogs_unittests\": \"b38363c97350f81ec1266807611c760a6040e899\", \"shell_encryption_unittests\": \"556420bd0ec7847096df8aa588a9c73387429ccf\", \"skia_unittests\": \"d0653efae7bcccbf3b81a21a84cb86a4ece2ca0d\", \"snapshot_unittests\": \"2d8fc409c9f655e42d8aa4fbcb5befba5b22d5f1\", \"sql_unittests\": \"4db67cf5b0f031daa0213f18f1e9bc9fe7d66a7f\", \"storage_unittests\": \"e4f2893c6d563359a66a92f30853d0e93a42bd0c\", \"sync_integration_tests\": \"24efced858980114fa31fa2807eea56b26cd0c98\", \"traffic_annotation_auditor_unittests\": \"efd0214eec72e40514caafc6f8979590e70e60e0\", \"ui_base_unittests\": \"a805f1b7b0ef448a7e1de6295fbfab4eb82715a4\", \"ui_chromeos_unittests\": \"e5e4c066dad34082ebb78d096380323777a46365\", \"ui_touch_selection_unittests\": \"498a0f9c671d706a4d4e7be98ebb915c2545813f\", \"unit_tests\": \"5345b235648e96b457bbb2ff59a4bac096efe189\", \"url_unittests\": \"e5279485c6e38630b21be906c4a39b413b4ccbff\", \"usage_time_limit_unittests\": \"0b7e23ae74d428fcbdd29215f638aba6b7a52154\", \"views_unittests\": \"31e4caf5ef03afbc6b9ba89998af22ed74cc1ba9\", \"viz_unittests\": \"1d763c767f00ff3231275aef3d371693e4a345b1\", \"wayland_client_perftests\": \"b8756214d7d5ee0729bc947f60078a067ef0b4e7\", \"wm_unittests\": \"1fe40804bb569e420c0da535b7a16f2bdc868170\", \"wtf_unittests\": \"b304bd3489c2ac2b1b4c70d65c45ad85a3decab0\", \"zlib_unittests\": \"5d776b4d312991aad8f640bb144494101e9b47c4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_37a6efb75484d21403d66fa62f2f0e5111772231983ba4ec0093d39fca548be8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a942695c23e0ee058ce93eb378e4719ec038e7b245f732574f7a4ff5c9d830ce_v2\", \"builder_cccbb10c846899f06deffa42caa19db86cd5babce89846fb5ee94576babbc4b9_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-120-8ubm\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611608379727650",
"status": "COMPLETED",
"status_changed_ts": "1611611392132329",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44894",
"builder:linux-chromeos-rel",
"buildset:commit/git/2e097d19d02172d36388b178b62a725de1d53262",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e097d19d02172d36388b178b62a725de1d53262",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022529926312102160",
"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/8857099864246663264/+/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:5154299d740e0610",
"user_agent:luci-scheduler"
],
"updated_ts": "1611611392136984",
"url": "https://ci.chromium.org/b/8857099864246663264",
"utcnow_ts": "1611611393468155"
}
}
[21:49:53.477] Invocation finished in 50m30.999619223s with status SUCCEEDED