[01:52:33.173] New invocation is queued and will start shortly
[01:52:34.353] Starting the invocation (attempt 1)
[01:52:34.383] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:52:34.387] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:52:34.387] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020608944850869632",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e492efd40e5635b52e9f1fe4f034c33b51210571\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020608944850869632",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e492efd40e5635b52e9f1fe4f034c33b51210571",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e492efd40e5635b52e9f1fe4f034c33b51210571",
"gitiles_ref:refs/heads/master"
]
}
[01:52:35.387] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613440354511725",
"id": "8855178882787024640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e492efd40e5635b52e9f1fe4f034c33b51210571\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613440355240959",
"tags": [
"build_address:luci.chromium.ci/win-asan/17366",
"builder:win-asan",
"buildset:commit/git/e492efd40e5635b52e9f1fe4f034c33b51210571",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e492efd40e5635b52e9f1fe4f034c33b51210571",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020608944850869632",
"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/8855178882787024640/+/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": "1613440355241239",
"url": "https://ci.chromium.org/b/8855178882787024640",
"utcnow_ts": "1613440355378271"
}
}
[01:52:35.387] Task URL: https://ci.chromium.org/b/8855178882787024640
[01:52:35.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:2:0) after 1m0s
[01:52:42.858] Received PubSub notification, asking Buildbucket for the build status
[01:52:42.932] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:2:0)
[01:53:35.402] Timer tick, asking Buildbucket for the build status
[01:53:35.481] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:4:0) after 1m0s
[01:54:35.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:4:0)
[01:54:35.502] Timer tick, asking Buildbucket for the build status
[01:54:35.584] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:35.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:5:0) after 1m0s
[01:55:35.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:5:0)
[01:55:35.630] Timer tick, asking Buildbucket for the build status
[01:55:35.722] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:35.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:6:0) after 1m0s
[01:56:35.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:6:0)
[01:56:35.739] Timer tick, asking Buildbucket for the build status
[01:56:35.967] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:35.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:7:0) after 1m0s
[01:57:36.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:7:0)
[01:57:36.130] Timer tick, asking Buildbucket for the build status
[01:57:36.240] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:36.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:8:0) after 1m0s
[01:58:36.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:8:0)
[01:58:36.258] Timer tick, asking Buildbucket for the build status
[01:58:36.369] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:36.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:9:0) after 1m0s
[01:59:36.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:9:0)
[01:59:36.506] Timer tick, asking Buildbucket for the build status
[01:59:36.589] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:36.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:10:0) after 1m0s
[02:00:36.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:10:0)
[02:00:36.706] Timer tick, asking Buildbucket for the build status
[02:00:36.777] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:11:0) after 1m0s
[02:01:36.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:11:0)
[02:01:36.843] Timer tick, asking Buildbucket for the build status
[02:01:36.935] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:12:0) after 1m0s
[02:02:36.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:12:0)
[02:02:36.978] Timer tick, asking Buildbucket for the build status
[02:02:37.169] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:13:0) after 1m0s
[02:03:37.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:13:0)
[02:03:37.292] Timer tick, asking Buildbucket for the build status
[02:03:37.383] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:37.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:14:0) after 1m0s
[02:04:37.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:14:0)
[02:04:37.439] Timer tick, asking Buildbucket for the build status
[02:04:37.524] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:37.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:15:0) after 1m0s
[02:05:37.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:15:0)
[02:05:37.553] Timer tick, asking Buildbucket for the build status
[02:05:37.693] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:37.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:16:0) after 1m0s
[02:06:37.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:16:0)
[02:06:37.747] Timer tick, asking Buildbucket for the build status
[02:06:37.872] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:37.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:17:0) after 1m0s
[02:07:37.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:17:0)
[02:07:37.885] Timer tick, asking Buildbucket for the build status
[02:07:38.021] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:38.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:18:0) after 1m0s
[02:08:38.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:18:0)
[02:08:38.059] Timer tick, asking Buildbucket for the build status
[02:08:38.190] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:38.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:19:0) after 1m0s
[02:09:38.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:19:0)
[02:09:38.228] Timer tick, asking Buildbucket for the build status
[02:09:38.477] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:38.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:20:0) after 1m0s
[02:10:38.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:20:0)
[02:10:38.557] Timer tick, asking Buildbucket for the build status
[02:10:38.746] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:38.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:21:0) after 1m0s
[02:11:38.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:21:0)
[02:11:38.763] Timer tick, asking Buildbucket for the build status
[02:11:38.926] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:38.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:22:0) after 1m0s
[02:12:38.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:22:0)
[02:12:38.970] Timer tick, asking Buildbucket for the build status
[02:12:39.382] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:39.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:23:0) after 1m0s
[02:13:39.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:23:0)
[02:13:39.442] Timer tick, asking Buildbucket for the build status
[02:13:39.514] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:39.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:24:0) after 1m0s
[02:14:39.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:24:0)
[02:14:39.529] Timer tick, asking Buildbucket for the build status
[02:14:39.802] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:39.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:25:0) after 1m0s
[02:15:39.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:25:0)
[02:15:39.826] Timer tick, asking Buildbucket for the build status
[02:15:39.918] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:39.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:26:0) after 1m0s
[02:16:39.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:26:0)
[02:16:39.942] Timer tick, asking Buildbucket for the build status
[02:16:40.037] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:40.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:27:0) after 1m0s
[02:17:40.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:27:0)
[02:17:40.085] Timer tick, asking Buildbucket for the build status
[02:17:40.186] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:40.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:28:0) after 1m0s
[02:18:40.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:28:0)
[02:18:40.207] Timer tick, asking Buildbucket for the build status
[02:18:40.291] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:40.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:29:0) after 1m0s
[02:19:40.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:29:0)
[02:19:40.300] Timer tick, asking Buildbucket for the build status
[02:19:40.394] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:40.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:30:0) after 1m0s
[02:20:40.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:30:0)
[02:20:40.409] Timer tick, asking Buildbucket for the build status
[02:20:40.546] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:40.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:31:0) after 1m0s
[02:21:40.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:31:0)
[02:21:40.564] Timer tick, asking Buildbucket for the build status
[02:21:40.659] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:40.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:32:0) after 1m0s
[02:22:40.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:32:0)
[02:22:40.750] Timer tick, asking Buildbucket for the build status
[02:22:41.047] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:41.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:33:0) after 1m0s
[02:23:41.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:33:0)
[02:23:41.062] Timer tick, asking Buildbucket for the build status
[02:23:41.208] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:41.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:34:0) after 1m0s
[02:24:41.190] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:34:0)
[02:24:41.190] Timer tick, asking Buildbucket for the build status
[02:24:41.437] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:41.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:35:0) after 1m0s
[02:25:41.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:35:0)
[02:25:41.486] Timer tick, asking Buildbucket for the build status
[02:25:41.573] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:41.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:36:0) after 1m0s
[02:26:42.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:36:0)
[02:26:42.208] Timer tick, asking Buildbucket for the build status
[02:26:42.704] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:42.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:37:0) after 1m0s
[02:27:42.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:37:0)
[02:27:42.773] Timer tick, asking Buildbucket for the build status
[02:27:42.873] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:42.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:38:0) after 1m0s
[02:28:42.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:38:0)
[02:28:42.893] Timer tick, asking Buildbucket for the build status
[02:28:42.981] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:42.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:39:0) after 1m0s
[02:29:43.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:39:0)
[02:29:43.027] Timer tick, asking Buildbucket for the build status
[02:29:43.106] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:43.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:40:0) after 1m0s
[02:30:43.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:40:0)
[02:30:43.149] Timer tick, asking Buildbucket for the build status
[02:30:43.245] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:43.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:41:0) after 1m0s
[02:31:43.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:41:0)
[02:31:43.244] Timer tick, asking Buildbucket for the build status
[02:31:43.537] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:43.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:42:0) after 1m0s
[02:32:43.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:42:0)
[02:32:43.636] Timer tick, asking Buildbucket for the build status
[02:32:43.737] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:43.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:43:0) after 1m0s
[02:33:43.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:43:0)
[02:33:43.820] Timer tick, asking Buildbucket for the build status
[02:33:43.918] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:43.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:44:0) after 1m0s
[02:34:44.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:44:0)
[02:34:44.273] Timer tick, asking Buildbucket for the build status
[02:34:44.448] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:44.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:45:0) after 1m0s
[02:35:44.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:45:0)
[02:35:44.697] Timer tick, asking Buildbucket for the build status
[02:35:44.778] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:44.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:46:0) after 1m0s
[02:36:44.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:46:0)
[02:36:44.900] Timer tick, asking Buildbucket for the build status
[02:36:45.623] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:45.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:47:0) after 1m0s
[02:37:45.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:47:0)
[02:37:45.699] Timer tick, asking Buildbucket for the build status
[02:37:45.872] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:48:0) after 1m0s
[02:38:45.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:48:0)
[02:38:45.969] Timer tick, asking Buildbucket for the build status
[02:38:46.085] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:46.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:49:0) after 1m0s
[02:39:46.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:49:0)
[02:39:46.114] Timer tick, asking Buildbucket for the build status
[02:39:46.514] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:46.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:50:0) after 1m0s
[02:40:46.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:50:0)
[02:40:46.545] Timer tick, asking Buildbucket for the build status
[02:40:46.776] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:46.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:51:0) after 1m0s
[02:41:46.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:51:0)
[02:41:46.785] Timer tick, asking Buildbucket for the build status
[02:41:46.887] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:46.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:52:0) after 1m0s
[02:42:46.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:52:0)
[02:42:46.914] Timer tick, asking Buildbucket for the build status
[02:42:47.024] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:47.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:53:0) after 1m0s
[02:43:47.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:53:0)
[02:43:47.044] Timer tick, asking Buildbucket for the build status
[02:43:47.154] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:47.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:54:0) after 1m0s
[02:44:47.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:54:0)
[02:44:47.258] Timer tick, asking Buildbucket for the build status
[02:44:47.588] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:47.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:55:0) after 1m0s
[02:45:47.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:55:0)
[02:45:47.651] Timer tick, asking Buildbucket for the build status
[02:45:47.752] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:47.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:56:0) after 1m0s
[02:46:47.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:56:0)
[02:46:47.840] Timer tick, asking Buildbucket for the build status
[02:46:48.433] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:48.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:57:0) after 1m0s
[02:47:48.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:57:0)
[02:47:48.481] Timer tick, asking Buildbucket for the build status
[02:47:48.580] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:48.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:58:0) after 1m0s
[02:48:48.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:58:0)
[02:48:48.678] Timer tick, asking Buildbucket for the build status
[02:48:48.754] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:48.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:59:0) after 1m0s
[02:49:48.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:59:0)
[02:49:48.772] Timer tick, asking Buildbucket for the build status
[02:49:48.963] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:48.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:60:0) after 1m0s
[02:50:49.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:60:0)
[02:50:49.100] Timer tick, asking Buildbucket for the build status
[02:50:49.194] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:49.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:61:0) after 1m0s
[02:51:49.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:61:0)
[02:51:49.414] Timer tick, asking Buildbucket for the build status
[02:51:49.514] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:49.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:62:0) after 1m0s
[02:52:49.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:62:0)
[02:52:49.545] Timer tick, asking Buildbucket for the build status
[02:52:49.661] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:49.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:63:0) after 1m0s
[02:53:49.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:63:0)
[02:53:49.708] Timer tick, asking Buildbucket for the build status
[02:53:49.787] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:49.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:64:0) after 1m0s
[02:54:49.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:64:0)
[02:54:49.845] Timer tick, asking Buildbucket for the build status
[02:54:50.101] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:50.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:65:0) after 1m0s
[02:55:50.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:65:0)
[02:55:50.122] Timer tick, asking Buildbucket for the build status
[02:55:50.217] Build 8855178882787024640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:50.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020608944850869632:66:0) after 1m0s
[02:56:29.544] Received PubSub notification, asking Buildbucket for the build status
[02:56:29.637] Build 8855178882787024640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:56:29.637] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613444188299836",
"created_by": "project:chromium",
"created_ts": "1613440354511725",
"id": "8855178882787024640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e492efd40e5635b52e9f1fe4f034c33b51210571\"}}",
"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\": \"e492efd40e5635b52e9f1fe4f034c33b51210571\", \"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-0-6l07\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17366, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-1\", \"got_angle_revision\": \"ca6573ebb08a3048f94965aec7514750579a158d\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"e492efd40e5635b52e9f1fe4f034c33b51210571\", \"got_revision_cp\": \"refs/heads/master@{#854128}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"a24f3d035f7d9acee551d5547f4fb16838cf98d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33258}\", \"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\": \"e492efd40e5635b52e9f1fe4f034c33b51210571\", \"swarm_hashes_refs/heads/master(at){#854128}_without_patch\": {\"absl_hardening_tests\": \"e3b1188b5fad238d6f229bec22f1743b1238d9ff\", \"accessibility_unittests\": \"4b77db15d1ff15a288018241e6492aa8982571bb\", \"angle_unittests\": \"aea3647269147993535855a0917783f144da6591\", \"app_shell_unittests\": \"317a103a7589219dd88bda8c9d4eee5deef2e424\", \"aura_unittests\": \"cbedd7d2a4a275ae9ccfc685bdfb1195693e9077\", \"base_unittests\": \"d375874e71924337f293d23f95f2eedfbf583866\", \"base_util_unittests\": \"2cba5f008f6330d2c5c6059f173c454c47e888ea\", \"blink_common_unittests\": \"c7a9764bf185920b61598f8ec91acf4eef7a7670\", \"blink_fuzzer_unittests\": \"2e6383c6e55e0265aa060a4df8bb66e1bf268f2e\", \"blink_heap_unittests\": \"123ae9c3c31b85315b9765b5a426d26692a85aca\", \"blink_platform_unittests\": \"42f44382a70fb7939a476f5d772f8fed0eab471d\", \"blink_unittests\": \"d53ef46eb41c9332181fc2fc6fab4c575d4d3068\", \"boringssl_crypto_tests\": \"e453d8fb80cee363177f3af7c343f6c3a86b3d13\", \"boringssl_ssl_tests\": \"afa4a155e532b35133044e699839888f5d9bf45d\", \"browser_switcher_bho_unittests\": \"4d769f0b7cd5a4f8a51cf51be4378f0de55d1d20\", \"browser_tests\": \"94bafc524d59c01c88df27d310f22316d132d301\", \"capture_unittests\": \"4954e0e1fab2b4a78d5439950b00d852ba308ef4\", \"cast_unittests\": \"a889b403fc847b946bd165711a014acf0050976c\", \"cc_unittests\": \"a60ca5fe0a8deaf6ba4ec9d3104adef21c7e63c7\", \"chrome_app_unittests\": \"fb3464c5f91e35b6a02348a61a854a6044dd2169\", \"chrome_cleaner_unittests\": \"f4eb7b8d399758abfbdb635be533a7a535629417\", \"chrome_elf_unittests\": \"20f79a3d787876ab1fecd9b3b23e8b6a86aa2a50\", \"chromedriver_unittests\": \"24801910c825967d4e00411295ecc3c394c677b8\", \"components_browsertests\": \"bb1922cbaab261b7b69f6f59099d7a1030329e43\", \"components_unittests\": \"f4199eb68b82908b92fb073d49856def2a0e7e05\", \"compositor_unittests\": \"3a44afcbfb03f6ecd41ec078f89d8ff7e7c972ae\", \"content_browsertests\": \"f2ef58fc71ad6c16577acca1a821c2622f32eb43\", \"content_unittests\": \"4d98f340d6ba5980f37907071437198bfefa2f4c\", \"courgette_unittests\": \"13418605631c010b5ace8d92ca36d5dc9f1fa485\", \"crashpad_tests\": \"c13ba8aa0d80dbd6fce4a1754159b76557e9f399\", \"cronet_tests\": \"fc0ac87e795fb3858b22290c9c5775f3a85b0e55\", \"cronet_unittests\": \"e87ede121216ad430a70d9906225494cd92a5f39\", \"crypto_unittests\": \"13812472fc3d571411430677e0f45e97d1bc6d50\", \"delayloads_unittests\": \"15367fc26b18bd07c817f1841ebf38e33d4ad6d9\", \"device_unittests\": \"87a4a9e0e73fc13c202c7caba896841ecac8e2ec\", \"display_unittests\": \"213de280977e43505ce7aa82e9ff7d169363657e\", \"elevation_service_unittests\": \"69e71bda68357a4a524522e521bec76b4cb5d8a1\", \"events_unittests\": \"6dcc80310c13e97ade1edd2e045f96973c4c3bd7\", \"extensions_browsertests\": \"ee25c2bc44a47d2766773774c589b32cb75e4fc3\", \"extensions_unittests\": \"340171bcaa5838a44ecf0d1fed923e4a8dbc29d3\", \"filesystem_service_unittests\": \"0b09869a337516f997ea8b25807ca91ec24a1ac4\", \"gcm_unit_tests\": \"18e937e6dc270ea8494156260ddde15068bbf0cd\", \"gcp_unittests\": \"f42ac61f357db7a9131c6af312f14c03574213bc\", \"gfx_unittests\": \"54b76b4f20c5257f12a9b83935899e7dac7bd2ac\", \"gin_unittests\": \"8962850f51be3f38dd69ca9811c8d90f3f1bdf9b\", \"google_apis_unittests\": \"26ef3a5baff8cf2324910529623104243ecb1a72\", \"gpu_unittests\": \"dfa8d4aa788ec9b5e0be8edb46b53c01fc8b0ecc\", \"gwp_asan_unittests\": \"dbbd3ab0fa39fe49942932361a2ca26e23b0f886\", \"headless_browsertests\": \"7160e6a6d0d302e22578e30962e43922693f460f\", \"headless_unittests\": \"00ccde4235ce0d0bedd27dd232e0cd143ffab2b1\", \"install_static_unittests\": \"ca6f27a19be4579ee38f46cb51a092f58a82ced0\", \"installer_util_unittests\": \"8e1b92922c6392a437522018d03e5dd36db4a0ae\", \"interactive_ui_tests\": \"6704067d43ce6e5c1303a08ae1020782ad8ca029\", \"ipc_tests\": \"3a969fb9c9463f171c50676932a0b41c4e095673\", \"jingle_unittests\": \"b5804fd0d878bf97c5580ac65a59c2d2d419dfa0\", \"latency_unittests\": \"69d274308ed126b4cca940ff557a2c0236a95c32\", \"libjingle_xmpp_unittests\": \"bdb664e4f2dc2c8af3840bacd5c27ceb59e49980\", \"liburlpattern_unittests\": \"e844e823a53d1a78b907d636fdb20126a9af5cfa\", \"media_blink_unittests\": \"51a8719c4af6b94cc2086ec5951735b0f0fe1bf3\", \"media_unittests\": \"6d8706938f0dc48b04ff1a106b4a5191e94d8dcf\", \"message_center_unittests\": \"586ec54565eef465134f754fe6615608593dab2b\", \"midi_unittests\": \"483334dadc3fefa6a77250a5852e162ca8138214\", \"mojo_core_unittests\": \"8c818f763b75103bddf464ddd44804b3a7d6309a\", \"mojo_unittests\": \"3ba881bc680d516c43da86748071fdbafd7f8859\", \"nacl_loader_unittests\": \"6cf43e44f413cb8b2edee6d82e15567486c7d3bd\", \"native_theme_unittests\": \"c087feca606704d23f04785aef4c68b1cf166712\", \"net_unittests\": \"11d1fde15e58cd36b5c063f53e8234898c02f6ae\", \"notification_helper_unittests\": \"618ec00477bc2856da286b1d56d2828c18ee9199\", \"pdf_unittests\": \"8c1fec8dceb1abee69c4665e31ea63089c41e9ec\", \"perfetto_unittests\": \"39895e2b2700a8648315c2c2826544055acfbbd1\", \"ppapi_unittests\": \"3e5e00c9c69b56d6646078bf9810b714ac3c5904\", \"printing_unittests\": \"a68513c4e6c4a75266451dfef3596066ea86f815\", \"remoting_unittests\": \"9bfb176733b6aef073db8725bc3e61a07958f4a1\", \"sbox_integration_tests\": \"860de998907bec8da442ece4ad0b0283c51c0dd8\", \"sbox_unittests\": \"630e831656cd65b1214c301b476fdb005e79deb0\", \"sbox_validation_tests\": \"7f7cdb2c92977ba383951e8b9c44295eb5a9260f\", \"service_manager_unittests\": \"672d41d4bd6c75491b5ac482386eb00d58caf736\", \"services_unittests\": \"d3eb45f637edb4e1e789f33dce80898f09670ef0\", \"setup_unittests\": \"4d832c0a30e8d74edf71e8234084480a62b6f0ef\", \"shell_dialogs_unittests\": \"521f99d03fb07c37537daecc3a4a1d083d884d56\", \"skia_unittests\": \"aa39681752e724255a56d8af013c046725ee4c84\", \"snapshot_unittests\": \"088d2f298151e4c3c3d890ce8e02ab948ade96cd\", \"sql_unittests\": \"e0cfcc8283db937a9caaed5706adde1a98beca2c\", \"storage_unittests\": \"68a4bc2f7eda40da6a386f7b12efc9cc63f6f408\", \"sync_integration_tests\": \"d2042e0b5f9ce8f2692b6f869ef09f1894250fd6\", \"traffic_annotation_auditor_unittests\": \"84ad7c2b2b7fcb937c2dbb97af067788c6f55a3a\", \"ui_base_unittests\": \"3307248ad0e3cbd481cf4ef598f2001b30d2e466\", \"ui_touch_selection_unittests\": \"a0ab175a5a276a466d7e186e0f1aa74a6354c446\", \"unit_tests\": \"092a5215bf1c2d107b0fb37840f08f94d16f5985\", \"updater_tests\": \"1220f9db332623940cf3f548060b1e4472bf6375\", \"url_unittests\": \"c38d24df0fa4634830ed808cc203dfd5781584b3\", \"views_unittests\": \"767946497dc95b991c7665dea006eedc35e1786b\", \"viz_unittests\": \"8bc46c5ca194325926991796aa8f8f2d3abf9df4\", \"vr_common_unittests\": \"01b8794ab98c070205816fdfbb4246d0e29b59ad\", \"vr_pixeltests\": \"11bc9eb01d05a9f2302a99a9da08b839fcf601d5\", \"weblayer_browsertests\": \"196df7470e041db51d5b9d46ac380207d35671f9\", \"weblayer_unittests\": \"ffcc35c1a9b3671b802ae521e27c752b8cf861fa\", \"wm_unittests\": \"8173603f7562d014788c1d0ecd494848dcd991ed\", \"wtf_unittests\": \"5ffcdf23f7bf07722484f93eaec5cf8ea3d0ca27\", \"zlib_unittests\": \"2ec4857729edb34bc28a3e39ded86866b4a2c7b7\", \"zucchini_unittests\": \"d5fb8bac5ae5af03a2b58b0579838ff6ce2b83cf\"}}, \"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-0-6l07\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5700-b36f18b\"], \"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": "1613440362335620",
"status": "COMPLETED",
"status_changed_ts": "1613444188639860",
"tags": [
"build_address:luci.chromium.ci/win-asan/17366",
"builder:win-asan",
"buildset:commit/git/e492efd40e5635b52e9f1fe4f034c33b51210571",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e492efd40e5635b52e9f1fe4f034c33b51210571",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020608944850869632",
"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/8855178882787024640/+/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:51c15b94c4df4610",
"user_agent:luci-scheduler"
],
"updated_ts": "1613444188648341",
"url": "https://ci.chromium.org/b/8855178882787024640",
"utcnow_ts": "1613444189628149"
}
}
[02:56:29.637] Invocation finished in 1h3m56.478533067s with status SUCCEEDED