[21:28:38.166] New invocation is queued and will start shortly
[21:28:39.316] Starting the invocation (attempt 1)
[21:28:39.355] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:28:39.355] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:28:39.355] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027873306373103472",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6b30439b9e4ba6152138d7bace67bbdfb11b2515\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027873306373103472",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"gitiles_ref:refs/heads/master"
]
}
[21:28:40.007] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606512519437375",
"id": "8862443244377460240",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b30439b9e4ba6152138d7bace67bbdfb11b2515\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606512519886471",
"tags": [
"build_address:luci.chromium.ci/win-asan/15893",
"builder:win-asan",
"buildset:commit/git/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027873306373103472",
"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/8862443244377460240/+/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": "1606512519886621",
"url": "https://ci.chromium.org/b/8862443244377460240",
"utcnow_ts": "1606512519998172"
}
}
[21:28:40.007] Task URL: https://ci.chromium.org/b/8862443244377460240
[21:28:40.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:2:0) after 1m0s
[21:28:42.942] Received PubSub notification, asking Buildbucket for the build status
[21:28:43.086] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:39.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:2:0)
[21:29:39.987] Timer tick, asking Buildbucket for the build status
[21:29:40.180] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:40.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:4:0) after 1m0s
[21:30:40.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:4:0)
[21:30:40.185] Timer tick, asking Buildbucket for the build status
[21:30:40.364] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:40.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:5:0) after 1m0s
[21:31:40.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:5:0)
[21:31:40.418] Timer tick, asking Buildbucket for the build status
[21:31:40.630] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:40.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:6:0) after 1m0s
[21:32:40.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:6:0)
[21:32:40.653] Timer tick, asking Buildbucket for the build status
[21:32:40.822] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:40.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:7:0) after 1m0s
[21:33:40.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:7:0)
[21:33:40.890] Timer tick, asking Buildbucket for the build status
[21:33:41.912] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:41.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:8:0) after 1m0s
[21:34:41.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:8:0)
[21:34:41.921] Timer tick, asking Buildbucket for the build status
[21:34:42.072] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:42.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:9:0) after 1m0s
[21:35:42.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:9:0)
[21:35:42.116] Timer tick, asking Buildbucket for the build status
[21:35:42.325] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:42.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:10:0) after 1m0s
[21:36:42.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:10:0)
[21:36:42.324] Timer tick, asking Buildbucket for the build status
[21:36:42.438] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:42.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:11:0) after 1m0s
[21:37:42.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:11:0)
[21:37:42.457] Timer tick, asking Buildbucket for the build status
[21:37:42.765] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:12:0) after 1m0s
[21:38:42.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:12:0)
[21:38:42.819] Timer tick, asking Buildbucket for the build status
[21:38:42.919] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:42.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:13:0) after 1m0s
[21:39:42.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:13:0)
[21:39:42.964] Timer tick, asking Buildbucket for the build status
[21:39:43.086] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:43.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:14:0) after 1m0s
[21:40:43.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:14:0)
[21:40:43.113] Timer tick, asking Buildbucket for the build status
[21:40:44.222] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:44.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:15:0) after 1m0s
[21:41:44.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:15:0)
[21:41:44.263] Timer tick, asking Buildbucket for the build status
[21:41:44.422] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:44.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:16:0) after 1m0s
[21:42:44.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:16:0)
[21:42:44.515] Timer tick, asking Buildbucket for the build status
[21:42:44.724] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:17:0) after 1m0s
[21:43:44.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:17:0)
[21:43:44.770] Timer tick, asking Buildbucket for the build status
[21:43:44.917] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:18:0) after 1m0s
[21:44:44.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:18:0)
[21:44:44.888] Timer tick, asking Buildbucket for the build status
[21:44:45.019] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:45.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:19:0) after 1m0s
[21:45:45.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:19:0)
[21:45:45.077] Timer tick, asking Buildbucket for the build status
[21:45:45.184] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:20:0) after 1m0s
[21:46:45.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:20:0)
[21:46:45.228] Timer tick, asking Buildbucket for the build status
[21:46:45.358] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:21:0) after 1m0s
[21:47:45.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:21:0)
[21:47:45.493] Timer tick, asking Buildbucket for the build status
[21:47:45.703] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:45.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:22:0) after 1m0s
[21:48:45.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:22:0)
[21:48:45.757] Timer tick, asking Buildbucket for the build status
[21:48:45.871] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:23:0) after 1m0s
[21:49:45.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:23:0)
[21:49:45.909] Timer tick, asking Buildbucket for the build status
[21:49:46.029] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:46.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:24:0) after 1m0s
[21:50:46.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:24:0)
[21:50:46.056] Timer tick, asking Buildbucket for the build status
[21:50:46.249] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:25:0) after 1m0s
[21:51:46.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:25:0)
[21:51:46.309] Timer tick, asking Buildbucket for the build status
[21:51:46.928] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:46.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:26:0) after 1m0s
[21:52:47.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:26:0)
[21:52:47.010] Timer tick, asking Buildbucket for the build status
[21:52:47.092] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:27:0) after 1m0s
[21:53:47.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:27:0)
[21:53:47.107] Timer tick, asking Buildbucket for the build status
[21:53:47.210] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:28:0) after 1m0s
[21:54:47.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:28:0)
[21:54:47.299] Timer tick, asking Buildbucket for the build status
[21:54:47.375] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:47.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:29:0) after 1m0s
[21:55:47.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:29:0)
[21:55:47.431] Timer tick, asking Buildbucket for the build status
[21:55:47.954] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:47.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:30:0) after 1m0s
[21:56:47.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:30:0)
[21:56:47.964] Timer tick, asking Buildbucket for the build status
[21:56:48.218] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:48.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:31:0) after 1m0s
[21:57:48.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:31:0)
[21:57:48.230] Timer tick, asking Buildbucket for the build status
[21:57:48.339] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:48.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:32:0) after 1m0s
[21:58:48.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:32:0)
[21:58:48.362] Timer tick, asking Buildbucket for the build status
[21:58:48.497] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:48.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:33:0) after 1m0s
[21:59:48.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:33:0)
[21:59:48.516] Timer tick, asking Buildbucket for the build status
[21:59:48.588] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:48.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:34:0) after 1m0s
[22:00:48.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:34:0)
[22:00:48.577] Timer tick, asking Buildbucket for the build status
[22:00:48.676] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:48.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:35:0) after 1m0s
[22:01:48.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:35:0)
[22:01:48.693] Timer tick, asking Buildbucket for the build status
[22:01:48.863] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:48.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:36:0) after 1m0s
[22:02:48.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:36:0)
[22:02:48.922] Timer tick, asking Buildbucket for the build status
[22:02:49.247] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:49.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:37:0) after 1m0s
[22:03:49.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:37:0)
[22:03:49.277] Timer tick, asking Buildbucket for the build status
[22:03:49.397] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:49.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:38:0) after 1m0s
[22:04:49.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:38:0)
[22:04:49.434] Timer tick, asking Buildbucket for the build status
[22:04:49.623] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:49.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:39:0) after 1m0s
[22:05:49.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:39:0)
[22:05:49.647] Timer tick, asking Buildbucket for the build status
[22:05:49.874] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:49.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:40:0) after 1m0s
[22:06:49.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:40:0)
[22:06:49.893] Timer tick, asking Buildbucket for the build status
[22:06:50.418] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:41:0) after 1m0s
[22:07:50.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:41:0)
[22:07:50.556] Timer tick, asking Buildbucket for the build status
[22:07:50.646] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:42:0) after 1m0s
[22:08:50.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:42:0)
[22:08:50.685] Timer tick, asking Buildbucket for the build status
[22:08:50.800] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:50.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:43:0) after 1m0s
[22:09:50.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:43:0)
[22:09:50.873] Timer tick, asking Buildbucket for the build status
[22:09:50.991] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:50.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:44:0) after 1m0s
[22:10:51.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:44:0)
[22:10:51.093] Timer tick, asking Buildbucket for the build status
[22:10:51.455] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:45:0) after 1m0s
[22:11:51.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:45:0)
[22:11:51.495] Timer tick, asking Buildbucket for the build status
[22:11:51.595] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:51.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:46:0) after 1m0s
[22:12:51.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:46:0)
[22:12:51.650] Timer tick, asking Buildbucket for the build status
[22:12:51.767] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:47:0) after 1m0s
[22:13:51.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:47:0)
[22:13:51.797] Timer tick, asking Buildbucket for the build status
[22:13:52.139] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:52.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:48:0) after 1m0s
[22:14:52.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:48:0)
[22:14:52.209] Timer tick, asking Buildbucket for the build status
[22:14:52.288] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:49:0) after 1m0s
[22:15:52.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:49:0)
[22:15:52.389] Timer tick, asking Buildbucket for the build status
[22:15:52.471] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:52.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:50:0) after 1m0s
[22:16:52.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:50:0)
[22:16:52.571] Timer tick, asking Buildbucket for the build status
[22:16:52.646] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:52.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:51:0) after 1m0s
[22:17:52.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:51:0)
[22:17:52.863] Timer tick, asking Buildbucket for the build status
[22:17:52.951] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:52.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:52:0) after 1m0s
[22:18:53.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:52:0)
[22:18:53.086] Timer tick, asking Buildbucket for the build status
[22:18:53.198] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:53:0) after 1m0s
[22:19:53.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:53:0)
[22:19:53.296] Timer tick, asking Buildbucket for the build status
[22:19:53.424] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:53.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:54:0) after 1m0s
[22:20:53.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:54:0)
[22:20:53.507] Timer tick, asking Buildbucket for the build status
[22:20:53.659] Build 8862443244377460240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:53.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027873306373103472:55:0) after 1m0s
[22:20:59.831] Received PubSub notification, asking Buildbucket for the build status
[22:20:59.914] Build 8862443244377460240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:20:59.914] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606515658892173",
"created_by": "project:chromium",
"created_ts": "1606512519437375",
"id": "8862443244377460240",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b30439b9e4ba6152138d7bace67bbdfb11b2515\"}}",
"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\": \"6b30439b9e4ba6152138d7bace67bbdfb11b2515\", \"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\": 15893, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"a5da17cd4e19649288b9634e7fff32455403b856\", \"got_dawn_revision\": \"e96986149080ca37e82788c907f439bc070aaa7b\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6b30439b9e4ba6152138d7bace67bbdfb11b2515\", \"got_revision_cp\": \"refs/heads/master@{#831649}\", \"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\": \"6b30439b9e4ba6152138d7bace67bbdfb11b2515\", \"swarm_hashes_refs/heads/master(at){#831649}_without_patch\": {\"absl_hardening_tests\": \"9509b936e1e93db1fce16ea3976e7b806fa31537\", \"accessibility_unittests\": \"b453f2b5562f20323ccbb21f64ca03ad7904e667\", \"angle_unittests\": \"192deb6ef56b86df372643139292597fc48ebc25\", \"app_shell_unittests\": \"0fd8a94df653cd02e37739b2266c751a4e6eb993\", \"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\": \"bb462f7bd33ef0072c8a67a88cc1dd3eb26935e8\", \"capture_unittests\": \"ff18fe8ec2b88e373b8e862921ea900dc4b42466\", \"cast_unittests\": \"3edafff0126c609a52be95d46b93f8ca98bb7540\", \"cc_unittests\": \"ba135175ed65c0fc44a126c3f4460570b08f2cf6\", \"chrome_app_unittests\": \"e8f3a92bf2db56b74fe4b6f3eafc9f4ce00cad64\", \"chrome_cleaner_unittests\": \"4038fdd7fdf5a796b45735e16ab0ffe5e1cba684\", \"chrome_elf_unittests\": \"31343e79fbda32cf8133656e5764ffb3c10d75e3\", \"chromedriver_unittests\": \"0beb3fff2fe6df5bbe2e843f6097807ab233f17f\", \"components_browsertests\": \"c9f4f34b2e71365be9d3ee568a1e87c1cde13669\", \"components_unittests\": \"97413b171987dec8ce48e11daa7f25b4b9444062\", \"compositor_unittests\": \"f75df333bb82232611eaa55269b9ea35c010fc4a\", \"content_browsertests\": \"75dcb37f7e18ef42fc4b450c2462aab73360aabb\", \"content_unittests\": \"22a4ee6dc4317f79958d2be82642743b95ca4aaa\", \"courgette_unittests\": \"da8dcd05044e7e94cf2f9c858ac5f00f0abd6e74\", \"crashpad_tests\": \"4231be2777e5527e07ac488ad2db6c4b31d13bb9\", \"cronet_tests\": \"94bd7b923903690737a258fef66184cd75fe37e0\", \"cronet_unittests\": \"7751056232f00b913c7a8c6540291d4b685d5ea2\", \"crypto_unittests\": \"9e3e9ea2685b65b9eb88cbd73754461955da9d30\", \"delayloads_unittests\": \"6d1c7d40c44002b17569ed036b181069f58347fa\", \"device_unittests\": \"5332650fa98fefe685aa4dd2bce726b6499857ed\", \"display_unittests\": \"51799191667b3f70c8995748c3d6b5d276baf61e\", \"elevation_service_unittests\": \"bf16033e784b92fd50ad8ea5e4d02e27e66539f4\", \"events_unittests\": \"2bf55fa9dc4a09b49080ce05b1107a7e145c477f\", \"extensions_browsertests\": \"7c43ea5af09f9341828f4dabe57798beb24c6f4b\", \"extensions_unittests\": \"47b920456fab95f9daac05829e28a7649c2f21e6\", \"filesystem_service_unittests\": \"c74aabc5cf8b91ea1c7c50b05e3a3822db0fb0db\", \"gcm_unit_tests\": \"e2a8bdc8cb3c1a0425be5abff5a4138b025bb0cc\", \"gcp_unittests\": \"bb1ec2dd418ece6db47a61f363c5c3dc2995f7d9\", \"gfx_unittests\": \"259b609ee8adc78ca5162f777c76882fa0e5312e\", \"gin_unittests\": \"49c893b177577058993259734c659e4e8e27065a\", \"google_apis_unittests\": \"ad9690cc9dd6801c3a779172a1ec8227155e7ce8\", \"gpu_unittests\": \"cedfbfcc3a7d58e978d7cf055c9366de70c33309\", \"gwp_asan_unittests\": \"8e1650ed78e7489fc10981a41cfb88d6d0553c0d\", \"headless_browsertests\": \"4a0881709a8830b376da2fb1407dcd379afa6ebc\", \"headless_unittests\": \"26797e42f9b1e46bc626db713befd5fdf192adb7\", \"install_static_unittests\": \"2cea63a14149a580deea62da5e6497b168fe1c55\", \"installer_util_unittests\": \"51a6fe3cf187e1a03398cc6880ed95ce60f867bc\", \"interactive_ui_tests\": \"a2c4c84516d89ebad9e746d687c268b77914f930\", \"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\": \"fbce36765a1d307fc90093408905306b0fbb331d\", \"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\": \"8ba757ae2300d1b959f01d291b44919e0a67baea\", \"traffic_annotation_auditor_unittests\": \"fa69f52c8f9031dd5259f2a39072e8cede12eb1d\", \"ui_base_unittests\": \"d81231ae7f445af41db1fec55131f5e6bd395dd3\", \"ui_touch_selection_unittests\": \"79e1060850f454babe3722931f51a8e0ca0fc071\", \"unit_tests\": \"7d28c9866a6cde9b104a1836777b1e71b9368d12\", \"updater_tests\": \"2b6f7c4b2fa4d41e098e1cfedcf28a0af62e75de\", \"url_unittests\": \"4d2f28e5f33e832ba9417998319ca698f5fc03d9\", \"views_unittests\": \"41b7f79d421e4c28e308b03672573c8231c7608a\", \"viz_unittests\": \"f227d4a492323e6a9060010638e54c675e08a480\", \"vr_common_unittests\": \"0f7a2e7e59c1684562f222afc76479535f9472d6\", \"vr_pixeltests\": \"83c826932c9bd2d81fb4e7c8b80918c50d98782d\", \"weblayer_browsertests\": \"b1fa431bf15a1b8b6d0f899a4f0619174aa81258\", \"weblayer_unittests\": \"6e9ec1295776dd2fb6bca2690c8029190b6f820e\", \"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": "1606512522269996",
"status": "COMPLETED",
"status_changed_ts": "1606515659261165",
"tags": [
"build_address:luci.chromium.ci/win-asan/15893",
"builder:win-asan",
"buildset:commit/git/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b30439b9e4ba6152138d7bace67bbdfb11b2515",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027873306373103472",
"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/8862443244377460240/+/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:50246d344ca5a510",
"user_agent:luci-scheduler"
],
"updated_ts": "1606515659267672",
"url": "https://ci.chromium.org/b/8862443244377460240",
"utcnow_ts": "1606515659905545"
}
}
[22:20:59.914] Invocation finished in 52m21.764459755s with status SUCCEEDED