[23:47:30.568] New invocation is queued and will start shortly
[23:47:31.828] Starting the invocation (attempt 1)
[23:47:31.864] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:47:31.864] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:47:31.864] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027955166183354016",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7d27e718acd38691273e103d81212168c410d0e8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027955166183354016",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/7d27e718acd38691273e103d81212168c410d0e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d27e718acd38691273e103d81212168c410d0e8",
"gitiles_ref:refs/heads/master"
]
}
[23:47:32.517] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606434452021217",
"id": "8862525103995554544",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d27e718acd38691273e103d81212168c410d0e8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606434452361850",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43217",
"builder:linux-chromeos-rel",
"buildset:commit/git/7d27e718acd38691273e103d81212168c410d0e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d27e718acd38691273e103d81212168c410d0e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027955166183354016",
"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/8862525103995554544/+/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": "1606434452361978",
"url": "https://ci.chromium.org/b/8862525103995554544",
"utcnow_ts": "1606434452505846"
}
}
[23:47:32.517] Task URL: https://ci.chromium.org/b/8862525103995554544
[23:47:32.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:2:0) after 1m0s
[23:47:35.406] Received PubSub notification, asking Buildbucket for the build status
[23:47:35.473] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:32.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:2:0)
[23:48:32.536] Timer tick, asking Buildbucket for the build status
[23:48:32.952] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:32.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:4:0) after 1m0s
[23:49:33.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:4:0)
[23:49:33.055] Timer tick, asking Buildbucket for the build status
[23:49:33.327] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:33.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:5:0) after 1m0s
[23:50:33.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:5:0)
[23:50:33.380] Timer tick, asking Buildbucket for the build status
[23:50:33.501] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:33.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:6:0) after 1m0s
[23:51:33.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:6:0)
[23:51:33.481] Timer tick, asking Buildbucket for the build status
[23:51:33.578] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:33.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:7:0) after 1m0s
[23:52:33.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:7:0)
[23:52:33.629] Timer tick, asking Buildbucket for the build status
[23:52:33.750] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:33.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:8:0) after 1m0s
[23:53:33.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:8:0)
[23:53:33.727] Timer tick, asking Buildbucket for the build status
[23:53:34.017] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:34.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:9:0) after 1m0s
[23:54:34.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:9:0)
[23:54:34.113] Timer tick, asking Buildbucket for the build status
[23:54:34.261] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:34.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:10:0) after 1m0s
[23:55:34.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:10:0)
[23:55:34.283] Timer tick, asking Buildbucket for the build status
[23:55:34.343] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:11:0) after 1m0s
[23:56:34.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:11:0)
[23:56:34.363] Timer tick, asking Buildbucket for the build status
[23:56:34.428] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:34.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:12:0) after 1m0s
[23:57:34.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:12:0)
[23:57:34.448] Timer tick, asking Buildbucket for the build status
[23:57:34.788] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:34.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:13:0) after 1m0s
[23:58:34.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:13:0)
[23:58:34.791] Timer tick, asking Buildbucket for the build status
[23:58:34.857] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:34.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:14:0) after 1m0s
[23:59:34.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:14:0)
[23:59:34.911] Timer tick, asking Buildbucket for the build status
[23:59:35.284] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:35.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:15:0) after 1m0s
[00:00:35.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:15:0)
[00:00:35.423] Timer tick, asking Buildbucket for the build status
[00:00:35.708] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:35.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:16:0) after 1m0s
[00:01:35.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:16:0)
[00:01:35.785] Timer tick, asking Buildbucket for the build status
[00:01:36.066] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:36.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:17:0) after 1m0s
[00:02:36.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:17:0)
[00:02:36.168] Timer tick, asking Buildbucket for the build status
[00:02:36.311] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:36.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:18:0) after 1m0s
[00:03:36.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:18:0)
[00:03:36.444] Timer tick, asking Buildbucket for the build status
[00:03:36.815] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:36.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:19:0) after 1m0s
[00:04:36.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:19:0)
[00:04:36.925] Timer tick, asking Buildbucket for the build status
[00:04:37.010] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:37.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:20:0) after 1m0s
[00:05:37.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:20:0)
[00:05:37.067] Timer tick, asking Buildbucket for the build status
[00:05:37.377] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:37.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:21:0) after 1m0s
[00:06:37.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:21:0)
[00:06:37.464] Timer tick, asking Buildbucket for the build status
[00:06:37.526] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:37.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:22:0) after 1m0s
[00:07:37.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:22:0)
[00:07:37.598] Timer tick, asking Buildbucket for the build status
[00:07:37.696] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:37.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:23:0) after 1m0s
[00:08:37.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:23:0)
[00:08:37.719] Timer tick, asking Buildbucket for the build status
[00:08:38.001] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:38.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:24:0) after 1m0s
[00:09:38.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:24:0)
[00:09:38.053] Timer tick, asking Buildbucket for the build status
[00:09:38.136] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:38.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:25:0) after 1m0s
[00:10:38.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:25:0)
[00:10:38.201] Timer tick, asking Buildbucket for the build status
[00:10:38.302] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:26:0) after 1m0s
[00:11:38.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:26:0)
[00:11:38.329] Timer tick, asking Buildbucket for the build status
[00:11:38.470] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:38.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:27:0) after 1m0s
[00:12:38.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:27:0)
[00:12:38.522] Timer tick, asking Buildbucket for the build status
[00:12:38.861] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:38.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:28:0) after 1m0s
[00:13:39.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:28:0)
[00:13:39.029] Timer tick, asking Buildbucket for the build status
[00:13:39.084] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:39.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:29:0) after 1m0s
[00:14:39.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:29:0)
[00:14:39.134] Timer tick, asking Buildbucket for the build status
[00:14:39.196] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:39.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:30:0) after 1m0s
[00:15:39.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:30:0)
[00:15:39.219] Timer tick, asking Buildbucket for the build status
[00:15:39.438] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:39.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:31:0) after 1m0s
[00:16:39.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:31:0)
[00:16:39.458] Timer tick, asking Buildbucket for the build status
[00:16:39.522] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:39.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:32:0) after 1m0s
[00:17:39.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:32:0)
[00:17:39.592] Timer tick, asking Buildbucket for the build status
[00:17:39.824] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:33:0) after 1m0s
[00:18:39.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:33:0)
[00:18:39.907] Timer tick, asking Buildbucket for the build status
[00:18:40.158] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:40.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:34:0) after 1m0s
[00:19:40.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:34:0)
[00:19:40.184] Timer tick, asking Buildbucket for the build status
[00:19:40.260] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:40.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:35:0) after 1m0s
[00:20:40.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:35:0)
[00:20:40.313] Timer tick, asking Buildbucket for the build status
[00:20:40.391] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:40.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:36:0) after 1m0s
[00:21:40.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:36:0)
[00:21:40.406] Timer tick, asking Buildbucket for the build status
[00:21:40.489] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:40.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:37:0) after 1m0s
[00:22:40.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:37:0)
[00:22:40.580] Timer tick, asking Buildbucket for the build status
[00:22:40.756] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:40.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:38:0) after 1m0s
[00:23:40.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:38:0)
[00:23:40.891] Timer tick, asking Buildbucket for the build status
[00:23:41.467] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:41.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:39:0) after 1m0s
[00:24:41.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:39:0)
[00:24:41.641] Timer tick, asking Buildbucket for the build status
[00:24:42.098] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:42.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:40:0) after 1m0s
[00:25:42.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:40:0)
[00:25:42.117] Timer tick, asking Buildbucket for the build status
[00:25:42.632] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:41:0) after 1m0s
[00:26:42.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:41:0)
[00:26:42.638] Timer tick, asking Buildbucket for the build status
[00:26:42.702] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:42.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:42:0) after 1m0s
[00:27:42.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:42:0)
[00:27:42.746] Timer tick, asking Buildbucket for the build status
[00:27:42.983] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:43:0) after 1m0s
[00:28:42.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:43:0)
[00:28:42.979] Timer tick, asking Buildbucket for the build status
[00:28:43.260] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:43.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:44:0) after 1m0s
[00:29:43.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:44:0)
[00:29:43.297] Timer tick, asking Buildbucket for the build status
[00:29:43.684] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:43.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:45:0) after 1m0s
[00:30:43.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:45:0)
[00:30:43.773] Timer tick, asking Buildbucket for the build status
[00:30:43.925] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:43.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:46:0) after 1m0s
[00:31:44.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:46:0)
[00:31:44.019] Timer tick, asking Buildbucket for the build status
[00:31:44.166] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:44.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:47:0) after 1m0s
[00:32:44.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:47:0)
[00:32:44.242] Timer tick, asking Buildbucket for the build status
[00:32:44.350] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:44.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:48:0) after 1m0s
[00:33:44.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:48:0)
[00:33:44.431] Timer tick, asking Buildbucket for the build status
[00:33:44.559] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:44.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:49:0) after 1m0s
[00:34:44.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:49:0)
[00:34:44.756] Timer tick, asking Buildbucket for the build status
[00:34:45.177] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:50:0) after 1m0s
[00:35:45.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:50:0)
[00:35:45.263] Timer tick, asking Buildbucket for the build status
[00:35:45.546] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:45.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:51:0) after 1m0s
[00:36:45.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:51:0)
[00:36:45.685] Timer tick, asking Buildbucket for the build status
[00:36:45.794] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:45.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:52:0) after 1m0s
[00:37:45.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:52:0)
[00:37:45.903] Timer tick, asking Buildbucket for the build status
[00:37:46.012] Build 8862525103995554544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:46.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027955166183354016:53:0) after 1m0s
[00:38:33.064] Received PubSub notification, asking Buildbucket for the build status
[00:38:33.159] Build 8862525103995554544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:38:33.159] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606437511988593",
"created_by": "project:chromium",
"created_ts": "1606434452021217",
"id": "8862525103995554544",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d27e718acd38691273e103d81212168c410d0e8\"}}",
"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\": \"7d27e718acd38691273e103d81212168c410d0e8\", \"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-196-kljg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43217, \"got_angle_revision\": \"fcb6b5a5c55ee35d232f35bcfa9c35aefc00f89e\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"7d27e718acd38691273e103d81212168c410d0e8\", \"got_revision_cp\": \"refs/heads/master@{#831441}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"961f93287f84e7e7a7f5ff8a43c7adf14ca7fc42\", \"got_v8_revision_cp\": \"refs/heads/8.9.63@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"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\": \"7d27e718acd38691273e103d81212168c410d0e8\", \"swarm_hashes_refs/heads/master(at){#831441}_without_patch\": {\"absl_hardening_tests\": \"c05b15159f78ec90e1fcf88ea57dd97a6a8f0a28\", \"accessibility_unittests\": \"31cfc0b1f756967ffac660280805ead96706530d\", \"angle_unittests\": \"c5238fbac667f35aac83726edee47472657803a4\", \"app_list_unittests\": \"0e5b411cf63ddae5d09cadf5922d6f06701d477b\", \"app_shell_unittests\": \"b9735b57ac7ecf501bf05ee253f645e4a4fc2d65\", \"ash_unittests\": \"6d82427b67a5bae91325a7a6fd2ee438a5a537b8\", \"aura_unittests\": \"ba92088b2e3b2da4716f05cc250526cd9565aee4\", \"base_unittests\": \"7134d5cc035f868ccbab68bf9427116dcd7fe2b2\", \"base_util_unittests\": \"10d0dcb2c09ae80a2ad9074a17c4b0e38fd5da59\", \"blink_common_unittests\": \"60d63b134363ecc74e2597f14c064b4e42d83187\", \"blink_fuzzer_unittests\": \"1a1660cf8486b39e59209e10064c25fc9b047527\", \"blink_heap_unittests\": \"8038d81fd772c2f01c49dff3be3c18d46a3b6dde\", \"blink_platform_unittests\": \"de16c3d9d087baea5e2e9d0dce75343b6b9dd3c3\", \"blink_unittests\": \"9ed58b6ab7bddbf8bfc56c40462bf1b53b0fa6d2\", \"boringssl_crypto_tests\": \"e9ba5703feaf52ccadc310b43f3b48b6feb10430\", \"boringssl_ssl_tests\": \"e628295e5a619575e5683cab9a9ccb94193d9738\", \"browser_tests\": \"86a22c3251314ae3a33db9794af58d03c9e8a8ee\", \"capture_unittests\": \"014ebe4906aa2bd4621ed323bb85e397621b751a\", \"cast_unittests\": \"d4e96990bee591619344073cbd6eb12e46b4390a\", \"cc_unittests\": \"44330032b845c9dbfb6a4ed4578fc6fde2e8c3ec\", \"chrome_app_unittests\": \"2490cb21c1a62cb31427b8f2b040b6f5d2dac41c\", \"chromedriver_unittests\": \"39b1b95c515fec341a1456982045d10c05433d32\", \"chromeos_components_unittests\": \"a0e753bbaf4c82e55e8623f682934c663bbf1f46\", \"chromeos_unittests\": \"32e7a3a04b976aa1a211a60a86674e46564c2ec4\", \"components_browsertests\": \"c4cab15379671a7e467f0dea1e7614137c7ed7c7\", \"components_unittests\": \"c938c1b51c633508e9723990bd998dfa89e9c5ff\", \"compositor_unittests\": \"444e7e1f6b23c6525a9d2e84906874c9091979b5\", \"content_browsertests\": \"ab315a85254fff21b88840a8c5193e0c9f049155\", \"content_unittests\": \"c8cb81fca7e5ff7c6ea46498cb186f15375a64d9\", \"crashpad_tests\": \"8da47b4e037d09a27bdf64d94698c28eaa8b2dc9\", \"crypto_unittests\": \"1e0ac9123d361c521fafe8dd551c74fd68a726dd\", \"dbus_unittests\": \"1246de960001723a5882146b07c1630003316ec7\", \"device_unittests\": \"90d8466af572bed05b8bcda6f8cc7b0fc25d73af\", \"display_unittests\": \"48a96017ff42d7f0960291d82ca1219716a8716c\", \"events_unittests\": \"fc5f125b6a3fb72dad688ed78ef6d2785226a6cd\", \"exo_unittests\": \"96b6cbfe31a64e62a54bfc6b071b4190139c70a2\", \"extensions_browsertests\": \"7e44893d4549415877277347e2218f5f6d94d915\", \"extensions_unittests\": \"337deded7aabb6dc0556cd0012c29f6cbb893238\", \"filesystem_service_unittests\": \"f32c265ac84b46762fdb29b5a2f786923d04e876\", \"gcm_unit_tests\": \"44d07d5140b5a1b39412b375062ea440371c46f1\", \"gfx_unittests\": \"d4945102089e5bc106896db972ce731e46f372f1\", \"gin_unittests\": \"9232f57043e607aacefb45c35cb0293cc2d1ca54\", \"gl_unittests_ozone\": \"9cd67b4e05165b3733ad0c2bc2104ab36a55ddf5\", \"google_apis_unittests\": \"4f40555314c99c8fc7f5ff6b3211f11d31edd5e0\", \"gpu_unittests\": \"404109f7af71b26786a7c5fd1e4ee564c16d2e25\", \"gwp_asan_unittests\": \"c01c459caa6c5aab275a408eba2071c3d5dd39e9\", \"interactive_ui_tests\": \"4326001fb1995559668f21861062ec9fb4606279\", \"ipc_tests\": \"b618be01f57871a6ce008739826493e59db865ed\", \"jingle_unittests\": \"cdff19a839440bb951e9a30254314104e7db4252\", \"keyboard_unittests\": \"3b5538379e600ecbd6944ede01811f8cc76dc81e\", \"latency_unittests\": \"a13c2385d596e4d42cf7062d90f3eab2a0ac5fd5\", \"libjingle_xmpp_unittests\": \"341206a7ccdfa75d682f53a2b05ea53704865c98\", \"liburlpattern_unittests\": \"3e7eda49d5abd2d92348f59f7229f29cad56a6f5\", \"media_blink_unittests\": \"036f87d47a43cb8dbcedd9d6fb9241c7f5765206\", \"media_unittests\": \"a88f6d6b5f39ed64a5f51af2df448b51f361bfd9\", \"message_center_unittests\": \"3cf7a46f25c93d3ef6115699a16a5165b34419a9\", \"midi_unittests\": \"41aca02e12fe1397a12dfad96cc79798c3270aff\", \"mojo_core_unittests\": \"12454e23a281ab503e0bdf7f44526a65cfec3b95\", \"mojo_unittests\": \"e996ea80f8de625a44984dee9e15df79c19392ff\", \"nacl_helper_nonsfi_unittests\": \"faa7a5ab3e4c000f560b6570d6aa9e0ecf173c4f\", \"nacl_loader_unittests\": \"c9f8b73ee81ae1b31733b793c8f6571d0e192f22\", \"native_theme_unittests\": \"acfd88e0c042b5205aab329b8b0a019662e1d48e\", \"net_unittests\": \"aff753283d7fee0fccfd6211de2b8b5f628e4109\", \"ozone_gl_unittests\": \"eb25ccddafe420c226fd44cc63c6371d18db1763\", \"ozone_unittests\": \"b08f70e40e3adf8fcf96e06a12a5b800a2fafd30\", \"ozone_x11_unittests\": \"df539d8cc78a9d2216e9fd145da8b1f8bd6aea80\", \"pdf_unittests\": \"28dc07f4bd456c1d62ee7a422627b8b4159f619d\", \"perfetto_unittests\": \"be1aa6f51f711faf68d0f1ab602e1cf520bc019b\", \"ppapi_unittests\": \"7d20dba07dacafc6b0e44ae9beedf7499c6ff448\", \"printing_unittests\": \"2c1c94187594b0aadddcd66e894ab0c612e67f7d\", \"remoting_unittests\": \"96165b11f2bfde4c4b5f3d1bfb655328024b2eb8\", \"sandbox_linux_unittests\": \"c0a25224d5e92a9c3feabe045295aaf337503683\", \"service_manager_unittests\": \"c5ee4eee7d2ac0daf2894fa91e5d879e91f6eabf\", \"services_unittests\": \"251ae866da7f2b4b3ccb5eac0881f261100b73ba\", \"shell_dialogs_unittests\": \"9cd01a860d3a0412e6763147a954c665f636ef1b\", \"skia_unittests\": \"3628e277ae2d00a40f44756d5ca8b3b86ba4b5dc\", \"snapshot_unittests\": \"27e0feabc7221c728c69398f3f8b451ba712cbca\", \"sql_unittests\": \"4f449c712d30274fb9f8b1e6800d597e8c2f14c8\", \"storage_unittests\": \"5c36fef7d12d40f47a555cb9cc38f55792a9476d\", \"sync_integration_tests\": \"2d0e0dfb23c6856206e66f0ee25854f5d4314390\", \"traffic_annotation_auditor_unittests\": \"4a30c23d84550ea8542c6619e93d25321aa512c1\", \"ui_base_unittests\": \"3160202657a426edc254d8409b5a051c0fda3a21\", \"ui_chromeos_unittests\": \"aedba9e55621500474f1dc918e3baf4fd500b5bc\", \"ui_touch_selection_unittests\": \"6661430d97e535869f35808e1432d3881bfd346f\", \"unit_tests\": \"fe8daab443cfd032c6069471911ba09c3027cef1\", \"url_unittests\": \"160bb80cc3f2b55abca8a4e8f3dc38e825a9a1a4\", \"usage_time_limit_unittests\": \"4cb229cf3b236adccd736856ebf933819af11399\", \"views_unittests\": \"945dd410d5d4d0d4d442074c5671ef5ae761dd60\", \"viz_unittests\": \"4f6f9ac356d0edbdf746376717cb0b9494f8439e\", \"wayland_client_perftests\": \"0edb37dd534707fad8912a4d6e29b5ea9f6876ef\", \"wm_unittests\": \"0d21cd3288512861061f6c4caf0898de4b69145f\", \"wtf_unittests\": \"5a568aba38e279ff286d35c21bdcddabfdcfe5be\", \"zlib_unittests\": \"48d3628819ade77b23806d45ff21e757486ec9a3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_554b324272771ff5af13275cc9c865b3499df108d1c4d159c356d5c678bf725c_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_abc31495eda36a292af84de2d2556c5a9957390958fb6f471694dbdb8b84ffff_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_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-196-kljg\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606434454631575",
"status": "COMPLETED",
"status_changed_ts": "1606437512434361",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43217",
"builder:linux-chromeos-rel",
"buildset:commit/git/7d27e718acd38691273e103d81212168c410d0e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d27e718acd38691273e103d81212168c410d0e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027955166183354016",
"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/8862525103995554544/+/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:501fc5fc7993ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606437512439304",
"url": "https://ci.chromium.org/b/8862525103995554544",
"utcnow_ts": "1606437513151048"
}
}
[00:38:33.159] Invocation finished in 51m2.60844643s with status SUCCEEDED