[22:57:28.709] New invocation is queued and will start shortly
[22:57:29.941] Starting the invocation (attempt 1)
[22:57:29.986] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:57:29.986] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:57:29.986] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023609659473150032",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"79f7d6932338b363482f68d530ec7b6ae2934b09\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023609659473150032",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/79f7d6932338b363482f68d530ec7b6ae2934b09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/79f7d6932338b363482f68d530ec7b6ae2934b09",
"gitiles_ref:refs/heads/master"
]
}
[22:57:31.005] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1610578650072605",
"id": "8858179597380289232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"79f7d6932338b363482f68d530ec7b6ae2934b09\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610578650728523",
"tags": [
"build_address:luci.chromium.ci/win-asan/16804",
"builder:win-asan",
"buildset:commit/git/79f7d6932338b363482f68d530ec7b6ae2934b09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/79f7d6932338b363482f68d530ec7b6ae2934b09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023609659473150032",
"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/8858179597380289232/+/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": "1610578650728648",
"url": "https://ci.chromium.org/b/8858179597380289232",
"utcnow_ts": "1610578650983823"
}
}
[22:57:31.005] Task URL: https://ci.chromium.org/b/8858179597380289232
[22:57:31.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:2:0) after 1m0s
[22:57:33.451] Received PubSub notification, asking Buildbucket for the build status
[22:57:34.339] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:31.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:2:0)
[22:58:31.005] Timer tick, asking Buildbucket for the build status
[22:58:31.114] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:31.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:4:0) after 1m0s
[22:59:31.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:4:0)
[22:59:31.183] Timer tick, asking Buildbucket for the build status
[22:59:31.339] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:31.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:5:0) after 1m0s
[23:00:31.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:5:0)
[23:00:31.422] Timer tick, asking Buildbucket for the build status
[23:00:31.594] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:31.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:6:0) after 1m0s
[23:01:31.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:6:0)
[23:01:31.646] Timer tick, asking Buildbucket for the build status
[23:01:31.776] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:31.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:7:0) after 1m0s
[23:02:31.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:7:0)
[23:02:31.835] Timer tick, asking Buildbucket for the build status
[23:02:31.991] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:31.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:8:0) after 1m0s
[23:03:32.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:8:0)
[23:03:32.103] Timer tick, asking Buildbucket for the build status
[23:03:32.185] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:32.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:9:0) after 1m0s
[23:04:32.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:9:0)
[23:04:32.303] Timer tick, asking Buildbucket for the build status
[23:04:32.562] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:32.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:10:0) after 1m0s
[23:05:32.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:10:0)
[23:05:32.600] Timer tick, asking Buildbucket for the build status
[23:05:32.688] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:32.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:11:0) after 1m0s
[23:06:32.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:11:0)
[23:06:32.747] Timer tick, asking Buildbucket for the build status
[23:06:32.924] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:32.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:12:0) after 1m0s
[23:07:33.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:12:0)
[23:07:33.006] Timer tick, asking Buildbucket for the build status
[23:07:33.226] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:13:0) after 1m0s
[23:08:33.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:13:0)
[23:08:33.258] Timer tick, asking Buildbucket for the build status
[23:08:33.713] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:33.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:14:0) after 1m0s
[23:09:33.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:14:0)
[23:09:33.783] Timer tick, asking Buildbucket for the build status
[23:09:34.748] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:15:0) after 1m0s
[23:10:34.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:15:0)
[23:10:34.889] Timer tick, asking Buildbucket for the build status
[23:10:34.981] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:34.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:16:0) after 1m0s
[23:11:35.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:16:0)
[23:11:35.079] Timer tick, asking Buildbucket for the build status
[23:11:35.219] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:17:0) after 1m0s
[23:12:35.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:17:0)
[23:12:35.331] Timer tick, asking Buildbucket for the build status
[23:12:35.451] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:18:0) after 1m0s
[23:13:35.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:18:0)
[23:13:35.520] Timer tick, asking Buildbucket for the build status
[23:13:35.679] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:35.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:19:0) after 1m0s
[23:14:35.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:19:0)
[23:14:35.758] Timer tick, asking Buildbucket for the build status
[23:14:35.864] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:35.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:20:0) after 1m0s
[23:15:35.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:20:0)
[23:15:35.885] Timer tick, asking Buildbucket for the build status
[23:15:36.022] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:36.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:21:0) after 1m0s
[23:16:36.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:21:0)
[23:16:36.074] Timer tick, asking Buildbucket for the build status
[23:16:36.203] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:36.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:22:0) after 1m0s
[23:17:36.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:22:0)
[23:17:36.252] Timer tick, asking Buildbucket for the build status
[23:17:37.147] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:37.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:23:0) after 1m0s
[23:18:37.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:23:0)
[23:18:37.486] Timer tick, asking Buildbucket for the build status
[23:18:37.619] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:37.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:24:0) after 1m0s
[23:19:38.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:24:0)
[23:19:38.172] Timer tick, asking Buildbucket for the build status
[23:19:38.289] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:38.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:25:0) after 1m0s
[23:20:38.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:25:0)
[23:20:38.353] Timer tick, asking Buildbucket for the build status
[23:20:38.472] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:38.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:26:0) after 1m0s
[23:21:38.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:26:0)
[23:21:38.543] Timer tick, asking Buildbucket for the build status
[23:21:38.621] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:38.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:27:0) after 1m0s
[23:22:38.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:27:0)
[23:22:38.686] Timer tick, asking Buildbucket for the build status
[23:22:38.830] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:38.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:28:0) after 1m0s
[23:23:38.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:28:0)
[23:23:38.900] Timer tick, asking Buildbucket for the build status
[23:23:39.228] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:39.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:29:0) after 1m0s
[23:24:39.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:29:0)
[23:24:39.388] Timer tick, asking Buildbucket for the build status
[23:24:39.488] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:39.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:30:0) after 1m0s
[23:25:39.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:30:0)
[23:25:39.808] Timer tick, asking Buildbucket for the build status
[23:25:39.972] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:39.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:31:0) after 1m0s
[23:26:40.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:31:0)
[23:26:40.122] Timer tick, asking Buildbucket for the build status
[23:26:40.234] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:40.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:32:0) after 1m0s
[23:27:40.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:32:0)
[23:27:40.312] Timer tick, asking Buildbucket for the build status
[23:27:40.495] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:40.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:33:0) after 1m0s
[23:28:40.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:33:0)
[23:28:40.649] Timer tick, asking Buildbucket for the build status
[23:28:40.900] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:40.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:34:0) after 1m0s
[23:29:40.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:34:0)
[23:29:40.988] Timer tick, asking Buildbucket for the build status
[23:29:41.065] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:41.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:35:0) after 1m0s
[23:30:41.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:35:0)
[23:30:41.123] Timer tick, asking Buildbucket for the build status
[23:30:41.663] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:41.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:36:0) after 1m0s
[23:31:41.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:36:0)
[23:31:41.834] Timer tick, asking Buildbucket for the build status
[23:31:41.907] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:41.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:37:0) after 1m0s
[23:32:42.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:37:0)
[23:32:42.004] Timer tick, asking Buildbucket for the build status
[23:32:42.126] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:38:0) after 1m0s
[23:33:42.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:38:0)
[23:33:42.186] Timer tick, asking Buildbucket for the build status
[23:33:42.251] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:42.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:39:0) after 1m0s
[23:34:42.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:39:0)
[23:34:42.330] Timer tick, asking Buildbucket for the build status
[23:34:42.392] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:42.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:40:0) after 1m0s
[23:35:42.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:40:0)
[23:35:42.510] Timer tick, asking Buildbucket for the build status
[23:35:42.836] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:42.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:41:0) after 1m0s
[23:36:42.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:41:0)
[23:36:42.909] Timer tick, asking Buildbucket for the build status
[23:36:43.407] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:43.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:42:0) after 1m0s
[23:37:43.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:42:0)
[23:37:43.453] Timer tick, asking Buildbucket for the build status
[23:37:43.641] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:43.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:43:0) after 1m0s
[23:38:43.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:43:0)
[23:38:43.656] Timer tick, asking Buildbucket for the build status
[23:38:43.830] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:43.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:44:0) after 1m0s
[23:39:43.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:44:0)
[23:39:43.861] Timer tick, asking Buildbucket for the build status
[23:39:43.999] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:45:0) after 1m0s
[23:40:44.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:45:0)
[23:40:44.772] Timer tick, asking Buildbucket for the build status
[23:40:44.903] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:44.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:46:0) after 1m0s
[23:41:45.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:46:0)
[23:41:45.076] Timer tick, asking Buildbucket for the build status
[23:41:45.295] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:45.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:47:0) after 1m0s
[23:42:45.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:47:0)
[23:42:45.607] Timer tick, asking Buildbucket for the build status
[23:42:45.748] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:45.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:48:0) after 1m0s
[23:43:45.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:48:0)
[23:43:45.865] Timer tick, asking Buildbucket for the build status
[23:43:45.975] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:45.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:49:0) after 1m0s
[23:44:46.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:49:0)
[23:44:46.079] Timer tick, asking Buildbucket for the build status
[23:44:46.239] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:46.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:50:0) after 1m0s
[23:45:46.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:50:0)
[23:45:46.307] Timer tick, asking Buildbucket for the build status
[23:45:46.713] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:51:0) after 1m0s
[23:46:46.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:51:0)
[23:46:46.721] Timer tick, asking Buildbucket for the build status
[23:46:46.998] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:46.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:52:0) after 1m0s
[23:47:47.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:52:0)
[23:47:47.098] Timer tick, asking Buildbucket for the build status
[23:47:47.582] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:47.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:53:0) after 1m0s
[23:48:47.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:53:0)
[23:48:47.748] Timer tick, asking Buildbucket for the build status
[23:48:47.831] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:47.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:54:0) after 1m0s
[23:49:47.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:54:0)
[23:49:47.901] Timer tick, asking Buildbucket for the build status
[23:49:47.962] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:47.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:55:0) after 1m0s
[23:50:48.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:55:0)
[23:50:48.026] Timer tick, asking Buildbucket for the build status
[23:50:48.108] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:48.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:56:0) after 1m0s
[23:51:48.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:56:0)
[23:51:48.526] Timer tick, asking Buildbucket for the build status
[23:51:48.625] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:48.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:57:0) after 1m0s
[23:52:48.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:57:0)
[23:52:48.839] Timer tick, asking Buildbucket for the build status
[23:52:48.999] Build 8858179597380289232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:48.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023609659473150032:58:0) after 1m0s
[23:53:22.749] Received PubSub notification, asking Buildbucket for the build status
[23:53:22.907] Build 8858179597380289232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:53:22.907] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610582001274280",
"created_by": "project:chromium",
"created_ts": "1610578650072605",
"id": "8858179597380289232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"79f7d6932338b363482f68d530ec7b6ae2934b09\"}}",
"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\": \"79f7d6932338b363482f68d530ec7b6ae2934b09\", \"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-3-nb2x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16804, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"47e9aed2af83c0c3f684a804156c3b876a58a1bf\", \"got_dawn_revision\": \"111ba65a5e3dbd23a58dd63991e92e9300f44d13\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"79f7d6932338b363482f68d530ec7b6ae2934b09\", \"got_revision_cp\": \"refs/heads/master@{#843215}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"a1598e5821fc3ca0d2ca8928d41cdd3a12114c7a\", \"got_v8_revision_cp\": \"refs/heads/8.9.266@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"79f7d6932338b363482f68d530ec7b6ae2934b09\", \"swarm_hashes_refs/heads/master(at){#843215}_without_patch\": {\"absl_hardening_tests\": \"e5d200530756ee63183975eb05cece6b271f0d95\", \"accessibility_unittests\": \"4e3f618a0db4217333337e70dd0acbebc89f4df9\", \"angle_unittests\": \"6747dbdadac56d50a8f9bc975525fa9e655aee86\", \"app_shell_unittests\": \"a7eabcf0a954bd102fe5f72d20402cd03be36734\", \"aura_unittests\": \"1399b6915e64eac7038d58d9cacca6a40a23a288\", \"base_unittests\": \"09cde2683027606642ea0d836339726961331e7c\", \"base_util_unittests\": \"262151d1d7b6f11e1333516b147d64315a589055\", \"blink_common_unittests\": \"930136ff39e48d5c6d09448bfa3aa50cca7764d1\", \"blink_fuzzer_unittests\": \"f71ee7cd448e8db8911f8b3aeec23e405715772e\", \"blink_heap_unittests\": \"7932cd64d078ab9251869e71ce92c7449464906c\", \"blink_platform_unittests\": \"28b4236d26a1873c341bc06f4850e0999b1ad752\", \"blink_unittests\": \"22a23f8980a5283dc10fe100c43fb1a9684a64a6\", \"boringssl_crypto_tests\": \"4d55d3433385cd277560b7b757b8856f144c9052\", \"boringssl_ssl_tests\": \"f4a74d0719257cd8a75f0fc3203113baa17c1708\", \"browser_switcher_bho_unittests\": \"2140e8c5d7e45c625b12f9c245eda90eb093d4e9\", \"browser_tests\": \"a012be4e22ab5fcab36365bf07f733852c52abb7\", \"capture_unittests\": \"c757f985a3de0a8fe7e890a24068c9e6359f7a3d\", \"cast_unittests\": \"b6887975d2362a239c1dc1fb6f96b9eb13551617\", \"cc_unittests\": \"071be2a3017be3216f71a3756007970a7e43f45c\", \"chrome_app_unittests\": \"de3fe75d5cfef76208775cb039257b2acf617346\", \"chrome_cleaner_unittests\": \"600eea723b91dd844eafa934e648dcaaa376f1a8\", \"chrome_elf_unittests\": \"24bcd741938a12dafed2dcddfb9d016ba49a3e03\", \"chromedriver_unittests\": \"0fa3e2040b51ee53e181732009e4b059548640cc\", \"components_browsertests\": \"caee0a270b5975be415d93adb5746a49bb6694be\", \"components_unittests\": \"6cdd479dfd1dc1137bab5e61b587b65ab7b60181\", \"compositor_unittests\": \"502beb092c78c1e2f7e9a75e46e8df2b044e4c6f\", \"content_browsertests\": \"ec32544a7256ed06e7a85f9c4c0f1d68daecf99f\", \"content_unittests\": \"3e4d16c8db6f66362dfcf61f34a09ff993322f44\", \"courgette_unittests\": \"5b36c05fbf6b6a0daaeb02ba86575ec3a7f6186e\", \"crashpad_tests\": \"274aaa96e55b178c72ba7f6ea60b2494a08f27b7\", \"cronet_tests\": \"adbfd6dbd5b367a62c82d68e77800221ee8b85c1\", \"cronet_unittests\": \"217d26b0b9f3d3781bbd1e93a26904458ff4f70b\", \"crypto_unittests\": \"13e3b845582a26f4f7e63923560370dc444e7ff9\", \"delayloads_unittests\": \"3f87d9cddaa1eddd32d409d540b6d587a167fd09\", \"device_unittests\": \"1be6b22bd43aced9b47eb810281f02ff81013fdd\", \"display_unittests\": \"eaa948c5475000bfe5a80640aeadb2436f42f85e\", \"elevation_service_unittests\": \"c9d4731785e78ef59ddc0058454119813a9a611c\", \"events_unittests\": \"2669663a2093f56ee35edb55aaf93f69b243bfe4\", \"extensions_browsertests\": \"dfaf8539ccdc3e133b0818665f0fcf0fa2f09ace\", \"extensions_unittests\": \"f41c1a62806e75e6617ceb42077851b059b1938f\", \"filesystem_service_unittests\": \"63e6a38c20afbca874bb845e3215f137840738ff\", \"gcm_unit_tests\": \"b19fb0cd32a54c255551815e042c8012ffca8670\", \"gcp_unittests\": \"eea9818f0dbbe81deaf9bf179a3d5f3d77ed71ce\", \"gfx_unittests\": \"2226858bcbc5ba4e5e261eab69d7ec87e252ec92\", \"gin_unittests\": \"7e99702e6755b9d29bf862a74a319b6f47a87386\", \"google_apis_unittests\": \"5648cee151b180c77bbc6d14d9b42a83afd8d0eb\", \"gpu_unittests\": \"9c6d970f0f2eb8b5cbcffb747b57a030c3dbaa14\", \"gwp_asan_unittests\": \"0edb5e62ab3bf0fd55d1879597645b04f8f920c5\", \"headless_browsertests\": \"d32537e615cc95f6acb5a3623428d4a37d12e40b\", \"headless_unittests\": \"1bcd4d4473ac7466314afd3799988aaa6998b592\", \"install_static_unittests\": \"d88242c7adedd4f764359a6787916b54e4c76ccc\", \"installer_util_unittests\": \"ff7622d6426c9d8abc38d5907e03c933108cbf93\", \"interactive_ui_tests\": \"8dd2e1dc6865ad1d057943a398db91c594f1f988\", \"ipc_tests\": \"0f33916248a3e32505b55c00165daf9bbfc55245\", \"jingle_unittests\": \"b77de21b4fbb518aaed805816b57ab11076f05fe\", \"latency_unittests\": \"ee52cb5deb91a53c8fae84d744a454fded748805\", \"libjingle_xmpp_unittests\": \"fdd6f3bc681406a700fd108065ad783612c007ce\", \"liburlpattern_unittests\": \"6d7aa038f5e23f9350f241bfca4beaaea063e019\", \"media_blink_unittests\": \"92e029b40c23e59a3e6d634f9aeb37d0ef6907cf\", \"media_unittests\": \"5d1b80f2cd7a5d9e53a3335e1bde2720091d41aa\", \"message_center_unittests\": \"46ba44a7e3fd73a9119afabe37cc6c2f5d02a779\", \"midi_unittests\": \"df6fbbe3798224d3c9bfc0a6114f2de57b0e5368\", \"mojo_core_unittests\": \"cc2d1f8753fe339755fda5bd8ca0c0aa3b658051\", \"mojo_unittests\": \"1abbda33ebb70d10a85dc0ba8c5a681af2f22e7d\", \"nacl_loader_unittests\": \"cc1a89f21526eb94a809c39452fa8ba8add9018d\", \"native_theme_unittests\": \"b8d4cf6837619c1cd8e9fd9d55e261cfdce080ac\", \"net_unittests\": \"cf86c51579827728bcf89b14169e39b8322d708a\", \"notification_helper_unittests\": \"4cc278b292dc7dca6281260294ce3110d48b6e9b\", \"pdf_unittests\": \"6fe9b0afa911b24854cdcaa534a9c21921c57f47\", \"perfetto_unittests\": \"d232aaa00814b97103f49b55419728a7ea8b169f\", \"ppapi_unittests\": \"f4920d9a9733246ce9674e20ac213337a7c7b4ae\", \"printing_unittests\": \"5428c495a2a81d92deba80d03d20a691628084de\", \"remoting_unittests\": \"f6bd15f6ee1a755add87ba0104083c2e4b3d5fc3\", \"sbox_integration_tests\": \"918c44c0dba0a7476ac0403e32c1ab20a0c3b4fa\", \"sbox_unittests\": \"3e90ce37a98cfc8214fa7bf36f691328e5fe1340\", \"sbox_validation_tests\": \"8e927bdb66d094882b16bd9dd2885175f1d53b0e\", \"service_manager_unittests\": \"c058d6d041329c0c8e52332f51c1d1366014f635\", \"services_unittests\": \"4bec26ccacc02f01f7ae2cc4fe32b815e917996e\", \"setup_unittests\": \"e2ec1f511879ada34c02dff6e8250ce015ed7363\", \"shell_dialogs_unittests\": \"920939b619f37a88c91d8862da58c210e979adc4\", \"skia_unittests\": \"2945a125541012770a1c0a22dc85d234ed9c5db1\", \"snapshot_unittests\": \"bc2f1a9d4f308653ca93e222c1feeb4d6989c60f\", \"sql_unittests\": \"47c132da9e8b679a7f214ffce49b52ec01323bda\", \"storage_unittests\": \"498a2afbba8a09602aae26a465d96a0dfc22e8c9\", \"sync_integration_tests\": \"4c28204f1b6946b5b57d80e523eb2e8fcaace084\", \"traffic_annotation_auditor_unittests\": \"86a9acbc01258daf728a84e9d4a80e3d2136eed3\", \"ui_base_unittests\": \"e464d258fa12b66ab1d4e3764e9646ff97b4bb72\", \"ui_touch_selection_unittests\": \"4703a575b459e747b5b993b09ac53d34a5c46b5d\", \"unit_tests\": \"5de8b722757a1d7c8abda9bba44bf1b884f7ebfd\", \"updater_tests\": \"375418dce220d1f28963ae972df054daac5301ea\", \"url_unittests\": \"d8475034181aa6d594812b7eb6e6e90d419addc6\", \"views_unittests\": \"60063f20f37442a372c56119700193a1b4276809\", \"viz_unittests\": \"c92e53363cc96116f1bca977c92c7aab510d0238\", \"vr_common_unittests\": \"044911b538a183c13e487ef88168f1f4a1a3664b\", \"vr_pixeltests\": \"ebf260dc638f51579b7b4fdcaaf2441dcee72977\", \"weblayer_browsertests\": \"4fb66ba70e1e94a7813132af60016a0626c307a0\", \"weblayer_unittests\": \"f5a6fce0d07b820006a3a534fb45d7802ffae836\", \"wm_unittests\": \"cd1b5365be912bed558289d0b9df3a023c309a11\", \"wtf_unittests\": \"0e2fac3e0131b8818d92e21cad362824de60480c\", \"zlib_unittests\": \"a210b2dc73ef9bd9735550fd6e75ca91eed09365\", \"zucchini_unittests\": \"b306dc77361d37da49650fb7266fa492967c7b40\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-3-nb2x\"], \"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\": [\"5661-c6f6250\"], \"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": "1610578652051584",
"status": "COMPLETED",
"status_changed_ts": "1610582001611193",
"tags": [
"build_address:luci.chromium.ci/win-asan/16804",
"builder:win-asan",
"buildset:commit/git/79f7d6932338b363482f68d530ec7b6ae2934b09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/79f7d6932338b363482f68d530ec7b6ae2934b09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023609659473150032",
"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/8858179597380289232/+/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:5116c96f83c10a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610582001684756",
"url": "https://ci.chromium.org/b/8858179597380289232",
"utcnow_ts": "1610582002880893"
}
}
[23:53:22.907] Invocation finished in 55m54.214171268s with status SUCCEEDED