[04:39:47.149] New invocation is queued and will start shortly
[04:39:48.348] Starting the invocation (attempt 1)
[04:39:48.384] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:39:48.384] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:39:48.384] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023406929426011024",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a2547f04000483721085400ec34d7a155c7a18e6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023406929426011024",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/a2547f04000483721085400ec34d7a155c7a18e6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2547f04000483721085400ec34d7a155c7a18e6",
"gitiles_ref:refs/heads/master"
]
}
[04:39:51.302] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610771988590969",
"id": "8857976867250288304",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2547f04000483721085400ec34d7a155c7a18e6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610771990976740",
"tags": [
"build_address:luci.chromium.ci/win-asan/16851",
"builder:win-asan",
"buildset:commit/git/a2547f04000483721085400ec34d7a155c7a18e6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2547f04000483721085400ec34d7a155c7a18e6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023406929426011024",
"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/8857976867250288304/+/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": "1610771990976860",
"url": "https://ci.chromium.org/b/8857976867250288304",
"utcnow_ts": "1610771991289311"
}
}
[04:39:51.302] Task URL: https://ci.chromium.org/b/8857976867250288304
[04:39:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:2:0) after 1m0s
[04:39:58.175] Received PubSub notification, asking Buildbucket for the build status
[04:39:58.244] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:51.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:2:0)
[04:40:51.434] Timer tick, asking Buildbucket for the build status
[04:40:51.640] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:4:0) after 1m0s
[04:41:51.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:4:0)
[04:41:51.648] Timer tick, asking Buildbucket for the build status
[04:41:51.788] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:51.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:5:0) after 1m0s
[04:42:51.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:5:0)
[04:42:51.814] Timer tick, asking Buildbucket for the build status
[04:42:52.133] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:52.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:6:0) after 1m0s
[04:43:52.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:6:0)
[04:43:52.153] Timer tick, asking Buildbucket for the build status
[04:43:52.279] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:52.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:7:0) after 1m0s
[04:44:52.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:7:0)
[04:44:52.339] Timer tick, asking Buildbucket for the build status
[04:44:52.551] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:8:0) after 1m0s
[04:45:52.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:8:0)
[04:45:52.641] Timer tick, asking Buildbucket for the build status
[04:45:52.741] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:52.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:9:0) after 1m0s
[04:46:52.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:9:0)
[04:46:52.768] Timer tick, asking Buildbucket for the build status
[04:46:52.899] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:52.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:10:0) after 1m0s
[04:47:53.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:10:0)
[04:47:53.004] Timer tick, asking Buildbucket for the build status
[04:47:53.066] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:53.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:11:0) after 1m0s
[04:48:53.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:11:0)
[04:48:53.221] Timer tick, asking Buildbucket for the build status
[04:48:53.401] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:53.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:12:0) after 1m0s
[04:49:53.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:12:0)
[04:49:53.529] Timer tick, asking Buildbucket for the build status
[04:49:54.005] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:54.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:13:0) after 1m0s
[04:50:54.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:13:0)
[04:50:54.015] Timer tick, asking Buildbucket for the build status
[04:50:54.619] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:54.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:14:0) after 1m0s
[04:51:54.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:14:0)
[04:51:54.645] Timer tick, asking Buildbucket for the build status
[04:51:54.704] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:54.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:15:0) after 1m0s
[04:52:54.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:15:0)
[04:52:54.764] Timer tick, asking Buildbucket for the build status
[04:52:54.824] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:54.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:16:0) after 1m0s
[04:53:54.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:16:0)
[04:53:54.961] Timer tick, asking Buildbucket for the build status
[04:53:55.017] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:55.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:17:0) after 1m0s
[04:54:55.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:17:0)
[04:54:55.173] Timer tick, asking Buildbucket for the build status
[04:54:55.286] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:55.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:18:0) after 1m0s
[04:55:55.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:18:0)
[04:55:55.431] Timer tick, asking Buildbucket for the build status
[04:55:55.959] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:55.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:19:0) after 1m0s
[04:56:56.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:19:0)
[04:56:56.031] Timer tick, asking Buildbucket for the build status
[04:56:56.145] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:20:0) after 1m0s
[04:57:56.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:20:0)
[04:57:56.283] Timer tick, asking Buildbucket for the build status
[04:57:57.205] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:57.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:21:0) after 1m0s
[04:58:57.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:21:0)
[04:58:57.224] Timer tick, asking Buildbucket for the build status
[04:58:57.620] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:57.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:22:0) after 1m0s
[04:59:57.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:22:0)
[04:59:57.716] Timer tick, asking Buildbucket for the build status
[04:59:57.975] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:57.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:23:0) after 1m0s
[05:00:58.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:23:0)
[05:00:58.064] Timer tick, asking Buildbucket for the build status
[05:00:58.428] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:58.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:24:0) after 1m0s
[05:01:58.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:24:0)
[05:01:58.504] Timer tick, asking Buildbucket for the build status
[05:01:58.637] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:58.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:25:0) after 1m0s
[05:02:58.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:25:0)
[05:02:58.727] Timer tick, asking Buildbucket for the build status
[05:02:58.857] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:58.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:26:0) after 1m0s
[05:03:58.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:26:0)
[05:03:58.896] Timer tick, asking Buildbucket for the build status
[05:03:59.008] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:59.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:27:0) after 1m0s
[05:04:59.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:27:0)
[05:04:59.042] Timer tick, asking Buildbucket for the build status
[05:04:59.157] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:59.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:28:0) after 1m0s
[05:05:59.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:28:0)
[05:05:59.239] Timer tick, asking Buildbucket for the build status
[05:05:59.512] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:59.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:29:0) after 1m0s
[05:06:59.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:29:0)
[05:06:59.654] Timer tick, asking Buildbucket for the build status
[05:07:00.162] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:00.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:30:0) after 1m0s
[05:08:00.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:30:0)
[05:08:00.232] Timer tick, asking Buildbucket for the build status
[05:08:00.413] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:00.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:31:0) after 1m0s
[05:09:00.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:31:0)
[05:09:00.518] Timer tick, asking Buildbucket for the build status
[05:09:00.622] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:00.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:32:0) after 1m0s
[05:10:00.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:32:0)
[05:10:00.668] Timer tick, asking Buildbucket for the build status
[05:10:00.926] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:00.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:33:0) after 1m0s
[05:11:00.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:33:0)
[05:11:00.963] Timer tick, asking Buildbucket for the build status
[05:11:01.080] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:01.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:34:0) after 1m0s
[05:12:01.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:34:0)
[05:12:01.502] Timer tick, asking Buildbucket for the build status
[05:12:01.617] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:01.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:35:0) after 1m0s
[05:13:01.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:35:0)
[05:13:01.702] Timer tick, asking Buildbucket for the build status
[05:13:01.876] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:01.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:36:0) after 1m0s
[05:14:01.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:36:0)
[05:14:01.887] Timer tick, asking Buildbucket for the build status
[05:14:02.528] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:02.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:37:0) after 1m0s
[05:15:02.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:37:0)
[05:15:02.577] Timer tick, asking Buildbucket for the build status
[05:15:02.872] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:02.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:38:0) after 1m0s
[05:16:02.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:38:0)
[05:16:02.945] Timer tick, asking Buildbucket for the build status
[05:16:03.052] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:03.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:39:0) after 1m0s
[05:17:03.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:39:0)
[05:17:03.098] Timer tick, asking Buildbucket for the build status
[05:17:03.231] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:03.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:40:0) after 1m0s
[05:18:03.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:40:0)
[05:18:03.262] Timer tick, asking Buildbucket for the build status
[05:18:03.399] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:03.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:41:0) after 1m0s
[05:19:03.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:41:0)
[05:19:03.449] Timer tick, asking Buildbucket for the build status
[05:19:03.527] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:03.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:42:0) after 1m0s
[05:20:03.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:42:0)
[05:20:03.530] Timer tick, asking Buildbucket for the build status
[05:20:03.765] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:03.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:43:0) after 1m0s
[05:21:03.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:43:0)
[05:21:03.794] Timer tick, asking Buildbucket for the build status
[05:21:03.989] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:03.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:44:0) after 1m0s
[05:22:04.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:44:0)
[05:22:04.039] Timer tick, asking Buildbucket for the build status
[05:22:04.117] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:04.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:45:0) after 1m0s
[05:23:04.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:45:0)
[05:23:04.218] Timer tick, asking Buildbucket for the build status
[05:23:04.371] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:04.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:46:0) after 1m0s
[05:24:04.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:46:0)
[05:24:04.399] Timer tick, asking Buildbucket for the build status
[05:24:04.462] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:04.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:47:0) after 1m0s
[05:25:04.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:47:0)
[05:25:04.565] Timer tick, asking Buildbucket for the build status
[05:25:06.168] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:06.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:48:0) after 1m0s
[05:26:06.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:48:0)
[05:26:06.200] Timer tick, asking Buildbucket for the build status
[05:26:06.335] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:06.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:49:0) after 1m0s
[05:27:06.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:49:0)
[05:27:06.549] Timer tick, asking Buildbucket for the build status
[05:27:06.631] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:06.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:50:0) after 1m0s
[05:28:06.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:50:0)
[05:28:06.749] Timer tick, asking Buildbucket for the build status
[05:28:06.915] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:06.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:51:0) after 1m0s
[05:29:06.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:51:0)
[05:29:06.938] Timer tick, asking Buildbucket for the build status
[05:29:07.009] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:07.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:52:0) after 1m0s
[05:30:07.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:52:0)
[05:30:07.145] Timer tick, asking Buildbucket for the build status
[05:30:07.280] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:07.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:53:0) after 1m0s
[05:31:07.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:53:0)
[05:31:07.488] Timer tick, asking Buildbucket for the build status
[05:31:07.638] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:07.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:54:0) after 1m0s
[05:32:07.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:54:0)
[05:32:07.758] Timer tick, asking Buildbucket for the build status
[05:32:08.291] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:08.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:55:0) after 1m0s
[05:33:08.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:55:0)
[05:33:08.568] Timer tick, asking Buildbucket for the build status
[05:33:08.671] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:08.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:56:0) after 1m0s
[05:34:08.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:56:0)
[05:34:08.953] Timer tick, asking Buildbucket for the build status
[05:34:09.391] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:09.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:57:0) after 1m0s
[05:35:09.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:57:0)
[05:35:09.491] Timer tick, asking Buildbucket for the build status
[05:35:09.651] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:09.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:58:0) after 1m0s
[05:36:09.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:58:0)
[05:36:09.728] Timer tick, asking Buildbucket for the build status
[05:36:09.876] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:09.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:59:0) after 1m0s
[05:37:10.090] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:59:0)
[05:37:10.090] Timer tick, asking Buildbucket for the build status
[05:37:10.192] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:10.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:60:0) after 1m0s
[05:38:10.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:60:0)
[05:38:10.304] Timer tick, asking Buildbucket for the build status
[05:38:10.696] Build 8857976867250288304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:10.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023406929426011024:61:0) after 1m0s
[05:38:30.306] Received PubSub notification, asking Buildbucket for the build status
[05:38:30.493] Build 8857976867250288304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:38:30.493] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610775509209083",
"created_by": "project:chromium",
"created_ts": "1610771988590969",
"id": "8857976867250288304",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2547f04000483721085400ec34d7a155c7a18e6\"}}",
"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\": \"a2547f04000483721085400ec34d7a155c7a18e6\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-5-aayu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16851, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"ff170c6f508d45a48e573dcbf2a3001200dde61b\", \"got_dawn_revision\": \"04772515a8b613150b28bbed19b4c261e0b50e96\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"a2547f04000483721085400ec34d7a155c7a18e6\", \"got_revision_cp\": \"refs/heads/master@{#844356}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"149733cead636de93d96c5c64f30168d5f6bb03f\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"a2547f04000483721085400ec34d7a155c7a18e6\", \"swarm_hashes_refs/heads/master(at){#844356}_without_patch\": {\"absl_hardening_tests\": \"e80e92a86c11a52a4cf3f675de43aec506c9e3ea\", \"accessibility_unittests\": \"9704748998313693cdc3c11c11e1ca3537c24571\", \"angle_unittests\": \"c9a56438b7b9e86005bf31a3eb9ba1ba34c2375d\", \"app_shell_unittests\": \"6145bbc26f028cedfb8a718a504145b3ad72e4af\", \"aura_unittests\": \"79cc3269b1055d46c167beab5c33696509bd8622\", \"base_unittests\": \"d71fd99ffde0901c3b07acfa22fc579e1604f734\", \"base_util_unittests\": \"531aa59189cf3c84d9310590aa31901cf8fab6be\", \"blink_common_unittests\": \"b85370c903ffe03aac42653c0d86a0bdf8c448b0\", \"blink_fuzzer_unittests\": \"88227652024fbe4fba3d7ced3cc91031c962ca1e\", \"blink_heap_unittests\": \"959873b8040c57f03344472a1accf08c253e3970\", \"blink_platform_unittests\": \"6fcb3625ba0442a4033a12ddc6691331859d485c\", \"blink_unittests\": \"11cfa22cb1e29a287580a302ae5ed766737a0abd\", \"boringssl_crypto_tests\": \"b995521b6f19b3b11577bfa9e47f07c1b5caaf53\", \"boringssl_ssl_tests\": \"cdd021a97166d08e7f1c5650219ec2c0451fd25b\", \"browser_switcher_bho_unittests\": \"d59b8f24bd6d2d6214b7eb96648da77ae91641d1\", \"browser_tests\": \"eb61442646bad07f51a907e66892d2ef61fe08e9\", \"capture_unittests\": \"d1a688ef4ed5d942ffac6c61e4716adfa5d1e230\", \"cast_unittests\": \"11bee9f835608f46e207047ff6cc2b40d58b683c\", \"cc_unittests\": \"662f156a3d20d1265d7dbf919b7136881bb81f77\", \"chrome_app_unittests\": \"2d46bd10c576bae7f969a20665dedecd21ca3453\", \"chrome_cleaner_unittests\": \"e3e903d143f073a002ce69ea5c74375a2aa0eecb\", \"chrome_elf_unittests\": \"bb65637cc8119687c249d6f8e1c1c920802d5bf0\", \"chromedriver_unittests\": \"1af3b416e667812f439802928b9b11a250718496\", \"components_browsertests\": \"03e359a9fa18581a059ccd2947145d484a206099\", \"components_unittests\": \"61c81c698ea8b2703f596ef62ae6d02d3f3c2496\", \"compositor_unittests\": \"1c614aacf3c33fde9e48a998a9e9c97ce0ddb847\", \"content_browsertests\": \"658ff9e0f1b96ec866ae42aedb7fb052df432ab0\", \"content_unittests\": \"a7dfc89a462a6d2a51e868c17f13e5cc3f2bfab3\", \"courgette_unittests\": \"b8b6c92c7b06b4d764c063717d0a5955a98de60b\", \"crashpad_tests\": \"06220aa4edecc39e23a185493813b2c21b5b94fd\", \"cronet_tests\": \"c17114770fdb26a9406c9e0ab73debc5bc354157\", \"cronet_unittests\": \"7278640d74d647d9046c7a9dedc27005bf527182\", \"crypto_unittests\": \"e2b0d161341807935eac59ec866a6fcea383d0ed\", \"delayloads_unittests\": \"73b9c30ad704d5d4195dfff19a37cd151af7c87b\", \"device_unittests\": \"17c197f4438e92d5fec5dd1a83c6666788086286\", \"display_unittests\": \"89c38c0df3ef86dbeadd56f9c2fc5b81dcf8367d\", \"elevation_service_unittests\": \"e826a47906a3455d7ab26e2deca93a4221425e01\", \"events_unittests\": \"b58569daadc7f33bbc86bbbb7268eff482968ce1\", \"extensions_browsertests\": \"0b9c9c8aac4d7592ad723b3a9733f8ae13ad5b8a\", \"extensions_unittests\": \"2dbaef42922fb8de529fc0de302bf5cadf104baf\", \"filesystem_service_unittests\": \"f64c7d7708f1434fbda79864cd0027e1e7ce397b\", \"gcm_unit_tests\": \"3ffa55c5d1b60df8929ed30c9342b67b97ee533a\", \"gcp_unittests\": \"9a0b15a244a098ae9f691961c8b5fa8efc505bbb\", \"gfx_unittests\": \"2ce087abc85b5eb7848899f8c0475e8d013fb693\", \"gin_unittests\": \"a36ae523b97dbe94b0fdea36d7b2f8f8f921d8c6\", \"google_apis_unittests\": \"ce66d718e495728675c2a8fcabf274cd6681de27\", \"gpu_unittests\": \"22ab150d2aa90294a69fe000dde20db20a31f8e4\", \"gwp_asan_unittests\": \"6d1b502b740bf4628309e3c928dcff3d0295e956\", \"headless_browsertests\": \"6563a7c32c6fe3816857bb3438f930f72477a5ab\", \"headless_unittests\": \"90604a8005bb7f6537110bcb54e0b228220280d9\", \"install_static_unittests\": \"6204fefd630d33dc255b12eb7f14ded6a7c3d03c\", \"installer_util_unittests\": \"94eab68c83c6ff6118e3a7edfd16ec39f390f934\", \"interactive_ui_tests\": \"5c95503c1bb84bb385e2547ac2a7bceb8846edfe\", \"ipc_tests\": \"91279c5abcd655445971c327a084b949788d3af5\", \"jingle_unittests\": \"9ec330f3e2d9d36e7d7c20b124d32aaf90b12624\", \"latency_unittests\": \"d07a783f8538297024dacb9fd17394bd0e188e59\", \"libjingle_xmpp_unittests\": \"894a6d24b059fb7dfad8dd1d6b9bfeecf47f4e57\", \"liburlpattern_unittests\": \"495c955f01e6fdcdefb5d15c755815bb921457ca\", \"media_blink_unittests\": \"7bb2bacb68ca9716c67a756b9963b7b0790af96b\", \"media_unittests\": \"db1793897daaa05e2051085981d24e41481d87cf\", \"message_center_unittests\": \"bdb4fefa0e81edc4bc3bd24109b9321097f72952\", \"midi_unittests\": \"d547e40f05c822f0dfcf594f3290cb0dc8b0a2b1\", \"mojo_core_unittests\": \"f6710360f13b359ca507b66bfd8b784e8620216d\", \"mojo_unittests\": \"95820bb1f686c770421ac77581811249af99f723\", \"nacl_loader_unittests\": \"37883a4e9b327ddda02f6842839a2c2053951a93\", \"native_theme_unittests\": \"59f4cc7059cdcd07f3084e4637469185d33ab8d6\", \"net_unittests\": \"48ff206d05ae9f55c4242d02b610fd8b4ead46ae\", \"notification_helper_unittests\": \"cb13392dd712a2e8ad2abc0f8364535fd53895e7\", \"pdf_unittests\": \"78ad424309f85a1d38f110655830fac7eb53d0a0\", \"perfetto_unittests\": \"624ce3abbe2f373f9756a323bfb69ca848cc380c\", \"ppapi_unittests\": \"8501936104d580d2a147debd399918272ea14f79\", \"printing_unittests\": \"b4bfc23cd7b7a87b21acb00b1ec14dfb2d7210f7\", \"remoting_unittests\": \"fea29be4f935c0948020b15c0dcfe1591a2525d4\", \"sbox_integration_tests\": \"b97a238235ba2e9b70ff904ee1cfcd5b6dca02dc\", \"sbox_unittests\": \"e6384c634732dc697d9968a7896a260ce5f4ba80\", \"sbox_validation_tests\": \"a445ad3b3d19612cdc2cf663ec2fb4c9a5646b8d\", \"service_manager_unittests\": \"0874a633fc59b0ed6def02292e6430bca40cd624\", \"services_unittests\": \"ec400720427b3bae1e21b05d4faa559f1026cd29\", \"setup_unittests\": \"31a98640f4348e24ac587b4973c2405151dc679f\", \"shell_dialogs_unittests\": \"143392d5d0cc0cfbd14698f23071a904f6f773ed\", \"skia_unittests\": \"b7f0ff7c8b769852154c3c42526e43af8eda08b6\", \"snapshot_unittests\": \"e6b81cb514d16abfa89da973747a4c079b791b75\", \"sql_unittests\": \"e5adab62a9ed29fb63800cf9acc67796c9ed1425\", \"storage_unittests\": \"6fd92fd4b94816f301c7bd9ceaeda414a83a7f11\", \"sync_integration_tests\": \"05d9e0f40a66b828937c4a401a5e0c3d8e2e3c9f\", \"traffic_annotation_auditor_unittests\": \"6047c84494bfe01b3f5b44aafdfe626df149c6dc\", \"ui_base_unittests\": \"5f9a5ff784b28683a0326dcf41d41738f156942a\", \"ui_touch_selection_unittests\": \"ecf4c7b2e7bdd7f9031ab6a3c837dfe7f988acbc\", \"unit_tests\": \"087080b615f5139a0f126adfd41dc52179c6db45\", \"updater_tests\": \"3a90e32085e7ae2c8d24fe44c7c39eb0a7c3ae62\", \"url_unittests\": \"413523601b7853d639a07d032465583233c8d759\", \"views_unittests\": \"6eac7755b56c01a274d6fe7b3c96145b097aa80b\", \"viz_unittests\": \"458bd2441db7394c26f371476e12a35591f06232\", \"vr_common_unittests\": \"fa0fa9cd033d39f9a1ca80e553d68cf18519e90d\", \"vr_pixeltests\": \"f6b76c6f94c40fb37b81d8762607bf65470636a5\", \"weblayer_browsertests\": \"e2a087cafc0fb4b369b792518b2a646b04bd2c77\", \"weblayer_unittests\": \"9439da118816bc886bad76abc22c2c1528ad3439\", \"wm_unittests\": \"27dd8bc21df4d52ba13704427ec8ea1e45e29b78\", \"wtf_unittests\": \"cb5ae1cad64169bdcc5e4bdbc6ab44db08c17182\", \"zlib_unittests\": \"2bac7ff559dcb01788a3ee11922da5c6ce43ca1e\", \"zucchini_unittests\": \"e4aae04e68d3e116a1918ef7332ae6230c43894f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-5-aayu\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5666-679c9bd\"], \"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": "1610771997268657",
"status": "COMPLETED",
"status_changed_ts": "1610775509649905",
"tags": [
"build_address:luci.chromium.ci/win-asan/16851",
"builder:win-asan",
"buildset:commit/git/a2547f04000483721085400ec34d7a155c7a18e6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2547f04000483721085400ec34d7a155c7a18e6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023406929426011024",
"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/8857976867250288304/+/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:51224f9344179c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610775509659316",
"url": "https://ci.chromium.org/b/8857976867250288304",
"utcnow_ts": "1610775510435584"
}
}
[05:38:30.493] Invocation finished in 58m43.360590329s with status SUCCEEDED