[19:03:55.712] New invocation is queued and will start shortly
[19:03:56.857] Starting the invocation (attempt 1)
[19:03:56.917] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:03:56.921] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:03:56.921] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028063604568764912",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028063604568764912",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"gitiles_ref:refs/heads/master"
]
}
[19:03:59.159] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606331038582066",
"id": "8862633540845864688",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606331039031640",
"tags": [
"build_address:luci.chromium.ci/win-asan/15847",
"builder:win-asan",
"buildset:commit/git/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028063604568764912",
"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/8862633540845864688/+/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": "1606331039031833",
"url": "https://ci.chromium.org/b/8862633540845864688",
"utcnow_ts": "1606331039151388"
}
}
[19:03:59.159] Task URL: https://ci.chromium.org/b/8862633540845864688
[19:03:59.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:2:0) after 1m0s
[19:04:01.207] Received PubSub notification, asking Buildbucket for the build status
[19:04:01.285] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:59.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:2:0)
[19:04:59.273] Timer tick, asking Buildbucket for the build status
[19:04:59.487] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:59.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:4:0) after 1m0s
[19:05:59.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:4:0)
[19:05:59.602] Timer tick, asking Buildbucket for the build status
[19:05:59.900] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:59.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:5:0) after 1m0s
[19:06:59.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:5:0)
[19:06:59.914] Timer tick, asking Buildbucket for the build status
[19:07:00.182] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:00.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:6:0) after 1m0s
[19:08:00.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:6:0)
[19:08:00.279] Timer tick, asking Buildbucket for the build status
[19:08:00.461] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:00.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:7:0) after 1m0s
[19:09:00.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:7:0)
[19:09:00.849] Timer tick, asking Buildbucket for the build status
[19:09:01.153] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:01.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:8:0) after 1m0s
[19:10:01.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:8:0)
[19:10:01.212] Timer tick, asking Buildbucket for the build status
[19:10:01.288] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:01.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:9:0) after 1m0s
[19:11:01.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:9:0)
[19:11:01.293] Timer tick, asking Buildbucket for the build status
[19:11:01.354] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:01.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:10:0) after 1m0s
[19:12:01.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:10:0)
[19:12:01.417] Timer tick, asking Buildbucket for the build status
[19:12:01.568] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:01.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:11:0) after 1m0s
[19:13:01.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:11:0)
[19:13:01.721] Timer tick, asking Buildbucket for the build status
[19:13:01.779] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:01.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:12:0) after 1m0s
[19:14:01.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:12:0)
[19:14:01.886] Timer tick, asking Buildbucket for the build status
[19:14:02.102] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:02.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:13:0) after 1m0s
[19:15:02.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:13:0)
[19:15:02.396] Timer tick, asking Buildbucket for the build status
[19:15:02.466] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:02.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:14:0) after 1m0s
[19:16:02.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:14:0)
[19:16:02.705] Timer tick, asking Buildbucket for the build status
[19:16:02.781] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:02.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:15:0) after 1m0s
[19:17:02.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:15:0)
[19:17:02.874] Timer tick, asking Buildbucket for the build status
[19:17:02.970] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:02.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:16:0) after 1m0s
[19:18:03.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:16:0)
[19:18:03.006] Timer tick, asking Buildbucket for the build status
[19:18:03.076] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:03.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:17:0) after 1m0s
[19:19:03.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:17:0)
[19:19:03.155] Timer tick, asking Buildbucket for the build status
[19:19:03.330] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:03.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:18:0) after 1m0s
[19:20:03.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:18:0)
[19:20:03.334] Timer tick, asking Buildbucket for the build status
[19:20:03.532] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:03.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:19:0) after 1m0s
[19:21:03.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:19:0)
[19:21:03.588] Timer tick, asking Buildbucket for the build status
[19:21:03.677] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:20:0) after 1m0s
[19:22:03.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:20:0)
[19:22:03.713] Timer tick, asking Buildbucket for the build status
[19:22:03.786] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:03.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:21:0) after 1m0s
[19:23:03.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:21:0)
[19:23:03.892] Timer tick, asking Buildbucket for the build status
[19:23:03.990] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:03.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:22:0) after 1m0s
[19:24:04.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:22:0)
[19:24:04.260] Timer tick, asking Buildbucket for the build status
[19:24:04.414] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:04.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:23:0) after 1m0s
[19:25:04.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:23:0)
[19:25:04.554] Timer tick, asking Buildbucket for the build status
[19:25:04.829] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:24:0) after 1m0s
[19:26:04.859] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:24:0)
[19:26:04.859] Timer tick, asking Buildbucket for the build status
[19:26:04.975] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:04.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:25:0) after 1m0s
[19:27:05.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:25:0)
[19:27:05.025] Timer tick, asking Buildbucket for the build status
[19:27:05.260] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:05.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:26:0) after 1m0s
[19:28:05.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:26:0)
[19:28:05.334] Timer tick, asking Buildbucket for the build status
[19:28:05.424] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:27:0) after 1m0s
[19:29:05.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:27:0)
[19:29:05.451] Timer tick, asking Buildbucket for the build status
[19:29:05.919] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:05.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:28:0) after 1m0s
[19:30:06.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:28:0)
[19:30:06.028] Timer tick, asking Buildbucket for the build status
[19:30:06.185] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:06.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:29:0) after 1m0s
[19:31:06.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:29:0)
[19:31:06.268] Timer tick, asking Buildbucket for the build status
[19:31:06.455] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:06.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:30:0) after 1m0s
[19:32:06.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:30:0)
[19:32:06.602] Timer tick, asking Buildbucket for the build status
[19:32:06.732] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:06.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:31:0) after 1m0s
[19:33:06.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:31:0)
[19:33:06.761] Timer tick, asking Buildbucket for the build status
[19:33:07.115] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:07.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:32:0) after 1m0s
[19:34:07.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:32:0)
[19:34:07.183] Timer tick, asking Buildbucket for the build status
[19:34:07.525] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:07.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:33:0) after 1m0s
[19:35:07.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:33:0)
[19:35:07.574] Timer tick, asking Buildbucket for the build status
[19:35:08.205] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:08.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:34:0) after 1m0s
[19:36:08.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:34:0)
[19:36:08.227] Timer tick, asking Buildbucket for the build status
[19:36:08.521] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:08.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:35:0) after 1m0s
[19:37:08.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:35:0)
[19:37:08.558] Timer tick, asking Buildbucket for the build status
[19:37:08.823] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:36:0) after 1m0s
[19:38:08.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:36:0)
[19:38:08.908] Timer tick, asking Buildbucket for the build status
[19:38:09.186] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:09.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:37:0) after 1m0s
[19:39:09.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:37:0)
[19:39:09.216] Timer tick, asking Buildbucket for the build status
[19:39:09.345] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:09.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:38:0) after 1m0s
[19:40:09.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:38:0)
[19:40:09.493] Timer tick, asking Buildbucket for the build status
[19:40:10.077] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:10.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:39:0) after 1m0s
[19:41:10.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:39:0)
[19:41:10.122] Timer tick, asking Buildbucket for the build status
[19:41:10.252] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:10.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:40:0) after 1m0s
[19:42:10.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:40:0)
[19:42:10.308] Timer tick, asking Buildbucket for the build status
[19:42:11.804] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:41:0) after 1m0s
[19:43:11.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:41:0)
[19:43:11.957] Timer tick, asking Buildbucket for the build status
[19:43:12.032] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:12.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:42:0) after 1m0s
[19:44:12.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:42:0)
[19:44:12.119] Timer tick, asking Buildbucket for the build status
[19:44:12.224] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:12.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:43:0) after 1m0s
[19:45:12.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:43:0)
[19:45:12.227] Timer tick, asking Buildbucket for the build status
[19:45:12.826] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:12.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:44:0) after 1m0s
[19:46:12.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:44:0)
[19:46:12.889] Timer tick, asking Buildbucket for the build status
[19:46:13.437] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:45:0) after 1m0s
[19:47:13.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:45:0)
[19:47:13.490] Timer tick, asking Buildbucket for the build status
[19:47:13.593] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:13.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:46:0) after 1m0s
[19:48:13.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:46:0)
[19:48:13.662] Timer tick, asking Buildbucket for the build status
[19:48:13.915] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:13.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:47:0) after 1m0s
[19:49:13.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:47:0)
[19:49:13.927] Timer tick, asking Buildbucket for the build status
[19:49:14.412] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:14.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:48:0) after 1m0s
[19:50:14.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:48:0)
[19:50:14.537] Timer tick, asking Buildbucket for the build status
[19:50:14.644] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:14.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:49:0) after 1m0s
[19:51:14.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:49:0)
[19:51:14.816] Timer tick, asking Buildbucket for the build status
[19:51:15.135] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:15.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:50:0) after 1m0s
[19:52:15.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:50:0)
[19:52:15.162] Timer tick, asking Buildbucket for the build status
[19:52:15.272] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:15.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:51:0) after 1m0s
[19:53:15.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:51:0)
[19:53:15.306] Timer tick, asking Buildbucket for the build status
[19:53:19.198] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:19.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:52:0) after 1m0s
[19:54:19.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:52:0)
[19:54:19.355] Timer tick, asking Buildbucket for the build status
[19:54:19.492] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:19.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:53:0) after 1m0s
[19:55:19.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:53:0)
[19:55:19.712] Timer tick, asking Buildbucket for the build status
[19:55:19.923] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:19.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:54:0) after 1m0s
[19:56:20.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:54:0)
[19:56:20.069] Timer tick, asking Buildbucket for the build status
[19:56:20.188] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:20.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:55:0) after 1m0s
[19:57:20.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:55:0)
[19:57:20.239] Timer tick, asking Buildbucket for the build status
[19:57:20.319] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:20.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:56:0) after 1m0s
[19:58:20.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:56:0)
[19:58:20.435] Timer tick, asking Buildbucket for the build status
[19:58:20.555] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:20.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:57:0) after 1m0s
[19:59:20.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:57:0)
[19:59:20.586] Timer tick, asking Buildbucket for the build status
[19:59:20.687] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:20.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:58:0) after 1m0s
[20:00:20.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:58:0)
[20:00:20.685] Timer tick, asking Buildbucket for the build status
[20:00:20.827] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:20.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:59:0) after 1m0s
[20:01:20.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:59:0)
[20:01:20.952] Timer tick, asking Buildbucket for the build status
[20:01:21.098] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:21.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:60:0) after 1m0s
[20:02:21.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:60:0)
[20:02:21.158] Timer tick, asking Buildbucket for the build status
[20:02:21.479] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:21.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:61:0) after 1m0s
[20:03:21.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:61:0)
[20:03:21.540] Timer tick, asking Buildbucket for the build status
[20:03:21.619] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:21.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:62:0) after 1m0s
[20:04:21.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:62:0)
[20:04:21.644] Timer tick, asking Buildbucket for the build status
[20:04:22.192] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:22.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:63:0) after 1m0s
[20:05:22.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:63:0)
[20:05:22.247] Timer tick, asking Buildbucket for the build status
[20:05:22.527] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:22.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:64:0) after 1m0s
[20:06:22.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:64:0)
[20:06:22.597] Timer tick, asking Buildbucket for the build status
[20:06:22.675] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:65:0) after 1m0s
[20:07:22.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:65:0)
[20:07:22.782] Timer tick, asking Buildbucket for the build status
[20:07:22.917] Build 8862633540845864688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:22.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028063604568764912:66:0) after 1m0s
[20:08:25.274] Received PubSub notification, asking Buildbucket for the build status
[20:08:25.361] Build 8862633540845864688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:08:25.361] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606334904291231",
"created_by": "project:chromium",
"created_ts": "1606331038582066",
"id": "8862633540845864688",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\"}}",
"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\": \"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\", \"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\": 15847, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"732dc2952044df8f3806cdb8e26e10687c422a7c\", \"got_dawn_revision\": \"a66263753a9f31ae9fa05af4f5ef0b18924d0b8e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\", \"got_revision_cp\": \"refs/heads/master@{#831080}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"08ac8ee506608963b749a7ec05b1dde7511d3996\", \"got_v8_revision_cp\": \"refs/heads/8.9.48@{#1}\", \"got_webrtc_revision\": \"9a5e21da681da6c0c786d83a2141367715293b6b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32692}\", \"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\": \"3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9\", \"swarm_hashes_refs/heads/master(at){#831080}_without_patch\": {\"absl_hardening_tests\": \"cf0820d8a993b97c73ed777e1e5d902f5d9cecd0\", \"accessibility_unittests\": \"c525ba1e6d966b1fe4374a2802bcb243454ffc19\", \"angle_unittests\": \"c7f7930cf2431d3bfaafe9f1140923b589c0aa7d\", \"app_shell_unittests\": \"acbae9f9f18f65b8a26e4b2037dcfb290641a546\", \"aura_unittests\": \"915474caf153d1c6b867c351d031db8ba93b1252\", \"base_unittests\": \"4614a5b23732b2ca7899efcfed31733a0813ff95\", \"base_util_unittests\": \"6367013368c86129c8673a0e8b1538668eec6589\", \"blink_common_unittests\": \"d6d9b467d22d823af8a91a4eb02fe1f86a002d4c\", \"blink_fuzzer_unittests\": \"6672bcf4233d4bc8311f17c2516d777fd6e48230\", \"blink_heap_unittests\": \"732ce14de1c15e8456aba3c5633c80389ca8f53d\", \"blink_platform_unittests\": \"431c200eff4d9d6df09e82557a8f210530cc6422\", \"blink_unittests\": \"cb3e1b42ce56dbba6becfec9f063f4763e00c2a5\", \"boringssl_crypto_tests\": \"b464be6df986747d2acfb400d881ace5f2358956\", \"boringssl_ssl_tests\": \"9e547a6359e7df90eed944389ebfbc7680948762\", \"browser_switcher_bho_unittests\": \"36326cd6f36818489c842a8f6acc57ab39e6f5b0\", \"browser_tests\": \"02cb9834fddd66f3b1ca8cb3f6ac7c78236b64ea\", \"capture_unittests\": \"5370de71326b38402db1780b2dbe69972831ee4f\", \"cast_unittests\": \"dd457477578624dfdb25b59f10e8a640e6b99d01\", \"cc_unittests\": \"9019e8017d73261e9ee6782db6ce2d1287471fab\", \"chrome_app_unittests\": \"cd31b62a7485eed4f3659f844ee7d26fd0f8e436\", \"chrome_cleaner_unittests\": \"f293ed6587c92432f32db921db62f0e85d32b39f\", \"chrome_elf_unittests\": \"72b2f42a883225a11e478f770ccb69e1ccccc396\", \"chromedriver_unittests\": \"ae3b488924bdf8f9ac0d945fbe3b5abe938b718b\", \"components_browsertests\": \"8a95468f9dc28f065a5e7f9db5686cd9cf6f0d65\", \"components_unittests\": \"00aa3e68ed9b9398690e0699d2b4c5c62b02eea9\", \"compositor_unittests\": \"712cc5b71bf3d99b01cce0c0b8ebd76a05f8d736\", \"content_browsertests\": \"9af31917f87a7f4bd3cb6dd0c944ae524e381d18\", \"content_unittests\": \"358a08cb06a1c93b233cb893722d1af839aa46b7\", \"courgette_unittests\": \"95a9ec4d74334f5c500608dfa2092fe7f6fce8ec\", \"crashpad_tests\": \"414b958fad391ba589ad32f1ae853a52b1277d06\", \"cronet_tests\": \"171661ff61ea570f9c5414242d6b730b4c738ace\", \"cronet_unittests\": \"141c5622987d4ab242713cbdc82805f9496ec8d5\", \"crypto_unittests\": \"8d1cac27ec0ef302b2a1d0fe6ce36024846dc0c8\", \"delayloads_unittests\": \"ecda08ea50b9af3c3a631218bc95945ba271b008\", \"device_unittests\": \"6db0e3e24430db21de1dcc01a1420f78ee7f98f8\", \"display_unittests\": \"add23534cdfb7178cb333247548364ee27264e0c\", \"elevation_service_unittests\": \"d23691825e805e5ce69631b5a4b2b8b8d9aa2702\", \"events_unittests\": \"d29c5dec86a82fd5c9fd039013cdc69a0b506b5f\", \"extensions_browsertests\": \"adf8438b76cb95c7b63bd3e214a627226362988a\", \"extensions_unittests\": \"0dc1dcf48d233c455755ca7b236ecd2e466be2f8\", \"filesystem_service_unittests\": \"d0b20a1315ec7ce538e4be153227f7275200a41c\", \"gcm_unit_tests\": \"acf37eb99b80ce61a829f09c544e6db0bd63ed2d\", \"gcp_unittests\": \"8c8e9f39b730ef77d16bb173c22ccce8f3c62d79\", \"gfx_unittests\": \"76283839b276bff2c918136648f598de6edc192d\", \"gin_unittests\": \"4f0fc35b39ae540e7edaa1c6cb2d556b09496c47\", \"google_apis_unittests\": \"f9a3201fbe1cbc16747a367bb608986d7b1c9fe5\", \"gpu_unittests\": \"307d5cdc87e5c9fb19b0b496a63d0a433f4bca20\", \"gwp_asan_unittests\": \"71a1b9b7153942016294e12491286ab041b7997d\", \"headless_browsertests\": \"9caabdae782700a9d6451aff66a9289c7331ac74\", \"headless_unittests\": \"54c63fb291c299b0e7849e5d6963058f190a0408\", \"install_static_unittests\": \"4bf9d2ec66679fac3b846fbe63c50725bfaa8687\", \"installer_util_unittests\": \"bf9ed31cb480f4b17d77e6620b1749a5c13ce0f8\", \"interactive_ui_tests\": \"306605f749fe19f5a4480d1683ed3cd57b75ebfe\", \"ipc_tests\": \"26358ad374cedf54d96ba9b5ed9f435d5c90c4b3\", \"jingle_unittests\": \"809c1cb6a3615059a31ff6274ed3ee45af83f569\", \"latency_unittests\": \"4ce147f834ef8c2410909bccffa368a269fc7f8a\", \"libjingle_xmpp_unittests\": \"ed6e8b4851e6287b23e4fe6695b39d5ed27924b2\", \"liburlpattern_unittests\": \"5651338ddfd5594e994e12200d81e4a53688c2d5\", \"media_blink_unittests\": \"69361103770af3f86f20c5c1e6e2e603f0fdb3dd\", \"media_unittests\": \"86f78ac86933131228b5e641d5f55ddf0651e317\", \"message_center_unittests\": \"74228f580bfc9d0eb9467888d50fa9d794ddba8a\", \"midi_unittests\": \"bdb94db6b0c34e6ad22a959058dcdf8042e2c3c2\", \"mojo_core_unittests\": \"655bfe36458eafc9ceb40ca641f94d1829cd275e\", \"mojo_unittests\": \"5b3bd4a32bbd588eba065fba27f3fd9099c49944\", \"nacl_loader_unittests\": \"914df695f1250781305291b971cb46d4a95b9ffb\", \"native_theme_unittests\": \"21a4b3752422ca9c6c94996fbcd26ee3156c1e0c\", \"net_unittests\": \"b6e8accfee18cb39bddb4cab197bd4707bdac318\", \"notification_helper_unittests\": \"88960979eb849d2413c5e70a8e46fa13cb3da5ff\", \"pdf_unittests\": \"4b840896b18cd06d30bb1c11f34edda4bf3f895e\", \"perfetto_unittests\": \"bb249fd3c92b01cf82d969f41e6d6e054e0662b3\", \"ppapi_unittests\": \"872b804d06e68fbc6935eb4e68fa9f017db69d16\", \"printing_unittests\": \"1a0d75a45b24a2ae53711d64ac2a5921d2f3d65f\", \"remoting_unittests\": \"3a6a3f35209710112450c60a247eaadc97d4e1ac\", \"sbox_integration_tests\": \"d785ea5ffaf748d456d1fdb56a92c25b6862beb5\", \"sbox_unittests\": \"c9fe1b9569c617e14c2db5ad7dd2487bedfbf061\", \"sbox_validation_tests\": \"948bae06099b9c2b7f26583317969c3244f8c8d6\", \"service_manager_unittests\": \"dd63a70e9d202301acce5d86844c8383a3caf431\", \"services_unittests\": \"1b9b00b5400c6471dfffb051110d8f0a36f17f52\", \"setup_unittests\": \"0bd63b2b627ea8bdd311b75eb2e8a5d16dbcd8d5\", \"shell_dialogs_unittests\": \"1b5cc1c5a9bdb4e8bdd3bdf3f029cf6c7fefa1ca\", \"skia_unittests\": \"302f099b9f5c7a589d40a5b2dc1506e71546a852\", \"snapshot_unittests\": \"bfce42b924a5a7745589eb91abee9c87a6f41f1d\", \"sql_unittests\": \"f6d646720088d30c6f18beb9447fe7d8a4fdffe7\", \"storage_unittests\": \"bda2d80fd32c72afdc92c9227a8daaf658105c12\", \"sync_integration_tests\": \"532fdb6cb562f217aeb1b92b8827e1f06e4cac24\", \"traffic_annotation_auditor_unittests\": \"00892dffd38798b9c108a4c37bd65102cf462aa4\", \"ui_base_unittests\": \"a509f5c0b049c9fc2687f4943163885cc251c35e\", \"ui_touch_selection_unittests\": \"4f0b17411aa4f5d972f00af84cdd84469fbe7de2\", \"unit_tests\": \"4597e29172dcb62ac3a15b3db839ac26ce90f2b0\", \"updater_tests\": \"7d57af8211e1e2175da48cfbea19b971f799f795\", \"url_unittests\": \"a15bce03d0d51672310bb6b31a56a77781216a47\", \"views_unittests\": \"8f3f4a55bc1fccac0febf73379faff7983701565\", \"viz_unittests\": \"c5f16a3c767d93fb29d6cd74ddb2f5080e026b51\", \"vr_common_unittests\": \"e5215e3b21286f4cc9167654f0b9e7789ed9cd10\", \"vr_pixeltests\": \"46a3a1f5741f5d44301cd0ed47bb1c437c3445d2\", \"weblayer_browsertests\": \"622061e68fd508098f9e28201f31bdc980e1dcc1\", \"weblayer_unittests\": \"362fd158ff5647654cb29e939b28195608494e8e\", \"wm_unittests\": \"e081d9adfd420a6c4ea8a3deca1071fde4206c51\", \"wtf_unittests\": \"13757aa8ab29def16070b61933fa5e1453238be9\", \"zlib_unittests\": \"5663640842c011132e875269a8f3c1cdb5479014\", \"zucchini_unittests\": \"b6d1cf814ccc85374a58dc1c9d56d3f12514dcc8\"}}, \"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": "1606331040505672",
"status": "COMPLETED",
"status_changed_ts": "1606334904785630",
"tags": [
"build_address:luci.chromium.ci/win-asan/15847",
"builder:win-asan",
"buildset:commit/git/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c7730b3b2b1f5930602e29ee4bfd52743b8ffd9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028063604568764912",
"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/8862633540845864688/+/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:50199c067ecc7b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606334904793640",
"url": "https://ci.chromium.org/b/8862633540845864688",
"utcnow_ts": "1606334905349260"
}
}
[20:08:25.361] Invocation finished in 1h4m29.713490458s with status SUCCEEDED