[00:21:18.203] New invocation is queued and will start shortly
[00:21:19.361] Starting the invocation (attempt 1)
[00:21:19.400] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:21:19.401] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:21:19.401] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029583785448356208",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029583785448356208",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"gitiles_ref:refs/heads/master"
]
}
[00:21:20.271] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604881279522603",
"id": "8864153723402071296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604881280132132",
"tags": [
"build_address:luci.chromium.ci/win-asan/15541",
"builder:win-asan",
"buildset:commit/git/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029583785448356208",
"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/8864153723402071296/+/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": "1604881280132295",
"url": "https://ci.chromium.org/b/8864153723402071296",
"utcnow_ts": "1604881280248981"
}
}
[00:21:20.271] Task URL: https://ci.chromium.org/b/8864153723402071296
[00:21:20.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:2:0) after 1m0s
[00:22:20.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:2:0)
[00:22:20.339] Timer tick, asking Buildbucket for the build status
[00:22:20.437] Build 8864153723402071296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:20.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:3:0) after 1m0s
[00:23:20.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:3:0)
[00:23:20.633] Timer tick, asking Buildbucket for the build status
[00:23:20.805] Build 8864153723402071296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:20.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:4:0) after 1m0s
[00:24:21.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:4:0)
[00:24:21.293] Timer tick, asking Buildbucket for the build status
[00:24:21.406] Build 8864153723402071296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:21.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:5:0) after 1m0s
[00:25:21.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:5:0)
[00:25:21.592] Timer tick, asking Buildbucket for the build status
[00:25:21.690] Build 8864153723402071296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:21.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:6:0) after 1m0s
[00:26:02.228] Received PubSub notification, asking Buildbucket for the build status
[00:26:02.302] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:21.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:6:0)
[00:26:21.772] Timer tick, asking Buildbucket for the build status
[00:26:21.911] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:21.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:8:0) after 1m0s
[00:27:21.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:8:0)
[00:27:21.934] Timer tick, asking Buildbucket for the build status
[00:27:22.244] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:22.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:9:0) after 1m0s
[00:28:22.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:9:0)
[00:28:22.410] Timer tick, asking Buildbucket for the build status
[00:28:22.546] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:22.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:10:0) after 1m0s
[00:29:22.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:10:0)
[00:29:22.657] Timer tick, asking Buildbucket for the build status
[00:29:22.719] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:22.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:11:0) after 1m0s
[00:30:24.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:11:0)
[00:30:24.174] Timer tick, asking Buildbucket for the build status
[00:30:24.451] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:24.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:12:0) after 1m0s
[00:31:24.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:12:0)
[00:31:24.670] Timer tick, asking Buildbucket for the build status
[00:31:24.951] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:24.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:13:0) after 1m0s
[00:32:25.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:13:0)
[00:32:25.079] Timer tick, asking Buildbucket for the build status
[00:32:25.331] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:14:0) after 1m0s
[00:33:25.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:14:0)
[00:33:25.467] Timer tick, asking Buildbucket for the build status
[00:33:25.547] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:25.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:15:0) after 1m0s
[00:34:25.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:15:0)
[00:34:25.674] Timer tick, asking Buildbucket for the build status
[00:34:25.990] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:25.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:16:0) after 1m0s
[00:35:26.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:16:0)
[00:35:26.278] Timer tick, asking Buildbucket for the build status
[00:35:26.353] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:17:0) after 1m0s
[00:36:26.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:17:0)
[00:36:26.579] Timer tick, asking Buildbucket for the build status
[00:36:26.736] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:26.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:18:0) after 1m0s
[00:37:27.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:18:0)
[00:37:27.480] Timer tick, asking Buildbucket for the build status
[00:37:27.581] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:27.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:19:0) after 1m0s
[00:38:27.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:19:0)
[00:38:27.883] Timer tick, asking Buildbucket for the build status
[00:38:28.205] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:28.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:20:0) after 1m0s
[00:39:28.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:20:0)
[00:39:28.234] Timer tick, asking Buildbucket for the build status
[00:39:28.424] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:28.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:21:0) after 1m0s
[00:40:28.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:21:0)
[00:40:28.569] Timer tick, asking Buildbucket for the build status
[00:40:29.005] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:29.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:22:0) after 1m0s
[00:41:29.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:22:0)
[00:41:29.232] Timer tick, asking Buildbucket for the build status
[00:41:29.727] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:23:0) after 1m0s
[00:42:30.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:23:0)
[00:42:30.085] Timer tick, asking Buildbucket for the build status
[00:42:30.211] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:30.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:24:0) after 1m0s
[00:43:30.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:24:0)
[00:43:30.328] Timer tick, asking Buildbucket for the build status
[00:43:30.409] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:30.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:25:0) after 1m0s
[00:44:30.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:25:0)
[00:44:30.501] Timer tick, asking Buildbucket for the build status
[00:44:30.566] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:30.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:26:0) after 1m0s
[00:45:30.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:26:0)
[00:45:30.628] Timer tick, asking Buildbucket for the build status
[00:45:30.895] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:30.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:27:0) after 1m0s
[00:46:30.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:27:0)
[00:46:30.986] Timer tick, asking Buildbucket for the build status
[00:46:31.097] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:31.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:28:0) after 1m0s
[00:47:31.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:28:0)
[00:47:31.167] Timer tick, asking Buildbucket for the build status
[00:47:31.271] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:31.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:29:0) after 1m0s
[00:48:31.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:29:0)
[00:48:31.324] Timer tick, asking Buildbucket for the build status
[00:48:31.400] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:31.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:30:0) after 1m0s
[00:49:31.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:30:0)
[00:49:31.515] Timer tick, asking Buildbucket for the build status
[00:49:31.669] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:31:0) after 1m0s
[00:50:31.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:31:0)
[00:50:31.711] Timer tick, asking Buildbucket for the build status
[00:50:31.863] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:31.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:32:0) after 1m0s
[00:51:32.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:32:0)
[00:51:32.001] Timer tick, asking Buildbucket for the build status
[00:51:32.121] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:32.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:33:0) after 1m0s
[00:52:32.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:33:0)
[00:52:32.210] Timer tick, asking Buildbucket for the build status
[00:52:32.533] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:32.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:34:0) after 1m0s
[00:53:32.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:34:0)
[00:53:32.577] Timer tick, asking Buildbucket for the build status
[00:53:32.656] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:32.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:35:0) after 1m0s
[00:54:32.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:35:0)
[00:54:32.825] Timer tick, asking Buildbucket for the build status
[00:54:32.888] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:36:0) after 1m0s
[00:55:32.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:36:0)
[00:55:32.947] Timer tick, asking Buildbucket for the build status
[00:55:33.161] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:33.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:37:0) after 1m0s
[00:56:33.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:37:0)
[00:56:33.232] Timer tick, asking Buildbucket for the build status
[00:56:33.365] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:33.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:38:0) after 1m0s
[00:57:33.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:38:0)
[00:57:33.414] Timer tick, asking Buildbucket for the build status
[00:57:33.488] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:33.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:39:0) after 1m0s
[00:58:33.940] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:39:0)
[00:58:33.940] Timer tick, asking Buildbucket for the build status
[00:58:34.343] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:40:0) after 1m0s
[00:59:34.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:40:0)
[00:59:34.566] Timer tick, asking Buildbucket for the build status
[00:59:34.640] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:41:0) after 1m0s
[01:00:34.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:41:0)
[01:00:34.735] Timer tick, asking Buildbucket for the build status
[01:00:34.875] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:34.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:42:0) after 1m0s
[01:01:34.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:42:0)
[01:01:34.936] Timer tick, asking Buildbucket for the build status
[01:01:35.040] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:43:0) after 1m0s
[01:02:35.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:43:0)
[01:02:35.216] Timer tick, asking Buildbucket for the build status
[01:02:37.404] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:37.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:44:0) after 1m0s
[01:03:37.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:44:0)
[01:03:37.642] Timer tick, asking Buildbucket for the build status
[01:03:37.710] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:37.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:45:0) after 1m0s
[01:04:37.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:45:0)
[01:04:37.850] Timer tick, asking Buildbucket for the build status
[01:04:37.944] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:37.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:46:0) after 1m0s
[01:05:38.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:46:0)
[01:05:38.157] Timer tick, asking Buildbucket for the build status
[01:05:38.324] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:38.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:47:0) after 1m0s
[01:06:38.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:47:0)
[01:06:38.519] Timer tick, asking Buildbucket for the build status
[01:06:38.639] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:38.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:48:0) after 1m0s
[01:07:38.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:48:0)
[01:07:38.732] Timer tick, asking Buildbucket for the build status
[01:07:38.813] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:38.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:49:0) after 1m0s
[01:08:38.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:49:0)
[01:08:38.939] Timer tick, asking Buildbucket for the build status
[01:08:39.143] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:39.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:50:0) after 1m0s
[01:09:39.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:50:0)
[01:09:39.178] Timer tick, asking Buildbucket for the build status
[01:09:39.749] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:39.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:51:0) after 1m0s
[01:10:39.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:51:0)
[01:10:39.740] Timer tick, asking Buildbucket for the build status
[01:10:39.852] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:39.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:52:0) after 1m0s
[01:11:39.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:52:0)
[01:11:39.878] Timer tick, asking Buildbucket for the build status
[01:11:40.198] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:40.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:53:0) after 1m0s
[01:12:40.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:53:0)
[01:12:40.312] Timer tick, asking Buildbucket for the build status
[01:12:41.191] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:41.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:54:0) after 1m0s
[01:13:41.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:54:0)
[01:13:41.230] Timer tick, asking Buildbucket for the build status
[01:13:41.395] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:41.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:55:0) after 1m0s
[01:14:41.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:55:0)
[01:14:41.570] Timer tick, asking Buildbucket for the build status
[01:14:41.792] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:41.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:56:0) after 1m0s
[01:15:41.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:56:0)
[01:15:41.935] Timer tick, asking Buildbucket for the build status
[01:15:42.068] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:42.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:57:0) after 1m0s
[01:16:42.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:57:0)
[01:16:42.135] Timer tick, asking Buildbucket for the build status
[01:16:42.265] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:42.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:58:0) after 1m0s
[01:17:42.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:58:0)
[01:17:42.324] Timer tick, asking Buildbucket for the build status
[01:17:44.089] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:44.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:59:0) after 1m0s
[01:18:44.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:59:0)
[01:18:44.124] Timer tick, asking Buildbucket for the build status
[01:18:44.197] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:60:0) after 1m0s
[01:19:44.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:60:0)
[01:19:44.286] Timer tick, asking Buildbucket for the build status
[01:19:44.353] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:44.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:61:0) after 1m0s
[01:20:44.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:61:0)
[01:20:44.389] Timer tick, asking Buildbucket for the build status
[01:20:44.639] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:44.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:62:0) after 1m0s
[01:21:44.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:62:0)
[01:21:44.673] Timer tick, asking Buildbucket for the build status
[01:21:44.793] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:63:0) after 1m0s
[01:22:44.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:63:0)
[01:22:44.873] Timer tick, asking Buildbucket for the build status
[01:22:44.966] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:44.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:64:0) after 1m0s
[01:23:45.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:64:0)
[01:23:45.116] Timer tick, asking Buildbucket for the build status
[01:23:45.195] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:45.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:65:0) after 1m0s
[01:24:45.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:65:0)
[01:24:45.211] Timer tick, asking Buildbucket for the build status
[01:24:45.407] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:45.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:66:0) after 1m0s
[01:25:45.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:66:0)
[01:25:45.436] Timer tick, asking Buildbucket for the build status
[01:25:45.509] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:45.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:67:0) after 1m0s
[01:26:45.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:67:0)
[01:26:45.537] Timer tick, asking Buildbucket for the build status
[01:26:45.645] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:45.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:68:0) after 1m0s
[01:27:45.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:68:0)
[01:27:45.679] Timer tick, asking Buildbucket for the build status
[01:27:47.129] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:47.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:69:0) after 1m0s
[01:28:47.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:69:0)
[01:28:47.191] Timer tick, asking Buildbucket for the build status
[01:28:47.326] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:47.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:70:0) after 1m0s
[01:29:47.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:70:0)
[01:29:47.339] Timer tick, asking Buildbucket for the build status
[01:29:47.444] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:47.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:71:0) after 1m0s
[01:30:47.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:71:0)
[01:30:47.524] Timer tick, asking Buildbucket for the build status
[01:30:47.673] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:47.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:72:0) after 1m0s
[01:31:47.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:72:0)
[01:31:47.701] Timer tick, asking Buildbucket for the build status
[01:31:47.812] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:47.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:73:0) after 1m0s
[01:32:47.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:73:0)
[01:32:47.834] Timer tick, asking Buildbucket for the build status
[01:32:47.999] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:47.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:74:0) after 1m0s
[01:33:48.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:74:0)
[01:33:48.046] Timer tick, asking Buildbucket for the build status
[01:33:49.387] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:75:0) after 1m0s
[01:34:49.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:75:0)
[01:34:49.453] Timer tick, asking Buildbucket for the build status
[01:34:50.094] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:50.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:76:0) after 1m0s
[01:35:50.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:76:0)
[01:35:50.214] Timer tick, asking Buildbucket for the build status
[01:35:50.323] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:50.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:77:0) after 1m0s
[01:36:50.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:77:0)
[01:36:50.407] Timer tick, asking Buildbucket for the build status
[01:36:50.524] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:50.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:78:0) after 1m0s
[01:37:50.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:78:0)
[01:37:50.551] Timer tick, asking Buildbucket for the build status
[01:37:50.621] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:50.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:79:0) after 1m0s
[01:38:50.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:79:0)
[01:38:50.666] Timer tick, asking Buildbucket for the build status
[01:38:50.739] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:50.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:80:0) after 1m0s
[01:39:50.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:80:0)
[01:39:50.737] Timer tick, asking Buildbucket for the build status
[01:39:51.099] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:51.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:81:0) after 1m0s
[01:40:51.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:81:0)
[01:40:51.202] Timer tick, asking Buildbucket for the build status
[01:40:51.320] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:51.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:82:0) after 1m0s
[01:41:51.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:82:0)
[01:41:51.373] Timer tick, asking Buildbucket for the build status
[01:41:51.463] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:51.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:83:0) after 1m0s
[01:42:51.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:83:0)
[01:42:51.525] Timer tick, asking Buildbucket for the build status
[01:42:51.603] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:51.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:84:0) after 1m0s
[01:43:51.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:84:0)
[01:43:51.650] Timer tick, asking Buildbucket for the build status
[01:43:51.760] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:51.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:85:0) after 1m0s
[01:44:51.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:85:0)
[01:44:51.826] Timer tick, asking Buildbucket for the build status
[01:44:52.166] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:52.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:86:0) after 1m0s
[01:45:52.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:86:0)
[01:45:52.225] Timer tick, asking Buildbucket for the build status
[01:45:52.384] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:52.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:87:0) after 1m0s
[01:46:52.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:87:0)
[01:46:52.410] Timer tick, asking Buildbucket for the build status
[01:46:52.555] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:52.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:88:0) after 1m0s
[01:47:52.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:88:0)
[01:47:52.615] Timer tick, asking Buildbucket for the build status
[01:47:52.699] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:52.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:89:0) after 1m0s
[01:48:52.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:89:0)
[01:48:52.794] Timer tick, asking Buildbucket for the build status
[01:48:53.065] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:53.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:90:0) after 1m0s
[01:49:53.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:90:0)
[01:49:53.126] Timer tick, asking Buildbucket for the build status
[01:49:53.193] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:53.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:91:0) after 1m0s
[01:50:53.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:91:0)
[01:50:53.233] Timer tick, asking Buildbucket for the build status
[01:50:53.332] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:53.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:92:0) after 1m0s
[01:51:53.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:92:0)
[01:51:53.409] Timer tick, asking Buildbucket for the build status
[01:51:53.533] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:53.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:93:0) after 1m0s
[01:52:53.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:93:0)
[01:52:53.594] Timer tick, asking Buildbucket for the build status
[01:52:53.895] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:53.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:94:0) after 1m0s
[01:53:53.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:94:0)
[01:53:53.924] Timer tick, asking Buildbucket for the build status
[01:53:54.006] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:54.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:95:0) after 1m0s
[01:54:54.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:95:0)
[01:54:54.079] Timer tick, asking Buildbucket for the build status
[01:54:54.200] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:54.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:96:0) after 1m0s
[01:55:54.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:96:0)
[01:55:54.303] Timer tick, asking Buildbucket for the build status
[01:55:54.407] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:54.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:97:0) after 1m0s
[01:56:54.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:97:0)
[01:56:54.484] Timer tick, asking Buildbucket for the build status
[01:56:54.614] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:54.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:98:0) after 1m0s
[01:57:54.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:98:0)
[01:57:54.715] Timer tick, asking Buildbucket for the build status
[01:57:54.868] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:54.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:99:0) after 1m0s
[01:58:54.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:99:0)
[01:58:54.966] Timer tick, asking Buildbucket for the build status
[01:58:55.152] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:55.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:100:0) after 1m0s
[01:59:55.297] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:100:0)
[01:59:55.297] Timer tick, asking Buildbucket for the build status
[01:59:55.376] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:55.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:101:0) after 1m0s
[02:00:55.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:101:0)
[02:00:55.508] Timer tick, asking Buildbucket for the build status
[02:00:55.580] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:55.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:102:0) after 1m0s
[02:01:55.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:102:0)
[02:01:55.666] Timer tick, asking Buildbucket for the build status
[02:01:55.764] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:55.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:103:0) after 1m0s
[02:02:55.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:103:0)
[02:02:55.933] Timer tick, asking Buildbucket for the build status
[02:02:56.013] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:56.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:104:0) after 1m0s
[02:03:56.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:104:0)
[02:03:56.292] Timer tick, asking Buildbucket for the build status
[02:03:56.617] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:56.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:105:0) after 1m0s
[02:04:56.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:105:0)
[02:04:56.671] Timer tick, asking Buildbucket for the build status
[02:04:56.909] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:56.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:106:0) after 1m0s
[02:05:56.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:106:0)
[02:05:56.963] Timer tick, asking Buildbucket for the build status
[02:05:57.043] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:57.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:107:0) after 1m0s
[02:06:57.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:107:0)
[02:06:57.129] Timer tick, asking Buildbucket for the build status
[02:06:57.636] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:57.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:108:0) after 1m0s
[02:07:57.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:108:0)
[02:07:57.664] Timer tick, asking Buildbucket for the build status
[02:07:58.082] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:58.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:109:0) after 1m0s
[02:08:59.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:109:0)
[02:08:59.306] Timer tick, asking Buildbucket for the build status
[02:08:59.386] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:59.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:110:0) after 1m0s
[02:09:59.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:110:0)
[02:09:59.664] Timer tick, asking Buildbucket for the build status
[02:09:59.929] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:59.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:111:0) after 1m0s
[02:11:00.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:111:0)
[02:11:00.049] Timer tick, asking Buildbucket for the build status
[02:11:00.338] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:112:0) after 1m0s
[02:12:00.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:112:0)
[02:12:00.520] Timer tick, asking Buildbucket for the build status
[02:12:00.640] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:113:0) after 1m0s
[02:13:01.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:113:0)
[02:13:01.104] Timer tick, asking Buildbucket for the build status
[02:13:01.424] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:01.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:114:0) after 1m0s
[02:14:01.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:114:0)
[02:14:01.665] Timer tick, asking Buildbucket for the build status
[02:14:01.816] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:01.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:115:0) after 1m0s
[02:15:02.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:115:0)
[02:15:02.097] Timer tick, asking Buildbucket for the build status
[02:15:02.294] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:02.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:116:0) after 1m0s
[02:16:02.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:116:0)
[02:16:02.563] Timer tick, asking Buildbucket for the build status
[02:16:02.675] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:02.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:117:0) after 1m0s
[02:17:02.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:117:0)
[02:17:02.751] Timer tick, asking Buildbucket for the build status
[02:17:02.870] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:02.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:118:0) after 1m0s
[02:18:02.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:118:0)
[02:18:02.978] Timer tick, asking Buildbucket for the build status
[02:18:03.318] Build 8864153723402071296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:03.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029583785448356208:119:0) after 1m0s
[02:18:50.859] Received PubSub notification, asking Buildbucket for the build status
[02:18:51.097] Build 8864153723402071296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:18:51.097] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604888329986121",
"created_by": "project:chromium",
"created_ts": "1604881279522603",
"id": "8864153723402071296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\"}}",
"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\": \"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\", \"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-8-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15541, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"aca3d408105d03683edd20b98b333c5064ac5254\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\", \"got_revision_cp\": \"refs/heads/master@{#825228}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"3f2e747a52cb3a8d0d47f602934c10cb309f29ae\", \"swarm_hashes_refs/heads/master(at){#825228}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"56ba679ce88d0be77eabd093b223be7b579fc489\", \"angle_unittests\": \"843343f44f056a64589b8f2b0112ea02581e06d7\", \"app_shell_unittests\": \"7bf77f805d65230fc06440ee7933e601498b2717\", \"aura_unittests\": \"c1b4210faea74962145c8864d53bfa3cfdc87814\", \"base_unittests\": \"745e5bd5e236ac1f16e148a951102592e8023748\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"569e9aa002b113f6d3b993fb1974a20f87259df9\", \"blink_fuzzer_unittests\": \"dc84e1cc3a3e246553d6cab5d657b5c613ddebc1\", \"blink_heap_unittests\": \"239e86cedd9ab4c067d6312277c91ee9048adfe8\", \"blink_platform_unittests\": \"bc1ba670015b04325a7cbf8a441c597c2d20d226\", \"blink_unittests\": \"2c7d6c9f04505fcb5033cf31c101207f471e3362\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"e41b90f400fdf153a73379aa49832314d91d9332\", \"capture_unittests\": \"5d9b126b7749bfb361ac58a9917ffa565df90692\", \"cast_unittests\": \"54cbcd714324783b63ee5bcd4a56beabb133c334\", \"cc_unittests\": \"b511a196ae7e5710907e4bc80a3a3552204a75ff\", \"chrome_app_unittests\": \"e1f81700643fc14a547ef0597f283dc3b19a589f\", \"chrome_cleaner_unittests\": \"6f02c7506ff5ed2660b99eaaab50d6a55d442f97\", \"chrome_elf_unittests\": \"eabf6cc0498591be14d74239d595cadfce934014\", \"chromedriver_unittests\": \"8eb84e411750fd59e6305b6016dcc09d075d2094\", \"components_browsertests\": \"59fe4fcbe91c722b3087af112dad30b7cff1a18d\", \"components_unittests\": \"430554b0d0ec581416d65003efe39095a7a70996\", \"compositor_unittests\": \"4b36ece110fb5ff40a375f2cc2891ce7c87b83ee\", \"content_browsertests\": \"7384829b8781bdc5797340fb4b0a1631f8a2e145\", \"content_unittests\": \"326238efcb84fe44a828cc8ae29c79ff2897805f\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"1cddd2f253cb1c9683cb1e355dc51695f5fcbf54\", \"cronet_unittests\": \"30d41eaa053ad3d8fde55a5188b184a0aa13f41c\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"a306c17411e8679a87728c39907d2af7d7124077\", \"device_unittests\": \"f157ca537591fb5958ac1c87ff98a5a2c5aac381\", \"display_unittests\": \"401fd88040731a349128bdc214833fd17fcbbaa0\", \"elevation_service_unittests\": \"aae9e59651657acb17e7ff6c68e333ced9e25e72\", \"events_unittests\": \"72dd4a361d57cbfdb80550f4fed8ccfd089d224a\", \"extensions_browsertests\": \"2ceb9593b27a223a3ad665020602913934d0ddbe\", \"extensions_unittests\": \"3aa3bebe0c484ae8a57c958fca484b21acdec0a9\", \"filesystem_service_unittests\": \"f139f0c8b716b5df7ff298813e37d63ff6ba4e77\", \"gcm_unit_tests\": \"80850ff3813a3bc98aa76d6bc3b9959607d8b90e\", \"gcp_unittests\": \"4437a50e92a74cb9c062d6ae48090ed7efcd5638\", \"gfx_unittests\": \"6e71d9e385ce16dc5e32695d69974222f3b91028\", \"gin_unittests\": \"a1d6f5e5c23d9b0a34197b68aee19ac26d80fe2a\", \"google_apis_unittests\": \"a8a671f7dbeaac280b82b4bd22a3d5f6677158da\", \"gpu_unittests\": \"22a3d3f1a8dfd2434a577d130522be0a0ad1103b\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"13d1ca87f23aac71c3bdfb7dd254efd436ccaa7e\", \"headless_unittests\": \"732f517a49fe74739d1c0f5e1f43db6737be189e\", \"install_static_unittests\": \"aa6dc1d2b7d74e01dbd860b1456b65f7823b0799\", \"installer_util_unittests\": \"eb40e78c9fe4bf93640b4a4ffdd853cb0e6bb511\", \"interactive_ui_tests\": \"d3dd13bbaf892a993cba3729f15834918252bc3c\", \"ipc_tests\": \"7a60798cac1ad0bdce80ad8bd9ee8d0df1ba06fd\", \"jingle_unittests\": \"0a1cba692b5854867d936808620685f8f628c8b5\", \"latency_unittests\": \"672c3927a432bbb97aa43dc2c5d6ef7320532183\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"7e7e1caa841a877e8acb487a0b997be3c3700d5b\", \"media_unittests\": \"393e09b2e0c4512ad9fa9aa3dc001f3554723c99\", \"message_center_unittests\": \"e2c0f84a2ebaedbd5d1dea527092ac35beafdcd4\", \"midi_unittests\": \"8621620633997195d1111fbd667b87ebeb87c498\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"95ce015e64f5df0151e836f91dc1636e69bc74a3\", \"nacl_loader_unittests\": \"33cc364005b815ae1e094998baa6a7f0b03d8ce0\", \"native_theme_unittests\": \"5f51251053eb21a375dac2e0f2432c49d68c1693\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"d7ae2dcbc0d75e4ae17160c36e2a56d427e70cd4\", \"pdf_unittests\": \"accb3a78f86f06836e18d5ed29afd7fc7c657985\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"9ee3d3c544582f8effce61aa035648c7d9efb218\", \"printing_unittests\": \"0911226c12cc0e99f46e805ed9ccd5ac01699d90\", \"remoting_unittests\": \"2d3605ef91f9d85d51171d92c5319efa67657f01\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"06d00b135e5635592f7e3d87058865b013133b53\", \"services_unittests\": \"8bcb54de4e2a9ded5e55f94d543decae2efc44cc\", \"setup_unittests\": \"6a0304bcb57550b2b29e591ac5ef64489eb95041\", \"shell_dialogs_unittests\": \"6a28b2a26889bedf7b583357072f8cec415a35e3\", \"skia_unittests\": \"f8628a8bc7336868ec4eb98610fd843128dc8d99\", \"snapshot_unittests\": \"07553e5e3006974c9a03b771fabf6a184e8c9f63\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"532c08c1095dc8ce8907db924e839ebff6a80e21\", \"sync_integration_tests\": \"ee1d01982cfa762fb6378eb3a395ae51c72534e6\", \"traffic_annotation_auditor_unittests\": \"db0a9e56cbb2b880aa6d40f34f96ae0da844ae7d\", \"ui_base_unittests\": \"ca4e97847f906b79906dd822f463153cd4b68ff7\", \"ui_touch_selection_unittests\": \"d9af223cbd83b20993807133f405a2815d04d71e\", \"unit_tests\": \"063dffaaa578a7a24fb822f3d4af9b488fbc26e6\", \"updater_tests\": \"7c122489cf41ba2db176a409bc5540efd5e8d97a\", \"url_unittests\": \"60636c3cd4eb903c4a54ecd769c80ddabbaa3667\", \"views_unittests\": \"a6ab071c11a1c444296cf09ff7b9a0d713ea1aa4\", \"viz_unittests\": \"07a4343de8404ee8bf4d6adde506169985b8463e\", \"vr_common_unittests\": \"6251e214197675ed0844f1c927000e3eee1da154\", \"vr_pixeltests\": \"f7d999406527247615a62f696864bf4c9fbd20d3\", \"weblayer_browsertests\": \"86fbcb44e3038312328a2fc800ec389fb2ca2341\", \"weblayer_unittests\": \"b6309a5edfeb5240ae1aca8b0a8aea8e19bb5bed\", \"wm_unittests\": \"b5843a6a02379ff1361be2c1522a02e5ad5d324e\", \"wtf_unittests\": \"394c61a366e86148ee87ce423bbbd4a69070e7e0\", \"zlib_unittests\": \"bc7f273c31debe9eb6780e640a2fbb01b16af2c3\", \"zucchini_unittests\": \"5de14c85af81babf49e0bce99fe4377d874c60df\"}}, \"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-8-b9eu\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5614-d862eaa\"], \"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": "1604881561406589",
"status": "COMPLETED",
"status_changed_ts": "1604888330360917",
"tags": [
"build_address:luci.chromium.ci/win-asan/15541",
"builder:win-asan",
"buildset:commit/git/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f2e747a52cb3a8d0d47f602934c10cb309f29ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029583785448356208",
"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/8864153723402071296/+/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:4fc33278cfb0b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604888330368072",
"url": "https://ci.chromium.org/b/8864153723402071296",
"utcnow_ts": "1604888331086746"
}
}
[02:18:51.097] Invocation finished in 1h57m32.909525948s with status SUCCEEDED