[11:37:44.729] New invocation is queued and will start shortly
[11:37:46.440] Starting the invocation (attempt 1)
[11:37:46.476] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:37:46.476] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:37:46.476] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023652424575138240",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023652424575138240",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"gitiles_ref:refs/heads/master"
]
}
[11:37:47.202] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610537866561435",
"id": "8858222361991366768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610537866953139",
"tags": [
"build_address:luci.chromium.ci/win-asan/16796",
"builder:win-asan",
"buildset:commit/git/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023652424575138240",
"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/8858222361991366768/+/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": "1610537866953303",
"url": "https://ci.chromium.org/b/8858222361991366768",
"utcnow_ts": "1610537867195397"
}
}
[11:37:47.203] Task URL: https://ci.chromium.org/b/8858222361991366768
[11:37:47.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:2:0) after 1m0s
[11:37:50.165] Received PubSub notification, asking Buildbucket for the build status
[11:37:50.250] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:47.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:2:0)
[11:38:47.498] Timer tick, asking Buildbucket for the build status
[11:38:47.590] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:47.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:4:0) after 1m0s
[11:39:47.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:4:0)
[11:39:47.856] Timer tick, asking Buildbucket for the build status
[11:39:48.162] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:48.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:5:0) after 1m0s
[11:40:48.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:5:0)
[11:40:48.326] Timer tick, asking Buildbucket for the build status
[11:40:48.523] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:48.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:6:0) after 1m0s
[11:41:48.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:6:0)
[11:41:48.793] Timer tick, asking Buildbucket for the build status
[11:41:48.891] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:48.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:7:0) after 1m0s
[11:42:49.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:7:0)
[11:42:49.095] Timer tick, asking Buildbucket for the build status
[11:42:49.272] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:49.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:8:0) after 1m0s
[11:43:49.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:8:0)
[11:43:49.324] Timer tick, asking Buildbucket for the build status
[11:43:49.391] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:49.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:9:0) after 1m0s
[11:44:49.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:9:0)
[11:44:49.428] Timer tick, asking Buildbucket for the build status
[11:44:49.521] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:49.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:10:0) after 1m0s
[11:45:49.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:10:0)
[11:45:49.636] Timer tick, asking Buildbucket for the build status
[11:45:49.704] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:49.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:11:0) after 1m0s
[11:46:49.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:11:0)
[11:46:49.781] Timer tick, asking Buildbucket for the build status
[11:46:49.866] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:49.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:12:0) after 1m0s
[11:47:50.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:12:0)
[11:47:50.013] Timer tick, asking Buildbucket for the build status
[11:47:50.113] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:50.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:13:0) after 1m0s
[11:48:50.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:13:0)
[11:48:50.235] Timer tick, asking Buildbucket for the build status
[11:48:50.302] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:50.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:14:0) after 1m0s
[11:49:50.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:14:0)
[11:49:50.414] Timer tick, asking Buildbucket for the build status
[11:49:50.483] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:50.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:15:0) after 1m0s
[11:50:50.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:15:0)
[11:50:50.622] Timer tick, asking Buildbucket for the build status
[11:50:50.700] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:50.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:16:0) after 1m0s
[11:51:50.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:16:0)
[11:51:50.827] Timer tick, asking Buildbucket for the build status
[11:51:53.543] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:53.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:17:0) after 1m0s
[11:52:53.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:17:0)
[11:52:53.564] Timer tick, asking Buildbucket for the build status
[11:52:53.895] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:53.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:18:0) after 1m0s
[11:53:53.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:18:0)
[11:53:53.936] Timer tick, asking Buildbucket for the build status
[11:53:54.656] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:54.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:19:0) after 1m0s
[11:54:54.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:19:0)
[11:54:54.677] Timer tick, asking Buildbucket for the build status
[11:54:54.754] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:54.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:20:0) after 1m0s
[11:55:54.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:20:0)
[11:55:54.774] Timer tick, asking Buildbucket for the build status
[11:55:54.830] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:54.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:21:0) after 1m0s
[11:56:54.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:21:0)
[11:56:54.850] Timer tick, asking Buildbucket for the build status
[11:56:54.922] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:54.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:22:0) after 1m0s
[11:57:54.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:22:0)
[11:57:54.945] Timer tick, asking Buildbucket for the build status
[11:57:55.049] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:55.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:23:0) after 1m0s
[11:58:55.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:23:0)
[11:58:55.051] Timer tick, asking Buildbucket for the build status
[11:58:55.152] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:55.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:24:0) after 1m0s
[11:59:55.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:24:0)
[11:59:55.173] Timer tick, asking Buildbucket for the build status
[11:59:55.327] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:55.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:25:0) after 1m0s
[12:00:55.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:25:0)
[12:00:55.333] Timer tick, asking Buildbucket for the build status
[12:00:55.629] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:55.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:26:0) after 1m0s
[12:01:55.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:26:0)
[12:01:55.652] Timer tick, asking Buildbucket for the build status
[12:01:55.758] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:27:0) after 1m0s
[12:02:55.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:27:0)
[12:02:55.814] Timer tick, asking Buildbucket for the build status
[12:02:55.964] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:55.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:28:0) after 1m0s
[12:03:56.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:28:0)
[12:03:56.120] Timer tick, asking Buildbucket for the build status
[12:03:56.246] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:56.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:29:0) after 1m0s
[12:04:56.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:29:0)
[12:04:56.331] Timer tick, asking Buildbucket for the build status
[12:04:56.893] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:30:0) after 1m0s
[12:05:56.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:30:0)
[12:05:56.915] Timer tick, asking Buildbucket for the build status
[12:05:57.022] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:31:0) after 1m0s
[12:06:57.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:31:0)
[12:06:57.448] Timer tick, asking Buildbucket for the build status
[12:06:57.554] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:57.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:32:0) after 1m0s
[12:07:57.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:32:0)
[12:07:57.632] Timer tick, asking Buildbucket for the build status
[12:07:57.773] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:57.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:33:0) after 1m0s
[12:08:57.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:33:0)
[12:08:57.897] Timer tick, asking Buildbucket for the build status
[12:08:57.995] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:57.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:34:0) after 1m0s
[12:09:58.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:34:0)
[12:09:58.126] Timer tick, asking Buildbucket for the build status
[12:09:58.238] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:58.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:35:0) after 1m0s
[12:10:58.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:35:0)
[12:10:58.344] Timer tick, asking Buildbucket for the build status
[12:10:58.485] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:58.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:36:0) after 1m0s
[12:11:58.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:36:0)
[12:11:58.597] Timer tick, asking Buildbucket for the build status
[12:11:58.792] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:58.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:37:0) after 1m0s
[12:12:58.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:37:0)
[12:12:58.878] Timer tick, asking Buildbucket for the build status
[12:12:59.001] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:59.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:38:0) after 1m0s
[12:13:59.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:38:0)
[12:13:59.041] Timer tick, asking Buildbucket for the build status
[12:13:59.315] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:39:0) after 1m0s
[12:14:59.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:39:0)
[12:14:59.329] Timer tick, asking Buildbucket for the build status
[12:14:59.428] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:59.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:40:0) after 1m0s
[12:15:59.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:40:0)
[12:15:59.428] Timer tick, asking Buildbucket for the build status
[12:15:59.496] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:59.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:41:0) after 1m0s
[12:16:59.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:41:0)
[12:16:59.522] Timer tick, asking Buildbucket for the build status
[12:17:00.143] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:00.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:42:0) after 1m0s
[12:18:00.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:42:0)
[12:18:00.170] Timer tick, asking Buildbucket for the build status
[12:18:00.323] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:00.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:43:0) after 1m0s
[12:19:00.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:43:0)
[12:19:00.416] Timer tick, asking Buildbucket for the build status
[12:19:00.492] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:00.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:44:0) after 1m0s
[12:20:01.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:44:0)
[12:20:01.726] Timer tick, asking Buildbucket for the build status
[12:20:01.854] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:01.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:45:0) after 1m0s
[12:21:01.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:45:0)
[12:21:01.921] Timer tick, asking Buildbucket for the build status
[12:21:02.441] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:02.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:46:0) after 1m0s
[12:22:02.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:46:0)
[12:22:02.480] Timer tick, asking Buildbucket for the build status
[12:22:02.566] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:02.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:47:0) after 1m0s
[12:23:02.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:47:0)
[12:23:02.606] Timer tick, asking Buildbucket for the build status
[12:23:02.736] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:02.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:48:0) after 1m0s
[12:24:02.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:48:0)
[12:24:02.769] Timer tick, asking Buildbucket for the build status
[12:24:02.983] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:02.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:49:0) after 1m0s
[12:25:03.071] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:49:0)
[12:25:03.071] Timer tick, asking Buildbucket for the build status
[12:25:03.315] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:03.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:50:0) after 1m0s
[12:26:03.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:50:0)
[12:26:03.388] Timer tick, asking Buildbucket for the build status
[12:26:03.616] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:03.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:51:0) after 1m0s
[12:27:03.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:51:0)
[12:27:03.642] Timer tick, asking Buildbucket for the build status
[12:27:03.806] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:03.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:52:0) after 1m0s
[12:28:03.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:52:0)
[12:28:03.942] Timer tick, asking Buildbucket for the build status
[12:28:04.352] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:04.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:53:0) after 1m0s
[12:29:04.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:53:0)
[12:29:04.429] Timer tick, asking Buildbucket for the build status
[12:29:04.587] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:04.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:54:0) after 1m0s
[12:30:04.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:54:0)
[12:30:04.736] Timer tick, asking Buildbucket for the build status
[12:30:05.044] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:05.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:55:0) after 1m0s
[12:31:05.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:55:0)
[12:31:05.591] Timer tick, asking Buildbucket for the build status
[12:31:05.713] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:05.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:56:0) after 1m0s
[12:32:05.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:56:0)
[12:32:05.756] Timer tick, asking Buildbucket for the build status
[12:32:05.838] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:05.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:57:0) after 1m0s
[12:33:05.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:57:0)
[12:33:05.865] Timer tick, asking Buildbucket for the build status
[12:33:06.530] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:06.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:58:0) after 1m0s
[12:34:06.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:58:0)
[12:34:06.557] Timer tick, asking Buildbucket for the build status
[12:34:06.655] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:06.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:59:0) after 1m0s
[12:35:06.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:59:0)
[12:35:06.733] Timer tick, asking Buildbucket for the build status
[12:35:06.927] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:06.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:60:0) after 1m0s
[12:36:07.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:60:0)
[12:36:07.053] Timer tick, asking Buildbucket for the build status
[12:36:07.224] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:07.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:61:0) after 1m0s
[12:37:07.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:61:0)
[12:37:07.290] Timer tick, asking Buildbucket for the build status
[12:37:07.365] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:07.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:62:0) after 1m0s
[12:38:07.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:62:0)
[12:38:07.408] Timer tick, asking Buildbucket for the build status
[12:38:07.587] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:07.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:63:0) after 1m0s
[12:39:07.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:63:0)
[12:39:07.681] Timer tick, asking Buildbucket for the build status
[12:39:07.779] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:07.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:64:0) after 1m0s
[12:40:07.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:64:0)
[12:40:07.823] Timer tick, asking Buildbucket for the build status
[12:40:07.936] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:07.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:65:0) after 1m0s
[12:41:08.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:65:0)
[12:41:08.011] Timer tick, asking Buildbucket for the build status
[12:41:08.187] Build 8858222361991366768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:08.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023652424575138240:66:0) after 1m0s
[12:41:35.466] Received PubSub notification, asking Buildbucket for the build status
[12:41:35.562] Build 8858222361991366768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:41:35.562] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610541693955342",
"created_by": "project:chromium",
"created_ts": "1610537866561435",
"id": "8858222361991366768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\"}}",
"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\": \"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\", \"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-8-wwgq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16796, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"2ed9671a0dddaab9c2582b62d3e479895ee0d333\", \"got_dawn_revision\": \"7faa362ea9c2bffbb8e9cc2e2d9f4f4af2fe4dde\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\", \"got_revision_cp\": \"refs/heads/master@{#842963}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"03dbe217fbc7fe9d939e0cf0c9bcb8bfa2c5de0e\", \"got_v8_revision_cp\": \"refs/heads/8.9.261@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"6f1ad3ee2cfa299c9699ed28385752b81654bdbf\", \"swarm_hashes_refs/heads/master(at){#842963}_without_patch\": {\"absl_hardening_tests\": \"1ef04d65afd764da8e896aeba26aada62e6909f3\", \"accessibility_unittests\": \"1bd885f7b3e42bbd204ae4d0cba640a14365c933\", \"angle_unittests\": \"55360ef4f7ede6186ee037170e24cdec374213f5\", \"app_shell_unittests\": \"57d09f8ca7ee47909fc0125c4687da30d6f0ec3b\", \"aura_unittests\": \"7a9c8138350292e1a6d9c18962146ac3fcbd0087\", \"base_unittests\": \"2593c3b129968b71e09f3687475de18ab115d5b6\", \"base_util_unittests\": \"3737961d0c8907433d49c3c79757dfa42e8e044e\", \"blink_common_unittests\": \"60c00bc9853ff8ac3a2c263b4be3cd0cc600d3e7\", \"blink_fuzzer_unittests\": \"66ded45262d29e14455c88f3657025b02e27dbb3\", \"blink_heap_unittests\": \"603a60384be4dac71bdcc79802b9b45c5225866e\", \"blink_platform_unittests\": \"54fe77d0a6fc5154e504212160bddb4cbb8a5e77\", \"blink_unittests\": \"69ee421cd8e3570b08ced61c9caa896eedb07412\", \"boringssl_crypto_tests\": \"5ee30f498c0f5848954b33a14a1e19c67cec788d\", \"boringssl_ssl_tests\": \"ee8da5a346cba968462f7108f0783dfd697f9e1a\", \"browser_switcher_bho_unittests\": \"7b8bc711ffb6bead9b12b397a47bae67cb5f6cb3\", \"browser_tests\": \"d2b645786996cb2dd257c3f14b967df944e5722b\", \"capture_unittests\": \"50de8f74593ff7dcc679a10ada0364e102ebe350\", \"cast_unittests\": \"2f99149e946bd9a04758223a8f9ba4267992e6fb\", \"cc_unittests\": \"0d66d678ee03b2728bfbbcae507ca00988a3e143\", \"chrome_app_unittests\": \"a8a67994592ccdb5f092ec0acec1389bf6c603f7\", \"chrome_cleaner_unittests\": \"0017a10c107f7c23fdeda97ac6db5383de56406f\", \"chrome_elf_unittests\": \"6b444fcfdac09dcc74e9c0f8205725c26b75b2ae\", \"chromedriver_unittests\": \"8c58a6c51d997221028d45fe756665afaa4aad27\", \"components_browsertests\": \"9677c77a6bd7917705bf1627306bed270a1b308a\", \"components_unittests\": \"c0eed23f69668549e815927e3539046f4f4ae9b5\", \"compositor_unittests\": \"9be70f7c795f9f114ca48bf63427b0107468102a\", \"content_browsertests\": \"7a118089ae50c846814f22a567160bd58919882b\", \"content_unittests\": \"0e3455d5f06c78239721bc719e9f4fae1cdd9360\", \"courgette_unittests\": \"098be4bf12255bab4f09da15b9478f91f5aa7040\", \"crashpad_tests\": \"361cc0081fa38be3532c6c97962a28b6e246ccea\", \"cronet_tests\": \"ea55d73aa0410d382b0be9c06df23cfa33e7def5\", \"cronet_unittests\": \"4132a5d142d76905ce9f4a42e0bc4692052c9871\", \"crypto_unittests\": \"adb7ab3f67626e0925d8d0be0410ea6582422342\", \"delayloads_unittests\": \"9830e69e3021d29222aa91f3eacedf4704af2022\", \"device_unittests\": \"2f2396f5d62d1b42f58f4174bf3a6dc2503ba4e0\", \"display_unittests\": \"61dca5338abd2a67c9d6181ecc0e67b68835fdf2\", \"elevation_service_unittests\": \"a5143a5d92b58f929f17bf03d5dfb8e00b1b6945\", \"events_unittests\": \"20b52c41dc9c2a953d30d74a9a51e3b9dfa25220\", \"extensions_browsertests\": \"f175d53029e87be955c6a317667029b57234975d\", \"extensions_unittests\": \"2df42117660d50ba7727ae3c37539da9157633db\", \"filesystem_service_unittests\": \"e520f364def20584f971b93ea66a5b33ec923c37\", \"gcm_unit_tests\": \"b419e26fc7249e2b45e9366d6468ca7dbf30b033\", \"gcp_unittests\": \"450f82ab36306c8c7530be52840df7db5b052ecb\", \"gfx_unittests\": \"7190354c7fc3cacc38987451d23830e57c821883\", \"gin_unittests\": \"af777875efcae7e7687459564b3bf87d0a13e9ff\", \"google_apis_unittests\": \"1cdc3f1376431c2888486e68f67e5db57559cea2\", \"gpu_unittests\": \"832c91cd82529cf1c31661eb1e409c7b41f42965\", \"gwp_asan_unittests\": \"15a1f0574f29e720be5b43fa47ee06d9e0434f18\", \"headless_browsertests\": \"a099542f0df20bbda908820d366ca28e0f30c4ea\", \"headless_unittests\": \"cbec9595d8a9355f476b7ae1dd95c7abc9b0363e\", \"install_static_unittests\": \"665d747ee0c6b437221113486535f95d2f306097\", \"installer_util_unittests\": \"d06bc7fdac39203b50ad471efe79b28a9d9e894e\", \"interactive_ui_tests\": \"957c79c3712d327761150e7134b77b63760a8fec\", \"ipc_tests\": \"e623ee383a4e525ebf2d8d9c6f6225f71841bfa1\", \"jingle_unittests\": \"01b321604b714f815893f4fc0deea1da0b245cf0\", \"latency_unittests\": \"787b53ecb555a40648480ad99807fc7ca3a93c34\", \"libjingle_xmpp_unittests\": \"93b6af5404d60342d6fafa3f75628cd13d783970\", \"liburlpattern_unittests\": \"62e961b1330c1644b0d3affbb61d654378d011af\", \"media_blink_unittests\": \"85f6361f715690c87220ec6f36d2b5efca1b33bc\", \"media_unittests\": \"353ada4443eb92e8d5885915e74a81caf0c2be6e\", \"message_center_unittests\": \"8a3b14175ae97bab689e995138ce3a4b7ac229d3\", \"midi_unittests\": \"5b17e444f83f7d2aadeacf9f3f870e20c7cf736c\", \"mojo_core_unittests\": \"a00b4b89d31be2ef0e6e41c059f16e5c5d3bc3ac\", \"mojo_unittests\": \"6fdb3cb1620bcde6f8cb2d4006dc5fe42bdebeab\", \"nacl_loader_unittests\": \"1935b76a668e30611ac9c0336aefc360a89077c9\", \"native_theme_unittests\": \"1446eb9ba712d50947a4e32859e7c42f9f9f41d4\", \"net_unittests\": \"bbfd42d9d551678c58cf2b497f0ea92856be398a\", \"notification_helper_unittests\": \"8e32d653eb2823faf775e9f1ccd45cf2eb8c3568\", \"pdf_unittests\": \"2d97c54759c55189c5473f78d87acca9adf9215c\", \"perfetto_unittests\": \"390f48362389f5bdccdb0cfb1480c57c5f2cab07\", \"ppapi_unittests\": \"6f205a97287e43b48efd92281d1403f1c90046ac\", \"printing_unittests\": \"e7d0a89b632c9a04051e0cd4af7f9337712f176b\", \"remoting_unittests\": \"4fbfde07cb5982cef1339a466615f34be7a7d994\", \"sbox_integration_tests\": \"63f3f07972685db3e67474c11c9144490ba3d089\", \"sbox_unittests\": \"013a8f0f93a07a08be956ee47c608e8d190523b1\", \"sbox_validation_tests\": \"80bb28f3ae967686eab469f9cfb08f4c0a6ac8dc\", \"service_manager_unittests\": \"d12d670b74bad5ab4ca1f42dce3d05795aae4e28\", \"services_unittests\": \"eabca4c9b19dd664ed8e8094ba2fea238399e08d\", \"setup_unittests\": \"108f4453dee6a2066dd62d56ae3f24312c49641a\", \"shell_dialogs_unittests\": \"01e198333e9362e0566b9cb1e227e15c249a0d71\", \"skia_unittests\": \"b08bf263ca8b07bd02bd9b2726d5e24c5fa6356f\", \"snapshot_unittests\": \"ed6622e7afe834d7844f3d14cb38c8335f5074a6\", \"sql_unittests\": \"6385b5245ef97c28b769d16b2019b293e544e5ff\", \"storage_unittests\": \"60b46ccfa2141034d4078568462a831be1d551e6\", \"sync_integration_tests\": \"3be103d914809bd6e4464a09c7260d2fa9cfbe09\", \"traffic_annotation_auditor_unittests\": \"627fa665b562c32cd1eb45d7cb6ce2dd50852826\", \"ui_base_unittests\": \"52be6dc269d0fa385390f3bcf48d56302066fb19\", \"ui_touch_selection_unittests\": \"b7f22d1bdeb3ba43d779e134b53129169372b9ed\", \"unit_tests\": \"1dac8da3d5ba9253664007c0215d7b243050be38\", \"updater_tests\": \"5c70372cbcf02470de961fd34b35832e338fcedd\", \"url_unittests\": \"9d1001babf56d179435c7af8624eb9a15bf9a6e1\", \"views_unittests\": \"a558bae86b60468139a14b8ac66949ac182baea0\", \"viz_unittests\": \"cee5c296f06191a4de12f0777a12bfecc53accf5\", \"vr_common_unittests\": \"bfb9a11adea3e0dc3da70cfea6e82ded954be214\", \"vr_pixeltests\": \"9ea095b520bd1a71c900b1464d927791a76ee638\", \"weblayer_browsertests\": \"a244e6db0eda2242969e631765046d276b49f6bb\", \"weblayer_unittests\": \"1e90b161fca799713a3dd2fb025dd280e0a778c3\", \"wm_unittests\": \"50d3274a0bf3607e91fdb4bf958a0a3fd1f79f4f\", \"wtf_unittests\": \"ea1320a8d23eb6e9f761935aba34245d0a4e461c\", \"zlib_unittests\": \"eac41890e5ef08112a0c18acda29c480652e0f6d\", \"zucchini_unittests\": \"feb6cc47956e67508e476dd2ec0bd9e27a1b3704\"}}, \"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-8-wwgq\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5661-c6f6250\"], \"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": "1610537869168933",
"status": "COMPLETED",
"status_changed_ts": "1610541694182629",
"tags": [
"build_address:luci.chromium.ci/win-asan/16796",
"builder:win-asan",
"buildset:commit/git/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f1ad3ee2cfa299c9699ed28385752b81654bdbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023652424575138240",
"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/8858222361991366768/+/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:51145b20cd68c810",
"user_agent:luci-scheduler"
],
"updated_ts": "1610541694189456",
"url": "https://ci.chromium.org/b/8858222361991366768",
"utcnow_ts": "1610541695554217"
}
}
[12:41:35.562] Invocation finished in 1h3m50.849080723s with status SUCCEEDED