[12:53:54.935] New invocation is queued and will start shortly
[12:53:56.191] Starting the invocation (attempt 1)
[12:53:56.235] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:53:56.235] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:53:56.235] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028811659454332928",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028811659454332928",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"gitiles_ref:refs/heads/master"
]
}
[12:53:56.891] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605617636324087",
"id": "8863381597332320944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605617636723977",
"tags": [
"build_address:luci.chromium.ci/win-asan/15687",
"builder:win-asan",
"buildset:commit/git/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028811659454332928",
"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/8863381597332320944/+/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": "1605617636724114",
"url": "https://ci.chromium.org/b/8863381597332320944",
"utcnow_ts": "1605617636882373"
}
}
[12:53:56.891] Task URL: https://ci.chromium.org/b/8863381597332320944
[12:53:56.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:2:0) after 1m0s
[12:54:03.767] Received PubSub notification, asking Buildbucket for the build status
[12:54:03.909] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:56.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:2:0)
[12:54:56.947] Timer tick, asking Buildbucket for the build status
[12:54:57.147] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:4:0) after 1m0s
[12:55:57.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:4:0)
[12:55:57.212] Timer tick, asking Buildbucket for the build status
[12:55:57.456] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:57.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:5:0) after 1m0s
[12:56:57.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:5:0)
[12:56:57.510] Timer tick, asking Buildbucket for the build status
[12:56:57.643] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:57.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:6:0) after 1m0s
[12:57:57.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:6:0)
[12:57:57.680] Timer tick, asking Buildbucket for the build status
[12:57:57.902] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:57.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:7:0) after 1m0s
[12:58:57.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:7:0)
[12:58:57.923] Timer tick, asking Buildbucket for the build status
[12:58:58.047] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:58.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:8:0) after 1m0s
[12:59:58.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:8:0)
[12:59:58.107] Timer tick, asking Buildbucket for the build status
[12:59:58.438] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:58.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:9:0) after 1m0s
[13:00:58.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:9:0)
[13:00:58.786] Timer tick, asking Buildbucket for the build status
[13:00:59.050] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:59.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:10:0) after 1m0s
[13:01:59.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:10:0)
[13:01:59.261] Timer tick, asking Buildbucket for the build status
[13:01:59.430] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:59.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:11:0) after 1m0s
[13:03:01.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:11:0)
[13:03:01.319] Timer tick, asking Buildbucket for the build status
[13:03:01.847] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:01.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:12:0) after 1m0s
[13:04:01.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:12:0)
[13:04:01.887] Timer tick, asking Buildbucket for the build status
[13:04:02.142] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:02.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:13:0) after 1m0s
[13:05:02.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:13:0)
[13:05:02.166] Timer tick, asking Buildbucket for the build status
[13:05:02.517] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:02.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:14:0) after 1m0s
[13:06:02.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:14:0)
[13:06:02.592] Timer tick, asking Buildbucket for the build status
[13:06:02.876] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:02.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:15:0) after 1m0s
[13:07:02.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:15:0)
[13:07:02.956] Timer tick, asking Buildbucket for the build status
[13:07:03.049] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:03.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:16:0) after 1m0s
[13:08:03.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:16:0)
[13:08:03.165] Timer tick, asking Buildbucket for the build status
[13:08:03.296] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:03.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:17:0) after 1m0s
[13:09:03.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:17:0)
[13:09:03.381] Timer tick, asking Buildbucket for the build status
[13:09:03.506] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:03.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:18:0) after 1m0s
[13:10:03.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:18:0)
[13:10:03.563] Timer tick, asking Buildbucket for the build status
[13:10:03.698] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:03.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:19:0) after 1m0s
[13:11:03.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:19:0)
[13:11:03.710] Timer tick, asking Buildbucket for the build status
[13:11:03.874] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:03.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:20:0) after 1m0s
[13:12:03.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:20:0)
[13:12:03.949] Timer tick, asking Buildbucket for the build status
[13:12:04.164] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:04.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:21:0) after 1m0s
[13:13:04.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:21:0)
[13:13:04.212] Timer tick, asking Buildbucket for the build status
[13:13:04.347] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:04.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:22:0) after 1m0s
[13:14:04.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:22:0)
[13:14:04.377] Timer tick, asking Buildbucket for the build status
[13:14:04.648] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:04.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:23:0) after 1m0s
[13:15:04.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:23:0)
[13:15:04.927] Timer tick, asking Buildbucket for the build status
[13:15:05.114] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:05.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:24:0) after 1m0s
[13:16:05.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:24:0)
[13:16:05.325] Timer tick, asking Buildbucket for the build status
[13:16:06.065] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:06.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:25:0) after 1m0s
[13:17:06.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:25:0)
[13:17:06.360] Timer tick, asking Buildbucket for the build status
[13:17:06.486] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:06.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:26:0) after 1m0s
[13:18:06.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:26:0)
[13:18:06.587] Timer tick, asking Buildbucket for the build status
[13:18:07.033] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:07.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:27:0) after 1m0s
[13:19:07.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:27:0)
[13:19:07.121] Timer tick, asking Buildbucket for the build status
[13:19:07.262] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:28:0) after 1m0s
[13:20:07.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:28:0)
[13:20:07.292] Timer tick, asking Buildbucket for the build status
[13:20:07.548] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:07.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:29:0) after 1m0s
[13:21:07.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:29:0)
[13:21:07.669] Timer tick, asking Buildbucket for the build status
[13:21:07.761] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:07.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:30:0) after 1m0s
[13:22:07.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:30:0)
[13:22:07.855] Timer tick, asking Buildbucket for the build status
[13:22:07.964] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:07.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:31:0) after 1m0s
[13:23:07.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:31:0)
[13:23:07.983] Timer tick, asking Buildbucket for the build status
[13:23:08.066] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:08.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:32:0) after 1m0s
[13:24:08.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:32:0)
[13:24:08.195] Timer tick, asking Buildbucket for the build status
[13:24:08.316] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:08.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:33:0) after 1m0s
[13:25:08.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:33:0)
[13:25:08.342] Timer tick, asking Buildbucket for the build status
[13:25:08.511] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:08.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:34:0) after 1m0s
[13:26:08.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:34:0)
[13:26:08.566] Timer tick, asking Buildbucket for the build status
[13:26:08.660] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:08.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:35:0) after 1m0s
[13:27:08.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:35:0)
[13:27:08.745] Timer tick, asking Buildbucket for the build status
[13:27:08.824] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:08.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:36:0) after 1m0s
[13:28:08.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:36:0)
[13:28:08.927] Timer tick, asking Buildbucket for the build status
[13:28:09.068] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:09.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:37:0) after 1m0s
[13:29:09.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:37:0)
[13:29:09.130] Timer tick, asking Buildbucket for the build status
[13:29:09.246] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:09.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:38:0) after 1m0s
[13:30:09.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:38:0)
[13:30:09.320] Timer tick, asking Buildbucket for the build status
[13:30:09.825] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:09.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:39:0) after 1m0s
[13:31:10.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:39:0)
[13:31:10.215] Timer tick, asking Buildbucket for the build status
[13:31:10.334] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:10.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:40:0) after 1m0s
[13:32:10.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:40:0)
[13:32:10.425] Timer tick, asking Buildbucket for the build status
[13:32:10.724] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:10.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:41:0) after 1m0s
[13:33:10.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:41:0)
[13:33:10.798] Timer tick, asking Buildbucket for the build status
[13:33:11.090] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:11.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:42:0) after 1m0s
[13:34:11.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:42:0)
[13:34:11.185] Timer tick, asking Buildbucket for the build status
[13:34:11.332] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:11.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:43:0) after 1m0s
[13:35:11.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:43:0)
[13:35:11.379] Timer tick, asking Buildbucket for the build status
[13:35:11.680] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:11.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:44:0) after 1m0s
[13:36:11.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:44:0)
[13:36:11.736] Timer tick, asking Buildbucket for the build status
[13:36:11.953] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:11.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:45:0) after 1m0s
[13:37:12.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:45:0)
[13:37:12.017] Timer tick, asking Buildbucket for the build status
[13:37:12.469] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:12.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:46:0) after 1m0s
[13:38:12.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:46:0)
[13:38:12.818] Timer tick, asking Buildbucket for the build status
[13:38:12.906] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:12.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:47:0) after 1m0s
[13:39:12.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:47:0)
[13:39:12.949] Timer tick, asking Buildbucket for the build status
[13:39:13.343] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:13.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:48:0) after 1m0s
[13:40:13.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:48:0)
[13:40:13.392] Timer tick, asking Buildbucket for the build status
[13:40:13.489] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:13.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:49:0) after 1m0s
[13:41:13.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:49:0)
[13:41:13.600] Timer tick, asking Buildbucket for the build status
[13:41:13.672] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:13.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:50:0) after 1m0s
[13:42:13.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:50:0)
[13:42:13.680] Timer tick, asking Buildbucket for the build status
[13:42:13.833] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:13.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:51:0) after 1m0s
[13:43:13.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:51:0)
[13:43:13.901] Timer tick, asking Buildbucket for the build status
[13:43:13.965] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:13.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:52:0) after 1m0s
[13:44:14.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:52:0)
[13:44:14.058] Timer tick, asking Buildbucket for the build status
[13:44:14.815] Build 8863381597332320944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:14.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028811659454332928:53:0) after 1m0s
[13:44:35.868] Received PubSub notification, asking Buildbucket for the build status
[13:44:35.940] Build 8863381597332320944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:44:35.940] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605620673722263",
"created_by": "project:chromium",
"created_ts": "1605617636324087",
"id": "8863381597332320944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\"}}",
"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\": \"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-5-fw95\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15687, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"4f96bf19941b3842126eb047d0573a053648bbdc\", \"got_dawn_revision\": \"f2bc3b3edd6f3a8424b230b17f844f59768d53b8\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\", \"got_revision_cp\": \"refs/heads/master@{#828157}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04515da400d5fbc22d852af1369c4d46bd54991e\", \"got_v8_revision\": \"15247228bbf879eab29da6c7a0b1a608fccbc1fa\", \"got_v8_revision_cp\": \"refs/heads/8.9.4@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1d6b29cd85c1c3cba093b8b69b2727cc26eaac97\", \"swarm_hashes_refs/heads/master(at){#828157}_without_patch\": {\"absl_hardening_tests\": \"ddc021eb1ab1b8e3067c8ebe8c3e1bf29562813e\", \"accessibility_unittests\": \"9c9a5e9953fdbe41996a55f35ad4464cedc632c3\", \"angle_unittests\": \"7dae1d5eabb966447e47379525059b6ae32af03f\", \"app_shell_unittests\": \"66679d1bdd9d0672da4714b3340bbb35ed8f4da6\", \"aura_unittests\": \"d3295091f69a83528c0518bebedf62b87eded342\", \"base_unittests\": \"1323a0b6c691282e268402056f45fde64aa6f8aa\", \"base_util_unittests\": \"aa70745eca3c8119bcff18e7c1ccf659c3e8c350\", \"blink_common_unittests\": \"cbd60e6ce2c4c23673770d948f202f07dae7c4d0\", \"blink_fuzzer_unittests\": \"5196aa529031be0f4cd894496c9c3c4032707e47\", \"blink_heap_unittests\": \"e14407b49f7338152c1e78d58770d26c9083f85b\", \"blink_platform_unittests\": \"f12c2a6a73e251a0ce019bdfe47098e33033b23c\", \"blink_unittests\": \"c150b5830f049148760a5fc31f51206dede40a24\", \"boringssl_crypto_tests\": \"cb1231c21fc042aac5d39a7c9508e82db8502426\", \"boringssl_ssl_tests\": \"d1ab5c076b5ca433b9201f4707a1d6ad8332a046\", \"browser_switcher_bho_unittests\": \"c88d2b1814dec38b29875c732d910c7ac5275e07\", \"browser_tests\": \"8b81f355380bc8ad83d68661160aeeee8ad466c7\", \"capture_unittests\": \"eea470cd2033d2b0a93fdd7d6d7aff8b5d024816\", \"cast_unittests\": \"f0d3c9ba1bf6b6e1d8d5d7dd8e2d54baf0f57a56\", \"cc_unittests\": \"e97d932609ea18f2bfe160ad92d633491fe09e8a\", \"chrome_app_unittests\": \"01c037b59e301e1f62092743f59a4726069dbeb5\", \"chrome_cleaner_unittests\": \"c1bbef8eedb3c6f62cae775f6ddbc76a9f65e4e0\", \"chrome_elf_unittests\": \"a36201431719fa98863d3d76d074d0750d69456f\", \"chromedriver_unittests\": \"cbdb47c2baf15ceb2f5d67b305b72e5df4e0c7e9\", \"components_browsertests\": \"390b5c86236c31800164bc9c1f8fb33ca9e51be7\", \"components_unittests\": \"4c5edbd01eb39c2ff7ace6bee5d40424f5faf359\", \"compositor_unittests\": \"1e6fe57958729339c6dcb88379083920e0b21553\", \"content_browsertests\": \"0d4619f26b1ccad6f719637a1e3ba4afa5904c4e\", \"content_unittests\": \"cce01801f48a317cabe1aac66b4b53ed496bac7e\", \"courgette_unittests\": \"cf7eaa40162b280097609d051a8f804754ff52c6\", \"crashpad_tests\": \"0fb4a63179b48379010a13e9eb5691ac97194ee8\", \"cronet_tests\": \"6e4b6552598d03d3d945ad1c9f4f73a03740485a\", \"cronet_unittests\": \"2c7d1ee03b1f6eb86ca5f42ba806bdec079bcf5a\", \"crypto_unittests\": \"ec88f2844d353fcfe055b7565b28d397d6ad3327\", \"delayloads_unittests\": \"626b421baf949a708bfd44eb65bbcd926e66555d\", \"device_unittests\": \"40b25064038a118d1f841cfdae0540bd2bdcfdd1\", \"display_unittests\": \"a53477465770430120f5cd6a054bd0e849e29def\", \"elevation_service_unittests\": \"68320b42c2e2e1bbf9465ab216205c039c424ee7\", \"events_unittests\": \"5b95ef2db3be7ce323412c611976b5235ad2aedc\", \"extensions_browsertests\": \"5f1172341f30cd8bdce071235887fa5f3c3125a7\", \"extensions_unittests\": \"e449c6d49ac4b3ccdd2850c5e5e1386175c3f4fa\", \"filesystem_service_unittests\": \"48431ce3bedcd73c5664ab5eda3362e26f533106\", \"gcm_unit_tests\": \"37af9ea5494966c182d088d71c644caea5d7aa93\", \"gcp_unittests\": \"6a30757946fbd4d3df853fcfab668e92125817e3\", \"gfx_unittests\": \"1c6462096c564f346135ad617785c08329342be8\", \"gin_unittests\": \"765759000350342434ed40a632f6cbe6a5d6480a\", \"google_apis_unittests\": \"9d647bcc55ba9d217fc3c9ffa72168ca418c3db4\", \"gpu_unittests\": \"c0afb0c96c0789098074d76cd424029bedf56e7f\", \"gwp_asan_unittests\": \"52455896c29fddadcc8accfcf15e6f23db27a02f\", \"headless_browsertests\": \"1b3630912fe741c58834f6b61bb5a94502e75287\", \"headless_unittests\": \"1c8f40a633896a6568bd9291a0b8e888f8a86c39\", \"install_static_unittests\": \"81626381b5c1fba89af148b687cd834c489edbde\", \"installer_util_unittests\": \"dcf8865169f6990dc7b525acb9b0cb6cb0725001\", \"interactive_ui_tests\": \"df7f2278b1818cc5ee3b4ee38f46693e5cfb20ab\", \"ipc_tests\": \"a80da608093c1df9f7d7bd1baf06e9973208cdee\", \"jingle_unittests\": \"3c5d59ebb28a5793ce92a45188d937010831b58c\", \"latency_unittests\": \"be17a77a0c5b64f9fed0fc11cb66985ff0475753\", \"libjingle_xmpp_unittests\": \"be86001ce22f5bfb6db3e76a0bff511824888181\", \"liburlpattern_unittests\": \"c72629253b60c04695568931828eaf4a2005d79a\", \"media_blink_unittests\": \"9f796f671d077a6320c73877ee0415353c89eb24\", \"media_unittests\": \"2588b1651017a3229bf1caf5fc95a4c32dc461f9\", \"message_center_unittests\": \"5ee989af8ba8d37c8e4cd6835791f5ffed31b052\", \"midi_unittests\": \"2d746801604adc7734ce36f7b52f41b450e3d602\", \"mojo_core_unittests\": \"328ecf62eab7cc5e3f832d48f8bfe3b39aa915c5\", \"mojo_unittests\": \"86a289429c5f3cd0eb2968e0e88743d4b899375d\", \"nacl_loader_unittests\": \"41d78d241b68d140f40ff16b6a22b8ced72c591e\", \"native_theme_unittests\": \"b8a4071d23ccb41a847d0cccd6538b1277065eec\", \"net_unittests\": \"b575b75854d9bef9012afaed36e239218ebf6e3e\", \"notification_helper_unittests\": \"168bcf9f9fa631b0664c984322bb734665b8f82e\", \"pdf_unittests\": \"206765e58b041d0d8ed547a9d2546c8eb88af36b\", \"perfetto_unittests\": \"7657d2971dee3e208ce8b1c783572393c9ca0866\", \"ppapi_unittests\": \"e9447f8a8e22f5d6b77fe6b1ab91c710c4dc0089\", \"printing_unittests\": \"58f04c47a5b84b465ff298c913c0979b39023ca0\", \"remoting_unittests\": \"7257a09aafd0a86726fee0f5237085fd221a81d7\", \"sbox_integration_tests\": \"23993c0e8fe76eccf55514ad872d98dff3f45bf0\", \"sbox_unittests\": \"c750b8282e179d8d668216f1892c3226076f488b\", \"sbox_validation_tests\": \"811b84f51d8ddd102d5065762791eea2306fb26f\", \"service_manager_unittests\": \"e59c1ff2db4f4c22256236ebaec42a9374022e6a\", \"services_unittests\": \"13d4ec34383c15573d59b4729e1fff900286d974\", \"setup_unittests\": \"3d06a7c764ba956ad4a866b0956c8c4b1261ba55\", \"shell_dialogs_unittests\": \"138d5e7de96678ea82cbe7c2587ac5cbff27c318\", \"skia_unittests\": \"01c89cb6e7496c9382bbfe532ef33556634f61bb\", \"snapshot_unittests\": \"3b1ab56a38748d80e7762201c945cae23da7adff\", \"sql_unittests\": \"b5a5acec4d109e4b08bd1e9ad3cf7fe70414909d\", \"storage_unittests\": \"34b159bf1a0059160cc7957384558ac6899c791f\", \"sync_integration_tests\": \"6de71064eede720ef86c86caa74a7cc9f16f63a7\", \"traffic_annotation_auditor_unittests\": \"5237f5a0e75e810a5a62058c3c8892ef192840e7\", \"ui_base_unittests\": \"b11fee03076ac1e51339b881355e55995437bfaf\", \"ui_touch_selection_unittests\": \"e7c688979cb312ff76994c83eab56697d491d1e7\", \"unit_tests\": \"7ec5a9ba66561f1698a625b9f53982543b973656\", \"updater_tests\": \"5de3946f58b3adddb0b0a23a9e98b8ce47725231\", \"url_unittests\": \"fdff5f552723b6b9e6a908c1205a71003ae8cfcd\", \"views_unittests\": \"0a8b5b4bfe1eeee2f0369e68ff1e953e38cbe4cf\", \"viz_unittests\": \"7ec59aec0efbb5417333bea6bc68a786783aeb57\", \"vr_common_unittests\": \"5081471a1a12ced200e7d91262a6fc8d4eb25a92\", \"vr_pixeltests\": \"a7ea554625ca8671629670ca07b5d610901ed623\", \"weblayer_browsertests\": \"36a53c7d0caa823f5163c38e99dbb8e851fd4b4b\", \"weblayer_unittests\": \"c28d15608a9558a8483673beeec6126fb3d26b2e\", \"wm_unittests\": \"e395d3306c794a79bc2bc90cef03bef65155f6de\", \"wtf_unittests\": \"043f449b3c11db8f611ecd85d56d736092cf74a5\", \"zlib_unittests\": \"72a9931ec3faf8c41ea04632440b8c15c6d55d60\", \"zucchini_unittests\": \"1603099186c59fa35551d77ac292e18d1659fe0b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-5-fw95\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605617640549288",
"status": "COMPLETED",
"status_changed_ts": "1605620674200380",
"tags": [
"build_address:luci.chromium.ci/win-asan/15687",
"builder:win-asan",
"buildset:commit/git/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1d6b29cd85c1c3cba093b8b69b2727cc26eaac97",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028811659454332928",
"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/8863381597332320944/+/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:4fef165ed0b97f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605620674457796",
"url": "https://ci.chromium.org/b/8863381597332320944",
"utcnow_ts": "1605620675931662"
}
}
[13:44:35.940] Invocation finished in 50m41.023411419s with status SUCCEEDED