[12:20:30.570] New invocation is queued and will start shortly
[12:20:31.671] Starting the invocation (attempt 1)
[12:20:31.704] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:20:31.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:20:31.704] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020207049370629472",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a7f523e49db223f13bce070d5271e85050fe527e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020207049370629472",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/a7f523e49db223f13bce070d5271e85050fe527e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7f523e49db223f13bce070d5271e85050fe527e",
"gitiles_ref:refs/heads/master"
]
}
[12:20:32.558] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613823631801530",
"id": "8854776987419254784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a7f523e49db223f13bce070d5271e85050fe527e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613823632255636",
"tags": [
"build_address:luci.chromium.ci/win-asan/17441",
"builder:win-asan",
"buildset:commit/git/a7f523e49db223f13bce070d5271e85050fe527e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7f523e49db223f13bce070d5271e85050fe527e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020207049370629472",
"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/8854776987419254784/+/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": "1613823632255760",
"url": "https://ci.chromium.org/b/8854776987419254784",
"utcnow_ts": "1613823632545008"
}
}
[12:20:32.558] Task URL: https://ci.chromium.org/b/8854776987419254784
[12:20:32.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:2:0) after 1m0s
[12:20:43.482] Received PubSub notification, asking Buildbucket for the build status
[12:20:43.909] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:32.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:2:0)
[12:21:32.563] Timer tick, asking Buildbucket for the build status
[12:21:32.626] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:32.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:4:0) after 1m0s
[12:22:32.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:4:0)
[12:22:32.642] Timer tick, asking Buildbucket for the build status
[12:22:32.716] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:32.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:5:0) after 1m0s
[12:23:32.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:5:0)
[12:23:32.734] Timer tick, asking Buildbucket for the build status
[12:23:33.008] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:33.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:6:0) after 1m0s
[12:24:33.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:6:0)
[12:24:33.034] Timer tick, asking Buildbucket for the build status
[12:24:33.133] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:33.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:7:0) after 1m0s
[12:25:33.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:7:0)
[12:25:33.171] Timer tick, asking Buildbucket for the build status
[12:25:33.261] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:33.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:8:0) after 1m0s
[12:26:33.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:8:0)
[12:26:33.286] Timer tick, asking Buildbucket for the build status
[12:26:33.684] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:9:0) after 1m0s
[12:27:33.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:9:0)
[12:27:33.722] Timer tick, asking Buildbucket for the build status
[12:27:34.032] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:34.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:10:0) after 1m0s
[12:28:34.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:10:0)
[12:28:34.062] Timer tick, asking Buildbucket for the build status
[12:28:34.122] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:11:0) after 1m0s
[12:29:34.160] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:11:0)
[12:29:34.160] Timer tick, asking Buildbucket for the build status
[12:29:34.334] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:34.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:12:0) after 1m0s
[12:30:34.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:12:0)
[12:30:34.425] Timer tick, asking Buildbucket for the build status
[12:30:34.809] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:34.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:13:0) after 1m0s
[12:31:34.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:13:0)
[12:31:34.808] Timer tick, asking Buildbucket for the build status
[12:31:34.903] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:14:0) after 1m0s
[12:32:34.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:14:0)
[12:32:34.920] Timer tick, asking Buildbucket for the build status
[12:32:34.980] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:34.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:15:0) after 1m0s
[12:33:35.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:15:0)
[12:33:35.033] Timer tick, asking Buildbucket for the build status
[12:33:35.201] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:35.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:16:0) after 1m0s
[12:34:35.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:16:0)
[12:34:35.211] Timer tick, asking Buildbucket for the build status
[12:34:35.297] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:35.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:17:0) after 1m0s
[12:35:35.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:17:0)
[12:35:35.353] Timer tick, asking Buildbucket for the build status
[12:35:35.448] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:35.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:18:0) after 1m0s
[12:36:35.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:18:0)
[12:36:35.482] Timer tick, asking Buildbucket for the build status
[12:36:35.643] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:19:0) after 1m0s
[12:37:35.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:19:0)
[12:37:35.631] Timer tick, asking Buildbucket for the build status
[12:37:35.741] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:20:0) after 1m0s
[12:38:35.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:20:0)
[12:38:35.761] Timer tick, asking Buildbucket for the build status
[12:38:35.846] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:35.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:21:0) after 1m0s
[12:39:35.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:21:0)
[12:39:35.897] Timer tick, asking Buildbucket for the build status
[12:39:35.983] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:35.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:22:0) after 1m0s
[12:40:36.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:22:0)
[12:40:36.004] Timer tick, asking Buildbucket for the build status
[12:40:36.215] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:36.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:23:0) after 1m0s
[12:41:36.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:23:0)
[12:41:36.205] Timer tick, asking Buildbucket for the build status
[12:41:36.295] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:24:0) after 1m0s
[12:42:36.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:24:0)
[12:42:36.314] Timer tick, asking Buildbucket for the build status
[12:42:36.418] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:36.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:25:0) after 1m0s
[12:43:36.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:25:0)
[12:43:36.471] Timer tick, asking Buildbucket for the build status
[12:43:36.552] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:36.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:26:0) after 1m0s
[12:44:36.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:26:0)
[12:44:36.525] Timer tick, asking Buildbucket for the build status
[12:44:36.600] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:36.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:27:0) after 1m0s
[12:45:36.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:27:0)
[12:45:36.585] Timer tick, asking Buildbucket for the build status
[12:45:36.708] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:36.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:28:0) after 1m0s
[12:46:36.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:28:0)
[12:46:36.730] Timer tick, asking Buildbucket for the build status
[12:46:37.025] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:29:0) after 1m0s
[12:47:37.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:29:0)
[12:47:37.082] Timer tick, asking Buildbucket for the build status
[12:47:37.208] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:30:0) after 1m0s
[12:48:37.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:30:0)
[12:48:37.269] Timer tick, asking Buildbucket for the build status
[12:48:37.365] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:37.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:31:0) after 1m0s
[12:49:37.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:31:0)
[12:49:37.384] Timer tick, asking Buildbucket for the build status
[12:49:37.469] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:37.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:32:0) after 1m0s
[12:50:37.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:32:0)
[12:50:37.492] Timer tick, asking Buildbucket for the build status
[12:50:37.565] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:37.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:33:0) after 1m0s
[12:51:37.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:33:0)
[12:51:37.566] Timer tick, asking Buildbucket for the build status
[12:51:37.725] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:37.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:34:0) after 1m0s
[12:52:37.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:34:0)
[12:52:37.743] Timer tick, asking Buildbucket for the build status
[12:52:37.853] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:37.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:35:0) after 1m0s
[12:53:37.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:35:0)
[12:53:37.877] Timer tick, asking Buildbucket for the build status
[12:53:37.956] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:37.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:36:0) after 1m0s
[12:54:37.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:36:0)
[12:54:37.975] Timer tick, asking Buildbucket for the build status
[12:54:38.155] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:38.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:37:0) after 1m0s
[12:55:38.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:37:0)
[12:55:38.177] Timer tick, asking Buildbucket for the build status
[12:55:38.259] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:38.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:38:0) after 1m0s
[12:56:38.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:38:0)
[12:56:38.277] Timer tick, asking Buildbucket for the build status
[12:56:38.745] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:38.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:39:0) after 1m0s
[12:57:38.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:39:0)
[12:57:38.792] Timer tick, asking Buildbucket for the build status
[12:57:39.112] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:39.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:40:0) after 1m0s
[12:58:39.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:40:0)
[12:58:39.130] Timer tick, asking Buildbucket for the build status
[12:58:39.304] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:39.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:41:0) after 1m0s
[12:59:39.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:41:0)
[12:59:39.339] Timer tick, asking Buildbucket for the build status
[12:59:39.783] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:39.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:42:0) after 1m0s
[13:00:39.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:42:0)
[13:00:39.836] Timer tick, asking Buildbucket for the build status
[13:00:39.964] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:39.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:43:0) after 1m0s
[13:01:39.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:43:0)
[13:01:39.984] Timer tick, asking Buildbucket for the build status
[13:01:40.104] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:40.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:44:0) after 1m0s
[13:02:40.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:44:0)
[13:02:40.123] Timer tick, asking Buildbucket for the build status
[13:02:40.265] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:40.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:45:0) after 1m0s
[13:03:40.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:45:0)
[13:03:40.283] Timer tick, asking Buildbucket for the build status
[13:03:40.394] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:40.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:46:0) after 1m0s
[13:04:40.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:46:0)
[13:04:40.482] Timer tick, asking Buildbucket for the build status
[13:04:40.570] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:40.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:47:0) after 1m0s
[13:05:40.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:47:0)
[13:05:40.679] Timer tick, asking Buildbucket for the build status
[13:05:40.831] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:40.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:48:0) after 1m0s
[13:06:41.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:48:0)
[13:06:41.438] Timer tick, asking Buildbucket for the build status
[13:06:41.809] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:41.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:49:0) after 1m0s
[13:07:41.940] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:49:0)
[13:07:41.940] Timer tick, asking Buildbucket for the build status
[13:07:42.137] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:42.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:50:0) after 1m0s
[13:08:42.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:50:0)
[13:08:42.299] Timer tick, asking Buildbucket for the build status
[13:08:42.635] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:42.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:51:0) after 1m0s
[13:09:42.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:51:0)
[13:09:42.658] Timer tick, asking Buildbucket for the build status
[13:09:42.744] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:42.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:52:0) after 1m0s
[13:10:42.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:52:0)
[13:10:42.789] Timer tick, asking Buildbucket for the build status
[13:10:43.146] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:43.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:53:0) after 1m0s
[13:11:43.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:53:0)
[13:11:43.169] Timer tick, asking Buildbucket for the build status
[13:11:43.247] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:43.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:54:0) after 1m0s
[13:12:44.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:54:0)
[13:12:44.306] Timer tick, asking Buildbucket for the build status
[13:12:44.387] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:55:0) after 1m0s
[13:13:44.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:55:0)
[13:13:44.510] Timer tick, asking Buildbucket for the build status
[13:13:44.615] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:44.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:56:0) after 1m0s
[13:14:44.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:56:0)
[13:14:44.646] Timer tick, asking Buildbucket for the build status
[13:14:44.727] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:44.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:57:0) after 1m0s
[13:15:44.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:57:0)
[13:15:44.793] Timer tick, asking Buildbucket for the build status
[13:15:44.999] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:44.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:58:0) after 1m0s
[13:16:45.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:58:0)
[13:16:45.206] Timer tick, asking Buildbucket for the build status
[13:16:45.307] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:45.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:59:0) after 1m0s
[13:17:45.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:59:0)
[13:17:45.401] Timer tick, asking Buildbucket for the build status
[13:17:45.498] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:45.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:60:0) after 1m0s
[13:18:45.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:60:0)
[13:18:45.574] Timer tick, asking Buildbucket for the build status
[13:18:45.675] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:45.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:61:0) after 1m0s
[13:19:45.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:61:0)
[13:19:45.704] Timer tick, asking Buildbucket for the build status
[13:19:45.800] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:45.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:62:0) after 1m0s
[13:20:45.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:62:0)
[13:20:45.880] Timer tick, asking Buildbucket for the build status
[13:20:45.965] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:45.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:63:0) after 1m0s
[13:21:45.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:63:0)
[13:21:45.985] Timer tick, asking Buildbucket for the build status
[13:21:46.076] Build 8854776987419254784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:46.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020207049370629472:64:0) after 1m0s
[13:22:44.523] Received PubSub notification, asking Buildbucket for the build status
[13:22:45.076] Build 8854776987419254784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:22:45.076] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613827362715315",
"created_by": "project:chromium",
"created_ts": "1613823631801530",
"id": "8854776987419254784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a7f523e49db223f13bce070d5271e85050fe527e\"}}",
"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\": \"a7f523e49db223f13bce070d5271e85050fe527e\", \"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-3-ivw4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17441, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"d3d30921fc4c74ff24d27c1ad038445fa497046e\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"a7f523e49db223f13bce070d5271e85050fe527e\", \"got_revision_cp\": \"refs/heads/master@{#856093}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"0cfc043a97311d6ea24f9b2f6b2b3118b05012d4\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"a7f523e49db223f13bce070d5271e85050fe527e\", \"swarm_hashes_refs/heads/master(at){#856093}_without_patch\": {\"absl_hardening_tests\": \"e04f1674c79d473a3e2ec7f43b98ab10afe8a948\", \"accessibility_unittests\": \"a40f93253cd404bd0f2dbb75c703b1f97940f8ad\", \"angle_unittests\": \"2d99ad6e2784e35a1d9e0c34394aaf41db0120cd\", \"app_shell_unittests\": \"75b86beb6d4b8e3e61131b3053bffe4b5d55e646\", \"aura_unittests\": \"90175901b77843ec8c324a7a63b7ae890406205c\", \"base_unittests\": \"1ceb22df0f743b895465b4bef1cb2600b451aa3c\", \"base_util_unittests\": \"4a24ae9205265c61bfb1a9220c14f27d1b9d590c\", \"blink_common_unittests\": \"d22575545990e52dc9bb43aed478597b4cf137e4\", \"blink_fuzzer_unittests\": \"c373175d6b0fa3e4b4161b459ae8ac301b3daa11\", \"blink_heap_unittests\": \"8191262fd72c855ea7eeab99ad5fce2c40603443\", \"blink_platform_unittests\": \"2813f28d588c65bcc20635159b467a17a2eb16f1\", \"blink_unittests\": \"d4919f58b2ba1de4abd6cd015022c44c5c2a97b5\", \"boringssl_crypto_tests\": \"2b0ecd2bff56d19ca45e48454a413c50a1b09777\", \"boringssl_ssl_tests\": \"8b3a5f3ddcb4b2e816e8227b339488d56dfa6f56\", \"browser_switcher_bho_unittests\": \"1211ef2ee8fb1f6eef648516423e73cdf0d102f9\", \"browser_tests\": \"2edff9fe6eedf0211b4c096a70fcc822006a8e80\", \"capture_unittests\": \"93d8deb9042a09ef3581b4e9877de8ceebf895ac\", \"cast_unittests\": \"085f1f9ecc069425eb3ec08ae1a38c98a63c3741\", \"cc_unittests\": \"606303e64b034009a33f19338081f28f106cb588\", \"chrome_app_unittests\": \"53a2314fa992d37b19c36dbfa31e694338efbc64\", \"chrome_cleaner_unittests\": \"91d68a1458ca61d1d8f74a4ebc1583b20ef3ef29\", \"chrome_elf_unittests\": \"7f9b61b2172d6b645c2e1aed271d82684f540fb5\", \"chromedriver_unittests\": \"39a2076f050495b1ce6abb1c937a8f434220fdc8\", \"components_browsertests\": \"d6107eb649f3cad1af9ea6a3179552c441e730a6\", \"components_unittests\": \"d0b8df7109cb2023e5c79aa35b09ba934be038c9\", \"compositor_unittests\": \"d639a988d9ccbc9ac5cde8533d2dbba110fe3d72\", \"content_browsertests\": \"afc4b70ad4b3ae39108bdfecfa3ab816f569199e\", \"content_unittests\": \"da7d032ca1bd454a68de1f56909452d5f8d46f10\", \"courgette_unittests\": \"3a8374677f99fe0e5c5776e38619bfada7d55a1d\", \"crashpad_tests\": \"7404d2fd388f46939e5fb883f9612ee165874e0f\", \"cronet_tests\": \"67c191b37e845456467c76bfffae52df04f9a7d1\", \"cronet_unittests\": \"9a4c6135488b0526610b880f4673604851679d33\", \"crypto_unittests\": \"bb7ab6223d44490aed5b625810f3bb94c6364428\", \"delayloads_unittests\": \"9c79c818d6531f9da8e9ed255a6d902f8064dcef\", \"device_unittests\": \"070205bfff9a6b36ea042310f5afb9459d57967d\", \"display_unittests\": \"d887f579bd6419e36dd5d620fefd2109c3a95f37\", \"elevation_service_unittests\": \"85affdb922652539400e54503f01e75c3c2aaba4\", \"events_unittests\": \"30d85397f088804d4cf329aef2a4d78047026a3c\", \"extensions_browsertests\": \"c7c3eef9edf04562563a8847827e72d3ea8f360e\", \"extensions_unittests\": \"1ffa575cf920316deca3ecae1f558b983605a80c\", \"filesystem_service_unittests\": \"894e8d9357c459cbee6bb5caa66fe77b9dcf7971\", \"gcm_unit_tests\": \"4261adee6cb8bc4958d32dfebd5c6dd2e19160e3\", \"gcp_unittests\": \"e2006c60488c3a2fda49fbe064e8177cd94e6095\", \"gfx_unittests\": \"60d7597e08ff41aaca5d05b897700fb737c43742\", \"gin_unittests\": \"4870a5d97c4ee8fa44241007482db1c691266529\", \"google_apis_unittests\": \"1a679bc505c4e9d085c87940e224314b4af29e91\", \"gpu_unittests\": \"b65c346bcede38e8145c9eada7e6ecc31ddeae19\", \"gwp_asan_unittests\": \"c00f048445175ea5a75d5a5c9d055469a4f4a0e0\", \"headless_browsertests\": \"7ea49924c9fff59d71ff76bc5303138b9f6d6d05\", \"headless_unittests\": \"123049f40c26e3d7d917a49cd236d7d7276e99b9\", \"install_static_unittests\": \"8202ce095aef2ad17f9d4fb46b5808e883f0276e\", \"installer_util_unittests\": \"b5206f7a16097366b56dec97cd0a3367191ebe21\", \"interactive_ui_tests\": \"29a991ba2bab1aeac815a4ba73e81738a9b53650\", \"ipc_tests\": \"3d021fd03e790946e8fb17d066ac2cf55385e4cd\", \"jingle_unittests\": \"bdf364b0f8de72888e9efc5d590d5bc540bfebeb\", \"latency_unittests\": \"fccf2fb57ec02e221b2b50dc0c5cd2cbc44ee6a9\", \"libjingle_xmpp_unittests\": \"153d75fb0f9d4b3fdaf953c090872b8dfb585aa2\", \"liburlpattern_unittests\": \"c0d6dbc61365d645cf1f0d3e3bac5a1d4c05a510\", \"media_blink_unittests\": \"f0d8adfadea34dcd5615dd840a945d6a95e555bf\", \"media_unittests\": \"412d879846a70e2cd1d94e6ba3299e42599a1ced\", \"message_center_unittests\": \"f739d1d828e07571bad9ee3d70a16b082ec1282f\", \"midi_unittests\": \"98373d8b72aae903046e691418cfa863230caa2d\", \"mojo_core_unittests\": \"f06ee34a8e63aa33bd666172a5eeb4cbdae01946\", \"mojo_unittests\": \"04261a236964c9577474ba357ca20738f5463c6c\", \"nacl_loader_unittests\": \"c7e577b691866736a77eeabd7f72d12bec32b359\", \"native_theme_unittests\": \"a97b91beebe4744ef8404b4c54557f4cb701142d\", \"net_unittests\": \"fdab5d3051b6e74b2299c4e46be6fe62ed20c2a5\", \"notification_helper_unittests\": \"69c5f40f5c8b57c8c361fb5e661c0de8e8d967fa\", \"pdf_unittests\": \"a35b1f2d4b3ed268c734563e6d10466806955f4c\", \"perfetto_unittests\": \"b29ca25b2015564b48607123201865eb7a0deb08\", \"ppapi_unittests\": \"79c52c8ebefd0bf933b716ddc1c1e85aa36a78e0\", \"printing_unittests\": \"7c5881aaa98df2b18e433e19eae8a334159abebb\", \"remoting_unittests\": \"08ae688bc79d0c2b93130da50ba247b222fd0a31\", \"sbox_integration_tests\": \"3995e50329370ea0713d1b92ee85bf47a43cc2fe\", \"sbox_unittests\": \"4f22d4da6535f959b0d550c8cf0b5aabb427af7f\", \"sbox_validation_tests\": \"c5e991b12786e38905ad66add06f53bdbb7abee0\", \"service_manager_unittests\": \"eb43e55b6036b8b1d327abdb7c9c1cfcf26c4efc\", \"services_unittests\": \"00c0cf703e553d4c451e2faee1b1b71eb42473b2\", \"setup_unittests\": \"238d233aa8b36e0d023342af996e6d1fb4dcd79c\", \"shell_dialogs_unittests\": \"fb35913cbbfb1ac580483efd5b4f690347faabc6\", \"skia_unittests\": \"c8dee1bb456f9b3f57afb5198b0eba4a8e965d97\", \"snapshot_unittests\": \"03384cee7349d5b3524b4946e994b83a4a59583c\", \"sql_unittests\": \"5b323fa2f39d43d5c9dc9b266449c526ff2bf153\", \"storage_unittests\": \"6b9709afaf233b224be03de7c3d1612157194f33\", \"sync_integration_tests\": \"4c88e11732b8305d4881277d58b9cadfb213272b\", \"traffic_annotation_auditor_unittests\": \"774059a4d1525c99a60dd3eee241c4046b561136\", \"ui_base_unittests\": \"e25b2c6de2db76bddea81ba085912fb02317a3ae\", \"ui_touch_selection_unittests\": \"69e23b5f1b1773827db8aa72548ed092bebfc778\", \"unit_tests\": \"d95c21bd58245c57f0b7a3e5c36d1748c72072fb\", \"updater_tests\": \"7d8edf98aa33ecc263e8f2643dd47e4474bc1e3a\", \"url_unittests\": \"9e21669aae25157e821cf8e8da3282e69e2d943c\", \"views_unittests\": \"2763c5769380b6f267b0fb6022fce22454a493d5\", \"viz_unittests\": \"3a8aa44b5f8f7b886c7ade12d24864f99381b746\", \"vr_common_unittests\": \"f64989ba11123642d482f7b8eec4fe40beb3ed62\", \"vr_pixeltests\": \"2228c683bc7104b6793d662a79d8e68b8f4f73d1\", \"weblayer_browsertests\": \"a1fde055a5ee038cd5a1dc89963d68b111b8a79f\", \"weblayer_unittests\": \"b5fd9fee7833f3a6b4406272a8a99234ddd4db0e\", \"wm_unittests\": \"43515f43047bc83b7ba4ad1cf2f6b26b273016e0\", \"wtf_unittests\": \"3ac4766317afbc12b8cd5eb009fb2f6f3a6de6a7\", \"zlib_unittests\": \"d17ddf218a891d025d74dea3cd99a9a800ef8238\", \"zucchini_unittests\": \"9907891d20b99c8b09101c204aa768f0902fbb25\"}}, \"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-3-ivw4\"], \"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\": [\"5706-397711c\"], \"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": "1613823637276359",
"status": "COMPLETED",
"status_changed_ts": "1613827362998730",
"tags": [
"build_address:luci.chromium.ci/win-asan/17441",
"builder:win-asan",
"buildset:commit/git/a7f523e49db223f13bce070d5271e85050fe527e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7f523e49db223f13bce070d5271e85050fe527e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020207049370629472",
"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/8854776987419254784/+/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:51d833f03596f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613827363004564",
"url": "https://ci.chromium.org/b/8854776987419254784",
"utcnow_ts": "1613827365059099"
}
}
[13:22:45.076] Invocation finished in 1h2m14.52027482s with status SUCCEEDED