[01:38:20.144] New invocation is queued and will start shortly
[01:38:21.279] Starting the invocation (attempt 1)
[01:38:21.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:38:21.317] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:38:21.317] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027948193599950816",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027948193599950816",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"gitiles_ref:refs/heads/master"
]
}
[01:38:22.353] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606441101433288",
"id": "8862518131581553536",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606441102217087",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43220",
"builder:linux-chromeos-rel",
"buildset:commit/git/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027948193599950816",
"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/8862518131581553536/+/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": "1606441102217193",
"url": "https://ci.chromium.org/b/8862518131581553536",
"utcnow_ts": "1606441102338070"
}
}
[01:38:22.353] Task URL: https://ci.chromium.org/b/8862518131581553536
[01:38:22.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:2:0) after 1m0s
[01:39:21.594] Received PubSub notification, asking Buildbucket for the build status
[01:39:21.655] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:2:0)
[01:39:24.841] Timer tick, asking Buildbucket for the build status
[01:39:24.918] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:4:0) after 1m0s
[01:40:24.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:4:0)
[01:40:24.977] Timer tick, asking Buildbucket for the build status
[01:40:25.136] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:5:0) after 1m0s
[01:41:25.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:5:0)
[01:41:25.153] Timer tick, asking Buildbucket for the build status
[01:41:25.421] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:6:0) after 1m0s
[01:42:25.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:6:0)
[01:42:25.461] Timer tick, asking Buildbucket for the build status
[01:42:25.591] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:25.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:7:0) after 1m0s
[01:43:25.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:7:0)
[01:43:25.584] Timer tick, asking Buildbucket for the build status
[01:43:25.679] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:25.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:8:0) after 1m0s
[01:44:25.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:8:0)
[01:44:25.698] Timer tick, asking Buildbucket for the build status
[01:44:25.824] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:25.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:9:0) after 1m0s
[01:45:25.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:9:0)
[01:45:25.895] Timer tick, asking Buildbucket for the build status
[01:45:26.052] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:26.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:10:0) after 1m0s
[01:46:26.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:10:0)
[01:46:26.108] Timer tick, asking Buildbucket for the build status
[01:46:26.489] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:26.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:11:0) after 1m0s
[01:47:26.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:11:0)
[01:47:26.599] Timer tick, asking Buildbucket for the build status
[01:47:26.673] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:26.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:12:0) after 1m0s
[01:48:26.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:12:0)
[01:48:26.739] Timer tick, asking Buildbucket for the build status
[01:48:26.810] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:26.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:13:0) after 1m0s
[01:49:26.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:13:0)
[01:49:26.827] Timer tick, asking Buildbucket for the build status
[01:49:26.986] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:14:0) after 1m0s
[01:50:26.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:14:0)
[01:50:26.983] Timer tick, asking Buildbucket for the build status
[01:50:27.061] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:27.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:15:0) after 1m0s
[01:51:27.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:15:0)
[01:51:27.089] Timer tick, asking Buildbucket for the build status
[01:51:27.368] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:27.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:16:0) after 1m0s
[01:52:27.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:16:0)
[01:52:27.422] Timer tick, asking Buildbucket for the build status
[01:52:27.615] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:17:0) after 1m0s
[01:53:27.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:17:0)
[01:53:27.700] Timer tick, asking Buildbucket for the build status
[01:53:27.788] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:27.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:18:0) after 1m0s
[01:54:27.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:18:0)
[01:54:27.810] Timer tick, asking Buildbucket for the build status
[01:54:27.901] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:27.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:19:0) after 1m0s
[01:55:27.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:19:0)
[01:55:27.951] Timer tick, asking Buildbucket for the build status
[01:55:28.038] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:28.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:20:0) after 1m0s
[01:56:28.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:20:0)
[01:56:28.068] Timer tick, asking Buildbucket for the build status
[01:56:28.327] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:28.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:21:0) after 1m0s
[01:57:28.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:21:0)
[01:57:28.347] Timer tick, asking Buildbucket for the build status
[01:57:28.419] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:28.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:22:0) after 1m0s
[01:58:28.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:22:0)
[01:58:28.484] Timer tick, asking Buildbucket for the build status
[01:58:28.578] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:28.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:23:0) after 1m0s
[01:59:28.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:23:0)
[01:59:28.590] Timer tick, asking Buildbucket for the build status
[01:59:28.713] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:28.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:24:0) after 1m0s
[02:00:28.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:24:0)
[02:00:28.732] Timer tick, asking Buildbucket for the build status
[02:00:28.803] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:28.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:25:0) after 1m0s
[02:01:28.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:25:0)
[02:01:28.955] Timer tick, asking Buildbucket for the build status
[02:01:29.094] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:26:0) after 1m0s
[02:02:29.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:26:0)
[02:02:29.208] Timer tick, asking Buildbucket for the build status
[02:02:29.899] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:29.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:27:0) after 1m0s
[02:03:29.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:27:0)
[02:03:29.973] Timer tick, asking Buildbucket for the build status
[02:03:30.039] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:30.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:28:0) after 1m0s
[02:04:30.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:28:0)
[02:04:30.072] Timer tick, asking Buildbucket for the build status
[02:04:30.303] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:30.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:29:0) after 1m0s
[02:05:30.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:29:0)
[02:05:30.326] Timer tick, asking Buildbucket for the build status
[02:05:30.413] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:30.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:30:0) after 1m0s
[02:06:30.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:30:0)
[02:06:30.392] Timer tick, asking Buildbucket for the build status
[02:06:30.489] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:30.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:31:0) after 1m0s
[02:07:30.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:31:0)
[02:07:30.491] Timer tick, asking Buildbucket for the build status
[02:07:31.077] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:31.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:32:0) after 1m0s
[02:08:31.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:32:0)
[02:08:31.100] Timer tick, asking Buildbucket for the build status
[02:08:31.299] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:31.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:33:0) after 1m0s
[02:09:31.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:33:0)
[02:09:31.371] Timer tick, asking Buildbucket for the build status
[02:09:31.532] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:31.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:34:0) after 1m0s
[02:10:31.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:34:0)
[02:10:31.554] Timer tick, asking Buildbucket for the build status
[02:10:31.754] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:31.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:35:0) after 1m0s
[02:11:31.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:35:0)
[02:11:31.773] Timer tick, asking Buildbucket for the build status
[02:11:31.880] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:31.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:36:0) after 1m0s
[02:12:31.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:36:0)
[02:12:31.990] Timer tick, asking Buildbucket for the build status
[02:12:32.445] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:32.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:37:0) after 1m0s
[02:13:32.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:37:0)
[02:13:32.579] Timer tick, asking Buildbucket for the build status
[02:13:32.648] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:32.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:38:0) after 1m0s
[02:14:32.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:38:0)
[02:14:32.778] Timer tick, asking Buildbucket for the build status
[02:14:34.117] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:39:0) after 1m0s
[02:15:34.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:39:0)
[02:15:34.153] Timer tick, asking Buildbucket for the build status
[02:15:34.504] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:40:0) after 1m0s
[02:16:34.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:40:0)
[02:16:34.584] Timer tick, asking Buildbucket for the build status
[02:16:34.753] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:41:0) after 1m0s
[02:17:34.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:41:0)
[02:17:34.747] Timer tick, asking Buildbucket for the build status
[02:17:34.893] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:42:0) after 1m0s
[02:18:34.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:42:0)
[02:18:34.873] Timer tick, asking Buildbucket for the build status
[02:18:34.991] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:34.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:43:0) after 1m0s
[02:19:35.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:43:0)
[02:19:35.010] Timer tick, asking Buildbucket for the build status
[02:19:35.124] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:44:0) after 1m0s
[02:20:35.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:44:0)
[02:20:35.145] Timer tick, asking Buildbucket for the build status
[02:20:35.295] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:45:0) after 1m0s
[02:21:35.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:45:0)
[02:21:35.317] Timer tick, asking Buildbucket for the build status
[02:21:35.422] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:46:0) after 1m0s
[02:22:35.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:46:0)
[02:22:35.449] Timer tick, asking Buildbucket for the build status
[02:22:35.806] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:47:0) after 1m0s
[02:23:35.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:47:0)
[02:23:35.827] Timer tick, asking Buildbucket for the build status
[02:23:35.967] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:35.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:48:0) after 1m0s
[02:24:35.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:48:0)
[02:24:35.990] Timer tick, asking Buildbucket for the build status
[02:24:36.133] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:49:0) after 1m0s
[02:25:36.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:49:0)
[02:25:36.213] Timer tick, asking Buildbucket for the build status
[02:25:36.775] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:50:0) after 1m0s
[02:26:36.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:50:0)
[02:26:36.802] Timer tick, asking Buildbucket for the build status
[02:26:36.916] Build 8862518131581553536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:36.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027948193599950816:51:0) after 1m0s
[02:26:40.765] Received PubSub notification, asking Buildbucket for the build status
[02:26:40.851] Build 8862518131581553536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:26:40.851] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606443999795681",
"created_by": "project:chromium",
"created_ts": "1606441101433288",
"id": "8862518131581553536",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\"}}",
"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\": \"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\", \"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-216-medw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43220, \"got_angle_revision\": \"fcb6b5a5c55ee35d232f35bcfa9c35aefc00f89e\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\", \"got_revision_cp\": \"refs/heads/master@{#831445}\", \"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\": \"6c726eafaf8a45fb9df7c6c7c92c4a1923914d41\", \"swarm_hashes_refs/heads/master(at){#831445}_without_patch\": {\"absl_hardening_tests\": \"c05b15159f78ec90e1fcf88ea57dd97a6a8f0a28\", \"accessibility_unittests\": \"31cfc0b1f756967ffac660280805ead96706530d\", \"angle_unittests\": \"c5238fbac667f35aac83726edee47472657803a4\", \"app_list_unittests\": \"0e5b411cf63ddae5d09cadf5922d6f06701d477b\", \"app_shell_unittests\": \"6f261f3f5ad42db3f401ddd854835d68220f061a\", \"ash_unittests\": \"6d82427b67a5bae91325a7a6fd2ee438a5a537b8\", \"aura_unittests\": \"ba92088b2e3b2da4716f05cc250526cd9565aee4\", \"base_unittests\": \"9ec8f1206afee799f77f2b47ce553ec59b276b8b\", \"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\": \"50ec6f2173207d96a45ae1def4074c6e7b12286d\", \"capture_unittests\": \"014ebe4906aa2bd4621ed323bb85e397621b751a\", \"cast_unittests\": \"d4e96990bee591619344073cbd6eb12e46b4390a\", \"cc_unittests\": \"44330032b845c9dbfb6a4ed4578fc6fde2e8c3ec\", \"chrome_app_unittests\": \"2490cb21c1a62cb31427b8f2b040b6f5d2dac41c\", \"chromedriver_unittests\": \"6c92f522a0c15d6ac963054cf6440d6df1aa4ea4\", \"chromeos_components_unittests\": \"a0e753bbaf4c82e55e8623f682934c663bbf1f46\", \"chromeos_unittests\": \"32e7a3a04b976aa1a211a60a86674e46564c2ec4\", \"components_browsertests\": \"70e94f7357463aba72f4945c1afcd03d297000f1\", \"components_unittests\": \"438da212357c071d24df849374899caa72b106fb\", \"compositor_unittests\": \"444e7e1f6b23c6525a9d2e84906874c9091979b5\", \"content_browsertests\": \"e456dea09c5366d2ee299343a648d7db0d584437\", \"content_unittests\": \"d1b1ef698f0b6313392a7a2da0e86ae8b83b2251\", \"crashpad_tests\": \"8da47b4e037d09a27bdf64d94698c28eaa8b2dc9\", \"crypto_unittests\": \"1e0ac9123d361c521fafe8dd551c74fd68a726dd\", \"dbus_unittests\": \"1246de960001723a5882146b07c1630003316ec7\", \"device_unittests\": \"90d8466af572bed05b8bcda6f8cc7b0fc25d73af\", \"display_unittests\": \"48a96017ff42d7f0960291d82ca1219716a8716c\", \"events_unittests\": \"fc5f125b6a3fb72dad688ed78ef6d2785226a6cd\", \"exo_unittests\": \"96b6cbfe31a64e62a54bfc6b071b4190139c70a2\", \"extensions_browsertests\": \"2d4934d39d3d7903d24d066d411c0dd67f100606\", \"extensions_unittests\": \"2304de3eb993223e3a1ca8bb03fce14ca0ed3e03\", \"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\": \"72168b7df74a1dbfbfead04ed46b0d523e5d2696\", \"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\": \"8c420fd85bf3f684da8cd6b81df0c5e57ebcfd1e\", \"traffic_annotation_auditor_unittests\": \"4a30c23d84550ea8542c6619e93d25321aa512c1\", \"ui_base_unittests\": \"3160202657a426edc254d8409b5a051c0fda3a21\", \"ui_chromeos_unittests\": \"aedba9e55621500474f1dc918e3baf4fd500b5bc\", \"ui_touch_selection_unittests\": \"6661430d97e535869f35808e1432d3881bfd346f\", \"unit_tests\": \"8618aa18b91e39d96fef4659e3fae5f8bb1f8648\", \"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_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_6ce0efae7132fe8ed0fd2e62adc5ba9342c3a2d5840b43c14152c2007d6a5024_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_eb9e31050ddbebce4ba6cbaea9a0445903ee5f3e90bdb319e3517a7851b1b7f7_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-216-medw\"], \"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": "1606441160023092",
"status": "COMPLETED",
"status_changed_ts": "1606444000112376",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43220",
"builder:linux-chromeos-rel",
"buildset:commit/git/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6c726eafaf8a45fb9df7c6c7c92c4a1923914d41",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027948193599950816",
"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/8862518131581553536/+/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:50202bb12797cf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606444000117731",
"url": "https://ci.chromium.org/b/8862518131581553536",
"utcnow_ts": "1606444000842668"
}
}
[02:26:40.851] Invocation finished in 48m20.726239249s with status SUCCEEDED