[17:17:54.587] New invocation is queued and will start shortly
[17:17:55.756] Starting the invocation (attempt 1)
[17:17:55.798] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:17:55.798] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:17:55.799] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019282368899778064",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019282368899778064",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"gitiles_ref:refs/heads/master"
]
}
[17:17:56.543] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614705475926739",
"id": "8853852306833407728",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614705476431012",
"tags": [
"build_address:luci.chromium.ci/win-asan/17595",
"builder:win-asan",
"buildset:commit/git/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019282368899778064",
"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/8853852306833407728/+/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": "1614705476431406",
"url": "https://ci.chromium.org/b/8853852306833407728",
"utcnow_ts": "1614705476534236"
}
}
[17:17:56.543] Task URL: https://ci.chromium.org/b/8853852306833407728
[17:17:56.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:2:0) after 1m0s
[17:18:56.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:2:0)
[17:18:56.680] Timer tick, asking Buildbucket for the build status
[17:18:56.770] Build 8853852306833407728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:56.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:3:0) after 1m0s
[17:19:56.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:3:0)
[17:19:56.814] Timer tick, asking Buildbucket for the build status
[17:19:56.884] Build 8853852306833407728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:56.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:4:0) after 1m0s
[17:20:49.058] Received PubSub notification, asking Buildbucket for the build status
[17:20:49.192] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:56.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:4:0)
[17:20:56.963] Timer tick, asking Buildbucket for the build status
[17:20:57.017] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:57.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:6:0) after 1m0s
[17:21:57.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:6:0)
[17:21:57.060] Timer tick, asking Buildbucket for the build status
[17:21:57.201] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:57.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:7:0) after 1m0s
[17:22:57.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:7:0)
[17:22:57.232] Timer tick, asking Buildbucket for the build status
[17:22:57.291] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:57.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:8:0) after 1m0s
[17:23:57.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:8:0)
[17:23:57.306] Timer tick, asking Buildbucket for the build status
[17:23:57.438] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:57.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:9:0) after 1m0s
[17:24:57.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:9:0)
[17:24:57.494] Timer tick, asking Buildbucket for the build status
[17:24:57.761] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:57.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:10:0) after 1m0s
[17:25:57.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:10:0)
[17:25:57.868] Timer tick, asking Buildbucket for the build status
[17:25:58.208] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:58.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:11:0) after 1m0s
[17:26:58.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:11:0)
[17:26:58.277] Timer tick, asking Buildbucket for the build status
[17:27:01.541] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:01.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:12:0) after 1m0s
[17:28:02.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:12:0)
[17:28:02.203] Timer tick, asking Buildbucket for the build status
[17:28:02.331] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:02.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:13:0) after 1m0s
[17:29:02.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:13:0)
[17:29:02.387] Timer tick, asking Buildbucket for the build status
[17:29:02.474] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:02.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:14:0) after 1m0s
[17:30:02.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:14:0)
[17:30:02.526] Timer tick, asking Buildbucket for the build status
[17:30:02.913] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:15:0) after 1m0s
[17:31:02.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:15:0)
[17:31:02.935] Timer tick, asking Buildbucket for the build status
[17:31:03.176] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:03.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:16:0) after 1m0s
[17:32:03.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:16:0)
[17:32:03.191] Timer tick, asking Buildbucket for the build status
[17:32:03.335] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:03.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:17:0) after 1m0s
[17:33:03.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:17:0)
[17:33:03.380] Timer tick, asking Buildbucket for the build status
[17:33:03.522] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:03.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:18:0) after 1m0s
[17:34:03.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:18:0)
[17:34:03.585] Timer tick, asking Buildbucket for the build status
[17:34:03.662] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:03.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:19:0) after 1m0s
[17:35:03.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:19:0)
[17:35:03.697] Timer tick, asking Buildbucket for the build status
[17:35:03.861] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:03.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:20:0) after 1m0s
[17:36:03.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:20:0)
[17:36:03.983] Timer tick, asking Buildbucket for the build status
[17:36:04.502] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:04.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:21:0) after 1m0s
[17:37:04.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:21:0)
[17:37:04.571] Timer tick, asking Buildbucket for the build status
[17:37:04.991] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:04.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:22:0) after 1m0s
[17:38:05.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:22:0)
[17:38:05.059] Timer tick, asking Buildbucket for the build status
[17:38:05.257] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:23:0) after 1m0s
[17:39:05.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:23:0)
[17:39:05.277] Timer tick, asking Buildbucket for the build status
[17:39:05.338] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:05.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:24:0) after 1m0s
[17:40:07.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:24:0)
[17:40:07.008] Timer tick, asking Buildbucket for the build status
[17:40:07.082] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:25:0) after 1m0s
[17:41:07.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:25:0)
[17:41:07.526] Timer tick, asking Buildbucket for the build status
[17:41:08.049] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:08.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:26:0) after 1m0s
[17:42:08.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:26:0)
[17:42:08.069] Timer tick, asking Buildbucket for the build status
[17:42:08.197] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:08.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:27:0) after 1m0s
[17:43:08.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:27:0)
[17:43:08.256] Timer tick, asking Buildbucket for the build status
[17:43:08.330] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:08.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:28:0) after 1m0s
[17:44:08.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:28:0)
[17:44:08.488] Timer tick, asking Buildbucket for the build status
[17:44:08.569] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:08.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:29:0) after 1m0s
[17:45:08.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:29:0)
[17:45:08.918] Timer tick, asking Buildbucket for the build status
[17:45:09.169] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:09.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:30:0) after 1m0s
[17:46:09.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:30:0)
[17:46:09.247] Timer tick, asking Buildbucket for the build status
[17:46:09.485] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:09.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:31:0) after 1m0s
[17:47:09.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:31:0)
[17:47:09.630] Timer tick, asking Buildbucket for the build status
[17:47:09.832] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:09.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:32:0) after 1m0s
[17:48:09.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:32:0)
[17:48:09.954] Timer tick, asking Buildbucket for the build status
[17:48:10.229] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:10.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:33:0) after 1m0s
[17:49:10.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:33:0)
[17:49:10.254] Timer tick, asking Buildbucket for the build status
[17:49:10.424] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:10.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:34:0) after 1m0s
[17:50:10.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:34:0)
[17:50:10.452] Timer tick, asking Buildbucket for the build status
[17:50:11.874] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:11.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:35:0) after 1m0s
[17:51:12.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:35:0)
[17:51:12.675] Timer tick, asking Buildbucket for the build status
[17:51:15.281] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:15.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:36:0) after 1m0s
[17:52:15.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:36:0)
[17:52:15.751] Timer tick, asking Buildbucket for the build status
[17:52:15.827] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:15.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:37:0) after 1m0s
[17:53:16.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:37:0)
[17:53:16.222] Timer tick, asking Buildbucket for the build status
[17:53:16.330] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:16.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:38:0) after 1m0s
[17:54:16.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:38:0)
[17:54:16.500] Timer tick, asking Buildbucket for the build status
[17:54:16.585] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:16.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:39:0) after 1m0s
[17:55:16.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:39:0)
[17:55:16.658] Timer tick, asking Buildbucket for the build status
[17:55:17.048] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:17.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:40:0) after 1m0s
[17:56:17.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:40:0)
[17:56:17.118] Timer tick, asking Buildbucket for the build status
[17:56:17.205] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:17.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:41:0) after 1m0s
[17:57:17.313] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:41:0)
[17:57:17.313] Timer tick, asking Buildbucket for the build status
[17:57:17.460] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:17.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:42:0) after 1m0s
[17:58:17.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:42:0)
[17:58:17.469] Timer tick, asking Buildbucket for the build status
[17:58:17.588] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:17.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:43:0) after 1m0s
[17:59:17.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:43:0)
[17:59:17.651] Timer tick, asking Buildbucket for the build status
[17:59:17.738] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:17.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:44:0) after 1m0s
[18:00:18.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:44:0)
[18:00:18.006] Timer tick, asking Buildbucket for the build status
[18:00:18.441] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:18.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:45:0) after 1m0s
[18:01:18.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:45:0)
[18:01:18.803] Timer tick, asking Buildbucket for the build status
[18:01:19.024] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:46:0) after 1m0s
[18:02:19.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:46:0)
[18:02:19.573] Timer tick, asking Buildbucket for the build status
[18:02:20.029] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:20.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:47:0) after 1m0s
[18:03:20.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:47:0)
[18:03:20.114] Timer tick, asking Buildbucket for the build status
[18:03:20.231] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:20.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:48:0) after 1m0s
[18:04:20.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:48:0)
[18:04:20.226] Timer tick, asking Buildbucket for the build status
[18:04:20.302] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:49:0) after 1m0s
[18:05:20.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:49:0)
[18:05:20.343] Timer tick, asking Buildbucket for the build status
[18:05:20.410] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:20.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:50:0) after 1m0s
[18:06:20.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:50:0)
[18:06:20.482] Timer tick, asking Buildbucket for the build status
[18:06:20.614] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:20.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:51:0) after 1m0s
[18:07:20.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:51:0)
[18:07:20.632] Timer tick, asking Buildbucket for the build status
[18:07:20.709] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:20.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:52:0) after 1m0s
[18:08:20.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:52:0)
[18:08:20.726] Timer tick, asking Buildbucket for the build status
[18:08:20.813] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:20.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:53:0) after 1m0s
[18:09:20.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:53:0)
[18:09:20.840] Timer tick, asking Buildbucket for the build status
[18:09:21.145] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:21.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:54:0) after 1m0s
[18:10:21.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:54:0)
[18:10:21.203] Timer tick, asking Buildbucket for the build status
[18:10:21.292] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:21.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:55:0) after 1m0s
[18:11:21.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:55:0)
[18:11:21.545] Timer tick, asking Buildbucket for the build status
[18:11:21.980] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:21.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:56:0) after 1m0s
[18:12:22.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:56:0)
[18:12:22.177] Timer tick, asking Buildbucket for the build status
[18:12:22.288] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:22.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:57:0) after 1m0s
[18:13:22.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:57:0)
[18:13:22.336] Timer tick, asking Buildbucket for the build status
[18:13:22.537] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:22.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:58:0) after 1m0s
[18:14:22.580] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:58:0)
[18:14:22.580] Timer tick, asking Buildbucket for the build status
[18:14:22.814] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:22.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:59:0) after 1m0s
[18:15:22.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:59:0)
[18:15:22.820] Timer tick, asking Buildbucket for the build status
[18:15:22.904] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:60:0) after 1m0s
[18:16:22.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:60:0)
[18:16:22.894] Timer tick, asking Buildbucket for the build status
[18:16:22.988] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:22.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:61:0) after 1m0s
[18:17:23.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:61:0)
[18:17:23.091] Timer tick, asking Buildbucket for the build status
[18:17:23.420] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:23.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:62:0) after 1m0s
[18:18:23.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:62:0)
[18:18:23.469] Timer tick, asking Buildbucket for the build status
[18:18:25.712] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:25.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:63:0) after 1m0s
[18:19:25.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:63:0)
[18:19:25.831] Timer tick, asking Buildbucket for the build status
[18:19:25.933] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:25.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:64:0) after 1m0s
[18:20:26.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:64:0)
[18:20:26.014] Timer tick, asking Buildbucket for the build status
[18:20:26.262] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:26.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:65:0) after 1m0s
[18:21:26.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:65:0)
[18:21:26.364] Timer tick, asking Buildbucket for the build status
[18:21:26.460] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:26.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:66:0) after 1m0s
[18:22:26.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:66:0)
[18:22:26.499] Timer tick, asking Buildbucket for the build status
[18:22:26.830] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:26.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:67:0) after 1m0s
[18:23:26.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:67:0)
[18:23:26.990] Timer tick, asking Buildbucket for the build status
[18:23:27.058] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:27.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:68:0) after 1m0s
[18:24:27.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:68:0)
[18:24:27.180] Timer tick, asking Buildbucket for the build status
[18:24:27.248] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:27.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:69:0) after 1m0s
[18:25:27.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:69:0)
[18:25:27.295] Timer tick, asking Buildbucket for the build status
[18:25:27.357] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:27.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:70:0) after 1m0s
[18:26:27.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:70:0)
[18:26:27.331] Timer tick, asking Buildbucket for the build status
[18:26:27.418] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:27.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:71:0) after 1m0s
[18:27:27.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:71:0)
[18:27:27.514] Timer tick, asking Buildbucket for the build status
[18:27:27.647] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:27.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:72:0) after 1m0s
[18:28:27.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:72:0)
[18:28:27.688] Timer tick, asking Buildbucket for the build status
[18:28:27.743] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:73:0) after 1m0s
[18:29:27.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:73:0)
[18:29:27.715] Timer tick, asking Buildbucket for the build status
[18:29:27.864] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:27.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:74:0) after 1m0s
[18:30:27.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:74:0)
[18:30:27.882] Timer tick, asking Buildbucket for the build status
[18:30:27.972] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:75:0) after 1m0s
[18:31:28.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:75:0)
[18:31:28.043] Timer tick, asking Buildbucket for the build status
[18:31:28.158] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:28.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:76:0) after 1m0s
[18:32:28.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:76:0)
[18:32:28.570] Timer tick, asking Buildbucket for the build status
[18:32:28.671] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:28.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:77:0) after 1m0s
[18:33:29.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:77:0)
[18:33:29.294] Timer tick, asking Buildbucket for the build status
[18:33:29.385] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:29.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:78:0) after 1m0s
[18:34:29.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:78:0)
[18:34:29.455] Timer tick, asking Buildbucket for the build status
[18:34:29.607] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:29.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:79:0) after 1m0s
[18:35:30.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:79:0)
[18:35:30.588] Timer tick, asking Buildbucket for the build status
[18:35:30.664] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:30.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:80:0) after 1m0s
[18:36:30.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:80:0)
[18:36:30.739] Timer tick, asking Buildbucket for the build status
[18:36:30.898] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:30.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:81:0) after 1m0s
[18:37:30.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:81:0)
[18:37:30.997] Timer tick, asking Buildbucket for the build status
[18:37:31.082] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:31.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:82:0) after 1m0s
[18:38:31.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:82:0)
[18:38:31.119] Timer tick, asking Buildbucket for the build status
[18:38:31.239] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:31.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:83:0) after 1m0s
[18:39:31.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:83:0)
[18:39:31.286] Timer tick, asking Buildbucket for the build status
[18:39:31.378] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:31.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:84:0) after 1m0s
[18:40:31.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:84:0)
[18:40:31.425] Timer tick, asking Buildbucket for the build status
[18:40:31.609] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:31.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:85:0) after 1m0s
[18:41:31.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:85:0)
[18:41:31.688] Timer tick, asking Buildbucket for the build status
[18:41:31.831] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:31.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:86:0) after 1m0s
[18:42:31.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:86:0)
[18:42:31.856] Timer tick, asking Buildbucket for the build status
[18:42:31.935] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:31.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:87:0) after 1m0s
[18:43:31.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:87:0)
[18:43:31.988] Timer tick, asking Buildbucket for the build status
[18:43:32.092] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:32.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:88:0) after 1m0s
[18:44:32.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:88:0)
[18:44:32.165] Timer tick, asking Buildbucket for the build status
[18:44:32.276] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:32.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:89:0) after 1m0s
[18:45:32.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:89:0)
[18:45:32.364] Timer tick, asking Buildbucket for the build status
[18:45:32.508] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:32.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:90:0) after 1m0s
[18:46:32.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:90:0)
[18:46:32.561] Timer tick, asking Buildbucket for the build status
[18:46:32.644] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:32.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:91:0) after 1m0s
[18:47:32.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:91:0)
[18:47:32.695] Timer tick, asking Buildbucket for the build status
[18:47:32.844] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:32.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:92:0) after 1m0s
[18:48:32.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:92:0)
[18:48:32.927] Timer tick, asking Buildbucket for the build status
[18:48:33.015] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:33.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:93:0) after 1m0s
[18:49:33.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:93:0)
[18:49:33.157] Timer tick, asking Buildbucket for the build status
[18:49:33.267] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:33.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:94:0) after 1m0s
[18:50:33.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:94:0)
[18:50:33.275] Timer tick, asking Buildbucket for the build status
[18:50:33.366] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:33.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:95:0) after 1m0s
[18:51:33.412] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:95:0)
[18:51:33.412] Timer tick, asking Buildbucket for the build status
[18:51:33.586] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:33.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:96:0) after 1m0s
[18:52:33.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:96:0)
[18:52:33.685] Timer tick, asking Buildbucket for the build status
[18:52:33.883] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:33.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:97:0) after 1m0s
[18:53:33.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:97:0)
[18:53:33.944] Timer tick, asking Buildbucket for the build status
[18:53:34.047] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:34.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:98:0) after 1m0s
[18:54:34.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:98:0)
[18:54:34.131] Timer tick, asking Buildbucket for the build status
[18:54:34.744] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:34.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:99:0) after 1m0s
[18:55:34.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:99:0)
[18:55:34.818] Timer tick, asking Buildbucket for the build status
[18:55:35.032] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:35.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:100:0) after 1m0s
[18:56:35.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:100:0)
[18:56:35.925] Timer tick, asking Buildbucket for the build status
[18:56:35.996] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:35.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:101:0) after 1m0s
[18:57:36.080] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:101:0)
[18:57:36.080] Timer tick, asking Buildbucket for the build status
[18:57:36.200] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:36.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:102:0) after 1m0s
[18:58:36.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:102:0)
[18:58:36.272] Timer tick, asking Buildbucket for the build status
[18:58:36.375] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:36.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:103:0) after 1m0s
[18:59:36.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:103:0)
[18:59:36.597] Timer tick, asking Buildbucket for the build status
[18:59:37.113] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:37.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:104:0) after 1m0s
[19:00:37.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:104:0)
[19:00:37.130] Timer tick, asking Buildbucket for the build status
[19:00:37.308] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:37.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:105:0) after 1m0s
[19:01:37.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:105:0)
[19:01:37.328] Timer tick, asking Buildbucket for the build status
[19:01:37.613] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:37.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:106:0) after 1m0s
[19:02:37.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:106:0)
[19:02:37.640] Timer tick, asking Buildbucket for the build status
[19:02:37.787] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:37.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:107:0) after 1m0s
[19:03:37.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:107:0)
[19:03:37.933] Timer tick, asking Buildbucket for the build status
[19:03:38.913] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:38.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:108:0) after 1m0s
[19:04:38.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:108:0)
[19:04:38.992] Timer tick, asking Buildbucket for the build status
[19:04:39.166] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:39.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:109:0) after 1m0s
[19:05:39.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:109:0)
[19:05:39.212] Timer tick, asking Buildbucket for the build status
[19:05:39.419] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:39.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:110:0) after 1m0s
[19:06:39.440] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:110:0)
[19:06:39.440] Timer tick, asking Buildbucket for the build status
[19:06:39.703] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:39.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:111:0) after 1m0s
[19:07:39.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:111:0)
[19:07:39.723] Timer tick, asking Buildbucket for the build status
[19:07:40.261] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:40.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:112:0) after 1m0s
[19:08:40.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:112:0)
[19:08:40.288] Timer tick, asking Buildbucket for the build status
[19:08:40.536] Build 8853852306833407728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:40.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019282368899778064:113:0) after 1m0s
[19:09:13.462] Received PubSub notification, asking Buildbucket for the build status
[19:09:13.525] Build 8853852306833407728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:09:13.525] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614712152508828",
"created_by": "project:chromium",
"created_ts": "1614705475926739",
"id": "8853852306833407728",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\"}}",
"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\": \"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\", \"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-qhp0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17595, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"6b6da203cce03287ef269846d54e77a8e871e221\", \"got_dawn_revision\": \"29f0bd7e6ac26992ecd380b9dbdc91e6fc9646c8\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\", \"got_revision_cp\": \"refs/heads/master@{#859028}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"da800c736f3a0b127f576fbded9d56d380b78a77\", \"got_v8_revision_cp\": \"refs/heads/9.1.14@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9\", \"swarm_hashes_refs/heads/master(at){#859028}_without_patch\": {\"absl_hardening_tests\": \"a290f97519b4321daaf133a4524b9f0ae09ee859\", \"accessibility_unittests\": \"bb43d53991a732ed38f410d44647ea239a0d7bf2\", \"angle_unittests\": \"aa9f8eb09af2b93a249400ab99714aa1ae1f31a5\", \"app_shell_unittests\": \"fbcc841c2de17c221df859d25e0e4430880a4ba9\", \"aura_unittests\": \"1e750a47b55243d7af05b8daf40f66008a9f716f\", \"base_unittests\": \"468c04ea6c99f99e65d5f6abcff473f97f462ba0\", \"base_util_unittests\": \"a4ed6dbd2f98a7e28bca6104d1634de67f748167\", \"blink_common_unittests\": \"292683e83433b4b6b5a9a1d6e3c5423bd5928c8c\", \"blink_fuzzer_unittests\": \"3da83c1c828a54064d230f690001f50f6c23ff52\", \"blink_heap_unittests\": \"85e1703d84a9d49b660cf7cf25ba085a76319d4b\", \"blink_platform_unittests\": \"340734ba4509796604ce49c20871b2a4ca7e0488\", \"blink_unittests\": \"a0858d06eae555eddeef6745d360d4258bbd5185\", \"boringssl_crypto_tests\": \"1db2b349a277f225470ae8538b51745c0b872c44\", \"boringssl_ssl_tests\": \"4b455509ebd45e8e5929ae7cd12bc84498e14b92\", \"browser_switcher_bho_unittests\": \"23d0adf17f2aada7b0533effa3772dc1c7cd5dd1\", \"browser_tests\": \"23548ddf9ce73b62906b24fbe9e6d69dd28810de\", \"capture_unittests\": \"fa5ad4f64dc3b2ad1dd52ea6446e174c4d096de5\", \"cast_unittests\": \"1afe45b1d621bc4cbad4036fac787d436f5f059f\", \"cc_unittests\": \"4f8af1dd40fa17d41a15c8d5fb72513c10b0b063\", \"chrome_app_unittests\": \"a95b9e6422671e9613a02407e2d02c2d122a3eff\", \"chrome_cleaner_unittests\": \"b58cdc638fe7c7ece22cbdc8ac268d5955352314\", \"chrome_elf_unittests\": \"19047c1cc1b3ead9a1e2dae862de6aec2567eec7\", \"chromedriver_unittests\": \"3c75da9d7001603a0ad44d7054b8757868d08f6b\", \"color_unittests\": \"7a246754c7dad02eb60ca95820bf3329bfb25050\", \"components_browsertests\": \"00270e444d8b4b383be19b14cba8e73ca27af19d\", \"components_unittests\": \"f5f071f6eb30bb0b702494836846ba619837eba7\", \"compositor_unittests\": \"9febff09470d85b6f375af589623b9427c18cb33\", \"content_browsertests\": \"65398952d105db8d3972ff89d6883f20e2595e5d\", \"content_unittests\": \"9500e74f5b2f8ccaeb911432ec5fc436ed00fca4\", \"courgette_unittests\": \"f80234192cf3ede66a1e512bf557a12ab7213d12\", \"crashpad_tests\": \"c7231ae3dfd3dd238b2c2e8139ab2372d83d66e1\", \"cronet_tests\": \"41d9952e7111a84c68fa7d898a174b31847c74c3\", \"cronet_unittests\": \"8e53817375369c3bdc380e3f6991df5f8b47a5ad\", \"crypto_unittests\": \"0bf98237cc7deafd15ab42478590a7894cd075df\", \"delayloads_unittests\": \"73ba983503c3f07470fff438ab0d06219908645b\", \"device_unittests\": \"430c82695a2116e285f23f73ff2946663bbc2b52\", \"display_unittests\": \"4f77d56d3cfa2649d74cd248741568a480f7616b\", \"elevation_service_unittests\": \"d3354f512a131f0a02b96d57a8630d4a6c2166d0\", \"events_unittests\": \"d5031348597f62a0e6483870143b93e344dfb8be\", \"extensions_browsertests\": \"72a5f5efce5e330ba3629ec82b37282c1ee5598f\", \"extensions_unittests\": \"64c6d39d8f51c7928e4832a84f73b422111f970c\", \"filesystem_service_unittests\": \"6d964cfb82879ac90a5dd1b62e61a87bd007132d\", \"gcm_unit_tests\": \"be080ffa5fe7b9331026ab3337f111361263403d\", \"gcp_unittests\": \"25dae42074c2d4e169e91b3105c14e5c3f06b53f\", \"gfx_unittests\": \"47dbc6d0a6c4b834764bda2a8bfcda4123fab30f\", \"gin_unittests\": \"cc28200e28ded3c648f10f9f924e8a88287d5d03\", \"google_apis_unittests\": \"96a849b45c770a8430b0d3c61bd0a2e9564ab4b5\", \"gpu_unittests\": \"d8f043ef24932777ecfd037ca2ae1da174291756\", \"gwp_asan_unittests\": \"965a7c865ebb1d6ad6136abe93f1b2640dbe5395\", \"headless_browsertests\": \"109ab06da1c0957e9f99b362b3c976c5dc07bd89\", \"headless_unittests\": \"2f808b6d94e66967935c8a163722ea2922946965\", \"install_static_unittests\": \"a070a02c64216f29af5d30c33956763bd0566556\", \"installer_util_unittests\": \"5813a558c6edb3f2ed4830798e5750edf64dc416\", \"interactive_ui_tests\": \"fff5b7565e142621ba42a32435d8536cbd434074\", \"ipc_tests\": \"81b33e229d97aec8fb72d5afe06d9eb8e01228d1\", \"jingle_unittests\": \"ae64d70ee1ab351a3353ea485e24b7e613ec83bb\", \"latency_unittests\": \"41e037f304501fcbfa194f921d45e691b7a75dac\", \"libjingle_xmpp_unittests\": \"9982dfba97d08a7600a93ad778e45ab0be855303\", \"liburlpattern_unittests\": \"e10246ac2e6aaa8a230f652ebe491d544a071f80\", \"media_blink_unittests\": \"d26d8eac38362447aa7611a2f57dd34e01f83016\", \"media_unittests\": \"13baa452e1963bfcc86caa2b869267fa3b21295f\", \"message_center_unittests\": \"27beef4f664819476a220ff138b1f1fb61e61c82\", \"midi_unittests\": \"85d7e8078dd606e925bde7a084bc1f747738534a\", \"mojo_core_unittests\": \"516ca01144ad9ed574bea207b013cfef0ac6b560\", \"mojo_unittests\": \"ef5ca16bcaf7be3a6ccfbfd66f97c7ed33b267be\", \"nacl_loader_unittests\": \"c6128cae79e1afcd7d6fb607be0ad2929943d052\", \"native_theme_unittests\": \"f7d21a9316df0847656482f3b75a870b20fad772\", \"net_unittests\": \"eeeb35ecaa62a884822e2f52d5266640aa191f2b\", \"notification_helper_unittests\": \"3cd10ee405e6cc72f761ac5102a05c2364528c03\", \"pdf_unittests\": \"b2d94c61f0788fb28b5375e6b8529ebb096ef51f\", \"perfetto_unittests\": \"89bedcd0ae73dee8ffd8f1590b678bcb164d18ea\", \"ppapi_unittests\": \"63e9e42d0680d685009149fd8ddea94b9bf72031\", \"printing_unittests\": \"33aada7f675780bf5725295a2183782c064648ea\", \"remoting_unittests\": \"92efcdddfb4703431fd66d4e0b6d166374aa70dc\", \"sbox_integration_tests\": \"8d2aab4d7870476c7f446175d0cdc43fa3575e05\", \"sbox_unittests\": \"271598a80fbad47bbca126a6f6bc323d6d3159f0\", \"sbox_validation_tests\": \"08eac390cdceac0b7e7994f37eaa9c80fe16c962\", \"service_manager_unittests\": \"f99716a4a6d142e7cdb0da4766559871003555e6\", \"services_unittests\": \"57bff9ff6b6bd1c86152339675b3bd683165c017\", \"setup_unittests\": \"507e702e9a9b1171695ad290e1d0cfba8264fec4\", \"shell_dialogs_unittests\": \"f0dc51e14ff09841c25351fa4834cfe0f29440b3\", \"skia_unittests\": \"431ccd5ac1a9d3cad5b4a23f2d7693eb7c350f7c\", \"snapshot_unittests\": \"b052a3e12e2dc0a03f22451d2929da98bdbc083e\", \"sql_unittests\": \"e44c13ce5dcdd92e6e815d4743b432751cb74604\", \"storage_unittests\": \"60d9a475b6097a74df0b15067ec049174e6e3731\", \"sync_integration_tests\": \"39ffe68d76dbb0ac29ac665f94125b1e37eb9c26\", \"traffic_annotation_auditor_unittests\": \"a6be37febcecee9ad27cda589b6d8d6404feb167\", \"ui_base_unittests\": \"259a072cce7773970e435c2d0d653026edb63f30\", \"ui_touch_selection_unittests\": \"1e2d399c7609be72df564492dd2585ffe5f87317\", \"unit_tests\": \"4ce670d5fef8235d8efd8614b78ddfcb97fecb2e\", \"updater_tests\": \"a6f559a9769a7ebef9c162c26e31dc4d77b30c07\", \"url_unittests\": \"adb500f966f59ee09c14a7bf2a0f0e35b13be56c\", \"views_unittests\": \"e4a648580fb0ae83645b97d207de38cfaad46ba8\", \"viz_unittests\": \"699df44f0e58686c2f28a8853a9612c0f6e85842\", \"vr_common_unittests\": \"718641252bbe1caa9c1480b5c8f95c6045bfb900\", \"vr_pixeltests\": \"242ac3cbadf5d72b3eb7cb9cb38c0f96021bc2ec\", \"weblayer_browsertests\": \"d57d977e713edaf9087c38a5a7a80a6e17f77b38\", \"weblayer_unittests\": \"de11432031b934046c70cdcce5a582e0277478bf\", \"wm_unittests\": \"2f8f853461967c74a527589e557e3f9205d99b6d\", \"wtf_unittests\": \"cbd2671622c54a621e05c514b1ca08e477482d51\", \"zlib_unittests\": \"76c98bf244f6adeea5fa8cea310119a817f184d5\", \"zucchini_unittests\": \"c6cace64781a98d8eb8cf11982848ca6af607fc1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"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-qhp0\"], \"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\": [\"5725-1a0d85e\"], \"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": "1614705648216464",
"status": "COMPLETED",
"status_changed_ts": "1614712152936734",
"tags": [
"build_address:luci.chromium.ci/win-asan/17595",
"builder:win-asan",
"buildset:commit/git/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33685a1e6fa0cc4e2288f7cf8f5b86c69fe7f4d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019282368899778064",
"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/8853852306833407728/+/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:520cc3cce2153b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614712152941143",
"url": "https://ci.chromium.org/b/8853852306833407728",
"utcnow_ts": "1614712153518035"
}
}
[19:09:13.525] Invocation finished in 1h51m18.953721168s with status SUCCEEDED