[22:52:07.132] New invocation is queued and will start shortly
[22:52:08.850] Starting the invocation (attempt 1)
[22:52:08.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:52:08.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:52:08.935] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029770590387040512",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e3355c85ae59975718961a072434659bb0756e62\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029770590387040512",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e3355c85ae59975718961a072434659bb0756e62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3355c85ae59975718961a072434659bb0756e62",
"gitiles_ref:refs/heads/master"
]
}
[22:52:09.686] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604703129031326",
"id": "8864340527731141568",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e3355c85ae59975718961a072434659bb0756e62\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604703129561085",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42650",
"builder:linux-chromeos-rel",
"buildset:commit/git/e3355c85ae59975718961a072434659bb0756e62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3355c85ae59975718961a072434659bb0756e62",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029770590387040512",
"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/8864340527731141568/+/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": "1604703129561194",
"url": "https://ci.chromium.org/b/8864340527731141568",
"utcnow_ts": "1604703129678678"
}
}
[22:52:09.686] Task URL: https://ci.chromium.org/b/8864340527731141568
[22:52:09.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:2:0) after 1m0s
[22:53:05.183] Received PubSub notification, asking Buildbucket for the build status
[22:53:05.262] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:09.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:2:0)
[22:53:09.744] Timer tick, asking Buildbucket for the build status
[22:53:09.827] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:09.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:4:0) after 1m0s
[22:54:09.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:4:0)
[22:54:09.875] Timer tick, asking Buildbucket for the build status
[22:54:09.978] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:09.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:5:0) after 1m0s
[22:55:10.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:5:0)
[22:55:10.096] Timer tick, asking Buildbucket for the build status
[22:55:10.161] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:10.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:6:0) after 1m0s
[22:56:10.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:6:0)
[22:56:10.381] Timer tick, asking Buildbucket for the build status
[22:56:10.513] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:7:0) after 1m0s
[22:57:10.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:7:0)
[22:57:10.649] Timer tick, asking Buildbucket for the build status
[22:57:10.791] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:10.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:8:0) after 1m0s
[22:58:10.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:8:0)
[22:58:10.892] Timer tick, asking Buildbucket for the build status
[22:58:11.491] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:11.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:9:0) after 1m0s
[22:59:11.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:9:0)
[22:59:11.598] Timer tick, asking Buildbucket for the build status
[22:59:11.904] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:10:0) after 1m0s
[23:00:12.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:10:0)
[23:00:12.050] Timer tick, asking Buildbucket for the build status
[23:00:12.405] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:12.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:11:0) after 1m0s
[23:01:12.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:11:0)
[23:01:12.421] Timer tick, asking Buildbucket for the build status
[23:01:12.715] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:12.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:12:0) after 1m0s
[23:02:12.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:12:0)
[23:02:12.780] Timer tick, asking Buildbucket for the build status
[23:02:12.982] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:12.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:13:0) after 1m0s
[23:03:13.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:13:0)
[23:03:13.031] Timer tick, asking Buildbucket for the build status
[23:03:13.350] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:13.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:14:0) after 1m0s
[23:04:13.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:14:0)
[23:04:13.404] Timer tick, asking Buildbucket for the build status
[23:04:13.485] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:13.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:15:0) after 1m0s
[23:05:13.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:15:0)
[23:05:13.596] Timer tick, asking Buildbucket for the build status
[23:05:13.696] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:13.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:16:0) after 1m0s
[23:06:13.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:16:0)
[23:06:13.741] Timer tick, asking Buildbucket for the build status
[23:06:14.253] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:14.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:17:0) after 1m0s
[23:07:14.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:17:0)
[23:07:14.280] Timer tick, asking Buildbucket for the build status
[23:07:14.656] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:14.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:18:0) after 1m0s
[23:08:14.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:18:0)
[23:08:14.829] Timer tick, asking Buildbucket for the build status
[23:08:15.244] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:15.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:19:0) after 1m0s
[23:09:15.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:19:0)
[23:09:15.292] Timer tick, asking Buildbucket for the build status
[23:09:15.361] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:15.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:20:0) after 1m0s
[23:10:15.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:20:0)
[23:10:15.389] Timer tick, asking Buildbucket for the build status
[23:10:15.476] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:15.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:21:0) after 1m0s
[23:11:15.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:21:0)
[23:11:15.528] Timer tick, asking Buildbucket for the build status
[23:11:15.848] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:15.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:22:0) after 1m0s
[23:12:15.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:22:0)
[23:12:15.924] Timer tick, asking Buildbucket for the build status
[23:12:16.057] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:16.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:23:0) after 1m0s
[23:13:16.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:23:0)
[23:13:16.043] Timer tick, asking Buildbucket for the build status
[23:13:16.121] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:16.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:24:0) after 1m0s
[23:14:16.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:24:0)
[23:14:16.178] Timer tick, asking Buildbucket for the build status
[23:14:16.253] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:25:0) after 1m0s
[23:15:16.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:25:0)
[23:15:16.287] Timer tick, asking Buildbucket for the build status
[23:15:16.356] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:16.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:26:0) after 1m0s
[23:16:16.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:26:0)
[23:16:16.508] Timer tick, asking Buildbucket for the build status
[23:16:16.740] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:16.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:27:0) after 1m0s
[23:17:16.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:27:0)
[23:17:16.761] Timer tick, asking Buildbucket for the build status
[23:17:17.111] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:17.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:28:0) after 1m0s
[23:18:17.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:28:0)
[23:18:17.162] Timer tick, asking Buildbucket for the build status
[23:18:17.249] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:17.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:29:0) after 1m0s
[23:19:17.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:29:0)
[23:19:17.258] Timer tick, asking Buildbucket for the build status
[23:19:17.563] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:17.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:30:0) after 1m0s
[23:20:17.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:30:0)
[23:20:17.695] Timer tick, asking Buildbucket for the build status
[23:20:17.812] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:17.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:31:0) after 1m0s
[23:21:17.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:31:0)
[23:21:17.885] Timer tick, asking Buildbucket for the build status
[23:21:18.194] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:18.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:32:0) after 1m0s
[23:22:18.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:32:0)
[23:22:18.329] Timer tick, asking Buildbucket for the build status
[23:22:18.471] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:18.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:33:0) after 1m0s
[23:23:18.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:33:0)
[23:23:18.513] Timer tick, asking Buildbucket for the build status
[23:23:18.574] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:18.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:34:0) after 1m0s
[23:24:18.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:34:0)
[23:24:18.617] Timer tick, asking Buildbucket for the build status
[23:24:18.714] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:18.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:35:0) after 1m0s
[23:25:18.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:35:0)
[23:25:18.776] Timer tick, asking Buildbucket for the build status
[23:25:18.856] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:18.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:36:0) after 1m0s
[23:26:18.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:36:0)
[23:26:18.984] Timer tick, asking Buildbucket for the build status
[23:26:19.126] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:19.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:37:0) after 1m0s
[23:27:19.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:37:0)
[23:27:19.186] Timer tick, asking Buildbucket for the build status
[23:27:19.322] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:19.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:38:0) after 1m0s
[23:28:19.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:38:0)
[23:28:19.344] Timer tick, asking Buildbucket for the build status
[23:28:19.471] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:19.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:39:0) after 1m0s
[23:29:20.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:39:0)
[23:29:20.104] Timer tick, asking Buildbucket for the build status
[23:29:20.204] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:20.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:40:0) after 1m0s
[23:30:20.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:40:0)
[23:30:20.424] Timer tick, asking Buildbucket for the build status
[23:30:20.602] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:20.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:41:0) after 1m0s
[23:31:20.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:41:0)
[23:31:20.667] Timer tick, asking Buildbucket for the build status
[23:31:20.795] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:20.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:42:0) after 1m0s
[23:32:20.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:42:0)
[23:32:20.840] Timer tick, asking Buildbucket for the build status
[23:32:21.097] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:21.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:43:0) after 1m0s
[23:33:21.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:43:0)
[23:33:21.182] Timer tick, asking Buildbucket for the build status
[23:33:21.398] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:21.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:44:0) after 1m0s
[23:34:21.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:44:0)
[23:34:21.482] Timer tick, asking Buildbucket for the build status
[23:34:21.774] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:21.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:45:0) after 1m0s
[23:35:21.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:45:0)
[23:35:21.865] Timer tick, asking Buildbucket for the build status
[23:35:21.993] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:21.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:46:0) after 1m0s
[23:36:22.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:46:0)
[23:36:22.048] Timer tick, asking Buildbucket for the build status
[23:36:22.164] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:22.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:47:0) after 1m0s
[23:37:22.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:47:0)
[23:37:22.141] Timer tick, asking Buildbucket for the build status
[23:37:23.134] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:48:0) after 1m0s
[23:38:23.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:48:0)
[23:38:23.146] Timer tick, asking Buildbucket for the build status
[23:38:23.274] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:49:0) after 1m0s
[23:39:23.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:49:0)
[23:39:23.381] Timer tick, asking Buildbucket for the build status
[23:39:23.509] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:23.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:50:0) after 1m0s
[23:40:23.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:50:0)
[23:40:23.519] Timer tick, asking Buildbucket for the build status
[23:40:24.267] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:24.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:51:0) after 1m0s
[23:41:24.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:51:0)
[23:41:24.346] Timer tick, asking Buildbucket for the build status
[23:41:24.455] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:24.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:52:0) after 1m0s
[23:42:24.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:52:0)
[23:42:24.490] Timer tick, asking Buildbucket for the build status
[23:42:24.996] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:53:0) after 1m0s
[23:43:25.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:53:0)
[23:43:25.118] Timer tick, asking Buildbucket for the build status
[23:43:25.772] Build 8864340527731141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:25.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029770590387040512:54:0) after 1m0s
[23:44:25.472] Received PubSub notification, asking Buildbucket for the build status
[23:44:25.559] Build 8864340527731141568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:44:25.559] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604706264184831",
"created_by": "project:chromium",
"created_ts": "1604703129031326",
"id": "8864340527731141568",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e3355c85ae59975718961a072434659bb0756e62\"}}",
"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\": \"e3355c85ae59975718961a072434659bb0756e62\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-41-sjjl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42650, \"got_angle_revision\": \"156c227d6cf2e09e2450d01ed45fc281494aa4ed\", \"got_dawn_revision\": \"16036cf206f186a1db2659e717711c72e81c392e\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"e3355c85ae59975718961a072434659bb0756e62\", \"got_revision_cp\": \"refs/heads/master@{#825069}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"8f12ca50c8acf32a14cf92bb7007a1275487c783\", \"got_v8_revision_cp\": \"refs/heads/8.8.247@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e3355c85ae59975718961a072434659bb0756e62\", \"swarm_hashes_refs/heads/master(at){#825069}_without_patch\": {\"absl_hardening_tests\": \"326289beede79982b2ddaa876582032fe813e0a1\", \"accessibility_unittests\": \"592cc310d850d1d49f6056bdf3be9e214702871d\", \"angle_unittests\": \"916ceed66234989849b5e886608d37c3d952102a\", \"app_list_unittests\": \"320c8b9d72f0b4c1a01991ac534c3ecb621bd581\", \"app_shell_unittests\": \"9b4162fcfa8e3be6ea21dd9fc0d8b3521f32d994\", \"ash_unittests\": \"01b2a7c9922830fecf9eda5d5155df09c192c294\", \"aura_unittests\": \"49e7d756421905963fc7892c2c7ea0de041d8099\", \"base_unittests\": \"1185de39697dd5053603fda1910e64d79342c2a9\", \"base_util_unittests\": \"0f165f86f6ae600aca53a0f4c636be2aec872960\", \"blink_common_unittests\": \"a2e85ef384ac0220701bbb021692e7c298b1258a\", \"blink_fuzzer_unittests\": \"4c360c8a83a540f12553bf3c156a615ba343d5ad\", \"blink_heap_unittests\": \"8bb6d6060010b7547a225aec305b756d015963f3\", \"blink_platform_unittests\": \"10689d2b877f472d8be5ff122e7fd8b2ff44c119\", \"blink_unittests\": \"ea7ce399587fa495cb311b868ce8298d43e7196c\", \"boringssl_crypto_tests\": \"af82c1b76906b56099d88c7a8fcd772aeda08110\", \"boringssl_ssl_tests\": \"cf98e78f0b8ab134ae901cfd5c5f18a5fa841a16\", \"browser_tests\": \"c93e1c23832a2c41cbb71862d48877024de65741\", \"capture_unittests\": \"65de2f141317b4c7bb824100eae987f42db81780\", \"cast_unittests\": \"de490f979248e2bd0a03c9f5b012df84c7aa2091\", \"cc_unittests\": \"3e4c701ae26c6d1396b5a1db0c20e3c6bdd832de\", \"chrome_app_unittests\": \"fd78549cbcf9828eaaf99d43fbb949c3d4baf1f7\", \"chromedriver_unittests\": \"f420bf9fc7e768ced213a12aec7a33895d740da8\", \"chromeos_components_unittests\": \"c1285dd6cc0ae72307a0c469296085d6aced1499\", \"chromeos_unittests\": \"57ddf11469437144ab1446ddcd4cd84b6868dc50\", \"components_browsertests\": \"bd4a233a090fff87bbe290944883faf37300de04\", \"components_unittests\": \"04f670619ba6e98d39e918cdffabfc56be1ce1b6\", \"compositor_unittests\": \"9c26c6b4857ab7beea80266d26d82c83d6b2ba55\", \"content_browsertests\": \"35c672adcd521a2157f1bc742a6444fc92b7153b\", \"content_unittests\": \"33742ed2726780976687254984c92c105e6c7ca8\", \"crypto_unittests\": \"a11532ad31f8bd522507162e021d06e226b907d3\", \"dbus_unittests\": \"2778a61da5a1ef232a4b53b4d333c51ffd268750\", \"device_unittests\": \"6e236d2accb229fd7b91a3c7e3d051ef9b74b370\", \"display_unittests\": \"75375af2f00502c22e0a50cea9d6583b5dcc145c\", \"events_unittests\": \"5f0e7f20e2b0710d894cb903fa7e8fbd79a9637d\", \"exo_unittests\": \"a511cf35658eceb15df9c80df679c43aed984179\", \"extensions_browsertests\": \"60c7e779b7b1db7d7cb6aaace1ce96ee1cd2c56b\", \"extensions_unittests\": \"1300a287228fbbbbeff929893cdc05ff595cce8b\", \"filesystem_service_unittests\": \"671c9b8ee51a66e0a202db6a3a85a50c72ae68e3\", \"gcm_unit_tests\": \"294fa7047e73445852513759d424f22dcc72fb5f\", \"gfx_unittests\": \"c52a1f26035f7bef916ced9c435d36e0685b60cf\", \"gin_unittests\": \"596a1249fbb2af15acd353179388f47b480c74c0\", \"gl_unittests_ozone\": \"a431e8d21be92bceabb0834ed627da92932add7d\", \"google_apis_unittests\": \"dea4b050df1cc57a96b2849c6383f060cc442798\", \"gpu_unittests\": \"4226a84b818f59b08505503e19e69986eb26f900\", \"gwp_asan_unittests\": \"4e570f28cd6d42a2cc39d7c00c5afc190f522b35\", \"interactive_ui_tests\": \"8d2de3cb77bc0848cfcb3a02e90c5ff899252a14\", \"ipc_tests\": \"7ae6e3d99af5afaa04b18f88236f3a6a189be899\", \"jingle_unittests\": \"49c91e3be586fd23a691545d200e463ef2826adb\", \"keyboard_unittests\": \"ae189639bfce0b28cc2a3984c66c45fbc015460d\", \"latency_unittests\": \"47cdac797d474a959bd72b43bedaeb5f0130e63c\", \"libjingle_xmpp_unittests\": \"2ed14b1f7464415eab3665eecd20ddfffdc2d446\", \"liburlpattern_unittests\": \"b5d850c70bcb837b602ea147cc788a3c698f7eaa\", \"media_blink_unittests\": \"a49b1bb5384a05da59eaa38efe16f0fff83ef7e3\", \"media_unittests\": \"6d466d71064c09b2d8b3ccb6a063876b8df98bb6\", \"message_center_unittests\": \"556b68be7b077b57ab49bd11819b0baa94ec0453\", \"midi_unittests\": \"18f6f439570036766dfbe8ee922a592af9234405\", \"mojo_core_unittests\": \"32b2349812dc8236f98d9f5fea39325094a3ad96\", \"mojo_unittests\": \"cdd2c7bd8dd3d931d0fa19a8e70d6a4ac39e748c\", \"nacl_helper_nonsfi_unittests\": \"9ae4fc5b2cbdad5b33dbde68bbcb7f826f35477a\", \"nacl_loader_unittests\": \"8ec279896b539a04a35acf1603abce2a5c9ac37f\", \"native_theme_unittests\": \"4542c4ce51e343df22215c1c8ea4c0316294874c\", \"net_unittests\": \"ad10d9a50c8a4750709ab7e9bc9dfc71b49e57f7\", \"ozone_gl_unittests\": \"6ea1fe6d4df5d7f4e6a53eee4d024a5af0485312\", \"ozone_unittests\": \"fc82ebdecd68b4d6a268948a89870cd90acc9116\", \"ozone_x11_unittests\": \"9e3f0df43211a38d0d71330901b5327da6d2e4fc\", \"pdf_unittests\": \"1212fc3687a0b5705263b3914501f5b77d2d7f8c\", \"perfetto_unittests\": \"4b1e483b53921ffbc8c1e1cd7647c2aa02162565\", \"ppapi_unittests\": \"bcd235929a39872efe021ca1e4e30e4b02e0f6e2\", \"printing_unittests\": \"ded670e1100f4e97f03768ef2786d9538b68ed41\", \"remoting_unittests\": \"2fa84aefd5fe90b3af55a8012833792af7556e0e\", \"sandbox_linux_unittests\": \"be9a3af70d398f3ae0119c50184af302c1a48e9d\", \"service_manager_unittests\": \"9f01b0e5f87ca148c72fe88d75af31c01c46cf71\", \"services_unittests\": \"29c464ba42ce4c0a6edd1be9115d42e52da21c11\", \"shell_dialogs_unittests\": \"9a1017cf83d5ebbca36d76c04ffe5fdcc8e4e1cb\", \"skia_unittests\": \"2f781b202d156e82a743f5f79e05baead5e2ae39\", \"snapshot_unittests\": \"68f4fca5fcc582889a29582460f02c763c2a74f0\", \"sql_unittests\": \"1b557f72ed8901f7bc836841c82af33201229e7a\", \"storage_unittests\": \"37ce972d8ee86a5765ce80bd27d7d8ee847abdad\", \"sync_integration_tests\": \"0dff8ef3fdb355f360a26d56abc6f4c2d4c0d4d2\", \"traffic_annotation_auditor_unittests\": \"05b8b64cd9e0b0e694ab63c58292ab6a3d431032\", \"ui_base_unittests\": \"d99e77620a5d110ea97424ff4ba11df49f30487f\", \"ui_chromeos_unittests\": \"fbec497a0ef861996e239f4bf3a92a7c99ce4064\", \"ui_touch_selection_unittests\": \"d1f21f9cd81931aaa76d0e02ff560e5e5b3d6b17\", \"unit_tests\": \"6b8b702e2bf5f546ff5b1a3a77fc288b768e001d\", \"url_unittests\": \"219c155ed7f210c1537fa863aba01304bc468e83\", \"usage_time_limit_unittests\": \"744ed791b1d723db42996b2602407a8b159b564d\", \"views_unittests\": \"2f41042631cb9fc1745e80530679c515276188ca\", \"viz_unittests\": \"74a6ac9a32f739a136073267d1f991557f647d14\", \"wayland_client_perftests\": \"00b452aaaa502ef13d412aa1c9b2818404d1b005\", \"wm_unittests\": \"60b8c4f6a51ab6f738f189f0912b4cf07334a760\", \"wtf_unittests\": \"67afed2d87962f1990d44a9bc690f3ad9d212310\", \"zlib_unittests\": \"c6e0e26981dc435fe0658332c0c9d8fd5303d7c9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-41-sjjl\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604703184143298",
"status": "COMPLETED",
"status_changed_ts": "1604706264673297",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42650",
"builder:linux-chromeos-rel",
"buildset:commit/git/e3355c85ae59975718961a072434659bb0756e62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3355c85ae59975718961a072434659bb0756e62",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029770590387040512",
"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/8864340527731141568/+/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:4fb894262aa93110",
"user_agent:luci-scheduler"
],
"updated_ts": "1604706264679888",
"url": "https://ci.chromium.org/b/8864340527731141568",
"utcnow_ts": "1604706265548717"
}
}
[23:44:25.559] Invocation finished in 52m18.444154912s with status SUCCEEDED