[01:29:43.488] New invocation is queued and will start shortly
[01:29:44.649] Starting the invocation (attempt 1)
[01:29:44.717] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:44.717] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:44.717] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023056499168401152",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023056499168401152",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master"
]
}
[01:29:45.501] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611106184822406",
"id": "8857626437102363392",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611106185372196",
"tags": [
"build_address:luci.chromium.ci/win-asan/16902",
"builder:win-asan",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023056499168401152",
"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/8857626437102363392/+/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": "1611106185372310",
"url": "https://ci.chromium.org/b/8857626437102363392",
"utcnow_ts": "1611106185492766"
}
}
[01:29:45.501] Task URL: https://ci.chromium.org/b/8857626437102363392
[01:29:45.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:2:0) after 1m0s
[01:30:05.119] Received PubSub notification, asking Buildbucket for the build status
[01:30:05.209] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:45.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:2:0)
[01:30:45.527] Timer tick, asking Buildbucket for the build status
[01:30:45.859] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:45.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:4:0) after 1m0s
[01:31:45.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:4:0)
[01:31:45.877] Timer tick, asking Buildbucket for the build status
[01:31:46.182] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:46.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:5:0) after 1m0s
[01:32:46.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:5:0)
[01:32:46.161] Timer tick, asking Buildbucket for the build status
[01:32:46.286] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:46.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:6:0) after 1m0s
[01:33:46.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:6:0)
[01:33:46.320] Timer tick, asking Buildbucket for the build status
[01:33:46.411] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:46.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:7:0) after 1m0s
[01:34:46.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:7:0)
[01:34:46.499] Timer tick, asking Buildbucket for the build status
[01:34:46.617] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:46.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:8:0) after 1m0s
[01:35:46.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:8:0)
[01:35:46.672] Timer tick, asking Buildbucket for the build status
[01:35:46.835] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:9:0) after 1m0s
[01:36:46.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:9:0)
[01:36:46.867] Timer tick, asking Buildbucket for the build status
[01:36:46.933] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:46.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:10:0) after 1m0s
[01:37:46.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:10:0)
[01:37:46.922] Timer tick, asking Buildbucket for the build status
[01:37:47.115] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:47.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:11:0) after 1m0s
[01:38:47.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:11:0)
[01:38:47.156] Timer tick, asking Buildbucket for the build status
[01:38:47.257] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:47.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:12:0) after 1m0s
[01:39:47.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:12:0)
[01:39:47.277] Timer tick, asking Buildbucket for the build status
[01:39:47.464] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:47.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:13:0) after 1m0s
[01:40:47.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:13:0)
[01:40:47.520] Timer tick, asking Buildbucket for the build status
[01:40:47.663] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:47.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:14:0) after 1m0s
[01:41:47.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:14:0)
[01:41:47.745] Timer tick, asking Buildbucket for the build status
[01:41:49.393] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:15:0) after 1m0s
[01:42:49.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:15:0)
[01:42:49.396] Timer tick, asking Buildbucket for the build status
[01:42:49.517] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:49.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:16:0) after 1m0s
[01:43:49.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:16:0)
[01:43:49.527] Timer tick, asking Buildbucket for the build status
[01:43:49.936] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:49.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:17:0) after 1m0s
[01:44:49.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:17:0)
[01:44:49.962] Timer tick, asking Buildbucket for the build status
[01:44:50.443] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:50.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:18:0) after 1m0s
[01:45:50.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:18:0)
[01:45:50.465] Timer tick, asking Buildbucket for the build status
[01:45:50.629] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:50.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:19:0) after 1m0s
[01:46:50.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:19:0)
[01:46:50.701] Timer tick, asking Buildbucket for the build status
[01:46:50.823] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:20:0) after 1m0s
[01:47:50.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:20:0)
[01:47:50.852] Timer tick, asking Buildbucket for the build status
[01:47:51.403] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:51.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:21:0) after 1m0s
[01:48:51.412] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:21:0)
[01:48:51.412] Timer tick, asking Buildbucket for the build status
[01:48:51.573] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:51.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:22:0) after 1m0s
[01:49:51.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:22:0)
[01:49:51.607] Timer tick, asking Buildbucket for the build status
[01:49:51.740] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:23:0) after 1m0s
[01:50:51.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:23:0)
[01:50:51.803] Timer tick, asking Buildbucket for the build status
[01:50:51.937] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:51.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:24:0) after 1m0s
[01:51:51.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:24:0)
[01:51:51.991] Timer tick, asking Buildbucket for the build status
[01:51:52.098] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:52.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:25:0) after 1m0s
[01:52:52.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:25:0)
[01:52:52.222] Timer tick, asking Buildbucket for the build status
[01:52:52.354] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:52.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:26:0) after 1m0s
[01:53:52.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:26:0)
[01:53:52.325] Timer tick, asking Buildbucket for the build status
[01:53:52.461] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:27:0) after 1m0s
[01:54:52.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:27:0)
[01:54:52.508] Timer tick, asking Buildbucket for the build status
[01:54:52.622] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:52.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:28:0) after 1m0s
[01:55:52.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:28:0)
[01:55:52.692] Timer tick, asking Buildbucket for the build status
[01:55:52.806] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:52.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:29:0) after 1m0s
[01:56:52.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:29:0)
[01:56:52.825] Timer tick, asking Buildbucket for the build status
[01:56:52.913] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:52.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:30:0) after 1m0s
[01:57:52.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:30:0)
[01:57:52.941] Timer tick, asking Buildbucket for the build status
[01:57:53.236] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:53.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:31:0) after 1m0s
[01:58:53.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:31:0)
[01:58:53.404] Timer tick, asking Buildbucket for the build status
[01:58:53.473] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:53.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:32:0) after 1m0s
[01:59:53.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:32:0)
[01:59:53.513] Timer tick, asking Buildbucket for the build status
[01:59:53.587] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:53.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:33:0) after 1m0s
[02:00:53.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:33:0)
[02:00:53.610] Timer tick, asking Buildbucket for the build status
[02:00:53.753] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:53.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:34:0) after 1m0s
[02:01:53.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:34:0)
[02:01:53.773] Timer tick, asking Buildbucket for the build status
[02:01:54.103] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:54.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:35:0) after 1m0s
[02:02:54.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:35:0)
[02:02:54.125] Timer tick, asking Buildbucket for the build status
[02:02:54.383] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:54.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:36:0) after 1m0s
[02:03:54.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:36:0)
[02:03:54.406] Timer tick, asking Buildbucket for the build status
[02:03:54.915] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:54.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:37:0) after 1m0s
[02:04:54.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:37:0)
[02:04:54.962] Timer tick, asking Buildbucket for the build status
[02:04:55.094] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:55.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:38:0) after 1m0s
[02:05:55.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:38:0)
[02:05:55.154] Timer tick, asking Buildbucket for the build status
[02:05:55.431] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:55.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:39:0) after 1m0s
[02:06:55.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:39:0)
[02:06:55.451] Timer tick, asking Buildbucket for the build status
[02:06:55.977] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:55.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:40:0) after 1m0s
[02:07:56.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:40:0)
[02:07:56.006] Timer tick, asking Buildbucket for the build status
[02:07:56.093] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:56.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:41:0) after 1m0s
[02:08:56.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:41:0)
[02:08:56.113] Timer tick, asking Buildbucket for the build status
[02:08:56.191] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:56.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:42:0) after 1m0s
[02:09:56.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:42:0)
[02:09:56.227] Timer tick, asking Buildbucket for the build status
[02:09:56.621] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:56.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:43:0) after 1m0s
[02:10:56.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:43:0)
[02:10:56.640] Timer tick, asking Buildbucket for the build status
[02:10:56.762] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:56.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:44:0) after 1m0s
[02:11:56.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:44:0)
[02:11:56.780] Timer tick, asking Buildbucket for the build status
[02:11:56.854] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:56.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:45:0) after 1m0s
[02:12:56.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:45:0)
[02:12:56.862] Timer tick, asking Buildbucket for the build status
[02:12:57.462] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:57.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:46:0) after 1m0s
[02:13:57.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:46:0)
[02:13:57.483] Timer tick, asking Buildbucket for the build status
[02:13:57.873] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:57.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:47:0) after 1m0s
[02:14:57.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:47:0)
[02:14:57.939] Timer tick, asking Buildbucket for the build status
[02:14:58.523] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:58.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:48:0) after 1m0s
[02:15:58.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:48:0)
[02:15:58.543] Timer tick, asking Buildbucket for the build status
[02:15:58.703] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:58.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:49:0) after 1m0s
[02:16:58.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:49:0)
[02:16:58.754] Timer tick, asking Buildbucket for the build status
[02:16:58.833] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:50:0) after 1m0s
[02:17:58.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:50:0)
[02:17:58.929] Timer tick, asking Buildbucket for the build status
[02:17:59.032] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:59.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:51:0) after 1m0s
[02:18:59.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:51:0)
[02:18:59.032] Timer tick, asking Buildbucket for the build status
[02:18:59.204] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:59.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:52:0) after 1m0s
[02:19:59.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:52:0)
[02:19:59.213] Timer tick, asking Buildbucket for the build status
[02:19:59.819] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:59.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:53:0) after 1m0s
[02:20:59.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:53:0)
[02:20:59.791] Timer tick, asking Buildbucket for the build status
[02:21:00.656] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:00.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:54:0) after 1m0s
[02:22:00.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:54:0)
[02:22:00.662] Timer tick, asking Buildbucket for the build status
[02:22:00.854] Build 8857626437102363392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:00.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023056499168401152:55:0) after 1m0s
[02:22:47.425] Received PubSub notification, asking Buildbucket for the build status
[02:22:47.505] Build 8857626437102363392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:22:47.506] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611109366363146",
"created_by": "project:chromium",
"created_ts": "1611106184822406",
"id": "8857626437102363392",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"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\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\", \"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-0-nszv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16902, \"clang_revision\": \"llvmorg-12-init-16548-gf1d5cbbd-1\", \"got_angle_revision\": \"2e0490eedcc809bcd6359de6afdb9e40bd9f731a\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\", \"got_revision_cp\": \"refs/heads/master@{#844986}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"89fd1480b47e8c8668dfd3c24302c53b76ba4c88\", \"got_v8_revision\": \"6181c222ef4e8307540a8b27201a790957a92fdd\", \"got_v8_revision_cp\": \"refs/heads/9.0.17@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"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\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\", \"swarm_hashes_refs/heads/master(at){#844986}_without_patch\": {\"absl_hardening_tests\": \"eed92c43599232bfcc016a84ee88e86c796635e2\", \"accessibility_unittests\": \"c78eee1c421f9948b75813d92b58e36c2ef40cf2\", \"angle_unittests\": \"da5bc912ee4d6f2e4d5d7a536816a74fe0494478\", \"app_shell_unittests\": \"a38ca114d20147e77d2c2829c57d66aa76b4c356\", \"aura_unittests\": \"21f0c29acd51cc22035d0c49d101ccb008cb9e09\", \"base_unittests\": \"9eb9d92a77125a21b77a5a1fbf4d16adb416420f\", \"base_util_unittests\": \"f4c49e1e855bddccff41ac0446144093180a39d4\", \"blink_common_unittests\": \"0db377d3d2acec1b9f9676ba239e8376e1d7ca16\", \"blink_fuzzer_unittests\": \"803664e52abb2cd55f5aaec86416275b2dbe2730\", \"blink_heap_unittests\": \"5ead7de4f3f6b16e2dc4a6e8ae5b5a9c9534cc07\", \"blink_platform_unittests\": \"e8a69d60a7557fb5d247d23cd751e44db98c63ed\", \"blink_unittests\": \"d55cf87e608b60d76764ff85d3c926fce8752cfc\", \"boringssl_crypto_tests\": \"bc5d33a1097f049a099861a6c8638b7ee00292ac\", \"boringssl_ssl_tests\": \"76e657d731aae1dd5b0b0fa674d33bed298247f3\", \"browser_switcher_bho_unittests\": \"17acbe9a6c516e8d9b1a8c9fbd27a1fad8081bb4\", \"browser_tests\": \"54a7c045aa964c2d5f05bb91540535689087600b\", \"capture_unittests\": \"ffc574ba83b1874ad289c998b4e30a59174260b4\", \"cast_unittests\": \"5d5a10390e8f59511a8b488d6d778f489083dc65\", \"cc_unittests\": \"24f0945d054028eb025a8ccc507bb861543b8c6d\", \"chrome_app_unittests\": \"b8045bb1ae6d94db2be1109a46b667839cceae38\", \"chrome_cleaner_unittests\": \"c373170d6b95864f6334bd15d790056feb08e7a5\", \"chrome_elf_unittests\": \"0f0ce216a709f40d74fce8310df1aee701f67875\", \"chromedriver_unittests\": \"8c1d55a5d5d6662ed546053b084216bb35c1f589\", \"components_browsertests\": \"66f33a73fd53cc9dccf86d4d94d2c0d236eab826\", \"components_unittests\": \"e351db076383853f25bdcc1203e33b9d9cc418d5\", \"compositor_unittests\": \"af045e7a4b9e81fc5359284e758bb09f7af8c493\", \"content_browsertests\": \"57969f02e024e29dc5fddc667d0432541e3b063a\", \"content_unittests\": \"0c6c4fa784cee50b00938ea6edf77073358a6fd4\", \"courgette_unittests\": \"61812110f8bdd381d2e6cdd39d9e95988e43b1eb\", \"crashpad_tests\": \"45c4b8372a1ae05dac5e596d9ec1775f20bb2a4b\", \"cronet_tests\": \"2d7f47b230bdc4ac706b661654fc755842ea7f5e\", \"cronet_unittests\": \"13e9d908b5946d2b899c7903ebf03b085d3b24af\", \"crypto_unittests\": \"aa3b06ae2d606a3f49f4889a04b891592c862702\", \"delayloads_unittests\": \"469ec05753ba3767ddf906b748d9caa79e546389\", \"device_unittests\": \"6e577ecb3517cbf4ac772eba04af12178b5566ef\", \"display_unittests\": \"8b8c10f4a4eceda0cef0803c068580521e630741\", \"elevation_service_unittests\": \"82eafe6c055b76549efbdaf1ffc1d5a406507289\", \"events_unittests\": \"8e5028e3af96bcd4c74cd1682647c36da3b4353d\", \"extensions_browsertests\": \"8cb76aa5e76b13ab0e06ce50058663032067fbe7\", \"extensions_unittests\": \"c026e3d584a5cfc389c0391ff169c01b39c20a9c\", \"filesystem_service_unittests\": \"acd201ed4a5ca85553f3bfa897a01bebf825f616\", \"gcm_unit_tests\": \"e62c3e24d597cf5dcbe908f53eaa211b91a8b5e4\", \"gcp_unittests\": \"4b5b29e09dadf9163d4830e5cd55973f07515e1a\", \"gfx_unittests\": \"c8bc87629f13b63bdf90a40727503f4973c6ba52\", \"gin_unittests\": \"449dad5b2f419f878665c1d6e01b96b012f96581\", \"google_apis_unittests\": \"a99331991de019f4ff6ffad0b874153cfcb4bbfc\", \"gpu_unittests\": \"012af923e9fe43a8b707a4d5f27ef0b93b66293b\", \"gwp_asan_unittests\": \"f7b5d5e9a9eac295650e70b1d051a789363d7eb2\", \"headless_browsertests\": \"0d7e26c5eaeb8da78358eb57d0da59e63fd74a75\", \"headless_unittests\": \"e65233fff594082b0c211151f22c32478b2ebabc\", \"install_static_unittests\": \"77f6cbde26dec86b4a5879511695b31d91a45a9c\", \"installer_util_unittests\": \"76f2c4c8093df701eade99ec71a9df4671ef0d0d\", \"interactive_ui_tests\": \"6c49dab67f0a69f5b08c53902c034bd39dcff2d8\", \"ipc_tests\": \"377e997404ec6b0a16f9060a55b30b84f2026a29\", \"jingle_unittests\": \"3d37a16ec4c41971c3084a5137295b1e84e2be18\", \"latency_unittests\": \"a981c6b8983267bee859a7ab7f1290004ef072bb\", \"libjingle_xmpp_unittests\": \"aaeef1564e951c4a0a4853a7feb9c624942f9ff9\", \"liburlpattern_unittests\": \"5a043d23caac014165d77fb1b2a670401f7c9235\", \"media_blink_unittests\": \"d8743f8782b4eb4ea10a76efb78a980497ad7d99\", \"media_unittests\": \"df5b9dc2231ce294a60cbdf1534a199a7995b42c\", \"message_center_unittests\": \"ed8b4ff9c10bc79e690e84dca21aef370a45bbed\", \"midi_unittests\": \"9ecd52143e83bc47032e74f1ab895ff5e85fa0cc\", \"mojo_core_unittests\": \"6207afcc95e06cb9fc8a5f5fc7e1b8c982f2ad56\", \"mojo_unittests\": \"ba837d5bb38858a122a1990383472a994078863f\", \"nacl_loader_unittests\": \"91bac66954c3213337a03c5959833b550da30825\", \"native_theme_unittests\": \"30474d2820d35cd0b26ed588350992d5c2a3e12c\", \"net_unittests\": \"59755d33d6c3a1c3125d7880d492a3211a27b70c\", \"notification_helper_unittests\": \"e229039638e88a7b587ba2a9ed8bf5d3cbe903ea\", \"pdf_unittests\": \"eeb77d615e8ce753213696ea077db14640147bc5\", \"perfetto_unittests\": \"c6bc5fc512a250e5702f41aa646de6245423cdb2\", \"ppapi_unittests\": \"99dc7369c0b8a9f2b791467dde91f10ccd4a274e\", \"printing_unittests\": \"3cd004a90c3690cc32ae79bdb7a36125e97c44e0\", \"remoting_unittests\": \"149c6457c01e9eaae5d90f76cba785034395a3a4\", \"sbox_integration_tests\": \"5cfc35d74db2efe9fd5ffaa5e2a34859df8678f8\", \"sbox_unittests\": \"0b028ceea80433cf3d72b8e12b9d2d9bdec3d989\", \"sbox_validation_tests\": \"3cea6d9eeaeab3e18809f7e505882ce4ad06ce94\", \"service_manager_unittests\": \"bd08107ef1c3942051e52becbfd7cbcf44372fd8\", \"services_unittests\": \"44b68b8a602749f15e26ec69b3e22083c61a9272\", \"setup_unittests\": \"382a82e749a45a053f83849d3b1dc22168b7f1ca\", \"shell_dialogs_unittests\": \"3ca0c3698dccdac88389d9b91aec54843f1debc3\", \"skia_unittests\": \"69a746d784b58ce0d670264574334471ea1bc97c\", \"snapshot_unittests\": \"14d30458d341c7d29f984a62694cf74848d67dea\", \"sql_unittests\": \"997444a0d81c8ca000eee269aab572dae968b353\", \"storage_unittests\": \"d626a70cc1e86977cc3ce8b88ee15a885e04455e\", \"sync_integration_tests\": \"c56adb35b0976a5d56ddc57262acf6a67a5b7843\", \"traffic_annotation_auditor_unittests\": \"d0976d0f1928a8088d56a792bb0c5daf430413a5\", \"ui_base_unittests\": \"91061617d296e7e3b68293a7980d393de6a69149\", \"ui_touch_selection_unittests\": \"48e4087d30e6797c690b0f2a63e48dcaf4665784\", \"unit_tests\": \"1823fd425ace134723574780d10be86bf581e7cd\", \"updater_tests\": \"b16d3f45992d9ce362a79097ef80a4410d68c836\", \"url_unittests\": \"5ff5e30eddb2bc440fa3da76374383a4aa1d3c11\", \"views_unittests\": \"7baf4fcccc95ca766d3017df0ca628f892949472\", \"viz_unittests\": \"564fab0b77f65758f71987cc3320c4d3582f5218\", \"vr_common_unittests\": \"67a027b04817f4d36f66d49a09dcb94bf42ee863\", \"vr_pixeltests\": \"1abcf65932d8776e318325afd7ab5470f9911069\", \"weblayer_browsertests\": \"023ce4b1d2a9d6833163226b3aff3f79b8c31f50\", \"weblayer_unittests\": \"2bee276c00314b8bd1a96ca7b8d32126ed5f722c\", \"wm_unittests\": \"5ad43493d27bb5da117caebf0d50816da7f9ef2f\", \"wtf_unittests\": \"8d96bc8ab5d85fbf6dc0a7044c91c02ea5ba9de2\", \"zlib_unittests\": \"a611ea2b1158e5401e63e83cd03366c322966ebd\", \"zucchini_unittests\": \"035aa851c72e8a8fae12d88bcb0e760be63d45cc\"}}, \"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-0-nszv\"], \"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": "1611106203637689",
"status": "COMPLETED",
"status_changed_ts": "1611109366782876",
"tags": [
"build_address:luci.chromium.ci/win-asan/16902",
"builder:win-asan",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023056499168401152",
"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/8857626437102363392/+/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:51363b33618dcd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611109366787141",
"url": "https://ci.chromium.org/b/8857626437102363392",
"utcnow_ts": "1611109367496659"
}
}
[02:22:47.506] Invocation finished in 53m4.037981168s with status SUCCEEDED