[07:50:25.368] New invocation is queued and will start shortly
[07:50:26.542] Starting the invocation (attempt 1)
[07:50:26.592] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:50:26.593] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:50:26.593] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028015380868745104",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028015380868745104",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"gitiles_ref:refs/heads/master"
]
}
[07:50:27.382] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606377026728124",
"id": "8862585318779502096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606377027171493",
"tags": [
"build_address:luci.chromium.ci/win-asan/15858",
"builder:win-asan",
"buildset:commit/git/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028015380868745104",
"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/8862585318779502096/+/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": "1606377027171604",
"url": "https://ci.chromium.org/b/8862585318779502096",
"utcnow_ts": "1606377027373087"
}
}
[07:50:27.382] Task URL: https://ci.chromium.org/b/8862585318779502096
[07:50:27.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:2:0) after 1m0s
[07:50:29.821] Received PubSub notification, asking Buildbucket for the build status
[07:50:29.887] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:27.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:2:0)
[07:51:27.498] Timer tick, asking Buildbucket for the build status
[07:51:27.930] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:27.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:4:0) after 1m0s
[07:52:28.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:4:0)
[07:52:28.019] Timer tick, asking Buildbucket for the build status
[07:52:28.630] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:28.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:5:0) after 1m0s
[07:53:28.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:5:0)
[07:53:28.640] Timer tick, asking Buildbucket for the build status
[07:53:28.765] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:28.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:6:0) after 1m0s
[07:54:28.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:6:0)
[07:54:28.840] Timer tick, asking Buildbucket for the build status
[07:54:29.037] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:7:0) after 1m0s
[07:55:29.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:7:0)
[07:55:29.062] Timer tick, asking Buildbucket for the build status
[07:55:29.162] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:29.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:8:0) after 1m0s
[07:56:29.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:8:0)
[07:56:29.213] Timer tick, asking Buildbucket for the build status
[07:56:29.302] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:29.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:9:0) after 1m0s
[07:57:29.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:9:0)
[07:57:29.332] Timer tick, asking Buildbucket for the build status
[07:57:29.402] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:29.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:10:0) after 1m0s
[07:58:29.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:10:0)
[07:58:29.458] Timer tick, asking Buildbucket for the build status
[07:58:29.525] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:29.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:11:0) after 1m0s
[07:59:29.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:11:0)
[07:59:29.641] Timer tick, asking Buildbucket for the build status
[07:59:29.714] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:29.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:12:0) after 1m0s
[08:00:29.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:12:0)
[08:00:29.899] Timer tick, asking Buildbucket for the build status
[08:00:30.111] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:30.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:13:0) after 1m0s
[08:01:30.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:13:0)
[08:01:30.213] Timer tick, asking Buildbucket for the build status
[08:01:30.268] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:14:0) after 1m0s
[08:02:30.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:14:0)
[08:02:30.295] Timer tick, asking Buildbucket for the build status
[08:02:30.601] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:30.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:15:0) after 1m0s
[08:03:30.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:15:0)
[08:03:30.686] Timer tick, asking Buildbucket for the build status
[08:03:30.760] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:30.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:16:0) after 1m0s
[08:04:30.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:16:0)
[08:04:30.824] Timer tick, asking Buildbucket for the build status
[08:04:31.219] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:31.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:17:0) after 1m0s
[08:05:31.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:17:0)
[08:05:31.253] Timer tick, asking Buildbucket for the build status
[08:05:31.976] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:18:0) after 1m0s
[08:06:32.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:18:0)
[08:06:32.045] Timer tick, asking Buildbucket for the build status
[08:06:32.118] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:32.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:19:0) after 1m0s
[08:07:32.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:19:0)
[08:07:32.205] Timer tick, asking Buildbucket for the build status
[08:07:32.331] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:32.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:20:0) after 1m0s
[08:08:32.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:20:0)
[08:08:32.351] Timer tick, asking Buildbucket for the build status
[08:08:32.411] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:32.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:21:0) after 1m0s
[08:09:32.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:21:0)
[08:09:32.510] Timer tick, asking Buildbucket for the build status
[08:09:32.712] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:32.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:22:0) after 1m0s
[08:10:32.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:22:0)
[08:10:32.798] Timer tick, asking Buildbucket for the build status
[08:10:32.957] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:32.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:23:0) after 1m0s
[08:11:33.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:23:0)
[08:11:33.028] Timer tick, asking Buildbucket for the build status
[08:11:33.128] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:33.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:24:0) after 1m0s
[08:12:33.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:24:0)
[08:12:33.195] Timer tick, asking Buildbucket for the build status
[08:12:33.280] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:33.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:25:0) after 1m0s
[08:13:33.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:25:0)
[08:13:33.319] Timer tick, asking Buildbucket for the build status
[08:13:34.771] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:34.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:26:0) after 1m0s
[08:14:34.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:26:0)
[08:14:34.805] Timer tick, asking Buildbucket for the build status
[08:14:34.943] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:34.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:27:0) after 1m0s
[08:15:34.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:27:0)
[08:15:34.995] Timer tick, asking Buildbucket for the build status
[08:15:35.196] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:35.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:28:0) after 1m0s
[08:16:35.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:28:0)
[08:16:35.298] Timer tick, asking Buildbucket for the build status
[08:16:35.683] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:35.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:29:0) after 1m0s
[08:17:35.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:29:0)
[08:17:35.841] Timer tick, asking Buildbucket for the build status
[08:17:35.957] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:35.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:30:0) after 1m0s
[08:18:35.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:30:0)
[08:18:35.981] Timer tick, asking Buildbucket for the build status
[08:18:36.139] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:36.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:31:0) after 1m0s
[08:19:36.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:31:0)
[08:19:36.202] Timer tick, asking Buildbucket for the build status
[08:19:36.412] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:36.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:32:0) after 1m0s
[08:20:36.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:32:0)
[08:20:36.488] Timer tick, asking Buildbucket for the build status
[08:20:36.635] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:36.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:33:0) after 1m0s
[08:21:36.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:33:0)
[08:21:36.689] Timer tick, asking Buildbucket for the build status
[08:21:36.799] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:36.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:34:0) after 1m0s
[08:22:36.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:34:0)
[08:22:36.890] Timer tick, asking Buildbucket for the build status
[08:22:37.294] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:37.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:35:0) after 1m0s
[08:23:37.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:35:0)
[08:23:37.365] Timer tick, asking Buildbucket for the build status
[08:23:38.067] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:36:0) after 1m0s
[08:24:38.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:36:0)
[08:24:38.197] Timer tick, asking Buildbucket for the build status
[08:24:38.399] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:38.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:37:0) after 1m0s
[08:25:38.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:37:0)
[08:25:38.568] Timer tick, asking Buildbucket for the build status
[08:25:38.741] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:38.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:38:0) after 1m0s
[08:26:38.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:38:0)
[08:26:38.719] Timer tick, asking Buildbucket for the build status
[08:26:38.815] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:38.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:39:0) after 1m0s
[08:27:38.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:39:0)
[08:27:38.916] Timer tick, asking Buildbucket for the build status
[08:27:38.996] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:38.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:40:0) after 1m0s
[08:28:39.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:40:0)
[08:28:39.024] Timer tick, asking Buildbucket for the build status
[08:28:39.499] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:39.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:41:0) after 1m0s
[08:29:39.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:41:0)
[08:29:39.692] Timer tick, asking Buildbucket for the build status
[08:29:39.772] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:39.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:42:0) after 1m0s
[08:30:40.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:42:0)
[08:30:40.139] Timer tick, asking Buildbucket for the build status
[08:30:40.376] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:40.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:43:0) after 1m0s
[08:31:40.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:43:0)
[08:31:40.767] Timer tick, asking Buildbucket for the build status
[08:31:40.834] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:40.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:44:0) after 1m0s
[08:32:41.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:44:0)
[08:32:41.133] Timer tick, asking Buildbucket for the build status
[08:32:41.205] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:41.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:45:0) after 1m0s
[08:33:41.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:45:0)
[08:33:41.419] Timer tick, asking Buildbucket for the build status
[08:33:41.494] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:41.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:46:0) after 1m0s
[08:34:41.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:46:0)
[08:34:41.521] Timer tick, asking Buildbucket for the build status
[08:34:41.627] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:41.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:47:0) after 1m0s
[08:35:41.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:47:0)
[08:35:41.682] Timer tick, asking Buildbucket for the build status
[08:35:41.786] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:41.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:48:0) after 1m0s
[08:36:41.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:48:0)
[08:36:41.837] Timer tick, asking Buildbucket for the build status
[08:36:41.956] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:41.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:49:0) after 1m0s
[08:37:41.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:49:0)
[08:37:41.988] Timer tick, asking Buildbucket for the build status
[08:37:42.086] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:42.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:50:0) after 1m0s
[08:38:42.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:50:0)
[08:38:42.133] Timer tick, asking Buildbucket for the build status
[08:38:42.328] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:42.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:51:0) after 1m0s
[08:39:42.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:51:0)
[08:39:42.372] Timer tick, asking Buildbucket for the build status
[08:39:42.458] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:42.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:52:0) after 1m0s
[08:40:42.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:52:0)
[08:40:42.511] Timer tick, asking Buildbucket for the build status
[08:40:42.648] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:42.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:53:0) after 1m0s
[08:41:42.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:53:0)
[08:41:42.988] Timer tick, asking Buildbucket for the build status
[08:41:43.208] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:43.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:54:0) after 1m0s
[08:42:43.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:54:0)
[08:42:43.292] Timer tick, asking Buildbucket for the build status
[08:42:43.393] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:43.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:55:0) after 1m0s
[08:43:43.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:55:0)
[08:43:43.471] Timer tick, asking Buildbucket for the build status
[08:43:43.580] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:43.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:56:0) after 1m0s
[08:44:43.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:56:0)
[08:44:43.633] Timer tick, asking Buildbucket for the build status
[08:44:43.713] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:43.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:57:0) after 1m0s
[08:45:43.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:57:0)
[08:45:43.773] Timer tick, asking Buildbucket for the build status
[08:45:44.138] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:44.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:58:0) after 1m0s
[08:46:44.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:58:0)
[08:46:44.211] Timer tick, asking Buildbucket for the build status
[08:46:44.277] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:44.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:59:0) after 1m0s
[08:47:44.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:59:0)
[08:47:44.529] Timer tick, asking Buildbucket for the build status
[08:47:45.175] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:45.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:60:0) after 1m0s
[08:48:45.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:60:0)
[08:48:45.174] Timer tick, asking Buildbucket for the build status
[08:48:45.826] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:45.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:61:0) after 1m0s
[08:49:45.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:61:0)
[08:49:45.997] Timer tick, asking Buildbucket for the build status
[08:49:46.072] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:46.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:62:0) after 1m0s
[08:50:46.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:62:0)
[08:50:46.119] Timer tick, asking Buildbucket for the build status
[08:50:46.510] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:63:0) after 1m0s
[08:51:46.595] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:63:0)
[08:51:46.595] Timer tick, asking Buildbucket for the build status
[08:51:47.021] Build 8862585318779502096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:47.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028015380868745104:64:0) after 1m0s
[08:52:27.511] Received PubSub notification, asking Buildbucket for the build status
[08:52:27.699] Build 8862585318779502096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:52:27.699] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606380746324089",
"created_by": "project:chromium",
"created_ts": "1606377026728124",
"id": "8862585318779502096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\"}}",
"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\": \"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\", \"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-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15858, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"939fcd1a14f5ddc43e300bcb2d5d1f680c50ab85\", \"got_dawn_revision\": \"9175f00eec91c6c9b3c3e264d6d8ec7879881844\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\", \"got_revision_cp\": \"refs/heads/master@{#831277}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"1166840df5216851f3f7d9f6e16f5d0ee3c08cbe\", \"got_v8_revision_cp\": \"refs/heads/8.9.54@{#1}\", \"got_webrtc_revision\": \"b6b599fc588e59142df343d2d2897203468aacea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32695}\", \"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\": \"fb1fc9b48cd1f0368d3a828146737df96d88a6f1\", \"swarm_hashes_refs/heads/master(at){#831277}_without_patch\": {\"absl_hardening_tests\": \"4918cbf3c3edab1c87acb76a873882c9292f27b4\", \"accessibility_unittests\": \"4b13c3d9cad5a01229e8a606015f3698327a507c\", \"angle_unittests\": \"a3af58276b6c5b2ebce836e856487295928489c6\", \"app_shell_unittests\": \"9deddd95f8161c5fb771751f0df4e9a64de03c40\", \"aura_unittests\": \"1d7c45e81a41c1f15a3b451b8b46ff29fbce97a2\", \"base_unittests\": \"23819d7156196e12d64f2b56cff0333c858dd0c9\", \"base_util_unittests\": \"f2faad506e8960d05b5a556e4601ca50481753c0\", \"blink_common_unittests\": \"3aa140cd5ece1adecd6de95976a238d3bff11b37\", \"blink_fuzzer_unittests\": \"b3b2be193491f3cd061b66ce610775e0741e58de\", \"blink_heap_unittests\": \"d821786c46bd5d8f82762547fd9587a2e754af3d\", \"blink_platform_unittests\": \"f819f418c753b528e26992437cedd3fc5a8cf9ec\", \"blink_unittests\": \"0fb2ddefc2d015133d11074079084d2e61e6a234\", \"boringssl_crypto_tests\": \"0e827e55fc4e902fa13394e2f03e33411768509b\", \"boringssl_ssl_tests\": \"f5bafeaad5a9507e0f4a3d43b17cad33e6abed40\", \"browser_switcher_bho_unittests\": \"a5bb0313c3a39326e0b81dcd07d392ff5108f11d\", \"browser_tests\": \"c27535026e32dbd6bf6d956eafc50728c6247c33\", \"capture_unittests\": \"b5807b6140f242377dd5851441047e810f9b0b64\", \"cast_unittests\": \"60ab9ae09f2a0dce3547329b04817e461376a5ee\", \"cc_unittests\": \"e58ea824c08e8f05d7ad33b0a426b1f075b1708b\", \"chrome_app_unittests\": \"3be523f74dbfdc858267c69adb5dc339a2223fa5\", \"chrome_cleaner_unittests\": \"0391ab25849c1ba174255a8992320a82468a9447\", \"chrome_elf_unittests\": \"53b383c2faf6d6ca9c2bfed76b29fb963c02e147\", \"chromedriver_unittests\": \"72253ae60a6e26bf06bde29a5432393e36f32f8f\", \"components_browsertests\": \"4377959857c9b6d3382c52e56504c5e2f32ba10f\", \"components_unittests\": \"2639182ad4bc6d0b8ee13ae18cee496aef052672\", \"compositor_unittests\": \"c3ee2f688183a7746fc449b1a05cfb454253e69b\", \"content_browsertests\": \"85a43b78653075e74a707a7888af3521215335d8\", \"content_unittests\": \"7356f50ea38e063cf4ddc47099862ffaa2767352\", \"courgette_unittests\": \"284223375255c857f179d5b5d744b7d8c7e0a7da\", \"crashpad_tests\": \"4911d21512ce5f37058f487327aac13a35b0f9b0\", \"cronet_tests\": \"54b472d33e8451fa4f3257aba70ce09fc49f8a87\", \"cronet_unittests\": \"1bf70783610d4292df3233518fc3519c004f4573\", \"crypto_unittests\": \"b60c8b269ab5cbd5d16515aed6b5c6eb80a9d8cf\", \"delayloads_unittests\": \"bd474ec527e21152eb7f56f170c6b2f06ecce282\", \"device_unittests\": \"43475c7f911ed981d8a618692e107f12b96ff766\", \"display_unittests\": \"225e36de29502813bad96ea5d23f52684d71cb81\", \"elevation_service_unittests\": \"c3dda4538ed1b6eac25e4ab189259cc9da15c66f\", \"events_unittests\": \"983242a3f4f6a91aeb9e6556bf09697d1a3ab7d0\", \"extensions_browsertests\": \"ac179a0346bfa9938e37bdf2549fce33937e3360\", \"extensions_unittests\": \"12e43334911d80a830a4d67654e333f196ed57aa\", \"filesystem_service_unittests\": \"a9f9e7617bccdc1fd98da88c5146c0a3ab9e894e\", \"gcm_unit_tests\": \"79fdce4f7ef9c08a8a035302fe45ba26382bd5bd\", \"gcp_unittests\": \"6667e8eb7587f548f90c1b7f3cc656919deb9e77\", \"gfx_unittests\": \"e831af53d5e6e5c4957d68b7e451a532a6612b67\", \"gin_unittests\": \"bdd822e9069b06ad317a92cfa993b2dc84f0f104\", \"google_apis_unittests\": \"edb0031ca34240ae4b6091fcad59e28da63ea962\", \"gpu_unittests\": \"1e9539e0b66bb7ba237608826e06cce7421e3f4b\", \"gwp_asan_unittests\": \"442cc9d9695a33aa9e4b47cfe7691a62ac1cff6a\", \"headless_browsertests\": \"0387e5f35d5c3ae9b1f5bc2e3186490a6b8fff8f\", \"headless_unittests\": \"5385a7c2b3541cd31e72b488b80ae070fac1d3f1\", \"install_static_unittests\": \"299d718239d35cbe735db999f57ae89df5fdd449\", \"installer_util_unittests\": \"0a31aa548def68d48e28cfd9d940d51a678b4bf9\", \"interactive_ui_tests\": \"7f6cc7ed5a19a3291bf25a627f2a3e847e79fa47\", \"ipc_tests\": \"e77ce0d30e157e5ea79679b1aaf0fcce3ced4e53\", \"jingle_unittests\": \"ba505b3951aa8f66970da904aeed367227c56674\", \"latency_unittests\": \"3cb1d7d395211530310460cf372b0ee1abdac5b4\", \"libjingle_xmpp_unittests\": \"704cdaa97564de191c3e23a624cf82ec1b76436a\", \"liburlpattern_unittests\": \"addd143253a68b70bd267c328dc7b278ce399bdc\", \"media_blink_unittests\": \"d0ab29b4061be9275043990f6e84ded1b0d2e72c\", \"media_unittests\": \"0298ea719fe1c6e0cafddc9c37e43bf46751e78e\", \"message_center_unittests\": \"61811b4439dce3858fcdd236718fee8dd85c4f96\", \"midi_unittests\": \"a3ca27adf3bd4281c1d88b19df3887b3622adaaf\", \"mojo_core_unittests\": \"8f53b1c31ac6bb56abeae484e1c934caadfd284e\", \"mojo_unittests\": \"1105f19e337f0b551e48be8bbedce29892232352\", \"nacl_loader_unittests\": \"880b86770648acd0af73a09d31e2b445b516706e\", \"native_theme_unittests\": \"dee0abba79f7477061ba2665084e1f948706a8fe\", \"net_unittests\": \"5308ab86ed24ecf29c35a2938281e119cc260b3a\", \"notification_helper_unittests\": \"eaf0b5ade73141183e11a4acae6ef17b320913e5\", \"pdf_unittests\": \"6930d06a558ce099829857667ea0407c5e192639\", \"perfetto_unittests\": \"06cc46c36cb35a66cef349ece22cb4a4df0ae921\", \"ppapi_unittests\": \"9f5d80ddcba0c1ae3f9b00dddbca41d29e26d25a\", \"printing_unittests\": \"d2ae9548ac7109472956b5084706f4f815168a85\", \"remoting_unittests\": \"78751c914d73c4c4bd7b0933f327564365ff8fbd\", \"sbox_integration_tests\": \"3d05f8daa22b372a3695f6bba44e92f9c8ff2146\", \"sbox_unittests\": \"8ced15b44acad9236cb2cc4d34b0c9177a59a510\", \"sbox_validation_tests\": \"e774629355cfe75dc4a60b45f98235534d3c76ce\", \"service_manager_unittests\": \"ab533cb557e6bb46a627906618a48fa59e9b6d98\", \"services_unittests\": \"34e51d8ed90baa7875a811a2c086af53cbf1ba50\", \"setup_unittests\": \"3be1b336d403ef35dd96ce559c66d8dfab4d2454\", \"shell_dialogs_unittests\": \"50c0b0b51605d1a9fc3de3a484945405d7a0ca6b\", \"skia_unittests\": \"fb20072ae27dc163cbbed23750a6baa5696bcb41\", \"snapshot_unittests\": \"c0e2d90baff2072502caaec0e1af1a07fe9cce9c\", \"sql_unittests\": \"b8fc17e2e37ec3f190fc44c2997748515fe1d89e\", \"storage_unittests\": \"91fffc3fad8c043e2f853d36baef747b6851faa2\", \"sync_integration_tests\": \"cde11130b52e3d9c3cd421fe8a9e18df5e4964c3\", \"traffic_annotation_auditor_unittests\": \"722f4c7bbe420316c069fa9428bb68c1ee7218cc\", \"ui_base_unittests\": \"8b90ed17d82fc4ed2d2e8865f0d6a0e7bd3e100b\", \"ui_touch_selection_unittests\": \"a1049f9cb7a0f49d18d7eda7693517c1329134f6\", \"unit_tests\": \"1f5832d0fa3e75c8b58efbc2f2e41a50da1113c3\", \"updater_tests\": \"01dc5275f36e00becbf689354e9f6be78fc15f0a\", \"url_unittests\": \"df7e2dad1293c323f2e18a0b339b99bbd2ec33f8\", \"views_unittests\": \"1b6ad2d03f38be9e167bf9b5b8376fd69f218006\", \"viz_unittests\": \"6e0c2a081d4d04e9722dc6c6f5877615d0af5a0a\", \"vr_common_unittests\": \"f685cd49e359ae374707b6d86bcdc9387fd5daaa\", \"vr_pixeltests\": \"1e5e6397dae9cbf954eee45769918a9458c4dc3f\", \"weblayer_browsertests\": \"661a2aca2bd722fc93c5c4cd80e086d67c99d413\", \"weblayer_unittests\": \"64c5b935ac358ab39bd8fdb1e6c47ccef5dd0dbe\", \"wm_unittests\": \"4e07784d71138fc8503d8a38411f0e184ea8cb6e\", \"wtf_unittests\": \"73844b1e11e37ed6dba60e3bdff31f7e54d810a7\", \"zlib_unittests\": \"ae081cdc6616c7d5495bc914ec29510c4239628f\", \"zucchini_unittests\": \"431fa5b1301e96b6cba4757387fc4406e0a98d86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-6-2gr3\"], \"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": "1606377029160736",
"status": "COMPLETED",
"status_changed_ts": "1606380746991332",
"tags": [
"build_address:luci.chromium.ci/win-asan/15858",
"builder:win-asan",
"buildset:commit/git/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb1fc9b48cd1f0368d3a828146737df96d88a6f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028015380868745104",
"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/8862585318779502096/+/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:501c59c0177e5210",
"user_agent:luci-scheduler"
],
"updated_ts": "1606380746997802",
"url": "https://ci.chromium.org/b/8862585318779502096",
"utcnow_ts": "1606380747648263"
}
}
[08:52:27.699] Invocation finished in 1h2m2.347107003s with status SUCCEEDED