[07:37:42.554] New invocation is queued and will start shortly
[07:37:43.845] Starting the invocation (attempt 1)
[07:37:43.890] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:37:43.890] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:37:43.890] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030190507939427328",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f2fabcd1994cd753a8fa2b6b11281d036c82413e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030190507939427328",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"gitiles_ref:refs/heads/master"
]
}
[07:37:46.927] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604302664791069",
"id": "8864760444922416656",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f2fabcd1994cd753a8fa2b6b11281d036c82413e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604302666703407",
"tags": [
"build_address:luci.chromium.ci/win-asan/15409",
"builder:win-asan",
"buildset:commit/git/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030190507939427328",
"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/8864760444922416656/+/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": "1604302666703529",
"url": "https://ci.chromium.org/b/8864760444922416656",
"utcnow_ts": "1604302666916905"
}
}
[07:37:46.927] Task URL: https://ci.chromium.org/b/8864760444922416656
[07:37:46.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:2:0) after 1m0s
[07:37:48.951] Received PubSub notification, asking Buildbucket for the build status
[07:37:49.049] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:46.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:2:0)
[07:38:46.978] Timer tick, asking Buildbucket for the build status
[07:38:47.514] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:4:0) after 1m0s
[07:39:47.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:4:0)
[07:39:47.593] Timer tick, asking Buildbucket for the build status
[07:39:47.711] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:47.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:5:0) after 1m0s
[07:40:47.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:5:0)
[07:40:47.792] Timer tick, asking Buildbucket for the build status
[07:40:48.339] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:48.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:6:0) after 1m0s
[07:41:48.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:6:0)
[07:41:48.369] Timer tick, asking Buildbucket for the build status
[07:41:48.637] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:48.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:7:0) after 1m0s
[07:42:48.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:7:0)
[07:42:48.679] Timer tick, asking Buildbucket for the build status
[07:42:48.808] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:48.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:8:0) after 1m0s
[07:43:48.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:8:0)
[07:43:48.831] Timer tick, asking Buildbucket for the build status
[07:43:48.924] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:48.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:9:0) after 1m0s
[07:44:49.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:9:0)
[07:44:49.154] Timer tick, asking Buildbucket for the build status
[07:44:49.310] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:49.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:10:0) after 1m0s
[07:45:49.350] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:10:0)
[07:45:49.350] Timer tick, asking Buildbucket for the build status
[07:45:49.485] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:49.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:11:0) after 1m0s
[07:46:49.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:11:0)
[07:46:49.483] Timer tick, asking Buildbucket for the build status
[07:46:49.870] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:49.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:12:0) after 1m0s
[07:47:49.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:12:0)
[07:47:49.872] Timer tick, asking Buildbucket for the build status
[07:47:50.006] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:50.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:13:0) after 1m0s
[07:48:50.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:13:0)
[07:48:50.134] Timer tick, asking Buildbucket for the build status
[07:48:51.286] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:51.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:14:0) after 1m0s
[07:49:51.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:14:0)
[07:49:51.548] Timer tick, asking Buildbucket for the build status
[07:49:51.683] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:51.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:15:0) after 1m0s
[07:50:51.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:15:0)
[07:50:51.944] Timer tick, asking Buildbucket for the build status
[07:50:52.147] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:52.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:16:0) after 1m0s
[07:51:52.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:16:0)
[07:51:52.242] Timer tick, asking Buildbucket for the build status
[07:51:52.362] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:52.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:17:0) after 1m0s
[07:52:52.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:17:0)
[07:52:52.446] Timer tick, asking Buildbucket for the build status
[07:52:52.657] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:18:0) after 1m0s
[07:53:52.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:18:0)
[07:53:52.683] Timer tick, asking Buildbucket for the build status
[07:53:53.310] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:53.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:19:0) after 1m0s
[07:54:53.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:19:0)
[07:54:53.302] Timer tick, asking Buildbucket for the build status
[07:54:53.650] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:53.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:20:0) after 1m0s
[07:55:53.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:20:0)
[07:55:53.712] Timer tick, asking Buildbucket for the build status
[07:55:53.819] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:53.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:21:0) after 1m0s
[07:56:53.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:21:0)
[07:56:53.847] Timer tick, asking Buildbucket for the build status
[07:56:53.990] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:53.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:22:0) after 1m0s
[07:57:54.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:22:0)
[07:57:54.049] Timer tick, asking Buildbucket for the build status
[07:57:54.179] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:54.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:23:0) after 1m0s
[07:58:54.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:23:0)
[07:58:54.220] Timer tick, asking Buildbucket for the build status
[07:58:54.377] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:54.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:24:0) after 1m0s
[07:59:54.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:24:0)
[07:59:54.496] Timer tick, asking Buildbucket for the build status
[07:59:54.616] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:54.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:25:0) after 1m0s
[08:00:54.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:25:0)
[08:00:54.680] Timer tick, asking Buildbucket for the build status
[08:00:54.846] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:54.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:26:0) after 1m0s
[08:01:54.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:26:0)
[08:01:54.874] Timer tick, asking Buildbucket for the build status
[08:01:54.981] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:54.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:27:0) after 1m0s
[08:02:55.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:27:0)
[08:02:55.004] Timer tick, asking Buildbucket for the build status
[08:02:55.225] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:55.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:28:0) after 1m0s
[08:03:55.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:28:0)
[08:03:55.300] Timer tick, asking Buildbucket for the build status
[08:03:55.384] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:55.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:29:0) after 1m0s
[08:04:55.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:29:0)
[08:04:55.501] Timer tick, asking Buildbucket for the build status
[08:04:55.665] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:55.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:30:0) after 1m0s
[08:05:55.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:30:0)
[08:05:55.828] Timer tick, asking Buildbucket for the build status
[08:05:56.010] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:56.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:31:0) after 1m0s
[08:06:56.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:31:0)
[08:06:56.129] Timer tick, asking Buildbucket for the build status
[08:06:56.216] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:56.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:32:0) after 1m0s
[08:07:56.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:32:0)
[08:07:56.414] Timer tick, asking Buildbucket for the build status
[08:07:56.815] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:56.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:33:0) after 1m0s
[08:08:56.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:33:0)
[08:08:56.800] Timer tick, asking Buildbucket for the build status
[08:08:57.087] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:57.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:34:0) after 1m0s
[08:09:57.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:34:0)
[08:09:57.165] Timer tick, asking Buildbucket for the build status
[08:09:57.339] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:57.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:35:0) after 1m0s
[08:10:57.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:35:0)
[08:10:57.373] Timer tick, asking Buildbucket for the build status
[08:10:57.461] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:57.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:36:0) after 1m0s
[08:11:57.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:36:0)
[08:11:57.511] Timer tick, asking Buildbucket for the build status
[08:11:57.660] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:57.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:37:0) after 1m0s
[08:12:57.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:37:0)
[08:12:57.863] Timer tick, asking Buildbucket for the build status
[08:12:58.008] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:58.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:38:0) after 1m0s
[08:13:58.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:38:0)
[08:13:58.033] Timer tick, asking Buildbucket for the build status
[08:13:58.190] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:58.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:39:0) after 1m0s
[08:14:58.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:39:0)
[08:14:58.269] Timer tick, asking Buildbucket for the build status
[08:14:58.657] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:58.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:40:0) after 1m0s
[08:15:58.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:40:0)
[08:15:58.677] Timer tick, asking Buildbucket for the build status
[08:15:58.824] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:58.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:41:0) after 1m0s
[08:16:58.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:41:0)
[08:16:58.858] Timer tick, asking Buildbucket for the build status
[08:16:58.948] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:58.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:42:0) after 1m0s
[08:17:58.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:42:0)
[08:17:58.987] Timer tick, asking Buildbucket for the build status
[08:17:59.408] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:43:0) after 1m0s
[08:18:59.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:43:0)
[08:18:59.516] Timer tick, asking Buildbucket for the build status
[08:19:00.207] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:00.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:44:0) after 1m0s
[08:20:00.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:44:0)
[08:20:00.904] Timer tick, asking Buildbucket for the build status
[08:20:01.084] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:01.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:45:0) after 1m0s
[08:21:02.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:45:0)
[08:21:02.151] Timer tick, asking Buildbucket for the build status
[08:21:02.300] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:02.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:46:0) after 1m0s
[08:22:03.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:46:0)
[08:22:03.067] Timer tick, asking Buildbucket for the build status
[08:22:03.229] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:03.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:47:0) after 1m0s
[08:23:03.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:47:0)
[08:23:03.784] Timer tick, asking Buildbucket for the build status
[08:23:03.926] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:03.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:48:0) after 1m0s
[08:24:04.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:48:0)
[08:24:04.227] Timer tick, asking Buildbucket for the build status
[08:24:04.324] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:04.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:49:0) after 1m0s
[08:25:04.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:49:0)
[08:25:04.486] Timer tick, asking Buildbucket for the build status
[08:25:04.648] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:04.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:50:0) after 1m0s
[08:26:04.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:50:0)
[08:26:04.765] Timer tick, asking Buildbucket for the build status
[08:26:04.851] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:04.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:51:0) after 1m0s
[08:27:04.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:51:0)
[08:27:04.871] Timer tick, asking Buildbucket for the build status
[08:27:05.015] Build 8864760444922416656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:05.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030190507939427328:52:0) after 1m0s
[08:27:29.155] Received PubSub notification, asking Buildbucket for the build status
[08:27:29.588] Build 8864760444922416656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:27:29.588] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604305647276819",
"created_by": "project:chromium",
"created_ts": "1604302664791069",
"id": "8864760444922416656",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f2fabcd1994cd753a8fa2b6b11281d036c82413e\"}}",
"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\": \"f2fabcd1994cd753a8fa2b6b11281d036c82413e\", \"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-us-central1-b-32-0-cki8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15409, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"068bb086e1c844161c18185a9110f9588f5b6e8a\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f2fabcd1994cd753a8fa2b6b11281d036c82413e\", \"got_revision_cp\": \"refs/heads/master@{#823076}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"be169f638f5edd2af0946618b0c98c9339f33627\", \"got_v8_revision_cp\": \"refs/heads/8.8.215@{#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\": \"f2fabcd1994cd753a8fa2b6b11281d036c82413e\", \"swarm_hashes_refs/heads/master(at){#823076}_without_patch\": {\"absl_hardening_tests\": \"d5a86944f2a750fb455a9a2699620e68bdd97190\", \"accessibility_unittests\": \"c741b4a86d6063f36195f02c1c4d6b00f6f659e7\", \"angle_unittests\": \"93d666cacde050d6d11937c7c9a60a4141874ae2\", \"app_shell_unittests\": \"eefc37eb3e562c43b8f80c096e91dbadf2553812\", \"aura_unittests\": \"a9b020739f488c54a94fca16e76e9f1cc7d60c7a\", \"base_unittests\": \"dff8dc06b5c39f36d1f7122678558135b60c9fdf\", \"base_util_unittests\": \"5ebd7ae8e2bf642902d1e8348fb5b7c271f5c80e\", \"blink_common_unittests\": \"d8a7f7928ea049de115c73b91a72b53647dc8c9c\", \"blink_fuzzer_unittests\": \"2eff3a6990d1817e6881bc9f6a86c54c74d18678\", \"blink_heap_unittests\": \"9ab802da2e82d36f44dc998d24544e7dd4f98920\", \"blink_platform_unittests\": \"265905aee0a69f212e4255fa31ca68a96ec43d1b\", \"blink_unittests\": \"c47940a3af7fc34005f3b265baf411cd6fdb5c6b\", \"boringssl_crypto_tests\": \"88cbfece12d9cb6fc9b8ac4db1e012d8775d31a2\", \"boringssl_ssl_tests\": \"bd1f7c2582a548a6144caa5ea57061db5d3159d5\", \"browser_switcher_bho_unittests\": \"1ed50446122794a2fa7b2c38f63f8972cffd5b8c\", \"browser_tests\": \"2957264a52b5682a0d0a34cee3fe7cd10faa17fa\", \"capture_unittests\": \"93951d9dae603875b01a6c5610890c712b2b59ee\", \"cast_unittests\": \"61509b2c2cab64a7cc633320c05fb062e0c7e3fc\", \"cc_unittests\": \"3dc6fef2fbf7f9be94273b28cddfd8fe93de35cd\", \"chrome_app_unittests\": \"02c6ce97074aaeed5909484c9945f32594848eae\", \"chrome_cleaner_unittests\": \"8e4a21aa2a37845363fc3481aae3f36a376ef1dc\", \"chrome_elf_unittests\": \"d94bf2311c13bb00a1e50ee40c64c604742be7e0\", \"chromedriver_unittests\": \"0cf1cd7ab3df2af60ecd5fe585aaa1d5f356f2c0\", \"components_browsertests\": \"94dab5555c1eb9484d5c752b73acb3e65f838780\", \"components_unittests\": \"c876632f4f3a47b8ea491438be301f96cfef314a\", \"compositor_unittests\": \"45dbb481317cdb74dc3ac39d88505ad7cc16f577\", \"content_browsertests\": \"874cfa963b668fbbe71e1b55161e1f861f3d95ed\", \"content_unittests\": \"38c7191b9b3ec52f17f11222b7872d6fdd98ce97\", \"courgette_unittests\": \"7d13ee8c04571136cc677c437e6d5ca9b3b07f6f\", \"crashpad_tests\": \"7d50ff645dde37d0f12477bec3b0ebc2ff9c6556\", \"cronet_tests\": \"a787394c649a2c6d233c305dc868ae673d1ac9ab\", \"cronet_unittests\": \"0d6c2e06e990000f25a5cf122b8cd2ada4dd022f\", \"crypto_unittests\": \"6719b0c5b489d31b48daea1b5cdbee159cda404f\", \"delayloads_unittests\": \"508c9fdc9d6eaccbd726fa31ccdf2491d3e35e48\", \"device_unittests\": \"bf9a50a3e8b9d1cb797f3e872ff2a33c984e9ff9\", \"display_unittests\": \"1263d498c57add70fef07d87ed22f3f608862a32\", \"elevation_service_unittests\": \"a6a2c4fc97a003e6d9ee4ab933a5140f359c184e\", \"events_unittests\": \"229f23129275ca157cb38b4744bcfa912826e771\", \"extensions_browsertests\": \"5ddecde18c32e1109a3cdfcb04691c5c6d7eff07\", \"extensions_unittests\": \"415c5dd1a881460e3fc63b1e22eb0da28365cbbd\", \"filesystem_service_unittests\": \"4b2e8b3e4bd32caa7ef2ae35b06f476acb47be08\", \"gcm_unit_tests\": \"dcf8eac2f4512eb1eec8cc12fe1a4ec838e5d849\", \"gcp_unittests\": \"1bb142fc27686bab6d5580c41050a36c45c1f2e2\", \"gfx_unittests\": \"a003b9ad9d507a925ae7daff4f1bcbc7aee34488\", \"gin_unittests\": \"b834e060882477e64f6f931b504a3abc31613d29\", \"google_apis_unittests\": \"90f88c098d935c05c26193dca08ef64639bcd2c8\", \"gpu_unittests\": \"5547356bd7d7fb45ab08d33bf6c28c821a19842a\", \"gwp_asan_unittests\": \"38a832f8d8d57c9f0f126591410bd172beca474d\", \"headless_browsertests\": \"0afb1eabea5cda62ba1d98e4e53ef5f8cdbda278\", \"headless_unittests\": \"ce56349e9ec3888259ba88e139a80fddde551dd1\", \"install_static_unittests\": \"0113705afce518735ebc94df605d91d1618dd705\", \"installer_util_unittests\": \"dbb3a637b547d77b630a6bcd4e625bdd5badcacc\", \"interactive_ui_tests\": \"2678bf1712ab285b7ad9d36f118ff17dc69d50e6\", \"ipc_tests\": \"4e88cf786df54c9c3a2effee60aa4029b34156b2\", \"jingle_unittests\": \"57c714b8670b394f1e1c58dbb846eea169089371\", \"latency_unittests\": \"ef1f17bcd8ebd0c5924c7e88ea86edcbbca89371\", \"libjingle_xmpp_unittests\": \"1b08636bc77c9f7b7932280b93f38f72c7560990\", \"liburlpattern_unittests\": \"9be2c250e7759e35a7fb76719aee63f52d108561\", \"media_blink_unittests\": \"fb7e247381a3877e435441f048367020d8c2b481\", \"media_unittests\": \"9edbdaf1586f7e716e4b32fc290dcca9e9b1882a\", \"message_center_unittests\": \"a9888af75e23a478e263e844740dd935c00edfff\", \"midi_unittests\": \"8113edd74d8b717c4f44d5e2f0a8860321330ee3\", \"mojo_core_unittests\": \"e48c911080a6f5f560be8c1afea807a97a9275b0\", \"mojo_unittests\": \"4468424a7e809a957ee4b21119233df6eec92ab0\", \"nacl_loader_unittests\": \"122cb2757987d109f5fb477601a46f38892c4961\", \"native_theme_unittests\": \"3abffb4231d94a055a8941d85a073007130728a0\", \"net_unittests\": \"f25a0ab68735471605bc807c379e10ade0cf2b3b\", \"notification_helper_unittests\": \"8dc271fe5c6f46425466f357b5d120a54760c93c\", \"pdf_unittests\": \"3347ccc36e7174fc9b5929d302900192a8f58103\", \"perfetto_unittests\": \"c95d5f0a9c3aa8a18b77d8ad5835e9a6b6f25c35\", \"ppapi_unittests\": \"9e085e19dd98c8e5bafb835eee0a2c21a3084bde\", \"printing_unittests\": \"eee576a591e606ab4289b395bd4acc1d45bed7bb\", \"remoting_unittests\": \"2f8afd12de50ba8ee2a85fbd1d56298bdac10a86\", \"sbox_integration_tests\": \"dbceea529608fd7babb570c35b15b1cbfb279d3c\", \"sbox_unittests\": \"b80b87758729672cffa9968eeb2c811496263cea\", \"sbox_validation_tests\": \"6769eb943f975f2910eab84bf63d18e826b46922\", \"service_manager_unittests\": \"58688b79351c7ce18a31a24001e943058bb3024c\", \"services_unittests\": \"58b4cf2925e8f382017fbae5e1efca856d4c47c2\", \"setup_unittests\": \"ee98d912049b14e4c10faeeed83c8e5ac002e3d6\", \"shell_dialogs_unittests\": \"4852fe8d3ec9a624a96886fa5315af26de3c6f97\", \"skia_unittests\": \"d9e0b36aeb1a6d5f1866db2fd0fa7a74e78343b0\", \"snapshot_unittests\": \"aede42d7886e4a68d22a7b87b1df12830a0892ca\", \"sql_unittests\": \"37c52cd19638482955dd59cf4266d5d6cdb033e9\", \"storage_unittests\": \"0146e511d251c857d764c7c1e40174b153d60f62\", \"sync_integration_tests\": \"e1a29f888ba1b6da9ab3806ed3a8d9a6827eeeac\", \"traffic_annotation_auditor_unittests\": \"50c79a81338d28720caf80b8586a632eca986d69\", \"ui_base_unittests\": \"11ab6921e839b6af12081e3ad6b4d29bad322f2b\", \"ui_touch_selection_unittests\": \"7558366ce1e6092bedc6b4dda978e3e67b910d7f\", \"unit_tests\": \"1e0a54e8f97b9152eb09c01f3956081cbe08cc27\", \"updater_tests\": \"669c88a636c69d015e497b5d5d858c1a88b71da3\", \"url_unittests\": \"aadab304eace47ad3864218fef55f8fe0ab21943\", \"views_unittests\": \"d2af875231b513476704fa792b85134b6beb6983\", \"viz_unittests\": \"338fe73e3ad94f5559b5c74e7d7ace5735aca8f0\", \"vr_common_unittests\": \"f91ca5a771f70ccd6c248262cb0898f318f6afe2\", \"vr_pixeltests\": \"0131b6bfad4eacd4134dc145c758849eec8c80df\", \"weblayer_browsertests\": \"70c02e8322a0c9cd3eed85aadecc6d5dfb6ada1b\", \"weblayer_unittests\": \"47bd4cfb1728921e3f309ce9b3b31a5cd218f1e7\", \"wm_unittests\": \"36d10797925183f3db1580c50677e42d283fcfc4\", \"wtf_unittests\": \"2438f96cc00457af545c22566ef630d96d03fa54\", \"zlib_unittests\": \"68dcde7ea2dc3f534e393188e9561c32ecd644c8\", \"zucchini_unittests\": \"944d862ac9b593887a7d63a508f6d5ea9e14c8e6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-cki8\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604302668179469",
"status": "COMPLETED",
"status_changed_ts": "1604305647785178",
"tags": [
"build_address:luci.chromium.ci/win-asan/15409",
"builder:win-asan",
"buildset:commit/git/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f2fabcd1994cd753a8fa2b6b11281d036c82413e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030190507939427328",
"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/8864760444922416656/+/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:4fa0b585c0819510",
"user_agent:luci-scheduler"
],
"updated_ts": "1604305647792435",
"url": "https://ci.chromium.org/b/8864760444922416656",
"utcnow_ts": "1604305649496197"
}
}
[08:27:29.588] Invocation finished in 49m47.057945066s with status SUCCEEDED