[00:47:46.231] New invocation is queued and will start shortly
[00:47:47.402] Starting the invocation (attempt 1)
[00:47:47.445] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:47.445] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:47.445] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029672717255678896",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3bed87d9190f74aa6c89d459d79628b998ae7235\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029672717255678896",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3bed87d9190f74aa6c89d459d79628b998ae7235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bed87d9190f74aa6c89d459d79628b998ae7235",
"gitiles_ref:refs/heads/master"
]
}
[00:47:48.060] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604796467535735",
"id": "8864242655216462016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3bed87d9190f74aa6c89d459d79628b998ae7235\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604796467938382",
"tags": [
"build_address:luci.chromium.ci/win-asan/15525",
"builder:win-asan",
"buildset:commit/git/3bed87d9190f74aa6c89d459d79628b998ae7235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bed87d9190f74aa6c89d459d79628b998ae7235",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029672717255678896",
"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/8864242655216462016/+/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": "1604796467938516",
"url": "https://ci.chromium.org/b/8864242655216462016",
"utcnow_ts": "1604796468053018"
}
}
[00:47:48.060] Task URL: https://ci.chromium.org/b/8864242655216462016
[00:47:48.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:2:0) after 1m0s
[00:47:49.241] Received PubSub notification, asking Buildbucket for the build status
[00:47:49.532] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:48.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:2:0)
[00:48:48.078] Timer tick, asking Buildbucket for the build status
[00:48:48.242] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:48.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:4:0) after 1m0s
[00:49:48.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:4:0)
[00:49:48.408] Timer tick, asking Buildbucket for the build status
[00:49:48.899] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:5:0) after 1m0s
[00:50:48.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:5:0)
[00:50:48.934] Timer tick, asking Buildbucket for the build status
[00:50:49.086] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:49.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:6:0) after 1m0s
[00:51:49.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:6:0)
[00:51:49.137] Timer tick, asking Buildbucket for the build status
[00:51:49.623] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:49.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:7:0) after 1m0s
[00:52:49.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:7:0)
[00:52:49.687] Timer tick, asking Buildbucket for the build status
[00:52:49.997] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:49.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:8:0) after 1m0s
[00:53:49.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:8:0)
[00:53:49.975] Timer tick, asking Buildbucket for the build status
[00:53:50.118] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:50.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:9:0) after 1m0s
[00:54:50.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:9:0)
[00:54:50.240] Timer tick, asking Buildbucket for the build status
[00:54:50.368] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:50.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:10:0) after 1m0s
[00:55:50.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:10:0)
[00:55:50.392] Timer tick, asking Buildbucket for the build status
[00:55:50.845] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:50.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:11:0) after 1m0s
[00:56:50.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:11:0)
[00:56:50.925] Timer tick, asking Buildbucket for the build status
[00:56:51.020] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:51.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:12:0) after 1m0s
[00:57:51.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:12:0)
[00:57:51.077] Timer tick, asking Buildbucket for the build status
[00:57:51.187] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:13:0) after 1m0s
[00:58:51.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:13:0)
[00:58:51.357] Timer tick, asking Buildbucket for the build status
[00:58:51.482] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:51.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:14:0) after 1m0s
[00:59:51.580] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:14:0)
[00:59:51.580] Timer tick, asking Buildbucket for the build status
[00:59:51.700] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:51.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:15:0) after 1m0s
[01:00:51.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:15:0)
[01:00:51.736] Timer tick, asking Buildbucket for the build status
[01:00:52.634] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:16:0) after 1m0s
[01:01:52.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:16:0)
[01:01:52.714] Timer tick, asking Buildbucket for the build status
[01:01:52.918] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:52.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:17:0) after 1m0s
[01:02:52.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:17:0)
[01:02:52.943] Timer tick, asking Buildbucket for the build status
[01:02:53.061] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:53.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:18:0) after 1m0s
[01:03:53.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:18:0)
[01:03:53.087] Timer tick, asking Buildbucket for the build status
[01:03:53.216] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:53.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:19:0) after 1m0s
[01:04:53.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:19:0)
[01:04:53.235] Timer tick, asking Buildbucket for the build status
[01:04:53.346] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:53.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:20:0) after 1m0s
[01:05:53.374] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:20:0)
[01:05:53.374] Timer tick, asking Buildbucket for the build status
[01:05:56.950] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:56.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:21:0) after 1m0s
[01:06:57.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:21:0)
[01:06:57.075] Timer tick, asking Buildbucket for the build status
[01:06:57.231] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:57.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:22:0) after 1m0s
[01:07:57.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:22:0)
[01:07:57.261] Timer tick, asking Buildbucket for the build status
[01:07:57.391] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:57.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:23:0) after 1m0s
[01:08:57.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:23:0)
[01:08:57.463] Timer tick, asking Buildbucket for the build status
[01:08:57.578] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:57.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:24:0) after 1m0s
[01:09:57.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:24:0)
[01:09:57.604] Timer tick, asking Buildbucket for the build status
[01:09:57.739] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:57.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:25:0) after 1m0s
[01:10:57.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:25:0)
[01:10:57.768] Timer tick, asking Buildbucket for the build status
[01:10:57.997] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:57.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:26:0) after 1m0s
[01:11:58.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:26:0)
[01:11:58.049] Timer tick, asking Buildbucket for the build status
[01:11:58.224] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:58.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:27:0) after 1m0s
[01:12:58.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:27:0)
[01:12:58.250] Timer tick, asking Buildbucket for the build status
[01:12:58.368] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:58.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:28:0) after 1m0s
[01:13:58.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:28:0)
[01:13:58.409] Timer tick, asking Buildbucket for the build status
[01:13:58.980] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:58.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:29:0) after 1m0s
[01:14:59.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:29:0)
[01:14:59.011] Timer tick, asking Buildbucket for the build status
[01:14:59.103] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:59.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:30:0) after 1m0s
[01:15:59.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:30:0)
[01:15:59.152] Timer tick, asking Buildbucket for the build status
[01:16:00.871] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:00.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:31:0) after 1m0s
[01:17:00.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:31:0)
[01:17:00.957] Timer tick, asking Buildbucket for the build status
[01:17:01.074] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:01.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:32:0) after 1m0s
[01:18:02.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:32:0)
[01:18:02.605] Timer tick, asking Buildbucket for the build status
[01:18:02.743] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:02.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:33:0) after 1m0s
[01:19:03.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:33:0)
[01:19:03.956] Timer tick, asking Buildbucket for the build status
[01:19:04.149] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:04.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:34:0) after 1m0s
[01:20:04.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:34:0)
[01:20:04.138] Timer tick, asking Buildbucket for the build status
[01:20:04.258] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:04.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:35:0) after 1m0s
[01:21:04.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:35:0)
[01:21:04.280] Timer tick, asking Buildbucket for the build status
[01:21:04.508] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:04.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:36:0) after 1m0s
[01:22:04.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:36:0)
[01:22:04.588] Timer tick, asking Buildbucket for the build status
[01:22:06.581] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:06.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:37:0) after 1m0s
[01:23:07.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:37:0)
[01:23:07.701] Timer tick, asking Buildbucket for the build status
[01:23:07.823] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:07.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:38:0) after 1m0s
[01:24:07.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:38:0)
[01:24:07.952] Timer tick, asking Buildbucket for the build status
[01:24:08.068] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:08.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:39:0) after 1m0s
[01:25:08.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:39:0)
[01:25:08.068] Timer tick, asking Buildbucket for the build status
[01:25:08.197] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:08.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:40:0) after 1m0s
[01:26:08.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:40:0)
[01:26:08.216] Timer tick, asking Buildbucket for the build status
[01:26:08.293] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:08.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:41:0) after 1m0s
[01:27:08.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:41:0)
[01:27:08.338] Timer tick, asking Buildbucket for the build status
[01:27:08.480] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:08.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:42:0) after 1m0s
[01:28:08.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:42:0)
[01:28:08.501] Timer tick, asking Buildbucket for the build status
[01:28:08.650] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:08.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:43:0) after 1m0s
[01:29:08.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:43:0)
[01:29:08.723] Timer tick, asking Buildbucket for the build status
[01:29:08.815] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:08.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:44:0) after 1m0s
[01:30:08.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:44:0)
[01:30:08.888] Timer tick, asking Buildbucket for the build status
[01:30:09.011] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:09.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:45:0) after 1m0s
[01:31:09.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:45:0)
[01:31:09.078] Timer tick, asking Buildbucket for the build status
[01:31:09.539] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:09.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:46:0) after 1m0s
[01:32:09.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:46:0)
[01:32:09.569] Timer tick, asking Buildbucket for the build status
[01:32:09.703] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:09.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:47:0) after 1m0s
[01:33:09.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:47:0)
[01:33:09.802] Timer tick, asking Buildbucket for the build status
[01:33:09.917] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:09.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:48:0) after 1m0s
[01:34:09.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:48:0)
[01:34:09.944] Timer tick, asking Buildbucket for the build status
[01:34:10.068] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:10.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:49:0) after 1m0s
[01:35:10.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:49:0)
[01:35:10.092] Timer tick, asking Buildbucket for the build status
[01:35:10.177] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:10.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:50:0) after 1m0s
[01:36:10.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:50:0)
[01:36:10.204] Timer tick, asking Buildbucket for the build status
[01:36:10.277] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:10.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:51:0) after 1m0s
[01:37:10.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:51:0)
[01:37:10.321] Timer tick, asking Buildbucket for the build status
[01:37:10.490] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:10.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:52:0) after 1m0s
[01:38:10.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:52:0)
[01:38:10.583] Timer tick, asking Buildbucket for the build status
[01:38:10.912] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:10.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:53:0) after 1m0s
[01:39:10.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:53:0)
[01:39:10.934] Timer tick, asking Buildbucket for the build status
[01:39:11.101] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:11.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:54:0) after 1m0s
[01:40:11.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:54:0)
[01:40:11.141] Timer tick, asking Buildbucket for the build status
[01:40:11.217] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:11.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:55:0) after 1m0s
[01:41:11.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:55:0)
[01:41:11.242] Timer tick, asking Buildbucket for the build status
[01:41:11.467] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:11.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:56:0) after 1m0s
[01:42:11.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:56:0)
[01:42:11.485] Timer tick, asking Buildbucket for the build status
[01:42:11.616] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:11.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:57:0) after 1m0s
[01:43:11.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:57:0)
[01:43:11.649] Timer tick, asking Buildbucket for the build status
[01:43:11.779] Build 8864242655216462016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:11.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029672717255678896:58:0) after 1m0s
[01:43:54.554] Received PubSub notification, asking Buildbucket for the build status
[01:43:54.859] Build 8864242655216462016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:43:54.859] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604799833574978",
"created_by": "project:chromium",
"created_ts": "1604796467535735",
"id": "8864242655216462016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3bed87d9190f74aa6c89d459d79628b998ae7235\"}}",
"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\": \"3bed87d9190f74aa6c89d459d79628b998ae7235\", \"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-8-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15525, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"aca3d408105d03683edd20b98b333c5064ac5254\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"3bed87d9190f74aa6c89d459d79628b998ae7235\", \"got_revision_cp\": \"refs/heads/master@{#825206}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"3bed87d9190f74aa6c89d459d79628b998ae7235\", \"swarm_hashes_refs/heads/master(at){#825206}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"a74d8de9b1d779cbebbc99c39b9fa26be3e5b5cd\", \"angle_unittests\": \"843343f44f056a64589b8f2b0112ea02581e06d7\", \"app_shell_unittests\": \"ccf8b5be72484f228ac1052117c6c72b82347a1f\", \"aura_unittests\": \"94d2fb81fa7d35ed7bf5f76aaa4d6157f5f08d55\", \"base_unittests\": \"745e5bd5e236ac1f16e148a951102592e8023748\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"aac7b7b79d26408f9a46d1338d33c4dfd3186403\", \"blink_fuzzer_unittests\": \"d1060ffc49d278c5316a3f954cbef2e4bac355cc\", \"blink_heap_unittests\": \"8c4197d97ec1b3ba88d5ac2d381ac49970acfdc4\", \"blink_platform_unittests\": \"0ebc7a59f56aba0763b279b3314c721e3d2919ab\", \"blink_unittests\": \"a52109cc376f39b5e7c4c00b561e541b348ae838\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"0972870a713570c224734a21fde06ecf8cf857f8\", \"capture_unittests\": \"302122f1fafb99ae58ff905a1d7ba9cd9f24b246\", \"cast_unittests\": \"e541bb5c210d1eed1f417df67a8a6f5b0cb4430f\", \"cc_unittests\": \"64239198a17db1186724d9b55ae5a1febbed0e6e\", \"chrome_app_unittests\": \"477d29b5d38e349857ad0ce5ae3caddf15a89fb8\", \"chrome_cleaner_unittests\": \"4c3fa9dd01ca42b345a462113b5b4817ee8d39a0\", \"chrome_elf_unittests\": \"5c26a367c008758929fcf076554c10cad11b8674\", \"chromedriver_unittests\": \"6337489fcada032acb27a7a60d1eda17e9c5de24\", \"components_browsertests\": \"b54b1ba02c0cb29c7978284dfb8c7497f9da542a\", \"components_unittests\": \"7f73efd65b5b8e25ba232099cb3ecc19faf95000\", \"compositor_unittests\": \"dc4a079a4278f06673a744e9c777be3d30cdb55d\", \"content_browsertests\": \"8da5f6bbf8394c7bb73b14b16219dffe1c8b44af\", \"content_unittests\": \"38b0b535f719fcb3db8f04847ab16cb0c53deca6\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"7ff0eeec532c3ce38d8110a87aa24225b577a719\", \"cronet_unittests\": \"955f5fa013c2768dd0d9eab7c554b79fc84970b8\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"838b0a19bacb90e377628854342ebc7d62784165\", \"device_unittests\": \"b61ac682c97acd63b8921ede2bb868a181c2b75c\", \"display_unittests\": \"401fd88040731a349128bdc214833fd17fcbbaa0\", \"elevation_service_unittests\": \"cc093260a767cab08808fa7bcf73e8bf16d5ab66\", \"events_unittests\": \"c968878f41dd48a587abd0212695a7a8fd070522\", \"extensions_browsertests\": \"1f3abf8e88f5a4e877c164746dad823e16d95d23\", \"extensions_unittests\": \"6fb0af946b951977a6067dec696be70e63f00337\", \"filesystem_service_unittests\": \"4841d25bfb502201caca7c3aa3cba8a8760291e5\", \"gcm_unit_tests\": \"d15fcb6c74dc975a34d5eed96970ffca8d60dc31\", \"gcp_unittests\": \"2b0975161b59aa09177bdea269ad2fffb1f8dfa6\", \"gfx_unittests\": \"d383ced2405df4fe7840ea584309a76b28ff8aea\", \"gin_unittests\": \"a1d6f5e5c23d9b0a34197b68aee19ac26d80fe2a\", \"google_apis_unittests\": \"ffb6aee2795be4e64efab666392e1fa6e32aaca7\", \"gpu_unittests\": \"469dec3aa7f9f0a592943501095fd0ae66e18a9a\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"7f48c7eafc1f56b87649200f57522cf06ebb806a\", \"headless_unittests\": \"1cf1828432e74bd069e05d4d77d7f6175a3bc844\", \"install_static_unittests\": \"d32b91c110bd7f6919bbd76c0a712b9c980c63c5\", \"installer_util_unittests\": \"6d24344b7c9e42aa642d9be964be61336b3e8e96\", \"interactive_ui_tests\": \"131e1816e449b4c4e1855d686757d9e4ca7515c7\", \"ipc_tests\": \"a2aa380848184f51f7cd1f70faf367e125f681e3\", \"jingle_unittests\": \"1781376710bd486fbb437ac7533373f7bd7c06d9\", \"latency_unittests\": \"3e4b8edaa43500ebc7dcdb6c10b3a03e981fa714\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"abafff51120b62b6a8ab9f57f19ace4898beee70\", \"media_unittests\": \"c013a11aa18cda5e2698dc0f3466d479db456d79\", \"message_center_unittests\": \"5b57185142f63c8d3458d742e621782f265eb552\", \"midi_unittests\": \"3c2472be1028389561fe47b0fb8887b5291fffcb\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"2c4cf417c0a20f15c6abb925f179a458abf3ea0a\", \"nacl_loader_unittests\": \"eb067f56b1ccef3a42bffdf2077e745625363bcc\", \"native_theme_unittests\": \"5f51251053eb21a375dac2e0f2432c49d68c1693\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"e577a180f426d557a5bab34aef26fdfa76f36890\", \"pdf_unittests\": \"c62022215207faaffbd11e3e8108b9d3c86ddd97\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"9ecb92979663898e983fd39646de3f50f11bc6b6\", \"printing_unittests\": \"cf4aa04e52b2ba637321f7b41ef7afaf0987d4f4\", \"remoting_unittests\": \"738ddfd83419ee4a94a9558cb39b95596064770a\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"2c32c3427bbfaa0052fac5b4f090f5e39edd2ccd\", \"services_unittests\": \"1e0fb67de587eab7b540c775e9807c40ed2c4fd3\", \"setup_unittests\": \"792d26fa1469869d0cb012ac52dcd0627e8c9fed\", \"shell_dialogs_unittests\": \"feade3aff177cbab2c350d5634445e0185f22af9\", \"skia_unittests\": \"f8628a8bc7336868ec4eb98610fd843128dc8d99\", \"snapshot_unittests\": \"e167547baa170df5efdae8b5ec434dab178c5772\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"d0f219a1cf1ae6e8322a163692e10550f7eaaa59\", \"sync_integration_tests\": \"f51d8c802177bb8305da15718ee597b7987f68b0\", \"traffic_annotation_auditor_unittests\": \"661095580b99ea2e11677299464ff9a6153fc8f7\", \"ui_base_unittests\": \"c8ae07d5233ffeac6d919d19348c0a6ebef77ed3\", \"ui_touch_selection_unittests\": \"250597aea4dc4d1b42d80defd4b94d09303665e7\", \"unit_tests\": \"562639ea987a7861edd69b4d245a802d88ed218f\", \"updater_tests\": \"c6739382347403179fa1a316430450be48dccb38\", \"url_unittests\": \"f94bc177174388871e2bdc957794c924de1d0b33\", \"views_unittests\": \"967ead5b086d174b393d232401b93b6678b71e94\", \"viz_unittests\": \"576147c2b892b4e1883d9963e6d82f5b851e5bd0\", \"vr_common_unittests\": \"2c019563da37cb71adde0e48f566d5116a3cb4c0\", \"vr_pixeltests\": \"523afe1ca3e0e5ae9f9cec4d79bd3368fbf8cac9\", \"weblayer_browsertests\": \"84d6c1bc47101fc0830a2ab5fc6c931453e239a2\", \"weblayer_unittests\": \"5acbbb57cc4683dccfb7f4bf094a0aa0876789c4\", \"wm_unittests\": \"ca5d8fadaac6c38f3d0782eea123d053d46ae087\", \"wtf_unittests\": \"0acaf1915287aebad235cd938bf6940b67f1e879\", \"zlib_unittests\": \"bc7f273c31debe9eb6780e640a2fbb01b16af2c3\", \"zucchini_unittests\": \"5de14c85af81babf49e0bce99fe4377d874c60df\"}}, \"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-8-b9eu\"], \"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": "1604796468721096",
"status": "COMPLETED",
"status_changed_ts": "1604799833899984",
"tags": [
"build_address:luci.chromium.ci/win-asan/15525",
"builder:win-asan",
"buildset:commit/git/3bed87d9190f74aa6c89d459d79628b998ae7235",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3bed87d9190f74aa6c89d459d79628b998ae7235",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029672717255678896",
"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/8864242655216462016/+/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:4fbe24547f11e110",
"user_agent:luci-scheduler"
],
"updated_ts": "1604799833904244",
"url": "https://ci.chromium.org/b/8864242655216462016",
"utcnow_ts": "1604799834841156"
}
}
[01:43:54.859] Invocation finished in 56m8.652240271s with status SUCCEEDED