[00:37:05.034] New invocation is queued and will start shortly
[00:37:06.242] Starting the invocation (attempt 1)
[00:37:06.278] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:06.278] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:06.278] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021972647447518160",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef273766fa1768290df2d63143a80cef05f32df5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021972647447518160",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/ef273766fa1768290df2d63143a80cef05f32df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef273766fa1768290df2d63143a80cef05f32df5",
"gitiles_ref:refs/heads/master"
]
}
[00:37:06.953] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612139826371851",
"id": "8856542585381157600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef273766fa1768290df2d63143a80cef05f32df5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612139826820882",
"tags": [
"build_address:luci.chromium.ci/win-asan/17102",
"builder:win-asan",
"buildset:commit/git/ef273766fa1768290df2d63143a80cef05f32df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef273766fa1768290df2d63143a80cef05f32df5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021972647447518160",
"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/8856542585381157600/+/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": "1612139826821098",
"url": "https://ci.chromium.org/b/8856542585381157600",
"utcnow_ts": "1612139826945239"
}
}
[00:37:06.953] Task URL: https://ci.chromium.org/b/8856542585381157600
[00:37:06.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:2:0) after 1m0s
[00:37:10.173] Received PubSub notification, asking Buildbucket for the build status
[00:37:10.258] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:06.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:2:0)
[00:38:06.972] Timer tick, asking Buildbucket for the build status
[00:38:07.074] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:07.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:4:0) after 1m0s
[00:39:07.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:4:0)
[00:39:07.097] Timer tick, asking Buildbucket for the build status
[00:39:07.190] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:07.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:5:0) after 1m0s
[00:40:07.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:5:0)
[00:40:07.242] Timer tick, asking Buildbucket for the build status
[00:40:07.694] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:07.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:6:0) after 1m0s
[00:41:07.760] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:6:0)
[00:41:07.760] Timer tick, asking Buildbucket for the build status
[00:41:07.846] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:07.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:7:0) after 1m0s
[00:42:07.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:7:0)
[00:42:07.813] Timer tick, asking Buildbucket for the build status
[00:42:08.002] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:8:0) after 1m0s
[00:43:08.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:8:0)
[00:43:08.030] Timer tick, asking Buildbucket for the build status
[00:43:08.243] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:08.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:9:0) after 1m0s
[00:44:08.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:9:0)
[00:44:08.273] Timer tick, asking Buildbucket for the build status
[00:44:08.347] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:08.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:10:0) after 1m0s
[00:45:08.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:10:0)
[00:45:08.418] Timer tick, asking Buildbucket for the build status
[00:45:08.480] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:08.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:11:0) after 1m0s
[00:46:08.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:11:0)
[00:46:08.524] Timer tick, asking Buildbucket for the build status
[00:46:08.940] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:08.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:12:0) after 1m0s
[00:47:09.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:12:0)
[00:47:09.042] Timer tick, asking Buildbucket for the build status
[00:47:09.625] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:09.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:13:0) after 1m0s
[00:48:09.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:13:0)
[00:48:09.644] Timer tick, asking Buildbucket for the build status
[00:48:09.760] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:09.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:14:0) after 1m0s
[00:49:09.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:14:0)
[00:49:09.777] Timer tick, asking Buildbucket for the build status
[00:49:09.852] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:09.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:15:0) after 1m0s
[00:50:09.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:15:0)
[00:50:09.900] Timer tick, asking Buildbucket for the build status
[00:50:09.967] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:16:0) after 1m0s
[00:51:09.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:16:0)
[00:51:09.963] Timer tick, asking Buildbucket for the build status
[00:51:10.052] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:10.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:17:0) after 1m0s
[00:52:10.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:17:0)
[00:52:10.105] Timer tick, asking Buildbucket for the build status
[00:52:10.197] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:10.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:18:0) after 1m0s
[00:53:10.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:18:0)
[00:53:10.172] Timer tick, asking Buildbucket for the build status
[00:53:10.236] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:10.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:19:0) after 1m0s
[00:54:10.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:19:0)
[00:54:10.255] Timer tick, asking Buildbucket for the build status
[00:54:10.847] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:10.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:20:0) after 1m0s
[00:55:10.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:20:0)
[00:55:10.868] Timer tick, asking Buildbucket for the build status
[00:55:11.014] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:11.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:21:0) after 1m0s
[00:56:11.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:21:0)
[00:56:11.028] Timer tick, asking Buildbucket for the build status
[00:56:11.110] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:11.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:22:0) after 1m0s
[00:57:11.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:22:0)
[00:57:11.152] Timer tick, asking Buildbucket for the build status
[00:57:11.546] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:11.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:23:0) after 1m0s
[00:58:11.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:23:0)
[00:58:11.552] Timer tick, asking Buildbucket for the build status
[00:58:11.950] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:11.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:24:0) after 1m0s
[00:59:11.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:24:0)
[00:59:11.942] Timer tick, asking Buildbucket for the build status
[00:59:12.058] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:12.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:25:0) after 1m0s
[01:00:12.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:25:0)
[01:00:12.076] Timer tick, asking Buildbucket for the build status
[01:00:12.842] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:12.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:26:0) after 1m0s
[01:01:12.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:26:0)
[01:01:12.906] Timer tick, asking Buildbucket for the build status
[01:01:13.111] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:13.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:27:0) after 1m0s
[01:02:13.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:27:0)
[01:02:13.153] Timer tick, asking Buildbucket for the build status
[01:02:13.282] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:13.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:28:0) after 1m0s
[01:03:13.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:28:0)
[01:03:13.336] Timer tick, asking Buildbucket for the build status
[01:03:13.467] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:13.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:29:0) after 1m0s
[01:04:13.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:29:0)
[01:04:13.537] Timer tick, asking Buildbucket for the build status
[01:04:13.733] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:30:0) after 1m0s
[01:05:13.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:30:0)
[01:05:13.750] Timer tick, asking Buildbucket for the build status
[01:05:13.815] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:13.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:31:0) after 1m0s
[01:06:13.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:31:0)
[01:06:13.848] Timer tick, asking Buildbucket for the build status
[01:06:13.916] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:13.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:32:0) after 1m0s
[01:07:13.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:32:0)
[01:07:13.983] Timer tick, asking Buildbucket for the build status
[01:07:14.083] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:14.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:33:0) after 1m0s
[01:08:14.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:33:0)
[01:08:14.137] Timer tick, asking Buildbucket for the build status
[01:08:14.208] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:14.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:34:0) after 1m0s
[01:09:14.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:34:0)
[01:09:14.256] Timer tick, asking Buildbucket for the build status
[01:09:14.314] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:14.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:35:0) after 1m0s
[01:10:14.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:35:0)
[01:10:14.359] Timer tick, asking Buildbucket for the build status
[01:10:14.514] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:14.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:36:0) after 1m0s
[01:11:14.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:36:0)
[01:11:14.581] Timer tick, asking Buildbucket for the build status
[01:11:14.653] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:14.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:37:0) after 1m0s
[01:12:14.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:37:0)
[01:12:14.708] Timer tick, asking Buildbucket for the build status
[01:12:14.822] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:14.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:38:0) after 1m0s
[01:13:14.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:38:0)
[01:13:14.884] Timer tick, asking Buildbucket for the build status
[01:13:14.986] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:14.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:39:0) after 1m0s
[01:14:15.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:39:0)
[01:14:15.014] Timer tick, asking Buildbucket for the build status
[01:14:15.154] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:15.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:40:0) after 1m0s
[01:15:15.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:40:0)
[01:15:15.234] Timer tick, asking Buildbucket for the build status
[01:15:15.356] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:15.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:41:0) after 1m0s
[01:16:15.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:41:0)
[01:16:15.389] Timer tick, asking Buildbucket for the build status
[01:16:15.463] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:15.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:42:0) after 1m0s
[01:17:15.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:42:0)
[01:17:15.483] Timer tick, asking Buildbucket for the build status
[01:17:15.898] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:15.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:43:0) after 1m0s
[01:18:15.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:43:0)
[01:18:15.918] Timer tick, asking Buildbucket for the build status
[01:18:15.983] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:15.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:44:0) after 1m0s
[01:19:19.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:44:0)
[01:19:19.972] Timer tick, asking Buildbucket for the build status
[01:19:20.090] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:45:0) after 1m0s
[01:20:20.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:45:0)
[01:20:20.212] Timer tick, asking Buildbucket for the build status
[01:20:20.350] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:46:0) after 1m0s
[01:21:20.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:46:0)
[01:21:20.493] Timer tick, asking Buildbucket for the build status
[01:21:20.601] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:20.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:47:0) after 1m0s
[01:22:20.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:47:0)
[01:22:20.683] Timer tick, asking Buildbucket for the build status
[01:22:20.819] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:20.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:48:0) after 1m0s
[01:23:20.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:48:0)
[01:23:20.913] Timer tick, asking Buildbucket for the build status
[01:23:21.686] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:21.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:49:0) after 1m0s
[01:24:21.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:49:0)
[01:24:21.691] Timer tick, asking Buildbucket for the build status
[01:24:21.931] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:21.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:50:0) after 1m0s
[01:25:21.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:50:0)
[01:25:21.962] Timer tick, asking Buildbucket for the build status
[01:25:22.094] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:22.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:51:0) after 1m0s
[01:26:22.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:51:0)
[01:26:22.147] Timer tick, asking Buildbucket for the build status
[01:26:22.267] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:22.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:52:0) after 1m0s
[01:27:22.297] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:52:0)
[01:27:22.297] Timer tick, asking Buildbucket for the build status
[01:27:22.441] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:22.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:53:0) after 1m0s
[01:28:22.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:53:0)
[01:28:22.463] Timer tick, asking Buildbucket for the build status
[01:28:22.540] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:22.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:54:0) after 1m0s
[01:29:22.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:54:0)
[01:29:22.592] Timer tick, asking Buildbucket for the build status
[01:29:23.219] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:23.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:55:0) after 1m0s
[01:30:23.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:55:0)
[01:30:23.232] Timer tick, asking Buildbucket for the build status
[01:30:24.015] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:56:0) after 1m0s
[01:31:24.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:56:0)
[01:31:24.147] Timer tick, asking Buildbucket for the build status
[01:31:24.398] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:24.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:57:0) after 1m0s
[01:32:24.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:57:0)
[01:32:24.700] Timer tick, asking Buildbucket for the build status
[01:32:27.652] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:58:0) after 1m0s
[01:33:27.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:58:0)
[01:33:27.745] Timer tick, asking Buildbucket for the build status
[01:33:27.810] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:27.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:59:0) after 1m0s
[01:34:27.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:59:0)
[01:34:27.836] Timer tick, asking Buildbucket for the build status
[01:34:28.005] Build 8856542585381157600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:28.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021972647447518160:60:0) after 1m0s
[01:35:13.284] Received PubSub notification, asking Buildbucket for the build status
[01:35:13.361] Build 8856542585381157600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:35:13.361] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612143311349058",
"created_by": "project:chromium",
"created_ts": "1612139826371851",
"id": "8856542585381157600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef273766fa1768290df2d63143a80cef05f32df5\"}}",
"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\": \"ef273766fa1768290df2d63143a80cef05f32df5\", \"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-us-central1-b-32-1-y2bx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17102, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"0be050a44a4308ace01229b89bd4560457356007\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"ef273766fa1768290df2d63143a80cef05f32df5\", \"got_revision_cp\": \"refs/heads/master@{#848976}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8b4cf1c2491d56cf9eda153b5455e4b295732b7c\", \"got_v8_revision\": \"cbbe339c1ca9754b3123fe2bdb83c0f58ee5d728\", \"got_v8_revision_cp\": \"refs/heads/9.0.101@{#1}\", \"got_webrtc_revision\": \"41bfcf4a63611409220fcd458a03deaa2cd23619\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33116}\", \"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\": \"ef273766fa1768290df2d63143a80cef05f32df5\", \"swarm_hashes_refs/heads/master(at){#848976}_without_patch\": {\"absl_hardening_tests\": \"54efe653eb29ffd0408a4310ba6170cd3f723d26\", \"accessibility_unittests\": \"7b09de4016baf5728a4c613e4cd45208fa5d1da1\", \"angle_unittests\": \"4cd792690eeb1b221fbda31e6b5762998eae92a3\", \"app_shell_unittests\": \"33446b6c30400d59fd6ccc56cefd52b6a000961d\", \"aura_unittests\": \"908e5801f262242173ffcaa3eb253ded55c260f0\", \"base_unittests\": \"59ca6465fde0e52df071d0976cc81c47fa039154\", \"base_util_unittests\": \"b8a938daa05583c3356c2b6658659f4a4496dc76\", \"blink_common_unittests\": \"6bf0ce12bd2ae087c852559fa86326e5fa430e08\", \"blink_fuzzer_unittests\": \"c23591b1ece14dba6cccd18a21b976f5ada4fea2\", \"blink_heap_unittests\": \"b96523ed16af7bdc2e94ebb10d32854be884d73e\", \"blink_platform_unittests\": \"b4e3b661795d2e9c44acb08c388473109a706620\", \"blink_unittests\": \"17a29705c9906235e7c9b03166aeb44d90f7489b\", \"boringssl_crypto_tests\": \"3c8d2559da392fae7f9aeef8f796d574e470b898\", \"boringssl_ssl_tests\": \"537a3ff703d15263942349feea13c0091e9cebd5\", \"browser_switcher_bho_unittests\": \"5aa750a9772e4e130f025c48361cb62cba0e5597\", \"browser_tests\": \"cbec5c44e481ed3f65724e10dcb264945f673dfc\", \"capture_unittests\": \"df47d2f118533d0b046f9e00b0c96e301c650346\", \"cast_unittests\": \"15cab57b5547670e2eeb5fb4e2f1d02d3fefbb10\", \"cc_unittests\": \"c2f1ae2e6172a46c74e4da8d3a53147fe4d3ee34\", \"chrome_app_unittests\": \"4f430d163a4ad38ec046cbfcf7dd77c87b830234\", \"chrome_cleaner_unittests\": \"6972b673cb403d105861b1178e2697ce14fa15aa\", \"chrome_elf_unittests\": \"41ef04e1c3d34d52388f142c8ecaba970cde8b84\", \"chromedriver_unittests\": \"57adbda8e058d79c174cb829c24833ef11df59d6\", \"components_browsertests\": \"99df88b70beb45c8032a06fedd793e6ccb1e1a8b\", \"components_unittests\": \"f3d3b7f5871c70335aedcbaae2d4930758dd6dda\", \"compositor_unittests\": \"c64c7e4e0f206038435be4a37274b131f8dbf865\", \"content_browsertests\": \"e024bde7ad466ef67e8f39e615fcf01a9f00bee0\", \"content_unittests\": \"9932031af70234cf80e4d5d7ec0e517f2e8ace2d\", \"courgette_unittests\": \"01836ce5c6dd616175cd1913a7397fdb7b914055\", \"crashpad_tests\": \"1bc71d38c563b9953a09ced2dfb7195ee06cb3a2\", \"cronet_tests\": \"73f0fabeda4c9846ee859151c39ee2c344423fbd\", \"cronet_unittests\": \"46e3fcf02c4c5415e64dc3f12c7a987b416e03c7\", \"crypto_unittests\": \"9ba1caa01ef2664436cec9cc0327c9eaeae91602\", \"delayloads_unittests\": \"102d0dd462472332a356137024cf1095d2a97539\", \"device_unittests\": \"0993f7ff4273ca7db15aa9c3ec40507ebc158324\", \"display_unittests\": \"33ace8f1410d3f6349d8bb23ad9723ba50bcdeaf\", \"elevation_service_unittests\": \"448bbf3edf5fb0815e4022420b9ccdfff237465e\", \"events_unittests\": \"e775887ba2ca2903d52e6c2d491efe11b55d8cb5\", \"extensions_browsertests\": \"3b26e094aabed76143df73d68c11442fcd764e4e\", \"extensions_unittests\": \"a1fc2be861f03857c3c6bb0a0e86b5df5bd24ff2\", \"filesystem_service_unittests\": \"0b7c53b96121ba682338d67bd8759716655adc23\", \"gcm_unit_tests\": \"a91d9924e16451ce6c329a12439907c4c8e3dc73\", \"gcp_unittests\": \"b636c0cb809c810ded5d0a8ca025c5f855c435d6\", \"gfx_unittests\": \"8e3ef9d8434edcc742bf09d37fb257204bd3e9c3\", \"gin_unittests\": \"c01087ea85cda169438957138e62a4ec5694e889\", \"google_apis_unittests\": \"979ecdec49e5763134b5799756aaf63dfa968e90\", \"gpu_unittests\": \"95250902c081571bb16bd97f4f5b99b0f11bc1e5\", \"gwp_asan_unittests\": \"d922626f4d63943e2b30c1dee963555c20d07e61\", \"headless_browsertests\": \"b33b2d0fc3f76b1597fb236bcbc38149516c39cd\", \"headless_unittests\": \"5c4499502485608ea0b1349a2bac4298c075d126\", \"install_static_unittests\": \"c7cf8633cf329daefb3d7093c646612b8487ef0d\", \"installer_util_unittests\": \"0b474f31c1039126d566ebd9b5049e5139ae5b8f\", \"interactive_ui_tests\": \"f3960ac6b5dbf681f2f4cb407e3649028dd925cc\", \"ipc_tests\": \"981e28a98a0c6f9b882f687ff7e4e9ba113a9173\", \"jingle_unittests\": \"0733c551b68cab5934fbc7b843acdb3a651a956b\", \"latency_unittests\": \"bad79be6996af3b0b26dd0e79769c12905ab7d26\", \"libjingle_xmpp_unittests\": \"1327d25f5573d93a4c711cfc01541512a5a724c5\", \"liburlpattern_unittests\": \"9d8a436360cafe877a842ac86e172549ed43b66e\", \"media_blink_unittests\": \"9e13de741ab1e4e53bc775bf438be5c12fe3a8fa\", \"media_unittests\": \"a20b6ee0bcccf0743e16c7d7d9f6f222041f6e37\", \"message_center_unittests\": \"a3af172ce96a3a2ff89290b635593fb3524c785b\", \"midi_unittests\": \"dc4bb666d6c61f615fd61dbc61d09eb0c2bcce7c\", \"mojo_core_unittests\": \"5e99d6e01d751cfa0fc244a36c25fcf7bf6954db\", \"mojo_unittests\": \"f893fcd9170974d7decc795c4890130c7c7ccb2a\", \"nacl_loader_unittests\": \"99d936705ecab4a2c8fc3192f3863dcf978ac903\", \"native_theme_unittests\": \"e89203da97e05274d997cecc37457a7c6691d95d\", \"net_unittests\": \"a0e7352c4ce4612013d432b30e9253a554632145\", \"notification_helper_unittests\": \"e2f717a0bd49466fd6614cea7e45bd34a95fb4ef\", \"pdf_unittests\": \"b381433ffae15aa5b8c1d20c5295cbb9bd239264\", \"perfetto_unittests\": \"250b8a7a7bdb2c8185a5d9ec0f70562d44005242\", \"ppapi_unittests\": \"dcc5ddd6f70013438d529f7e506947a9e4f55343\", \"printing_unittests\": \"5c013c790d79fef9e1114bfd5198ad81b1692208\", \"remoting_unittests\": \"756dd7d0d72ff540c3f06fd0085981272befeec9\", \"sbox_integration_tests\": \"b8e746a2f9de2048eed46435e17f422ecd6e14d0\", \"sbox_unittests\": \"e9728144e8bd0110aedb71bf34553d0b3c45f525\", \"sbox_validation_tests\": \"80fbe13df3a07fe477a7450b65ddc4aa83b228d2\", \"service_manager_unittests\": \"0d31728ee44eb17bad3bfff468c1e8e26b25c5fd\", \"services_unittests\": \"9d619914c14cb8330b852d7daa77a6a1809e55fc\", \"setup_unittests\": \"1a8051bae7db17a94c8658d0d7fcfdb666173994\", \"shell_dialogs_unittests\": \"c4baea57210c41e3529cf07e6ef7f81329a9560c\", \"skia_unittests\": \"4836d03443606b0cd0ca7efee7718cb5952ff45b\", \"snapshot_unittests\": \"7474338b8f3d2d6d8def49ae06d310018e47842b\", \"sql_unittests\": \"267040b731bfc2161f3dfa7b233b4d5d604cb3bf\", \"storage_unittests\": \"fd349436e9d74e7384d8bf09dc11e601656467c2\", \"sync_integration_tests\": \"eef90bdd782076908420e4038fc8cf50de17f5ef\", \"traffic_annotation_auditor_unittests\": \"ec5d35c2e34616b972c0e51487143429415f061a\", \"ui_base_unittests\": \"e715a05c36280005c83f69f57eb1997e0b77e7d5\", \"ui_touch_selection_unittests\": \"f5f3b592fc8f322b23da4131dd2756e7d076a160\", \"unit_tests\": \"7563d73012202673851d402d827d978c4168f1a5\", \"updater_tests\": \"06e324ff8c8767b9e58b34b9668817019a26a8fa\", \"url_unittests\": \"07bb83330d8d20976982bf9e382019f2e8f41efe\", \"views_unittests\": \"14a7293e650ea1ec6d5b91b6022a3c75fab11d05\", \"viz_unittests\": \"bcb5a1d031e6263286cfe5d24b791c628a05e1b6\", \"vr_common_unittests\": \"282f7ce5277f4dcd91356a2bb865d657f4f90712\", \"vr_pixeltests\": \"46f7333812ff84120b3b0b8dd26183c7fdb3b8c4\", \"weblayer_browsertests\": \"420bf45d52a57f9acdb4e47c153e90a85e3fc7f2\", \"weblayer_unittests\": \"e26668e06ea77e9522cddda4740e4ad423f4b7d3\", \"wm_unittests\": \"6e6a608b2dfaead931684151049dc7e3d469d400\", \"wtf_unittests\": \"1b34fe72f3bd8f17820e53521105443b9eb3c120\", \"zlib_unittests\": \"e5553eff791df2decc8f7026c12654aaaa409792\", \"zucchini_unittests\": \"84d957c3537bb5c8a9b4834f7e2c8e032ca6792d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-y2bx\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612139828825011",
"status": "COMPLETED",
"status_changed_ts": "1612143311602173",
"tags": [
"build_address:luci.chromium.ci/win-asan/17102",
"builder:win-asan",
"buildset:commit/git/ef273766fa1768290df2d63143a80cef05f32df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef273766fa1768290df2d63143a80cef05f32df5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021972647447518160",
"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/8856542585381157600/+/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:5173d7174a01f410",
"user_agent:luci-scheduler"
],
"updated_ts": "1612143311608408",
"url": "https://ci.chromium.org/b/8856542585381157600",
"utcnow_ts": "1612143313339566"
}
}
[01:35:13.361] Invocation finished in 58m8.344328216s with status SUCCEEDED