[08:32:41.752] New invocation is queued and will start shortly
[08:32:42.984] Starting the invocation (attempt 1)
[08:32:43.031] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:32:43.031] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:32:43.031] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022939291159597536",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3f9cd882eda35d29a2997b876bf5a975a11e2ece\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022939291159597536",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"gitiles_ref:refs/heads/master"
]
}
[08:32:45.008] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611217963272863",
"id": "8857509228902237296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f9cd882eda35d29a2997b876bf5a975a11e2ece\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611217964580350",
"tags": [
"build_address:luci.chromium.ci/win-asan/16927",
"builder:win-asan",
"buildset:commit/git/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022939291159597536",
"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/8857509228902237296/+/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": "1611217964580773",
"url": "https://ci.chromium.org/b/8857509228902237296",
"utcnow_ts": "1611217964994761"
}
}
[08:32:45.009] Task URL: https://ci.chromium.org/b/8857509228902237296
[08:32:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:2:0) after 1m0s
[08:32:48.743] Received PubSub notification, asking Buildbucket for the build status
[08:32:48.835] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:45.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:2:0)
[08:33:45.027] Timer tick, asking Buildbucket for the build status
[08:33:45.131] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:45.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:4:0) after 1m0s
[08:34:45.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:4:0)
[08:34:45.194] Timer tick, asking Buildbucket for the build status
[08:34:45.389] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:45.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:5:0) after 1m0s
[08:35:45.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:5:0)
[08:35:45.467] Timer tick, asking Buildbucket for the build status
[08:35:45.583] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:45.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:6:0) after 1m0s
[08:36:45.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:6:0)
[08:36:45.589] Timer tick, asking Buildbucket for the build status
[08:36:45.689] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:45.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:7:0) after 1m0s
[08:37:45.706] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:7:0)
[08:37:45.706] Timer tick, asking Buildbucket for the build status
[08:37:45.817] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:45.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:8:0) after 1m0s
[08:38:45.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:8:0)
[08:38:45.788] Timer tick, asking Buildbucket for the build status
[08:38:45.879] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:45.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:9:0) after 1m0s
[08:39:45.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:9:0)
[08:39:45.936] Timer tick, asking Buildbucket for the build status
[08:39:46.102] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:46.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:10:0) after 1m0s
[08:40:46.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:10:0)
[08:40:46.146] Timer tick, asking Buildbucket for the build status
[08:40:46.267] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:46.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:11:0) after 1m0s
[08:41:46.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:11:0)
[08:41:46.300] Timer tick, asking Buildbucket for the build status
[08:41:46.616] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:46.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:12:0) after 1m0s
[08:42:46.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:12:0)
[08:42:46.617] Timer tick, asking Buildbucket for the build status
[08:42:47.112] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:13:0) after 1m0s
[08:43:47.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:13:0)
[08:43:47.128] Timer tick, asking Buildbucket for the build status
[08:43:47.249] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:47.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:14:0) after 1m0s
[08:44:47.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:14:0)
[08:44:47.302] Timer tick, asking Buildbucket for the build status
[08:44:47.610] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:47.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:15:0) after 1m0s
[08:45:47.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:15:0)
[08:45:47.663] Timer tick, asking Buildbucket for the build status
[08:45:47.763] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:47.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:16:0) after 1m0s
[08:46:47.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:16:0)
[08:46:47.818] Timer tick, asking Buildbucket for the build status
[08:46:48.141] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:48.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:17:0) after 1m0s
[08:47:48.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:17:0)
[08:47:48.134] Timer tick, asking Buildbucket for the build status
[08:47:48.251] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:48.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:18:0) after 1m0s
[08:48:48.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:18:0)
[08:48:48.301] Timer tick, asking Buildbucket for the build status
[08:48:48.740] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:19:0) after 1m0s
[08:49:48.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:19:0)
[08:49:48.797] Timer tick, asking Buildbucket for the build status
[08:49:48.918] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:48.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:20:0) after 1m0s
[08:50:48.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:20:0)
[08:50:48.937] Timer tick, asking Buildbucket for the build status
[08:50:49.153] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:49.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:21:0) after 1m0s
[08:51:49.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:21:0)
[08:51:49.232] Timer tick, asking Buildbucket for the build status
[08:51:49.351] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:49.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:22:0) after 1m0s
[08:52:49.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:22:0)
[08:52:49.490] Timer tick, asking Buildbucket for the build status
[08:52:49.624] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:49.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:23:0) after 1m0s
[08:53:49.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:23:0)
[08:53:49.646] Timer tick, asking Buildbucket for the build status
[08:53:49.716] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:49.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:24:0) after 1m0s
[08:54:49.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:24:0)
[08:54:49.736] Timer tick, asking Buildbucket for the build status
[08:54:50.222] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:50.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:25:0) after 1m0s
[08:55:50.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:25:0)
[08:55:50.258] Timer tick, asking Buildbucket for the build status
[08:55:50.381] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:50.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:26:0) after 1m0s
[08:56:50.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:26:0)
[08:56:50.434] Timer tick, asking Buildbucket for the build status
[08:56:50.501] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:50.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:27:0) after 1m0s
[08:57:50.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:27:0)
[08:57:50.598] Timer tick, asking Buildbucket for the build status
[08:57:50.714] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:50.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:28:0) after 1m0s
[08:58:50.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:28:0)
[08:58:50.771] Timer tick, asking Buildbucket for the build status
[08:58:51.608] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:51.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:29:0) after 1m0s
[08:59:51.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:29:0)
[08:59:51.672] Timer tick, asking Buildbucket for the build status
[08:59:51.775] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:51.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:30:0) after 1m0s
[09:00:51.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:30:0)
[09:00:51.888] Timer tick, asking Buildbucket for the build status
[09:00:52.032] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:52.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:31:0) after 1m0s
[09:01:52.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:31:0)
[09:01:52.024] Timer tick, asking Buildbucket for the build status
[09:01:52.469] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:52.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:32:0) after 1m0s
[09:02:52.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:32:0)
[09:02:52.525] Timer tick, asking Buildbucket for the build status
[09:02:52.932] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:52.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:33:0) after 1m0s
[09:03:52.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:33:0)
[09:03:52.939] Timer tick, asking Buildbucket for the build status
[09:03:53.040] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:53.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:34:0) after 1m0s
[09:04:53.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:34:0)
[09:04:53.077] Timer tick, asking Buildbucket for the build status
[09:04:53.224] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:53.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:35:0) after 1m0s
[09:05:53.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:35:0)
[09:05:53.250] Timer tick, asking Buildbucket for the build status
[09:05:53.328] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:53.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:36:0) after 1m0s
[09:06:53.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:36:0)
[09:06:53.322] Timer tick, asking Buildbucket for the build status
[09:06:53.410] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:37:0) after 1m0s
[09:07:53.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:37:0)
[09:07:53.435] Timer tick, asking Buildbucket for the build status
[09:07:53.968] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:53.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:38:0) after 1m0s
[09:08:54.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:38:0)
[09:08:54.011] Timer tick, asking Buildbucket for the build status
[09:08:54.408] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:54.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:39:0) after 1m0s
[09:09:54.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:39:0)
[09:09:54.450] Timer tick, asking Buildbucket for the build status
[09:09:54.577] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:54.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:40:0) after 1m0s
[09:10:54.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:40:0)
[09:10:54.629] Timer tick, asking Buildbucket for the build status
[09:10:54.748] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:54.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:41:0) after 1m0s
[09:11:54.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:41:0)
[09:11:54.862] Timer tick, asking Buildbucket for the build status
[09:11:55.001] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:55.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:42:0) after 1m0s
[09:12:55.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:42:0)
[09:12:55.039] Timer tick, asking Buildbucket for the build status
[09:12:55.158] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:55.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:43:0) after 1m0s
[09:13:55.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:43:0)
[09:13:55.186] Timer tick, asking Buildbucket for the build status
[09:13:55.339] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:44:0) after 1m0s
[09:14:55.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:44:0)
[09:14:55.361] Timer tick, asking Buildbucket for the build status
[09:14:55.484] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:55.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:45:0) after 1m0s
[09:15:55.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:45:0)
[09:15:55.543] Timer tick, asking Buildbucket for the build status
[09:15:55.638] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:55.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:46:0) after 1m0s
[09:16:55.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:46:0)
[09:16:55.663] Timer tick, asking Buildbucket for the build status
[09:16:55.782] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:55.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:47:0) after 1m0s
[09:17:55.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:47:0)
[09:17:55.836] Timer tick, asking Buildbucket for the build status
[09:17:56.162] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:56.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:48:0) after 1m0s
[09:18:56.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:48:0)
[09:18:56.186] Timer tick, asking Buildbucket for the build status
[09:18:56.262] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:56.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:49:0) after 1m0s
[09:19:56.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:49:0)
[09:19:56.292] Timer tick, asking Buildbucket for the build status
[09:19:56.636] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:56.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:50:0) after 1m0s
[09:20:56.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:50:0)
[09:20:56.695] Timer tick, asking Buildbucket for the build status
[09:20:56.842] Build 8857509228902237296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:56.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022939291159597536:51:0) after 1m0s
[09:21:43.905] Received PubSub notification, asking Buildbucket for the build status
[09:21:44.380] Build 8857509228902237296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:21:44.380] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611220903063632",
"created_by": "project:chromium",
"created_ts": "1611217963272863",
"id": "8857509228902237296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f9cd882eda35d29a2997b876bf5a975a11e2ece\"}}",
"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\": \"3f9cd882eda35d29a2997b876bf5a975a11e2ece\", \"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-us-central1-b-32-0-gbsn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16927, \"clang_revision\": \"llvmorg-12-init-16548-gf1d5cbbd-1\", \"got_angle_revision\": \"bb7660008b16bd0fea2bf114075aece585fbe1f1\", \"got_dawn_revision\": \"762814bd922932d3d9da9b220463b6ce5f167d76\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"3f9cd882eda35d29a2997b876bf5a975a11e2ece\", \"got_revision_cp\": \"refs/heads/master@{#845557}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"ed78a10326a2854dcf8561c61c974270f8e01dbe\", \"got_v8_revision_cp\": \"refs/heads/9.0.34@{#1}\", \"got_webrtc_revision\": \"49b20f919abe9a21227b0f6f86d223a3fb1e5ee4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33048}\", \"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\": \"3f9cd882eda35d29a2997b876bf5a975a11e2ece\", \"swarm_hashes_refs/heads/master(at){#845557}_without_patch\": {\"absl_hardening_tests\": \"dc35cb42963efcea80f33ed5c78fd03aed79fcb6\", \"accessibility_unittests\": \"09e1139fa610207da2a02e04f0384f0a8a18b254\", \"angle_unittests\": \"5723548142bdb8fbca4b7cf133d5656feb7da5d1\", \"app_shell_unittests\": \"0669d51c4e29eb0b43345c702773b207a4850c5f\", \"aura_unittests\": \"c9a29abfcd3f00681d26170b152e7080dd0a4244\", \"base_unittests\": \"17cf1e6082693145e29d58c8224f1bd42cb64c98\", \"base_util_unittests\": \"f9ad5889cc13f826ef49367cd1efeb2a3cae4d6f\", \"blink_common_unittests\": \"4c8771d24e0dee58c57afd3686de7fe4d498fcd5\", \"blink_fuzzer_unittests\": \"d406311c293cda9e07358e0d20cba06020f763e6\", \"blink_heap_unittests\": \"e689d60083935b3ab3f6caf973e60139b7e05e24\", \"blink_platform_unittests\": \"4c3d91eda120986a749736be218d05392cd08a45\", \"blink_unittests\": \"a03b4bac791d427825411817aa1c8e7aa8427e78\", \"boringssl_crypto_tests\": \"11c5024930a6fae2479d268bf8604e4fab4dc188\", \"boringssl_ssl_tests\": \"298fd77075a2fe073948e92c10bba7904588c176\", \"browser_switcher_bho_unittests\": \"cba2ae6ca042740a44508802432b5e656df7bb18\", \"browser_tests\": \"059f9b3d04691502252d2ca5add4a03847a80742\", \"capture_unittests\": \"201a670638d2cf2edfa2c91d98855562d43ff08a\", \"cast_unittests\": \"f86392225975c475bec03c24570fbd4a045124f5\", \"cc_unittests\": \"5f04e689d46666e097b5e335e33fb30e4d419ace\", \"chrome_app_unittests\": \"a5fc6206fdc33bb29d5681e65a64f3d5728539f8\", \"chrome_cleaner_unittests\": \"0b9a577310301ac1ab026efc10f0d2e1e47fdd37\", \"chrome_elf_unittests\": \"ae066e866c64d667e301ca2827d8730115cb5532\", \"chromedriver_unittests\": \"cc3e6ce87ff83d0b39804599453526e339cf8422\", \"components_browsertests\": \"11eddbd02f2d3b1c0e49783cb9aa94bc7bae491e\", \"components_unittests\": \"a85a4b9a88273dee1426fece72c9dc95c74a9542\", \"compositor_unittests\": \"05c1ecbe22ac77c306d569d26b020683b2d7a7b2\", \"content_browsertests\": \"82f4ce341ffd72512b3d053f89db35cf2dfc7e32\", \"content_unittests\": \"680f65c86aa22dbb74109b83549a1bcb31753ff1\", \"courgette_unittests\": \"c725ca5979a190556e7436ce0f798af592d6e11c\", \"crashpad_tests\": \"cf582ac6f64b54b0cc25c81310e42ad4785f7d9d\", \"cronet_tests\": \"2d9bc014cc5c763164040b2b2e28354bac1fe6c6\", \"cronet_unittests\": \"ed605f551885e73cbfd4a417198d191e17b807c5\", \"crypto_unittests\": \"2bcd04804f9fe00c0a83eccfeb257815c980eea9\", \"delayloads_unittests\": \"7dd3af3e9b535c5e775726a89c7d8f64c455b33f\", \"device_unittests\": \"56b6c2fa800ffbb932b5a7ebcbd7be634784cbde\", \"display_unittests\": \"947ce1de50b7a73052aea86af5d7a63c26517498\", \"elevation_service_unittests\": \"67255f29f13c577883d53f6faa46d64c0d0a3391\", \"events_unittests\": \"fd752f0dd1ffa8aa36a37417283cf11b443e9582\", \"extensions_browsertests\": \"9c9b89b1a5204690474a11710caf8ade55858bbe\", \"extensions_unittests\": \"f34556d4bdefe4a7fd7603732b49326dec770f8f\", \"filesystem_service_unittests\": \"4ddef985e5d547e38317d33a49633dea948cc036\", \"gcm_unit_tests\": \"de3a41b889dc6265e20d2b92f2eb6121e8ad6551\", \"gcp_unittests\": \"c4c5bcca8074b9fd6c4dcb44065df04168523039\", \"gfx_unittests\": \"b9b59b4570052676471d72714634c464c55dfdad\", \"gin_unittests\": \"b45773a3373b09b8a7f6bdff8680f13a890b359c\", \"google_apis_unittests\": \"cbb03da9e663dd298921254b0a48febc444b6e01\", \"gpu_unittests\": \"85b8f2b4e634fc9a0ec8eb8554a6f31571ab159a\", \"gwp_asan_unittests\": \"bdb7e454615f0f8e7a5f185f1c890fdd2b3f1f65\", \"headless_browsertests\": \"7975c8ed420b4a3013d08bc4f46fe67f38bf4092\", \"headless_unittests\": \"1a76fbe3069ae3c93dee2096190200863560e29e\", \"install_static_unittests\": \"67455bcc07270bdf99f1fc95187b28befd3c39cc\", \"installer_util_unittests\": \"795d53b9ab76cfb7bfd2524396735dfa48ffc760\", \"interactive_ui_tests\": \"23fac4023eceeaa5df8f008ff06f9b88d4b9f32f\", \"ipc_tests\": \"8a17c5292863f44608cf0b2bde495f883e646890\", \"jingle_unittests\": \"95060c7b483f497a0919a14ad5840f13fcba4d27\", \"latency_unittests\": \"a536b1fe61cf3d56cf9b5286cd8fcc760d3b6c44\", \"libjingle_xmpp_unittests\": \"5c8d9044710bb65d9dba9c456f1ed03567481b05\", \"liburlpattern_unittests\": \"85603534e43c823ba89be9c73c2176c4a25ce960\", \"media_blink_unittests\": \"84770b259e3eabd3b8c7c7d84120abdcbfa8155a\", \"media_unittests\": \"61aabf483fa18b7d6f0ff9ed0f2bc6dfc8312fc0\", \"message_center_unittests\": \"d8be508dd1d943c1aebd8770dab8fe0d8cab2568\", \"midi_unittests\": \"7caa641f73ee1405bf557d28c3e6a702e07ad57b\", \"mojo_core_unittests\": \"e379fc39a7bf7c68630eb17deeaffc07e7e1525c\", \"mojo_unittests\": \"23129bc3563e914ee12b0e14f20178ab583ead5c\", \"nacl_loader_unittests\": \"7734b1977c162f7a2c99df6eaa31974141e5510c\", \"native_theme_unittests\": \"54887ec934208a3c67eaa22151723142c1d14992\", \"net_unittests\": \"164743677f1fa2595f8613c3f9501eade17f3635\", \"notification_helper_unittests\": \"cc0d8bc6b5e43a7ab6475283b0154210f087a861\", \"pdf_unittests\": \"70d6f9e35707d7d7bc0ba40f162ec46427828995\", \"perfetto_unittests\": \"0ff1711e5d1c49e41a523bcbcdcd0a8ab466d551\", \"ppapi_unittests\": \"f9caadefeff1db6b57711b59fc87d1b144af434f\", \"printing_unittests\": \"bf235dc21c53bee9585d87698d818e096d6a9b46\", \"remoting_unittests\": \"ccfe9cecc83fb3460505cb46b97822d6900eecd7\", \"sbox_integration_tests\": \"93bcd74cc639c50c0250b77ad99610fc81dcf606\", \"sbox_unittests\": \"a91a6af93289d004a5c0a50bcc8095be039d02ac\", \"sbox_validation_tests\": \"5a8e8c365c88e928032cc2857c1e55f0c4eb819d\", \"service_manager_unittests\": \"8730515b75e09fcdc8956cfc28db37fff2056020\", \"services_unittests\": \"a02680932335620a89669b572d43bafa7912c2db\", \"setup_unittests\": \"9e857b553cef8f834ca58e2b8965441f97f3537b\", \"shell_dialogs_unittests\": \"fd4e8c6580f8af518e4665fb08c1be2913dbdea7\", \"skia_unittests\": \"01653f77585e6573d59f49d9b581449dce8f37f5\", \"snapshot_unittests\": \"2d6a3187d06b7a248ca5c8ca96f361b5adfd9a0a\", \"sql_unittests\": \"7f6b83e752787be6b5beed8f2fc80218231bc6e2\", \"storage_unittests\": \"c7f53fd0ecf864b126e91f03101bc8cee2929a97\", \"sync_integration_tests\": \"b76483bb843093e9d1c8abb20f694899a87d8db6\", \"traffic_annotation_auditor_unittests\": \"ed6d4efd2da86df36937643be0fcaff3b895ed18\", \"ui_base_unittests\": \"150c30eb09fa0cefb5380a597f98ff010e212a24\", \"ui_touch_selection_unittests\": \"af62e03387d23d1f208f8db99dd12f3980af1f1b\", \"unit_tests\": \"bebd8eddd734658bcb685c29bb9e2796d4ea4393\", \"updater_tests\": \"8f073fd3b56f43d5a93a0d3a50e4a4cfb4443626\", \"url_unittests\": \"2da501f278a38ed18bd70d43d6dc16ff64c84779\", \"views_unittests\": \"421a599795223f7ada8406c806344464cfe8d3ac\", \"viz_unittests\": \"0e14160dc96d6200bd27a4b593611d9453d5db62\", \"vr_common_unittests\": \"abfcb7c00607aba999c354f8d6852470c9f4a903\", \"vr_pixeltests\": \"a25a53c01b72809e3baafe0a45c1e308e0b90f6b\", \"weblayer_browsertests\": \"4482a83cfadb0a93f9985c1479a2a6b028e38219\", \"weblayer_unittests\": \"ee259fd315051e8bfd61de6e957f120f63c2a5ca\", \"wm_unittests\": \"971d1c35ecbdd7f1d5f09ee4cc88f4a30cc69ffe\", \"wtf_unittests\": \"9728b76bb33d028d0379348c340672b3f842d1b1\", \"zlib_unittests\": \"27d2261a0214c40fe246bac81651fa22feaffd83\", \"zucchini_unittests\": \"6dee760ca2f9478f1ef0428c4cfd8e83df105bf1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-gbsn\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611217968089613",
"status": "COMPLETED",
"status_changed_ts": "1611220903316159",
"tags": [
"build_address:luci.chromium.ci/win-asan/16927",
"builder:win-asan",
"buildset:commit/git/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f9cd882eda35d29a2997b876bf5a975a11e2ece",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022939291159597536",
"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/8857509228902237296/+/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:513ce497b57dfa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611220903320910",
"url": "https://ci.chromium.org/b/8857509228902237296",
"utcnow_ts": "1611220904021394"
}
}
[09:21:44.380] Invocation finished in 49m2.644748116s with status SUCCEEDED