[05:01:28.896] New invocation is queued and will start shortly
[05:01:29.974] Starting the invocation (attempt 1)
[05:01:30.039] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:01:30.039] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:01:30.039] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019147507022606576",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019147507022606576",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"gitiles_ref:refs/heads/master"
]
}
[05:01:30.784] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614834090177082",
"id": "8853717445016909680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614834090671518",
"tags": [
"build_address:luci.chromium.ci/win-asan/17623",
"builder:win-asan",
"buildset:commit/git/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019147507022606576",
"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/8853717445016909680/+/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": "1614834090671625",
"url": "https://ci.chromium.org/b/8853717445016909680",
"utcnow_ts": "1614834090776894"
}
}
[05:01:30.784] Task URL: https://ci.chromium.org/b/8853717445016909680
[05:01:30.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:2:0) after 1m0s
[05:01:35.476] Received PubSub notification, asking Buildbucket for the build status
[05:01:35.607] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:30.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:2:0)
[05:02:30.808] Timer tick, asking Buildbucket for the build status
[05:02:30.880] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:30.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:4:0) after 1m0s
[05:03:30.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:4:0)
[05:03:30.942] Timer tick, asking Buildbucket for the build status
[05:03:31.010] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:31.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:5:0) after 1m0s
[05:04:31.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:5:0)
[05:04:31.046] Timer tick, asking Buildbucket for the build status
[05:04:31.126] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:6:0) after 1m0s
[05:05:31.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:6:0)
[05:05:31.211] Timer tick, asking Buildbucket for the build status
[05:05:31.281] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:31.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:7:0) after 1m0s
[05:06:31.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:7:0)
[05:06:31.360] Timer tick, asking Buildbucket for the build status
[05:06:31.436] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:31.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:8:0) after 1m0s
[05:07:31.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:8:0)
[05:07:31.473] Timer tick, asking Buildbucket for the build status
[05:07:31.547] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:9:0) after 1m0s
[05:08:31.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:9:0)
[05:08:31.626] Timer tick, asking Buildbucket for the build status
[05:08:31.753] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:31.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:10:0) after 1m0s
[05:09:31.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:10:0)
[05:09:31.844] Timer tick, asking Buildbucket for the build status
[05:09:31.905] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:11:0) after 1m0s
[05:10:32.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:11:0)
[05:10:32.002] Timer tick, asking Buildbucket for the build status
[05:10:32.079] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:32.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:12:0) after 1m0s
[05:11:32.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:12:0)
[05:11:32.191] Timer tick, asking Buildbucket for the build status
[05:11:32.269] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:32.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:13:0) after 1m0s
[05:12:32.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:13:0)
[05:12:32.891] Timer tick, asking Buildbucket for the build status
[05:12:32.999] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:32.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:14:0) after 1m0s
[05:13:33.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:14:0)
[05:13:33.443] Timer tick, asking Buildbucket for the build status
[05:13:33.521] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:33.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:15:0) after 1m0s
[05:14:33.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:15:0)
[05:14:33.535] Timer tick, asking Buildbucket for the build status
[05:14:33.625] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:33.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:16:0) after 1m0s
[05:15:33.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:16:0)
[05:15:33.687] Timer tick, asking Buildbucket for the build status
[05:15:33.767] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:33.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:17:0) after 1m0s
[05:16:33.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:17:0)
[05:16:33.922] Timer tick, asking Buildbucket for the build status
[05:16:34.099] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:34.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:18:0) after 1m0s
[05:17:34.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:18:0)
[05:17:34.242] Timer tick, asking Buildbucket for the build status
[05:17:34.366] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:34.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:19:0) after 1m0s
[05:18:34.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:19:0)
[05:18:34.872] Timer tick, asking Buildbucket for the build status
[05:18:34.959] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:34.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:20:0) after 1m0s
[05:19:35.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:20:0)
[05:19:35.120] Timer tick, asking Buildbucket for the build status
[05:19:35.198] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:35.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:21:0) after 1m0s
[05:20:35.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:21:0)
[05:20:35.331] Timer tick, asking Buildbucket for the build status
[05:20:35.410] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:35.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:22:0) after 1m0s
[05:21:35.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:22:0)
[05:21:35.503] Timer tick, asking Buildbucket for the build status
[05:21:35.835] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:35.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:23:0) after 1m0s
[05:22:36.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:23:0)
[05:22:36.014] Timer tick, asking Buildbucket for the build status
[05:22:36.096] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:36.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:24:0) after 1m0s
[05:23:36.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:24:0)
[05:23:36.118] Timer tick, asking Buildbucket for the build status
[05:23:36.199] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:36.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:25:0) after 1m0s
[05:24:36.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:25:0)
[05:24:36.396] Timer tick, asking Buildbucket for the build status
[05:24:36.549] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:36.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:26:0) after 1m0s
[05:25:36.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:26:0)
[05:25:36.564] Timer tick, asking Buildbucket for the build status
[05:25:36.661] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:36.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:27:0) after 1m0s
[05:26:36.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:27:0)
[05:26:36.796] Timer tick, asking Buildbucket for the build status
[05:26:37.023] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:37.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:28:0) after 1m0s
[05:27:37.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:28:0)
[05:27:37.048] Timer tick, asking Buildbucket for the build status
[05:27:37.120] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:37.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:29:0) after 1m0s
[05:28:37.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:29:0)
[05:28:37.167] Timer tick, asking Buildbucket for the build status
[05:28:37.278] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:37.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:30:0) after 1m0s
[05:29:37.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:30:0)
[05:29:37.416] Timer tick, asking Buildbucket for the build status
[05:29:37.495] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:37.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:31:0) after 1m0s
[05:30:37.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:31:0)
[05:30:37.695] Timer tick, asking Buildbucket for the build status
[05:30:37.784] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:37.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:32:0) after 1m0s
[05:31:37.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:32:0)
[05:31:37.854] Timer tick, asking Buildbucket for the build status
[05:31:37.982] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:37.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:33:0) after 1m0s
[05:32:37.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:33:0)
[05:32:37.993] Timer tick, asking Buildbucket for the build status
[05:32:38.083] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:38.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:34:0) after 1m0s
[05:33:38.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:34:0)
[05:33:38.143] Timer tick, asking Buildbucket for the build status
[05:33:38.239] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:38.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:35:0) after 1m0s
[05:34:38.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:35:0)
[05:34:38.421] Timer tick, asking Buildbucket for the build status
[05:34:38.501] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:36:0) after 1m0s
[05:35:38.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:36:0)
[05:35:38.593] Timer tick, asking Buildbucket for the build status
[05:35:38.670] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:38.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:37:0) after 1m0s
[05:36:38.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:37:0)
[05:36:38.725] Timer tick, asking Buildbucket for the build status
[05:36:38.884] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:38:0) after 1m0s
[05:37:38.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:38:0)
[05:37:38.916] Timer tick, asking Buildbucket for the build status
[05:37:39.323] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:39.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:39:0) after 1m0s
[05:38:39.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:39:0)
[05:38:39.461] Timer tick, asking Buildbucket for the build status
[05:38:39.532] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:39.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:40:0) after 1m0s
[05:39:39.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:40:0)
[05:39:39.655] Timer tick, asking Buildbucket for the build status
[05:39:39.750] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:39.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:41:0) after 1m0s
[05:40:39.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:41:0)
[05:40:39.771] Timer tick, asking Buildbucket for the build status
[05:40:39.929] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:39.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:42:0) after 1m0s
[05:41:39.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:42:0)
[05:41:39.924] Timer tick, asking Buildbucket for the build status
[05:41:40.043] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:40.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:43:0) after 1m0s
[05:42:40.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:43:0)
[05:42:40.102] Timer tick, asking Buildbucket for the build status
[05:42:40.180] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:40.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:44:0) after 1m0s
[05:43:40.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:44:0)
[05:43:40.281] Timer tick, asking Buildbucket for the build status
[05:43:40.425] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:40.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:45:0) after 1m0s
[05:44:40.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:45:0)
[05:44:40.445] Timer tick, asking Buildbucket for the build status
[05:44:42.986] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:42.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:46:0) after 1m0s
[05:45:43.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:46:0)
[05:45:43.033] Timer tick, asking Buildbucket for the build status
[05:45:43.899] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:43.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:47:0) after 1m0s
[05:46:43.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:47:0)
[05:46:43.990] Timer tick, asking Buildbucket for the build status
[05:46:44.453] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:44.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:48:0) after 1m0s
[05:47:44.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:48:0)
[05:47:44.571] Timer tick, asking Buildbucket for the build status
[05:47:44.653] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:44.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:49:0) after 1m0s
[05:48:44.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:49:0)
[05:48:44.700] Timer tick, asking Buildbucket for the build status
[05:48:44.783] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:44.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:50:0) after 1m0s
[05:49:44.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:50:0)
[05:49:44.882] Timer tick, asking Buildbucket for the build status
[05:49:44.955] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:44.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:51:0) after 1m0s
[05:50:45.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:51:0)
[05:50:45.003] Timer tick, asking Buildbucket for the build status
[05:50:45.921] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:45.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:52:0) after 1m0s
[05:51:46.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:52:0)
[05:51:46.157] Timer tick, asking Buildbucket for the build status
[05:51:46.252] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:46.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:53:0) after 1m0s
[05:52:46.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:53:0)
[05:52:46.320] Timer tick, asking Buildbucket for the build status
[05:52:46.414] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:46.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:54:0) after 1m0s
[05:53:46.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:54:0)
[05:53:46.536] Timer tick, asking Buildbucket for the build status
[05:53:46.665] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:46.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:55:0) after 1m0s
[05:54:47.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:55:0)
[05:54:47.753] Timer tick, asking Buildbucket for the build status
[05:54:47.977] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:47.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:56:0) after 1m0s
[05:55:48.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:56:0)
[05:55:48.234] Timer tick, asking Buildbucket for the build status
[05:55:48.320] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:48.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:57:0) after 1m0s
[05:56:48.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:57:0)
[05:56:48.739] Timer tick, asking Buildbucket for the build status
[05:56:48.878] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:48.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:58:0) after 1m0s
[05:57:48.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:58:0)
[05:57:48.916] Timer tick, asking Buildbucket for the build status
[05:57:48.994] Build 8853717445016909680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:48.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019147507022606576:59:0) after 1m0s
[05:58:29.066] Received PubSub notification, asking Buildbucket for the build status
[05:58:30.260] Build 8853717445016909680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:58:30.260] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614837507517045",
"created_by": "project:chromium",
"created_ts": "1614834090177082",
"id": "8853717445016909680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\"}}",
"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\": \"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\", \"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-10-v3tg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17623, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"90db604919ba6e3a5ffbdd43845ac33f91e7ddfa\", \"got_dawn_revision\": \"c36a9e8579a17d1afb730a3de6af12fb0a3c210d\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\", \"got_revision_cp\": \"refs/heads/master@{#859647}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"1bf9a25b8165c205ba4ed305e8e84bc4a8e54fbc\", \"got_v8_revision_cp\": \"refs/heads/9.1.31@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"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\": \"6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa\", \"swarm_hashes_refs/heads/master(at){#859647}_without_patch\": {\"absl_hardening_tests\": \"961c9af9fd1ecba55a7561bfc8f124b83d8427f7\", \"accessibility_unittests\": \"465ad1c5b98a0ab2a8d82cd8dc351a2d4050e38c\", \"angle_unittests\": \"e46a5f50e57af47c5766df078065fa885c105826\", \"app_shell_unittests\": \"dc9efff0f798a8fc709ede0c26db7e52039ffb38\", \"aura_unittests\": \"4cc969b6604e31b9fc715d487478e0f6253d42a5\", \"base_unittests\": \"febeeebedb634e120a5cbd73e10890f689acce99\", \"base_util_unittests\": \"1c581cbfe0339090d93bf39d37c873c92a41e0f8\", \"blink_common_unittests\": \"b9bdb13e5681a8698f1ce51a17d33d6c808d4047\", \"blink_fuzzer_unittests\": \"cf0a5ed087b212237830ca64b82823e3a4ca4f17\", \"blink_heap_unittests\": \"21d9c22ba08ad55e0a17f5b453a2c7b878b06f12\", \"blink_platform_unittests\": \"f713baaeaa401fec708ba0a3c4fd4f34a2d5f6ee\", \"blink_unittests\": \"37e8ad8a2632e2a955175cee54c8aa0472d6f042\", \"boringssl_crypto_tests\": \"9535147e31a73a79acb3e43255295796325217d2\", \"boringssl_ssl_tests\": \"b879fc9b72743df1b506968654c59fbd5d0f06f2\", \"browser_switcher_bho_unittests\": \"622d740876f0a88de1f06f7f1b45beee03626c0f\", \"browser_tests\": \"3122e1732e0a32ab7092f6e48a67c073e2eb21e5\", \"capture_unittests\": \"60b70a56a313720cc5853b912cd81e1df5d16b67\", \"cast_unittests\": \"6004de13e7bf201ea43d2afa53560e0f72ea2107\", \"cc_unittests\": \"f28fc4ad18cab0109cbf01600edd3ff287cf5f22\", \"chrome_app_unittests\": \"3fc2391ae44c12c8adedfe87ade2053d698b3da1\", \"chrome_cleaner_unittests\": \"2010582c565b830580ef17dce14e035fd28166fb\", \"chrome_elf_unittests\": \"f2a19364d77f75cf45778123f5598032857b89f4\", \"chromedriver_unittests\": \"41a5cf52b8e052e9488df2caa6432cbef2dedf8c\", \"color_unittests\": \"dffc67b4fa206304c53e16dd9afa90c953d2c5ff\", \"components_browsertests\": \"3501aa77592453eb3fd50a35c95a35f26c77f941\", \"components_unittests\": \"32f7a9101906dfab33b3bb26a09c0eac40aedfaf\", \"compositor_unittests\": \"9146aaeb23a8fff374f36e88b39c9054a4057d0f\", \"content_browsertests\": \"010f5eab59ec3478ed3e64a915f22b9fa1ad6639\", \"content_unittests\": \"4d41bbfa5e265bc94c756f54231064ad4b9ce64d\", \"courgette_unittests\": \"20f0482fa3e86724e79dac3ee805011d6dbfd307\", \"crashpad_tests\": \"1e9fffcf71839fc4037ad325d71826dbd71a1c40\", \"cronet_tests\": \"d759e9463ea3a909b4c6992d7dc59309857bdfea\", \"cronet_unittests\": \"04d93311bdfcf57e98a8d81c6e9bfbfd4624a74d\", \"crypto_unittests\": \"d0f0d367217c8b13f8b2e31d83330f0fa10ebbf7\", \"delayloads_unittests\": \"4b1c50f90c871e5ef70f436deff4af6e693999d0\", \"device_unittests\": \"45173bd991d6a9eefe937d12d03f11c980f52d7c\", \"display_unittests\": \"d68a1fbabadf0b28e38dc691c34d8a001e105286\", \"elevation_service_unittests\": \"517a7d1a152d9d2eaaf6b250c13e9c3c6d26ce0c\", \"events_unittests\": \"100a4f9e61443a492989df2dde40c7fccb82390a\", \"extensions_browsertests\": \"4efdf24323f3fb414b1f72e1942edae4b6b96f1a\", \"extensions_unittests\": \"8527ee3bd9f40a55ab565259fe821cc8470be0aa\", \"filesystem_service_unittests\": \"d8430245029b8f3e15bad8f24be25c4be39249d9\", \"gcm_unit_tests\": \"ec1d5e70728470e588d6348a1d4d3d0a757c9702\", \"gcp_unittests\": \"bbc9abea4cacf2bb63c3caac1949523560f5fce8\", \"gfx_unittests\": \"ac67c8ec5f67648da03993cfe18dba8812511a85\", \"gin_unittests\": \"531966c37c15b83f0a52d4f6aa536e7e2bf9bc09\", \"google_apis_unittests\": \"9bea8b4cee8aa1336344bca33e581e2f2c6c4e01\", \"gpu_unittests\": \"c6a49fe54269e7b401b955608e4780af24d82162\", \"gwp_asan_unittests\": \"f648cc28d99a030b65023410c193799cf56a00ea\", \"headless_browsertests\": \"d7053c943123a8f2f1a075788ed44565c2e3f52b\", \"headless_unittests\": \"ffab9751809c70d0323899b463f52060e3696548\", \"install_static_unittests\": \"e5f8ba7e35aced3eab36f11cfe98ac54ca749862\", \"installer_util_unittests\": \"1fa0ca97b6c143ebde9f9b04a36c6a2d21c784f0\", \"interactive_ui_tests\": \"5b3402fc50c67a2eeeb1e4dce1de0bd07a942035\", \"ipc_tests\": \"a59de04c8e45733c2ac43a8717d76d516c1073bb\", \"jingle_unittests\": \"3284e112ea80942c43cc2367aefc7fa96ef1a0e4\", \"latency_unittests\": \"a2f8e977326edaa4f628777cb95fbddc7e388264\", \"libjingle_xmpp_unittests\": \"102f89a2e49ff2d7c24d73281dc06359129cda76\", \"liburlpattern_unittests\": \"ba5ac6a3eb9908364fb2126a0df8ddd916bcc006\", \"media_blink_unittests\": \"82b5c82dea1cf0eca5b09ebe11649277630a7e9b\", \"media_unittests\": \"72902b1e76cb9f2c63588655f54cb5eb59fa9675\", \"message_center_unittests\": \"4b18a0fa49d95946798b9f8cded080a51b3a7e2e\", \"midi_unittests\": \"e53fdae7052b6e9d66d41f091b258126a140c3f0\", \"mojo_core_unittests\": \"de4fe7baba302157469286bd7a9da00dff2fb33e\", \"mojo_unittests\": \"98666a138f12d171f8bd24b6b4082c70c261d64a\", \"nacl_loader_unittests\": \"c95a800b2ac9273daf7dd154804b5515012b1e0a\", \"native_theme_unittests\": \"81985cac99ff048b3edc7c4778e70d0c8986f6ae\", \"net_unittests\": \"8b2048a1eb0379d82a374a8bef15029302a053f9\", \"notification_helper_unittests\": \"06c6197f616e2ceb50755e79d7709fce54e73b95\", \"pdf_unittests\": \"91329734a87f0bf7861f5fb9d8bd46af6a183f3b\", \"perfetto_unittests\": \"116f99211f087e58540dc5cbf16b3036a08d6fd8\", \"ppapi_unittests\": \"c0406a9c785d33a52520198bb0aad7ffb0b5d2bc\", \"printing_unittests\": \"a2d69a8cc35b5bc0246f0b0601f78056bcb08aaf\", \"remoting_unittests\": \"adefce36d4a6946914724e5da440e9cb33ca09f1\", \"sbox_integration_tests\": \"bb83e7441fe9ed9162a465e5e9818204fa36e72f\", \"sbox_unittests\": \"766344f697fbeb47c24373379604d303d2ff1eba\", \"sbox_validation_tests\": \"4dac19fc49e37863e6862a480194be5288960088\", \"service_manager_unittests\": \"9b00d420b422c3ac87f6e356a3fa94fcf78a236a\", \"services_unittests\": \"0c20fbaaf574689eed87701a4b57643e9eb45cf9\", \"setup_unittests\": \"423e67a82d674212207aabad42c4710c1fefa099\", \"shell_dialogs_unittests\": \"2be7bc2b48cc038b72611baa1834886abff707b1\", \"skia_unittests\": \"b81bb9bb8de4cd5ba21857453a6b55f8671c2824\", \"snapshot_unittests\": \"fe01b8e805ec2adceccd7f59f96d042888a6bcc1\", \"sql_unittests\": \"bda96d74a577ebabfda3cde7d9058b97298d3142\", \"storage_unittests\": \"db9f06f7f9d5a2c245b8cd95825730d69a848bce\", \"sync_integration_tests\": \"d769f8d305a6f61ce1e69a28980715b8844eaed1\", \"traffic_annotation_auditor_unittests\": \"da52a034e09278b3e0d591ba4b01bd05b3a46929\", \"ui_base_unittests\": \"e7811e6c21807f85e6ae2426a99651af4218ce58\", \"ui_touch_selection_unittests\": \"f961b051426ce373a4d22ae177f54fd6e712b3d8\", \"unit_tests\": \"943b7298da6d521be01bd33df874b5128c3bc4e8\", \"updater_tests\": \"bd29ff1063a7bfd2186ada83702fc5f9c24e44c7\", \"url_unittests\": \"f7c9b2f4101fb6749c4d8b502ae0b6622c2d3dc2\", \"views_unittests\": \"9426b83b79b3e1a6892ec3ff4d22ff92699ac1e8\", \"viz_unittests\": \"425c059646bac120481904cf4d4999e7aa9afd4c\", \"vr_common_unittests\": \"75831319aaa5831a763d6f68fe442da2f479c398\", \"vr_pixeltests\": \"aea25d7991bcb0ba9da7df4d313ad70c16d9cb38\", \"weblayer_browsertests\": \"52b3ea9b73702a2ff94dde7d41febf2595ed265d\", \"weblayer_unittests\": \"52582db58d1c0a72509107a64576ece0fe27d0b6\", \"wm_unittests\": \"85bfd3623da18524ee02db4cff6e7cf543698b63\", \"wtf_unittests\": \"26950d6f784283eb539fd934ec5b85d41bf66441\", \"zlib_unittests\": \"375ea136e26e5679ac9c66df84971a06ef5f2eca\", \"zucchini_unittests\": \"a82f214c932efb0d4c77d3f87964c68eb0508bb5\"}}, \"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-10-v3tg\"], \"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\": [\"5725-1a0d85e\"], \"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": "1614834094615375",
"status": "COMPLETED",
"status_changed_ts": "1614837507775567",
"tags": [
"build_address:luci.chromium.ci/win-asan/17623",
"builder:win-asan",
"buildset:commit/git/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6db1b2f9c4b6b0aaf3f08755badd644e6c78fafa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019147507022606576",
"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/8853717445016909680/+/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:52146e4bac036210",
"user_agent:luci-scheduler"
],
"updated_ts": "1614837507779636",
"url": "https://ci.chromium.org/b/8853717445016909680",
"utcnow_ts": "1614837510251293"
}
}
[05:58:30.260] Invocation finished in 57m1.378694835s with status SUCCEEDED