[00:15:15.020] New invocation is queued and will start shortly
[00:15:16.084] Starting the invocation (attempt 1)
[00:15:16.116] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:15:16.116] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:15:16.116] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025507302788625664",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cca0dd73c5c2bc719f8152bd33599bd7799926be\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025507302788625664",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"gitiles_ref:refs/heads/master"
]
}
[00:15:16.940] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608768916259292",
"id": "8860077240822683856",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cca0dd73c5c2bc719f8152bd33599bd7799926be\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608768916811829",
"tags": [
"build_address:luci.chromium.ci/win-asan/16418",
"builder:win-asan",
"buildset:commit/git/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025507302788625664",
"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/8860077240822683856/+/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": "1608768916811935",
"url": "https://ci.chromium.org/b/8860077240822683856",
"utcnow_ts": "1608768916931924"
}
}
[00:15:16.940] Task URL: https://ci.chromium.org/b/8860077240822683856
[00:15:16.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:2:0) after 1m0s
[00:15:25.416] Received PubSub notification, asking Buildbucket for the build status
[00:15:25.504] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:17.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:2:0)
[00:16:17.034] Timer tick, asking Buildbucket for the build status
[00:16:17.130] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:17.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:4:0) after 1m0s
[00:17:17.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:4:0)
[00:17:17.246] Timer tick, asking Buildbucket for the build status
[00:17:17.358] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:5:0) after 1m0s
[00:18:17.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:5:0)
[00:18:17.496] Timer tick, asking Buildbucket for the build status
[00:18:17.837] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:17.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:6:0) after 1m0s
[00:19:17.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:6:0)
[00:19:17.945] Timer tick, asking Buildbucket for the build status
[00:19:18.141] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:18.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:7:0) after 1m0s
[00:20:18.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:7:0)
[00:20:18.249] Timer tick, asking Buildbucket for the build status
[00:20:18.382] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:18.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:8:0) after 1m0s
[00:21:18.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:8:0)
[00:21:18.478] Timer tick, asking Buildbucket for the build status
[00:21:18.593] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:18.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:9:0) after 1m0s
[00:22:18.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:9:0)
[00:22:18.658] Timer tick, asking Buildbucket for the build status
[00:22:18.717] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:10:0) after 1m0s
[00:23:18.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:10:0)
[00:23:18.772] Timer tick, asking Buildbucket for the build status
[00:23:18.832] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:18.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:11:0) after 1m0s
[00:24:19.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:11:0)
[00:24:19.077] Timer tick, asking Buildbucket for the build status
[00:24:19.148] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:19.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:12:0) after 1m0s
[00:25:19.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:12:0)
[00:25:19.411] Timer tick, asking Buildbucket for the build status
[00:25:19.541] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:19.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:13:0) after 1m0s
[00:26:19.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:13:0)
[00:26:19.559] Timer tick, asking Buildbucket for the build status
[00:26:19.689] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:19.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:14:0) after 1m0s
[00:27:19.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:14:0)
[00:27:19.716] Timer tick, asking Buildbucket for the build status
[00:27:19.782] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:15:0) after 1m0s
[00:28:19.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:15:0)
[00:28:19.984] Timer tick, asking Buildbucket for the build status
[00:28:20.122] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:20.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:16:0) after 1m0s
[00:29:20.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:16:0)
[00:29:20.321] Timer tick, asking Buildbucket for the build status
[00:29:20.477] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:20.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:17:0) after 1m0s
[00:30:20.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:17:0)
[00:30:20.659] Timer tick, asking Buildbucket for the build status
[00:30:20.828] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:20.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:18:0) after 1m0s
[00:31:21.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:18:0)
[00:31:21.001] Timer tick, asking Buildbucket for the build status
[00:31:21.160] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:21.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:19:0) after 1m0s
[00:32:21.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:19:0)
[00:32:21.216] Timer tick, asking Buildbucket for the build status
[00:32:21.461] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:21.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:20:0) after 1m0s
[00:33:21.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:20:0)
[00:33:21.957] Timer tick, asking Buildbucket for the build status
[00:33:22.107] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:22.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:21:0) after 1m0s
[00:34:22.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:21:0)
[00:34:22.317] Timer tick, asking Buildbucket for the build status
[00:34:22.475] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:22.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:22:0) after 1m0s
[00:35:22.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:22:0)
[00:35:22.755] Timer tick, asking Buildbucket for the build status
[00:35:22.867] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:22.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:23:0) after 1m0s
[00:36:23.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:23:0)
[00:36:23.009] Timer tick, asking Buildbucket for the build status
[00:36:23.155] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:23.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:24:0) after 1m0s
[00:37:23.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:24:0)
[00:37:23.253] Timer tick, asking Buildbucket for the build status
[00:37:23.388] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:23.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:25:0) after 1m0s
[00:38:23.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:25:0)
[00:38:23.422] Timer tick, asking Buildbucket for the build status
[00:38:23.590] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:26:0) after 1m0s
[00:39:23.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:26:0)
[00:39:23.711] Timer tick, asking Buildbucket for the build status
[00:39:23.799] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:27:0) after 1m0s
[00:40:23.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:27:0)
[00:40:23.802] Timer tick, asking Buildbucket for the build status
[00:40:24.119] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:24.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:28:0) after 1m0s
[00:41:24.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:28:0)
[00:41:24.127] Timer tick, asking Buildbucket for the build status
[00:41:24.209] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:24.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:29:0) after 1m0s
[00:42:24.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:29:0)
[00:42:24.266] Timer tick, asking Buildbucket for the build status
[00:42:24.500] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:24.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:30:0) after 1m0s
[00:43:24.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:30:0)
[00:43:24.579] Timer tick, asking Buildbucket for the build status
[00:43:24.666] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:24.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:31:0) after 1m0s
[00:44:24.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:31:0)
[00:44:24.677] Timer tick, asking Buildbucket for the build status
[00:44:24.832] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:24.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:32:0) after 1m0s
[00:45:25.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:32:0)
[00:45:25.001] Timer tick, asking Buildbucket for the build status
[00:45:25.118] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:33:0) after 1m0s
[00:46:25.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:33:0)
[00:46:25.139] Timer tick, asking Buildbucket for the build status
[00:46:25.351] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:25.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:34:0) after 1m0s
[00:47:25.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:34:0)
[00:47:25.372] Timer tick, asking Buildbucket for the build status
[00:47:25.895] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:25.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:35:0) after 1m0s
[00:48:25.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:35:0)
[00:48:25.990] Timer tick, asking Buildbucket for the build status
[00:48:26.174] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:26.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:36:0) after 1m0s
[00:49:26.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:36:0)
[00:49:26.230] Timer tick, asking Buildbucket for the build status
[00:49:26.734] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:26.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:37:0) after 1m0s
[00:50:26.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:37:0)
[00:50:26.745] Timer tick, asking Buildbucket for the build status
[00:50:27.401] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:27.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:38:0) after 1m0s
[00:51:27.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:38:0)
[00:51:27.445] Timer tick, asking Buildbucket for the build status
[00:51:27.708] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:27.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:39:0) after 1m0s
[00:52:27.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:39:0)
[00:52:27.782] Timer tick, asking Buildbucket for the build status
[00:52:28.113] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:28.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:40:0) after 1m0s
[00:53:28.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:40:0)
[00:53:28.099] Timer tick, asking Buildbucket for the build status
[00:53:28.288] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:41:0) after 1m0s
[00:54:28.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:41:0)
[00:54:28.322] Timer tick, asking Buildbucket for the build status
[00:54:28.455] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:28.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:42:0) after 1m0s
[00:55:28.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:42:0)
[00:55:28.550] Timer tick, asking Buildbucket for the build status
[00:55:28.640] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:43:0) after 1m0s
[00:56:28.778] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:43:0)
[00:56:28.778] Timer tick, asking Buildbucket for the build status
[00:56:29.437] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:44:0) after 1m0s
[00:57:29.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:44:0)
[00:57:29.556] Timer tick, asking Buildbucket for the build status
[00:57:29.995] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:29.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:45:0) after 1m0s
[00:58:30.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:45:0)
[00:58:30.038] Timer tick, asking Buildbucket for the build status
[00:58:30.168] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:30.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:46:0) after 1m0s
[00:59:30.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:46:0)
[00:59:30.187] Timer tick, asking Buildbucket for the build status
[00:59:30.269] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:30.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:47:0) after 1m0s
[01:00:30.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:47:0)
[01:00:30.687] Timer tick, asking Buildbucket for the build status
[01:00:30.835] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:48:0) after 1m0s
[01:01:31.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:48:0)
[01:01:31.379] Timer tick, asking Buildbucket for the build status
[01:01:31.529] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:31.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:49:0) after 1m0s
[01:02:31.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:49:0)
[01:02:31.793] Timer tick, asking Buildbucket for the build status
[01:02:31.879] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:31.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:50:0) after 1m0s
[01:03:32.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:50:0)
[01:03:32.209] Timer tick, asking Buildbucket for the build status
[01:03:32.291] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:32.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:51:0) after 1m0s
[01:04:32.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:51:0)
[01:04:32.611] Timer tick, asking Buildbucket for the build status
[01:04:32.820] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:32.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:52:0) after 1m0s
[01:05:33.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:52:0)
[01:05:33.070] Timer tick, asking Buildbucket for the build status
[01:05:33.483] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:33.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:53:0) after 1m0s
[01:06:33.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:53:0)
[01:06:33.527] Timer tick, asking Buildbucket for the build status
[01:06:33.805] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:33.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:54:0) after 1m0s
[01:07:33.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:54:0)
[01:07:33.782] Timer tick, asking Buildbucket for the build status
[01:07:34.174] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:34.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:55:0) after 1m0s
[01:08:34.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:55:0)
[01:08:34.576] Timer tick, asking Buildbucket for the build status
[01:08:34.720] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:34.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:56:0) after 1m0s
[01:09:34.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:56:0)
[01:09:34.748] Timer tick, asking Buildbucket for the build status
[01:09:34.853] Build 8860077240822683856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:34.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025507302788625664:57:0) after 1m0s
[01:10:06.786] Received PubSub notification, asking Buildbucket for the build status
[01:10:06.862] Build 8860077240822683856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:10:06.862] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608772205785212",
"created_by": "project:chromium",
"created_ts": "1608768916259292",
"id": "8860077240822683856",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cca0dd73c5c2bc719f8152bd33599bd7799926be\"}}",
"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\": \"cca0dd73c5c2bc719f8152bd33599bd7799926be\", \"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-6-gpyc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16418, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"c500ee031d36ae8485a6ff657b2e870ed1de08c4\", \"got_dawn_revision\": \"a4fb42ac92cc4fc391bc48b2d66f72065b3a1b69\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"cca0dd73c5c2bc719f8152bd33599bd7799926be\", \"got_revision_cp\": \"refs/heads/master@{#839211}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"711cf5ad4a12abe0f6b50058cb2248d7fb80374e\", \"got_v8_revision_cp\": \"refs/heads/8.9.187@{#1}\", \"got_webrtc_revision\": \"fec83cc8602580ce1c078f7cd4e7f4d2be4ac850\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32877}\", \"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\": \"cca0dd73c5c2bc719f8152bd33599bd7799926be\", \"swarm_hashes_refs/heads/master(at){#839211}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"f259e6e6b1e879b08f0a51b323e6d35f4fbae461\", \"angle_unittests\": \"c0f3927098f674fe683b534fd1a63132337f8637\", \"app_shell_unittests\": \"63ac79a74febb3013db6d5d5198b1e24923fb6a2\", \"aura_unittests\": \"253d8fb0ab1793641f7d0091a29ecde6f9bc0a6a\", \"base_unittests\": \"7a300f3a73fe4f21347fca447f4743905ab9542c\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"8a3dec75a4f66dc2f13893ea1f898fa1f9362136\", \"blink_fuzzer_unittests\": \"8ae20f9145ba16f13a1ee30eb9ac5fb9424756d5\", \"blink_heap_unittests\": \"9abc6dc3c9f536586eb06a70d4ad03f5518156f8\", \"blink_platform_unittests\": \"ad52059d99c041bc11e168601d4e1fef665ec1ca\", \"blink_unittests\": \"2507fd0286a6fa055ff6a45d9cdce356356b16e2\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"ebfcb8ebb9c1e8a3c8708121bb7f35e088b1fc26\", \"capture_unittests\": \"d55bef5e1d1664a94ba5ba9a1dff3272af5487bd\", \"cast_unittests\": \"7b6d8e63c4bb682ae375f84bc8782a32b83a8ff2\", \"cc_unittests\": \"281b26b5dab1885ce2000145db593c12bca5d5fa\", \"chrome_app_unittests\": \"160387d66d7916719bfa70f72f722faa3696aa94\", \"chrome_cleaner_unittests\": \"e33b92c20d1022023206d87209a7daf5903f4472\", \"chrome_elf_unittests\": \"f2aaacc67583739919e2c501549e18f5a7f84639\", \"chromedriver_unittests\": \"cbe25dd121fe24e6680d6309efd8622f31013c23\", \"components_browsertests\": \"6350671e4b6f11b01689adf978015185ffc2f440\", \"components_unittests\": \"e2e0a6295adae7df26cf6b742be752ca99acd3fd\", \"compositor_unittests\": \"e3f06bd36e3128c7d23efc2219adb5497466aec4\", \"content_browsertests\": \"92c7e7785e1b4bb72c0625086a3b05d5e1a8bcf0\", \"content_unittests\": \"9b03eedbb546b27c76afd2bfe6911419f8acb062\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"21b1527f2f9a816e15eaadc7961d454b567a9af2\", \"cronet_unittests\": \"5e87d89a57ebf0af8b4362686903d72610ab3e55\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"3aad427f608cec6717f7c0edcb5fbcd52be245ff\", \"device_unittests\": \"5de82a7d130a18b020fe81c2b291177fa088d5d4\", \"display_unittests\": \"25a8dd924ad0fea7e74e645e2789bad2f64ede04\", \"elevation_service_unittests\": \"ec353277b338257c4d8f17f27e6128bf9e7c8c87\", \"events_unittests\": \"c503f8314eec6b84997e9e42604d43ef0c7b8892\", \"extensions_browsertests\": \"7d83715ef0205ec92ca1837869cb623fb35fac95\", \"extensions_unittests\": \"0a573fde6f5044bcce27d29d18194feb64c07903\", \"filesystem_service_unittests\": \"d092594ef413e064bdeff37e62044f5b2a101bd6\", \"gcm_unit_tests\": \"121fc417656592333cea56eb55c1e830c077a078\", \"gcp_unittests\": \"871d7b815f584e8be68ee7ad6fbfd82c3e6f0df1\", \"gfx_unittests\": \"885ea230308c08d6608b5df1eb395c6a8c622e7b\", \"gin_unittests\": \"be87c5dc4264fc574b938f678825984e75e90b79\", \"google_apis_unittests\": \"b46ce6524a4bd2f330b17a1577550e863ad30e25\", \"gpu_unittests\": \"1c16d31d20d5fa14a4d5631d94fe466a5c862ed3\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"8bc0e2f7370eb377ed6e6147f21d77cf84aa2905\", \"headless_unittests\": \"a2346bf1caf0d70c744b224ffcd2d9f8d9cf8254\", \"install_static_unittests\": \"280548038f19c95a74f1ed98de8a493fa3a63f01\", \"installer_util_unittests\": \"a80121a842251b8cdfcda19c02e1410f34a97ebd\", \"interactive_ui_tests\": \"a08e9a65354bc102d9ee9d0080e69da9844812fd\", \"ipc_tests\": \"6d4f521b65028bd1d3c6c7257741261d315dce8b\", \"jingle_unittests\": \"d350c51f29b02a8ad442f12056ff921270da4ba1\", \"latency_unittests\": \"b53c593bfd092c39e48bf939cb054e6e23b63ac3\", \"libjingle_xmpp_unittests\": \"2ca994cb2da85c1c6fd970340d7618f54a90e9c3\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"df125af9dca713b889a2620124516e4818d935a8\", \"media_unittests\": \"2d379382ca957001eb642d4f01bc1b6b666517b0\", \"message_center_unittests\": \"4d40b1e89e4bff44bfa43ca6a4e490f135362113\", \"midi_unittests\": \"806b4f6b481d690ba397eefc8299e920aabff9e4\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"5d4f554f87ae78354552dfbfa7974a9e1dec6ee5\", \"nacl_loader_unittests\": \"68ca08409cffcc7c879d2ebc230248828523af0e\", \"native_theme_unittests\": \"54638d393307a801219fd7a16e55b7deb1c12114\", \"net_unittests\": \"174af46ccf001969f8170a643cf29fcf07e28d7a\", \"notification_helper_unittests\": \"4df6959f24517bf6fb67fe5a217bf24481d8c1cb\", \"pdf_unittests\": \"e78c161d8c65ae3293c8bfcf22e6edb27f15489b\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"121794be3f8cfd38837ed0b381b3847c462a720e\", \"printing_unittests\": \"d7a2671aca86321fa26255a6a9636653eac072a4\", \"remoting_unittests\": \"dd9f68a1d3318cd61630e92b6a84222bf3222bdd\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"7d88cba7efe5261ad660576f2c18ab74ac09ecef\", \"services_unittests\": \"590be452dca43efe98fa7fafa30b537d58d15c8d\", \"setup_unittests\": \"64fb6c6251a507a891adc37b0c85f7462b3d4b66\", \"shell_dialogs_unittests\": \"64eb5a5285c9190a4bc1607994041dd046149961\", \"skia_unittests\": \"b52fe2053d6f2b6a41fd61ca1dcd27f9111becd9\", \"snapshot_unittests\": \"3d5f12603b2521bfdb6b3f89180aebc30ef20b18\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"85ace7468d036eadfdf7745dfa6b7ce8bf554ad6\", \"sync_integration_tests\": \"0c670658d290f82daa8c55de82a2b5a3282d44eb\", \"traffic_annotation_auditor_unittests\": \"e02b203d0be6c4c522aee20986a6984fe4ac0337\", \"ui_base_unittests\": \"a81b09943f4d3695ef123aa85c2ed60eb713a9cb\", \"ui_touch_selection_unittests\": \"487f2e275415df58c82583ab7df666e3dace536e\", \"unit_tests\": \"68e3b7304add6f8d208f033df59e5ac24ef4acea\", \"updater_tests\": \"e474ee6f85b081a3edcb7e2e9b4fbf038fade280\", \"url_unittests\": \"84cdd9e2933f621b7eb029d145ce4c3acd541a47\", \"views_unittests\": \"481c5e6b673898bdbbadf9bb11ac5f9ba22eb1fe\", \"viz_unittests\": \"555607b1255bc7b4b44ab3f05f456f5429bc217e\", \"vr_common_unittests\": \"4fa4845c80bbcd0addfc28309815d5bd424412e0\", \"vr_pixeltests\": \"3f07046720ecdc284f1dd6a536f22ba53a7daf9a\", \"weblayer_browsertests\": \"7b69054c743f2c8e45fa1fd7614eec3c56114845\", \"weblayer_unittests\": \"a5f9caf280b9eb0ae77f8a697be1b28e77838515\", \"wm_unittests\": \"ed9a1ad5040b6c31f1fa78ecb83f4acedc93339e\", \"wtf_unittests\": \"1ff1b3920090fb003616dc82eeea08d0589c59a6\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"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-6-gpyc\"], \"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\": [\"5657-0417a3f\"], \"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": "1608768923973742",
"status": "COMPLETED",
"status_changed_ts": "1608772206095017",
"tags": [
"build_address:luci.chromium.ci/win-asan/16418",
"builder:win-asan",
"buildset:commit/git/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cca0dd73c5c2bc719f8152bd33599bd7799926be",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025507302788625664",
"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/8860077240822683856/+/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:50aaeb25d5633810",
"user_agent:luci-scheduler"
],
"updated_ts": "1608772206100831",
"url": "https://ci.chromium.org/b/8860077240822683856",
"utcnow_ts": "1608772206851796"
}
}
[01:10:06.862] Invocation finished in 54m51.860991802s with status SUCCEEDED