[22:21:02.495] New invocation is queued and will start shortly
[22:21:03.872] Starting the invocation (attempt 1)
[22:21:03.902] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:21:03.903] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:21:03.903] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027870009304342720",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8ee89b5a853e263574016bc659860bb105791fd5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027870009304342720",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/8ee89b5a853e263574016bc659860bb105791fd5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8ee89b5a853e263574016bc659860bb105791fd5",
"gitiles_ref:refs/heads/master"
]
}
[22:21:04.504] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606515663973210",
"id": "8862439947092405952",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8ee89b5a853e263574016bc659860bb105791fd5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606515664365655",
"tags": [
"build_address:luci.chromium.ci/win-asan/15894",
"builder:win-asan",
"buildset:commit/git/8ee89b5a853e263574016bc659860bb105791fd5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8ee89b5a853e263574016bc659860bb105791fd5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027870009304342720",
"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/8862439947092405952/+/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": "1606515664365772",
"url": "https://ci.chromium.org/b/8862439947092405952",
"utcnow_ts": "1606515664498339"
}
}
[22:21:04.504] Task URL: https://ci.chromium.org/b/8862439947092405952
[22:21:04.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:2:0) after 1m0s
[22:21:12.040] Received PubSub notification, asking Buildbucket for the build status
[22:21:12.928] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:04.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:2:0)
[22:22:04.610] Timer tick, asking Buildbucket for the build status
[22:22:04.700] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:04.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:4:0) after 1m0s
[22:23:04.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:4:0)
[22:23:04.969] Timer tick, asking Buildbucket for the build status
[22:23:05.083] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:05.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:5:0) after 1m0s
[22:24:05.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:5:0)
[22:24:05.067] Timer tick, asking Buildbucket for the build status
[22:24:05.522] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:05.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:6:0) after 1m0s
[22:25:05.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:6:0)
[22:25:05.659] Timer tick, asking Buildbucket for the build status
[22:25:05.795] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:05.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:7:0) after 1m0s
[22:26:05.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:7:0)
[22:26:05.847] Timer tick, asking Buildbucket for the build status
[22:26:06.009] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:06.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:8:0) after 1m0s
[22:27:05.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:8:0)
[22:27:05.992] Timer tick, asking Buildbucket for the build status
[22:27:06.224] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:06.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:9:0) after 1m0s
[22:28:06.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:9:0)
[22:28:06.242] Timer tick, asking Buildbucket for the build status
[22:28:06.541] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:06.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:10:0) after 1m0s
[22:29:06.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:10:0)
[22:29:06.558] Timer tick, asking Buildbucket for the build status
[22:29:06.724] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:06.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:11:0) after 1m0s
[22:30:06.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:11:0)
[22:30:06.849] Timer tick, asking Buildbucket for the build status
[22:30:06.951] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:06.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:12:0) after 1m0s
[22:31:07.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:12:0)
[22:31:07.340] Timer tick, asking Buildbucket for the build status
[22:31:07.509] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:07.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:13:0) after 1m0s
[22:32:07.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:13:0)
[22:32:07.553] Timer tick, asking Buildbucket for the build status
[22:32:07.981] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:07.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:14:0) after 1m0s
[22:33:08.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:14:0)
[22:33:08.060] Timer tick, asking Buildbucket for the build status
[22:33:08.424] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:08.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:15:0) after 1m0s
[22:34:08.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:15:0)
[22:34:08.506] Timer tick, asking Buildbucket for the build status
[22:34:11.527] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:11.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:16:0) after 1m0s
[22:35:11.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:16:0)
[22:35:11.558] Timer tick, asking Buildbucket for the build status
[22:35:11.665] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:11.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:17:0) after 1m0s
[22:36:11.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:17:0)
[22:36:11.656] Timer tick, asking Buildbucket for the build status
[22:36:11.776] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:11.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:18:0) after 1m0s
[22:37:11.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:18:0)
[22:37:11.796] Timer tick, asking Buildbucket for the build status
[22:37:11.920] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:11.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:19:0) after 1m0s
[22:38:11.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:19:0)
[22:38:11.977] Timer tick, asking Buildbucket for the build status
[22:38:12.114] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:12.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:20:0) after 1m0s
[22:39:12.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:20:0)
[22:39:12.131] Timer tick, asking Buildbucket for the build status
[22:39:12.244] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:12.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:21:0) after 1m0s
[22:40:12.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:21:0)
[22:40:12.287] Timer tick, asking Buildbucket for the build status
[22:40:12.492] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:12.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:22:0) after 1m0s
[22:41:12.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:22:0)
[22:41:12.491] Timer tick, asking Buildbucket for the build status
[22:41:12.598] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:12.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:23:0) after 1m0s
[22:42:12.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:23:0)
[22:42:12.599] Timer tick, asking Buildbucket for the build status
[22:42:12.698] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:12.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:24:0) after 1m0s
[22:43:12.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:24:0)
[22:43:12.823] Timer tick, asking Buildbucket for the build status
[22:43:12.938] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:12.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:25:0) after 1m0s
[22:44:12.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:25:0)
[22:44:12.923] Timer tick, asking Buildbucket for the build status
[22:44:12.997] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:12.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:26:0) after 1m0s
[22:45:13.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:26:0)
[22:45:13.086] Timer tick, asking Buildbucket for the build status
[22:45:13.170] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:13.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:27:0) after 1m0s
[22:46:13.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:27:0)
[22:46:13.164] Timer tick, asking Buildbucket for the build status
[22:46:13.310] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:13.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:28:0) after 1m0s
[22:47:13.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:28:0)
[22:47:13.408] Timer tick, asking Buildbucket for the build status
[22:47:13.474] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:13.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:29:0) after 1m0s
[22:48:13.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:29:0)
[22:48:13.528] Timer tick, asking Buildbucket for the build status
[22:48:13.771] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:13.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:30:0) after 1m0s
[22:49:13.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:30:0)
[22:49:13.777] Timer tick, asking Buildbucket for the build status
[22:49:13.842] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:13.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:31:0) after 1m0s
[22:50:13.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:31:0)
[22:50:13.865] Timer tick, asking Buildbucket for the build status
[22:50:13.990] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:13.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:32:0) after 1m0s
[22:51:13.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:32:0)
[22:51:13.964] Timer tick, asking Buildbucket for the build status
[22:51:14.115] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:14.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:33:0) after 1m0s
[22:52:14.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:33:0)
[22:52:14.127] Timer tick, asking Buildbucket for the build status
[22:52:14.237] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:34:0) after 1m0s
[22:53:14.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:34:0)
[22:53:14.262] Timer tick, asking Buildbucket for the build status
[22:53:14.365] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:14.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:35:0) after 1m0s
[22:54:14.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:35:0)
[22:54:14.361] Timer tick, asking Buildbucket for the build status
[22:54:14.610] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:14.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:36:0) after 1m0s
[22:55:14.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:36:0)
[22:55:14.666] Timer tick, asking Buildbucket for the build status
[22:55:15.064] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:15.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:37:0) after 1m0s
[22:56:15.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:37:0)
[22:56:15.089] Timer tick, asking Buildbucket for the build status
[22:56:15.567] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:15.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:38:0) after 1m0s
[22:57:15.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:38:0)
[22:57:15.589] Timer tick, asking Buildbucket for the build status
[22:57:16.154] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:16.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:39:0) after 1m0s
[22:58:16.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:39:0)
[22:58:16.158] Timer tick, asking Buildbucket for the build status
[22:58:16.228] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:16.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:40:0) after 1m0s
[22:59:16.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:40:0)
[22:59:16.249] Timer tick, asking Buildbucket for the build status
[22:59:16.315] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:16.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:41:0) after 1m0s
[23:00:16.405] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:41:0)
[23:00:16.405] Timer tick, asking Buildbucket for the build status
[23:00:16.774] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:16.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:42:0) after 1m0s
[23:01:16.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:42:0)
[23:01:16.783] Timer tick, asking Buildbucket for the build status
[23:01:17.490] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:17.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:43:0) after 1m0s
[23:02:17.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:43:0)
[23:02:17.608] Timer tick, asking Buildbucket for the build status
[23:02:17.757] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:17.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:44:0) after 1m0s
[23:03:18.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:44:0)
[23:03:18.029] Timer tick, asking Buildbucket for the build status
[23:03:18.161] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:18.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:45:0) after 1m0s
[23:04:18.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:45:0)
[23:04:18.277] Timer tick, asking Buildbucket for the build status
[23:04:18.568] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:18.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:46:0) after 1m0s
[23:05:18.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:46:0)
[23:05:18.745] Timer tick, asking Buildbucket for the build status
[23:05:18.844] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:18.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:47:0) after 1m0s
[23:06:18.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:47:0)
[23:06:18.870] Timer tick, asking Buildbucket for the build status
[23:06:19.256] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:19.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:48:0) after 1m0s
[23:07:19.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:48:0)
[23:07:19.295] Timer tick, asking Buildbucket for the build status
[23:07:19.358] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:19.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:49:0) after 1m0s
[23:08:19.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:49:0)
[23:08:19.365] Timer tick, asking Buildbucket for the build status
[23:08:19.447] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:19.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:50:0) after 1m0s
[23:09:21.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:50:0)
[23:09:21.101] Timer tick, asking Buildbucket for the build status
[23:09:21.192] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:51:0) after 1m0s
[23:10:21.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:51:0)
[23:10:21.242] Timer tick, asking Buildbucket for the build status
[23:10:21.425] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:21.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:52:0) after 1m0s
[23:11:21.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:52:0)
[23:11:21.444] Timer tick, asking Buildbucket for the build status
[23:11:21.552] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:21.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:53:0) after 1m0s
[23:12:21.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:53:0)
[23:12:21.601] Timer tick, asking Buildbucket for the build status
[23:12:21.906] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:21.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:54:0) after 1m0s
[23:13:21.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:54:0)
[23:13:21.927] Timer tick, asking Buildbucket for the build status
[23:13:22.008] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:22.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:55:0) after 1m0s
[23:14:22.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:55:0)
[23:14:22.032] Timer tick, asking Buildbucket for the build status
[23:14:22.147] Build 8862439947092405952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:22.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027870009304342720:56:0) after 1m0s
[23:15:14.737] Received PubSub notification, asking Buildbucket for the build status
[23:15:16.201] Build 8862439947092405952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:15:16.201] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606518913657100",
"created_by": "project:chromium",
"created_ts": "1606515663973210",
"id": "8862439947092405952",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8ee89b5a853e263574016bc659860bb105791fd5\"}}",
"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\": \"8ee89b5a853e263574016bc659860bb105791fd5\", \"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\": 15894, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"a5da17cd4e19649288b9634e7fff32455403b856\", \"got_dawn_revision\": \"e96986149080ca37e82788c907f439bc070aaa7b\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"8ee89b5a853e263574016bc659860bb105791fd5\", \"got_revision_cp\": \"refs/heads/master@{#831650}\", \"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\": \"8ee89b5a853e263574016bc659860bb105791fd5\", \"swarm_hashes_refs/heads/master(at){#831650}_without_patch\": {\"absl_hardening_tests\": \"9509b936e1e93db1fce16ea3976e7b806fa31537\", \"accessibility_unittests\": \"b453f2b5562f20323ccbb21f64ca03ad7904e667\", \"angle_unittests\": \"192deb6ef56b86df372643139292597fc48ebc25\", \"app_shell_unittests\": \"b8ac676c36682d51c5301a463ac7c4c956eecdfe\", \"aura_unittests\": \"917df3a43582c69c8fac57838fd9e27356eb4e44\", \"base_unittests\": \"5a01b95113ab79435dbfddcab08da0c597f9d643\", \"base_util_unittests\": \"e1edb8c892de0e4d36b3c3c2f659ff90d64b953e\", \"blink_common_unittests\": \"3f243666f31317d2144bae1c6183e9f3cded23e1\", \"blink_fuzzer_unittests\": \"cdb4f10164ba715c3940b1ae03fba3c4cd0c6b59\", \"blink_heap_unittests\": \"f3b43f515adff94fcfbceaac5cb55509165bbbe7\", \"blink_platform_unittests\": \"ef5e48bf55ae78360abad82b258ebe6a5c534bef\", \"blink_unittests\": \"dba9b849d4f872cb12323eb0fbb352a42a752b31\", \"boringssl_crypto_tests\": \"5ed56e4294391e789e6334bd8b4ef89d7801bb84\", \"boringssl_ssl_tests\": \"a27883cf305210b0c6c718c7620aa55d333fe9b6\", \"browser_switcher_bho_unittests\": \"aa682e26dbaf4ea03d16a9b39852f1951574bd4a\", \"browser_tests\": \"6df3d08dd8cc6421d53ca2b16036bdf32b225d14\", \"capture_unittests\": \"ff18fe8ec2b88e373b8e862921ea900dc4b42466\", \"cast_unittests\": \"3edafff0126c609a52be95d46b93f8ca98bb7540\", \"cc_unittests\": \"ba135175ed65c0fc44a126c3f4460570b08f2cf6\", \"chrome_app_unittests\": \"e8f3a92bf2db56b74fe4b6f3eafc9f4ce00cad64\", \"chrome_cleaner_unittests\": \"4038fdd7fdf5a796b45735e16ab0ffe5e1cba684\", \"chrome_elf_unittests\": \"1e21c788f63e1272bbb573f07e86e47fd309cd2c\", \"chromedriver_unittests\": \"927c9aff01a88e2991955b77112f5ba725732631\", \"components_browsertests\": \"ded98290c2d1021915ab533693547da842372f7b\", \"components_unittests\": \"3a732f12b21314ae526e2f22e4cd44527c9133f0\", \"compositor_unittests\": \"f75df333bb82232611eaa55269b9ea35c010fc4a\", \"content_browsertests\": \"aa705ee1079804537ef5f8a72dfc93199f462d9a\", \"content_unittests\": \"54402d9c87e65025d585054c7ee4e5ec63de3f60\", \"courgette_unittests\": \"da8dcd05044e7e94cf2f9c858ac5f00f0abd6e74\", \"crashpad_tests\": \"4231be2777e5527e07ac488ad2db6c4b31d13bb9\", \"cronet_tests\": \"94bd7b923903690737a258fef66184cd75fe37e0\", \"cronet_unittests\": \"7751056232f00b913c7a8c6540291d4b685d5ea2\", \"crypto_unittests\": \"9e3e9ea2685b65b9eb88cbd73754461955da9d30\", \"delayloads_unittests\": \"57254a553a610d4e25c197285dd76e7fc0ab80e3\", \"device_unittests\": \"5332650fa98fefe685aa4dd2bce726b6499857ed\", \"display_unittests\": \"51799191667b3f70c8995748c3d6b5d276baf61e\", \"elevation_service_unittests\": \"039339b7272f53bd52422dcd84bb830f554ed06e\", \"events_unittests\": \"2bf55fa9dc4a09b49080ce05b1107a7e145c477f\", \"extensions_browsertests\": \"ec8e064af7b76a86b0b598ed6cba0429c3f03d49\", \"extensions_unittests\": \"1fe1a06c8574fd4bfb8b61f57df751bb1fa5f8c9\", \"filesystem_service_unittests\": \"c74aabc5cf8b91ea1c7c50b05e3a3822db0fb0db\", \"gcm_unit_tests\": \"e2a8bdc8cb3c1a0425be5abff5a4138b025bb0cc\", \"gcp_unittests\": \"d9280a69987de0fb8c2e97cbb944cdfeff51dca1\", \"gfx_unittests\": \"259b609ee8adc78ca5162f777c76882fa0e5312e\", \"gin_unittests\": \"49c893b177577058993259734c659e4e8e27065a\", \"google_apis_unittests\": \"ad9690cc9dd6801c3a779172a1ec8227155e7ce8\", \"gpu_unittests\": \"cedfbfcc3a7d58e978d7cf055c9366de70c33309\", \"gwp_asan_unittests\": \"8e1650ed78e7489fc10981a41cfb88d6d0553c0d\", \"headless_browsertests\": \"84198306b184e629b2e225c97f3bc73847285f05\", \"headless_unittests\": \"26797e42f9b1e46bc626db713befd5fdf192adb7\", \"install_static_unittests\": \"2cea63a14149a580deea62da5e6497b168fe1c55\", \"installer_util_unittests\": \"72a8e069e5a05ee3801e13cf9bab0084826fb823\", \"interactive_ui_tests\": \"9259d457f0ccff5c900c91dfc6d03dd56da7e4b0\", \"ipc_tests\": \"e1c9c3303b094c4f50d67d7abed987a2fbccba1f\", \"jingle_unittests\": \"03c81238c77f4abeec7e2954f7c944333c97aedd\", \"latency_unittests\": \"7e504834a8562471a893fef37e57cb8827e0a032\", \"libjingle_xmpp_unittests\": \"e94ecbfca99448bdb459f44e8cd7d438a5898f71\", \"liburlpattern_unittests\": \"8becd94e286821bb962ffb78b9bd9710d57e7d26\", \"media_blink_unittests\": \"a280bc5b6d6c53d0ad19649cf84d61ab6fdb4b63\", \"media_unittests\": \"1ded741caead17dc4b143228af2ebd7d9db9c4a2\", \"message_center_unittests\": \"94ceb319732d06862f0f031493ec69b5af5eec0c\", \"midi_unittests\": \"236571f082a386b17596329707f3a612b61df1cc\", \"mojo_core_unittests\": \"eab4948b2421d413e680f349c9c1c29333dfae06\", \"mojo_unittests\": \"de3f923e55eb2703b769edac40733b31cd778089\", \"nacl_loader_unittests\": \"dee495f5c8fe17b7649e9b1c1fc6583b0e2c3833\", \"native_theme_unittests\": \"c15699a79ef0ba0b00a682f0680cc58b6817bcde\", \"net_unittests\": \"bf7972a8141477417ab490df8dd2931a7725096a\", \"notification_helper_unittests\": \"39e730c458ebad18acd85f141ce7772b0dac9d8d\", \"pdf_unittests\": \"3f53b15c178a9f63f3f11add658cb4c2f5d24ef4\", \"perfetto_unittests\": \"70f78ad0db5bbbaf7d9f463b30801e25143462e8\", \"ppapi_unittests\": \"fa9c176fdef7aa2ea774aae4ee6fc614831b19d2\", \"printing_unittests\": \"df35c12e63b215fc695c82e4d46514706ab762c9\", \"remoting_unittests\": \"16bdb49ca4d25518a842f9b97654e59a9417b7fd\", \"sbox_integration_tests\": \"68c581528953aeda37be48e488fee96c586ecbed\", \"sbox_unittests\": \"22c289e956baad152bdc70ab7664ab33c693f45f\", \"sbox_validation_tests\": \"b416829327ac687f70ff60f4b1a1611db6cf232e\", \"service_manager_unittests\": \"30cac1a28644fdff5485f1e6f77f2c5c276e8dd1\", \"services_unittests\": \"e5e322988e90d83d1017c1b49a9f243539fa2cfb\", \"setup_unittests\": \"5db0fe135a20e8cbbfa58fb531347656f23d7228\", \"shell_dialogs_unittests\": \"ef6ed1b83c59d7ddde1ccec3e3cb70072594426c\", \"skia_unittests\": \"4bfc18378d4bd39252396546b10bcd686b72814e\", \"snapshot_unittests\": \"b52d98b70ebec27c060490d494086e0c2ebb2ca6\", \"sql_unittests\": \"7b0b80233e090efbfd19e40755d8efd562140154\", \"storage_unittests\": \"ca62929795ec1596add6db9035353a7ccbc4d8b8\", \"sync_integration_tests\": \"e146f2a5ef8be5fbb8a66807cdb55d1cd407d924\", \"traffic_annotation_auditor_unittests\": \"fa69f52c8f9031dd5259f2a39072e8cede12eb1d\", \"ui_base_unittests\": \"d81231ae7f445af41db1fec55131f5e6bd395dd3\", \"ui_touch_selection_unittests\": \"79e1060850f454babe3722931f51a8e0ca0fc071\", \"unit_tests\": \"70ce3460801cc69efb9446f2f75ffb19a5720585\", \"updater_tests\": \"4a429c74526be8c9b25490132d2205c0518bee92\", \"url_unittests\": \"4d2f28e5f33e832ba9417998319ca698f5fc03d9\", \"views_unittests\": \"41b7f79d421e4c28e308b03672573c8231c7608a\", \"viz_unittests\": \"f227d4a492323e6a9060010638e54c675e08a480\", \"vr_common_unittests\": \"0f7a2e7e59c1684562f222afc76479535f9472d6\", \"vr_pixeltests\": \"83c826932c9bd2d81fb4e7c8b80918c50d98782d\", \"weblayer_browsertests\": \"cf7c538d242ff86ed848b2f23ac3403007eba363\", \"weblayer_unittests\": \"2c2b3f55fff0d50f1e8331f02986d9f5eb97b1c4\", \"wm_unittests\": \"1fc7a8c96498d690142493801fa9312f169c9b62\", \"wtf_unittests\": \"f8e2a1ad1e18003c7c510b6dd147d139d2f2034d\", \"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": "1606515670899370",
"status": "COMPLETED",
"status_changed_ts": "1606518914175343",
"tags": [
"build_address:luci.chromium.ci/win-asan/15894",
"builder:win-asan",
"buildset:commit/git/8ee89b5a853e263574016bc659860bb105791fd5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8ee89b5a853e263574016bc659860bb105791fd5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027870009304342720",
"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/8862439947092405952/+/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:50249d38b3c60c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606518914180036",
"url": "https://ci.chromium.org/b/8862439947092405952",
"utcnow_ts": "1606518915975647"
}
}
[23:15:16.201] Invocation finished in 54m13.721338377s with status SUCCEEDED