[08:54:06.931] New invocation is queued and will start shortly
[08:54:08.661] Starting the invocation (attempt 1)
[08:54:08.695] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:54:08.695] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:54:08.695] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027920776703418848",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"adcc1b456a8129bfa26eda97e3210c2068b42924\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027920776703418848",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/adcc1b456a8129bfa26eda97e3210c2068b42924",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/adcc1b456a8129bfa26eda97e3210c2068b42924",
"gitiles_ref:refs/heads/master"
]
}
[08:54:10.555] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606467249229814",
"id": "8862490713630728768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"adcc1b456a8129bfa26eda97e3210c2068b42924\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606467250273767",
"tags": [
"build_address:luci.chromium.ci/win-asan/15881",
"builder:win-asan",
"buildset:commit/git/adcc1b456a8129bfa26eda97e3210c2068b42924",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/adcc1b456a8129bfa26eda97e3210c2068b42924",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027920776703418848",
"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/8862490713630728768/+/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": "1606467250273904",
"url": "https://ci.chromium.org/b/8862490713630728768",
"utcnow_ts": "1606467250541413"
}
}
[08:54:10.555] Task URL: https://ci.chromium.org/b/8862490713630728768
[08:54:10.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:2:0) after 1m0s
[08:54:13.915] Received PubSub notification, asking Buildbucket for the build status
[08:54:14.039] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:10.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:2:0)
[08:55:10.600] Timer tick, asking Buildbucket for the build status
[08:55:11.055] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:11.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:4:0) after 1m0s
[08:56:11.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:4:0)
[08:56:11.054] Timer tick, asking Buildbucket for the build status
[08:56:11.947] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:11.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:5:0) after 1m0s
[08:57:12.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:5:0)
[08:57:12.046] Timer tick, asking Buildbucket for the build status
[08:57:12.235] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:12.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:6:0) after 1m0s
[08:58:12.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:6:0)
[08:58:12.283] Timer tick, asking Buildbucket for the build status
[08:58:12.467] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:12.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:7:0) after 1m0s
[08:59:12.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:7:0)
[08:59:12.493] Timer tick, asking Buildbucket for the build status
[08:59:12.910] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:8:0) after 1m0s
[09:00:12.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:8:0)
[09:00:12.965] Timer tick, asking Buildbucket for the build status
[09:00:13.148] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:13.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:9:0) after 1m0s
[09:01:13.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:9:0)
[09:01:13.251] Timer tick, asking Buildbucket for the build status
[09:01:13.336] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:10:0) after 1m0s
[09:02:13.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:10:0)
[09:02:13.337] Timer tick, asking Buildbucket for the build status
[09:02:13.420] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:11:0) after 1m0s
[09:03:13.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:11:0)
[09:03:13.444] Timer tick, asking Buildbucket for the build status
[09:03:13.596] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:12:0) after 1m0s
[09:04:13.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:12:0)
[09:04:13.628] Timer tick, asking Buildbucket for the build status
[09:04:13.736] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:13:0) after 1m0s
[09:05:13.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:13:0)
[09:05:13.766] Timer tick, asking Buildbucket for the build status
[09:05:13.962] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:13.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:14:0) after 1m0s
[09:06:13.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:14:0)
[09:06:13.966] Timer tick, asking Buildbucket for the build status
[09:06:14.056] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:14.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:15:0) after 1m0s
[09:07:14.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:15:0)
[09:07:14.079] Timer tick, asking Buildbucket for the build status
[09:07:14.232] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:14.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:16:0) after 1m0s
[09:08:14.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:16:0)
[09:08:14.319] Timer tick, asking Buildbucket for the build status
[09:08:14.511] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:14.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:17:0) after 1m0s
[09:09:14.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:17:0)
[09:09:14.550] Timer tick, asking Buildbucket for the build status
[09:09:15.018] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:18:0) after 1m0s
[09:10:15.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:18:0)
[09:10:15.047] Timer tick, asking Buildbucket for the build status
[09:10:15.204] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:15.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:19:0) after 1m0s
[09:11:15.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:19:0)
[09:11:15.256] Timer tick, asking Buildbucket for the build status
[09:11:15.666] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:15.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:20:0) after 1m0s
[09:12:15.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:20:0)
[09:12:15.685] Timer tick, asking Buildbucket for the build status
[09:12:15.833] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:15.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:21:0) after 1m0s
[09:13:16.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:21:0)
[09:13:16.009] Timer tick, asking Buildbucket for the build status
[09:13:16.127] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:16.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:22:0) after 1m0s
[09:14:16.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:22:0)
[09:14:16.247] Timer tick, asking Buildbucket for the build status
[09:14:16.406] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:16.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:23:0) after 1m0s
[09:15:16.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:23:0)
[09:15:16.432] Timer tick, asking Buildbucket for the build status
[09:15:16.604] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:16.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:24:0) after 1m0s
[09:16:16.643] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:24:0)
[09:16:16.643] Timer tick, asking Buildbucket for the build status
[09:16:16.962] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:16.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:25:0) after 1m0s
[09:17:17.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:25:0)
[09:17:17.543] Timer tick, asking Buildbucket for the build status
[09:17:18.379] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:18.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:26:0) after 1m0s
[09:18:18.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:26:0)
[09:18:18.612] Timer tick, asking Buildbucket for the build status
[09:18:18.862] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:18.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:27:0) after 1m0s
[09:19:18.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:27:0)
[09:19:18.925] Timer tick, asking Buildbucket for the build status
[09:19:19.041] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:28:0) after 1m0s
[09:20:19.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:28:0)
[09:20:19.063] Timer tick, asking Buildbucket for the build status
[09:20:19.125] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:29:0) after 1m0s
[09:21:19.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:29:0)
[09:21:19.402] Timer tick, asking Buildbucket for the build status
[09:21:19.526] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:19.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:30:0) after 1m0s
[09:22:19.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:30:0)
[09:22:19.622] Timer tick, asking Buildbucket for the build status
[09:22:19.722] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:19.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:31:0) after 1m0s
[09:23:21.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:31:0)
[09:23:21.690] Timer tick, asking Buildbucket for the build status
[09:23:22.057] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:22.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:32:0) after 1m0s
[09:24:22.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:32:0)
[09:24:22.441] Timer tick, asking Buildbucket for the build status
[09:24:22.742] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:33:0) after 1m0s
[09:25:22.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:33:0)
[09:25:22.883] Timer tick, asking Buildbucket for the build status
[09:25:22.975] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:22.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:34:0) after 1m0s
[09:26:23.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:34:0)
[09:26:23.182] Timer tick, asking Buildbucket for the build status
[09:26:23.257] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:35:0) after 1m0s
[09:27:23.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:35:0)
[09:27:23.438] Timer tick, asking Buildbucket for the build status
[09:27:23.561] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:36:0) after 1m0s
[09:28:23.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:36:0)
[09:28:23.861] Timer tick, asking Buildbucket for the build status
[09:28:23.985] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:37:0) after 1m0s
[09:29:24.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:37:0)
[09:29:24.115] Timer tick, asking Buildbucket for the build status
[09:29:24.474] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:38:0) after 1m0s
[09:30:24.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:38:0)
[09:30:24.523] Timer tick, asking Buildbucket for the build status
[09:30:24.650] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:24.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:39:0) after 1m0s
[09:31:24.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:39:0)
[09:31:24.668] Timer tick, asking Buildbucket for the build status
[09:31:25.112] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:40:0) after 1m0s
[09:32:25.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:40:0)
[09:32:25.144] Timer tick, asking Buildbucket for the build status
[09:32:25.329] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:25.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:41:0) after 1m0s
[09:33:25.350] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:41:0)
[09:33:25.350] Timer tick, asking Buildbucket for the build status
[09:33:25.552] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:25.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:42:0) after 1m0s
[09:34:25.575] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:42:0)
[09:34:25.575] Timer tick, asking Buildbucket for the build status
[09:34:25.827] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:25.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:43:0) after 1m0s
[09:35:25.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:43:0)
[09:35:25.849] Timer tick, asking Buildbucket for the build status
[09:35:26.096] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:26.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:44:0) after 1m0s
[09:36:26.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:44:0)
[09:36:26.123] Timer tick, asking Buildbucket for the build status
[09:36:26.222] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:26.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:45:0) after 1m0s
[09:37:26.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:45:0)
[09:37:26.376] Timer tick, asking Buildbucket for the build status
[09:37:26.442] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:26.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:46:0) after 1m0s
[09:38:26.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:46:0)
[09:38:26.690] Timer tick, asking Buildbucket for the build status
[09:38:26.802] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:26.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:47:0) after 1m0s
[09:39:26.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:47:0)
[09:39:26.941] Timer tick, asking Buildbucket for the build status
[09:39:27.056] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:27.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:48:0) after 1m0s
[09:40:27.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:48:0)
[09:40:27.287] Timer tick, asking Buildbucket for the build status
[09:40:27.438] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:27.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:49:0) after 1m0s
[09:41:27.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:49:0)
[09:41:27.639] Timer tick, asking Buildbucket for the build status
[09:41:27.815] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:27.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:50:0) after 1m0s
[09:42:27.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:50:0)
[09:42:27.990] Timer tick, asking Buildbucket for the build status
[09:42:28.096] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:28.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:51:0) after 1m0s
[09:43:28.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:51:0)
[09:43:28.263] Timer tick, asking Buildbucket for the build status
[09:43:28.340] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:28.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:52:0) after 1m0s
[09:44:28.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:52:0)
[09:44:28.397] Timer tick, asking Buildbucket for the build status
[09:44:28.506] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:28.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:53:0) after 1m0s
[09:45:28.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:53:0)
[09:45:28.676] Timer tick, asking Buildbucket for the build status
[09:45:28.756] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:28.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:54:0) after 1m0s
[09:46:28.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:54:0)
[09:46:28.848] Timer tick, asking Buildbucket for the build status
[09:46:29.039] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:29.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:55:0) after 1m0s
[09:47:29.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:55:0)
[09:47:29.150] Timer tick, asking Buildbucket for the build status
[09:47:29.421] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:29.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:56:0) after 1m0s
[09:48:29.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:56:0)
[09:48:29.703] Timer tick, asking Buildbucket for the build status
[09:48:30.614] Build 8862490713630728768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027920776703418848:57:0) after 1m0s
[09:49:27.162] Received PubSub notification, asking Buildbucket for the build status
[09:49:27.227] Build 8862490713630728768: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:49:27.227] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606470565585360",
"created_by": "project:chromium",
"created_ts": "1606467249229814",
"failure_reason": "BUILD_FAILURE",
"id": "8862490713630728768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"adcc1b456a8129bfa26eda97e3210c2068b42924\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ChromeSitePerProcessTestWithVerifiedUserActivation.UserActivationBrowserVerificationSameOriginSite\"}, \"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\": \"adcc1b456a8129bfa26eda97e3210c2068b42924\", \"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\": 15881, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"fcb6b5a5c55ee35d232f35bcfa9c35aefc00f89e\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"adcc1b456a8129bfa26eda97e3210c2068b42924\", \"got_revision_cp\": \"refs/heads/master@{#831505}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"961f93287f84e7e7a7f5ff8a43c7adf14ca7fc42\", \"got_v8_revision_cp\": \"refs/heads/8.9.63@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"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\": \"adcc1b456a8129bfa26eda97e3210c2068b42924\", \"swarm_hashes_refs/heads/master(at){#831505}_without_patch\": {\"absl_hardening_tests\": \"82aa67fbb5885bc90653b5daa2d0c7c71f6c2dba\", \"accessibility_unittests\": \"e1ae1f29376fe1273fda0d9dff7193ca2bb4198e\", \"angle_unittests\": \"9f0a260d5f9a3f52193277c7df9d258e334435bc\", \"app_shell_unittests\": \"9e49bef006997aa94c76d442b5c8900a5b3b5b03\", \"aura_unittests\": \"a12daebd0911b7f2842f195bb098c83ec3878f01\", \"base_unittests\": \"a320039b382f925cf086eca42b308ce2f44ca761\", \"base_util_unittests\": \"22dae98eec4f8488849be3196607efa28f5e429e\", \"blink_common_unittests\": \"8bc53c4441fcbe7a90d4e61b26541be33e1c56e3\", \"blink_fuzzer_unittests\": \"fd2d00a63c822d65259c8329e8664713aab00696\", \"blink_heap_unittests\": \"c613aa85feb56d97327834b8999e1bf44a67c78f\", \"blink_platform_unittests\": \"ad9648bd9d56b81e9eb6768837dc19cf6bc62c87\", \"blink_unittests\": \"ab9e8e1c627c2dd897d6d1d6e4edd74653ce393d\", \"boringssl_crypto_tests\": \"70879457f1fc7b8ba0f90aabe885b4877537f0c8\", \"boringssl_ssl_tests\": \"74d4cfac1c832b14ffe6dd5695a476b5a4421b09\", \"browser_switcher_bho_unittests\": \"af49d9ab209cf4b3b436608eb48c48acd746b828\", \"browser_tests\": \"c4fe0ee277cb973e455d893c36728dcfc83a66d1\", \"capture_unittests\": \"aa285dbf8493c5ff20ba714587444ee3a140d6b5\", \"cast_unittests\": \"2570b2c65733e87fbabfdacd73654ad0e229bd65\", \"cc_unittests\": \"0baf54d144d190c9406fb7fd254f761cca764a05\", \"chrome_app_unittests\": \"94b282507c3a8920829ca39b75a2cf0c0f6c0e6e\", \"chrome_cleaner_unittests\": \"318de6e6c4e10103c9df92cd011e8344ab13fe48\", \"chrome_elf_unittests\": \"6aafac4c8f94ca615b39a5379b7063623afd4145\", \"chromedriver_unittests\": \"2758753d4024a0514535d6df10a2b2ceeb2c2a43\", \"components_browsertests\": \"121f3d733f308a26d645b48eb5b4f9cdd1139619\", \"components_unittests\": \"0c749649e4b6050c9539773803a5a5bc375de3b0\", \"compositor_unittests\": \"b3dc1c431c277faff62202184ca5faecc8ad1934\", \"content_browsertests\": \"e832969bebe01fa132644285a262c82f597d38a6\", \"content_unittests\": \"b1ebdab2c50fc0a0f24f7fd58aecdf5aa406a009\", \"courgette_unittests\": \"73e4c0e4357ffe6f9c0bda3b1aa8053c4a350d1e\", \"crashpad_tests\": \"730d05a025601d65d9be64c43a90dd56b9896ff9\", \"cronet_tests\": \"7fe1b131bec5e6eb993bd8f87a319cc8adab371e\", \"cronet_unittests\": \"9915e97f2921a29ace934f157fe2434c7db78daf\", \"crypto_unittests\": \"1542c0096b5a673dafa8cdbdde8605ab40d8c7b6\", \"delayloads_unittests\": \"b3a87eb44c1b077dcb8a34b880c4c348b90bbbb3\", \"device_unittests\": \"ef95b169d9dcc5303a2b80bc84913a44d7601f4e\", \"display_unittests\": \"6ac7ebe02a1ffc21a76b339eac445cb6854976b1\", \"elevation_service_unittests\": \"a7a3e0c9dc5ad8251858a7ece7821ed650650c39\", \"events_unittests\": \"8613caff5e160367d9ace1cab36ed0f047910e99\", \"extensions_browsertests\": \"68fafd91dc278d8bc946621a956f6f978648140f\", \"extensions_unittests\": \"a14a4bc69d42be16e92b98379c4bce7d0017ebf7\", \"filesystem_service_unittests\": \"2b9d6174380df17284c3b6097638632de7184cfe\", \"gcm_unit_tests\": \"3355efb20189e3972db3c4315037c2593139fef6\", \"gcp_unittests\": \"ba7f34f54011ad0ba2d5aedc262d9a4be390d5e1\", \"gfx_unittests\": \"248117cdb673b4ff62c9995c7867465476430809\", \"gin_unittests\": \"ea193d6d53370394c007fe60f2119969cf1c6f8d\", \"google_apis_unittests\": \"4fe52cda3dd0e8a8afc2a58a410d515494a29c86\", \"gpu_unittests\": \"77a8186ea110e8d5b1915a6a36ecfe2c9fd3e915\", \"gwp_asan_unittests\": \"fb9e8672dd9392410d8f62def0ac7de9cbe49b04\", \"headless_browsertests\": \"a2ecc92f34bc22e1b193198cb25c9a227f3e32e9\", \"headless_unittests\": \"04e05dea7807637f1228f2c37cf7ebfe9124923e\", \"install_static_unittests\": \"c5eeb68b34873c43bc8bbf57ddd1b19a4bb4960e\", \"installer_util_unittests\": \"f6de54b9e7c270b672e61f945986b9d5496215ff\", \"interactive_ui_tests\": \"4ec4515fe40cfd00e1db4235503d0077ca8abc99\", \"ipc_tests\": \"d03d6ab83a72a59c5c25227c60f6ecf71128d17d\", \"jingle_unittests\": \"941cb9be449f51e4abadf90fa79ec197909f70bc\", \"latency_unittests\": \"0f2c11751c53ea8815a7f052cb9c2947e14a3437\", \"libjingle_xmpp_unittests\": \"c01e4e51af2611a8081f973e0ba2f1c42a936c71\", \"liburlpattern_unittests\": \"fd05ee5b31addaf5047a0e010bb9f6a5a3b1f3d0\", \"media_blink_unittests\": \"00d2a2372277f00ca6b73e1fc2a1f6464e2c8535\", \"media_unittests\": \"9198e097ce20847742686582c5a8f20d480e993e\", \"message_center_unittests\": \"633b78608eef73991d06b8279a48e1b3e54ec9c8\", \"midi_unittests\": \"426849819e62b467ba935f7b7b40f4fd5a570f51\", \"mojo_core_unittests\": \"5cd7d119197acac3bc5028d8c948ade749d80ab3\", \"mojo_unittests\": \"e5002eb39c5e2091a4bc92a3b07ab72b74bb7be1\", \"nacl_loader_unittests\": \"42119f37c3504d0e19b2d7164a9480a143210465\", \"native_theme_unittests\": \"541220a30ad4d47e0c4732dd719099c33e7ad075\", \"net_unittests\": \"5455e1094c834abe756d6aea029b9dd3d56df418\", \"notification_helper_unittests\": \"af00a34e6e8bf80c51ff00eb58ed4c3be18ab8a1\", \"pdf_unittests\": \"5250822a9a3f0d54d72fa0211e0e626624938580\", \"perfetto_unittests\": \"f7bed5bba44cdf165d662b7e0342643e9cd3d2f5\", \"ppapi_unittests\": \"56c8dfc18bfa51315e3ebef078cbad7281552cfa\", \"printing_unittests\": \"8a5db93b9c09ec1426888c152de87093658ad878\", \"remoting_unittests\": \"0fd103ad660f9a545452e2d03d2e375367c2ae72\", \"sbox_integration_tests\": \"0823695b4ba828c8c3dcf040649143cd5ee72128\", \"sbox_unittests\": \"d25055c36e66b930aa4d72e0df5e1f84b37a68c9\", \"sbox_validation_tests\": \"a00ad8915b9b94bc6871d3347749ea8accaeb5b0\", \"service_manager_unittests\": \"7df1109817be4b9ea832cd95fb5dbb4e3d2cf7e6\", \"services_unittests\": \"eb6d2793bee75c4c4236a5ea8d419cdf63c8522a\", \"setup_unittests\": \"923e1f0d8056ebaded370884e01174652dd38570\", \"shell_dialogs_unittests\": \"14c350522bffbe27fda814a6f80007f339e35b17\", \"skia_unittests\": \"29f1156f0770ea92fad7a9492b23dca5b58b23bd\", \"snapshot_unittests\": \"f92425734499a9bfb316fb2bf673dd12fbcac7bf\", \"sql_unittests\": \"190498fc256713750ba125c38236710735059915\", \"storage_unittests\": \"55f17fc5a49b6315043b982faafd440059caf787\", \"sync_integration_tests\": \"8fd9cbad7fd7b506fa298105164edac14a66d1f6\", \"traffic_annotation_auditor_unittests\": \"a751bf21a7ac72ffb81ddb3f72ee3a8378f44cba\", \"ui_base_unittests\": \"f44ac35cfe0100d5af25775fe57bd55544a9e3d5\", \"ui_touch_selection_unittests\": \"a0b3ea91fa495ddcbd6bb21b2116af1098787189\", \"unit_tests\": \"7fa82824643cc08dd0dca34c189b66e322380141\", \"updater_tests\": \"3db86f88e2e8d2dc51bbb9554438b7bc32469749\", \"url_unittests\": \"eea1aba62a0a470fe61554f4564fabf9ee541bc3\", \"views_unittests\": \"d448cf6bb004d2e6ea0b0d8903fbfba39c04b640\", \"viz_unittests\": \"4347102ad0b9049ac6afe1cac989fd63544b639c\", \"vr_common_unittests\": \"b11d0d2aa6db62143366e54b8bd06ff2ca8d2641\", \"vr_pixeltests\": \"24032b3c7c0de4f029e2de2939e3462c9696ff43\", \"weblayer_browsertests\": \"f0e1c4925d15ac831770a27b4f58fbf1bcda9457\", \"weblayer_unittests\": \"5f0b91fbbd6cc41c0a37a82feaaf7a190befffae\", \"wm_unittests\": \"aa5cac503a51fee18f48f62081c67e01c1950346\", \"wtf_unittests\": \"2dd747310a1d13014c454d6899d3279dfa84e078\", \"zlib_unittests\": \"827cd81e434ea291b3382deacf14a071d3870896\", \"zucchini_unittests\": \"5fc74bbf6409902855f80c97fb4a1f73fc22a570\"}}, \"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\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ChromeSitePerProcessTestWithVerifiedUserActivation.UserActivationBrowserVerificationSameOriginSite\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606467252195340",
"status": "COMPLETED",
"status_changed_ts": "1606467252482948",
"tags": [
"build_address:luci.chromium.ci/win-asan/15881",
"builder:win-asan",
"buildset:commit/git/adcc1b456a8129bfa26eda97e3210c2068b42924",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/adcc1b456a8129bfa26eda97e3210c2068b42924",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027920776703418848",
"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/8862490713630728768/+/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:5021ba71e0cd2610",
"user_agent:luci-scheduler"
],
"updated_ts": "1606470566565520",
"url": "https://ci.chromium.org/b/8862490713630728768",
"utcnow_ts": "1606470567217892"
}
}
[09:49:27.227] Invocation finished in 55m20.312020695s with status FAILED