[19:55:00.262] New invocation is queued and will start shortly
[19:55:02.335] Starting the invocation (attempt 1)
[19:55:02.395] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:55:02.395] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:55:02.395] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027788600208926016",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6f5a045a7bae7cce612a73d65ffa941508b3708a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027788600208926016",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"gitiles_ref:refs/heads/master"
]
}
[19:55:03.114] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606593302494449",
"id": "8862358537202340960",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6f5a045a7bae7cce612a73d65ffa941508b3708a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606593302934791",
"tags": [
"build_address:luci.chromium.ci/win-asan/15915",
"builder:win-asan",
"buildset:commit/git/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027788600208926016",
"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/8862358537202340960/+/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": "1606593302934953",
"url": "https://ci.chromium.org/b/8862358537202340960",
"utcnow_ts": "1606593303100913"
}
}
[19:55:03.114] Task URL: https://ci.chromium.org/b/8862358537202340960
[19:55:03.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:2:0) after 1m0s
[19:55:07.653] Received PubSub notification, asking Buildbucket for the build status
[19:55:07.861] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:2:0)
[19:56:03.134] Timer tick, asking Buildbucket for the build status
[19:56:03.370] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:4:0) after 1m0s
[19:57:03.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:4:0)
[19:57:03.393] Timer tick, asking Buildbucket for the build status
[19:57:04.632] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:04.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:5:0) after 1m0s
[19:58:04.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:5:0)
[19:58:04.757] Timer tick, asking Buildbucket for the build status
[19:58:04.905] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:04.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:6:0) after 1m0s
[19:59:04.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:6:0)
[19:59:04.926] Timer tick, asking Buildbucket for the build status
[19:59:05.032] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:05.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:7:0) after 1m0s
[20:00:05.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:7:0)
[20:00:05.125] Timer tick, asking Buildbucket for the build status
[20:00:05.516] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:05.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:8:0) after 1m0s
[20:01:06.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:8:0)
[20:01:06.240] Timer tick, asking Buildbucket for the build status
[20:01:06.299] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:06.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:9:0) after 1m0s
[20:02:06.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:9:0)
[20:02:06.465] Timer tick, asking Buildbucket for the build status
[20:02:06.814] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:06.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:10:0) after 1m0s
[20:03:06.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:10:0)
[20:03:06.888] Timer tick, asking Buildbucket for the build status
[20:03:07.116] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:07.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:11:0) after 1m0s
[20:04:07.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:11:0)
[20:04:07.139] Timer tick, asking Buildbucket for the build status
[20:04:07.311] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:07.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:12:0) after 1m0s
[20:05:07.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:12:0)
[20:05:07.400] Timer tick, asking Buildbucket for the build status
[20:05:07.544] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:13:0) after 1m0s
[20:06:07.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:13:0)
[20:06:07.688] Timer tick, asking Buildbucket for the build status
[20:06:07.831] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:07.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:14:0) after 1m0s
[20:07:07.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:14:0)
[20:07:07.875] Timer tick, asking Buildbucket for the build status
[20:07:08.181] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:08.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:15:0) after 1m0s
[20:08:08.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:15:0)
[20:08:08.360] Timer tick, asking Buildbucket for the build status
[20:08:08.494] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:08.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:16:0) after 1m0s
[20:09:08.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:16:0)
[20:09:08.730] Timer tick, asking Buildbucket for the build status
[20:09:09.558] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:09.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:17:0) after 1m0s
[20:10:09.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:17:0)
[20:10:09.926] Timer tick, asking Buildbucket for the build status
[20:10:10.509] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:10.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:18:0) after 1m0s
[20:11:10.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:18:0)
[20:11:10.567] Timer tick, asking Buildbucket for the build status
[20:11:10.688] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:10.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:19:0) after 1m0s
[20:12:10.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:19:0)
[20:12:10.865] Timer tick, asking Buildbucket for the build status
[20:12:11.394] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:11.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:20:0) after 1m0s
[20:13:11.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:20:0)
[20:13:11.407] Timer tick, asking Buildbucket for the build status
[20:13:11.566] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:11.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:21:0) after 1m0s
[20:14:11.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:21:0)
[20:14:11.663] Timer tick, asking Buildbucket for the build status
[20:14:12.249] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:22:0) after 1m0s
[20:15:12.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:22:0)
[20:15:12.271] Timer tick, asking Buildbucket for the build status
[20:15:12.608] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:12.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:23:0) after 1m0s
[20:16:12.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:23:0)
[20:16:12.763] Timer tick, asking Buildbucket for the build status
[20:16:12.874] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:24:0) after 1m0s
[20:17:13.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:24:0)
[20:17:13.067] Timer tick, asking Buildbucket for the build status
[20:17:13.185] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:13.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:25:0) after 1m0s
[20:18:13.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:25:0)
[20:18:13.205] Timer tick, asking Buildbucket for the build status
[20:18:13.548] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:13.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:26:0) after 1m0s
[20:19:13.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:26:0)
[20:19:13.628] Timer tick, asking Buildbucket for the build status
[20:19:13.696] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:13.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:27:0) after 1m0s
[20:20:13.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:27:0)
[20:20:13.725] Timer tick, asking Buildbucket for the build status
[20:20:14.064] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:14.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:28:0) after 1m0s
[20:21:14.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:28:0)
[20:21:14.172] Timer tick, asking Buildbucket for the build status
[20:21:14.705] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:14.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:29:0) after 1m0s
[20:22:14.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:29:0)
[20:22:14.726] Timer tick, asking Buildbucket for the build status
[20:22:14.895] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:14.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:30:0) after 1m0s
[20:23:14.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:30:0)
[20:23:14.915] Timer tick, asking Buildbucket for the build status
[20:23:14.991] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:14.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:31:0) after 1m0s
[20:24:15.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:31:0)
[20:24:15.025] Timer tick, asking Buildbucket for the build status
[20:24:15.525] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:15.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:32:0) after 1m0s
[20:25:15.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:32:0)
[20:25:15.558] Timer tick, asking Buildbucket for the build status
[20:25:15.675] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:15.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:33:0) after 1m0s
[20:26:15.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:33:0)
[20:26:15.751] Timer tick, asking Buildbucket for the build status
[20:26:15.862] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:15.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:34:0) after 1m0s
[20:27:15.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:34:0)
[20:27:15.882] Timer tick, asking Buildbucket for the build status
[20:27:15.957] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:15.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:35:0) after 1m0s
[20:28:15.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:35:0)
[20:28:15.979] Timer tick, asking Buildbucket for the build status
[20:28:16.066] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:36:0) after 1m0s
[20:29:16.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:36:0)
[20:29:16.118] Timer tick, asking Buildbucket for the build status
[20:29:16.338] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:16.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:37:0) after 1m0s
[20:30:16.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:37:0)
[20:30:16.359] Timer tick, asking Buildbucket for the build status
[20:30:16.843] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:16.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:38:0) after 1m0s
[20:31:16.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:38:0)
[20:31:16.862] Timer tick, asking Buildbucket for the build status
[20:31:16.992] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:16.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:39:0) after 1m0s
[20:32:17.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:39:0)
[20:32:17.014] Timer tick, asking Buildbucket for the build status
[20:32:17.433] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:17.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:40:0) after 1m0s
[20:33:17.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:40:0)
[20:33:17.469] Timer tick, asking Buildbucket for the build status
[20:33:17.782] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:17.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:41:0) after 1m0s
[20:34:17.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:41:0)
[20:34:17.801] Timer tick, asking Buildbucket for the build status
[20:34:18.019] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:18.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:42:0) after 1m0s
[20:35:18.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:42:0)
[20:35:18.040] Timer tick, asking Buildbucket for the build status
[20:35:18.264] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:18.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:43:0) after 1m0s
[20:36:18.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:43:0)
[20:36:18.284] Timer tick, asking Buildbucket for the build status
[20:36:18.409] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:18.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:44:0) after 1m0s
[20:37:19.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:44:0)
[20:37:19.076] Timer tick, asking Buildbucket for the build status
[20:37:19.146] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:19.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:45:0) after 1m0s
[20:38:19.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:45:0)
[20:38:19.274] Timer tick, asking Buildbucket for the build status
[20:38:19.354] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:19.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:46:0) after 1m0s
[20:39:19.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:46:0)
[20:39:19.527] Timer tick, asking Buildbucket for the build status
[20:39:19.597] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:19.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:47:0) after 1m0s
[20:40:19.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:47:0)
[20:40:19.794] Timer tick, asking Buildbucket for the build status
[20:40:20.306] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:20.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:48:0) after 1m0s
[20:41:20.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:48:0)
[20:41:20.465] Timer tick, asking Buildbucket for the build status
[20:41:20.579] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:20.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:49:0) after 1m0s
[20:42:20.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:49:0)
[20:42:20.621] Timer tick, asking Buildbucket for the build status
[20:42:20.773] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:20.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:50:0) after 1m0s
[20:43:20.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:50:0)
[20:43:20.918] Timer tick, asking Buildbucket for the build status
[20:43:21.779] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:21.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:51:0) after 1m0s
[20:44:21.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:51:0)
[20:44:21.982] Timer tick, asking Buildbucket for the build status
[20:44:22.415] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:22.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:52:0) after 1m0s
[20:45:22.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:52:0)
[20:45:22.513] Timer tick, asking Buildbucket for the build status
[20:45:22.877] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:22.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:53:0) after 1m0s
[20:46:23.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:53:0)
[20:46:23.055] Timer tick, asking Buildbucket for the build status
[20:46:23.145] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:54:0) after 1m0s
[20:47:23.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:54:0)
[20:47:23.336] Timer tick, asking Buildbucket for the build status
[20:47:23.811] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:55:0) after 1m0s
[20:48:24.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:55:0)
[20:48:24.105] Timer tick, asking Buildbucket for the build status
[20:48:24.408] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:24.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:56:0) after 1m0s
[20:49:24.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:56:0)
[20:49:24.457] Timer tick, asking Buildbucket for the build status
[20:49:24.531] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:24.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:57:0) after 1m0s
[20:50:24.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:57:0)
[20:50:24.652] Timer tick, asking Buildbucket for the build status
[20:50:24.778] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:24.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:58:0) after 1m0s
[20:51:24.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:58:0)
[20:51:24.844] Timer tick, asking Buildbucket for the build status
[20:51:24.942] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:24.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:59:0) after 1m0s
[20:52:25.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:59:0)
[20:52:25.098] Timer tick, asking Buildbucket for the build status
[20:52:25.254] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:25.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:60:0) after 1m0s
[20:53:25.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:60:0)
[20:53:25.296] Timer tick, asking Buildbucket for the build status
[20:53:25.387] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:25.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:61:0) after 1m0s
[20:54:25.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:61:0)
[20:54:25.459] Timer tick, asking Buildbucket for the build status
[20:54:25.672] Build 8862358537202340960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027788600208926016:62:0) after 1m0s
[20:55:04.973] Received PubSub notification, asking Buildbucket for the build status
[20:55:05.035] Build 8862358537202340960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:55:05.035] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606596903955254",
"created_by": "project:chromium",
"created_ts": "1606593302494449",
"id": "8862358537202340960",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6f5a045a7bae7cce612a73d65ffa941508b3708a\"}}",
"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\": \"6f5a045a7bae7cce612a73d65ffa941508b3708a\", \"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-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15915, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"59aa1ef1975ae2d263da864f111eaaa7cdb4f9f2\", \"got_dawn_revision\": \"d8bb0bb7c735173219d7a8ffec18eee1813ff302\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6f5a045a7bae7cce612a73d65ffa941508b3708a\", \"got_revision_cp\": \"refs/heads/master@{#831694}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"8d791670ba247239ef6ce9091183f11f8c5f0825\", \"got_v8_revision_cp\": \"refs/heads/8.9.65@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"6f5a045a7bae7cce612a73d65ffa941508b3708a\", \"swarm_hashes_refs/heads/master(at){#831694}_without_patch\": {\"absl_hardening_tests\": \"9509b936e1e93db1fce16ea3976e7b806fa31537\", \"accessibility_unittests\": \"391baa3cd046b05196f8754201eeb2699131712a\", \"angle_unittests\": \"dcdf3196b9f347ab7ae5d8cd94f00f107010f3fc\", \"app_shell_unittests\": \"f16aaa0837340ed39b9823c0504765714056a8d1\", \"aura_unittests\": \"1691c47686db80c91d83d0c215e28df7c9bace73\", \"base_unittests\": \"5a01b95113ab79435dbfddcab08da0c597f9d643\", \"base_util_unittests\": \"e1edb8c892de0e4d36b3c3c2f659ff90d64b953e\", \"blink_common_unittests\": \"d983d8354a445d6119c2475b8ebe8e3c73925f2d\", \"blink_fuzzer_unittests\": \"2395ddc09cd592bdfecfac54f959f7b5875541db\", \"blink_heap_unittests\": \"a78b5905c89d88a85c1f0405178023168fa83d1d\", \"blink_platform_unittests\": \"7f3834d71a314913ae6e34159608780774180293\", \"blink_unittests\": \"0a8d96ba52aea0c56bd99b5a50087469f609a186\", \"boringssl_crypto_tests\": \"5ed56e4294391e789e6334bd8b4ef89d7801bb84\", \"boringssl_ssl_tests\": \"a27883cf305210b0c6c718c7620aa55d333fe9b6\", \"browser_switcher_bho_unittests\": \"aa682e26dbaf4ea03d16a9b39852f1951574bd4a\", \"browser_tests\": \"f17e068561d31c84b70958a014bafdb991a98c32\", \"capture_unittests\": \"8d0c9495287698a41d50392ef9130836dfe4aa62\", \"cast_unittests\": \"6c856b1270bfbef243a984671a10fb8514239466\", \"cc_unittests\": \"c20a42ae99f67d0237564c8507e73fe8fe68688b\", \"chrome_app_unittests\": \"560a4feec6292040e9b83345a1d9db3f0e86de2d\", \"chrome_cleaner_unittests\": \"e2cc2c3acc45b2afa342ef5b945b57f83ed45fff\", \"chrome_elf_unittests\": \"028b5148ae60725794e7e3cc446c09518d6c378f\", \"chromedriver_unittests\": \"d3a078f844c396f40ae22863511ad02c4ad48639\", \"components_browsertests\": \"c9c099ee79ec85bc0dfa2451efa499a100b2073e\", \"components_unittests\": \"c74fbc547f22cbb6a877fa92b0231ace17e173a4\", \"compositor_unittests\": \"619157971ed7769e7306444f76c3a23c2693a031\", \"content_browsertests\": \"df602be6eb3d30788f1f3126cafb61e404d70ad7\", \"content_unittests\": \"0512726695992c2e2549e3ca8ec003d011abbfc3\", \"courgette_unittests\": \"da8dcd05044e7e94cf2f9c858ac5f00f0abd6e74\", \"crashpad_tests\": \"4231be2777e5527e07ac488ad2db6c4b31d13bb9\", \"cronet_tests\": \"df26c56887d3cceb2272a39c7f9ef404352e56fb\", \"cronet_unittests\": \"4fc1669278d80d23f2c01e6e2edff287f8f3bf14\", \"crypto_unittests\": \"9e3e9ea2685b65b9eb88cbd73754461955da9d30\", \"delayloads_unittests\": \"1671a0a7a9b23e6098079e0bc861f1838c9388c4\", \"device_unittests\": \"695a98d43d640fa06691710b92484b2dc9484cda\", \"display_unittests\": \"53ec82f6709dfcc008547c67a5585ea474c2e778\", \"elevation_service_unittests\": \"767e55cf92a382856644594dd2a2cb43be0bed0e\", \"events_unittests\": \"be28174d738f3e2cefd7c925af0db7663e145dfe\", \"extensions_browsertests\": \"97765754b39b1a819f414739ec4e2676721fcc63\", \"extensions_unittests\": \"d480fa87b86d16a70546dc9e4868a70a33733e19\", \"filesystem_service_unittests\": \"d1e63234bd7d7474b8acea6e3d983322a473cd05\", \"gcm_unit_tests\": \"cbe838d0ad94342aca582994e20d29d748bd3adb\", \"gcp_unittests\": \"c8c24e0cf7886e2354014666b8d42fe8ebb616d7\", \"gfx_unittests\": \"efaf5998b461b1fc82c2b75c93b2fb4f0fbe3576\", \"gin_unittests\": \"49c893b177577058993259734c659e4e8e27065a\", \"google_apis_unittests\": \"fb1caf24abc10653464bf8534e48bda1ba25d5ec\", \"gpu_unittests\": \"5fa366bfc7afbf45bd28c43b1016e646f4c7491a\", \"gwp_asan_unittests\": \"8e1650ed78e7489fc10981a41cfb88d6d0553c0d\", \"headless_browsertests\": \"61dd67fc3d2a07b9da4ed2d5ba4e7b6c35e2b5d0\", \"headless_unittests\": \"9b9459c4e5693b67891c591ce75ca776fdcc9a42\", \"install_static_unittests\": \"4f06fd7cae9a0785251a69a5418db0a43c0ae683\", \"installer_util_unittests\": \"82a7852283b4bdaacc7052a04b175e33d1ebfe58\", \"interactive_ui_tests\": \"f59e12165bd456f0eb3301137e85cc937b7f67eb\", \"ipc_tests\": \"a712b449ffedb6fc8300d2a58ea0e1bad4b3002f\", \"jingle_unittests\": \"678e662a1cf9e04f3cf88e38a152b3e70edf4231\", \"latency_unittests\": \"9edfaf8b59423640cf423bae5dc56120de657f12\", \"libjingle_xmpp_unittests\": \"e94ecbfca99448bdb459f44e8cd7d438a5898f71\", \"liburlpattern_unittests\": \"8becd94e286821bb962ffb78b9bd9710d57e7d26\", \"media_blink_unittests\": \"9066253cf7e99a2b1749604477ab0f44b5c0888f\", \"media_unittests\": \"6cd51dba2cb2323ab9944741059508af15f0f6e7\", \"message_center_unittests\": \"18062bb6f7901fedc8c8ef3c98003ab37b5e9971\", \"midi_unittests\": \"96e97a0e8e674ff4b84323203597ae712adbdb85\", \"mojo_core_unittests\": \"eab4948b2421d413e680f349c9c1c29333dfae06\", \"mojo_unittests\": \"59aa4a141673767cda26dc928a6fc566ef52f913\", \"nacl_loader_unittests\": \"7d780dde9aa005e09188a68e45caf53683aaf514\", \"native_theme_unittests\": \"37154487a98106d8cb12a39e3a78d24fa7bef259\", \"net_unittests\": \"bf7972a8141477417ab490df8dd2931a7725096a\", \"notification_helper_unittests\": \"915a9494d496e06af9fb9cccf7ed515eb29a9d43\", \"pdf_unittests\": \"dc251072319ebb0c69e105bce747b932a5b8a40a\", \"perfetto_unittests\": \"70f78ad0db5bbbaf7d9f463b30801e25143462e8\", \"ppapi_unittests\": \"402ea77e5e11f1b58045308df3c467b67d898639\", \"printing_unittests\": \"b0f375c2c8dad9d7cf57d49780609d8e9314cf34\", \"remoting_unittests\": \"ee5c568d70fbb519280a78eef4eb8f3c35b4833a\", \"sbox_integration_tests\": \"68c581528953aeda37be48e488fee96c586ecbed\", \"sbox_unittests\": \"22c289e956baad152bdc70ab7664ab33c693f45f\", \"sbox_validation_tests\": \"b416829327ac687f70ff60f4b1a1611db6cf232e\", \"service_manager_unittests\": \"a4d4d78014dea33f478b5b3b315941bda99bc840\", \"services_unittests\": \"295737cf40ca1bedda48836efb2a71f86dc1b8d4\", \"setup_unittests\": \"f6f3549094747771ae0d66a62469479ad0959d52\", \"shell_dialogs_unittests\": \"57c34cf58f425e971fb620b6e23deecdb0b34b06\", \"skia_unittests\": \"2df010c370cb2792b0b44db8cc43b071c9ffd137\", \"snapshot_unittests\": \"ed40c188d288394d01fd11db9c0c5dc3e555e6ed\", \"sql_unittests\": \"7b0b80233e090efbfd19e40755d8efd562140154\", \"storage_unittests\": \"f51bc661f93c214951d7ee29dd7dcea7bc84c423\", \"sync_integration_tests\": \"e4dee1ababa4cddac7a64261b44c5cd298e876b8\", \"traffic_annotation_auditor_unittests\": \"800382fced7db2a2f7ef124265eb1b415fb9e7ba\", \"ui_base_unittests\": \"654eeb583abaeeadea65114bfd3506414f1cf0f0\", \"ui_touch_selection_unittests\": \"caedce3cfcef480cafd2e0f30c307c3473fc85e0\", \"unit_tests\": \"fce6050dadbdea27511dedb5e131936052d538c9\", \"updater_tests\": \"2e898408abfbeafb370483c56560953c455f0ad8\", \"url_unittests\": \"48fde9671b7bf1b2fb43f6edaa2e0e7f02a90166\", \"views_unittests\": \"d686b43f6724be578aaa0ecb4f37e6b1810d258e\", \"viz_unittests\": \"ea7ee2bbed4668d7e8dc113232bb1119b3bed566\", \"vr_common_unittests\": \"9fe47fcc85bf58300a59080cdc59dc5ad6e16add\", \"vr_pixeltests\": \"3d639e6195ea0f431a4e8739986628d27e0e6630\", \"weblayer_browsertests\": \"71a059785eea71220270832a1322571b98c31f17\", \"weblayer_unittests\": \"4d5207523da925c7971df8c760e5a59ceb56ea78\", \"wm_unittests\": \"b4d04832a7e1383ad3768c638806620675efce97\", \"wtf_unittests\": \"22ced23887b85c5744ef8230688fb64418c16333\", \"zlib_unittests\": \"074656959fac523a08e63074e3c144b21b39257d\", \"zucchini_unittests\": \"fd55c3644f4239fdc58c5ad73a1ee0f9fa7b528f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"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-4-qhsy\"], \"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\": [\"5640-d0eb544\"], \"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": "1606593304926809",
"status": "COMPLETED",
"status_changed_ts": "1606596904470907",
"tags": [
"build_address:luci.chromium.ci/win-asan/15915",
"builder:win-asan",
"buildset:commit/git/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6f5a045a7bae7cce612a73d65ffa941508b3708a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027788600208926016",
"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/8862358537202340960/+/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:50293dda8e0a8410",
"user_agent:luci-scheduler"
],
"updated_ts": "1606596904478593",
"url": "https://ci.chromium.org/b/8862358537202340960",
"utcnow_ts": "1606596905026351"
}
}
[20:55:05.035] Invocation finished in 1h0m4.791501269s with status SUCCEEDED