[05:35:11.228] New invocation is queued and will start shortly
[05:35:14.028] Starting the invocation (attempt 1)
[05:35:14.070] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:35:14.070] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:35:14.070] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023765831743348144",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2af43d0146c9ab7f4c69292676bd0e8d58a17025\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023765831743348144",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"gitiles_ref:refs/heads/master"
]
}
[05:35:14.708] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610429714195123",
"id": "8858335767966655360",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2af43d0146c9ab7f4c69292676bd0e8d58a17025\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610429714550210",
"tags": [
"build_address:luci.chromium.ci/win-asan/16770",
"builder:win-asan",
"buildset:commit/git/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023765831743348144",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858335767966655360/+/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": "1610429714550323",
"url": "https://ci.chromium.org/b/8858335767966655360",
"utcnow_ts": "1610429714699806"
}
}
[05:35:14.708] Task URL: https://ci.chromium.org/b/8858335767966655360
[05:35:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:2:0) after 1m0s
[05:35:21.205] Received PubSub notification, asking Buildbucket for the build status
[05:35:21.304] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:14.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:2:0)
[05:36:14.861] Timer tick, asking Buildbucket for the build status
[05:36:14.934] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:14.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:4:0) after 1m0s
[05:37:16.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:4:0)
[05:37:16.993] Timer tick, asking Buildbucket for the build status
[05:37:17.111] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:17.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:5:0) after 1m0s
[05:38:17.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:5:0)
[05:38:17.553] Timer tick, asking Buildbucket for the build status
[05:38:17.690] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:17.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:6:0) after 1m0s
[05:39:17.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:6:0)
[05:39:17.767] Timer tick, asking Buildbucket for the build status
[05:39:17.929] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:17.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:7:0) after 1m0s
[05:40:17.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:7:0)
[05:40:17.955] Timer tick, asking Buildbucket for the build status
[05:40:18.094] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:18.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:8:0) after 1m0s
[05:41:18.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:8:0)
[05:41:18.095] Timer tick, asking Buildbucket for the build status
[05:41:18.200] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:18.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:9:0) after 1m0s
[05:42:18.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:9:0)
[05:42:18.232] Timer tick, asking Buildbucket for the build status
[05:42:18.290] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:18.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:10:0) after 1m0s
[05:43:18.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:10:0)
[05:43:18.311] Timer tick, asking Buildbucket for the build status
[05:43:18.376] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:18.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:11:0) after 1m0s
[05:44:18.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:11:0)
[05:44:18.481] Timer tick, asking Buildbucket for the build status
[05:44:18.573] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:18.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:12:0) after 1m0s
[05:45:18.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:12:0)
[05:45:18.662] Timer tick, asking Buildbucket for the build status
[05:45:19.322] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:19.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:13:0) after 1m0s
[05:46:19.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:13:0)
[05:46:19.371] Timer tick, asking Buildbucket for the build status
[05:46:19.591] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:14:0) after 1m0s
[05:47:19.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:14:0)
[05:47:19.661] Timer tick, asking Buildbucket for the build status
[05:47:19.827] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:19.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:15:0) after 1m0s
[05:48:19.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:15:0)
[05:48:19.871] Timer tick, asking Buildbucket for the build status
[05:48:20.104] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:16:0) after 1m0s
[05:49:20.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:16:0)
[05:49:20.143] Timer tick, asking Buildbucket for the build status
[05:49:20.243] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:20.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:17:0) after 1m0s
[05:50:20.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:17:0)
[05:50:20.309] Timer tick, asking Buildbucket for the build status
[05:50:20.410] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:20.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:18:0) after 1m0s
[05:51:20.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:18:0)
[05:51:20.451] Timer tick, asking Buildbucket for the build status
[05:51:20.544] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:20.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:19:0) after 1m0s
[05:52:20.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:19:0)
[05:52:20.577] Timer tick, asking Buildbucket for the build status
[05:52:21.157] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:21.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:20:0) after 1m0s
[05:53:21.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:20:0)
[05:53:21.322] Timer tick, asking Buildbucket for the build status
[05:53:21.433] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:21.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:21:0) after 1m0s
[05:54:21.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:21:0)
[05:54:21.453] Timer tick, asking Buildbucket for the build status
[05:54:21.571] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:21.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:22:0) after 1m0s
[05:55:21.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:22:0)
[05:55:21.594] Timer tick, asking Buildbucket for the build status
[05:55:21.864] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:23:0) after 1m0s
[05:56:21.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:23:0)
[05:56:21.931] Timer tick, asking Buildbucket for the build status
[05:56:22.034] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:22.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:24:0) after 1m0s
[05:57:22.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:24:0)
[05:57:22.098] Timer tick, asking Buildbucket for the build status
[05:57:22.211] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:22.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:25:0) after 1m0s
[05:58:22.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:25:0)
[05:58:22.260] Timer tick, asking Buildbucket for the build status
[05:58:22.392] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:22.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:26:0) after 1m0s
[05:59:22.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:26:0)
[05:59:22.444] Timer tick, asking Buildbucket for the build status
[05:59:22.570] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:22.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:27:0) after 1m0s
[06:00:22.595] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:27:0)
[06:00:22.595] Timer tick, asking Buildbucket for the build status
[06:00:22.716] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:22.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:28:0) after 1m0s
[06:01:27.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:28:0)
[06:01:27.069] Timer tick, asking Buildbucket for the build status
[06:01:27.154] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:27.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:29:0) after 1m0s
[06:02:27.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:29:0)
[06:02:27.199] Timer tick, asking Buildbucket for the build status
[06:02:27.295] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:27.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:30:0) after 1m0s
[06:03:27.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:30:0)
[06:03:27.319] Timer tick, asking Buildbucket for the build status
[06:03:27.576] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:27.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:31:0) after 1m0s
[06:04:27.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:31:0)
[06:04:27.576] Timer tick, asking Buildbucket for the build status
[06:04:27.697] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:32:0) after 1m0s
[06:05:27.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:32:0)
[06:05:27.761] Timer tick, asking Buildbucket for the build status
[06:05:27.916] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:27.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:33:0) after 1m0s
[06:06:28.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:33:0)
[06:06:28.043] Timer tick, asking Buildbucket for the build status
[06:06:28.114] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:28.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:34:0) after 1m0s
[06:07:28.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:34:0)
[06:07:28.366] Timer tick, asking Buildbucket for the build status
[06:07:28.445] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:28.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:35:0) after 1m0s
[06:08:28.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:35:0)
[06:08:28.658] Timer tick, asking Buildbucket for the build status
[06:08:28.845] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:28.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:36:0) after 1m0s
[06:09:28.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:36:0)
[06:09:28.889] Timer tick, asking Buildbucket for the build status
[06:09:29.051] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:29.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:37:0) after 1m0s
[06:10:29.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:37:0)
[06:10:29.184] Timer tick, asking Buildbucket for the build status
[06:10:29.300] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:29.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:38:0) after 1m0s
[06:11:29.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:38:0)
[06:11:29.435] Timer tick, asking Buildbucket for the build status
[06:11:29.572] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:29.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:39:0) after 1m0s
[06:12:29.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:39:0)
[06:12:29.651] Timer tick, asking Buildbucket for the build status
[06:12:29.857] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:29.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:40:0) after 1m0s
[06:13:30.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:40:0)
[06:13:30.005] Timer tick, asking Buildbucket for the build status
[06:13:30.116] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:30.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:41:0) after 1m0s
[06:14:30.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:41:0)
[06:14:30.357] Timer tick, asking Buildbucket for the build status
[06:14:30.494] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:42:0) after 1m0s
[06:15:30.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:42:0)
[06:15:30.526] Timer tick, asking Buildbucket for the build status
[06:15:30.694] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:43:0) after 1m0s
[06:16:30.998] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:43:0)
[06:16:30.998] Timer tick, asking Buildbucket for the build status
[06:16:31.231] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:31.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:44:0) after 1m0s
[06:17:31.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:44:0)
[06:17:31.357] Timer tick, asking Buildbucket for the build status
[06:17:31.453] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:31.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:45:0) after 1m0s
[06:18:31.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:45:0)
[06:18:31.624] Timer tick, asking Buildbucket for the build status
[06:18:32.165] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:32.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:46:0) after 1m0s
[06:19:32.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:46:0)
[06:19:32.246] Timer tick, asking Buildbucket for the build status
[06:19:32.326] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:47:0) after 1m0s
[06:20:32.420] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:47:0)
[06:20:32.420] Timer tick, asking Buildbucket for the build status
[06:20:32.841] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:32.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:48:0) after 1m0s
[06:21:32.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:48:0)
[06:21:32.863] Timer tick, asking Buildbucket for the build status
[06:21:32.940] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:32.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:49:0) after 1m0s
[06:22:32.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:49:0)
[06:22:32.920] Timer tick, asking Buildbucket for the build status
[06:22:33.409] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:33.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:50:0) after 1m0s
[06:23:33.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:50:0)
[06:23:33.499] Timer tick, asking Buildbucket for the build status
[06:23:33.856] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:33.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:51:0) after 1m0s
[06:24:33.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:51:0)
[06:24:33.913] Timer tick, asking Buildbucket for the build status
[06:24:34.136] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:34.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:52:0) after 1m0s
[06:25:34.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:52:0)
[06:25:34.151] Timer tick, asking Buildbucket for the build status
[06:25:34.386] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:34.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:53:0) after 1m0s
[06:26:34.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:53:0)
[06:26:34.382] Timer tick, asking Buildbucket for the build status
[06:26:34.496] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:34.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:54:0) after 1m0s
[06:27:34.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:54:0)
[06:27:34.538] Timer tick, asking Buildbucket for the build status
[06:27:34.610] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:34.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:55:0) after 1m0s
[06:28:34.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:55:0)
[06:28:34.801] Timer tick, asking Buildbucket for the build status
[06:28:34.975] Build 8858335767966655360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:34.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023765831743348144:56:0) after 1m0s
[06:29:06.558] Received PubSub notification, asking Buildbucket for the build status
[06:29:06.625] Build 8858335767966655360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:29:06.625] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610432945764093",
"created_by": "project:chromium",
"created_ts": "1610429714195123",
"id": "8858335767966655360",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2af43d0146c9ab7f4c69292676bd0e8d58a17025\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"2af43d0146c9ab7f4c69292676bd0e8d58a17025\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-1-ervs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16770, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"2c65da28a2ee7c56e5aab44aeb3557e163410d94\", \"got_dawn_revision\": \"ea26a8ce553fe2efa94830f3d7326072487bde3f\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"2af43d0146c9ab7f4c69292676bd0e8d58a17025\", \"got_revision_cp\": \"refs/heads/master@{#842389}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"43ed322b6a782285f8fcfbaadd3926c371c3a60b\", \"got_v8_revision_cp\": \"refs/heads/8.9.241@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2af43d0146c9ab7f4c69292676bd0e8d58a17025\", \"swarm_hashes_refs/heads/master(at){#842389}_without_patch\": {\"absl_hardening_tests\": \"39947578cad4b4944d238c2e290f470ecd715e06\", \"accessibility_unittests\": \"84aa036d82e3435981304e6a90fd81784be49408\", \"angle_unittests\": \"031f81ea1baf2300190ed94586042c8fa7999d73\", \"app_shell_unittests\": \"d225ef1fe4d643c2d6d0802c07a216ac61524bf3\", \"aura_unittests\": \"f87ac14898c1333551b7e2ea88d43db418a401b8\", \"base_unittests\": \"a870141fecfddb6bf082f4e0a75db9e60061f6a5\", \"base_util_unittests\": \"800ba2cc0e6a277e72c249fe37a7d999f3929c7e\", \"blink_common_unittests\": \"bae78c37bbc0a9ad5bc873dc58c04584c2dcfbc1\", \"blink_fuzzer_unittests\": \"ae9ddc6c55a227eab63d314ac4f1a5fadd0317d2\", \"blink_heap_unittests\": \"4f00954e47d27874372c48e1b9f17bd002cdfad1\", \"blink_platform_unittests\": \"79dd8f1e48f0016681319c8b0fb9165660d09855\", \"blink_unittests\": \"22fdd489729b3bc4e2eba02dcbbffdb1d12ba192\", \"boringssl_crypto_tests\": \"170dbbe5a69c12612507a65ff9eab6a6d9a94e6e\", \"boringssl_ssl_tests\": \"846d68e10ac80200edc8c8161b0f05e14a1cedb5\", \"browser_switcher_bho_unittests\": \"ebba3240b94c1ff09a05e3d559f51d8d76023665\", \"browser_tests\": \"cb168a1726d47f33bf2b5e869cb15d0cca863e1a\", \"capture_unittests\": \"1ae0f23698597049584f1ee9148864a999ff3b03\", \"cast_unittests\": \"4d65109ec736124acc23625bbb3a08b3f59c60ac\", \"cc_unittests\": \"c60bac21a359273c899b5028d475223603de070d\", \"chrome_app_unittests\": \"17764881ea9d49d3b5a35d25b6555e8c4c6ad122\", \"chrome_cleaner_unittests\": \"ecdd754989daf95fb3fbd2d41847177e5acc48fe\", \"chrome_elf_unittests\": \"f98906477b1038608b2ae5cb4f5470539b1c14aa\", \"chromedriver_unittests\": \"6be72677a7be11764338ac5b6ae52ba882ef07e1\", \"components_browsertests\": \"979bde0c47c90361afbe1cfdf27a789bc78c80bf\", \"components_unittests\": \"37717d3b67da03af6f8f493b0db38da8ea25cf4b\", \"compositor_unittests\": \"2ffe3c25ac87a492575edeb9bc38fed5d82b4d85\", \"content_browsertests\": \"c56f4908a6a5b8051ee24c3adf26e6e7b272f57d\", \"content_unittests\": \"cc013d33f86cb84fe54bdacc71e88d664a6e91d3\", \"courgette_unittests\": \"762ca72eb01e26642a15fac137d2d1da13646abd\", \"crashpad_tests\": \"ab26af0352985d1a4f58c4afb2b8ba2026f2d6ec\", \"cronet_tests\": \"9bc6eaa48525f9d27cc3ed44686b8f663ffea037\", \"cronet_unittests\": \"f60e5861ebcea4e9ad889e56de0848a3b50c0687\", \"crypto_unittests\": \"a5fca417f6faef9bc3ccaee3d292f3e62a371e55\", \"delayloads_unittests\": \"697d2f565c82b880e44167b2f882b94babc2921e\", \"device_unittests\": \"9df961e2e375ae0577965a51f96a295e3f10c3a7\", \"display_unittests\": \"d30cfb787b99b8490be098c058f76de62558b567\", \"elevation_service_unittests\": \"22a85184f0e13f86a2bebc1c447ee93b15490b92\", \"events_unittests\": \"00d6563efbbb3098930bda159f1ecf4f1522ed43\", \"extensions_browsertests\": \"47847078f69f396cdfd09547acfe9b5ffae29ded\", \"extensions_unittests\": \"c7182597c4cc890edc900df394ce3eca7e2bd4b8\", \"filesystem_service_unittests\": \"149fded819ea8a085e99d2c39c5b0c0de7a7a7fa\", \"gcm_unit_tests\": \"8f836a10e6a3e40b7d2641c45dbdedf99a6a1449\", \"gcp_unittests\": \"9bc9a294bc644eb3160c5c3beac6f736cb821fcc\", \"gfx_unittests\": \"1723364c44d4d24b114e36e4cfaf787df741ee2c\", \"gin_unittests\": \"26ffbf640a58915ed59565d5f0a01e5f55cc4392\", \"google_apis_unittests\": \"15a90aa250a429deff58705348e2881182d5053a\", \"gpu_unittests\": \"e547d7036456bb680567ca76b3d20c47beb1f26b\", \"gwp_asan_unittests\": \"b5335895f33b4abb0188adec793609987f65d04b\", \"headless_browsertests\": \"e138885737b1da667c249f211e3445bd15496200\", \"headless_unittests\": \"49019017888fe19522a2f223ff4f69501a8d36fa\", \"install_static_unittests\": \"9e64838934cecf142619169de6faa581ec4ded18\", \"installer_util_unittests\": \"8335e3d42779337866f77c7184379943d37db450\", \"interactive_ui_tests\": \"65bcb7fb20d3b9e417ec57dc957adf2598b47cd2\", \"ipc_tests\": \"86c7479f2d11d8da5e4bba64a751350491b3ccaf\", \"jingle_unittests\": \"bc78a7f70f693dd575d38634239a411ad31edd18\", \"latency_unittests\": \"ab2e440ae6974553fbe95be81d46ee5b90eaf5ea\", \"libjingle_xmpp_unittests\": \"52de022dc22a287bc1ed2839b2e23b879e0022ab\", \"liburlpattern_unittests\": \"75ba19a0dea304bd6eb561e6f0a96c023b8b2cce\", \"media_blink_unittests\": \"7c7047874012c41debffc9e55d2487349b8bffde\", \"media_unittests\": \"e5cff064bd77a31c586c9375cc76ba24e63b1a0a\", \"message_center_unittests\": \"91e85d51b2e10d4689f64c2f84fa4ffac48ebcb0\", \"midi_unittests\": \"f3b308cd75a8b85fac5f83f0fbc4ada6d7883933\", \"mojo_core_unittests\": \"fa9f3e30eb7f093b0e37f82e20b063d2c535648a\", \"mojo_unittests\": \"7d835d610943fc15e12c01f0716319ba9c090c41\", \"nacl_loader_unittests\": \"9a5829bb2fde371d04dae5a5a15c4263a893625c\", \"native_theme_unittests\": \"7b54e6eaf0fc09f22ba69c41c9cbaf57dc73635f\", \"net_unittests\": \"d7262afb5142ebc1167e2927bb02d2f8bcb128ab\", \"notification_helper_unittests\": \"300b26deccbde98a8d73a350146821de5f544df0\", \"pdf_unittests\": \"facc4899f0fbcc9967f9afc575e5275c893362ec\", \"perfetto_unittests\": \"d742e30d9bd4c65c866853c91ac11c62feb159f3\", \"ppapi_unittests\": \"4427a6bca194325bc7a624941a41bf7309b98c4b\", \"printing_unittests\": \"781a685762b76c9e3102dfe34f1a3ff56eefedfa\", \"remoting_unittests\": \"e1d1a73c25b6ed19ea1fb2c947c1d661710423ea\", \"sbox_integration_tests\": \"af187132fcc3e20595faa3ffd11695ff956baa5a\", \"sbox_unittests\": \"fdc8c01dae39594e6d62e1ebeff3ca88215207e0\", \"sbox_validation_tests\": \"c68bb41cf5722446eaf3229b3283b967ae6e7a82\", \"service_manager_unittests\": \"f0895428ff8d6d04d69be8565ac50b67976c5afe\", \"services_unittests\": \"254c2fa115ba504fb3238447f32d7ca19c8b020a\", \"setup_unittests\": \"9b2e2983b948a492aaa9ea88f681b8c5a1b047b1\", \"shell_dialogs_unittests\": \"ecfb16d163cc4d230a90636a0c5eb18162215b18\", \"skia_unittests\": \"93a96fcb2c86887dc3314c0e2647cafc01f4228f\", \"snapshot_unittests\": \"4aa15d1f30c77004bf71d4c426f4491240a08e03\", \"sql_unittests\": \"574b2fae6b73b55f822c7ba09b50ee3cf35565db\", \"storage_unittests\": \"fb2ec0884eb905f65f0114d9216182f56ffeef2f\", \"sync_integration_tests\": \"8b69fabde4ed06b18afe6dff738c36f0440a52df\", \"traffic_annotation_auditor_unittests\": \"b17b353112748e4e6f24fe8631b52dffeb90082b\", \"ui_base_unittests\": \"c97cb4541df515ee2bf3c156a04a75118f5a74ad\", \"ui_touch_selection_unittests\": \"8741b61d2f03feaea59745b98146448ac9f02e21\", \"unit_tests\": \"26e833dec12c98949e1a322f00a90a8ddd338f15\", \"updater_tests\": \"a0886e28c198027c07da7c27298c87d4680b50ec\", \"url_unittests\": \"3cf39c8679f37c7a057460d382d26ee9a28b17a1\", \"views_unittests\": \"0498998b51f29a0600219b403791f1960b550780\", \"viz_unittests\": \"e1aaf683c66b967a2951eb3eae80cbebd61df73b\", \"vr_common_unittests\": \"da0bdf90fb9d6c53fbba374cef4431b4493a5a31\", \"vr_pixeltests\": \"23c9b0451621d23c4f9dff9ba57f6c2f9e3ea988\", \"weblayer_browsertests\": \"0f7d6a16dbce33c22059f217082eb8e051abfb5b\", \"weblayer_unittests\": \"5e7d18d39855890255fc43f655508e8a0d51c6e6\", \"wm_unittests\": \"0264fb90f309236b306f407419da9650f45beeaa\", \"wtf_unittests\": \"904215f2a9b49a86596122233c78a53f25c343fc\", \"zlib_unittests\": \"d327ec5ddfe03de3724d7af6cbca38cb5bcad0de\", \"zucchini_unittests\": \"5b4a35d76a5156d73f0269d42d294a2eb211fcfd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-ervs\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610429719795709",
"status": "COMPLETED",
"status_changed_ts": "1610432945978312",
"tags": [
"build_address:luci.chromium.ci/win-asan/16770",
"builder:win-asan",
"buildset:commit/git/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2af43d0146c9ab7f4c69292676bd0e8d58a17025",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023765831743348144",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858335767966655360/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:510de8de6f777b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610432945983190",
"url": "https://ci.chromium.org/b/8858335767966655360",
"utcnow_ts": "1610432946617133"
}
}
[06:29:06.625] Invocation finished in 53m55.414434826s with status SUCCEEDED