[06:22:47.101] New invocation is queued and will start shortly
[06:22:48.191] Starting the invocation (attempt 1)
[06:22:48.240] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:22:48.240] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:22:48.241] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028745670294669696",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028745670294669696",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"gitiles_ref:refs/heads/master"
]
}
[06:22:48.840] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605680568342153",
"id": "8863315608328168928",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605680568713822",
"tags": [
"build_address:luci.chromium.ci/win-asan/15699",
"builder:win-asan",
"buildset:commit/git/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028745670294669696",
"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/8863315608328168928/+/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": "1605680568713930",
"url": "https://ci.chromium.org/b/8863315608328168928",
"utcnow_ts": "1605680568831522"
}
}
[06:22:48.840] Task URL: https://ci.chromium.org/b/8863315608328168928
[06:22:48.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:2:0) after 1m0s
[06:22:50.560] Received PubSub notification, asking Buildbucket for the build status
[06:22:50.635] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:48.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:2:0)
[06:23:48.827] Timer tick, asking Buildbucket for the build status
[06:23:49.116] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:49.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:4:0) after 1m0s
[06:24:49.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:4:0)
[06:24:49.135] Timer tick, asking Buildbucket for the build status
[06:24:49.278] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:49.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:5:0) after 1m0s
[06:25:49.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:5:0)
[06:25:49.334] Timer tick, asking Buildbucket for the build status
[06:25:49.545] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:49.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:6:0) after 1m0s
[06:26:49.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:6:0)
[06:26:49.545] Timer tick, asking Buildbucket for the build status
[06:26:49.681] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:49.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:7:0) after 1m0s
[06:27:49.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:7:0)
[06:27:49.743] Timer tick, asking Buildbucket for the build status
[06:27:49.846] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:49.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:8:0) after 1m0s
[06:28:49.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:8:0)
[06:28:49.921] Timer tick, asking Buildbucket for the build status
[06:28:50.202] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:50.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:9:0) after 1m0s
[06:29:50.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:9:0)
[06:29:50.335] Timer tick, asking Buildbucket for the build status
[06:29:51.619] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:51.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:10:0) after 1m0s
[06:30:51.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:10:0)
[06:30:51.648] Timer tick, asking Buildbucket for the build status
[06:30:51.718] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:51.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:11:0) after 1m0s
[06:31:51.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:11:0)
[06:31:51.811] Timer tick, asking Buildbucket for the build status
[06:31:51.936] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:51.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:12:0) after 1m0s
[06:32:51.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:12:0)
[06:32:51.976] Timer tick, asking Buildbucket for the build status
[06:32:52.106] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:52.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:13:0) after 1m0s
[06:33:52.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:13:0)
[06:33:52.127] Timer tick, asking Buildbucket for the build status
[06:33:52.285] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:52.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:14:0) after 1m0s
[06:34:52.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:14:0)
[06:34:52.308] Timer tick, asking Buildbucket for the build status
[06:34:52.388] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:52.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:15:0) after 1m0s
[06:35:52.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:15:0)
[06:35:52.532] Timer tick, asking Buildbucket for the build status
[06:35:52.591] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:52.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:16:0) after 1m0s
[06:36:54.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:16:0)
[06:36:54.054] Timer tick, asking Buildbucket for the build status
[06:36:54.127] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:54.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:17:0) after 1m0s
[06:37:54.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:17:0)
[06:37:54.264] Timer tick, asking Buildbucket for the build status
[06:37:54.370] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:54.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:18:0) after 1m0s
[06:38:54.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:18:0)
[06:38:54.728] Timer tick, asking Buildbucket for the build status
[06:38:54.851] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:54.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:19:0) after 1m0s
[06:39:55.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:19:0)
[06:39:55.127] Timer tick, asking Buildbucket for the build status
[06:39:55.336] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:55.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:20:0) after 1m0s
[06:40:55.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:20:0)
[06:40:55.400] Timer tick, asking Buildbucket for the build status
[06:40:55.510] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:55.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:21:0) after 1m0s
[06:41:55.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:21:0)
[06:41:55.537] Timer tick, asking Buildbucket for the build status
[06:41:55.652] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:55.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:22:0) after 1m0s
[06:42:55.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:22:0)
[06:42:55.690] Timer tick, asking Buildbucket for the build status
[06:42:55.828] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:55.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:23:0) after 1m0s
[06:43:55.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:23:0)
[06:43:55.895] Timer tick, asking Buildbucket for the build status
[06:43:56.914] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:24:0) after 1m0s
[06:44:56.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:24:0)
[06:44:56.995] Timer tick, asking Buildbucket for the build status
[06:44:57.420] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:57.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:25:0) after 1m0s
[06:45:57.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:25:0)
[06:45:57.435] Timer tick, asking Buildbucket for the build status
[06:45:57.725] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:57.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:26:0) after 1m0s
[06:46:57.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:26:0)
[06:46:57.848] Timer tick, asking Buildbucket for the build status
[06:46:57.968] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:57.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:27:0) after 1m0s
[06:47:58.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:27:0)
[06:47:58.087] Timer tick, asking Buildbucket for the build status
[06:47:58.226] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:28:0) after 1m0s
[06:48:58.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:28:0)
[06:48:58.232] Timer tick, asking Buildbucket for the build status
[06:48:58.368] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:58.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:29:0) after 1m0s
[06:49:58.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:29:0)
[06:49:58.371] Timer tick, asking Buildbucket for the build status
[06:49:58.507] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:58.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:30:0) after 1m0s
[06:50:58.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:30:0)
[06:50:58.533] Timer tick, asking Buildbucket for the build status
[06:50:58.723] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:58.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:31:0) after 1m0s
[06:51:58.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:31:0)
[06:51:58.745] Timer tick, asking Buildbucket for the build status
[06:51:59.171] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:32:0) after 1m0s
[06:52:59.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:32:0)
[06:52:59.264] Timer tick, asking Buildbucket for the build status
[06:52:59.370] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:59.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:33:0) after 1m0s
[06:53:59.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:33:0)
[06:53:59.352] Timer tick, asking Buildbucket for the build status
[06:53:59.434] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:59.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:34:0) after 1m0s
[06:54:59.462] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:34:0)
[06:54:59.462] Timer tick, asking Buildbucket for the build status
[06:54:59.540] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:59.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:35:0) after 1m0s
[06:55:59.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:35:0)
[06:55:59.552] Timer tick, asking Buildbucket for the build status
[06:55:59.636] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:59.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:36:0) after 1m0s
[06:56:59.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:36:0)
[06:56:59.705] Timer tick, asking Buildbucket for the build status
[06:56:59.785] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:59.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:37:0) after 1m0s
[06:57:59.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:37:0)
[06:57:59.846] Timer tick, asking Buildbucket for the build status
[06:58:00.180] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:00.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:38:0) after 1m0s
[06:59:00.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:38:0)
[06:59:00.318] Timer tick, asking Buildbucket for the build status
[06:59:00.449] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:00.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:39:0) after 1m0s
[07:00:00.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:39:0)
[07:00:00.476] Timer tick, asking Buildbucket for the build status
[07:00:00.589] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:00.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:40:0) after 1m0s
[07:01:00.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:40:0)
[07:01:00.747] Timer tick, asking Buildbucket for the build status
[07:01:01.120] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:01.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:41:0) after 1m0s
[07:02:01.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:41:0)
[07:02:01.161] Timer tick, asking Buildbucket for the build status
[07:02:01.428] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:42:0) after 1m0s
[07:03:01.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:42:0)
[07:03:01.526] Timer tick, asking Buildbucket for the build status
[07:03:02.123] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:02.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:43:0) after 1m0s
[07:04:02.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:43:0)
[07:04:02.252] Timer tick, asking Buildbucket for the build status
[07:04:02.762] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:02.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:44:0) after 1m0s
[07:05:02.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:44:0)
[07:05:02.861] Timer tick, asking Buildbucket for the build status
[07:05:03.034] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:03.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:45:0) after 1m0s
[07:06:03.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:45:0)
[07:06:03.064] Timer tick, asking Buildbucket for the build status
[07:06:03.138] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:46:0) after 1m0s
[07:07:03.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:46:0)
[07:07:03.207] Timer tick, asking Buildbucket for the build status
[07:07:03.346] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:03.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:47:0) after 1m0s
[07:08:03.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:47:0)
[07:08:03.413] Timer tick, asking Buildbucket for the build status
[07:08:04.765] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:04.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:48:0) after 1m0s
[07:09:04.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:48:0)
[07:09:04.770] Timer tick, asking Buildbucket for the build status
[07:09:04.950] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:04.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:49:0) after 1m0s
[07:10:05.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:49:0)
[07:10:05.062] Timer tick, asking Buildbucket for the build status
[07:10:05.175] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:05.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:50:0) after 1m0s
[07:11:05.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:50:0)
[07:11:05.305] Timer tick, asking Buildbucket for the build status
[07:11:05.621] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:05.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:51:0) after 1m0s
[07:12:05.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:51:0)
[07:12:05.768] Timer tick, asking Buildbucket for the build status
[07:12:05.837] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:05.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:52:0) after 1m0s
[07:13:06.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:52:0)
[07:13:06.497] Timer tick, asking Buildbucket for the build status
[07:13:06.628] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:06.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:53:0) after 1m0s
[07:14:06.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:53:0)
[07:14:06.731] Timer tick, asking Buildbucket for the build status
[07:14:07.011] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:07.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:54:0) after 1m0s
[07:15:07.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:54:0)
[07:15:07.025] Timer tick, asking Buildbucket for the build status
[07:15:07.223] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:07.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:55:0) after 1m0s
[07:16:07.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:55:0)
[07:16:07.276] Timer tick, asking Buildbucket for the build status
[07:16:07.398] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:07.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:56:0) after 1m0s
[07:17:07.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:56:0)
[07:17:07.427] Timer tick, asking Buildbucket for the build status
[07:17:07.578] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:07.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:57:0) after 1m0s
[07:18:07.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:57:0)
[07:18:07.616] Timer tick, asking Buildbucket for the build status
[07:18:07.742] Build 8863315608328168928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028745670294669696:58:0) after 1m0s
[07:18:11.331] Received PubSub notification, asking Buildbucket for the build status
[07:18:11.416] Build 8863315608328168928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:18:11.416] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605683890121556",
"created_by": "project:chromium",
"created_ts": "1605680568342153",
"id": "8863315608328168928",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\"}}",
"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\": \"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\", \"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-6zek\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15699, \"clang_revision\": \"llvmorg-12-init-11780-g6ef07111-1\", \"got_angle_revision\": \"2ffff6d024c7d639ecf4258402c2d047bb09588a\", \"got_dawn_revision\": \"a0758a1aef12b02216c2df2781d8e1458d6d7da6\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\", \"got_revision_cp\": \"refs/heads/master@{#828618}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"bb96f79d0e15daa9af7b11b2868baeb052d136d9\", \"got_v8_revision\": \"3644d1fc3b7f59e11f5e80b6feb79634736e0192\", \"got_v8_revision_cp\": \"refs/heads/8.9.7@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"bc2114c0a1cfa05a4fdffbd1971619b203d711bc\", \"swarm_hashes_refs/heads/master(at){#828618}_without_patch\": {\"absl_hardening_tests\": \"2899f96619f3e37c0fe3bf4ede9beb0668782b59\", \"accessibility_unittests\": \"bd176466e92d77abbac221a0afa32135c6aa4b77\", \"angle_unittests\": \"6a594a8c840620ce7a9671ddda6a40981e734e6b\", \"app_shell_unittests\": \"014f003421f6665fd7d637e6497e2aeebad203f2\", \"aura_unittests\": \"6a6f7f80586265b126a2f036e9ae66c12ddda3ce\", \"base_unittests\": \"56beff4ccf5b8d1bb2baa6e156e6020ff92b5bc7\", \"base_util_unittests\": \"76bd897522333207654fc4e0163672a51f8d2820\", \"blink_common_unittests\": \"60e4d869ffaefbde5d0ac656a8bb5503624e89e5\", \"blink_fuzzer_unittests\": \"2d9ad858e5e224b4fd61721203906b533e902e10\", \"blink_heap_unittests\": \"158c363a90be73dde50c2c6370ff43312e816046\", \"blink_platform_unittests\": \"f4e6da809d0ebca7e703f0f68d9a73c898d9ec2c\", \"blink_unittests\": \"32f02a83a02d8aaa6a7e9905efe9444d330ee626\", \"boringssl_crypto_tests\": \"946c1d7fdc1f69f47b937293ad84dc7e94532b9f\", \"boringssl_ssl_tests\": \"87cbeed4e6573da2b019c8fe988918d8537b7914\", \"browser_switcher_bho_unittests\": \"119b041fd0c7feb23df798e13f43f512660022ec\", \"browser_tests\": \"f6b79b970a5ad69f4673a3ecfce60d846792ae9a\", \"capture_unittests\": \"d154a137c15a46d9e400eb91036d354ce5711edf\", \"cast_unittests\": \"6b7c04e11a4a557be969f0b2c5b359bedfb57924\", \"cc_unittests\": \"df3760ec356729af1689aef48776516ca2ec86bb\", \"chrome_app_unittests\": \"467704f3dc3e06c07c7403f427daf42bd5eabf6e\", \"chrome_cleaner_unittests\": \"679a636eaa5c502ca001edf0e91155fc2047587a\", \"chrome_elf_unittests\": \"fa3bd941f2c8847ef9b8b2df99f53d30ba80c223\", \"chromedriver_unittests\": \"77570ae526320b534a5c5f71cc4ef24a2aa99945\", \"components_browsertests\": \"17466c045c8212112f8c16aa55db5084bae4e67f\", \"components_unittests\": \"f507e605f6fc84c3cebf10dac38396b031e2e2d9\", \"compositor_unittests\": \"df954a7e9b31683d8068cb52d2a6bbcc8d0a92ca\", \"content_browsertests\": \"bf0fd666b00d95ed62a0a08ca6a88e2a4a3674c5\", \"content_unittests\": \"b6ac4ce2b9d7b25210bf91a5a0b01292b39c8b92\", \"courgette_unittests\": \"d8552bc0728bfe12811145a94b60b1b258ef110f\", \"crashpad_tests\": \"2e2cc07326eb52fdbae9522ba0074704fa6b3f4a\", \"cronet_tests\": \"1970b72066b284a11239e8959d5f1033e361fff9\", \"cronet_unittests\": \"55e974f8178d645f7623ce0028b01207abb8b864\", \"crypto_unittests\": \"a80177288911e1703115bdc084bbe9c48e65d9aa\", \"delayloads_unittests\": \"0ced54def11c1ac3efa7c98ff6bd8b4a8ee451d3\", \"device_unittests\": \"ffc9b8c65c16a04e06c124630cdd2069d4f39032\", \"display_unittests\": \"3a98bccd8f791365837b5c086f3f0a6f5db8be8e\", \"elevation_service_unittests\": \"c5f405add26b5323a00e3d837259546770c849db\", \"events_unittests\": \"8a0b068127e48df32c870fbe918d96b40820fcb5\", \"extensions_browsertests\": \"813d1994d506a4418a973b7b8528b5118b96f05f\", \"extensions_unittests\": \"a264e886d216fb67092c0bede9b3b8a85edc401e\", \"filesystem_service_unittests\": \"1369b7222cb90cc3368f200b586dd8786320d2f1\", \"gcm_unit_tests\": \"81971d0bf0b20e77ee77e2b949ac825361dff74c\", \"gcp_unittests\": \"c69a58a6280ac3426fbbdfb8d9cd3de5023589a0\", \"gfx_unittests\": \"c716176a7f891f29421f22bd21a4dee704d3554d\", \"gin_unittests\": \"d9f95cd7470c062e83f04e9cf97e865b1f5e3851\", \"google_apis_unittests\": \"024da5aa29394ddbe45c7b77de7758c811dd8db6\", \"gpu_unittests\": \"0c1d318bda581e80f6e050efd269ca0761b7ab09\", \"gwp_asan_unittests\": \"bcf25a5360021ae482296d3008061c2cf2e06007\", \"headless_browsertests\": \"f7ae1832d914cef1ed25535fac2208ba43e748d8\", \"headless_unittests\": \"64bb80f9f6d132cc03771fad29d1c3f12dd63c65\", \"install_static_unittests\": \"ee725551f453c82be155b05f20e69350753d14e6\", \"installer_util_unittests\": \"b30cddf0da3a8d67e59341e358c296ba2c8299af\", \"interactive_ui_tests\": \"29e47dbb7675c65a10cb94372c3b8c876e12f4a0\", \"ipc_tests\": \"b981b9c12b4a3eaf53e4b74757e14a71931afee5\", \"jingle_unittests\": \"c1e9b9f22f45e726509c1bc606e9a6e2502858e1\", \"latency_unittests\": \"3ff65d057030c72fca02e2af69bbc9fe6966c769\", \"libjingle_xmpp_unittests\": \"1b8e4433cd1ee2366097edfd56f6f327679a2d71\", \"liburlpattern_unittests\": \"84b4aaac3eebecdd47c3b2e63f7aa65ea4881ad9\", \"media_blink_unittests\": \"85d65ae3479b86b78e5fddc7cce170bbae6f1dee\", \"media_unittests\": \"ddb5d702c8866935050424670696897d79de6179\", \"message_center_unittests\": \"cbab669229a8c21f1519a19b9e443d516ff2e720\", \"midi_unittests\": \"4cf72ae26c6589c8b5bf5dded602db39453269f1\", \"mojo_core_unittests\": \"6e68c7e0125c25346af6b9657e59e6a2172c3b34\", \"mojo_unittests\": \"20bd4ff219e52d3bc93731ee694d8eafb145b217\", \"nacl_loader_unittests\": \"cddd16d706a11ccac591d47f514a744e8e6ae2a1\", \"native_theme_unittests\": \"f768f18619f8fe1c975b6be64d35fb789f0550de\", \"net_unittests\": \"1f3be9476ed89ebd4bd8edca3a7f5d8082b87f50\", \"notification_helper_unittests\": \"96f23552d5f9eafa65fe4cd057a8d465a840ba30\", \"pdf_unittests\": \"aac05b3b78a11595b315f83699fd0b5196f9e200\", \"perfetto_unittests\": \"2298eb88ea19ba0d6ddf36ea84b21c2ec6b18509\", \"ppapi_unittests\": \"d4bcd5ef7dc3a330b62ce3a97d87950f22a994e5\", \"printing_unittests\": \"fba54ad546d577a13f49c8d40bf22b7748ca9722\", \"remoting_unittests\": \"695f98c402687b47182236f431e352948ac9f7a8\", \"sbox_integration_tests\": \"bed5572a4e5207d116ffafeab6b11c60f171664c\", \"sbox_unittests\": \"49960af7a8d928a6e76bf8533b77e282c24b4d4d\", \"sbox_validation_tests\": \"658383efac1543af0c3943c80e6aa0e8372e80f4\", \"service_manager_unittests\": \"5a2f1c500954a9503ab1f9c8918062043dfa660a\", \"services_unittests\": \"5d85af0a987c15eeb630accb474b03b55e37ef60\", \"setup_unittests\": \"557e03215a5653ae69fd4458aac77e8083773828\", \"shell_dialogs_unittests\": \"66d2b6d31cac3a523bdf43fa0c52fae51c66b6d8\", \"skia_unittests\": \"4178d719c275d0e5582089309c9878b7862861dc\", \"snapshot_unittests\": \"f78d37e445ad7247fa4ef1b8237f4acfa87accf7\", \"sql_unittests\": \"9a31755417a1a65d4ad4ff25e96011a4a146ce68\", \"storage_unittests\": \"2714ed8e43aed236057f29df2adc9b139865514a\", \"sync_integration_tests\": \"50b703e227ad88240bb01f90cfe9c5619441c385\", \"traffic_annotation_auditor_unittests\": \"f3301607cff8791ad74287568046a789f7e12e4e\", \"ui_base_unittests\": \"40544dea134d940df7e74dbf422398f4d11d88d5\", \"ui_touch_selection_unittests\": \"6d5024e29472a8ca6b2f735b036ac2a62369a7cc\", \"unit_tests\": \"2c0365498c17d1fb06e9d85f9b4d991c628cd2aa\", \"updater_tests\": \"547725c606e74c2bf9e4d635cab62245f4238c95\", \"url_unittests\": \"b2dae5f4e771e2d17d441a26bfc22865f983e5f0\", \"views_unittests\": \"0a06beb1d48b79e5ca45728359baa0bfb88dc063\", \"viz_unittests\": \"37703786ce80466fd0143be1d4270ecb831c3bc6\", \"vr_common_unittests\": \"daca2c462f22052ee321ae008f7deca5150b67fe\", \"vr_pixeltests\": \"be6f3fb57adf225cabbf9a8c25f88c7705a829a7\", \"weblayer_browsertests\": \"04405c58a3d3e20cd442672ec2e51c272157271c\", \"weblayer_unittests\": \"b36c123fe45521072871d90ef141926c1899b7d4\", \"wm_unittests\": \"d60c35c282d16376956a020b4cb4f715d61f27d0\", \"wtf_unittests\": \"e006bd48dc4c9d9320b208ed1bdc5654d9913a01\", \"zlib_unittests\": \"91c2b009001d9b6c079832860bf752a78a091132\", \"zucchini_unittests\": \"f6dc4be9cd3e0fc248c02e883a51a77f96e4bdd6\"}}, \"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-6zek\"], \"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\": [\"5635-1756fdb\"], \"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": "1605680569719517",
"status": "COMPLETED",
"status_changed_ts": "1605683890439437",
"tags": [
"build_address:luci.chromium.ci/win-asan/15699",
"builder:win-asan",
"buildset:commit/git/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc2114c0a1cfa05a4fdffbd1971619b203d711bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028745670294669696",
"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/8863315608328168928/+/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:4ff2d6a29374ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605683890443622",
"url": "https://ci.chromium.org/b/8863315608328168928",
"utcnow_ts": "1605683891401078"
}
}
[07:18:11.416] Invocation finished in 55m24.333156332s with status SUCCEEDED