[07:21:45.231] New invocation is queued and will start shortly
[07:21:46.449] Starting the invocation (attempt 1)
[07:21:46.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:21:46.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:21:46.486] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018413906126134464",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018413906126134464",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"gitiles_ref:refs/heads/master"
]
}
[07:21:47.505] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615533706595033",
"id": "8852983844031981888",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615533707026492",
"tags": [
"build_address:luci.chromium.ci/win-asan/17767",
"builder:win-asan",
"buildset:commit/git/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018413906126134464",
"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/8852983844031981888/+/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": "1615533707026662",
"url": "https://ci.chromium.org/b/8852983844031981888",
"utcnow_ts": "1615533707443305"
}
}
[07:21:47.505] Task URL: https://ci.chromium.org/b/8852983844031981888
[07:21:47.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:2:0) after 1m0s
[07:21:51.086] Received PubSub notification, asking Buildbucket for the build status
[07:21:51.161] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:47.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:2:0)
[07:22:47.531] Timer tick, asking Buildbucket for the build status
[07:22:47.644] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:47.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:4:0) after 1m0s
[07:23:47.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:4:0)
[07:23:47.721] Timer tick, asking Buildbucket for the build status
[07:23:47.780] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:47.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:5:0) after 1m0s
[07:24:47.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:5:0)
[07:24:47.855] Timer tick, asking Buildbucket for the build status
[07:24:47.963] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:47.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:6:0) after 1m0s
[07:25:48.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:6:0)
[07:25:48.060] Timer tick, asking Buildbucket for the build status
[07:25:48.162] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:48.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:7:0) after 1m0s
[07:26:48.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:7:0)
[07:26:48.249] Timer tick, asking Buildbucket for the build status
[07:26:48.336] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:48.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:8:0) after 1m0s
[07:27:48.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:8:0)
[07:27:48.398] Timer tick, asking Buildbucket for the build status
[07:27:48.458] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:48.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:9:0) after 1m0s
[07:28:48.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:9:0)
[07:28:48.469] Timer tick, asking Buildbucket for the build status
[07:28:48.540] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:48.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:10:0) after 1m0s
[07:29:48.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:10:0)
[07:29:48.556] Timer tick, asking Buildbucket for the build status
[07:29:48.631] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:48.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:11:0) after 1m0s
[07:30:48.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:11:0)
[07:30:48.674] Timer tick, asking Buildbucket for the build status
[07:30:48.759] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:48.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:12:0) after 1m0s
[07:31:48.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:12:0)
[07:31:48.858] Timer tick, asking Buildbucket for the build status
[07:31:48.961] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:48.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:13:0) after 1m0s
[07:32:49.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:13:0)
[07:32:49.056] Timer tick, asking Buildbucket for the build status
[07:32:49.311] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:49.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:14:0) after 1m0s
[07:33:49.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:14:0)
[07:33:49.417] Timer tick, asking Buildbucket for the build status
[07:33:49.625] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:49.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:15:0) after 1m0s
[07:34:49.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:15:0)
[07:34:49.701] Timer tick, asking Buildbucket for the build status
[07:34:49.784] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:49.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:16:0) after 1m0s
[07:35:49.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:16:0)
[07:35:49.814] Timer tick, asking Buildbucket for the build status
[07:35:49.880] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:49.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:17:0) after 1m0s
[07:36:49.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:17:0)
[07:36:49.901] Timer tick, asking Buildbucket for the build status
[07:36:49.983] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:49.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:18:0) after 1m0s
[07:37:50.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:18:0)
[07:37:50.089] Timer tick, asking Buildbucket for the build status
[07:37:50.153] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:50.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:19:0) after 1m0s
[07:38:50.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:19:0)
[07:38:50.225] Timer tick, asking Buildbucket for the build status
[07:38:50.309] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:50.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:20:0) after 1m0s
[07:39:50.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:20:0)
[07:39:50.409] Timer tick, asking Buildbucket for the build status
[07:39:50.677] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:50.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:21:0) after 1m0s
[07:40:50.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:21:0)
[07:40:50.800] Timer tick, asking Buildbucket for the build status
[07:40:50.880] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:50.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:22:0) after 1m0s
[07:41:50.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:22:0)
[07:41:50.949] Timer tick, asking Buildbucket for the build status
[07:41:51.043] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:51.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:23:0) after 1m0s
[07:42:51.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:23:0)
[07:42:51.025] Timer tick, asking Buildbucket for the build status
[07:42:51.098] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:51.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:24:0) after 1m0s
[07:43:51.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:24:0)
[07:43:51.116] Timer tick, asking Buildbucket for the build status
[07:43:51.198] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:51.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:25:0) after 1m0s
[07:44:51.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:25:0)
[07:44:51.216] Timer tick, asking Buildbucket for the build status
[07:44:51.296] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:51.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:26:0) after 1m0s
[07:45:51.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:26:0)
[07:45:51.466] Timer tick, asking Buildbucket for the build status
[07:45:51.535] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:51.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:27:0) after 1m0s
[07:46:51.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:27:0)
[07:46:51.645] Timer tick, asking Buildbucket for the build status
[07:46:51.903] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:51.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:28:0) after 1m0s
[07:47:51.998] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:28:0)
[07:47:51.998] Timer tick, asking Buildbucket for the build status
[07:47:52.078] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:52.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:29:0) after 1m0s
[07:48:52.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:29:0)
[07:48:52.179] Timer tick, asking Buildbucket for the build status
[07:48:52.347] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:52.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:30:0) after 1m0s
[07:49:52.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:30:0)
[07:49:52.331] Timer tick, asking Buildbucket for the build status
[07:49:52.748] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:31:0) after 1m0s
[07:50:52.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:31:0)
[07:50:52.762] Timer tick, asking Buildbucket for the build status
[07:50:52.902] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:52.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:32:0) after 1m0s
[07:51:52.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:32:0)
[07:51:52.923] Timer tick, asking Buildbucket for the build status
[07:51:53.010] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:53.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:33:0) after 1m0s
[07:52:53.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:33:0)
[07:52:53.102] Timer tick, asking Buildbucket for the build status
[07:52:53.747] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:53.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:34:0) after 1m0s
[07:53:53.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:34:0)
[07:53:53.848] Timer tick, asking Buildbucket for the build status
[07:53:53.922] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:53.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:35:0) after 1m0s
[07:54:54.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:35:0)
[07:54:54.032] Timer tick, asking Buildbucket for the build status
[07:54:54.111] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:54.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:36:0) after 1m0s
[07:55:54.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:36:0)
[07:55:54.165] Timer tick, asking Buildbucket for the build status
[07:55:54.236] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:54.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:37:0) after 1m0s
[07:56:54.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:37:0)
[07:56:54.303] Timer tick, asking Buildbucket for the build status
[07:56:54.446] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:54.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:38:0) after 1m0s
[07:57:54.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:38:0)
[07:57:54.618] Timer tick, asking Buildbucket for the build status
[07:57:54.876] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:54.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:39:0) after 1m0s
[07:58:54.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:39:0)
[07:58:54.879] Timer tick, asking Buildbucket for the build status
[07:58:55.143] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:55.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:40:0) after 1m0s
[07:59:55.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:40:0)
[07:59:55.157] Timer tick, asking Buildbucket for the build status
[07:59:55.345] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:55.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:41:0) after 1m0s
[08:00:55.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:41:0)
[08:00:55.509] Timer tick, asking Buildbucket for the build status
[08:00:58.244] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:58.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:42:0) after 1m0s
[08:01:58.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:42:0)
[08:01:58.283] Timer tick, asking Buildbucket for the build status
[08:01:58.766] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:58.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:43:0) after 1m0s
[08:02:58.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:43:0)
[08:02:58.745] Timer tick, asking Buildbucket for the build status
[08:02:58.831] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:58.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:44:0) after 1m0s
[08:03:58.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:44:0)
[08:03:58.853] Timer tick, asking Buildbucket for the build status
[08:03:59.086] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:59.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:45:0) after 1m0s
[08:04:59.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:45:0)
[08:04:59.146] Timer tick, asking Buildbucket for the build status
[08:04:59.324] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:59.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:46:0) after 1m0s
[08:05:59.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:46:0)
[08:05:59.387] Timer tick, asking Buildbucket for the build status
[08:05:59.772] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:59.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:47:0) after 1m0s
[08:06:59.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:47:0)
[08:06:59.890] Timer tick, asking Buildbucket for the build status
[08:07:00.075] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:00.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:48:0) after 1m0s
[08:08:00.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:48:0)
[08:08:00.095] Timer tick, asking Buildbucket for the build status
[08:08:00.417] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:00.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:49:0) after 1m0s
[08:09:00.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:49:0)
[08:09:00.451] Timer tick, asking Buildbucket for the build status
[08:09:00.579] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:00.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:50:0) after 1m0s
[08:10:00.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:50:0)
[08:10:00.800] Timer tick, asking Buildbucket for the build status
[08:10:00.890] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:00.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:51:0) after 1m0s
[08:11:01.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:51:0)
[08:11:01.082] Timer tick, asking Buildbucket for the build status
[08:11:01.341] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:01.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:52:0) after 1m0s
[08:12:01.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:52:0)
[08:12:01.401] Timer tick, asking Buildbucket for the build status
[08:12:01.492] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:01.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:53:0) after 1m0s
[08:13:01.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:53:0)
[08:13:01.535] Timer tick, asking Buildbucket for the build status
[08:13:01.781] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:01.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:54:0) after 1m0s
[08:14:01.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:54:0)
[08:14:01.897] Timer tick, asking Buildbucket for the build status
[08:14:02.212] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:02.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:55:0) after 1m0s
[08:15:02.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:55:0)
[08:15:02.358] Timer tick, asking Buildbucket for the build status
[08:15:02.736] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:02.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:56:0) after 1m0s
[08:16:02.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:56:0)
[08:16:02.957] Timer tick, asking Buildbucket for the build status
[08:16:03.040] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:03.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:57:0) after 1m0s
[08:17:03.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:57:0)
[08:17:03.140] Timer tick, asking Buildbucket for the build status
[08:17:03.457] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:03.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:58:0) after 1m0s
[08:18:03.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:58:0)
[08:18:03.551] Timer tick, asking Buildbucket for the build status
[08:18:03.657] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:03.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:59:0) after 1m0s
[08:19:03.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:59:0)
[08:19:03.650] Timer tick, asking Buildbucket for the build status
[08:19:03.744] Build 8852983844031981888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:03.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018413906126134464:60:0) after 1m0s
[08:19:44.352] Received PubSub notification, asking Buildbucket for the build status
[08:19:44.650] Build 8852983844031981888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:19:44.650] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615537183377985",
"created_by": "project:chromium",
"created_ts": "1615533706595033",
"id": "8852983844031981888",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\"}}",
"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\": \"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\", \"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-z2yd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17767, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"225e1952d49477a114942c86328cb294e52781c6\", \"got_dawn_revision\": \"2f72aeda4fa52c3e7eb6276b0a59b1d568983517\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\", \"got_revision_cp\": \"refs/heads/master@{#862329}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3c4fd15fb075ab3a8eb5809f9a42b5faa9ac63ae\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"14a626af56675c9d95f9fb207d53366a53a95fbd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33409}\", \"is_cached\": true, \"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\": \"c5f8d9c390528198fcf4c3d17a823f09e907e6cd\", \"swarm_hashes_refs/heads/master(at){#862329}_without_patch\": {\"absl_hardening_tests\": \"edf477556a2e14b23d410133b1f10bacc70350d7\", \"accessibility_unittests\": \"52e079394fb9863aa0c5f0e101f750709b2af933\", \"angle_unittests\": \"7b37cd225952f578da35b7b2c808d42e0e479fde\", \"app_shell_unittests\": \"c6ab4d08d8d7f41281204133acd9dfc20f6d7b60\", \"aura_unittests\": \"bd7f7f5998adccc6a2cc64a93068fe07552943f1\", \"base_unittests\": \"d72fb46fbfebe407c2480fd549de33f509976777\", \"base_util_unittests\": \"909e4d06e9e52b530e76a2bd764e727976e3fb46\", \"blink_common_unittests\": \"d70676a576db7de58636d4cda36dbc88870c4685\", \"blink_fuzzer_unittests\": \"edd45cd8294813ca436c3e499a2a0f9e7c41f650\", \"blink_heap_unittests\": \"7ffecccd3fb52477888f2419f617ecb87cf17be7\", \"blink_platform_unittests\": \"cff5ff79ee3a8005261ce7db7dba582b2e4a6a71\", \"blink_unittests\": \"a90f168caf42ca6dbc713f727de8817c70075e6f\", \"boringssl_crypto_tests\": \"908c0ea56a8013697e6eb1ee185d431e58ab66ca\", \"boringssl_ssl_tests\": \"c5f86ed5f97ed2a63fd46ad26b738683005adc85\", \"browser_switcher_bho_unittests\": \"67cd5403b9c8dc9b2b1546fadccd7e55d21b0155\", \"browser_tests\": \"34b7668da2d0a92bc65609a5807fd919ef164b33\", \"capture_unittests\": \"4787e3bf80a77ae0c8c7762129b0f5e8914197c2\", \"cast_unittests\": \"83e752f5deeda4beee1829e7dbb84ea4916f738e\", \"cc_unittests\": \"32ea49808733c9fce485f3aa69b70f4d5af25807\", \"chrome_app_unittests\": \"98158e68807bf3118c34a75e2abba6782eb7dcde\", \"chrome_cleaner_unittests\": \"00abcc8a438954198876a0be7afc332ca4b8edc7\", \"chrome_elf_unittests\": \"54092b0efbd8fca0e825471bd9931c3ceef4e570\", \"chromedriver_unittests\": \"72215e387cbfd945ea43672a4363f6f1b4781a5b\", \"color_unittests\": \"89176962ba8b54bc530e4459a5303e7920151e4f\", \"components_browsertests\": \"dca9072f10cd57152db6eb78d6999455619db5c2\", \"components_unittests\": \"d6a64ca9b9535d7be1032450d92a68c179568a5b\", \"compositor_unittests\": \"4f77ee2be0bc1731aabb1854387b1a54b7d03166\", \"content_browsertests\": \"a79d4e3b2c96ca5b38ffc2d25c1b8d85e737b5bb\", \"content_unittests\": \"520080c724bd65384447d2d80714369a7bdca567\", \"courgette_unittests\": \"3cd2e0e7343f3509d023f0e6d05a23b13651b21e\", \"crashpad_tests\": \"fc146a6654ca64a1f66ec364134a1b7c4781c76e\", \"cronet_tests\": \"6c8b2679f9b94875e276173db7df19aa221e3713\", \"cronet_unittests\": \"3a63d57518c6ce05f9f04dd4806b205271a67380\", \"crypto_unittests\": \"4087369f2ed0c9100600b8d83485a397445cf991\", \"delayloads_unittests\": \"234cd180321b441ebc58bcf5b9980d9b5f16f7d2\", \"device_unittests\": \"3b19a2714908c322aa6b197905088ffdd81e36f8\", \"display_unittests\": \"7986a0a11446ff1dcb15510ac16893a76a807ab3\", \"elevation_service_unittests\": \"62235245cb071b2aafcf21f73541946161728828\", \"events_unittests\": \"67de7977397f843f894b1b880ae6a7e0120b4139\", \"extensions_browsertests\": \"ad0b632d0c7dc705aea4e010b6ae5c90f83de389\", \"extensions_unittests\": \"338fb51955312beb6c4dff8244b706c24aa0bd9f\", \"filesystem_service_unittests\": \"876270206035b629a8a698e6055935c04a02566c\", \"gcm_unit_tests\": \"3272d99e16228c8ea1aba4877a30cdca4f4da8d4\", \"gcp_unittests\": \"e7c09bf391dff704e238eb2062ff9353e3fadcc5\", \"gfx_unittests\": \"192b66d30521ffa2e9fc48ce4407b6afc82f506f\", \"gin_unittests\": \"7fb128f7e5f2ddc3bc54ef365d55cef399f3827c\", \"google_apis_unittests\": \"e996cfae0adaa54110b61c3ae53bcf0244d969a6\", \"gpu_unittests\": \"2a7bae7eacaafe903cc2fd13cbef3a9b9558efff\", \"gwp_asan_unittests\": \"626221dc65eab352eea542cf495121aa772364e1\", \"headless_browsertests\": \"c808475624352380de10f534f8ea83ed5e709169\", \"headless_unittests\": \"ff5f933e85e6ac86a739ceb2a86046a5667b0895\", \"install_static_unittests\": \"41f92029b55e2a90c429a96bcb869eeab568edeb\", \"installer_util_unittests\": \"49959dffbebf2e5005bcb572c706d18624071c11\", \"interactive_ui_tests\": \"3716b6e39f403ce5aaee6d00d17113ebd27da6fa\", \"ipc_tests\": \"10ae0cbcd651524f1ea83c63974a37836faddb85\", \"jingle_unittests\": \"5d420b15e95c063d8be1f53682e9ac83bc598701\", \"latency_unittests\": \"498754930402ba8d1c2c7a1ffb70e0d622febe76\", \"libjingle_xmpp_unittests\": \"962cfa40d2aa323ca272bb5bd3c497b895abce52\", \"liburlpattern_unittests\": \"98960badd88a66b1c221ff95a84320b34c6d7639\", \"media_blink_unittests\": \"6d3003f92f560087bd2c0b5baa2c77a02d3ebc42\", \"media_unittests\": \"683deb1bd76ea610f6f0bd12f68797d94c0d7793\", \"message_center_unittests\": \"854d2000c8c004bd3001c5374a728366b294fee9\", \"midi_unittests\": \"59a9a18244ee8a3431f7962327184d9315b37d8c\", \"mojo_core_unittests\": \"4af0f69b58fafa6fc111710c082f18a43310c85c\", \"mojo_unittests\": \"abba14624ee207960c47470cc959732a084a9bbf\", \"nacl_loader_unittests\": \"18b56bdc3e9e8256cd4ab07d4f36d1f6a2ef6e47\", \"native_theme_unittests\": \"aaa95eb13a958b17b63f2f496f4f415920fc1bc6\", \"net_unittests\": \"999c1924297d8922a19d96f33c12b4e9f6a73153\", \"notification_helper_unittests\": \"ce593d30953793ad8b48ae6296380defa93fc3c1\", \"pdf_unittests\": \"9f8a7a24f4ca2872b2b810d1889511f4aac1afcc\", \"perfetto_unittests\": \"637c6747e55401ba3dc2c0c14a56156c5e4728ad\", \"ppapi_unittests\": \"c1385f241fea59b70b849285445369c0f0039aba\", \"printing_unittests\": \"e82c0e66be32dd8d8321afd9a447b25c52955f1f\", \"remoting_unittests\": \"e7e9b02d10f7f2166056e7061edf67f94c3c2f42\", \"sbox_integration_tests\": \"4131d5e5ff31729aef31e300ffa3ddf14cc79512\", \"sbox_unittests\": \"5f5aa3c604de65fff72d74924cbdba81d1ac6626\", \"sbox_validation_tests\": \"6cc7da75acaf26b31c0dfb88d0ef38dbea497924\", \"service_manager_unittests\": \"20b9483214c92cd8bf451982324adb3c9aaf6f5e\", \"services_unittests\": \"145a01d0652bb2d781f0ca17504b334414fc1dff\", \"setup_unittests\": \"2deaad08c24fa9a582e68bae8adb1bf5863b98d0\", \"shell_dialogs_unittests\": \"257dbb33001724f7a1e327054e1aeb6e63f5db86\", \"skia_unittests\": \"5d437de10451d817f2b4cda8d15d87a2f32e42a3\", \"snapshot_unittests\": \"a82eb2797ce83fba3a0659068ba5d353d6b13292\", \"sql_unittests\": \"5fb81ca1912a31ef918cbb291fb48bccda87c987\", \"storage_unittests\": \"8d1e82ee650cd04b6c208218d1dd2186661c122e\", \"sync_integration_tests\": \"c2223ae73919a223f9e920b319915bb15edae1cf\", \"traffic_annotation_auditor_unittests\": \"21c0516e1370563aecf3d1e9d0baec723d022703\", \"ui_base_unittests\": \"d33376dd8d70ae74d86bdb8f110ccacf092cfabe\", \"ui_touch_selection_unittests\": \"30418c9a5a1145faa534bebffde2464fbd3dd050\", \"unit_tests\": \"5a1b1c2de070823d6238dab81b1e6ecb950e0960\", \"updater_tests\": \"6dfc887a4f1a22c2dbe63876c0e07b9a9b3e3b4d\", \"url_unittests\": \"3c4b355582bcbc2ddc49972e7ececccf67d90401\", \"views_unittests\": \"da642f389cbf893ed2ec65b9923679c450bc114d\", \"viz_unittests\": \"b4ab1fc5941c670976673f92a0a0489cfe52fabf\", \"vr_common_unittests\": \"f960bc8aca1915db7dd406a79e122689542a20f9\", \"vr_pixeltests\": \"ef027f561d5de0872286bc54c6d49ca1e8309b71\", \"weblayer_browsertests\": \"f913ace77ffa1a423e1d28dce64a4e1487cd4a29\", \"weblayer_unittests\": \"931306987f44db8215cceaa2c4d8f54a3dbbda3d\", \"wm_unittests\": \"fe4567ee11966cfe910e11b58332bce080eccb45\", \"wtf_unittests\": \"e5d8269b3b6f77cf66d375dc4ea2566557308161\", \"zlib_unittests\": \"6b19a44b4e81cb9f9d08d9eab29358ef3ee224ca\", \"zucchini_unittests\": \"05ddf2d58a31381fd224e7ed60ae0ff1f7c69edc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_05f97ad14167df9074a6905c05cccbc862b4a7ff68b1655c21ecf0b33d70df67_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-z2yd\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5754-8c4f760\"], \"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": "1615533710215969",
"status": "COMPLETED",
"status_changed_ts": "1615537183681018",
"tags": [
"build_address:luci.chromium.ci/win-asan/17767",
"builder:win-asan",
"buildset:commit/git/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5f8d9c390528198fcf4c3d17a823f09e907e6cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018413906126134464",
"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/8852983844031981888/+/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:523e2198e9332110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615537183697892",
"url": "https://ci.chromium.org/b/8852983844031981888",
"utcnow_ts": "1615537184632567"
}
}
[08:19:44.650] Invocation finished in 57m59.435704944s with status SUCCEEDED