[13:32:58.133] New invocation is queued and will start shortly
[13:32:59.246] Starting the invocation (attempt 1)
[13:32:59.285] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:32:59.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:32:59.286] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030077559962141040",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cf25f42141b6fcc73cb826cfce1b293b10317e1a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030077559962141040",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"gitiles_ref:refs/heads/master"
]
}
[13:32:59.951] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604410379364748",
"id": "8864647498005782784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf25f42141b6fcc73cb826cfce1b293b10317e1a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604410379784376",
"tags": [
"build_address:luci.chromium.ci/win-asan/15434",
"builder:win-asan",
"buildset:commit/git/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030077559962141040",
"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/8864647498005782784/+/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": "1604410379784496",
"url": "https://ci.chromium.org/b/8864647498005782784",
"utcnow_ts": "1604410379943188"
}
}
[13:32:59.951] Task URL: https://ci.chromium.org/b/8864647498005782784
[13:32:59.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:2:0) after 1m0s
[13:33:04.689] Received PubSub notification, asking Buildbucket for the build status
[13:33:04.785] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:59.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:2:0)
[13:33:59.972] Timer tick, asking Buildbucket for the build status
[13:34:00.315] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:00.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:4:0) after 1m0s
[13:35:00.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:4:0)
[13:35:00.336] Timer tick, asking Buildbucket for the build status
[13:35:00.536] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:00.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:5:0) after 1m0s
[13:36:00.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:5:0)
[13:36:00.622] Timer tick, asking Buildbucket for the build status
[13:36:00.750] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:00.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:6:0) after 1m0s
[13:37:00.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:6:0)
[13:37:00.777] Timer tick, asking Buildbucket for the build status
[13:37:01.114] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:01.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:7:0) after 1m0s
[13:38:01.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:7:0)
[13:38:01.114] Timer tick, asking Buildbucket for the build status
[13:38:01.249] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:01.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:8:0) after 1m0s
[13:39:01.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:8:0)
[13:39:01.284] Timer tick, asking Buildbucket for the build status
[13:39:01.437] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:01.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:9:0) after 1m0s
[13:40:01.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:9:0)
[13:40:01.499] Timer tick, asking Buildbucket for the build status
[13:40:01.583] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:01.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:10:0) after 1m0s
[13:41:01.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:10:0)
[13:41:01.567] Timer tick, asking Buildbucket for the build status
[13:41:01.881] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:01.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:11:0) after 1m0s
[13:42:01.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:11:0)
[13:42:01.977] Timer tick, asking Buildbucket for the build status
[13:42:02.057] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:02.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:12:0) after 1m0s
[13:43:02.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:12:0)
[13:43:02.171] Timer tick, asking Buildbucket for the build status
[13:43:02.267] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:02.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:13:0) after 1m0s
[13:44:02.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:13:0)
[13:44:02.273] Timer tick, asking Buildbucket for the build status
[13:44:02.741] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:02.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:14:0) after 1m0s
[13:45:02.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:14:0)
[13:45:02.790] Timer tick, asking Buildbucket for the build status
[13:45:02.992] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:02.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:15:0) after 1m0s
[13:46:03.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:15:0)
[13:46:03.014] Timer tick, asking Buildbucket for the build status
[13:46:03.130] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:03.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:16:0) after 1m0s
[13:47:03.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:16:0)
[13:47:03.151] Timer tick, asking Buildbucket for the build status
[13:47:03.773] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:03.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:17:0) after 1m0s
[13:48:03.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:17:0)
[13:48:03.809] Timer tick, asking Buildbucket for the build status
[13:48:04.103] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:04.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:18:0) after 1m0s
[13:49:04.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:18:0)
[13:49:04.128] Timer tick, asking Buildbucket for the build status
[13:49:04.785] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:04.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:19:0) after 1m0s
[13:50:04.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:19:0)
[13:50:04.818] Timer tick, asking Buildbucket for the build status
[13:50:05.012] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:05.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:20:0) after 1m0s
[13:51:05.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:20:0)
[13:51:05.064] Timer tick, asking Buildbucket for the build status
[13:51:05.820] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:05.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:21:0) after 1m0s
[13:52:05.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:21:0)
[13:52:05.836] Timer tick, asking Buildbucket for the build status
[13:52:06.080] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:06.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:22:0) after 1m0s
[13:53:06.160] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:22:0)
[13:53:06.160] Timer tick, asking Buildbucket for the build status
[13:53:06.304] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:06.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:23:0) after 1m0s
[13:54:06.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:23:0)
[13:54:06.288] Timer tick, asking Buildbucket for the build status
[13:54:06.555] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:06.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:24:0) after 1m0s
[13:55:06.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:24:0)
[13:55:06.679] Timer tick, asking Buildbucket for the build status
[13:55:06.840] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:06.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:25:0) after 1m0s
[13:56:06.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:25:0)
[13:56:06.911] Timer tick, asking Buildbucket for the build status
[13:56:07.196] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:07.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:26:0) after 1m0s
[13:57:07.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:26:0)
[13:57:07.259] Timer tick, asking Buildbucket for the build status
[13:57:07.408] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:07.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:27:0) after 1m0s
[13:58:07.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:27:0)
[13:58:07.456] Timer tick, asking Buildbucket for the build status
[13:58:07.612] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:07.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:28:0) after 1m0s
[13:59:07.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:28:0)
[13:59:07.634] Timer tick, asking Buildbucket for the build status
[13:59:08.269] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:08.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:29:0) after 1m0s
[14:00:08.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:29:0)
[14:00:08.338] Timer tick, asking Buildbucket for the build status
[14:00:08.634] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:08.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:30:0) after 1m0s
[14:01:08.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:30:0)
[14:01:08.690] Timer tick, asking Buildbucket for the build status
[14:01:08.815] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:08.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:31:0) after 1m0s
[14:02:08.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:31:0)
[14:02:08.850] Timer tick, asking Buildbucket for the build status
[14:02:08.969] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:08.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:32:0) after 1m0s
[14:03:09.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:32:0)
[14:03:09.098] Timer tick, asking Buildbucket for the build status
[14:03:10.891] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:10.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:33:0) after 1m0s
[14:04:10.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:33:0)
[14:04:10.992] Timer tick, asking Buildbucket for the build status
[14:04:11.173] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:11.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:34:0) after 1m0s
[14:05:11.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:34:0)
[14:05:11.232] Timer tick, asking Buildbucket for the build status
[14:05:11.347] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:11.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:35:0) after 1m0s
[14:06:11.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:35:0)
[14:06:11.398] Timer tick, asking Buildbucket for the build status
[14:06:11.613] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:11.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:36:0) after 1m0s
[14:07:11.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:36:0)
[14:07:11.699] Timer tick, asking Buildbucket for the build status
[14:07:11.804] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:37:0) after 1m0s
[14:08:11.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:37:0)
[14:08:11.840] Timer tick, asking Buildbucket for the build status
[14:08:13.695] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:13.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:38:0) after 1m0s
[14:09:13.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:38:0)
[14:09:13.716] Timer tick, asking Buildbucket for the build status
[14:09:14.053] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:39:0) after 1m0s
[14:10:14.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:39:0)
[14:10:14.069] Timer tick, asking Buildbucket for the build status
[14:10:15.472] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:15.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:40:0) after 1m0s
[14:11:15.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:40:0)
[14:11:15.501] Timer tick, asking Buildbucket for the build status
[14:11:15.885] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:15.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:41:0) after 1m0s
[14:12:15.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:41:0)
[14:12:15.925] Timer tick, asking Buildbucket for the build status
[14:12:16.101] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:16.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:42:0) after 1m0s
[14:13:16.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:42:0)
[14:13:16.155] Timer tick, asking Buildbucket for the build status
[14:13:16.681] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:16.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:43:0) after 1m0s
[14:14:16.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:43:0)
[14:14:16.702] Timer tick, asking Buildbucket for the build status
[14:14:17.334] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:17.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:44:0) after 1m0s
[14:15:17.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:44:0)
[14:15:17.387] Timer tick, asking Buildbucket for the build status
[14:15:17.602] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:17.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:45:0) after 1m0s
[14:16:17.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:45:0)
[14:16:17.617] Timer tick, asking Buildbucket for the build status
[14:16:17.833] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:17.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:46:0) after 1m0s
[14:17:17.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:46:0)
[14:17:17.852] Timer tick, asking Buildbucket for the build status
[14:17:17.997] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:17.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:47:0) after 1m0s
[14:18:18.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:47:0)
[14:18:18.021] Timer tick, asking Buildbucket for the build status
[14:18:18.230] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:18.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:48:0) after 1m0s
[14:19:18.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:48:0)
[14:19:18.255] Timer tick, asking Buildbucket for the build status
[14:19:18.406] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:18.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:49:0) after 1m0s
[14:20:18.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:49:0)
[14:20:18.467] Timer tick, asking Buildbucket for the build status
[14:20:18.550] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:18.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:50:0) after 1m0s
[14:21:18.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:50:0)
[14:21:18.615] Timer tick, asking Buildbucket for the build status
[14:21:18.696] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:18.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:51:0) after 1m0s
[14:22:18.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:51:0)
[14:22:18.716] Timer tick, asking Buildbucket for the build status
[14:22:19.260] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:19.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:52:0) after 1m0s
[14:23:19.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:52:0)
[14:23:19.346] Timer tick, asking Buildbucket for the build status
[14:23:19.553] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:19.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:53:0) after 1m0s
[14:24:19.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:53:0)
[14:24:19.601] Timer tick, asking Buildbucket for the build status
[14:24:19.804] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:19.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:54:0) after 1m0s
[14:25:19.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:54:0)
[14:25:19.840] Timer tick, asking Buildbucket for the build status
[14:25:20.070] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:20.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:55:0) after 1m0s
[14:26:20.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:55:0)
[14:26:20.097] Timer tick, asking Buildbucket for the build status
[14:26:20.366] Build 8864647498005782784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:20.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030077559962141040:56:0) after 1m0s
[14:26:49.216] Received PubSub notification, asking Buildbucket for the build status
[14:26:49.315] Build 8864647498005782784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:26:49.315] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604413605694796",
"created_by": "project:chromium",
"created_ts": "1604410379364748",
"id": "8864647498005782784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf25f42141b6fcc73cb826cfce1b293b10317e1a\"}}",
"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\": \"cf25f42141b6fcc73cb826cfce1b293b10317e1a\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15434, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"ed916ddf61cc0021cebf55fb6901ba71fe9e6a2e\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"cf25f42141b6fcc73cb826cfce1b293b10317e1a\", \"got_revision_cp\": \"refs/heads/master@{#823520}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"b5bf82693f85b53ce31846705d323764a582489b\", \"got_v8_revision\": \"e0ff8ffa26e56bf39b22eea7731e1b434d2d7378\", \"got_v8_revision_cp\": \"refs/heads/8.8.219@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cf25f42141b6fcc73cb826cfce1b293b10317e1a\", \"swarm_hashes_refs/heads/master(at){#823520}_without_patch\": {\"absl_hardening_tests\": \"0979e211dff75b2bedbff36038687ed6c868a44f\", \"accessibility_unittests\": \"e0d9718f767383b937fcc28ff0776ee0d5ef7f12\", \"angle_unittests\": \"4773d438f0ac2b7f11b3a820eec42f7dbb081b27\", \"app_shell_unittests\": \"22383c0bcb46fbe064043129bec09a774f6e1c32\", \"aura_unittests\": \"ff7523d49e2e8ced14ab180d9f5ac41969e8b151\", \"base_unittests\": \"9527d32e23c99f5805e4427f36aa9e12d4d89dae\", \"base_util_unittests\": \"34d8cb3b0907c95c3ec16fa47e471275f38ec7eb\", \"blink_common_unittests\": \"aafdde71d9fef6ba8d0feddf4d450509b3c14785\", \"blink_fuzzer_unittests\": \"e66f7ac81b1e64c2c9a0b6e3e21a2e7f400157bd\", \"blink_heap_unittests\": \"8f0509bf2d2b375d47e6804f2a3f51488b65ffa5\", \"blink_platform_unittests\": \"77046c76d8c2dc0c8110c9bc41c0f42df9ccb8fa\", \"blink_unittests\": \"80299ee83d00522af80d69b548c6c3a18f2f8c2b\", \"boringssl_crypto_tests\": \"4188a0deabd2561ec21e35ba72ce5417158ffeea\", \"boringssl_ssl_tests\": \"d220d7e48d053546c8098a82a6c677e97ebd13f9\", \"browser_switcher_bho_unittests\": \"204b9791280c4d4914a6ac8786aef4226cef7937\", \"browser_tests\": \"606af2b02ee710022689c77e76b338e6f20220b9\", \"capture_unittests\": \"453749850be9b09c373f5813372536e81b2f89a9\", \"cast_unittests\": \"0011f2c6038f0fd2754b1128b6ac128f62346f38\", \"cc_unittests\": \"861fd0521252ecaa8e684024208bd3b5921f3577\", \"chrome_app_unittests\": \"cb46c062a8fdb32d6bad3b72a96803949b0636ee\", \"chrome_cleaner_unittests\": \"117752adf0943d7bcd8c7ddeb88e0add0839d216\", \"chrome_elf_unittests\": \"83b6ed619f8513d5eb5f4c80d62ed391706aae39\", \"chromedriver_unittests\": \"0126920c1295ad41f52f2b8ecb324f7d6db5f113\", \"components_browsertests\": \"2297d5588bf2391cbc1dec2f8fd64b3e0fd4203b\", \"components_unittests\": \"2cf2161c8274ce12cd82a0ddc637fb220d636393\", \"compositor_unittests\": \"6d5b1b6979c7065256ca0d5bb3545162e1fc6b5b\", \"content_browsertests\": \"9b2d92166790f324383b7fb62ebd61ce84625c36\", \"content_unittests\": \"0d70f4dc52525b494783a6447b080e6ca7e0389e\", \"courgette_unittests\": \"2eb97ce94f62c69ec62970508b0eab41e71fb5d0\", \"crashpad_tests\": \"ac1f05ace3e6cead49d9efeaa7a1702594e39a57\", \"cronet_tests\": \"6fe5c6216f70755f337cbb2528d44a871d0fa735\", \"cronet_unittests\": \"d0ff52fb100f7b0001d4e0fa1782e181d1bd04c5\", \"crypto_unittests\": \"93c3ecca9a65545b4986253cdde82af897ed6998\", \"delayloads_unittests\": \"da1c8ae2065f47d4748f1630310d6fe4dc40602d\", \"device_unittests\": \"d6c5fe6c43e52c25d2969780fa8fa5ae94dd6efa\", \"display_unittests\": \"7e9733250e0903610e4d7f4b5d6d5eba835b56c1\", \"elevation_service_unittests\": \"429bc978366f4500eb3cdfbbc42e33203c8b5f01\", \"events_unittests\": \"ad2941510c29e2c45c39f5688fa08226cc34cb36\", \"extensions_browsertests\": \"3e9de092de2c812bb7aa5bc57a278b8742f186cf\", \"extensions_unittests\": \"26d398e7cf52a989d68b8e550102dd8e9e5f1ce8\", \"filesystem_service_unittests\": \"03e8c3596ba43f3fa7dec051cf1514262b3ca47a\", \"gcm_unit_tests\": \"1be1d1afdb1a8d0025b5b23e8b7fa71e11e3e947\", \"gcp_unittests\": \"623211f7d640613f6f193d61183755a52427977f\", \"gfx_unittests\": \"21c6df237a501a59746fbe5759853f891a4c8075\", \"gin_unittests\": \"95d5188371bf93fade558f20f1f2c753fa7b9e99\", \"google_apis_unittests\": \"2d5899451e73e27c36b9110b20ee9c471b136179\", \"gpu_unittests\": \"bcb2e35b98965d785fd60dec69167fafe438247d\", \"gwp_asan_unittests\": \"0b5a3f75e6c689ab3cf054fb93b981bf7885d739\", \"headless_browsertests\": \"0dcc3da76d43d138aa0c5fd620af2115c463cc45\", \"headless_unittests\": \"59c65807648161171f74e5b357083642fdc4836f\", \"install_static_unittests\": \"29ec5a806c693e9d6d8738a84f7bd9d3100752c1\", \"installer_util_unittests\": \"f52698a6955a9ef47ecdb0cd9155a6999b19e0bc\", \"interactive_ui_tests\": \"ba5d6829917566a26bdcedfe0b716c36a8ed3ccc\", \"ipc_tests\": \"29d91483963d0c303bc27a99fdf4bf5953aafca6\", \"jingle_unittests\": \"06aaa8603b1b79387b37d47cecd26fab699d177a\", \"latency_unittests\": \"ca45fd33a16725bd70c7adf6847440fb5838d3f1\", \"libjingle_xmpp_unittests\": \"a932424e1805bb50a6885586c2eee7e35092a869\", \"liburlpattern_unittests\": \"fbe139c3e4d0a82a33b09f020496b9bfbf60802a\", \"media_blink_unittests\": \"885d370d833fe5bf43695e41ab5f81ad1f8b7922\", \"media_unittests\": \"b79b532e49cc38d3c7f614e3994ab31497a24381\", \"message_center_unittests\": \"339e9034e5b9a94024e533aedb10cc0840d4599c\", \"midi_unittests\": \"40d8deb0a61f84d9fe6e2d5444d6f09981cc33a1\", \"mojo_core_unittests\": \"3051f29f90dd6d75c2e1cc9ca7638f4eb89582bd\", \"mojo_unittests\": \"d99cca28d366a3c35d7e4f7ac11bf86c0e2d33bc\", \"nacl_loader_unittests\": \"5a040772ed518923ce28b6a6841a9dd5af6c8eaa\", \"native_theme_unittests\": \"f3c1c3d6936cec54920127a42fcb80809fe5bcb5\", \"net_unittests\": \"719d4d106d4abab9fbb5dcfa3436953825ae5dfa\", \"notification_helper_unittests\": \"7e5237645105757771f6cf3f578a2e655ebde958\", \"pdf_unittests\": \"b4db75443d7fa0fbe193139855c0a8bd0878deba\", \"perfetto_unittests\": \"1824cd7a0b718afc2243dc065ad489f4e0077b7a\", \"ppapi_unittests\": \"6150c7baf6397aa4eb2e7f5787810d02a71e7ada\", \"printing_unittests\": \"5181145d005ee46c10540d6ba6e75536ed6ee35c\", \"remoting_unittests\": \"f378f17794132c38ed1ad9cffcd8423718c01b44\", \"sbox_integration_tests\": \"a16fb5cc19cd926d95ace79c998e51876515c5f9\", \"sbox_unittests\": \"a21b4c8cb1c0eeb88ec2bbb1554908253865a84e\", \"sbox_validation_tests\": \"03888581661332c067847984d48458b77c6c5af5\", \"service_manager_unittests\": \"3439921202a2be99f00369b1bc12321bc49313ee\", \"services_unittests\": \"a2bd9a20f45b2b3bae53de6d0388b22c98b9465f\", \"setup_unittests\": \"d17b0f9b186ccb1833288af93614b06440344252\", \"shell_dialogs_unittests\": \"2e2680b28a85491bfc42507b9c8fc6cee609a65c\", \"skia_unittests\": \"57a0256daf39ac79a61febe573aec52365c8052a\", \"snapshot_unittests\": \"6703ab3bee938bf9d3422990580ee6cea99e7184\", \"sql_unittests\": \"945443c20014d036b56e82ee39b247f562a0ed03\", \"storage_unittests\": \"ef041cf879eab15860d9a59c3a286342658cd489\", \"sync_integration_tests\": \"139a1d6e85c0d07556c58863fbf113612fc1eb28\", \"traffic_annotation_auditor_unittests\": \"dac6d230774a3192ffc9ce952358472e7fdee2d7\", \"ui_base_unittests\": \"77150ee21b05deeff4b31f58aea4b85f8019ffbf\", \"ui_touch_selection_unittests\": \"4fae7678ff825fa9b1104ab8b609747ec13d75e0\", \"unit_tests\": \"1c91521e874a704e16137fccba32f5b17d37b80f\", \"updater_tests\": \"519237b1ae4bc0008b89118292e14b1975e87bd4\", \"url_unittests\": \"3beb4107f711afda3a475270bc917040754972e3\", \"views_unittests\": \"c0b89506a24385c75b2890c709bd88dfcc80d1e7\", \"viz_unittests\": \"cc79d7e6d3812adb3e1e3802586bca619c6f8906\", \"vr_common_unittests\": \"fc449d2ccb7c3fb3a457243e899afe014bca5324\", \"vr_pixeltests\": \"7a09cde76a6e5e961f1644da7c289322adb9aef0\", \"weblayer_browsertests\": \"50f316b6c478dfc4805f9550cc7e1afce86096fc\", \"weblayer_unittests\": \"3f697a97618a79ef032ef8f09330fe2fa35c4f20\", \"wm_unittests\": \"f8fc862e3f1e9d781322971ed194c677b9aacbca\", \"wtf_unittests\": \"7a30e30f2141b9c71b761509d83b406ead4cb9bb\", \"zlib_unittests\": \"e07821a9877f2b741464b9a344166e0e0b02ec24\", \"zucchini_unittests\": \"34a4a72b7a8fe827830b57d7cdb6715ee8240b02\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"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": "1604410382094906",
"status": "COMPLETED",
"status_changed_ts": "1604413606208770",
"tags": [
"build_address:luci.chromium.ci/win-asan/15434",
"builder:win-asan",
"buildset:commit/git/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf25f42141b6fcc73cb826cfce1b293b10317e1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030077559962141040",
"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/8864647498005782784/+/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:4fa72118b58e1410",
"user_agent:luci-scheduler"
],
"updated_ts": "1604413606230182",
"url": "https://ci.chromium.org/b/8864647498005782784",
"utcnow_ts": "1604413609301303"
}
}
[14:26:49.315] Invocation finished in 53m51.200249498s with status SUCCEEDED