[16:50:14.958] New invocation is queued and will start shortly
[16:50:16.155] Starting the invocation (attempt 1)
[16:50:16.197] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:50:16.197] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:50:16.198] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028434402754181088",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028434402754181088",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"gitiles_ref:refs/heads/master"
]
}
[16:50:16.859] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605977416284294",
"id": "8863004340700784384",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605977416742552",
"tags": [
"build_address:luci.chromium.ci/win-asan/15763",
"builder:win-asan",
"buildset:commit/git/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028434402754181088",
"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/8863004340700784384/+/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": "1605977416742739",
"url": "https://ci.chromium.org/b/8863004340700784384",
"utcnow_ts": "1605977416851553"
}
}
[16:50:16.859] Task URL: https://ci.chromium.org/b/8863004340700784384
[16:50:16.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:2:0) after 1m0s
[16:50:20.158] Received PubSub notification, asking Buildbucket for the build status
[16:50:20.303] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:16.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:2:0)
[16:51:16.989] Timer tick, asking Buildbucket for the build status
[16:51:17.069] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:17.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:4:0) after 1m0s
[16:52:17.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:4:0)
[16:52:17.127] Timer tick, asking Buildbucket for the build status
[16:52:17.228] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:17.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:5:0) after 1m0s
[16:53:17.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:5:0)
[16:53:17.254] Timer tick, asking Buildbucket for the build status
[16:53:17.353] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:17.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:6:0) after 1m0s
[16:54:17.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:6:0)
[16:54:17.389] Timer tick, asking Buildbucket for the build status
[16:54:17.490] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:17.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:7:0) after 1m0s
[16:55:17.575] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:7:0)
[16:55:17.575] Timer tick, asking Buildbucket for the build status
[16:55:17.670] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:8:0) after 1m0s
[16:56:17.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:8:0)
[16:56:17.759] Timer tick, asking Buildbucket for the build status
[16:56:18.145] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:18.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:9:0) after 1m0s
[16:57:18.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:9:0)
[16:57:18.120] Timer tick, asking Buildbucket for the build status
[16:57:18.248] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:18.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:10:0) after 1m0s
[16:58:18.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:10:0)
[16:58:18.295] Timer tick, asking Buildbucket for the build status
[16:58:18.519] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:18.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:11:0) after 1m0s
[16:59:18.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:11:0)
[16:59:18.565] Timer tick, asking Buildbucket for the build status
[16:59:18.647] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:18.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:12:0) after 1m0s
[17:00:18.706] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:12:0)
[17:00:18.706] Timer tick, asking Buildbucket for the build status
[17:00:18.822] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:18.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:13:0) after 1m0s
[17:01:18.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:13:0)
[17:01:18.843] Timer tick, asking Buildbucket for the build status
[17:01:18.926] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:18.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:14:0) after 1m0s
[17:02:19.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:14:0)
[17:02:19.014] Timer tick, asking Buildbucket for the build status
[17:02:19.070] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:19.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:15:0) after 1m0s
[17:03:19.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:15:0)
[17:03:19.133] Timer tick, asking Buildbucket for the build status
[17:03:20.107] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:20.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:16:0) after 1m0s
[17:04:20.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:16:0)
[17:04:20.127] Timer tick, asking Buildbucket for the build status
[17:04:20.237] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:20.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:17:0) after 1m0s
[17:05:20.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:17:0)
[17:05:20.257] Timer tick, asking Buildbucket for the build status
[17:05:20.353] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:18:0) after 1m0s
[17:06:20.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:18:0)
[17:06:20.367] Timer tick, asking Buildbucket for the build status
[17:06:20.605] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:19:0) after 1m0s
[17:07:20.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:19:0)
[17:07:20.636] Timer tick, asking Buildbucket for the build status
[17:07:21.061] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:21.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:20:0) after 1m0s
[17:08:21.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:20:0)
[17:08:21.070] Timer tick, asking Buildbucket for the build status
[17:08:22.172] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:22.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:21:0) after 1m0s
[17:09:22.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:21:0)
[17:09:22.172] Timer tick, asking Buildbucket for the build status
[17:09:22.404] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:22.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:22:0) after 1m0s
[17:10:22.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:22:0)
[17:10:22.438] Timer tick, asking Buildbucket for the build status
[17:10:22.574] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:22.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:23:0) after 1m0s
[17:11:22.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:23:0)
[17:11:22.609] Timer tick, asking Buildbucket for the build status
[17:11:23.068] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:23.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:24:0) after 1m0s
[17:12:23.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:24:0)
[17:12:23.092] Timer tick, asking Buildbucket for the build status
[17:12:23.295] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:23.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:25:0) after 1m0s
[17:13:23.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:25:0)
[17:13:23.349] Timer tick, asking Buildbucket for the build status
[17:13:23.760] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:23.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:26:0) after 1m0s
[17:14:23.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:26:0)
[17:14:23.817] Timer tick, asking Buildbucket for the build status
[17:14:23.939] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:23.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:27:0) after 1m0s
[17:15:24.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:27:0)
[17:15:24.062] Timer tick, asking Buildbucket for the build status
[17:15:24.203] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:24.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:28:0) after 1m0s
[17:16:24.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:28:0)
[17:16:24.209] Timer tick, asking Buildbucket for the build status
[17:16:24.334] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:24.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:29:0) after 1m0s
[17:17:24.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:29:0)
[17:17:24.352] Timer tick, asking Buildbucket for the build status
[17:17:24.466] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:24.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:30:0) after 1m0s
[17:18:24.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:30:0)
[17:18:24.502] Timer tick, asking Buildbucket for the build status
[17:18:24.695] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:24.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:31:0) after 1m0s
[17:19:24.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:31:0)
[17:19:24.746] Timer tick, asking Buildbucket for the build status
[17:19:25.127] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:32:0) after 1m0s
[17:20:25.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:32:0)
[17:20:25.153] Timer tick, asking Buildbucket for the build status
[17:20:25.324] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:25.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:33:0) after 1m0s
[17:21:25.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:33:0)
[17:21:25.327] Timer tick, asking Buildbucket for the build status
[17:21:25.710] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:25.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:34:0) after 1m0s
[17:22:25.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:34:0)
[17:22:25.736] Timer tick, asking Buildbucket for the build status
[17:22:25.876] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:25.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:35:0) after 1m0s
[17:23:25.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:35:0)
[17:23:25.900] Timer tick, asking Buildbucket for the build status
[17:23:26.012] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:26.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:36:0) after 1m0s
[17:24:26.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:36:0)
[17:24:26.032] Timer tick, asking Buildbucket for the build status
[17:24:26.305] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:26.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:37:0) after 1m0s
[17:25:26.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:37:0)
[17:25:26.355] Timer tick, asking Buildbucket for the build status
[17:25:26.710] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:26.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:38:0) after 1m0s
[17:26:26.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:38:0)
[17:26:26.858] Timer tick, asking Buildbucket for the build status
[17:26:27.302] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:27.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:39:0) after 1m0s
[17:27:27.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:39:0)
[17:27:27.352] Timer tick, asking Buildbucket for the build status
[17:27:27.510] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:27.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:40:0) after 1m0s
[17:28:27.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:40:0)
[17:28:27.529] Timer tick, asking Buildbucket for the build status
[17:28:28.194] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:28.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:41:0) after 1m0s
[17:29:28.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:41:0)
[17:29:28.215] Timer tick, asking Buildbucket for the build status
[17:29:28.359] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:28.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:42:0) after 1m0s
[17:30:28.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:42:0)
[17:30:28.383] Timer tick, asking Buildbucket for the build status
[17:30:28.509] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:28.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:43:0) after 1m0s
[17:31:28.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:43:0)
[17:31:28.541] Timer tick, asking Buildbucket for the build status
[17:31:29.014] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:29.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:44:0) after 1m0s
[17:32:29.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:44:0)
[17:32:29.053] Timer tick, asking Buildbucket for the build status
[17:32:29.183] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:29.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:45:0) after 1m0s
[17:33:29.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:45:0)
[17:33:29.205] Timer tick, asking Buildbucket for the build status
[17:33:29.304] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:29.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:46:0) after 1m0s
[17:34:31.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:46:0)
[17:34:31.671] Timer tick, asking Buildbucket for the build status
[17:34:31.767] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:31.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:47:0) after 1m0s
[17:35:31.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:47:0)
[17:35:31.850] Timer tick, asking Buildbucket for the build status
[17:35:31.968] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:31.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:48:0) after 1m0s
[17:36:32.073] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:48:0)
[17:36:32.073] Timer tick, asking Buildbucket for the build status
[17:36:32.313] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:49:0) after 1m0s
[17:37:32.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:49:0)
[17:37:32.329] Timer tick, asking Buildbucket for the build status
[17:37:32.446] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:32.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:50:0) after 1m0s
[17:38:32.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:50:0)
[17:38:32.489] Timer tick, asking Buildbucket for the build status
[17:38:32.604] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:32.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:51:0) after 1m0s
[17:39:32.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:51:0)
[17:39:32.626] Timer tick, asking Buildbucket for the build status
[17:39:32.725] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:32.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:52:0) after 1m0s
[17:40:32.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:52:0)
[17:40:32.746] Timer tick, asking Buildbucket for the build status
[17:40:32.880] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:32.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:53:0) after 1m0s
[17:41:32.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:53:0)
[17:41:32.930] Timer tick, asking Buildbucket for the build status
[17:41:33.102] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:33.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:54:0) after 1m0s
[17:42:33.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:54:0)
[17:42:33.176] Timer tick, asking Buildbucket for the build status
[17:42:33.311] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:55:0) after 1m0s
[17:43:33.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:55:0)
[17:43:33.394] Timer tick, asking Buildbucket for the build status
[17:43:33.468] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:33.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:56:0) after 1m0s
[17:44:33.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:56:0)
[17:44:33.466] Timer tick, asking Buildbucket for the build status
[17:44:33.545] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:33.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:57:0) after 1m0s
[17:45:33.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:57:0)
[17:45:33.536] Timer tick, asking Buildbucket for the build status
[17:45:33.673] Build 8863004340700784384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:33.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028434402754181088:58:0) after 1m0s
[17:46:18.969] Received PubSub notification, asking Buildbucket for the build status
[17:46:19.071] Build 8863004340700784384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:46:19.071] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605980777651893",
"created_by": "project:chromium",
"created_ts": "1605977416284294",
"id": "8863004340700784384",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\"}}",
"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\": \"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\", \"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-32-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15763, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\", \"got_revision_cp\": \"refs/heads/master@{#829996}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"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\": \"522973e6906e1e91f3e8f594fdd756fbcaa2dc2e\", \"swarm_hashes_refs/heads/master(at){#829996}_without_patch\": {\"absl_hardening_tests\": \"03f8cf3a2f4169627e0ed28ba69c5c84c44e9bca\", \"accessibility_unittests\": \"fb53dc171b0a719d0aab3c657cd47e0319bf9b4f\", \"angle_unittests\": \"61d00a2ca7432bf2f24d1cfe2e38adfe0b5dada6\", \"app_shell_unittests\": \"6c3d7c8c252c60eee28e738afc5d6e0fb8a3cb24\", \"aura_unittests\": \"7f3e44ec9a4f08c3446356586239fe6c4c54fe35\", \"base_unittests\": \"b17ffdd03697a33f343c1c2a67807ddb161c7985\", \"base_util_unittests\": \"812836bc6dd6835f64320125857ead7b6fcb58da\", \"blink_common_unittests\": \"adc22442737a39f7feb1177029deaec9c9f16104\", \"blink_fuzzer_unittests\": \"2a263181914dff76aad9e834388beec9d70cf158\", \"blink_heap_unittests\": \"b294e8893d416465bf3b2fbfec08638cb0d337c4\", \"blink_platform_unittests\": \"0faf563c5c558cf0c9b32d068f619632c3c07c66\", \"blink_unittests\": \"b26c049a2aad5ca0e2d1f15bad83ca110cc85d36\", \"boringssl_crypto_tests\": \"437c75175903f17674a9426a491631b4128312e4\", \"boringssl_ssl_tests\": \"f4ff432e1af43e5acb487de694833bb9c814729b\", \"browser_switcher_bho_unittests\": \"919516cdd26c2924eef5e801aba557510c19e98d\", \"browser_tests\": \"ff1007086245bb80315201e8ef58ff5fd9d0c0f6\", \"capture_unittests\": \"c59e2862d479d275ee14875e0b1361cda16f9131\", \"cast_unittests\": \"2e81114622f67db4173bd0819448ed199add6ea0\", \"cc_unittests\": \"d42a98bbc33f8d3965b854c372205943f0863ebf\", \"chrome_app_unittests\": \"b006ce67e26db7c9ab310d876993b6fcc140152a\", \"chrome_cleaner_unittests\": \"7b80ca66f96ea4228110f27f40ec6928a7e0c0ca\", \"chrome_elf_unittests\": \"4511c286709cef436df46221c379496351604fc7\", \"chromedriver_unittests\": \"e26701dfc7dfb725e6698f651566cfce464bcd31\", \"components_browsertests\": \"e3db761b009c3bac51c7e81d65e103fb3835cfe0\", \"components_unittests\": \"a814eddebca2711be5ec0c01670a834d5697777a\", \"compositor_unittests\": \"d5129f93580bd6a52c4b28e7323051035dc05ab4\", \"content_browsertests\": \"6aeeccb260cbc4c9e1a59101fc170e71a3c42af0\", \"content_unittests\": \"0d842296b87112d15fd6e92c23059e67242ed799\", \"courgette_unittests\": \"a17f5074c9c443370901ebbd313a73fad4f2232d\", \"crashpad_tests\": \"2fa8caccdc442fd1d58e8af08fc7595ed23482c8\", \"cronet_tests\": \"64a1a87b84d94ba28aa36b43e4349cb99bb90ceb\", \"cronet_unittests\": \"77db119592d5c1ef68e9c029cfddd9430a31f9f6\", \"crypto_unittests\": \"3da2dbc00740440fb318d4c7ff7565d884f2c7d4\", \"delayloads_unittests\": \"694a256a798c8883d9008f50b28800aae267f4ee\", \"device_unittests\": \"b20cb146188d38e07c7cbb4f78a75f7536254792\", \"display_unittests\": \"0e7859cfabf5c929767bb12e87ee08954c1ffd2f\", \"elevation_service_unittests\": \"c57bd4e9a125a05bf8a6070836f5aacc9f8c127a\", \"events_unittests\": \"15216aaf8975385acca07773566d8205a09513d6\", \"extensions_browsertests\": \"a086c82344d45c0c16d22d25afd532c15056a0a8\", \"extensions_unittests\": \"469864709007e6d2c9790360009c878236757f0c\", \"filesystem_service_unittests\": \"fdac573d1382394d2f151c6d3bfbeb63e15a0cc3\", \"gcm_unit_tests\": \"f57052a52de0643e7f742d3751f42fd1513c1717\", \"gcp_unittests\": \"1fddea77a2a35898359e516d7aad9c724fe30215\", \"gfx_unittests\": \"d4ca301da81f9aae8f2a17134575b0de28a7955a\", \"gin_unittests\": \"f3c145ba478a44a5a280790d3f2f8f22aa41d9e1\", \"google_apis_unittests\": \"8f85a3448b172e3a4a8e47a1bea93f3abbf09a66\", \"gpu_unittests\": \"600b8d882b615314b56fa3dd8ea9e11a4f966058\", \"gwp_asan_unittests\": \"d089adbe34f9eb3581284df92e7c9b9cae7bf80e\", \"headless_browsertests\": \"4355aa3c6d6c9da1131ba38bc4563553b15ed892\", \"headless_unittests\": \"461e4cd0231962bb60f676f4da0f0d4230944fe6\", \"install_static_unittests\": \"2edf1b7d23afcb4022d3824355ed553468a3e500\", \"installer_util_unittests\": \"2e13af3d160533e034d687573f82fd5da71c8535\", \"interactive_ui_tests\": \"5664acf460ab3752559afaec989b0cb374da4e17\", \"ipc_tests\": \"8a91f2ffb2683809f4c32af4109fa87e6e4cee65\", \"jingle_unittests\": \"c724bb89720f07bd799734ae38f279747592896d\", \"latency_unittests\": \"1104431caf1173a54aa4a519a628abb607982b19\", \"libjingle_xmpp_unittests\": \"572ece09f722d4c605e3b5329e22992e71ddf109\", \"liburlpattern_unittests\": \"4d9b160b32a730f6228271723d31ba3533ea8a90\", \"media_blink_unittests\": \"f7b96d261cb61c9b2e82c553e2b4f7206f903298\", \"media_unittests\": \"beafab018506e52496a18445730b1a92300f4e1b\", \"message_center_unittests\": \"ae97a484f5b257d320074647f185f438175d5fc0\", \"midi_unittests\": \"d1c87dca65125232d5addd6c538d49aa18b2b6dc\", \"mojo_core_unittests\": \"475f21aeb586ace23eee0c18ba22b4aafbea0bc3\", \"mojo_unittests\": \"95fe0fda746f2a7fb6ae4eee22844ad6975ec159\", \"nacl_loader_unittests\": \"cdb5ba9dd1906fc3015f463ef81bbb1079867160\", \"native_theme_unittests\": \"ca5738b52eba8b510209eb143e06c9c2b0991998\", \"net_unittests\": \"3cd506f18c18a86a4994dbfe009d8c251640b384\", \"notification_helper_unittests\": \"aced3c9138f1b3209cf59f42195fcfdd78e43abf\", \"pdf_unittests\": \"5e30f5261d4e9403a52eea84f05177459e3244a5\", \"perfetto_unittests\": \"82bd99ddee7719e34966774e38dc3b74958506d3\", \"ppapi_unittests\": \"da99c3159c5fc243f5f6de5b2e8f974c6213739b\", \"printing_unittests\": \"9f1492dfd85b14a4c1274e914e554430dd6e94a2\", \"remoting_unittests\": \"4483a6fa7ae3f22b904af6f1f85412396bd22150\", \"sbox_integration_tests\": \"e6bd515c87268308824a2c219974ac6df2d152d1\", \"sbox_unittests\": \"fb25190ce879ae23856e8fa9ec2df388ea4a81f0\", \"sbox_validation_tests\": \"73711daf6e4bee6a49876d8236a80596d9026575\", \"service_manager_unittests\": \"8a2b0f87cdf0eae2fd15ba3d92035ea7cf208c55\", \"services_unittests\": \"22fc9a4339ee1ca661f6fe74b466ee87faebdfda\", \"setup_unittests\": \"bb2ca24c54cac58f02caed9ef369d2f3543b6eb8\", \"shell_dialogs_unittests\": \"0c3e6c82a3ab78a4b9bd98385581b735936f9cbe\", \"skia_unittests\": \"23f518601809eec29f28ebf03b115857d16e4f55\", \"snapshot_unittests\": \"e04ae10d0e16b101dc24d6bbdb50df90cb781fa1\", \"sql_unittests\": \"b758c138cfee371b392954b82b108423636c39bc\", \"storage_unittests\": \"1e64a290d6a92bb825137fd4cd3a23895bf15394\", \"sync_integration_tests\": \"a2dd9670503b0250dd2917d0cdbb161305104c10\", \"traffic_annotation_auditor_unittests\": \"f47a08f7c985d97872e41dcc546da1e45a12b3a7\", \"ui_base_unittests\": \"8d9d0c42bc6315fd5f95dc4eb8df2e5174c64a2c\", \"ui_touch_selection_unittests\": \"10dc99cf467af7e1afaa6969936270d1088c431b\", \"unit_tests\": \"9fb8f2458b5fc66aceb4256aa515136968d26bfc\", \"updater_tests\": \"d4ddec938fcbc0c16c196f71532ce8f5fb452d43\", \"url_unittests\": \"6ad24ee46ed673531cf4d3fba2020f90e7f10499\", \"views_unittests\": \"73c525b19fabe009d7cd60e47d4468379f0fb452\", \"viz_unittests\": \"1dd2bfe1cb1cdda8b730ddb533f2a93de92a5e6f\", \"vr_common_unittests\": \"a41b492ef85d0f7c066d1d88bb44fdd1a619405d\", \"vr_pixeltests\": \"07f35866c594db896776d67e6dfe69687f287d7a\", \"weblayer_browsertests\": \"a74231ecbb7fcc7929ea3b195ec536da7cd7093f\", \"weblayer_unittests\": \"6dc9fb9e3e9d2ef8a33aaab9ef930ff3c3caf7cb\", \"wm_unittests\": \"61c952ad5a3d6aa74441fb99a98e4b44b215abf9\", \"wtf_unittests\": \"9b3a592a33ef0bffcaf4d28dc25a9f976daaf642\", \"zlib_unittests\": \"ba6da342d7ae880f9c35d222d5c5daa0c2a982a3\", \"zucchini_unittests\": \"75335a4920051e8a5388fc68fa6c32da0ae47dce\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xoby\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605977419270701",
"status": "COMPLETED",
"status_changed_ts": "1605980778132054",
"tags": [
"build_address:luci.chromium.ci/win-asan/15763",
"builder:win-asan",
"buildset:commit/git/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/522973e6906e1e91f3e8f594fdd756fbcaa2dc2e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028434402754181088",
"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/8863004340700784384/+/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:5004882d52af0210",
"user_agent:luci-scheduler"
],
"updated_ts": "1605980778141464",
"url": "https://ci.chromium.org/b/8863004340700784384",
"utcnow_ts": "1605980779057788"
}
}
[17:46:19.071] Invocation finished in 56m4.128838539s with status SUCCEEDED