[07:28:29.398] New invocation is queued and will start shortly
[07:28:30.657] Starting the invocation (attempt 1)
[07:28:30.732] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:28:30.732] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:28:30.732] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024121091210017872",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7d9afdd32c1575355cd8429484b8c97c422ed91a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024121091210017872",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"gitiles_ref:refs/heads/master"
]
}
[07:28:31.437] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610090910867150",
"id": "8858691029004588608",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d9afdd32c1575355cd8429484b8c97c422ed91a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610090911223695",
"tags": [
"build_address:luci.chromium.ci/win-asan/16689",
"builder:win-asan",
"buildset:commit/git/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024121091210017872",
"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/8858691029004588608/+/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": "1610090911223848",
"url": "https://ci.chromium.org/b/8858691029004588608",
"utcnow_ts": "1610090911422272"
}
}
[07:28:31.437] Task URL: https://ci.chromium.org/b/8858691029004588608
[07:28:31.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:2:0) after 1m0s
[07:28:35.040] Received PubSub notification, asking Buildbucket for the build status
[07:28:35.317] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:31.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:2:0)
[07:29:31.555] Timer tick, asking Buildbucket for the build status
[07:29:31.627] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:31.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:4:0) after 1m0s
[07:30:31.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:4:0)
[07:30:31.679] Timer tick, asking Buildbucket for the build status
[07:30:32.247] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:32.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:5:0) after 1m0s
[07:31:32.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:5:0)
[07:31:32.309] Timer tick, asking Buildbucket for the build status
[07:31:32.458] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:32.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:6:0) after 1m0s
[07:32:32.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:6:0)
[07:32:32.519] Timer tick, asking Buildbucket for the build status
[07:32:32.608] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:32.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:7:0) after 1m0s
[07:33:32.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:7:0)
[07:33:32.617] Timer tick, asking Buildbucket for the build status
[07:33:32.900] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:32.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:8:0) after 1m0s
[07:34:33.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:8:0)
[07:34:33.170] Timer tick, asking Buildbucket for the build status
[07:34:33.279] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:33.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:9:0) after 1m0s
[07:35:33.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:9:0)
[07:35:33.298] Timer tick, asking Buildbucket for the build status
[07:35:33.397] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:33.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:10:0) after 1m0s
[07:36:33.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:10:0)
[07:36:33.519] Timer tick, asking Buildbucket for the build status
[07:36:33.651] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:33.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:11:0) after 1m0s
[07:37:33.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:11:0)
[07:37:33.759] Timer tick, asking Buildbucket for the build status
[07:37:34.297] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:34.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:12:0) after 1m0s
[07:38:34.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:12:0)
[07:38:34.508] Timer tick, asking Buildbucket for the build status
[07:38:34.606] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:34.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:13:0) after 1m0s
[07:39:34.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:13:0)
[07:39:34.625] Timer tick, asking Buildbucket for the build status
[07:39:34.748] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:14:0) after 1m0s
[07:40:34.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:14:0)
[07:40:34.861] Timer tick, asking Buildbucket for the build status
[07:40:34.957] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:15:0) after 1m0s
[07:41:35.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:15:0)
[07:41:35.003] Timer tick, asking Buildbucket for the build status
[07:41:35.113] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:35.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:16:0) after 1m0s
[07:42:35.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:16:0)
[07:42:35.151] Timer tick, asking Buildbucket for the build status
[07:42:35.262] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:35.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:17:0) after 1m0s
[07:43:35.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:17:0)
[07:43:35.280] Timer tick, asking Buildbucket for the build status
[07:43:35.384] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:35.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:18:0) after 1m0s
[07:44:35.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:18:0)
[07:44:35.402] Timer tick, asking Buildbucket for the build status
[07:44:35.644] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:35.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:19:0) after 1m0s
[07:45:35.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:19:0)
[07:45:35.701] Timer tick, asking Buildbucket for the build status
[07:45:36.209] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:20:0) after 1m0s
[07:46:36.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:20:0)
[07:46:36.228] Timer tick, asking Buildbucket for the build status
[07:46:36.715] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:21:0) after 1m0s
[07:47:36.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:21:0)
[07:47:36.843] Timer tick, asking Buildbucket for the build status
[07:47:36.975] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:36.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:22:0) after 1m0s
[07:48:37.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:22:0)
[07:48:37.079] Timer tick, asking Buildbucket for the build status
[07:48:37.310] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:37.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:23:0) after 1m0s
[07:49:37.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:23:0)
[07:49:37.337] Timer tick, asking Buildbucket for the build status
[07:49:37.696] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:37.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:24:0) after 1m0s
[07:50:37.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:24:0)
[07:50:37.718] Timer tick, asking Buildbucket for the build status
[07:50:38.147] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:38.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:25:0) after 1m0s
[07:51:38.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:25:0)
[07:51:38.234] Timer tick, asking Buildbucket for the build status
[07:51:38.303] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:38.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:26:0) after 1m0s
[07:52:38.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:26:0)
[07:52:38.347] Timer tick, asking Buildbucket for the build status
[07:52:38.420] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:38.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:27:0) after 1m0s
[07:53:38.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:27:0)
[07:53:38.432] Timer tick, asking Buildbucket for the build status
[07:53:38.555] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:38.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:28:0) after 1m0s
[07:54:38.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:28:0)
[07:54:38.716] Timer tick, asking Buildbucket for the build status
[07:54:38.790] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:38.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:29:0) after 1m0s
[07:55:38.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:29:0)
[07:55:38.808] Timer tick, asking Buildbucket for the build status
[07:55:38.927] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:38.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:30:0) after 1m0s
[07:56:39.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:30:0)
[07:56:39.017] Timer tick, asking Buildbucket for the build status
[07:56:39.179] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:39.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:31:0) after 1m0s
[07:57:39.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:31:0)
[07:57:39.235] Timer tick, asking Buildbucket for the build status
[07:57:39.328] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:39.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:32:0) after 1m0s
[07:58:39.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:32:0)
[07:58:39.418] Timer tick, asking Buildbucket for the build status
[07:58:39.558] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:39.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:33:0) after 1m0s
[07:59:39.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:33:0)
[07:59:39.614] Timer tick, asking Buildbucket for the build status
[07:59:39.678] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:39.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:34:0) after 1m0s
[08:00:39.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:34:0)
[08:00:39.781] Timer tick, asking Buildbucket for the build status
[08:00:40.131] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:40.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:35:0) after 1m0s
[08:01:40.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:35:0)
[08:01:40.150] Timer tick, asking Buildbucket for the build status
[08:01:40.273] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:40.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:36:0) after 1m0s
[08:02:40.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:36:0)
[08:02:40.308] Timer tick, asking Buildbucket for the build status
[08:02:40.513] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:40.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:37:0) after 1m0s
[08:03:40.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:37:0)
[08:03:40.498] Timer tick, asking Buildbucket for the build status
[08:03:40.893] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:40.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:38:0) after 1m0s
[08:04:40.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:38:0)
[08:04:40.884] Timer tick, asking Buildbucket for the build status
[08:04:41.243] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:41.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:39:0) after 1m0s
[08:05:41.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:39:0)
[08:05:41.304] Timer tick, asking Buildbucket for the build status
[08:05:41.381] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:41.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:40:0) after 1m0s
[08:06:41.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:40:0)
[08:06:41.378] Timer tick, asking Buildbucket for the build status
[08:06:41.512] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:41.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:41:0) after 1m0s
[08:07:41.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:41:0)
[08:07:41.532] Timer tick, asking Buildbucket for the build status
[08:07:42.124] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:42.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:42:0) after 1m0s
[08:08:42.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:42:0)
[08:08:42.146] Timer tick, asking Buildbucket for the build status
[08:08:42.682] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:42.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:43:0) after 1m0s
[08:09:42.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:43:0)
[08:09:42.788] Timer tick, asking Buildbucket for the build status
[08:09:43.431] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:43.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:44:0) after 1m0s
[08:10:43.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:44:0)
[08:10:43.455] Timer tick, asking Buildbucket for the build status
[08:10:43.802] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:43.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:45:0) after 1m0s
[08:11:43.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:45:0)
[08:11:43.896] Timer tick, asking Buildbucket for the build status
[08:11:44.094] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:44.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:46:0) after 1m0s
[08:12:44.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:46:0)
[08:12:44.187] Timer tick, asking Buildbucket for the build status
[08:12:44.331] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:44.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:47:0) after 1m0s
[08:13:44.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:47:0)
[08:13:44.388] Timer tick, asking Buildbucket for the build status
[08:13:44.766] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:44.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:48:0) after 1m0s
[08:14:44.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:48:0)
[08:14:44.790] Timer tick, asking Buildbucket for the build status
[08:14:44.868] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:44.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:49:0) after 1m0s
[08:15:44.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:49:0)
[08:15:44.896] Timer tick, asking Buildbucket for the build status
[08:15:45.013] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:45.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:50:0) after 1m0s
[08:16:45.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:50:0)
[08:16:45.030] Timer tick, asking Buildbucket for the build status
[08:16:45.110] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:45.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:51:0) after 1m0s
[08:17:45.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:51:0)
[08:17:45.131] Timer tick, asking Buildbucket for the build status
[08:17:45.202] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:45.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:52:0) after 1m0s
[08:18:45.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:52:0)
[08:18:45.240] Timer tick, asking Buildbucket for the build status
[08:18:45.386] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:45.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:53:0) after 1m0s
[08:19:45.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:53:0)
[08:19:45.425] Timer tick, asking Buildbucket for the build status
[08:19:45.668] Build 8858691029004588608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:45.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024121091210017872:54:0) after 1m0s
[08:20:09.194] Received PubSub notification, asking Buildbucket for the build status
[08:20:09.314] Build 8858691029004588608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:20:09.314] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610094006096364",
"created_by": "project:chromium",
"created_ts": "1610090910867150",
"id": "8858691029004588608",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d9afdd32c1575355cd8429484b8c97c422ed91a\"}}",
"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\": \"7d9afdd32c1575355cd8429484b8c97c422ed91a\", \"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-7-w73f\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16689, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"f99ccb082ba59aab0fba2b8d04625bc2364fc01f\", \"got_dawn_revision\": \"00fcab636a055c78036ee20bb1a89339b0a28bad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"7d9afdd32c1575355cd8429484b8c97c422ed91a\", \"got_revision_cp\": \"refs/heads/master@{#841395}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"937395c1ed5d20af5a5fd999d7e2deddf1b78fe3\", \"got_v8_revision\": \"4d379d2f001373295530d8154f5bea14f1257e8d\", \"got_v8_revision_cp\": \"refs/heads/8.9.218@{#1}\", \"got_webrtc_revision\": \"cdb3bc3b93dae5237610d0e45bccd900812a0cfe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32922}\", \"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\": \"7d9afdd32c1575355cd8429484b8c97c422ed91a\", \"swarm_hashes_refs/heads/master(at){#841395}_without_patch\": {\"absl_hardening_tests\": \"b11aab489fd338eec5039b0f0561868ec69583e4\", \"accessibility_unittests\": \"8701d540fa62b2c29b3985dcdc48043d6add021e\", \"angle_unittests\": \"d74fa58833f9ded5f199e7b2b0c6ab06e800d1f0\", \"app_shell_unittests\": \"1000b5277c3cbcfab79e5656c58c785ff0932e9a\", \"aura_unittests\": \"c92828c23e6772009469e7b39a07864512c98562\", \"base_unittests\": \"d467f444ac169459134873baa2b97bb1a12bbdbd\", \"base_util_unittests\": \"8a745bc9b33fb71968fd99a09cfbc631642e1247\", \"blink_common_unittests\": \"ac777718c8cdc8f2a44e087621fcfaebaf609626\", \"blink_fuzzer_unittests\": \"7795ab7c841c10edcc02ad2e74baf002c12cf6a9\", \"blink_heap_unittests\": \"3493581ecfda311c6bc760a9d841d2b1f5f29dd1\", \"blink_platform_unittests\": \"5bf531b6649b56d01bc5bfc3d1bca893cf4c8e85\", \"blink_unittests\": \"a02495f73d1d1b0607b31de4e15562de89fe9b2e\", \"boringssl_crypto_tests\": \"e5ea2633a84299abf0b88ce4806ee95a00a938cc\", \"boringssl_ssl_tests\": \"b1c7a85dd41d3271dc059e1f66852df1e2f18eea\", \"browser_switcher_bho_unittests\": \"c51c77c6a0b091a07eb860d1f0c791d72565a76d\", \"browser_tests\": \"52d9c4d63c73a5606dd5018bb243f184db301e8a\", \"capture_unittests\": \"2bfa4b6df8c1357660bd114d77810cd8acb41a9d\", \"cast_unittests\": \"695b0ad5d85ba7e7878656a5b9278bdd5c67cc9c\", \"cc_unittests\": \"bac54ad82182daed3faa71acabbf564d368160ae\", \"chrome_app_unittests\": \"6df2303b122a260eb91fac09b36e467d3549d082\", \"chrome_cleaner_unittests\": \"3af22b78021799163414aa135fa36cd0149f2c14\", \"chrome_elf_unittests\": \"53b053144e371d33c76e03a46b50330654332018\", \"chromedriver_unittests\": \"f3c9ec65d24014c9a05cbda68ded67342b3c45ef\", \"components_browsertests\": \"264e7bed48e28c1dfefd09448264c86d1f3464cb\", \"components_unittests\": \"96c485073c2930a1ce92fedea686803001a4065b\", \"compositor_unittests\": \"43a42d6af50697b18b5def5d35162a4f3ca0ef6f\", \"content_browsertests\": \"d7907148c9581274b8badb3c0e954751971bd1c0\", \"content_unittests\": \"668a96fb77d50c5a9921dff4fa159710a552d726\", \"courgette_unittests\": \"9f12be1e84d597d8ec026823513729cc8ab18f88\", \"crashpad_tests\": \"727093d32309c8707e0d01878d6cb232173f1afe\", \"cronet_tests\": \"54bacc64097a87fb4c59726713e469e44bab3a08\", \"cronet_unittests\": \"7c1c3bfb25b96aa14f8048575f4824042ec28394\", \"crypto_unittests\": \"4db24f0aaeb20356f9ea203bed36cd90fcd3a8ac\", \"delayloads_unittests\": \"aef7a12eea5670cc558499edb9a1c16ccbdf0148\", \"device_unittests\": \"f3b03f183983d13d7e97ed46d5ed0cad0699d40a\", \"display_unittests\": \"ca165a5da85edae947c0a78b22baaac608efb7cf\", \"elevation_service_unittests\": \"855258d2033e8919c10dafbd9a355adf037b0439\", \"events_unittests\": \"766c88e84491934e216998e4281f53307c8aae5b\", \"extensions_browsertests\": \"0b9c6032c0c15ef730fa18838b22a4650dcc1361\", \"extensions_unittests\": \"cfd1934d6d75886a175e5ac03d315d3d98cac13d\", \"filesystem_service_unittests\": \"32a3539a43f48ee5431a857fddf67e58320a5861\", \"gcm_unit_tests\": \"e42470fe5d534d2dfdd640976ade2faf65dfc790\", \"gcp_unittests\": \"7869c7308d8f9aedd21859819a73b9ba574dcf6c\", \"gfx_unittests\": \"24f9386131b36820750453c63b98a2ac9c26585a\", \"gin_unittests\": \"12f5d533e8cee7d2194e1d26bd28819000dbe5df\", \"google_apis_unittests\": \"107595037c91b655509b696de4c03d23e5badabc\", \"gpu_unittests\": \"0d1340dc788bdef7f35329f232808b23aad007c5\", \"gwp_asan_unittests\": \"9657cb74b9e311147733f000be99eceaff95edd2\", \"headless_browsertests\": \"333d25f40df18809c4030815a47a9d0bba544d9f\", \"headless_unittests\": \"b1a1f6ab9eb25ba2969a5b7929dd1ad5be124ea8\", \"install_static_unittests\": \"e5c185fc122462a3b69ec7624a5cb0aba90dd78a\", \"installer_util_unittests\": \"5c085707ffb021da845ed15173c77a9a6dd3533c\", \"interactive_ui_tests\": \"6a369cca984cb44d77f204b8154c13360f03b6b1\", \"ipc_tests\": \"828f98741a6e9318bf3ca10225691dd33b6c1a5c\", \"jingle_unittests\": \"28f33fb8118b14bff6792dbb9e08ef8b73e5f471\", \"latency_unittests\": \"d813fc14d9c42e0aa6d4e6f21ca749138233f374\", \"libjingle_xmpp_unittests\": \"d6ab69fa4ae0e9919f93315489ae1a17c5db52d7\", \"liburlpattern_unittests\": \"f350f3f185dc920ca3de1f4e1debe544b39c9d5b\", \"media_blink_unittests\": \"70f8331f8c769c234b6aa69fcb3d6f8bee189e3c\", \"media_unittests\": \"4db0777bfd8d7064471be9eb3e53ab31c36fcdca\", \"message_center_unittests\": \"bbe81c5257329e0db943ddbc994573a0a448373b\", \"midi_unittests\": \"ec123cdf94aa5893bc7fe1282961a13d85c18183\", \"mojo_core_unittests\": \"ededeaab415ffff22c4fe48f91049cdcc32b7438\", \"mojo_unittests\": \"cb446710d2d53544b3a36718f8685eeaae3b1f07\", \"nacl_loader_unittests\": \"cc41279f70dd083f583cdea50660b84584fd443d\", \"native_theme_unittests\": \"41534b0fde78d85b197222862d681694f8f3ed0a\", \"net_unittests\": \"8c540393267c93a34fe71a5c92841fe1049a2078\", \"notification_helper_unittests\": \"d1e9249f5d7d012cce3ecea1f40bb9a252483ffc\", \"pdf_unittests\": \"5e64ebde5557ac3aecf4a2b0fbf50de42cc0e08d\", \"perfetto_unittests\": \"dfc08f1aee0bbcf02e7a1a3a3acd0dae0d9f5240\", \"ppapi_unittests\": \"7eaa63a59e0087c307073750c899a79b636f794a\", \"printing_unittests\": \"46b2c16c2cd738eb7454e5ea300f5371ca3b8977\", \"remoting_unittests\": \"91d9141bff4f9a5a1664f6d803e991c90e9c4ff4\", \"sbox_integration_tests\": \"7de2a5548e1ce90528bd8734e6ff6e48b747e287\", \"sbox_unittests\": \"b5c03b2cf0be033ecbe3c51e2294f53ef4516209\", \"sbox_validation_tests\": \"29ea8343b468d7b0262b59dd7bf94813f1e103d2\", \"service_manager_unittests\": \"df54f4ea410fa7aef69a202761fa8d1c01301fea\", \"services_unittests\": \"694c89cad2a420269b0487ef2fd013024de97dda\", \"setup_unittests\": \"fd4643f9ce776875bd93c83fda0d6dfbde28ca1f\", \"shell_dialogs_unittests\": \"1f3b30b26123cc16ce11a097d0975b6dab7c5c0e\", \"skia_unittests\": \"67f71d89c94ac71809f459953ecd89eba199e0e7\", \"snapshot_unittests\": \"23126ff9e86bbf510bcad388f02d4b77b60b29ef\", \"sql_unittests\": \"7f3af85404df670c1f7d0647251892cffa99a208\", \"storage_unittests\": \"781fc1a768c06b5831be0eba4068f9b2b8be35b0\", \"sync_integration_tests\": \"ea0de3fb17a853b9a492499dc03995c6abdc870d\", \"traffic_annotation_auditor_unittests\": \"97af0b4f39c4d1f7c2094ffdcb8c67309938c7ce\", \"ui_base_unittests\": \"23756ee30f67652a0f2b7c30c80200f45cfba1aa\", \"ui_touch_selection_unittests\": \"92e24b3cd150d44d889500759298c6fda9d87369\", \"unit_tests\": \"a7871bd2dd53732731febd83af46eb0d06c68944\", \"updater_tests\": \"4dbd01665151d5fa48e1388cfc829f7128b235d2\", \"url_unittests\": \"1315ed6a2b5419ccea30e491917987cda97a7b20\", \"views_unittests\": \"edf471631e370348ef5a49dc6de5a29ebe5e59da\", \"viz_unittests\": \"d34eb9770deeedce1e639f70ff1bc9a57c5fe48e\", \"vr_common_unittests\": \"e7369a19b8fc1f717dbbb9e6a4b09d77196b9efa\", \"vr_pixeltests\": \"a623724a9a4092da404f30a80ea093b9eed609ad\", \"weblayer_browsertests\": \"75284a0e3ec42f1adfa64918e23d48fae9588160\", \"weblayer_unittests\": \"9571f3323ebed5e615b2480ce5aa07e181372564\", \"wm_unittests\": \"b1d6926fd08e29a8e60a65c28f0a40691d2c726a\", \"wtf_unittests\": \"09ef0e533feb236653c9d1cea4c8d7dc640b7659\", \"zlib_unittests\": \"e86603549bb9dad69fd446d885cdbd1adf05b693\", \"zucchini_unittests\": \"b925579d04ae02cb22626a2b586c07ba0c5599ee\"}}, \"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-7-w73f\"], \"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\": [\"5657-0417a3f\"], \"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": "1610090914414614",
"status": "COMPLETED",
"status_changed_ts": "1610094006961739",
"tags": [
"build_address:luci.chromium.ci/win-asan/16689",
"builder:win-asan",
"buildset:commit/git/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d9afdd32c1575355cd8429484b8c97c422ed91a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024121091210017872",
"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/8858691029004588608/+/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:50f9b71f61007410",
"user_agent:luci-scheduler"
],
"updated_ts": "1610094006997994",
"url": "https://ci.chromium.org/b/8858691029004588608",
"utcnow_ts": "1610094009293230"
}
}
[08:20:09.314] Invocation finished in 51m39.933195911s with status SUCCEEDED