[14:18:44.675] New invocation is queued and will start shortly
[14:18:45.906] Starting the invocation (attempt 1)
[14:18:45.948] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:18:45.948] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:18:45.948] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025544831683644768",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e7ea1421b74698a2775ba0d353114c5618a7d953\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025544831683644768",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e7ea1421b74698a2775ba0d353114c5618a7d953",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7ea1421b74698a2775ba0d353114c5618a7d953",
"gitiles_ref:refs/heads/master"
]
}
[14:18:46.961] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608733126072273",
"id": "8860114769554607200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e7ea1421b74698a2775ba0d353114c5618a7d953\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608733126711038",
"tags": [
"build_address:luci.chromium.ci/win-asan/16409",
"builder:win-asan",
"buildset:commit/git/e7ea1421b74698a2775ba0d353114c5618a7d953",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7ea1421b74698a2775ba0d353114c5618a7d953",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025544831683644768",
"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/8860114769554607200/+/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": "1608733126711132",
"url": "https://ci.chromium.org/b/8860114769554607200",
"utcnow_ts": "1608733126953131"
}
}
[14:18:46.961] Task URL: https://ci.chromium.org/b/8860114769554607200
[14:18:46.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:2:0) after 1m0s
[14:18:54.924] Received PubSub notification, asking Buildbucket for the build status
[14:18:55.165] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:47.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:2:0)
[14:19:47.093] Timer tick, asking Buildbucket for the build status
[14:19:47.315] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:47.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:4:0) after 1m0s
[14:20:47.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:4:0)
[14:20:47.338] Timer tick, asking Buildbucket for the build status
[14:20:47.503] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:5:0) after 1m0s
[14:21:47.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:5:0)
[14:21:47.585] Timer tick, asking Buildbucket for the build status
[14:21:47.678] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:47.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:6:0) after 1m0s
[14:22:47.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:6:0)
[14:22:47.723] Timer tick, asking Buildbucket for the build status
[14:22:48.192] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:48.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:7:0) after 1m0s
[14:23:48.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:7:0)
[14:23:48.213] Timer tick, asking Buildbucket for the build status
[14:23:48.327] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:48.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:8:0) after 1m0s
[14:24:48.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:8:0)
[14:24:48.356] Timer tick, asking Buildbucket for the build status
[14:24:48.654] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:9:0) after 1m0s
[14:25:48.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:9:0)
[14:25:48.711] Timer tick, asking Buildbucket for the build status
[14:25:48.823] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:48.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:10:0) after 1m0s
[14:26:48.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:10:0)
[14:26:48.876] Timer tick, asking Buildbucket for the build status
[14:26:48.952] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:48.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:11:0) after 1m0s
[14:27:48.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:11:0)
[14:27:48.947] Timer tick, asking Buildbucket for the build status
[14:27:49.008] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:49.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:12:0) after 1m0s
[14:28:48.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:12:0)
[14:28:48.995] Timer tick, asking Buildbucket for the build status
[14:28:49.118] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:13:0) after 1m0s
[14:29:49.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:13:0)
[14:29:49.131] Timer tick, asking Buildbucket for the build status
[14:29:49.602] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:49.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:14:0) after 1m0s
[14:30:49.613] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:14:0)
[14:30:49.613] Timer tick, asking Buildbucket for the build status
[14:30:49.724] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:49.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:15:0) after 1m0s
[14:31:49.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:15:0)
[14:31:49.738] Timer tick, asking Buildbucket for the build status
[14:31:49.834] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:16:0) after 1m0s
[14:32:49.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:16:0)
[14:32:49.890] Timer tick, asking Buildbucket for the build status
[14:32:50.003] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:50.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:17:0) after 1m0s
[14:33:49.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:17:0)
[14:33:49.983] Timer tick, asking Buildbucket for the build status
[14:33:50.123] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:50.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:18:0) after 1m0s
[14:34:50.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:18:0)
[14:34:50.159] Timer tick, asking Buildbucket for the build status
[14:34:50.342] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:50.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:19:0) after 1m0s
[14:35:50.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:19:0)
[14:35:50.397] Timer tick, asking Buildbucket for the build status
[14:35:50.551] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:50.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:20:0) after 1m0s
[14:36:50.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:20:0)
[14:36:50.525] Timer tick, asking Buildbucket for the build status
[14:36:50.661] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:50.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:21:0) after 1m0s
[14:37:50.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:21:0)
[14:37:50.808] Timer tick, asking Buildbucket for the build status
[14:37:50.933] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:50.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:22:0) after 1m0s
[14:38:51.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:22:0)
[14:38:51.029] Timer tick, asking Buildbucket for the build status
[14:38:51.536] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:51.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:23:0) after 1m0s
[14:39:51.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:23:0)
[14:39:51.554] Timer tick, asking Buildbucket for the build status
[14:39:51.717] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:51.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:24:0) after 1m0s
[14:40:51.778] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:24:0)
[14:40:51.778] Timer tick, asking Buildbucket for the build status
[14:40:51.879] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:51.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:25:0) after 1m0s
[14:41:51.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:25:0)
[14:41:51.904] Timer tick, asking Buildbucket for the build status
[14:41:52.002] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:52.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:26:0) after 1m0s
[14:42:52.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:26:0)
[14:42:52.021] Timer tick, asking Buildbucket for the build status
[14:42:52.408] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:52.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:27:0) after 1m0s
[14:43:52.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:27:0)
[14:43:52.436] Timer tick, asking Buildbucket for the build status
[14:43:52.604] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:52.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:28:0) after 1m0s
[14:44:52.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:28:0)
[14:44:52.626] Timer tick, asking Buildbucket for the build status
[14:44:52.897] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:52.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:29:0) after 1m0s
[14:45:52.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:29:0)
[14:45:52.894] Timer tick, asking Buildbucket for the build status
[14:45:53.295] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:53.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:30:0) after 1m0s
[14:46:53.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:30:0)
[14:46:53.303] Timer tick, asking Buildbucket for the build status
[14:46:53.370] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:31:0) after 1m0s
[14:47:53.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:31:0)
[14:47:53.360] Timer tick, asking Buildbucket for the build status
[14:47:53.434] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:53.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:32:0) after 1m0s
[14:48:53.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:32:0)
[14:48:53.466] Timer tick, asking Buildbucket for the build status
[14:48:53.600] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:53.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:33:0) after 1m0s
[14:49:53.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:33:0)
[14:49:53.634] Timer tick, asking Buildbucket for the build status
[14:49:53.706] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:53.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:34:0) after 1m0s
[14:50:53.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:34:0)
[14:50:53.721] Timer tick, asking Buildbucket for the build status
[14:50:53.821] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:53.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:35:0) after 1m0s
[14:51:53.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:35:0)
[14:51:53.929] Timer tick, asking Buildbucket for the build status
[14:51:54.036] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:54.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:36:0) after 1m0s
[14:52:54.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:36:0)
[14:52:54.069] Timer tick, asking Buildbucket for the build status
[14:52:54.278] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:54.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:37:0) after 1m0s
[14:53:54.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:37:0)
[14:53:54.260] Timer tick, asking Buildbucket for the build status
[14:53:54.721] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:38:0) after 1m0s
[14:54:54.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:38:0)
[14:54:54.752] Timer tick, asking Buildbucket for the build status
[14:54:54.900] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:54.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:39:0) after 1m0s
[14:55:54.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:39:0)
[14:55:54.909] Timer tick, asking Buildbucket for the build status
[14:55:55.137] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:55.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:40:0) after 1m0s
[14:56:55.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:40:0)
[14:56:55.163] Timer tick, asking Buildbucket for the build status
[14:56:55.410] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:55.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:41:0) after 1m0s
[14:57:55.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:41:0)
[14:57:55.483] Timer tick, asking Buildbucket for the build status
[14:57:55.615] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:55.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:42:0) after 1m0s
[14:58:55.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:42:0)
[14:58:55.645] Timer tick, asking Buildbucket for the build status
[14:58:56.136] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:56.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:43:0) after 1m0s
[14:59:56.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:43:0)
[14:59:56.185] Timer tick, asking Buildbucket for the build status
[14:59:56.423] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:56.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:44:0) after 1m0s
[15:00:56.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:44:0)
[15:00:56.515] Timer tick, asking Buildbucket for the build status
[15:00:56.619] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:56.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:45:0) after 1m0s
[15:01:56.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:45:0)
[15:01:56.626] Timer tick, asking Buildbucket for the build status
[15:01:56.753] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:56.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:46:0) after 1m0s
[15:02:56.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:46:0)
[15:02:56.809] Timer tick, asking Buildbucket for the build status
[15:02:56.935] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:56.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:47:0) after 1m0s
[15:03:56.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:47:0)
[15:03:56.992] Timer tick, asking Buildbucket for the build status
[15:03:57.175] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:57.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:48:0) after 1m0s
[15:04:57.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:48:0)
[15:04:57.197] Timer tick, asking Buildbucket for the build status
[15:04:57.401] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:57.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:49:0) after 1m0s
[15:05:57.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:49:0)
[15:05:57.447] Timer tick, asking Buildbucket for the build status
[15:05:57.748] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:57.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:50:0) after 1m0s
[15:06:57.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:50:0)
[15:06:57.924] Timer tick, asking Buildbucket for the build status
[15:06:57.995] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:57.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:51:0) after 1m0s
[15:07:58.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:51:0)
[15:07:58.024] Timer tick, asking Buildbucket for the build status
[15:07:58.096] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:58.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:52:0) after 1m0s
[15:08:58.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:52:0)
[15:08:58.138] Timer tick, asking Buildbucket for the build status
[15:08:58.315] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:58.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:53:0) after 1m0s
[15:09:58.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:53:0)
[15:09:58.352] Timer tick, asking Buildbucket for the build status
[15:09:58.496] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:58.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:54:0) after 1m0s
[15:10:58.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:54:0)
[15:10:58.517] Timer tick, asking Buildbucket for the build status
[15:10:58.590] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:58.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:55:0) after 1m0s
[15:11:58.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:55:0)
[15:11:58.610] Timer tick, asking Buildbucket for the build status
[15:11:58.814] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:58.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:56:0) after 1m0s
[15:12:58.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:56:0)
[15:12:58.839] Timer tick, asking Buildbucket for the build status
[15:12:58.928] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:58.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:57:0) after 1m0s
[15:13:58.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:57:0)
[15:13:58.939] Timer tick, asking Buildbucket for the build status
[15:13:59.066] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:59.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:58:0) after 1m0s
[15:14:59.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:58:0)
[15:14:59.078] Timer tick, asking Buildbucket for the build status
[15:14:59.185] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:59.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:59:0) after 1m0s
[15:15:59.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:59:0)
[15:15:59.211] Timer tick, asking Buildbucket for the build status
[15:15:59.327] Build 8860114769554607200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025544831683644768:60:0) after 1m0s
[15:16:00.186] Received PubSub notification, asking Buildbucket for the build status
[15:16:00.302] Build 8860114769554607200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:16:00.302] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608736558333804",
"created_by": "project:chromium",
"created_ts": "1608733126072273",
"id": "8860114769554607200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e7ea1421b74698a2775ba0d353114c5618a7d953\"}}",
"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\": \"e7ea1421b74698a2775ba0d353114c5618a7d953\", \"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-gpyc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16409, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"d447829c19fd6275b94676aab20e303c224fe126\", \"got_dawn_revision\": \"33bf309c1d45e4da80ba77913eab9dadfc8f5e26\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"e7ea1421b74698a2775ba0d353114c5618a7d953\", \"got_revision_cp\": \"refs/heads/master@{#839105}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"711cf5ad4a12abe0f6b50058cb2248d7fb80374e\", \"got_v8_revision_cp\": \"refs/heads/8.9.187@{#1}\", \"got_webrtc_revision\": \"c463a784c340874c75032da7602ec1fde43f75ed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32874}\", \"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\": \"e7ea1421b74698a2775ba0d353114c5618a7d953\", \"swarm_hashes_refs/heads/master(at){#839105}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"9c25cf576cee4b5d6304917b3460cd841b85afa9\", \"angle_unittests\": \"571027a9beb72b2b4a56911580ec4a89ba604851\", \"app_shell_unittests\": \"4a604d6cfa2c27683e34662ff12ad68a79793781\", \"aura_unittests\": \"66e0fa61c402298ff9f9d9391cf3ad6b6be4177d\", \"base_unittests\": \"ff09bb7d5f2b63139b7ee1626375a378dd7e50f0\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"eb21fdbc2caef49497b3bdcfccae2bd0f82f4997\", \"blink_fuzzer_unittests\": \"61489c13afbaaa092caf6ee18de780d1e2b9dccb\", \"blink_heap_unittests\": \"d486f7e50ff533a3a779fe73ed91e09029b0a994\", \"blink_platform_unittests\": \"061b483e1fb240443bf0b9159481ebc34c62e416\", \"blink_unittests\": \"753a3803b836f8c3fa3c8e0f92bd84ee23b8b5e1\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"cf2f885805270c2f0fde2d71be61163b0b64f133\", \"capture_unittests\": \"6baf52caca9e23026e2c5e5251f5d7eda81f48b9\", \"cast_unittests\": \"a2aa57a1cb67e4d9f04bc1edd162f1cbda0f14c1\", \"cc_unittests\": \"4843d66f185324f440843406c22a5d278ecbf758\", \"chrome_app_unittests\": \"7960a59b37db8f801c94fe89e5d3cb1b3400a57a\", \"chrome_cleaner_unittests\": \"ef985271248808e928b9d5050c1cecafc6295542\", \"chrome_elf_unittests\": \"3ded23aba9f4bc4610cdfa25da23629320cbcd0d\", \"chromedriver_unittests\": \"1436f069dc9dac8e449e16cd3121904373df0bda\", \"components_browsertests\": \"03db732a44fa416c54e66452c6e0f5ea4d06eff2\", \"components_unittests\": \"a9ccfd731802e47c74c371e0789301531f90fd70\", \"compositor_unittests\": \"c876234675c59dac2162a099181e03e11d27468c\", \"content_browsertests\": \"f05eec435313f9371c840322d9261c05d7622e63\", \"content_unittests\": \"a48d7327a566eb8a9b1fb62166d2c58c6db026b4\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"7a9b09a8aa0c185fa6297f2c11aa679520451d21\", \"cronet_unittests\": \"32ac780691e63b92d2c3b6e10968b1c1237f25e5\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"bd5bedca8602626348abd6b48b1d66719b5ad74f\", \"device_unittests\": \"e24b10062dc061a21c0a6a6b23d9debf64f6bca9\", \"display_unittests\": \"0d5e3123755d93fd59b42b3011a243f5a5b9dbbc\", \"elevation_service_unittests\": \"4e73c5b56312141734ea0e9b14548cccf6a6592f\", \"events_unittests\": \"d62bd5e9f38333e493d0a4c6410ef141c59c2b96\", \"extensions_browsertests\": \"a62684fd6aea83f020201f05c0cbb7787e9469ed\", \"extensions_unittests\": \"ca9c7bf4e36bf7c102b1ddacfb3a3f3a80b4cd63\", \"filesystem_service_unittests\": \"d092594ef413e064bdeff37e62044f5b2a101bd6\", \"gcm_unit_tests\": \"254496cf3db352ff3bc68859a34c5637d34d3a49\", \"gcp_unittests\": \"a12d58b8a082cae72473850645b09e11530c8c32\", \"gfx_unittests\": \"e858888990f8ec196b244320534b41269673db8e\", \"gin_unittests\": \"be87c5dc4264fc574b938f678825984e75e90b79\", \"google_apis_unittests\": \"c2fb0a97fb338ae8fb65adc2fe40b6f3ae43b28a\", \"gpu_unittests\": \"e343ad00e4d9d3067bd5bc7dd4b21b1c0c2aa8c4\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"55e16be3edf491e2631f5da7cda85de2c0d76f9a\", \"headless_unittests\": \"6c00d47233379dcc1850778933410911337fc5d3\", \"install_static_unittests\": \"280548038f19c95a74f1ed98de8a493fa3a63f01\", \"installer_util_unittests\": \"5855c5b10f46ff63318f157fc8b17ab60e6f6da2\", \"interactive_ui_tests\": \"f92db613db607197a04d6f9c7bccba9daf5f3a16\", \"ipc_tests\": \"4a04e979b7bf4609cd781bac2f50263972d457d8\", \"jingle_unittests\": \"0f727a8e66d9bacf7747bb6206f4851c0966a9da\", \"latency_unittests\": \"8151a18aa9bfa476451f7310237886623c992928\", \"libjingle_xmpp_unittests\": \"ccd9bf5de47731a4925b3f48fc0e0084f636b7e0\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"471d9d6bc08c6ccfc833f9799febda4834c97161\", \"media_unittests\": \"741b7528ece72bdcd9163ac956afa73a192d6d75\", \"message_center_unittests\": \"2b22d186b3f507251865e0eab288f95283af966e\", \"midi_unittests\": \"806b4f6b481d690ba397eefc8299e920aabff9e4\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"48b2fdae4040884d57fb569ec4fda1e1415e56c0\", \"nacl_loader_unittests\": \"3377aecbc57f3dfd4398a5326074e47c8641e075\", \"native_theme_unittests\": \"61fea70574a0ede955a363d0bd61b42736c76ea1\", \"net_unittests\": \"86dfa37e0c269a2f40a2635cd2f79ec3abec6c52\", \"notification_helper_unittests\": \"499f04be8fce92c67d44656d1037e19018545bfe\", \"pdf_unittests\": \"523c2c26dea2b32b93f30ad88e48b0a79e7622f4\", \"perfetto_unittests\": \"67327832b9d178166a745f7c4905751ae5d4144e\", \"ppapi_unittests\": \"528b450ea675e89670cef3ceae84ec4856db5712\", \"printing_unittests\": \"635a60d3faf6915d3d1adc736c9ed0663b584f7d\", \"remoting_unittests\": \"9cc0ee6c35e4d8b1efd17b135c2c0fc53eed9580\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"c651b5ecd123f81227d5def5b0c5fd6cfcd9adf5\", \"services_unittests\": \"95a0c4d15a9d29513188cdcbd2cca06d52707cbf\", \"setup_unittests\": \"99c426eedca8600fc10b14eaf2d308616d6c89ef\", \"shell_dialogs_unittests\": \"72cf6c1e86fb36fc141b52c0c1e41150838d8011\", \"skia_unittests\": \"18ead11d3706944cc2326e691efcf502a97a4dd1\", \"snapshot_unittests\": \"5fdba06de5e313b5c25e8ae2fd52bc0c60f1bab2\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"a91a312b9a5dad147f1b49d36efd726ad2d83601\", \"sync_integration_tests\": \"46d842f2449e286656aa4024b705e22b5e914a8c\", \"traffic_annotation_auditor_unittests\": \"e02b203d0be6c4c522aee20986a6984fe4ac0337\", \"ui_base_unittests\": \"d443564944c0df95efa46cb609a23eca30d61146\", \"ui_touch_selection_unittests\": \"fad905adc771ae651bed83d07cdd7acff764d62e\", \"unit_tests\": \"634d33e6bbd674650c767dd7476384e86e4cd978\", \"updater_tests\": \"b013931815c76665b120f93a2c60f5ae2edbaf74\", \"url_unittests\": \"84cdd9e2933f621b7eb029d145ce4c3acd541a47\", \"views_unittests\": \"4b8644dd63c75f01f24361f588c1178d4d61ceea\", \"viz_unittests\": \"9451d6a714264f6a51f427d9077726ba310561a5\", \"vr_common_unittests\": \"563c87c9a1a6bf00bdf11110ad436b01785849fc\", \"vr_pixeltests\": \"4ae87472419d8b45609678d7bc6197248ff6964a\", \"weblayer_browsertests\": \"fdfd7f44a7e87dbde0dc243506ef5bd8ea28261b\", \"weblayer_unittests\": \"4f41e5644f08b9590cb52a4fd8f08077264448ff\", \"wm_unittests\": \"524f1039dc57a8ee38717c5eec4dcbe51c9f101d\", \"wtf_unittests\": \"9fcfc07bf261dbfd4c00be248dd40f6264a10ebe\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"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-6-gpyc\"], \"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\": [\"5657-0417a3f\"], \"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": "1608733134126424",
"status": "COMPLETED",
"status_changed_ts": "1608736558732539",
"tags": [
"build_address:luci.chromium.ci/win-asan/16409",
"builder:win-asan",
"buildset:commit/git/e7ea1421b74698a2775ba0d353114c5618a7d953",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e7ea1421b74698a2775ba0d353114c5618a7d953",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025544831683644768",
"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/8860114769554607200/+/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:50a8c907092f4110",
"user_agent:luci-scheduler"
],
"updated_ts": "1608736558789181",
"url": "https://ci.chromium.org/b/8860114769554607200",
"utcnow_ts": "1608736560294170"
}
}
[15:16:00.302] Invocation finished in 57m15.644374952s with status SUCCEEDED