[12:45:40.517] New invocation is queued and will start shortly
[12:45:41.665] Starting the invocation (attempt 1)
[12:45:41.719] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:45:41.719] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:45:41.719] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023013972077338896",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"16df8a5776d666a042c948b894b9e41af64ae6c9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023013972077338896",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/16df8a5776d666a042c948b894b9e41af64ae6c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16df8a5776d666a042c948b894b9e41af64ae6c9",
"gitiles_ref:refs/heads/master"
]
}
[12:45:43.936] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611146741990534",
"id": "8857583909829868800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"16df8a5776d666a042c948b894b9e41af64ae6c9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611146743686382",
"tags": [
"build_address:luci.chromium.ci/win-asan/16910",
"builder:win-asan",
"buildset:commit/git/16df8a5776d666a042c948b894b9e41af64ae6c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16df8a5776d666a042c948b894b9e41af64ae6c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023013972077338896",
"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/8857583909829868800/+/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": "1611146743686532",
"url": "https://ci.chromium.org/b/8857583909829868800",
"utcnow_ts": "1611146743912087"
}
}
[12:45:43.936] Task URL: https://ci.chromium.org/b/8857583909829868800
[12:45:43.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:2:0) after 1m0s
[12:45:46.496] Received PubSub notification, asking Buildbucket for the build status
[12:45:46.632] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:43.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:2:0)
[12:46:43.993] Timer tick, asking Buildbucket for the build status
[12:46:44.730] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:44.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:4:0) after 1m0s
[12:47:44.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:4:0)
[12:47:44.758] Timer tick, asking Buildbucket for the build status
[12:47:44.869] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:44.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:5:0) after 1m0s
[12:48:44.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:5:0)
[12:48:44.891] Timer tick, asking Buildbucket for the build status
[12:48:45.226] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:45.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:6:0) after 1m0s
[12:49:45.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:6:0)
[12:49:45.231] Timer tick, asking Buildbucket for the build status
[12:49:45.692] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:45.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:7:0) after 1m0s
[12:50:45.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:7:0)
[12:50:45.728] Timer tick, asking Buildbucket for the build status
[12:50:46.041] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:46.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:8:0) after 1m0s
[12:51:46.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:8:0)
[12:51:46.150] Timer tick, asking Buildbucket for the build status
[12:51:46.294] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:46.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:9:0) after 1m0s
[12:52:46.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:9:0)
[12:52:46.321] Timer tick, asking Buildbucket for the build status
[12:52:46.672] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:10:0) after 1m0s
[12:53:46.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:10:0)
[12:53:46.683] Timer tick, asking Buildbucket for the build status
[12:53:47.077] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:47.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:11:0) after 1m0s
[12:54:47.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:11:0)
[12:54:47.133] Timer tick, asking Buildbucket for the build status
[12:54:47.247] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:47.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:12:0) after 1m0s
[12:55:47.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:12:0)
[12:55:47.457] Timer tick, asking Buildbucket for the build status
[12:55:47.567] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:47.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:13:0) after 1m0s
[12:56:47.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:13:0)
[12:56:47.689] Timer tick, asking Buildbucket for the build status
[12:56:47.972] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:47.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:14:0) after 1m0s
[12:57:48.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:14:0)
[12:57:48.013] Timer tick, asking Buildbucket for the build status
[12:57:48.187] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:48.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:15:0) after 1m0s
[12:58:48.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:15:0)
[12:58:48.206] Timer tick, asking Buildbucket for the build status
[12:58:48.305] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:48.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:16:0) after 1m0s
[12:59:48.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:16:0)
[12:59:48.327] Timer tick, asking Buildbucket for the build status
[12:59:49.054] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:49.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:17:0) after 1m0s
[13:00:49.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:17:0)
[13:00:49.119] Timer tick, asking Buildbucket for the build status
[13:00:49.449] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:49.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:18:0) after 1m0s
[13:01:49.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:18:0)
[13:01:49.475] Timer tick, asking Buildbucket for the build status
[13:01:49.744] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:49.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:19:0) after 1m0s
[13:02:49.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:19:0)
[13:02:49.802] Timer tick, asking Buildbucket for the build status
[13:02:49.906] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:49.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:20:0) after 1m0s
[13:03:49.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:20:0)
[13:03:49.955] Timer tick, asking Buildbucket for the build status
[13:03:50.095] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:50.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:21:0) after 1m0s
[13:04:50.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:21:0)
[13:04:50.121] Timer tick, asking Buildbucket for the build status
[13:04:50.220] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:50.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:22:0) after 1m0s
[13:05:50.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:22:0)
[13:05:50.304] Timer tick, asking Buildbucket for the build status
[13:05:50.450] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:50.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:23:0) after 1m0s
[13:06:50.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:23:0)
[13:06:50.463] Timer tick, asking Buildbucket for the build status
[13:06:50.936] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:50.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:24:0) after 1m0s
[13:07:50.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:24:0)
[13:07:50.956] Timer tick, asking Buildbucket for the build status
[13:07:51.041] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:51.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:25:0) after 1m0s
[13:08:51.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:25:0)
[13:08:51.060] Timer tick, asking Buildbucket for the build status
[13:08:51.301] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:51.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:26:0) after 1m0s
[13:09:51.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:26:0)
[13:09:51.362] Timer tick, asking Buildbucket for the build status
[13:09:51.548] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:51.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:27:0) after 1m0s
[13:10:51.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:27:0)
[13:10:51.602] Timer tick, asking Buildbucket for the build status
[13:10:52.311] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:52.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:28:0) after 1m0s
[13:11:52.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:28:0)
[13:11:52.331] Timer tick, asking Buildbucket for the build status
[13:11:52.447] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:52.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:29:0) after 1m0s
[13:12:52.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:29:0)
[13:12:52.486] Timer tick, asking Buildbucket for the build status
[13:12:52.553] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:52.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:30:0) after 1m0s
[13:13:52.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:30:0)
[13:13:52.528] Timer tick, asking Buildbucket for the build status
[13:13:52.714] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:52.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:31:0) after 1m0s
[13:14:52.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:31:0)
[13:14:52.771] Timer tick, asking Buildbucket for the build status
[13:14:52.851] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:52.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:32:0) after 1m0s
[13:15:52.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:32:0)
[13:15:52.873] Timer tick, asking Buildbucket for the build status
[13:15:53.021] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:53.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:33:0) after 1m0s
[13:16:53.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:33:0)
[13:16:53.112] Timer tick, asking Buildbucket for the build status
[13:16:53.334] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:53.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:34:0) after 1m0s
[13:17:53.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:34:0)
[13:17:53.415] Timer tick, asking Buildbucket for the build status
[13:17:53.736] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:53.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:35:0) after 1m0s
[13:18:53.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:35:0)
[13:18:53.756] Timer tick, asking Buildbucket for the build status
[13:18:53.909] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:53.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:36:0) after 1m0s
[13:19:53.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:36:0)
[13:19:53.965] Timer tick, asking Buildbucket for the build status
[13:19:54.136] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:54.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:37:0) after 1m0s
[13:20:54.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:37:0)
[13:20:54.254] Timer tick, asking Buildbucket for the build status
[13:20:54.380] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:54.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:38:0) after 1m0s
[13:21:54.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:38:0)
[13:21:54.404] Timer tick, asking Buildbucket for the build status
[13:21:54.695] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:54.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:39:0) after 1m0s
[13:22:54.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:39:0)
[13:22:54.726] Timer tick, asking Buildbucket for the build status
[13:22:55.598] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:55.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:40:0) after 1m0s
[13:23:55.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:40:0)
[13:23:55.652] Timer tick, asking Buildbucket for the build status
[13:23:55.736] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:41:0) after 1m0s
[13:24:55.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:41:0)
[13:24:55.744] Timer tick, asking Buildbucket for the build status
[13:24:56.090] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:56.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:42:0) after 1m0s
[13:25:56.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:42:0)
[13:25:56.123] Timer tick, asking Buildbucket for the build status
[13:25:56.260] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:56.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:43:0) after 1m0s
[13:26:56.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:43:0)
[13:26:56.260] Timer tick, asking Buildbucket for the build status
[13:26:56.380] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:56.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:44:0) after 1m0s
[13:27:56.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:44:0)
[13:27:56.438] Timer tick, asking Buildbucket for the build status
[13:27:56.577] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:45:0) after 1m0s
[13:28:56.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:45:0)
[13:28:56.600] Timer tick, asking Buildbucket for the build status
[13:28:57.063] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:57.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:46:0) after 1m0s
[13:29:57.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:46:0)
[13:29:57.109] Timer tick, asking Buildbucket for the build status
[13:29:57.235] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:47:0) after 1m0s
[13:30:57.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:47:0)
[13:30:57.321] Timer tick, asking Buildbucket for the build status
[13:30:57.469] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:57.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:48:0) after 1m0s
[13:31:57.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:48:0)
[13:31:57.472] Timer tick, asking Buildbucket for the build status
[13:31:57.553] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:57.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:49:0) after 1m0s
[13:32:57.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:49:0)
[13:32:57.628] Timer tick, asking Buildbucket for the build status
[13:32:57.703] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:57.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:50:0) after 1m0s
[13:33:57.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:50:0)
[13:33:57.734] Timer tick, asking Buildbucket for the build status
[13:33:57.812] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:57.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:51:0) after 1m0s
[13:34:57.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:51:0)
[13:34:57.895] Timer tick, asking Buildbucket for the build status
[13:34:57.971] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:57.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:52:0) after 1m0s
[13:35:57.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:52:0)
[13:35:57.991] Timer tick, asking Buildbucket for the build status
[13:35:58.146] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:58.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:53:0) after 1m0s
[13:36:58.241] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:53:0)
[13:36:58.241] Timer tick, asking Buildbucket for the build status
[13:36:58.332] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:58.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:54:0) after 1m0s
[13:37:58.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:54:0)
[13:37:58.312] Timer tick, asking Buildbucket for the build status
[13:37:58.427] Build 8857583909829868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:58.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023013972077338896:55:0) after 1m0s
[13:38:22.966] Received PubSub notification, asking Buildbucket for the build status
[13:38:23.165] Build 8857583909829868800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:38:23.165] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611149901748003",
"created_by": "project:chromium",
"created_ts": "1611146741990534",
"id": "8857583909829868800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"16df8a5776d666a042c948b894b9e41af64ae6c9\"}}",
"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\": \"16df8a5776d666a042c948b894b9e41af64ae6c9\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-0-gbsn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16910, \"clang_revision\": \"llvmorg-12-init-16548-gf1d5cbbd-1\", \"got_angle_revision\": \"186fe99034047745c4a626935b3ac2cce557f8f3\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"16df8a5776d666a042c948b894b9e41af64ae6c9\", \"got_revision_cp\": \"refs/heads/master@{#845132}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"22be66d4071284ffeeef424adc068e9e400835ab\", \"got_v8_revision\": \"0c46f3e0ded50952ed6f46254bbd16776f532aa0\", \"got_v8_revision_cp\": \"refs/heads/9.0.20@{#1}\", \"got_webrtc_revision\": \"6dcbcead3da45604b84aef9d9496689fef5ff8f5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33041}\", \"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\": \"16df8a5776d666a042c948b894b9e41af64ae6c9\", \"swarm_hashes_refs/heads/master(at){#845132}_without_patch\": {\"absl_hardening_tests\": \"8b37c98a73171163ead860841d8637eb4ae4d6d2\", \"accessibility_unittests\": \"0a4ac4be5734453fc4e3cad41c5c094c9304790f\", \"angle_unittests\": \"43867a53b20bbbc53ef1f939c0fb4afd499644c1\", \"app_shell_unittests\": \"a1a869b7de23a1ba13fe40e9e449be8e7fe31c05\", \"aura_unittests\": \"6cf665f05db377d98e6decbbed0da1650d896ca5\", \"base_unittests\": \"7e9490ec2aae91377d8cfa766f4837ec33f80497\", \"base_util_unittests\": \"f18bb6b6dd6bcc4e42cb36c91d64c2809b78e6a5\", \"blink_common_unittests\": \"5d5f3f48dfc64fee0414312edeca0b1f3b7d0ba0\", \"blink_fuzzer_unittests\": \"0688a43b7d057c1640e1993463e7fb72011bb1f4\", \"blink_heap_unittests\": \"019a38ec593327d4201621ced55b6ad07b32aa22\", \"blink_platform_unittests\": \"f833bcadcc236e650935fd0c3db616fb3892941b\", \"blink_unittests\": \"0e8b941abb5078e8712e4a3e4728b99bc1507051\", \"boringssl_crypto_tests\": \"a95fed092a3e73f89f78e3ad63bc9245ddd6cf2e\", \"boringssl_ssl_tests\": \"b2aec04b6ad7bf484ad1282185c7f423677dcce6\", \"browser_switcher_bho_unittests\": \"67432ed17db15186e456b42155c6cafc128d7480\", \"browser_tests\": \"cf81a4cec7116d53a07cb29111b035de467e425f\", \"capture_unittests\": \"0f8deee19673ed9ae802365d5cc9e724f91f91fd\", \"cast_unittests\": \"15afdd2b8a4c44b6ec1bd5a57f1a784327bcbeda\", \"cc_unittests\": \"79567179989679f2e94014aca79b6250432e0969\", \"chrome_app_unittests\": \"59f7301a0473a0d0200c7c5aa7bf445066d873dd\", \"chrome_cleaner_unittests\": \"6f2e1c74e2b5e1356a4909167c1d3cf7612303b8\", \"chrome_elf_unittests\": \"753e57a0b788bc6ab8f1ba953b8d646f1a94afd1\", \"chromedriver_unittests\": \"8191303e9005d13ed5e875ed8d6c3194f42ba124\", \"components_browsertests\": \"51fc87c674cbba5fe2f3b5739e8c1e626ed28525\", \"components_unittests\": \"d61173336c08775c34adc29dc203a823ba4fe730\", \"compositor_unittests\": \"55ce3f6931823a462fd8ee4fb6545ff5ac22e2c2\", \"content_browsertests\": \"7d546f1f46eb58ddfdcba10abb9fbe431440b8ab\", \"content_unittests\": \"50da3b2587ab1935ee28409e30520ab53bdd620c\", \"courgette_unittests\": \"9e4aad88f1e2e56f6c6762298236036a6246dab2\", \"crashpad_tests\": \"1187b83970e6d6775a5337443176cb0aa80e776b\", \"cronet_tests\": \"4e6af90d130130fdd7340c01f091b0416bf479f8\", \"cronet_unittests\": \"7850252469795809e10c06ff7ebe699fac4a072d\", \"crypto_unittests\": \"d2bc23a0db5f2e5398c1cdbcd3dff7104abeecb3\", \"delayloads_unittests\": \"59eef81f88e2bf139d2e97caa515d790367a381f\", \"device_unittests\": \"84b9ff18a56684d69155891d87d24e7cb06a682f\", \"display_unittests\": \"2b118b9c1f2089cd0e1b498fd59f1ced7894abd5\", \"elevation_service_unittests\": \"b08eb7a84b8bd5f03f15b452af5fd40d287e98c9\", \"events_unittests\": \"dbbfcbb7825b0fdf797c05685dfcf42d384c7e57\", \"extensions_browsertests\": \"7173b22297b6283c8eef909fd64e5fb6d2d78389\", \"extensions_unittests\": \"37425b962ba999cde9d0f3041835ff86c263b684\", \"filesystem_service_unittests\": \"e73100deaf110b47f67c23140658ad190d1d0f5e\", \"gcm_unit_tests\": \"321e06dcef9131a06a86cd77f340fe87bf8f082d\", \"gcp_unittests\": \"d8c821f7003a3af260e6b7dcb6bb94f9dbfd84b3\", \"gfx_unittests\": \"09995d7ffb3ba3264f26da94df5bc928e3bbc180\", \"gin_unittests\": \"2ee722afe6453ff0db31e8dc87e090b28b5f0538\", \"google_apis_unittests\": \"2e9f09aad52cafc5c1e52a5861a33424cc424ff9\", \"gpu_unittests\": \"ca952117f022c6090ecfe9c08aac35d4bb119566\", \"gwp_asan_unittests\": \"a428fe9518717480d7136b391c8001b988107807\", \"headless_browsertests\": \"03813c0590ef0dedb3b708de660443b0c53d4016\", \"headless_unittests\": \"a959b2aea45ef594fcd42806d27b3d6ff789fd64\", \"install_static_unittests\": \"787c08d90aca640cc43e97e7c147b92ab72fdbe8\", \"installer_util_unittests\": \"deceaf3d7bf2a028fc344df97a7076e39ddc3e5c\", \"interactive_ui_tests\": \"731e8a6a2b7293ee09e651c3262038c32897ce1a\", \"ipc_tests\": \"4560bc6c618a0bff54a11a3eff041b0b1ea4687f\", \"jingle_unittests\": \"681f27574b47da2a34bf70698906d20d7ab1d3ad\", \"latency_unittests\": \"10a03b85ad0fbcdcd986dc6c46883ad792d5f3ac\", \"libjingle_xmpp_unittests\": \"fb3ea5809df597f493d1bac2e581919ae1a5f0c0\", \"liburlpattern_unittests\": \"ee19e67c904ef5755073c4513f19de6589c67355\", \"media_blink_unittests\": \"1d65d57423deed4833e4d28d0346f09989cadddc\", \"media_unittests\": \"6f3465e0e765c96919bdbe65cb18bc640b3435e1\", \"message_center_unittests\": \"f9a9b2ae0a254457bd31ba3229be5e71ae80dc9d\", \"midi_unittests\": \"a12967970c81467172cd7a8fe32a0c8b5dafcc5a\", \"mojo_core_unittests\": \"1cacf3c6573f125a1cc44bb05d982cda0e83e2c3\", \"mojo_unittests\": \"245ef17de44c7d9c7b1893a0988fd2e591f9f3cf\", \"nacl_loader_unittests\": \"85a4fa3d66526e239ede219c4bdb05ef29f0ee8b\", \"native_theme_unittests\": \"d0808e5ee59763a76b0fd354c5a2f0f9eac3460e\", \"net_unittests\": \"0ca6e412fa970cf85e5ae979b16ffb0a7caa6ab4\", \"notification_helper_unittests\": \"abfc185002376fcb776c930aeabe4926a4d0c0ea\", \"pdf_unittests\": \"c41ac70177e07ec15d83c958d87cba94d3bee63e\", \"perfetto_unittests\": \"3d7c818a934a2b27d5978efa12c87ca11bd54bf4\", \"ppapi_unittests\": \"d2ff0aeb7d2790511c65b413836f0bc838ed83fc\", \"printing_unittests\": \"2b520aeff268e4c7c19f007a7f8a60f0b91b4643\", \"remoting_unittests\": \"050625b4f777d02d5bd95498e5e69cdabd191388\", \"sbox_integration_tests\": \"5f35cc3527874237066fdf81b25131cb17c0cc65\", \"sbox_unittests\": \"866ee1647f34e4d6c3f30f061fb965ab86a78826\", \"sbox_validation_tests\": \"128710c7c819fcbde9c8c2b4a3b88408d00c1806\", \"service_manager_unittests\": \"ba02af1863db1516317131a2b2806e04c2dbb2fe\", \"services_unittests\": \"1ae40724b55c0d25950568556d98d44afc0def2e\", \"setup_unittests\": \"28f0d7027efb6a8126e777169e5c35873996b783\", \"shell_dialogs_unittests\": \"21af627684b67944c425506826b538fded1ac9ff\", \"skia_unittests\": \"013b86254582a8709c188f25446dd8163d1708a2\", \"snapshot_unittests\": \"e9f666aba406061694938ab2c7615b252b1fb5e6\", \"sql_unittests\": \"c2015dfaa8305cc12fe4d3b072a33c267db594a4\", \"storage_unittests\": \"19a2fc44510807d860bd7276958ff2b7492fea49\", \"sync_integration_tests\": \"6ec894e751fb1ee2e1efb1d7cf357763fd389da5\", \"traffic_annotation_auditor_unittests\": \"ef89721b95cf8edbd62fe26bb1b50be3dbbf4d9d\", \"ui_base_unittests\": \"8dd79fce9caa6ab1f5a4b19fd2ffc43b79ff5b9b\", \"ui_touch_selection_unittests\": \"d33017cf61c7aa1bb7927b5fcc11f9e361177be0\", \"unit_tests\": \"8f31490add8a9bc52cf11d6a37ede01b06dd8e76\", \"updater_tests\": \"760fd3065c82898f49c86e4b4e932150cbf25a6b\", \"url_unittests\": \"57681ed628f80fbcd6203ffd817153c433b00918\", \"views_unittests\": \"84a354f09387d57a7d5687784a7f5f80d94770f7\", \"viz_unittests\": \"7e37371d49792adadaa9b59e92decdd91124ffa1\", \"vr_common_unittests\": \"ff17cd764fc7e55fcfa9f87c32b3cb315731bf1e\", \"vr_pixeltests\": \"904291c141b41dbc7a85b8b61f4bc9b5676942af\", \"weblayer_browsertests\": \"a0a7cf536e185c3a070b6ff9415d378bbd594f1c\", \"weblayer_unittests\": \"ee9a27c4ebab094cb195075c662f4c75d8bf4aef\", \"wm_unittests\": \"46874c05ac9bab7c05d673f979d25f5e16e40c71\", \"wtf_unittests\": \"e32d7ee168aa7120ef0eeda1829274357b42c6df\", \"zlib_unittests\": \"9cb184d2fe2b218d3c427246c937d09e605968b8\", \"zucchini_unittests\": \"5863bbde755aeff68b7ca78e54fac518e0e296c8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_v2\", \"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-gbsn\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611146745137696",
"status": "COMPLETED",
"status_changed_ts": "1611149902126740",
"tags": [
"build_address:luci.chromium.ci/win-asan/16910",
"builder:win-asan",
"buildset:commit/git/16df8a5776d666a042c948b894b9e41af64ae6c9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16df8a5776d666a042c948b894b9e41af64ae6c9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023013972077338896",
"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/8857583909829868800/+/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:5138a5d92ae9f510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611149902131441",
"url": "https://ci.chromium.org/b/8857583909829868800",
"utcnow_ts": "1611149903151436"
}
}
[13:38:23.165] Invocation finished in 52m42.701762232s with status SUCCEEDED