[05:00:01.251] New invocation is queued and will start shortly
[05:00:03.543] Starting the invocation (attempt 1)
[05:00:03.602] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:03.602] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:03.602] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028026101634535232",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028026101634535232",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"gitiles_ref:refs/heads/master"
]
}
[05:00:05.324] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606366803759273",
"id": "8862596038340059056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606366805007218",
"tags": [
"build_address:luci.chromium.ci/win-asan/15855",
"builder:win-asan",
"buildset:commit/git/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028026101634535232",
"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/8862596038340059056/+/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": "1606366805009262",
"url": "https://ci.chromium.org/b/8862596038340059056",
"utcnow_ts": "1606366805314064"
}
}
[05:00:05.324] Task URL: https://ci.chromium.org/b/8862596038340059056
[05:00:05.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:2:0) after 1m0s
[05:00:07.880] Received PubSub notification, asking Buildbucket for the build status
[05:00:08.510] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:05.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:2:0)
[05:01:05.593] Timer tick, asking Buildbucket for the build status
[05:01:06.412] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:06.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:4:0) after 1m0s
[05:02:06.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:4:0)
[05:02:06.530] Timer tick, asking Buildbucket for the build status
[05:02:06.633] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:06.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:5:0) after 1m0s
[05:03:06.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:5:0)
[05:03:06.668] Timer tick, asking Buildbucket for the build status
[05:03:06.852] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:06.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:6:0) after 1m0s
[05:04:06.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:6:0)
[05:04:06.931] Timer tick, asking Buildbucket for the build status
[05:04:07.039] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:07.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:7:0) after 1m0s
[05:05:07.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:7:0)
[05:05:07.098] Timer tick, asking Buildbucket for the build status
[05:05:07.202] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:8:0) after 1m0s
[05:06:07.237] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:8:0)
[05:06:07.237] Timer tick, asking Buildbucket for the build status
[05:06:07.315] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:07.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:9:0) after 1m0s
[05:07:07.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:9:0)
[05:07:07.339] Timer tick, asking Buildbucket for the build status
[05:07:07.423] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:10:0) after 1m0s
[05:08:07.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:10:0)
[05:08:07.518] Timer tick, asking Buildbucket for the build status
[05:08:07.601] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:07.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:11:0) after 1m0s
[05:09:07.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:11:0)
[05:09:07.708] Timer tick, asking Buildbucket for the build status
[05:09:07.914] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:07.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:12:0) after 1m0s
[05:10:07.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:12:0)
[05:10:07.966] Timer tick, asking Buildbucket for the build status
[05:10:08.072] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:08.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:13:0) after 1m0s
[05:11:08.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:13:0)
[05:11:08.092] Timer tick, asking Buildbucket for the build status
[05:11:08.309] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:08.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:14:0) after 1m0s
[05:12:08.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:14:0)
[05:12:08.403] Timer tick, asking Buildbucket for the build status
[05:12:08.460] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:08.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:15:0) after 1m0s
[05:13:08.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:15:0)
[05:13:08.633] Timer tick, asking Buildbucket for the build status
[05:13:08.736] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:08.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:16:0) after 1m0s
[05:14:08.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:16:0)
[05:14:08.840] Timer tick, asking Buildbucket for the build status
[05:14:08.992] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:08.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:17:0) after 1m0s
[05:15:09.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:17:0)
[05:15:09.051] Timer tick, asking Buildbucket for the build status
[05:15:09.176] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:09.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:18:0) after 1m0s
[05:16:09.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:18:0)
[05:16:09.231] Timer tick, asking Buildbucket for the build status
[05:16:09.435] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:09.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:19:0) after 1m0s
[05:17:09.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:19:0)
[05:17:09.455] Timer tick, asking Buildbucket for the build status
[05:17:09.743] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:09.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:20:0) after 1m0s
[05:18:10.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:20:0)
[05:18:10.102] Timer tick, asking Buildbucket for the build status
[05:18:10.238] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:10.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:21:0) after 1m0s
[05:19:10.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:21:0)
[05:19:10.291] Timer tick, asking Buildbucket for the build status
[05:19:10.449] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:10.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:22:0) after 1m0s
[05:20:10.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:22:0)
[05:20:10.541] Timer tick, asking Buildbucket for the build status
[05:20:10.641] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:10.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:23:0) after 1m0s
[05:21:10.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:23:0)
[05:21:10.678] Timer tick, asking Buildbucket for the build status
[05:21:10.778] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:10.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:24:0) after 1m0s
[05:22:10.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:24:0)
[05:22:10.862] Timer tick, asking Buildbucket for the build status
[05:22:10.995] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:10.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:25:0) after 1m0s
[05:23:11.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:25:0)
[05:23:11.027] Timer tick, asking Buildbucket for the build status
[05:23:11.244] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:11.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:26:0) after 1m0s
[05:24:11.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:26:0)
[05:24:11.505] Timer tick, asking Buildbucket for the build status
[05:24:11.672] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:11.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:27:0) after 1m0s
[05:25:11.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:27:0)
[05:25:11.849] Timer tick, asking Buildbucket for the build status
[05:25:12.014] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:12.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:28:0) after 1m0s
[05:26:12.083] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:28:0)
[05:26:12.083] Timer tick, asking Buildbucket for the build status
[05:26:12.233] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:12.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:29:0) after 1m0s
[05:27:12.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:29:0)
[05:27:12.493] Timer tick, asking Buildbucket for the build status
[05:27:12.555] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:12.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:30:0) after 1m0s
[05:28:12.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:30:0)
[05:28:12.649] Timer tick, asking Buildbucket for the build status
[05:28:12.770] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:12.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:31:0) after 1m0s
[05:29:12.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:31:0)
[05:29:12.863] Timer tick, asking Buildbucket for the build status
[05:29:12.932] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:12.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:32:0) after 1m0s
[05:30:12.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:32:0)
[05:30:12.955] Timer tick, asking Buildbucket for the build status
[05:30:13.073] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:13.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:33:0) after 1m0s
[05:31:13.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:33:0)
[05:31:13.133] Timer tick, asking Buildbucket for the build status
[05:31:13.267] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:13.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:34:0) after 1m0s
[05:32:13.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:34:0)
[05:32:13.307] Timer tick, asking Buildbucket for the build status
[05:32:13.373] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:13.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:35:0) after 1m0s
[05:33:13.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:35:0)
[05:33:13.455] Timer tick, asking Buildbucket for the build status
[05:33:13.880] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:13.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:36:0) after 1m0s
[05:34:13.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:36:0)
[05:34:13.934] Timer tick, asking Buildbucket for the build status
[05:34:14.088] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:14.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:37:0) after 1m0s
[05:35:14.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:37:0)
[05:35:14.240] Timer tick, asking Buildbucket for the build status
[05:35:14.372] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:14.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:38:0) after 1m0s
[05:36:14.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:38:0)
[05:36:14.495] Timer tick, asking Buildbucket for the build status
[05:36:14.577] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:14.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:39:0) after 1m0s
[05:37:14.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:39:0)
[05:37:14.716] Timer tick, asking Buildbucket for the build status
[05:37:15.018] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:40:0) after 1m0s
[05:38:15.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:40:0)
[05:38:15.095] Timer tick, asking Buildbucket for the build status
[05:38:15.979] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:15.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:41:0) after 1m0s
[05:39:16.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:41:0)
[05:39:16.005] Timer tick, asking Buildbucket for the build status
[05:39:16.073] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:42:0) after 1m0s
[05:40:16.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:42:0)
[05:40:16.137] Timer tick, asking Buildbucket for the build status
[05:40:16.353] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:16.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:43:0) after 1m0s
[05:41:16.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:43:0)
[05:41:16.379] Timer tick, asking Buildbucket for the build status
[05:41:16.461] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:16.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:44:0) after 1m0s
[05:42:16.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:44:0)
[05:42:16.527] Timer tick, asking Buildbucket for the build status
[05:42:17.250] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:17.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:45:0) after 1m0s
[05:43:17.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:45:0)
[05:43:17.402] Timer tick, asking Buildbucket for the build status
[05:43:18.165] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:18.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:46:0) after 1m0s
[05:44:18.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:46:0)
[05:44:18.217] Timer tick, asking Buildbucket for the build status
[05:44:18.785] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:47:0) after 1m0s
[05:45:18.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:47:0)
[05:45:18.841] Timer tick, asking Buildbucket for the build status
[05:45:18.959] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:18.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:48:0) after 1m0s
[05:46:19.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:48:0)
[05:46:19.060] Timer tick, asking Buildbucket for the build status
[05:46:19.133] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:19.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:49:0) after 1m0s
[05:47:19.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:49:0)
[05:47:19.146] Timer tick, asking Buildbucket for the build status
[05:47:19.242] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:19.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:50:0) after 1m0s
[05:48:19.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:50:0)
[05:48:19.277] Timer tick, asking Buildbucket for the build status
[05:48:19.352] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:19.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:51:0) after 1m0s
[05:49:19.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:51:0)
[05:49:19.383] Timer tick, asking Buildbucket for the build status
[05:49:19.711] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:19.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:52:0) after 1m0s
[05:50:19.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:52:0)
[05:50:19.719] Timer tick, asking Buildbucket for the build status
[05:50:19.854] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:19.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:53:0) after 1m0s
[05:51:19.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:53:0)
[05:51:19.976] Timer tick, asking Buildbucket for the build status
[05:51:20.059] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:20.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:54:0) after 1m0s
[05:52:20.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:54:0)
[05:52:20.097] Timer tick, asking Buildbucket for the build status
[05:52:20.176] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:20.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:55:0) after 1m0s
[05:53:20.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:55:0)
[05:53:20.322] Timer tick, asking Buildbucket for the build status
[05:53:20.731] Build 8862596038340059056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:20.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028026101634535232:56:0) after 1m0s
[05:53:34.630] Received PubSub notification, asking Buildbucket for the build status
[05:53:34.880] Build 8862596038340059056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:53:34.880] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606370013824933",
"created_by": "project:chromium",
"created_ts": "1606366803759273",
"id": "8862596038340059056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\"}}",
"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\": \"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\", \"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-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15855, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"4dba276776bda27af2e6422f699b0c3429399e24\", \"got_dawn_revision\": \"9175f00eec91c6c9b3c3e264d6d8ec7879881844\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\", \"got_revision_cp\": \"refs/heads/master@{#831254}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"fe46597df7664f8fe317c2363cfad28007283e75\", \"got_v8_revision_cp\": \"refs/heads/8.9.53@{#1}\", \"got_webrtc_revision\": \"b6b599fc588e59142df343d2d2897203468aacea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32695}\", \"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\": \"7ed8f6034d055aac3c44c74e22427da95e3f4a9e\", \"swarm_hashes_refs/heads/master(at){#831254}_without_patch\": {\"absl_hardening_tests\": \"4918cbf3c3edab1c87acb76a873882c9292f27b4\", \"accessibility_unittests\": \"662428b620e68d173a16ad7abd0fd6c5a810133b\", \"angle_unittests\": \"c0d7782a296298494db850c4a05b6f5e45dfe07b\", \"app_shell_unittests\": \"7c4d64cc68548e6b50348667a10e2859d8656245\", \"aura_unittests\": \"b279e2f374f9d6bf2ed392615955a06f02f4a28c\", \"base_unittests\": \"e2cc0c1af0365fab6045d4a23ebfb18957350b1b\", \"base_util_unittests\": \"f2faad506e8960d05b5a556e4601ca50481753c0\", \"blink_common_unittests\": \"9535f0a7f6d71c7fe73aabfa9ecc01d8bfbbba2f\", \"blink_fuzzer_unittests\": \"b198d4657f13f60f22a726537cead3ec3c6ff527\", \"blink_heap_unittests\": \"3a50a41b16cd67760368c8e6827575d956550f53\", \"blink_platform_unittests\": \"a887a4f950e26f76e863ba12598bd9d11fbda44d\", \"blink_unittests\": \"26fef985cd96262d49a01f1e71a71bc81f16bfab\", \"boringssl_crypto_tests\": \"0e827e55fc4e902fa13394e2f03e33411768509b\", \"boringssl_ssl_tests\": \"f5bafeaad5a9507e0f4a3d43b17cad33e6abed40\", \"browser_switcher_bho_unittests\": \"a5bb0313c3a39326e0b81dcd07d392ff5108f11d\", \"browser_tests\": \"398ce3ce90ed387aea105219555c26c70a266462\", \"capture_unittests\": \"7fe8250318576f64408e2fdb04b2e88a7e5271f1\", \"cast_unittests\": \"629e5b92629ebe9939b3c6f2c3841a7a404e3856\", \"cc_unittests\": \"715cf48dd7a81492dda9f13693c3cfd9fc2b55a3\", \"chrome_app_unittests\": \"af2a0bd08442ce7bc21090d32ac7637cd8382adb\", \"chrome_cleaner_unittests\": \"0391ab25849c1ba174255a8992320a82468a9447\", \"chrome_elf_unittests\": \"83e1ada018d2906fac554ffe3184dafa467cb1fd\", \"chromedriver_unittests\": \"0738761e630e06a080646866c3c3524da2344b42\", \"components_browsertests\": \"91a1ac5085ec5e03a877377a003d9e070a29869b\", \"components_unittests\": \"464ce4b0670dc0aca5d8b467a96cd5de42d079e4\", \"compositor_unittests\": \"fdf7b2c71d5d617a882cea1514559fde20378deb\", \"content_browsertests\": \"f1d0105593e7fc80422251d1d356f52a065c1947\", \"content_unittests\": \"f2a407f267a4acd17dd0cf32883c4e3278628744\", \"courgette_unittests\": \"284223375255c857f179d5b5d744b7d8c7e0a7da\", \"crashpad_tests\": \"4911d21512ce5f37058f487327aac13a35b0f9b0\", \"cronet_tests\": \"54b472d33e8451fa4f3257aba70ce09fc49f8a87\", \"cronet_unittests\": \"1bf70783610d4292df3233518fc3519c004f4573\", \"crypto_unittests\": \"b60c8b269ab5cbd5d16515aed6b5c6eb80a9d8cf\", \"delayloads_unittests\": \"760d4941bf91c690413fa41c8b2cb036cf978512\", \"device_unittests\": \"d550ae6326fe5f36bb7cb22230d2abf89316f8e1\", \"display_unittests\": \"225e36de29502813bad96ea5d23f52684d71cb81\", \"elevation_service_unittests\": \"5f64d235285f307e816f3c87a5bf447e7fe281a3\", \"events_unittests\": \"422a458b96d8b463a6c6083fa9efcf07960d30d1\", \"extensions_browsertests\": \"71901384df03d37cef7f6fd5122e9d682ac02fbb\", \"extensions_unittests\": \"66df23452469c4379683a24a2e1912f10a86b25a\", \"filesystem_service_unittests\": \"a9f9e7617bccdc1fd98da88c5146c0a3ab9e894e\", \"gcm_unit_tests\": \"292eaa2636eb7b01f2ce57526438dbb5d907b959\", \"gcp_unittests\": \"7b5890a708ad648c2a95a2b11f5182386101e21f\", \"gfx_unittests\": \"e831af53d5e6e5c4957d68b7e451a532a6612b67\", \"gin_unittests\": \"6a9ba7a2598abbb0b894d2fd43db19839ffe944b\", \"google_apis_unittests\": \"72fea5a3d283115d51f8d1bf86149088caf9ef4d\", \"gpu_unittests\": \"eaaa81bdd5ee0986380f62442a2b36f26ac1ce2b\", \"gwp_asan_unittests\": \"442cc9d9695a33aa9e4b47cfe7691a62ac1cff6a\", \"headless_browsertests\": \"eed743065cfbc90dc6ebe0cfaa7f5d4754d6fcb3\", \"headless_unittests\": \"2650de3c1f2f78243ed46006fe41639fa0218879\", \"install_static_unittests\": \"299d718239d35cbe735db999f57ae89df5fdd449\", \"installer_util_unittests\": \"0b975b0ceb71d1a491f5b48fb0b4d5dfee369c45\", \"interactive_ui_tests\": \"9f819b65f6343b782fe0bb19b861be1884233718\", \"ipc_tests\": \"e77ce0d30e157e5ea79679b1aaf0fcce3ced4e53\", \"jingle_unittests\": \"e51b384d307172b60b61299668c783d8849a4e7b\", \"latency_unittests\": \"3cb1d7d395211530310460cf372b0ee1abdac5b4\", \"libjingle_xmpp_unittests\": \"704cdaa97564de191c3e23a624cf82ec1b76436a\", \"liburlpattern_unittests\": \"addd143253a68b70bd267c328dc7b278ce399bdc\", \"media_blink_unittests\": \"2f67d4d05df8dc607c56e47ee3c5b21aeb178c41\", \"media_unittests\": \"678d688be73ff941d5bff620c2f1f34c5c956b1f\", \"message_center_unittests\": \"8db1f954338483045b8e6c7f457345f6252a0e8f\", \"midi_unittests\": \"a3ca27adf3bd4281c1d88b19df3887b3622adaaf\", \"mojo_core_unittests\": \"8f53b1c31ac6bb56abeae484e1c934caadfd284e\", \"mojo_unittests\": \"93b2ae8d8528e12d1f2f1f4d762bb059e5ea98bb\", \"nacl_loader_unittests\": \"5d7b2c01736fabd786845a4ec8684b949948c5e8\", \"native_theme_unittests\": \"dee0abba79f7477061ba2665084e1f948706a8fe\", \"net_unittests\": \"5308ab86ed24ecf29c35a2938281e119cc260b3a\", \"notification_helper_unittests\": \"93fdd6e39ba11d0a8acd3378c7f7876e589e3d5f\", \"pdf_unittests\": \"fb2346a4da4fe697fe6da6ef6131685a7c746d5c\", \"perfetto_unittests\": \"06cc46c36cb35a66cef349ece22cb4a4df0ae921\", \"ppapi_unittests\": \"822587d432c90ead0fb0c4be968409f7dc3da662\", \"printing_unittests\": \"10ccd11aa20f682ab3417d53e8b7e5aa25f163df\", \"remoting_unittests\": \"a4af79e72e80eecb55e9c8fb7508453950913353\", \"sbox_integration_tests\": \"3d05f8daa22b372a3695f6bba44e92f9c8ff2146\", \"sbox_unittests\": \"8ced15b44acad9236cb2cc4d34b0c9177a59a510\", \"sbox_validation_tests\": \"e774629355cfe75dc4a60b45f98235534d3c76ce\", \"service_manager_unittests\": \"ab533cb557e6bb46a627906618a48fa59e9b6d98\", \"services_unittests\": \"3e69e97b813f66d582caed85e1fe97224240bd72\", \"setup_unittests\": \"3be1b336d403ef35dd96ce559c66d8dfab4d2454\", \"shell_dialogs_unittests\": \"4b6d305a22bcbb950592acfbfa4f22155423cd51\", \"skia_unittests\": \"fb20072ae27dc163cbbed23750a6baa5696bcb41\", \"snapshot_unittests\": \"ab8a39fb157b43cd21711a0346a162b506229028\", \"sql_unittests\": \"b8fc17e2e37ec3f190fc44c2997748515fe1d89e\", \"storage_unittests\": \"bca1dafbf265053b4ca202a7129d3247245e6f02\", \"sync_integration_tests\": \"18b7710da79bda44022a4bc3f5fa3dea66d54511\", \"traffic_annotation_auditor_unittests\": \"722f4c7bbe420316c069fa9428bb68c1ee7218cc\", \"ui_base_unittests\": \"59aa1c4846c204c40f8906ff45c7c3a87a0240d9\", \"ui_touch_selection_unittests\": \"6df4f737c30ee779170da5195483fb2e5afdf604\", \"unit_tests\": \"789336f5c09cffb86ed668d488d5c3e425622062\", \"updater_tests\": \"605632cd4fe3ee8132bf5732178d936f63a113ed\", \"url_unittests\": \"df7e2dad1293c323f2e18a0b339b99bbd2ec33f8\", \"views_unittests\": \"05c12267e007d340f612d3a302dcd2207b5236cd\", \"viz_unittests\": \"9e122639b4828d8e2ce5487f953f1e5c59b6dfa6\", \"vr_common_unittests\": \"ebe812d275d01f4910465212c223b1b892e1a448\", \"vr_pixeltests\": \"ea004babaa78600af2b76f02b12ee5ef738ffa7d\", \"weblayer_browsertests\": \"ee126be9b689fb1475bb35519c4b90f696dce889\", \"weblayer_unittests\": \"f98ab07e79294f51e43d26d6e9bc8b58f2d54176\", \"wm_unittests\": \"30750e0a46ebc5cdb7889b2515e2880350da5267\", \"wtf_unittests\": \"38ad0aa0f391c586f3208709f334e28e50e9dc8d\", \"zlib_unittests\": \"ae081cdc6616c7d5495bc914ec29510c4239628f\", \"zucchini_unittests\": \"431fa5b1301e96b6cba4757387fc4406e0a98d86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-6-2gr3\"], \"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": "1606366806973700",
"status": "COMPLETED",
"status_changed_ts": "1606370014125795",
"tags": [
"build_address:luci.chromium.ci/win-asan/15855",
"builder:win-asan",
"buildset:commit/git/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ed8f6034d055aac3c44c74e22427da95e3f4a9e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028026101634535232",
"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/8862596038340059056/+/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:501bbdc700edae10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606370014130018",
"url": "https://ci.chromium.org/b/8862596038340059056",
"utcnow_ts": "1606370014869751"
}
}
[05:53:34.880] Invocation finished in 53m33.647313737s with status SUCCEEDED