[13:47:38.895] New invocation is queued and will start shortly
[13:47:40.006] Starting the invocation (attempt 1)
[13:47:40.051] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:47:40.051] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:47:40.051] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029895442481243152",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aa1a5efea5303b40dde879d67110f9cdd20b3235\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029895442481243152",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"gitiles_ref:refs/heads/master"
]
}
[13:47:41.276] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604584060195520",
"id": "8864465380454797184",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa1a5efea5303b40dde879d67110f9cdd20b3235\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604584060998723",
"tags": [
"build_address:luci.chromium.ci/win-asan/15478",
"builder:win-asan",
"buildset:commit/git/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029895442481243152",
"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/8864465380454797184/+/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": "1604584060998829",
"url": "https://ci.chromium.org/b/8864465380454797184",
"utcnow_ts": "1604584061259248"
}
}
[13:47:41.276] Task URL: https://ci.chromium.org/b/8864465380454797184
[13:47:41.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:2:0) after 1m0s
[13:47:43.624] Received PubSub notification, asking Buildbucket for the build status
[13:47:43.696] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:41.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:2:0)
[13:48:41.406] Timer tick, asking Buildbucket for the build status
[13:48:41.650] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:41.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:4:0) after 1m0s
[13:49:41.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:4:0)
[13:49:41.716] Timer tick, asking Buildbucket for the build status
[13:49:41.840] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:41.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:5:0) after 1m0s
[13:50:41.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:5:0)
[13:50:41.895] Timer tick, asking Buildbucket for the build status
[13:50:42.023] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:42.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:6:0) after 1m0s
[13:51:42.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:6:0)
[13:51:42.067] Timer tick, asking Buildbucket for the build status
[13:51:42.218] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:42.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:7:0) after 1m0s
[13:52:42.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:7:0)
[13:52:42.270] Timer tick, asking Buildbucket for the build status
[13:52:42.462] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:42.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:8:0) after 1m0s
[13:53:42.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:8:0)
[13:53:42.532] Timer tick, asking Buildbucket for the build status
[13:53:42.608] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:9:0) after 1m0s
[13:54:42.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:9:0)
[13:54:42.626] Timer tick, asking Buildbucket for the build status
[13:54:42.694] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:42.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:10:0) after 1m0s
[13:55:42.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:10:0)
[13:55:42.685] Timer tick, asking Buildbucket for the build status
[13:55:42.875] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:42.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:11:0) after 1m0s
[13:56:42.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:11:0)
[13:56:42.905] Timer tick, asking Buildbucket for the build status
[13:56:43.012] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:43.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:12:0) after 1m0s
[13:57:43.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:12:0)
[13:57:43.035] Timer tick, asking Buildbucket for the build status
[13:57:43.543] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:43.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:13:0) after 1m0s
[13:58:43.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:13:0)
[13:58:43.622] Timer tick, asking Buildbucket for the build status
[13:58:43.687] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:43.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:14:0) after 1m0s
[13:59:43.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:14:0)
[13:59:43.845] Timer tick, asking Buildbucket for the build status
[13:59:43.938] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:43.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:15:0) after 1m0s
[14:00:44.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:15:0)
[14:00:44.056] Timer tick, asking Buildbucket for the build status
[14:00:44.203] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:44.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:16:0) after 1m0s
[14:01:44.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:16:0)
[14:01:44.303] Timer tick, asking Buildbucket for the build status
[14:01:44.536] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:44.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:17:0) after 1m0s
[14:02:44.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:17:0)
[14:02:44.558] Timer tick, asking Buildbucket for the build status
[14:02:44.665] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:44.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:18:0) after 1m0s
[14:03:44.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:18:0)
[14:03:44.689] Timer tick, asking Buildbucket for the build status
[14:03:46.157] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:46.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:19:0) after 1m0s
[14:04:46.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:19:0)
[14:04:46.186] Timer tick, asking Buildbucket for the build status
[14:04:46.424] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:46.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:20:0) after 1m0s
[14:05:46.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:20:0)
[14:05:46.548] Timer tick, asking Buildbucket for the build status
[14:05:46.878] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:46.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:21:0) after 1m0s
[14:06:46.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:21:0)
[14:06:46.870] Timer tick, asking Buildbucket for the build status
[14:06:47.000] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:47.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:22:0) after 1m0s
[14:07:47.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:22:0)
[14:07:47.066] Timer tick, asking Buildbucket for the build status
[14:07:48.044] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:48.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:23:0) after 1m0s
[14:08:48.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:23:0)
[14:08:48.077] Timer tick, asking Buildbucket for the build status
[14:08:48.192] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:48.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:24:0) after 1m0s
[14:09:48.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:24:0)
[14:09:48.262] Timer tick, asking Buildbucket for the build status
[14:09:48.377] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:48.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:25:0) after 1m0s
[14:10:48.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:25:0)
[14:10:48.482] Timer tick, asking Buildbucket for the build status
[14:10:49.221] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:49.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:26:0) after 1m0s
[14:11:49.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:26:0)
[14:11:49.263] Timer tick, asking Buildbucket for the build status
[14:11:49.743] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:49.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:27:0) after 1m0s
[14:12:49.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:27:0)
[14:12:49.877] Timer tick, asking Buildbucket for the build status
[14:12:49.996] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:49.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:28:0) after 1m0s
[14:13:50.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:28:0)
[14:13:50.072] Timer tick, asking Buildbucket for the build status
[14:13:50.223] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:50.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:29:0) after 1m0s
[14:14:50.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:29:0)
[14:14:50.295] Timer tick, asking Buildbucket for the build status
[14:14:50.474] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:50.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:30:0) after 1m0s
[14:15:50.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:30:0)
[14:15:50.569] Timer tick, asking Buildbucket for the build status
[14:15:50.659] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:50.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:31:0) after 1m0s
[14:16:50.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:31:0)
[14:16:50.731] Timer tick, asking Buildbucket for the build status
[14:16:51.002] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:51.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:32:0) after 1m0s
[14:17:51.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:32:0)
[14:17:51.092] Timer tick, asking Buildbucket for the build status
[14:17:51.252] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:51.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:33:0) after 1m0s
[14:18:51.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:33:0)
[14:18:51.259] Timer tick, asking Buildbucket for the build status
[14:18:51.347] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:51.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:34:0) after 1m0s
[14:19:51.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:34:0)
[14:19:51.385] Timer tick, asking Buildbucket for the build status
[14:19:51.605] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:51.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:35:0) after 1m0s
[14:20:51.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:35:0)
[14:20:51.689] Timer tick, asking Buildbucket for the build status
[14:20:51.760] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:51.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:36:0) after 1m0s
[14:21:51.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:36:0)
[14:21:51.782] Timer tick, asking Buildbucket for the build status
[14:21:52.035] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:52.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:37:0) after 1m0s
[14:22:52.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:37:0)
[14:22:52.126] Timer tick, asking Buildbucket for the build status
[14:22:52.733] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:52.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:38:0) after 1m0s
[14:23:52.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:38:0)
[14:23:52.866] Timer tick, asking Buildbucket for the build status
[14:23:53.251] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:53.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:39:0) after 1m0s
[14:24:53.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:39:0)
[14:24:53.269] Timer tick, asking Buildbucket for the build status
[14:24:53.687] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:53.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:40:0) after 1m0s
[14:25:53.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:40:0)
[14:25:53.770] Timer tick, asking Buildbucket for the build status
[14:25:53.926] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:53.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:41:0) after 1m0s
[14:26:54.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:41:0)
[14:26:54.004] Timer tick, asking Buildbucket for the build status
[14:26:54.497] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:54.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:42:0) after 1m0s
[14:27:54.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:42:0)
[14:27:54.535] Timer tick, asking Buildbucket for the build status
[14:27:54.658] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:54.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:43:0) after 1m0s
[14:28:54.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:43:0)
[14:28:54.713] Timer tick, asking Buildbucket for the build status
[14:28:54.800] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:54.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:44:0) after 1m0s
[14:29:54.807] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:44:0)
[14:29:54.807] Timer tick, asking Buildbucket for the build status
[14:29:54.948] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:54.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:45:0) after 1m0s
[14:30:54.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:45:0)
[14:30:54.971] Timer tick, asking Buildbucket for the build status
[14:30:55.503] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:55.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:46:0) after 1m0s
[14:31:55.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:46:0)
[14:31:55.583] Timer tick, asking Buildbucket for the build status
[14:31:55.736] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:47:0) after 1m0s
[14:32:55.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:47:0)
[14:32:55.810] Timer tick, asking Buildbucket for the build status
[14:32:55.938] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:55.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:48:0) after 1m0s
[14:33:56.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:48:0)
[14:33:56.150] Timer tick, asking Buildbucket for the build status
[14:33:56.236] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:56.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:49:0) after 1m0s
[14:34:56.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:49:0)
[14:34:56.417] Timer tick, asking Buildbucket for the build status
[14:34:56.575] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:56.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:50:0) after 1m0s
[14:35:56.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:50:0)
[14:35:56.594] Timer tick, asking Buildbucket for the build status
[14:35:56.768] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:56.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:51:0) after 1m0s
[14:36:56.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:51:0)
[14:36:56.857] Timer tick, asking Buildbucket for the build status
[14:36:56.923] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:56.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:52:0) after 1m0s
[14:37:56.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:52:0)
[14:37:56.989] Timer tick, asking Buildbucket for the build status
[14:37:57.387] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:57.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:53:0) after 1m0s
[14:38:57.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:53:0)
[14:38:57.385] Timer tick, asking Buildbucket for the build status
[14:38:57.903] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:57.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:54:0) after 1m0s
[14:39:57.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:54:0)
[14:39:57.933] Timer tick, asking Buildbucket for the build status
[14:39:58.034] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:58.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:55:0) after 1m0s
[14:40:58.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:55:0)
[14:40:58.102] Timer tick, asking Buildbucket for the build status
[14:40:58.247] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:58.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:56:0) after 1m0s
[14:41:58.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:56:0)
[14:41:58.369] Timer tick, asking Buildbucket for the build status
[14:41:58.447] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:58.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:57:0) after 1m0s
[14:42:58.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:57:0)
[14:42:58.476] Timer tick, asking Buildbucket for the build status
[14:42:58.614] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:58.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:58:0) after 1m0s
[14:43:58.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:58:0)
[14:43:58.673] Timer tick, asking Buildbucket for the build status
[14:43:58.743] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:58.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:59:0) after 1m0s
[14:44:58.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:59:0)
[14:44:58.777] Timer tick, asking Buildbucket for the build status
[14:44:59.100] Build 8864465380454797184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:59.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029895442481243152:60:0) after 1m0s
[14:45:47.640] Received PubSub notification, asking Buildbucket for the build status
[14:45:48.073] Build 8864465380454797184: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:45:48.074] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604587546204739",
"created_by": "project:chromium",
"created_ts": "1604584060195520",
"id": "8864465380454797184",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa1a5efea5303b40dde879d67110f9cdd20b3235\"}}",
"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\": \"aa1a5efea5303b40dde879d67110f9cdd20b3235\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15478, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"1e59a0e12e6d8af582bfcf091a1f5b3334c1985d\", \"got_dawn_revision\": \"e87a8c466fb1652aedc2bfea464ae0b99782a357\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"aa1a5efea5303b40dde879d67110f9cdd20b3235\", \"got_revision_cp\": \"refs/heads/master@{#824401}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ad54c71632cc0f18584a7009f1e6fc44f5453bc7\", \"got_v8_revision\": \"1028db2c611d2463358536933d7ab59d6ffdb167\", \"got_v8_revision_cp\": \"refs/heads/8.8.237@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aa1a5efea5303b40dde879d67110f9cdd20b3235\", \"swarm_hashes_refs/heads/master(at){#824401}_without_patch\": {\"absl_hardening_tests\": \"82904aa0b30adcc2075512e6bee412bbbb22829c\", \"accessibility_unittests\": \"4f0b5418fde1ffcc93a9c0e2277e2ec307e4f1bf\", \"angle_unittests\": \"b267fdaaaa789b4e2c4b8a2a64e0b3fcb49b9c14\", \"app_shell_unittests\": \"983248ae7ce8910b97e50d9b0fb534eb817ccce3\", \"aura_unittests\": \"cc369a5f8d3529bcc32e475e5c6d569217367154\", \"base_unittests\": \"fe98cdd8725545dae8e619d9786c218c97566c6a\", \"base_util_unittests\": \"b153701ba40c088eec43c5e1170294b5db4f47ad\", \"blink_common_unittests\": \"bd267bf93eb1577f596241f5f451682a717d083c\", \"blink_fuzzer_unittests\": \"9d4431a435f94a8385c6096ac6a09507f6605544\", \"blink_heap_unittests\": \"61469c6f0f70f6a80252b5677504a178dfe1904d\", \"blink_platform_unittests\": \"1d6fd6aeea0e3a68823ca08f29b8013da8300d56\", \"blink_unittests\": \"73e6b3f606ad044303c1efd7b5324bf7da315fbd\", \"boringssl_crypto_tests\": \"ba2ae9bba771b5163c933a0bf65e052ee25bd141\", \"boringssl_ssl_tests\": \"848e8c10319cd8e5be8c0841129dd4a66b23ef8c\", \"browser_switcher_bho_unittests\": \"1f46c3440c42110f9d293f6b8a38db34cc83635e\", \"browser_tests\": \"e35022d8dbd33efc2debe3ee7bbe4bb2919ed381\", \"capture_unittests\": \"40dcd82fd4f9db3e324dcfffc34eaa576b1af3d8\", \"cast_unittests\": \"3cbcc1dad034732da6c6216ed97f45283c5f2b09\", \"cc_unittests\": \"237b30d51959fe8727b0455fa6e8d13b1a175c71\", \"chrome_app_unittests\": \"6e722fef7ce65a30b2b14353e79fbb7d784d4952\", \"chrome_cleaner_unittests\": \"2f7e48752890de11e386c544c23bc0951326e922\", \"chrome_elf_unittests\": \"359f381694c915189498b35cad98716ba5745917\", \"chromedriver_unittests\": \"19c6a949e503d7ba71c656369147806234536c0c\", \"components_browsertests\": \"ee0046493e17f692725ccfd4636258d3cd0dd148\", \"components_unittests\": \"650908a6985f47a059420d7e311be1915c960d68\", \"compositor_unittests\": \"093baf33be1cf8d7ce658db73a9de3b86f7c3dfe\", \"content_browsertests\": \"67a6594cc9c3a4c829bd55ac95da6529e5f401a5\", \"content_unittests\": \"4417d438da3c33fb16fa67752dc8f5d83ce5275c\", \"courgette_unittests\": \"673bca7a6894485f4d07a68c5b4220d86654c277\", \"crashpad_tests\": \"f61ee89bd14e48315f859c9739b0a6a11735dbfd\", \"cronet_tests\": \"7029fa1ac23d2f779766a53d33e7c1033afbcd01\", \"cronet_unittests\": \"868f3398a9972a6475c87536c97030f69672d9d7\", \"crypto_unittests\": \"acce79b0f3df0b49b157b211886119aa16726e52\", \"delayloads_unittests\": \"1f784bcc6f7e79e42735268bc568fb1b8cb75c1b\", \"device_unittests\": \"e07ae620a8d6613caa009c5a0bbec8e4e16cabbc\", \"display_unittests\": \"2f299810147b73107b0aeffa353b78a39e2c8378\", \"elevation_service_unittests\": \"719de22b2c66ada2afb9d3010b29e2a7e7f043e5\", \"events_unittests\": \"293032f4556f6fa2037f515db0fa1788aa9726cf\", \"extensions_browsertests\": \"e75528ad530b81ccd6125268d009a61997a99ef3\", \"extensions_unittests\": \"3afa917e1581aa8985c7c5b4409666064e66524d\", \"filesystem_service_unittests\": \"68cbd6adc7b407f895c7402bf2d5e3acee522054\", \"gcm_unit_tests\": \"26f2a00a34c58a9471cb20518c9f501336fc0abc\", \"gcp_unittests\": \"42197525463537ddf6518d1e5c9d2cbb236caf9c\", \"gfx_unittests\": \"f8a1cad6cf78fe835393aace7da65d3c269d17ae\", \"gin_unittests\": \"65d5f6a1dd08343073fdbfcdd001153d7e5611ea\", \"google_apis_unittests\": \"b75887cad17d6fdc2ddc2009d346443052f29234\", \"gpu_unittests\": \"fb5fcc1da15d0d744f3c6de1ce528bd3b89c0a97\", \"gwp_asan_unittests\": \"e79990af7a4e285a18dca3210259b2d394548faf\", \"headless_browsertests\": \"90d9f59ef55d66a91fb830e9e72df042169bf59b\", \"headless_unittests\": \"0ed592735646ab39d9d271e7b5e56b51765d7dfc\", \"install_static_unittests\": \"e23ea3ad586ffe6400f70ba5f4c44e7e294c7511\", \"installer_util_unittests\": \"0751703daef9de2dabd36a70aab2d3313a3ed21b\", \"interactive_ui_tests\": \"cfd8119a14fe339dba64c520b5de181a539949b3\", \"ipc_tests\": \"17338e78cd66de4908685cfb2b29f87774995bbf\", \"jingle_unittests\": \"9346c7c79eb732273a09dc0cea0c3848a6f422f6\", \"latency_unittests\": \"a39d2650e76e10091b8a80ea292a1fe601ea8243\", \"libjingle_xmpp_unittests\": \"b88f20401b2d471854e20f41b8fbd9721c960546\", \"liburlpattern_unittests\": \"48ea8a0cb041f7d91299eeb0c6c41581d3394d3f\", \"media_blink_unittests\": \"fd189f9013e814608fa6e226e1aab43cdc70e0d0\", \"media_unittests\": \"31bff69012ee6b8564538f46c5c48c5670ededba\", \"message_center_unittests\": \"126773fc001609430f55560e204f12124951dcc4\", \"midi_unittests\": \"0cab752305c531c9ebe63369f7a0c3f2e9d6368e\", \"mojo_core_unittests\": \"0ab7cfccc4e758530884a98f7286001a9fbdc4b7\", \"mojo_unittests\": \"2ff2d50a791c3a68893134a91ce464064dbed3a2\", \"nacl_loader_unittests\": \"2fa54b26b3e7b3a4c14439c346a49ac200013173\", \"native_theme_unittests\": \"beb5220194b14d413052cc7436351853133e59bd\", \"net_unittests\": \"6d518a362e22f3d31299dd96069db226de077ae9\", \"notification_helper_unittests\": \"6a8b8d0c2c440213797eda12d78c3d9849dbafac\", \"pdf_unittests\": \"2dda46310e46256be905729db986cb467494b7db\", \"perfetto_unittests\": \"545495c377bd8c4e6a9cc7fb9189565e63b45e6f\", \"ppapi_unittests\": \"56004d7eed0b827d9820966cc8d4de1c96f6027e\", \"printing_unittests\": \"06a04e362193bf82d15cfbdf7b41e584e2094590\", \"remoting_unittests\": \"73ded9004ac005801978e4c4bc79afee318fd93e\", \"sbox_integration_tests\": \"46558932d35dde246790984e80fc68f898d4a28d\", \"sbox_unittests\": \"62b64dcc1c49afa4ab5b996aa71126145b343f05\", \"sbox_validation_tests\": \"ba53524c86ea42b2df4408b64533cb9ef05195cf\", \"service_manager_unittests\": \"c411641d7b8bdb5653e4d8b154b2d2d73b721f46\", \"services_unittests\": \"56b7e33b44cdd87b79aae209dda2a34ee4160fe6\", \"setup_unittests\": \"f51f560e1de883236ad90b49fa4edf590d54cd9f\", \"shell_dialogs_unittests\": \"76d0896ae9d31f5a28a0b694ff04ed72ffbc388a\", \"skia_unittests\": \"6fc54437a15bf67758acac4492a3ab910f11e1f1\", \"snapshot_unittests\": \"f2fcf2226b45f5da56d0e5dba795f774179ab99d\", \"sql_unittests\": \"29cc497e27be34ade13f742fef3a968e0344cbcd\", \"storage_unittests\": \"f53a91ada8db4501ac4e6274a02d0bd5fc4aa8c2\", \"sync_integration_tests\": \"5837d68a575270504305031bd8d9526e4d425782\", \"traffic_annotation_auditor_unittests\": \"48904d9888733e8b822f0f3871d7dd44a5c4fb9f\", \"ui_base_unittests\": \"68c80fd1f95774e68d7c1f458adf6cb863daf85f\", \"ui_touch_selection_unittests\": \"66534f899652ce39ef7b44b1c460ba9d9dac1365\", \"unit_tests\": \"b6afb5804f69837db3aedd9817bf9a90a212e000\", \"updater_tests\": \"30e4721b98ce5256a8533be1d39a20c61b2528b0\", \"url_unittests\": \"c5a06def78f46b82724877ba6a3f36d1133e7dc0\", \"views_unittests\": \"319427eac5b39b6911a3113597502b5d7d784f70\", \"viz_unittests\": \"a950144e1df33110fbced09730d60fb1ff2166a2\", \"vr_common_unittests\": \"1d8ac03f4ee9403495c421bca1d57a949ec7eaf3\", \"vr_pixeltests\": \"450d25dd4d894d79024155f68d51f9399bd728f7\", \"weblayer_browsertests\": \"3f3a580d0b63d18da2129636c370a64504b34a06\", \"weblayer_unittests\": \"8ce44b6278c314c67a36ba1c698010f034a1f8c3\", \"wm_unittests\": \"bcc562260488bc86c620a34069af6c771e3b7573\", \"wtf_unittests\": \"078dbccdac75dd146c9d1734a6ef500df9f51e42\", \"zlib_unittests\": \"b9ba4e576ee6b585668d374b0c6bf26f7b9a08ab\", \"zucchini_unittests\": \"5a31a8fad1381bf5532faedb9e5ae6c4a03b0a64\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"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": "1604584062940956",
"status": "COMPLETED",
"status_changed_ts": "1604587546828895",
"tags": [
"build_address:luci.chromium.ci/win-asan/15478",
"builder:win-asan",
"buildset:commit/git/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa1a5efea5303b40dde879d67110f9cdd20b3235",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029895442481243152",
"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/8864465380454797184/+/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:4fb17b428347a310",
"user_agent:luci-scheduler"
],
"updated_ts": "1604587546850130",
"url": "https://ci.chromium.org/b/8864465380454797184",
"utcnow_ts": "1604587548017926"
}
}
[14:45:48.074] Invocation finished in 58m9.194924029s with status SUCCEEDED