[09:17:25.061] New invocation is queued and will start shortly
[09:17:26.135] Starting the invocation (attempt 1)
[09:17:26.168] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:17:26.168] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:17:26.168] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024748416832549792",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d598cd9212ce7df81218a9435b6aeef8c82822b0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024748416832549792",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"gitiles_ref:refs/heads/master"
]
}
[09:17:27.608] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609492646287971",
"id": "8859318354885312944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d598cd9212ce7df81218a9435b6aeef8c82822b0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609492647439460",
"tags": [
"build_address:luci.chromium.ci/win-asan/16571",
"builder:win-asan",
"buildset:commit/git/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024748416832549792",
"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/8859318354885312944/+/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": "1609492647440455",
"url": "https://ci.chromium.org/b/8859318354885312944",
"utcnow_ts": "1609492647588549"
}
}
[09:17:27.608] Task URL: https://ci.chromium.org/b/8859318354885312944
[09:17:27.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:2:0) after 1m0s
[09:17:42.915] Received PubSub notification, asking Buildbucket for the build status
[09:17:43.124] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:27.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:2:0)
[09:18:27.850] Timer tick, asking Buildbucket for the build status
[09:18:28.031] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:28.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:4:0) after 1m0s
[09:19:28.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:4:0)
[09:19:28.229] Timer tick, asking Buildbucket for the build status
[09:19:28.531] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:28.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:5:0) after 1m0s
[09:20:28.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:5:0)
[09:20:28.689] Timer tick, asking Buildbucket for the build status
[09:20:28.774] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:28.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:6:0) after 1m0s
[09:21:28.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:6:0)
[09:21:28.860] Timer tick, asking Buildbucket for the build status
[09:21:28.981] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:28.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:7:0) after 1m0s
[09:22:29.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:7:0)
[09:22:29.037] Timer tick, asking Buildbucket for the build status
[09:22:29.388] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:29.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:8:0) after 1m0s
[09:23:29.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:8:0)
[09:23:29.414] Timer tick, asking Buildbucket for the build status
[09:23:29.481] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:29.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:9:0) after 1m0s
[09:24:29.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:9:0)
[09:24:29.546] Timer tick, asking Buildbucket for the build status
[09:24:29.737] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:29.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:10:0) after 1m0s
[09:25:29.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:10:0)
[09:25:29.725] Timer tick, asking Buildbucket for the build status
[09:25:29.787] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:29.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:11:0) after 1m0s
[09:26:29.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:11:0)
[09:26:29.866] Timer tick, asking Buildbucket for the build status
[09:26:29.989] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:29.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:12:0) after 1m0s
[09:27:30.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:12:0)
[09:27:30.059] Timer tick, asking Buildbucket for the build status
[09:27:30.484] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:30.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:13:0) after 1m0s
[09:28:30.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:13:0)
[09:28:30.697] Timer tick, asking Buildbucket for the build status
[09:28:30.757] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:30.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:14:0) after 1m0s
[09:29:30.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:14:0)
[09:29:30.800] Timer tick, asking Buildbucket for the build status
[09:29:31.201] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:31.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:15:0) after 1m0s
[09:30:31.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:15:0)
[09:30:31.202] Timer tick, asking Buildbucket for the build status
[09:30:31.250] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:31.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:16:0) after 1m0s
[09:31:31.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:16:0)
[09:31:31.278] Timer tick, asking Buildbucket for the build status
[09:31:31.400] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:31.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:17:0) after 1m0s
[09:32:31.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:17:0)
[09:32:31.431] Timer tick, asking Buildbucket for the build status
[09:32:31.529] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:31.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:18:0) after 1m0s
[09:33:31.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:18:0)
[09:33:31.574] Timer tick, asking Buildbucket for the build status
[09:33:31.714] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:31.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:19:0) after 1m0s
[09:34:31.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:19:0)
[09:34:31.744] Timer tick, asking Buildbucket for the build status
[09:34:31.965] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:31.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:20:0) after 1m0s
[09:35:32.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:20:0)
[09:35:32.000] Timer tick, asking Buildbucket for the build status
[09:35:32.462] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:32.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:21:0) after 1m0s
[09:36:32.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:21:0)
[09:36:32.456] Timer tick, asking Buildbucket for the build status
[09:36:32.614] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:32.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:22:0) after 1m0s
[09:37:32.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:22:0)
[09:37:32.635] Timer tick, asking Buildbucket for the build status
[09:37:33.004] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:33.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:23:0) after 1m0s
[09:38:33.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:23:0)
[09:38:33.055] Timer tick, asking Buildbucket for the build status
[09:38:33.153] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:24:0) after 1m0s
[09:39:33.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:24:0)
[09:39:33.174] Timer tick, asking Buildbucket for the build status
[09:39:33.266] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:33.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:25:0) after 1m0s
[09:40:33.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:25:0)
[09:40:33.288] Timer tick, asking Buildbucket for the build status
[09:40:33.994] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:26:0) after 1m0s
[09:41:34.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:26:0)
[09:41:34.052] Timer tick, asking Buildbucket for the build status
[09:41:34.203] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:34.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:27:0) after 1m0s
[09:42:34.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:27:0)
[09:42:34.210] Timer tick, asking Buildbucket for the build status
[09:42:34.323] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:28:0) after 1m0s
[09:43:34.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:28:0)
[09:43:34.342] Timer tick, asking Buildbucket for the build status
[09:43:34.703] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:34.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:29:0) after 1m0s
[09:44:34.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:29:0)
[09:44:34.830] Timer tick, asking Buildbucket for the build status
[09:44:35.182] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:35.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:30:0) after 1m0s
[09:45:35.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:30:0)
[09:45:35.174] Timer tick, asking Buildbucket for the build status
[09:45:35.320] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:35.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:31:0) after 1m0s
[09:46:35.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:31:0)
[09:46:35.395] Timer tick, asking Buildbucket for the build status
[09:46:35.490] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:35.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:32:0) after 1m0s
[09:47:35.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:32:0)
[09:47:35.530] Timer tick, asking Buildbucket for the build status
[09:47:35.869] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:35.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:33:0) after 1m0s
[09:48:35.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:33:0)
[09:48:35.944] Timer tick, asking Buildbucket for the build status
[09:48:36.069] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:36.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:34:0) after 1m0s
[09:49:36.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:34:0)
[09:49:36.136] Timer tick, asking Buildbucket for the build status
[09:49:36.803] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:36.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:35:0) after 1m0s
[09:50:36.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:35:0)
[09:50:36.903] Timer tick, asking Buildbucket for the build status
[09:50:36.976] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:36.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:36:0) after 1m0s
[09:51:37.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:36:0)
[09:51:37.019] Timer tick, asking Buildbucket for the build status
[09:51:37.318] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:37.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:37:0) after 1m0s
[09:52:37.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:37:0)
[09:52:37.392] Timer tick, asking Buildbucket for the build status
[09:52:37.511] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:37.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:38:0) after 1m0s
[09:53:37.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:38:0)
[09:53:37.588] Timer tick, asking Buildbucket for the build status
[09:53:37.723] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:37.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:39:0) after 1m0s
[09:54:37.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:39:0)
[09:54:37.743] Timer tick, asking Buildbucket for the build status
[09:54:37.876] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:37.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:40:0) after 1m0s
[09:55:37.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:40:0)
[09:55:37.951] Timer tick, asking Buildbucket for the build status
[09:55:38.187] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:38.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:41:0) after 1m0s
[09:56:38.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:41:0)
[09:56:38.225] Timer tick, asking Buildbucket for the build status
[09:56:38.355] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:38.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:42:0) after 1m0s
[09:57:38.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:42:0)
[09:57:38.398] Timer tick, asking Buildbucket for the build status
[09:57:38.494] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:38.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:43:0) after 1m0s
[09:58:38.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:43:0)
[09:58:38.515] Timer tick, asking Buildbucket for the build status
[09:58:38.699] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:38.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:44:0) after 1m0s
[09:59:38.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:44:0)
[09:59:38.717] Timer tick, asking Buildbucket for the build status
[09:59:38.825] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:38.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:45:0) after 1m0s
[10:00:38.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:45:0)
[10:00:38.871] Timer tick, asking Buildbucket for the build status
[10:00:39.661] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:39.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:46:0) after 1m0s
[10:01:39.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:46:0)
[10:01:39.823] Timer tick, asking Buildbucket for the build status
[10:01:39.948] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:39.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:47:0) after 1m0s
[10:02:40.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:47:0)
[10:02:40.035] Timer tick, asking Buildbucket for the build status
[10:02:40.137] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:40.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:48:0) after 1m0s
[10:03:40.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:48:0)
[10:03:40.312] Timer tick, asking Buildbucket for the build status
[10:03:40.415] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:40.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:49:0) after 1m0s
[10:04:40.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:49:0)
[10:04:40.449] Timer tick, asking Buildbucket for the build status
[10:04:40.632] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:40.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:50:0) after 1m0s
[10:05:40.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:50:0)
[10:05:40.759] Timer tick, asking Buildbucket for the build status
[10:05:40.965] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:40.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:51:0) after 1m0s
[10:06:40.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:51:0)
[10:06:40.942] Timer tick, asking Buildbucket for the build status
[10:06:41.043] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:41.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:52:0) after 1m0s
[10:07:41.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:52:0)
[10:07:41.051] Timer tick, asking Buildbucket for the build status
[10:07:41.154] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:41.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:53:0) after 1m0s
[10:08:41.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:53:0)
[10:08:41.230] Timer tick, asking Buildbucket for the build status
[10:08:41.297] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:41.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:54:0) after 1m0s
[10:09:41.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:54:0)
[10:09:41.356] Timer tick, asking Buildbucket for the build status
[10:09:41.493] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:41.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:55:0) after 1m0s
[10:10:41.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:55:0)
[10:10:41.501] Timer tick, asking Buildbucket for the build status
[10:10:41.570] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:41.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:56:0) after 1m0s
[10:11:41.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:56:0)
[10:11:41.561] Timer tick, asking Buildbucket for the build status
[10:11:42.134] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:42.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:57:0) after 1m0s
[10:12:42.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:57:0)
[10:12:42.223] Timer tick, asking Buildbucket for the build status
[10:12:42.342] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:42.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:58:0) after 1m0s
[10:13:42.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:58:0)
[10:13:42.331] Timer tick, asking Buildbucket for the build status
[10:13:42.394] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:42.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:59:0) after 1m0s
[10:14:42.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:59:0)
[10:14:42.475] Timer tick, asking Buildbucket for the build status
[10:14:42.611] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:42.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:60:0) after 1m0s
[10:15:42.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:60:0)
[10:15:42.615] Timer tick, asking Buildbucket for the build status
[10:15:42.891] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:42.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:61:0) after 1m0s
[10:16:42.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:61:0)
[10:16:42.876] Timer tick, asking Buildbucket for the build status
[10:16:42.939] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:62:0) after 1m0s
[10:17:42.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:62:0)
[10:17:42.961] Timer tick, asking Buildbucket for the build status
[10:17:43.073] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:43.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:63:0) after 1m0s
[10:18:43.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:63:0)
[10:18:43.094] Timer tick, asking Buildbucket for the build status
[10:18:43.187] Build 8859318354885312944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:43.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024748416832549792:64:0) after 1m0s
[10:19:29.664] Received PubSub notification, asking Buildbucket for the build status
[10:19:29.747] Build 8859318354885312944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:19:29.747] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609496328732942",
"created_by": "project:chromium",
"created_ts": "1609492646287971",
"id": "8859318354885312944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d598cd9212ce7df81218a9435b6aeef8c82822b0\"}}",
"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\": \"d598cd9212ce7df81218a9435b6aeef8c82822b0\", \"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-1-9pgs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16571, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"2cbcb18e95e6820e1266fa17f421efe86f1bcc52\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d598cd9212ce7df81218a9435b6aeef8c82822b0\", \"got_revision_cp\": \"refs/heads/master@{#839889}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a3f2933bb6d06bd7473ccbed77714874e6bf63b3\", \"got_v8_revision_cp\": \"refs/heads/8.9.201@{#1}\", \"got_webrtc_revision\": \"6215ba804eb500f3e28b39088c73af3c4f4cd10a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32897}\", \"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\": \"d598cd9212ce7df81218a9435b6aeef8c82822b0\", \"swarm_hashes_refs/heads/master(at){#839889}_without_patch\": {\"absl_hardening_tests\": \"4b5c3ca1221575578a87a70377477b7181dac560\", \"accessibility_unittests\": \"55b8eef447e4e1e1bfa97cdc6273104a66ea669e\", \"angle_unittests\": \"1650a0574320d3c94e4893279072710ff6c4406e\", \"app_shell_unittests\": \"5fd2f39a6cfed09318ffdbb89947dac1306f38a9\", \"aura_unittests\": \"8964da53aea069de4823aa6f83879d0a2a724b80\", \"base_unittests\": \"f389b31b4fa77b28bd2557986be1757977c1f6de\", \"base_util_unittests\": \"30cd4e78714aae2b8d42d7f2b477ad3f4bc4923b\", \"blink_common_unittests\": \"cbb43f41ff3517f9a02e03c82eacbb2a23b94b31\", \"blink_fuzzer_unittests\": \"d7a0e8c2128784dd8e81ad4aeff5a38de6a4bbb5\", \"blink_heap_unittests\": \"4e9e0579ebf1e7fca3390fbb85558959ae22e9c8\", \"blink_platform_unittests\": \"2fa3ac6c173bca1cb8b3756e62f63538c93e3ce4\", \"blink_unittests\": \"9d9b65bc69745aeee565b885b3f53ea7bd3f60e0\", \"boringssl_crypto_tests\": \"e8272ba7e9b69b4bf0a35039ee8b72950ca04c0e\", \"boringssl_ssl_tests\": \"bc8e5da089e5c401dd7e977ec3165a3abc98e124\", \"browser_switcher_bho_unittests\": \"3b0b8468d116f1ccb582cb9131e89d6fdb3b444c\", \"browser_tests\": \"577c47d9dafbfa144559fdc0eaa026ef9e9ec585\", \"capture_unittests\": \"bd4145d085f8ff09ba6b52b3ad04dd8685448b94\", \"cast_unittests\": \"3ecfa906ad64c58d516d3689ff21f0d3c3a0f680\", \"cc_unittests\": \"ddc594af52985e17d39c13082c0dbe8b2e14d10e\", \"chrome_app_unittests\": \"306aa0a01f33f5b035451f1c3e9f253e69faa5a0\", \"chrome_cleaner_unittests\": \"835107da6c2c935039925b54c294af64ffa196c7\", \"chrome_elf_unittests\": \"501fde9eb2860eae3c4cdecd5ab7bab28df3e58e\", \"chromedriver_unittests\": \"4ad037b1c9a429d129ac15afa0126a625a2af0c2\", \"components_browsertests\": \"8f9864edae772de3be7617c3c4b1b373f90f7555\", \"components_unittests\": \"cf8370afb05be3f02011033574aa626a2f5d54ed\", \"compositor_unittests\": \"a1f8e82ca3829f62f145ea694f799c639589a19e\", \"content_browsertests\": \"98d1afd573287f4cdfdcc6d8a69d31c3180ce445\", \"content_unittests\": \"2617706ece959fd306d8f93fcfc4f0d859d2c160\", \"courgette_unittests\": \"8291c07967c4855e7d366ef0c4dab1329dc2c358\", \"crashpad_tests\": \"2fc96d89198874c1095261057fb2b07a456bdaf1\", \"cronet_tests\": \"869385412ebe58403fe419507b1dbb8833fbf267\", \"cronet_unittests\": \"a25cb3656bc859c9e57091ab86ca7ecbbd042d01\", \"crypto_unittests\": \"5f95f1c4e3d78558a42991b0bafdcab70c1d0a8e\", \"delayloads_unittests\": \"a1a8311b7d9a725d5df1406c19eae5cfd34a67e1\", \"device_unittests\": \"9477cdb471490aeae3bca385c96ed7d2885947d9\", \"display_unittests\": \"068bf8b4f6231220f17e2a05551b99f830e4e084\", \"elevation_service_unittests\": \"a743967e4a69054a6211954b622c8ed010974137\", \"events_unittests\": \"dcb10c704801724ba7412d3738d349b78a61d8bc\", \"extensions_browsertests\": \"b7f692c71cb60d061aac6cfda6bf8aa3cd88292f\", \"extensions_unittests\": \"df6168882069618eb78fa830c62823775ac590c5\", \"filesystem_service_unittests\": \"526e7640405984d57e8e98483603a160f179f2fc\", \"gcm_unit_tests\": \"3c28677560db55a6200a0c9456487a9188d79727\", \"gcp_unittests\": \"228e7c05c7907ea42b5018ec7bea856bbd52f8be\", \"gfx_unittests\": \"55d72e000cf6b2064f7044b430804d20c8e1d809\", \"gin_unittests\": \"12e85f845677340c24dde2a5d325c2ca0a37845d\", \"google_apis_unittests\": \"d40c88cf574cfd98a21ee6e604828d46469f7659\", \"gpu_unittests\": \"6c2747bc2bab9a0ba0637a88dbfb39a3dd4bcf7b\", \"gwp_asan_unittests\": \"70494ee86946b11b5428dcae620c3ff511dc5cf7\", \"headless_browsertests\": \"7d1dd13fe0c84fd799558ebf153ad039e43afd7e\", \"headless_unittests\": \"824c587534670b97f3ec2f5eba54aee8600e8846\", \"install_static_unittests\": \"f00a5d5403820fe29fae32b1f6e985bbdff4a10f\", \"installer_util_unittests\": \"0928d5a9df4c34b8cd393286a510e50d6484d4e2\", \"interactive_ui_tests\": \"9334818bd780b53a0044f08b23d6ea0d29821b0b\", \"ipc_tests\": \"d3d9b577d2992349455aa2ca0ef760b0116b7285\", \"jingle_unittests\": \"70e70db8a79fafe1e22ddc26720697065b450e16\", \"latency_unittests\": \"5bee15533fe6ed948b4a43dc3802cee1a47be377\", \"libjingle_xmpp_unittests\": \"764102ab86a5511a0ed7af932cd70633c9f1298d\", \"liburlpattern_unittests\": \"05e42b7bd00e8b3aedd47087663fcb4ddc35ad3b\", \"media_blink_unittests\": \"89bd82bb949b8f0b1e9c1fda3b926c7a696bcb83\", \"media_unittests\": \"87eb5db9a37ed5e9ac1a5d300355da086da85d8a\", \"message_center_unittests\": \"8f0eafc795b8ed77083e6cc726f1ade3562594cb\", \"midi_unittests\": \"f8f3d17fe9d48366f503ffeee50063beb90eec9d\", \"mojo_core_unittests\": \"e1ac989b5f5bcc278b16a4c87c8292504311ceab\", \"mojo_unittests\": \"11853d1e40d79380396c0b1d7cd18ccd9f018cc5\", \"nacl_loader_unittests\": \"ac09002fecbdda0ca5001f6c0bb2c108a6d122b0\", \"native_theme_unittests\": \"6655c92506564afff0e8c4a867e1351dd17af7cf\", \"net_unittests\": \"6175b2f79e34204658c42c9df23254fede5ba4cb\", \"notification_helper_unittests\": \"230cdf37e888641b394bbace0e7c1603a2f5ada5\", \"pdf_unittests\": \"70660c55a1a5419a092620890553c261c9aabf03\", \"perfetto_unittests\": \"b903917a353625c02407765030c826cffb2a72e2\", \"ppapi_unittests\": \"4f34d246c7acfad2b9fde28567f593a986bfa2de\", \"printing_unittests\": \"aa57c1057327b708909b11f14c3d79aaa7c76493\", \"remoting_unittests\": \"b66d2544b670440994e6fa457b3cc0bab9995b7a\", \"sbox_integration_tests\": \"27bc4514b56c6c16af16296ac5daa1ca08d8f63a\", \"sbox_unittests\": \"90b9fe4846a75eee70608081ef25bfba13c29416\", \"sbox_validation_tests\": \"3cc333cb24d22c229df887cb736e6aed6a23fbef\", \"service_manager_unittests\": \"e1a6e564c58e1edbc2ced5f4a6601bf1a884b002\", \"services_unittests\": \"4bcb0d15ddd1ad07d7091042f58be752090fec88\", \"setup_unittests\": \"d45dd19f9097b4f0324b17f7bbde01ac3384bc86\", \"shell_dialogs_unittests\": \"26cc47c32b6c7cee72139ec37104cdde02d85509\", \"skia_unittests\": \"25dbccb70ddf779068494596f7900ae216caa6fa\", \"snapshot_unittests\": \"3928b33c1c4f9136b9cce19fbcf368eab4066bf8\", \"sql_unittests\": \"e58c761f7c2e18a41887a089151f58e640a70ea0\", \"storage_unittests\": \"125904228057224141770d6ff63901c5b0469373\", \"sync_integration_tests\": \"301070a19f2967df91a5ac39b780a7fcfbec62fe\", \"traffic_annotation_auditor_unittests\": \"d344eeaf1af69394405d10245ee47a34134916a8\", \"ui_base_unittests\": \"8f82da303b702df676276f8abf732ba517a0ca13\", \"ui_touch_selection_unittests\": \"e8e7526a2c0b0a0c10668383987803c044ffd64f\", \"unit_tests\": \"fa4252080cf3c8eee65690d383ea03c5ee2980b4\", \"updater_tests\": \"4d5528a3c836553c60ecc549867a12231051c59b\", \"url_unittests\": \"0b04704ac98c2bb2f9b738054da078b7501bcbdb\", \"views_unittests\": \"80e9927a82a91df30c4421fc75eff977b3897a08\", \"viz_unittests\": \"e8f5012b9b1efc6b962f9c671d033163bd239970\", \"vr_common_unittests\": \"5910e5701674d0362c2ee0ab6493b87775036440\", \"vr_pixeltests\": \"b75800ad33a58e6d06a6cc469183f67e566ed237\", \"weblayer_browsertests\": \"b45fdb1805c03d40a319167b6c3a675f600857a4\", \"weblayer_unittests\": \"79a15d10afe157afa230981301aae68d94811bc9\", \"wm_unittests\": \"897b5b52b2d6b4104f465e909a45d23cbb36e452\", \"wtf_unittests\": \"700a9e4a80d9a027b0e4054ca84fb9151d0411ea\", \"zlib_unittests\": \"dbd6ebb7321f8e3b9fb5bed64bd1af9b79c91268\", \"zucchini_unittests\": \"8c5e18b623a78e7916c544bde56c95541d04fc2b\"}}, \"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-1-9pgs\"], \"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": "1609492649303361",
"status": "COMPLETED",
"status_changed_ts": "1609496329117253",
"tags": [
"build_address:luci.chromium.ci/win-asan/16571",
"builder:win-asan",
"buildset:commit/git/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d598cd9212ce7df81218a9435b6aeef8c82822b0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024748416832549792",
"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/8859318354885312944/+/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:50d60e5707c19d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609496329123612",
"url": "https://ci.chromium.org/b/8859318354885312944",
"utcnow_ts": "1609496369738497"
}
}
[10:19:29.747] Invocation finished in 1h2m4.701595702s with status SUCCEEDED