[02:18:53.632] New invocation is queued and will start shortly
[02:18:54.894] Starting the invocation (attempt 1)
[02:18:54.934] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:18:54.934] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:18:54.934] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029576387330028256",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"59575ceb5143fc94d4c353aaa9b029c70a258ae5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029576387330028256",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"gitiles_ref:refs/heads/master"
]
}
[02:18:57.048] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604888335179815",
"id": "8864146325009108752",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59575ceb5143fc94d4c353aaa9b029c70a258ae5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604888336778303",
"tags": [
"build_address:luci.chromium.ci/win-asan/15542",
"builder:win-asan",
"buildset:commit/git/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029576387330028256",
"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/8864146325009108752/+/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": "1604888336778569",
"url": "https://ci.chromium.org/b/8864146325009108752",
"utcnow_ts": "1604888337032078"
}
}
[02:18:57.048] Task URL: https://ci.chromium.org/b/8864146325009108752
[02:18:57.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:2:0) after 1m0s
[02:19:03.701] Received PubSub notification, asking Buildbucket for the build status
[02:19:03.795] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:57.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:2:0)
[02:19:57.454] Timer tick, asking Buildbucket for the build status
[02:19:57.614] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:57.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:4:0) after 1m0s
[02:20:57.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:4:0)
[02:20:57.815] Timer tick, asking Buildbucket for the build status
[02:20:57.931] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:57.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:5:0) after 1m0s
[02:21:57.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:5:0)
[02:21:57.997] Timer tick, asking Buildbucket for the build status
[02:21:58.092] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:58.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:6:0) after 1m0s
[02:22:58.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:6:0)
[02:22:58.346] Timer tick, asking Buildbucket for the build status
[02:22:58.447] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:58.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:7:0) after 1m0s
[02:23:58.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:7:0)
[02:23:58.526] Timer tick, asking Buildbucket for the build status
[02:23:58.992] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:58.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:8:0) after 1m0s
[02:24:59.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:8:0)
[02:24:59.087] Timer tick, asking Buildbucket for the build status
[02:24:59.225] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:59.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:9:0) after 1m0s
[02:25:59.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:9:0)
[02:25:59.403] Timer tick, asking Buildbucket for the build status
[02:26:00.288] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:10:0) after 1m0s
[02:27:00.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:10:0)
[02:27:00.465] Timer tick, asking Buildbucket for the build status
[02:27:00.844] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:00.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:11:0) after 1m0s
[02:28:01.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:11:0)
[02:28:01.008] Timer tick, asking Buildbucket for the build status
[02:28:01.116] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:01.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:12:0) after 1m0s
[02:29:01.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:12:0)
[02:29:01.312] Timer tick, asking Buildbucket for the build status
[02:29:01.447] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:01.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:13:0) after 1m0s
[02:30:01.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:13:0)
[02:30:01.542] Timer tick, asking Buildbucket for the build status
[02:30:01.770] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:01.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:14:0) after 1m0s
[02:31:01.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:14:0)
[02:31:01.923] Timer tick, asking Buildbucket for the build status
[02:31:02.053] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:02.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:15:0) after 1m0s
[02:32:02.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:15:0)
[02:32:02.135] Timer tick, asking Buildbucket for the build status
[02:32:02.751] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:02.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:16:0) after 1m0s
[02:33:02.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:16:0)
[02:33:02.784] Timer tick, asking Buildbucket for the build status
[02:33:03.420] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:03.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:17:0) after 1m0s
[02:34:03.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:17:0)
[02:34:03.442] Timer tick, asking Buildbucket for the build status
[02:34:03.638] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:03.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:18:0) after 1m0s
[02:35:03.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:18:0)
[02:35:03.651] Timer tick, asking Buildbucket for the build status
[02:35:04.123] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:04.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:19:0) after 1m0s
[02:36:04.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:19:0)
[02:36:04.273] Timer tick, asking Buildbucket for the build status
[02:36:04.503] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:04.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:20:0) after 1m0s
[02:37:04.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:20:0)
[02:37:04.650] Timer tick, asking Buildbucket for the build status
[02:37:05.145] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:05.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:21:0) after 1m0s
[02:38:05.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:21:0)
[02:38:05.215] Timer tick, asking Buildbucket for the build status
[02:38:05.452] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:05.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:22:0) after 1m0s
[02:39:05.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:22:0)
[02:39:05.544] Timer tick, asking Buildbucket for the build status
[02:39:05.756] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:05.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:23:0) after 1m0s
[02:40:05.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:23:0)
[02:40:05.804] Timer tick, asking Buildbucket for the build status
[02:40:06.178] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:06.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:24:0) after 1m0s
[02:41:06.243] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:24:0)
[02:41:06.243] Timer tick, asking Buildbucket for the build status
[02:41:06.569] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:06.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:25:0) after 1m0s
[02:42:06.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:25:0)
[02:42:06.696] Timer tick, asking Buildbucket for the build status
[02:42:06.865] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:06.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:26:0) after 1m0s
[02:43:06.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:26:0)
[02:43:06.946] Timer tick, asking Buildbucket for the build status
[02:43:07.060] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:07.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:27:0) after 1m0s
[02:44:07.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:27:0)
[02:44:07.038] Timer tick, asking Buildbucket for the build status
[02:44:07.240] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:07.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:28:0) after 1m0s
[02:45:07.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:28:0)
[02:45:07.295] Timer tick, asking Buildbucket for the build status
[02:45:07.547] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:29:0) after 1m0s
[02:46:07.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:29:0)
[02:46:07.670] Timer tick, asking Buildbucket for the build status
[02:46:07.790] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:30:0) after 1m0s
[02:47:07.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:30:0)
[02:47:07.834] Timer tick, asking Buildbucket for the build status
[02:47:07.912] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:07.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:31:0) after 1m0s
[02:48:08.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:31:0)
[02:48:08.023] Timer tick, asking Buildbucket for the build status
[02:48:08.226] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:08.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:32:0) after 1m0s
[02:49:08.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:32:0)
[02:49:08.261] Timer tick, asking Buildbucket for the build status
[02:49:08.495] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:08.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:33:0) after 1m0s
[02:50:08.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:33:0)
[02:50:08.494] Timer tick, asking Buildbucket for the build status
[02:50:08.601] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:08.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:34:0) after 1m0s
[02:51:08.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:34:0)
[02:51:08.858] Timer tick, asking Buildbucket for the build status
[02:51:09.134] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:09.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:35:0) after 1m0s
[02:52:09.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:35:0)
[02:52:09.253] Timer tick, asking Buildbucket for the build status
[02:52:09.477] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:09.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:36:0) after 1m0s
[02:53:09.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:36:0)
[02:53:09.806] Timer tick, asking Buildbucket for the build status
[02:53:10.036] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:37:0) after 1m0s
[02:54:10.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:37:0)
[02:54:10.258] Timer tick, asking Buildbucket for the build status
[02:54:10.448] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:10.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:38:0) after 1m0s
[02:55:10.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:38:0)
[02:55:10.519] Timer tick, asking Buildbucket for the build status
[02:55:10.618] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:10.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:39:0) after 1m0s
[02:56:10.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:39:0)
[02:56:10.772] Timer tick, asking Buildbucket for the build status
[02:56:10.900] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:10.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:40:0) after 1m0s
[02:57:11.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:40:0)
[02:57:11.044] Timer tick, asking Buildbucket for the build status
[02:57:11.161] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:11.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:41:0) after 1m0s
[02:58:11.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:41:0)
[02:58:11.218] Timer tick, asking Buildbucket for the build status
[02:58:11.298] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:11.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:42:0) after 1m0s
[02:59:11.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:42:0)
[02:59:11.409] Timer tick, asking Buildbucket for the build status
[02:59:11.523] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:11.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:43:0) after 1m0s
[03:00:11.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:43:0)
[03:00:11.622] Timer tick, asking Buildbucket for the build status
[03:00:12.016] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:12.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:44:0) after 1m0s
[03:01:13.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:44:0)
[03:01:13.306] Timer tick, asking Buildbucket for the build status
[03:01:13.406] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:13.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:45:0) after 1m0s
[03:02:13.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:45:0)
[03:02:13.644] Timer tick, asking Buildbucket for the build status
[03:02:13.940] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:46:0) after 1m0s
[03:03:14.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:46:0)
[03:03:14.012] Timer tick, asking Buildbucket for the build status
[03:03:14.698] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:14.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:47:0) after 1m0s
[03:04:14.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:47:0)
[03:04:14.838] Timer tick, asking Buildbucket for the build status
[03:04:15.186] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:15.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:48:0) after 1m0s
[03:05:15.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:48:0)
[03:05:15.397] Timer tick, asking Buildbucket for the build status
[03:05:15.480] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:15.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:49:0) after 1m0s
[03:06:15.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:49:0)
[03:06:15.630] Timer tick, asking Buildbucket for the build status
[03:06:15.718] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:50:0) after 1m0s
[03:07:15.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:50:0)
[03:07:15.943] Timer tick, asking Buildbucket for the build status
[03:07:16.515] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:16.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:51:0) after 1m0s
[03:08:16.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:51:0)
[03:08:16.700] Timer tick, asking Buildbucket for the build status
[03:08:16.772] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:52:0) after 1m0s
[03:09:17.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:52:0)
[03:09:17.016] Timer tick, asking Buildbucket for the build status
[03:09:17.473] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:53:0) after 1m0s
[03:10:17.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:53:0)
[03:10:17.563] Timer tick, asking Buildbucket for the build status
[03:10:17.988] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:54:0) after 1m0s
[03:11:18.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:54:0)
[03:11:18.041] Timer tick, asking Buildbucket for the build status
[03:11:18.252] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:18.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:55:0) after 1m0s
[03:12:18.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:55:0)
[03:12:18.291] Timer tick, asking Buildbucket for the build status
[03:12:18.427] Build 8864146325009108752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:18.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029576387330028256:56:0) after 1m0s
[03:13:05.245] Received PubSub notification, asking Buildbucket for the build status
[03:13:05.347] Build 8864146325009108752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:13:05.347] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604891583488538",
"created_by": "project:chromium",
"created_ts": "1604888335179815",
"id": "8864146325009108752",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59575ceb5143fc94d4c353aaa9b029c70a258ae5\"}}",
"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\": \"59575ceb5143fc94d4c353aaa9b029c70a258ae5\", \"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\": 15542, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"d4439824c55428a699aa543a2f397d06a00841b6\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"59575ceb5143fc94d4c353aaa9b029c70a258ae5\", \"got_revision_cp\": \"refs/heads/master@{#825243}\", \"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\": \"59575ceb5143fc94d4c353aaa9b029c70a258ae5\", \"swarm_hashes_refs/heads/master(at){#825243}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"48f45d1b212a84cb125a8611f83737eeb46726cc\", \"angle_unittests\": \"29fbd0146a40c67e8dce25a78dce2a10b2c67cf1\", \"app_shell_unittests\": \"30f9494f9b478677de56715bfe2b7fa935b11f63\", \"aura_unittests\": \"efd3557cdcf80e689a05a64bbec554963bf07095\", \"base_unittests\": \"745e5bd5e236ac1f16e148a951102592e8023748\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"400ad698e26eb072ad1043c12a38cdaa16492094\", \"blink_fuzzer_unittests\": \"90afac37614ceb86a0e660706faf7dbcf6dff56a\", \"blink_heap_unittests\": \"15e7dc5eba3d5d2f35f1e771575669a7bfdc4228\", \"blink_platform_unittests\": \"5afbc4fb3186bb13c92eff829667d93f99f33e06\", \"blink_unittests\": \"e995f2d1e95d72966ba693e720fd6a80bbf901ce\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"7dac0b8a138610f50577a86d326b2076bcc123c0\", \"capture_unittests\": \"af4d7cf3b1572225989ab14fe5c41dd593715d2c\", \"cast_unittests\": \"53d063fdc8b7203d75ae6c2fa7a11c900706642a\", \"cc_unittests\": \"aea540169bce42810b37a2c25576e28a6134caa9\", \"chrome_app_unittests\": \"271787d9a2210922882efb61afbf76a908130648\", \"chrome_cleaner_unittests\": \"6f02c7506ff5ed2660b99eaaab50d6a55d442f97\", \"chrome_elf_unittests\": \"b35b48d13c507c8bf24900dcd5a10f7cdc492f63\", \"chromedriver_unittests\": \"668b945f84e0c5de3e124be341085c4e5bc2bfcd\", \"components_browsertests\": \"ef1f0e808ed168502f16ae1c351790424830d43d\", \"components_unittests\": \"a94be5452ec088c579c58049da89ff5dbc683f57\", \"compositor_unittests\": \"4cab2c4ba132e5079980f9bc4a25c890b2ac790c\", \"content_browsertests\": \"bf86c566305d89e6ad1f78cc2cac855cd2e18c6c\", \"content_unittests\": \"66df2606302e28f0ecb11cbaf9095f8c629f9247\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"1cddd2f253cb1c9683cb1e355dc51695f5fcbf54\", \"cronet_unittests\": \"30d41eaa053ad3d8fde55a5188b184a0aa13f41c\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"b7697c930f1b2fd35293e5d399f45c228ea2f136\", \"device_unittests\": \"0d94ba567b593e65e3f55711e33738b2fbce6275\", \"display_unittests\": \"401fd88040731a349128bdc214833fd17fcbbaa0\", \"elevation_service_unittests\": \"8bcb969500ba6391d01927123b2ac0107c7dd411\", \"events_unittests\": \"bc3c14dd0c70830615f44a5f2338fe894aaea29b\", \"extensions_browsertests\": \"f58d0fcd0565716ec457eff10f69c07ef63952c1\", \"extensions_unittests\": \"1f8a369de7401bf7f33e62babd8aa021c6159c78\", \"filesystem_service_unittests\": \"f139f0c8b716b5df7ff298813e37d63ff6ba4e77\", \"gcm_unit_tests\": \"80850ff3813a3bc98aa76d6bc3b9959607d8b90e\", \"gcp_unittests\": \"1e8020838c8bb28a64dfb609157fd3d5cc41f5ee\", \"gfx_unittests\": \"6e71d9e385ce16dc5e32695d69974222f3b91028\", \"gin_unittests\": \"a1d6f5e5c23d9b0a34197b68aee19ac26d80fe2a\", \"google_apis_unittests\": \"a8a671f7dbeaac280b82b4bd22a3d5f6677158da\", \"gpu_unittests\": \"4845f7b59881754fa300fcf2f698bc0405559d59\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"c6128e3addbfd90cdb6f1a3cf51d529dea3c18ca\", \"headless_unittests\": \"9eaf3eab27e94fe5978af971e666d2f65e102106\", \"install_static_unittests\": \"aa6dc1d2b7d74e01dbd860b1456b65f7823b0799\", \"installer_util_unittests\": \"3fc5d950f7b40f0a4fabf1ff3287bcea921a781d\", \"interactive_ui_tests\": \"d21ef362bade5d6310292ec601064c237487ae71\", \"ipc_tests\": \"7a60798cac1ad0bdce80ad8bd9ee8d0df1ba06fd\", \"jingle_unittests\": \"0a1cba692b5854867d936808620685f8f628c8b5\", \"latency_unittests\": \"672c3927a432bbb97aa43dc2c5d6ef7320532183\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"7034863bc44f984f56532f1b600b74b06694234d\", \"media_unittests\": \"7ab59a5a2f872c0f2e26ec2c1b69b40ace365b78\", \"message_center_unittests\": \"d2f57ab4335c5b91586db87c4061fe953bb98401\", \"midi_unittests\": \"8621620633997195d1111fbd667b87ebeb87c498\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"17e52310d8dd6fb3c347944d46f6039a28211b1d\", \"nacl_loader_unittests\": \"c2277454be3f697ffe89541e3b3a4c5db36dc6c1\", \"native_theme_unittests\": \"5f51251053eb21a375dac2e0f2432c49d68c1693\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"96221f95dc3ad2944e3592e3349b62504ccb6968\", \"pdf_unittests\": \"f0fe5ae302dcfe92eda26419b420409a697dad4a\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"bc2b2c6eaa41482be7f3b69051d4b69a764e4b69\", \"printing_unittests\": \"1acc702b85f93d38d23ad9c2e2ebfa67e64019fc\", \"remoting_unittests\": \"adc781cefcd8d5975c4f99060bf2773aac76e8e4\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"06d00b135e5635592f7e3d87058865b013133b53\", \"services_unittests\": \"40ca30a704e9fb80dd633694cc89226be21027b6\", \"setup_unittests\": \"6a0304bcb57550b2b29e591ac5ef64489eb95041\", \"shell_dialogs_unittests\": \"67bdf230047fcd0046795663d64e4499ede090d7\", \"skia_unittests\": \"f8628a8bc7336868ec4eb98610fd843128dc8d99\", \"snapshot_unittests\": \"dc30e96f2920dcf2a64d7633333f4188d4371def\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"8c412b0b597d4b6f79f9d6c3fc3acb99eaafe85b\", \"sync_integration_tests\": \"6a8d2e3bd78dc9911e51ac6fbd741fb06aa42d48\", \"traffic_annotation_auditor_unittests\": \"db0a9e56cbb2b880aa6d40f34f96ae0da844ae7d\", \"ui_base_unittests\": \"2e53c09b0c75dbbd68fee9127562eb405b444d91\", \"ui_touch_selection_unittests\": \"c7a502a32e61b12b76dd230be2b360af74f2c19c\", \"unit_tests\": \"2dbbf5c0d39b969f535c481d7b3c4a2992e05629\", \"updater_tests\": \"9b83c76ba6437fd460673ad1e08887e86b2a4253\", \"url_unittests\": \"60636c3cd4eb903c4a54ecd769c80ddabbaa3667\", \"views_unittests\": \"c09f000866ce4cb29462ea2b1b62271b8072c7df\", \"viz_unittests\": \"22b17adaba2604dab3184ef1d3859291cc9958c4\", \"vr_common_unittests\": \"c2dda16c6869253953ac620a8815c28f189d7433\", \"vr_pixeltests\": \"3994c2179979e89a23f64fae0af9662ca9b7a904\", \"weblayer_browsertests\": \"dc395ebb278780480b1289bd2f4a6921059dbafc\", \"weblayer_unittests\": \"17e5baa77295f311218c453079d09d2f9104f144\", \"wm_unittests\": \"193a1d6dc538a177138094231526aba39f1e18cb\", \"wtf_unittests\": \"6c0ae3af3eb13519dea7d72090687cc27649690b\", \"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\": [\"5626-39642e9\"], \"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": "1604888342518968",
"status": "COMPLETED",
"status_changed_ts": "1604891583904600",
"tags": [
"build_address:luci.chromium.ci/win-asan/15542",
"builder:win-asan",
"buildset:commit/git/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59575ceb5143fc94d4c353aaa9b029c70a258ae5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029576387330028256",
"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/8864146325009108752/+/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:4fc39e251b7f2310",
"user_agent:luci-scheduler"
],
"updated_ts": "1604891583934376",
"url": "https://ci.chromium.org/b/8864146325009108752",
"utcnow_ts": "1604891585336363"
}
}
[03:13:05.347] Invocation finished in 54m11.763742764s with status SUCCEEDED