[07:24:14.102] New invocation is queued and will start shortly
[07:24:15.224] Starting the invocation (attempt 1)
[07:24:15.284] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:24:15.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:24:15.285] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028832401160016832",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4becd6bf1c0d8e7f360077f018e07e761d57e716\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028832401160016832",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"gitiles_ref:refs/heads/master"
]
}
[07:24:16.012] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605597855410947",
"id": "8863402339123796144",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4becd6bf1c0d8e7f360077f018e07e761d57e716\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605597855884812",
"tags": [
"build_address:luci.chromium.ci/win-asan/15682",
"builder:win-asan",
"buildset:commit/git/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028832401160016832",
"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/8863402339123796144/+/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": "1605597855884967",
"url": "https://ci.chromium.org/b/8863402339123796144",
"utcnow_ts": "1605597856001994"
}
}
[07:24:16.012] Task URL: https://ci.chromium.org/b/8863402339123796144
[07:24:16.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:2:0) after 1m0s
[07:24:43.910] Received PubSub notification, asking Buildbucket for the build status
[07:24:43.983] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:16.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:2:0)
[07:25:16.179] Timer tick, asking Buildbucket for the build status
[07:25:16.257] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:16.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:4:0) after 1m0s
[07:26:16.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:4:0)
[07:26:16.359] Timer tick, asking Buildbucket for the build status
[07:26:16.471] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:16.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:5:0) after 1m0s
[07:27:16.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:5:0)
[07:27:16.528] Timer tick, asking Buildbucket for the build status
[07:27:16.811] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:16.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:6:0) after 1m0s
[07:28:16.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:6:0)
[07:28:16.841] Timer tick, asking Buildbucket for the build status
[07:28:16.949] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:16.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:7:0) after 1m0s
[07:29:16.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:7:0)
[07:29:16.970] Timer tick, asking Buildbucket for the build status
[07:29:17.095] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:17.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:8:0) after 1m0s
[07:30:17.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:8:0)
[07:30:17.155] Timer tick, asking Buildbucket for the build status
[07:30:17.264] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:17.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:9:0) after 1m0s
[07:31:17.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:9:0)
[07:31:17.332] Timer tick, asking Buildbucket for the build status
[07:31:17.398] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:17.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:10:0) after 1m0s
[07:32:17.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:10:0)
[07:32:17.492] Timer tick, asking Buildbucket for the build status
[07:32:18.152] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:11:0) after 1m0s
[07:33:18.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:11:0)
[07:33:18.219] Timer tick, asking Buildbucket for the build status
[07:33:18.432] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:18.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:12:0) after 1m0s
[07:34:18.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:12:0)
[07:34:18.487] Timer tick, asking Buildbucket for the build status
[07:34:18.585] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:18.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:13:0) after 1m0s
[07:35:18.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:13:0)
[07:35:18.622] Timer tick, asking Buildbucket for the build status
[07:35:18.725] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:18.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:14:0) after 1m0s
[07:36:18.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:14:0)
[07:36:18.757] Timer tick, asking Buildbucket for the build status
[07:36:18.830] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:18.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:15:0) after 1m0s
[07:37:18.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:15:0)
[07:37:18.824] Timer tick, asking Buildbucket for the build status
[07:37:18.881] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:18.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:16:0) after 1m0s
[07:38:18.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:16:0)
[07:38:18.933] Timer tick, asking Buildbucket for the build status
[07:38:19.812] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:19.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:17:0) after 1m0s
[07:39:19.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:17:0)
[07:39:19.880] Timer tick, asking Buildbucket for the build status
[07:39:19.996] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:19.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:18:0) after 1m0s
[07:40:20.020] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:18:0)
[07:40:20.020] Timer tick, asking Buildbucket for the build status
[07:40:20.172] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:20.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:19:0) after 1m0s
[07:41:20.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:19:0)
[07:41:20.181] Timer tick, asking Buildbucket for the build status
[07:41:20.302] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:20:0) after 1m0s
[07:42:20.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:20:0)
[07:42:20.371] Timer tick, asking Buildbucket for the build status
[07:42:20.529] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:20.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:21:0) after 1m0s
[07:43:20.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:21:0)
[07:43:20.616] Timer tick, asking Buildbucket for the build status
[07:43:20.849] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:20.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:22:0) after 1m0s
[07:44:20.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:22:0)
[07:44:20.923] Timer tick, asking Buildbucket for the build status
[07:44:21.254] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:21.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:23:0) after 1m0s
[07:45:21.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:23:0)
[07:45:21.255] Timer tick, asking Buildbucket for the build status
[07:45:21.403] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:21.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:24:0) after 1m0s
[07:46:21.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:24:0)
[07:46:21.380] Timer tick, asking Buildbucket for the build status
[07:46:21.502] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:21.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:25:0) after 1m0s
[07:47:21.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:25:0)
[07:47:21.535] Timer tick, asking Buildbucket for the build status
[07:47:21.717] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:21.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:26:0) after 1m0s
[07:48:21.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:26:0)
[07:48:21.743] Timer tick, asking Buildbucket for the build status
[07:48:21.874] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:21.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:27:0) after 1m0s
[07:49:21.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:27:0)
[07:49:21.958] Timer tick, asking Buildbucket for the build status
[07:49:22.201] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:22.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:28:0) after 1m0s
[07:50:22.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:28:0)
[07:50:22.534] Timer tick, asking Buildbucket for the build status
[07:50:22.645] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:22.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:29:0) after 1m0s
[07:51:22.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:29:0)
[07:51:22.777] Timer tick, asking Buildbucket for the build status
[07:51:23.033] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:23.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:30:0) after 1m0s
[07:52:23.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:30:0)
[07:52:23.093] Timer tick, asking Buildbucket for the build status
[07:52:23.930] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:23.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:31:0) after 1m0s
[07:53:24.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:31:0)
[07:53:24.078] Timer tick, asking Buildbucket for the build status
[07:53:24.605] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:24.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:32:0) after 1m0s
[07:54:24.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:32:0)
[07:54:24.813] Timer tick, asking Buildbucket for the build status
[07:54:25.124] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:25.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:33:0) after 1m0s
[07:55:25.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:33:0)
[07:55:25.249] Timer tick, asking Buildbucket for the build status
[07:55:25.411] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:25.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:34:0) after 1m0s
[07:56:25.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:34:0)
[07:56:25.415] Timer tick, asking Buildbucket for the build status
[07:56:25.524] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:35:0) after 1m0s
[07:57:25.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:35:0)
[07:57:25.574] Timer tick, asking Buildbucket for the build status
[07:57:25.956] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:25.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:36:0) after 1m0s
[07:58:25.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:36:0)
[07:58:25.982] Timer tick, asking Buildbucket for the build status
[07:58:26.074] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:37:0) after 1m0s
[07:59:26.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:37:0)
[07:59:26.162] Timer tick, asking Buildbucket for the build status
[07:59:26.290] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:38:0) after 1m0s
[08:00:26.412] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:38:0)
[08:00:26.412] Timer tick, asking Buildbucket for the build status
[08:00:44.312] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:44.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:39:0) after 1m0s
[08:01:44.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:39:0)
[08:01:44.352] Timer tick, asking Buildbucket for the build status
[08:01:44.805] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:44.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:40:0) after 1m0s
[08:02:44.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:40:0)
[08:02:44.841] Timer tick, asking Buildbucket for the build status
[08:02:44.996] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:44.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:41:0) after 1m0s
[08:03:45.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:41:0)
[08:03:45.023] Timer tick, asking Buildbucket for the build status
[08:03:45.357] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:45.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:42:0) after 1m0s
[08:04:45.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:42:0)
[08:04:45.330] Timer tick, asking Buildbucket for the build status
[08:04:45.472] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:43:0) after 1m0s
[08:05:45.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:43:0)
[08:05:45.524] Timer tick, asking Buildbucket for the build status
[08:05:45.671] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:45.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:44:0) after 1m0s
[08:06:45.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:44:0)
[08:06:45.677] Timer tick, asking Buildbucket for the build status
[08:06:45.806] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:45.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:45:0) after 1m0s
[08:07:45.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:45:0)
[08:07:45.862] Timer tick, asking Buildbucket for the build status
[08:07:46.028] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:46.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:46:0) after 1m0s
[08:08:46.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:46:0)
[08:08:46.053] Timer tick, asking Buildbucket for the build status
[08:08:46.243] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:46.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:47:0) after 1m0s
[08:09:46.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:47:0)
[08:09:46.265] Timer tick, asking Buildbucket for the build status
[08:09:46.729] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:46.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:48:0) after 1m0s
[08:10:46.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:48:0)
[08:10:46.755] Timer tick, asking Buildbucket for the build status
[08:10:48.695] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:48.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:49:0) after 1m0s
[08:11:48.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:49:0)
[08:11:48.715] Timer tick, asking Buildbucket for the build status
[08:11:48.835] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:48.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:50:0) after 1m0s
[08:12:48.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:50:0)
[08:12:48.895] Timer tick, asking Buildbucket for the build status
[08:12:49.104] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:49.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:51:0) after 1m0s
[08:13:49.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:51:0)
[08:13:49.230] Timer tick, asking Buildbucket for the build status
[08:13:49.917] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:49.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:52:0) after 1m0s
[08:14:50.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:52:0)
[08:14:50.009] Timer tick, asking Buildbucket for the build status
[08:14:50.191] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:50.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:53:0) after 1m0s
[08:15:50.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:53:0)
[08:15:50.215] Timer tick, asking Buildbucket for the build status
[08:15:50.592] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:50.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:54:0) after 1m0s
[08:16:50.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:54:0)
[08:16:50.608] Timer tick, asking Buildbucket for the build status
[08:16:50.890] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:50.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:55:0) after 1m0s
[08:17:50.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:55:0)
[08:17:50.945] Timer tick, asking Buildbucket for the build status
[08:17:51.033] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:51.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:56:0) after 1m0s
[08:18:51.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:56:0)
[08:18:51.141] Timer tick, asking Buildbucket for the build status
[08:18:51.351] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:51.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:57:0) after 1m0s
[08:19:51.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:57:0)
[08:19:51.434] Timer tick, asking Buildbucket for the build status
[08:19:51.561] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:51.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:58:0) after 1m0s
[08:20:51.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:58:0)
[08:20:51.675] Timer tick, asking Buildbucket for the build status
[08:20:51.848] Build 8863402339123796144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:51.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028832401160016832:59:0) after 1m0s
[08:21:38.294] Received PubSub notification, asking Buildbucket for the build status
[08:21:38.406] Build 8863402339123796144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:21:38.406] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605601296309547",
"created_by": "project:chromium",
"created_ts": "1605597855410947",
"id": "8863402339123796144",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4becd6bf1c0d8e7f360077f018e07e761d57e716\"}}",
"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\": \"4becd6bf1c0d8e7f360077f018e07e761d57e716\", \"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-5-fw95\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15682, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"4f96bf19941b3842126eb047d0573a053648bbdc\", \"got_dawn_revision\": \"f2bc3b3edd6f3a8424b230b17f844f59768d53b8\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"4becd6bf1c0d8e7f360077f018e07e761d57e716\", \"got_revision_cp\": \"refs/heads/master@{#828100}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04515da400d5fbc22d852af1369c4d46bd54991e\", \"got_v8_revision\": \"15247228bbf879eab29da6c7a0b1a608fccbc1fa\", \"got_v8_revision_cp\": \"refs/heads/8.9.4@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4becd6bf1c0d8e7f360077f018e07e761d57e716\", \"swarm_hashes_refs/heads/master(at){#828100}_without_patch\": {\"absl_hardening_tests\": \"ddc021eb1ab1b8e3067c8ebe8c3e1bf29562813e\", \"accessibility_unittests\": \"423de2ed0cf2d6f6db45e34337c4eb9c967fc96e\", \"angle_unittests\": \"7dae1d5eabb966447e47379525059b6ae32af03f\", \"app_shell_unittests\": \"3e86c2697e348205886f02d934a594d368ee38cd\", \"aura_unittests\": \"7fb95e8ea990a616d14a1e50e897a2467fa91887\", \"base_unittests\": \"82254ef72f6f3c5fdc14468b4430ad029c767207\", \"base_util_unittests\": \"aa70745eca3c8119bcff18e7c1ccf659c3e8c350\", \"blink_common_unittests\": \"237800a9f740fc6b1747c3d8a1608aab8caaf0df\", \"blink_fuzzer_unittests\": \"5fbceeee6a72e2cd52ee4e8d81c7f3f079801292\", \"blink_heap_unittests\": \"e93fa493900d192b0c6d3657e83c89a1b52b2c1d\", \"blink_platform_unittests\": \"05605b58f7bb69a20557fd4034235780e0289375\", \"blink_unittests\": \"81b3685461e1cc2156cf3efffb9f6f133134c414\", \"boringssl_crypto_tests\": \"cb1231c21fc042aac5d39a7c9508e82db8502426\", \"boringssl_ssl_tests\": \"d1ab5c076b5ca433b9201f4707a1d6ad8332a046\", \"browser_switcher_bho_unittests\": \"c88d2b1814dec38b29875c732d910c7ac5275e07\", \"browser_tests\": \"492267894030d2f321598b671a620cb9d7713b9f\", \"capture_unittests\": \"a410400c3c65622f657c033147e71074868adfe6\", \"cast_unittests\": \"83a4d1fd1a1e4bfdd164502206b7bf321a141222\", \"cc_unittests\": \"2c9d9b097d7d1c0189bb228e18d29a05383d65ed\", \"chrome_app_unittests\": \"a3ab645d940d719cc15218faefc9a494dad07e66\", \"chrome_cleaner_unittests\": \"c1bbef8eedb3c6f62cae775f6ddbc76a9f65e4e0\", \"chrome_elf_unittests\": \"0f100b24b9d14ec380f3afd446b61536f83b15a0\", \"chromedriver_unittests\": \"0163089d59540b2b0cabe4b2a84d6bfbcb2d5376\", \"components_browsertests\": \"68e7b5d14054bd4929671b6b7da0671ccf860bdf\", \"components_unittests\": \"298e948bda5e9cc3074266d881c808a511f6e81a\", \"compositor_unittests\": \"d669465921bbf662d608d37f72d18ef129db97f2\", \"content_browsertests\": \"39532b157541f27a28885977d4644d16f4f8b641\", \"content_unittests\": \"aa39154fee998af7dfd80582b2b246f887d548da\", \"courgette_unittests\": \"cf7eaa40162b280097609d051a8f804754ff52c6\", \"crashpad_tests\": \"0fb4a63179b48379010a13e9eb5691ac97194ee8\", \"cronet_tests\": \"3e156de067c08ef1a3d6dea15706532cde20e934\", \"cronet_unittests\": \"0b27812c9d4bce540132aff7517978128f275070\", \"crypto_unittests\": \"ec88f2844d353fcfe055b7565b28d397d6ad3327\", \"delayloads_unittests\": \"f8f5f59f8eab5bbe440ce00648690ba6cf6b2744\", \"device_unittests\": \"2a00a85eb8dd1820a36a9e1f6413cc505f1e95c3\", \"display_unittests\": \"c07655bfc079fca3147d11594922ae9389a61250\", \"elevation_service_unittests\": \"b7b0055b1285acfb1c718cdb5c4379d0e32a4560\", \"events_unittests\": \"be3f5530cd45b88802fe8d69583d476b421498e5\", \"extensions_browsertests\": \"88e6497b7f956df90fd935df54d2a25de1b3230b\", \"extensions_unittests\": \"a58b188ef2d2861baabc81b416e054fabd1f4710\", \"filesystem_service_unittests\": \"48431ce3bedcd73c5664ab5eda3362e26f533106\", \"gcm_unit_tests\": \"1bb49f077103a366e24aa06b6d9de9df4eaec44c\", \"gcp_unittests\": \"7d2c185b0ea4d760caaa5bb855b7c4172713f2fa\", \"gfx_unittests\": \"29bbb433061b2e428e2725360dfb4b93e8094d96\", \"gin_unittests\": \"765759000350342434ed40a632f6cbe6a5d6480a\", \"google_apis_unittests\": \"097830ea7d7736c8f4d02a08e736a7020f3ac558\", \"gpu_unittests\": \"6b6c0fe0ed6966791ad8775efd7ebe58fcc09dc0\", \"gwp_asan_unittests\": \"52455896c29fddadcc8accfcf15e6f23db27a02f\", \"headless_browsertests\": \"63d576bd9ce699f6a53edba5892502803ab287da\", \"headless_unittests\": \"c23775a6b997212a5b95a70bb3ca55cd9795ebb9\", \"install_static_unittests\": \"81626381b5c1fba89af148b687cd834c489edbde\", \"installer_util_unittests\": \"b0497e8eaf1e66b218ed365c8a8d0e0969f6a3db\", \"interactive_ui_tests\": \"4f72cfae9c84ecb0acb29e7d4bbdf64e534e077b\", \"ipc_tests\": \"a80da608093c1df9f7d7bd1baf06e9973208cdee\", \"jingle_unittests\": \"6e4293a90dcee40b0bdec70a7951c71d8cf7c812\", \"latency_unittests\": \"be17a77a0c5b64f9fed0fc11cb66985ff0475753\", \"libjingle_xmpp_unittests\": \"c26a5e5f7dc0f8e69f7ec734fa09a7467a8d2e4e\", \"liburlpattern_unittests\": \"c72629253b60c04695568931828eaf4a2005d79a\", \"media_blink_unittests\": \"19173c2cd0de882f364397e63567bae077530c4e\", \"media_unittests\": \"fdffa05e3d022b825804b7497c92965cfcb16993\", \"message_center_unittests\": \"092d5d54ce424c849274a6edde6d56f8823c3904\", \"midi_unittests\": \"2d746801604adc7734ce36f7b52f41b450e3d602\", \"mojo_core_unittests\": \"328ecf62eab7cc5e3f832d48f8bfe3b39aa915c5\", \"mojo_unittests\": \"74449051e0e5792c3f820091e1523f65263aabe2\", \"nacl_loader_unittests\": \"0da8b2276194b843b966c8a4322d8c9c18294b3c\", \"native_theme_unittests\": \"5c96a85719736147c1dd632ff5fb9d5429610b3e\", \"net_unittests\": \"158f23640b657c16a980a5986ff2b27ef3adbfac\", \"notification_helper_unittests\": \"65074abb77712b25de55cea3f4d52cd7bb17a7de\", \"pdf_unittests\": \"a0f22fc267af1604e14c6e33c0206513c4b83792\", \"perfetto_unittests\": \"7657d2971dee3e208ce8b1c783572393c9ca0866\", \"ppapi_unittests\": \"91a0b3918f8eea17f0fb58b24c8ded303820ae6a\", \"printing_unittests\": \"ff226c2ab7d5e0a68c90c1c4e39ef523341bfe5c\", \"remoting_unittests\": \"5365396494ea068e44393622f3ee35183c3700f7\", \"sbox_integration_tests\": \"23993c0e8fe76eccf55514ad872d98dff3f45bf0\", \"sbox_unittests\": \"c750b8282e179d8d668216f1892c3226076f488b\", \"sbox_validation_tests\": \"811b84f51d8ddd102d5065762791eea2306fb26f\", \"service_manager_unittests\": \"1a2bf5542bc8617aaafc07bd487026914751b771\", \"services_unittests\": \"a402a261faad69bd2e34d18018f6aee66e12ea89\", \"setup_unittests\": \"c7dfbd7c92e3c39beb4461e6d6ad4c90b6a7ebe5\", \"shell_dialogs_unittests\": \"988c2bb9154422f5ea1b84fb060d24b3eb98538f\", \"skia_unittests\": \"01c89cb6e7496c9382bbfe532ef33556634f61bb\", \"snapshot_unittests\": \"4b79f3f1223f0f93e96ac259b4d8e4d7923184b4\", \"sql_unittests\": \"b5a5acec4d109e4b08bd1e9ad3cf7fe70414909d\", \"storage_unittests\": \"1daca501343d1df52a84f1897aa317f358f0644d\", \"sync_integration_tests\": \"f8d39a6fd3590027b03700543729f181d055c972\", \"traffic_annotation_auditor_unittests\": \"5237f5a0e75e810a5a62058c3c8892ef192840e7\", \"ui_base_unittests\": \"d53d8efa08cef66e58984e7308f516cd2b916b0e\", \"ui_touch_selection_unittests\": \"4a6945902d2b8af571fd61513a5850817509a4a8\", \"unit_tests\": \"4716a0b2cb85341400864b8ec7aa3bc5745d50dc\", \"updater_tests\": \"af46506d261bca7c5ea81a2af4fdea3b36b7fdcb\", \"url_unittests\": \"fdff5f552723b6b9e6a908c1205a71003ae8cfcd\", \"views_unittests\": \"08aa27743e362bb2628c6d54d2d66229ef2e1de4\", \"viz_unittests\": \"5b12edef2ef7ebbed020a034369269323f511c59\", \"vr_common_unittests\": \"6cd6bed30644ea28bd616feec4e5aa7fdfb5e39f\", \"vr_pixeltests\": \"68e80f401ac11e3559ad58bd39e40328b2568c31\", \"weblayer_browsertests\": \"bd274691043b4d7c7af17dca6d1e71ad5f3c2314\", \"weblayer_unittests\": \"24387bd901b3fcbdf31ef85d948d0f2435e29b60\", \"wm_unittests\": \"3b08b77378f19f419edba2a1674345db0ef7cc63\", \"wtf_unittests\": \"50590556dc2cbfbe87cdef38b0c2ead5c792fbcc\", \"zlib_unittests\": \"72a9931ec3faf8c41ea04632440b8c15c6d55d60\", \"zucchini_unittests\": \"1603099186c59fa35551d77ac292e18d1659fe0b\"}}, \"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-5-fw95\"], \"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\": [\"5632-2e614e1\"], \"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": "1605597867478149",
"status": "COMPLETED",
"status_changed_ts": "1605601296724093",
"tags": [
"build_address:luci.chromium.ci/win-asan/15682",
"builder:win-asan",
"buildset:commit/git/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4becd6bf1c0d8e7f360077f018e07e761d57e716",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028832401160016832",
"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/8863402339123796144/+/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:4fede8a0098c8010",
"user_agent:luci-scheduler"
],
"updated_ts": "1605601296747450",
"url": "https://ci.chromium.org/b/8863402339123796144",
"utcnow_ts": "1605601298389308"
}
}
[08:21:38.406] Invocation finished in 57m24.320274167s with status SUCCEEDED