[00:37:44.203] New invocation is queued and will start shortly
[00:37:45.266] Starting the invocation (attempt 1)
[00:37:45.310] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:37:45.310] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:37:45.310] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022244397272626560",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022244397272626560",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"gitiles_ref:refs/heads/master"
]
}
[00:37:46.024] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611880665397052",
"id": "8856814335358492096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611880665876382",
"tags": [
"build_address:luci.chromium.ci/win-asan/17058",
"builder:win-asan",
"buildset:commit/git/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022244397272626560",
"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/8856814335358492096/+/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": "1611880665876518",
"url": "https://ci.chromium.org/b/8856814335358492096",
"utcnow_ts": "1611880665997658"
}
}
[00:37:46.024] Task URL: https://ci.chromium.org/b/8856814335358492096
[00:37:46.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:2:0) after 1m0s
[00:38:46.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:2:0)
[00:38:46.036] Timer tick, asking Buildbucket for the build status
[00:38:46.512] Build 8856814335358492096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:46.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:3:0) after 1m0s
[00:39:46.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:3:0)
[00:39:46.513] Timer tick, asking Buildbucket for the build status
[00:39:46.623] Build 8856814335358492096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:4:0) after 1m0s
[00:40:42.831] Received PubSub notification, asking Buildbucket for the build status
[00:40:43.077] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:46.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:4:0)
[00:40:46.652] Timer tick, asking Buildbucket for the build status
[00:40:46.817] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:46.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:6:0) after 1m0s
[00:41:46.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:6:0)
[00:41:46.846] Timer tick, asking Buildbucket for the build status
[00:41:46.953] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:46.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:7:0) after 1m0s
[00:42:47.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:7:0)
[00:42:47.002] Timer tick, asking Buildbucket for the build status
[00:42:47.095] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:47.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:8:0) after 1m0s
[00:43:47.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:8:0)
[00:43:47.131] Timer tick, asking Buildbucket for the build status
[00:43:47.704] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:47.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:9:0) after 1m0s
[00:44:47.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:9:0)
[00:44:47.805] Timer tick, asking Buildbucket for the build status
[00:44:47.874] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:10:0) after 1m0s
[00:45:47.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:10:0)
[00:45:47.897] Timer tick, asking Buildbucket for the build status
[00:45:47.970] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:47.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:11:0) after 1m0s
[00:46:47.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:11:0)
[00:46:47.994] Timer tick, asking Buildbucket for the build status
[00:46:48.074] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:48.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:12:0) after 1m0s
[00:47:48.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:12:0)
[00:47:48.128] Timer tick, asking Buildbucket for the build status
[00:47:48.275] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:13:0) after 1m0s
[00:48:48.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:13:0)
[00:48:48.536] Timer tick, asking Buildbucket for the build status
[00:48:49.025] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:49.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:14:0) after 1m0s
[00:49:49.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:14:0)
[00:49:49.204] Timer tick, asking Buildbucket for the build status
[00:49:49.313] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:49.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:15:0) after 1m0s
[00:50:49.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:15:0)
[00:50:49.416] Timer tick, asking Buildbucket for the build status
[00:50:49.529] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:49.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:16:0) after 1m0s
[00:51:49.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:16:0)
[00:51:49.716] Timer tick, asking Buildbucket for the build status
[00:51:49.837] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:17:0) after 1m0s
[00:52:49.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:17:0)
[00:52:49.966] Timer tick, asking Buildbucket for the build status
[00:52:50.371] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:50.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:18:0) after 1m0s
[00:53:50.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:18:0)
[00:53:50.401] Timer tick, asking Buildbucket for the build status
[00:53:50.823] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:19:0) after 1m0s
[00:54:50.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:19:0)
[00:54:50.917] Timer tick, asking Buildbucket for the build status
[00:54:51.008] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:51.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:20:0) after 1m0s
[00:55:51.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:20:0)
[00:55:51.023] Timer tick, asking Buildbucket for the build status
[00:55:51.500] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:51.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:21:0) after 1m0s
[00:56:51.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:21:0)
[00:56:51.599] Timer tick, asking Buildbucket for the build status
[00:56:51.710] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:51.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:22:0) after 1m0s
[00:57:51.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:22:0)
[00:57:51.791] Timer tick, asking Buildbucket for the build status
[00:57:52.069] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:52.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:23:0) after 1m0s
[00:58:52.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:23:0)
[00:58:52.104] Timer tick, asking Buildbucket for the build status
[00:58:52.183] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:52.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:24:0) after 1m0s
[00:59:52.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:24:0)
[00:59:52.186] Timer tick, asking Buildbucket for the build status
[00:59:52.421] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:52.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:25:0) after 1m0s
[01:00:52.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:25:0)
[01:00:52.477] Timer tick, asking Buildbucket for the build status
[01:00:52.744] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:26:0) after 1m0s
[01:01:52.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:26:0)
[01:01:52.764] Timer tick, asking Buildbucket for the build status
[01:01:52.891] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:52.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:27:0) after 1m0s
[01:02:52.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:27:0)
[01:02:52.935] Timer tick, asking Buildbucket for the build status
[01:02:53.235] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:53.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:28:0) after 1m0s
[01:03:53.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:28:0)
[01:03:53.264] Timer tick, asking Buildbucket for the build status
[01:03:53.329] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:53.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:29:0) after 1m0s
[01:04:53.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:29:0)
[01:04:53.428] Timer tick, asking Buildbucket for the build status
[01:04:53.482] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:53.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:30:0) after 1m0s
[01:05:53.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:30:0)
[01:05:53.501] Timer tick, asking Buildbucket for the build status
[01:05:54.703] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:31:0) after 1m0s
[01:06:54.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:31:0)
[01:06:54.755] Timer tick, asking Buildbucket for the build status
[01:06:54.813] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:54.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:32:0) after 1m0s
[01:07:54.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:32:0)
[01:07:54.811] Timer tick, asking Buildbucket for the build status
[01:07:55.239] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:55.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:33:0) after 1m0s
[01:08:55.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:33:0)
[01:08:55.317] Timer tick, asking Buildbucket for the build status
[01:08:55.432] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:55.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:34:0) after 1m0s
[01:09:55.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:34:0)
[01:09:55.452] Timer tick, asking Buildbucket for the build status
[01:09:55.722] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:35:0) after 1m0s
[01:10:55.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:35:0)
[01:10:55.804] Timer tick, asking Buildbucket for the build status
[01:10:56.011] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:56.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:36:0) after 1m0s
[01:11:56.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:36:0)
[01:11:56.121] Timer tick, asking Buildbucket for the build status
[01:11:56.201] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:56.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:37:0) after 1m0s
[01:12:56.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:37:0)
[01:12:56.260] Timer tick, asking Buildbucket for the build status
[01:12:56.524] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:56.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:38:0) after 1m0s
[01:13:56.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:38:0)
[01:13:56.545] Timer tick, asking Buildbucket for the build status
[01:13:56.599] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:56.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:39:0) after 1m0s
[01:14:56.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:39:0)
[01:14:56.699] Timer tick, asking Buildbucket for the build status
[01:14:56.786] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:56.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:40:0) after 1m0s
[01:15:56.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:40:0)
[01:15:56.874] Timer tick, asking Buildbucket for the build status
[01:15:57.102] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:41:0) after 1m0s
[01:16:57.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:41:0)
[01:16:57.211] Timer tick, asking Buildbucket for the build status
[01:16:57.285] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:42:0) after 1m0s
[01:17:57.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:42:0)
[01:17:57.514] Timer tick, asking Buildbucket for the build status
[01:17:57.753] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:57.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:43:0) after 1m0s
[01:18:57.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:43:0)
[01:18:57.809] Timer tick, asking Buildbucket for the build status
[01:18:57.881] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:57.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:44:0) after 1m0s
[01:19:57.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:44:0)
[01:19:57.980] Timer tick, asking Buildbucket for the build status
[01:19:58.106] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:58.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:45:0) after 1m0s
[01:20:58.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:45:0)
[01:20:58.183] Timer tick, asking Buildbucket for the build status
[01:20:58.494] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:58.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:46:0) after 1m0s
[01:21:58.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:46:0)
[01:21:58.567] Timer tick, asking Buildbucket for the build status
[01:21:58.676] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:58.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:47:0) after 1m0s
[01:22:58.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:47:0)
[01:22:58.792] Timer tick, asking Buildbucket for the build status
[01:22:58.964] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:58.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:48:0) after 1m0s
[01:23:59.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:48:0)
[01:23:59.002] Timer tick, asking Buildbucket for the build status
[01:23:59.079] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:49:0) after 1m0s
[01:24:59.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:49:0)
[01:24:59.210] Timer tick, asking Buildbucket for the build status
[01:24:59.315] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:50:0) after 1m0s
[01:25:59.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:50:0)
[01:25:59.370] Timer tick, asking Buildbucket for the build status
[01:25:59.473] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:59.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:51:0) after 1m0s
[01:26:59.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:51:0)
[01:26:59.604] Timer tick, asking Buildbucket for the build status
[01:27:00.191] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:00.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:52:0) after 1m0s
[01:28:00.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:52:0)
[01:28:00.747] Timer tick, asking Buildbucket for the build status
[01:28:00.865] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:00.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:53:0) after 1m0s
[01:29:00.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:53:0)
[01:29:00.941] Timer tick, asking Buildbucket for the build status
[01:29:01.025] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:01.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:54:0) after 1m0s
[01:30:01.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:54:0)
[01:30:01.616] Timer tick, asking Buildbucket for the build status
[01:30:01.672] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:01.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:55:0) after 1m0s
[01:31:02.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:55:0)
[01:31:02.050] Timer tick, asking Buildbucket for the build status
[01:31:02.287] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:56:0) after 1m0s
[01:32:02.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:56:0)
[01:32:02.366] Timer tick, asking Buildbucket for the build status
[01:32:02.747] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:02.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:57:0) after 1m0s
[01:33:02.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:57:0)
[01:33:02.729] Timer tick, asking Buildbucket for the build status
[01:33:02.898] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:02.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:58:0) after 1m0s
[01:34:02.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:58:0)
[01:34:02.918] Timer tick, asking Buildbucket for the build status
[01:34:02.980] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:02.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:59:0) after 1m0s
[01:35:03.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:59:0)
[01:35:03.004] Timer tick, asking Buildbucket for the build status
[01:35:03.093] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:60:0) after 1m0s
[01:36:03.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:60:0)
[01:36:03.134] Timer tick, asking Buildbucket for the build status
[01:36:03.220] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:03.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:61:0) after 1m0s
[01:37:03.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:61:0)
[01:37:03.267] Timer tick, asking Buildbucket for the build status
[01:37:03.390] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:03.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:62:0) after 1m0s
[01:38:03.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:62:0)
[01:38:03.409] Timer tick, asking Buildbucket for the build status
[01:38:03.591] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:03.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:63:0) after 1m0s
[01:39:03.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:63:0)
[01:39:03.649] Timer tick, asking Buildbucket for the build status
[01:39:03.725] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:03.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:64:0) after 1m0s
[01:40:03.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:64:0)
[01:40:03.755] Timer tick, asking Buildbucket for the build status
[01:40:04.135] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:04.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:65:0) after 1m0s
[01:41:04.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:65:0)
[01:41:04.196] Timer tick, asking Buildbucket for the build status
[01:41:04.268] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:04.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:66:0) after 1m0s
[01:42:04.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:66:0)
[01:42:04.305] Timer tick, asking Buildbucket for the build status
[01:42:04.376] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:04.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:67:0) after 1m0s
[01:43:04.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:67:0)
[01:43:04.450] Timer tick, asking Buildbucket for the build status
[01:43:04.556] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:04.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:68:0) after 1m0s
[01:44:04.575] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:68:0)
[01:44:04.575] Timer tick, asking Buildbucket for the build status
[01:44:04.657] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:04.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:69:0) after 1m0s
[01:45:04.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:69:0)
[01:45:04.680] Timer tick, asking Buildbucket for the build status
[01:45:04.867] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:04.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:70:0) after 1m0s
[01:46:04.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:70:0)
[01:46:04.980] Timer tick, asking Buildbucket for the build status
[01:46:05.093] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:05.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:71:0) after 1m0s
[01:47:05.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:71:0)
[01:47:05.211] Timer tick, asking Buildbucket for the build status
[01:47:05.311] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:05.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:72:0) after 1m0s
[01:48:05.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:72:0)
[01:48:05.402] Timer tick, asking Buildbucket for the build status
[01:48:05.492] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:05.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:73:0) after 1m0s
[01:49:05.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:73:0)
[01:49:05.693] Timer tick, asking Buildbucket for the build status
[01:49:05.761] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:05.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:74:0) after 1m0s
[01:50:06.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:74:0)
[01:50:06.089] Timer tick, asking Buildbucket for the build status
[01:50:06.419] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:75:0) after 1m0s
[01:51:06.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:75:0)
[01:51:06.492] Timer tick, asking Buildbucket for the build status
[01:51:06.564] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:76:0) after 1m0s
[01:52:06.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:76:0)
[01:52:06.721] Timer tick, asking Buildbucket for the build status
[01:52:06.839] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:06.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:77:0) after 1m0s
[01:53:07.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:77:0)
[01:53:07.002] Timer tick, asking Buildbucket for the build status
[01:53:07.175] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:07.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:78:0) after 1m0s
[01:54:07.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:78:0)
[01:54:07.287] Timer tick, asking Buildbucket for the build status
[01:54:07.708] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:07.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:79:0) after 1m0s
[01:55:07.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:79:0)
[01:55:07.851] Timer tick, asking Buildbucket for the build status
[01:55:07.955] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:07.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:80:0) after 1m0s
[01:56:07.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:80:0)
[01:56:07.968] Timer tick, asking Buildbucket for the build status
[01:56:08.180] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:08.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:81:0) after 1m0s
[01:57:08.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:81:0)
[01:57:08.347] Timer tick, asking Buildbucket for the build status
[01:57:08.818] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:08.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:82:0) after 1m0s
[01:58:08.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:82:0)
[01:58:08.878] Timer tick, asking Buildbucket for the build status
[01:58:09.097] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:83:0) after 1m0s
[01:59:09.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:83:0)
[01:59:09.142] Timer tick, asking Buildbucket for the build status
[01:59:09.638] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:09.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:84:0) after 1m0s
[02:00:09.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:84:0)
[02:00:09.862] Timer tick, asking Buildbucket for the build status
[02:00:10.227] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:85:0) after 1m0s
[02:01:10.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:85:0)
[02:01:10.381] Timer tick, asking Buildbucket for the build status
[02:01:10.692] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:86:0) after 1m0s
[02:02:10.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:86:0)
[02:02:10.797] Timer tick, asking Buildbucket for the build status
[02:02:10.927] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:10.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:87:0) after 1m0s
[02:03:11.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:87:0)
[02:03:11.003] Timer tick, asking Buildbucket for the build status
[02:03:11.405] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:11.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:88:0) after 1m0s
[02:04:11.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:88:0)
[02:04:11.492] Timer tick, asking Buildbucket for the build status
[02:04:11.633] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:11.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:89:0) after 1m0s
[02:05:11.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:89:0)
[02:05:11.788] Timer tick, asking Buildbucket for the build status
[02:05:11.877] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:11.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:90:0) after 1m0s
[02:06:11.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:90:0)
[02:06:11.991] Timer tick, asking Buildbucket for the build status
[02:06:13.038] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:13.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:91:0) after 1m0s
[02:07:13.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:91:0)
[02:07:13.059] Timer tick, asking Buildbucket for the build status
[02:07:13.209] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:13.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:92:0) after 1m0s
[02:08:13.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:92:0)
[02:08:13.246] Timer tick, asking Buildbucket for the build status
[02:08:13.369] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:13.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:93:0) after 1m0s
[02:09:13.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:93:0)
[02:09:13.507] Timer tick, asking Buildbucket for the build status
[02:09:13.592] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:13.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:94:0) after 1m0s
[02:10:13.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:94:0)
[02:10:13.715] Timer tick, asking Buildbucket for the build status
[02:10:13.848] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:13.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:95:0) after 1m0s
[02:11:13.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:95:0)
[02:11:13.908] Timer tick, asking Buildbucket for the build status
[02:11:14.010] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:14.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:96:0) after 1m0s
[02:12:14.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:96:0)
[02:12:14.106] Timer tick, asking Buildbucket for the build status
[02:12:14.383] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:14.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:97:0) after 1m0s
[02:13:14.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:97:0)
[02:13:14.507] Timer tick, asking Buildbucket for the build status
[02:13:14.665] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:14.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:98:0) after 1m0s
[02:14:14.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:98:0)
[02:14:14.780] Timer tick, asking Buildbucket for the build status
[02:14:14.953] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:99:0) after 1m0s
[02:15:14.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:99:0)
[02:15:14.988] Timer tick, asking Buildbucket for the build status
[02:15:15.181] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:15.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:100:0) after 1m0s
[02:16:15.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:100:0)
[02:16:15.262] Timer tick, asking Buildbucket for the build status
[02:16:15.365] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:15.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:101:0) after 1m0s
[02:17:15.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:101:0)
[02:17:15.394] Timer tick, asking Buildbucket for the build status
[02:17:15.504] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:15.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:102:0) after 1m0s
[02:18:15.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:102:0)
[02:18:15.609] Timer tick, asking Buildbucket for the build status
[02:18:15.847] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:15.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:103:0) after 1m0s
[02:19:15.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:103:0)
[02:19:15.895] Timer tick, asking Buildbucket for the build status
[02:19:16.024] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:104:0) after 1m0s
[02:20:16.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:104:0)
[02:20:16.127] Timer tick, asking Buildbucket for the build status
[02:20:16.303] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:16.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:105:0) after 1m0s
[02:21:16.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:105:0)
[02:21:16.341] Timer tick, asking Buildbucket for the build status
[02:21:16.545] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:16.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:106:0) after 1m0s
[02:22:16.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:106:0)
[02:22:16.604] Timer tick, asking Buildbucket for the build status
[02:22:17.224] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:17.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:107:0) after 1m0s
[02:23:17.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:107:0)
[02:23:17.299] Timer tick, asking Buildbucket for the build status
[02:23:17.834] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:17.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:108:0) after 1m0s
[02:24:17.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:108:0)
[02:24:17.852] Timer tick, asking Buildbucket for the build status
[02:24:17.961] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:17.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:109:0) after 1m0s
[02:25:18.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:109:0)
[02:25:18.028] Timer tick, asking Buildbucket for the build status
[02:25:18.159] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:18.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:110:0) after 1m0s
[02:26:18.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:110:0)
[02:26:18.257] Timer tick, asking Buildbucket for the build status
[02:26:18.749] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:18.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:111:0) after 1m0s
[02:27:18.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:111:0)
[02:27:18.786] Timer tick, asking Buildbucket for the build status
[02:27:18.919] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:18.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:112:0) after 1m0s
[02:28:18.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:112:0)
[02:28:18.996] Timer tick, asking Buildbucket for the build status
[02:28:19.156] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:19.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:113:0) after 1m0s
[02:29:19.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:113:0)
[02:29:19.167] Timer tick, asking Buildbucket for the build status
[02:29:19.742] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:19.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:114:0) after 1m0s
[02:30:19.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:114:0)
[02:30:19.798] Timer tick, asking Buildbucket for the build status
[02:30:20.985] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:20.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:115:0) after 1m0s
[02:31:21.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:115:0)
[02:31:21.014] Timer tick, asking Buildbucket for the build status
[02:31:21.144] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:21.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:116:0) after 1m0s
[02:32:21.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:116:0)
[02:32:21.229] Timer tick, asking Buildbucket for the build status
[02:32:21.320] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:21.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:117:0) after 1m0s
[02:33:21.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:117:0)
[02:33:21.353] Timer tick, asking Buildbucket for the build status
[02:33:21.503] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:118:0) after 1m0s
[02:34:21.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:118:0)
[02:34:21.570] Timer tick, asking Buildbucket for the build status
[02:34:21.689] Build 8856814335358492096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022244397272626560:119:0) after 1m0s
[02:35:16.511] Received PubSub notification, asking Buildbucket for the build status
[02:35:16.632] Build 8856814335358492096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:35:16.632] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611887713593194",
"created_by": "project:chromium",
"created_ts": "1611880665397052",
"id": "8856814335358492096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\"}}",
"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\": \"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\", \"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-us-central1-b-32-1-nlke\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17058, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"a408ce8349289c8fe457a5ebccb8c4cbac7b9c3f\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\", \"got_revision_cp\": \"refs/heads/master@{#848341}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"609f77888b667dbb70edc38715437b69f15a4dc4\", \"got_v8_revision_cp\": \"refs/heads/9.0.99@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"fc00c3119a62b7178c9ec1b6cbdc3957a4346edf\", \"swarm_hashes_refs/heads/master(at){#848341}_without_patch\": {\"absl_hardening_tests\": \"48558cf6423274e2817ab9c28190051fc16cda6c\", \"accessibility_unittests\": \"b0840df6d7cc2c4b714d630cadd22e587d871426\", \"angle_unittests\": \"338edd9004e707ffb209a6195633d251654939d0\", \"app_shell_unittests\": \"60f3cf1e26f5d43212f6dbecd0302ce7be759fb7\", \"aura_unittests\": \"61d551cea4d24ad83b586f982d4f5ef893987fef\", \"base_unittests\": \"0d35b907cfcef269be88f3e08690d122536759a0\", \"base_util_unittests\": \"af4a6db8a5b14e0554ab68bc3754727f51c42b47\", \"blink_common_unittests\": \"51a09bd37bcb8d175b75b855c61aef2898aec30a\", \"blink_fuzzer_unittests\": \"815ed018c35cf454fc9231568d75353fd6550dcf\", \"blink_heap_unittests\": \"fa843c536695d7bf68d0afdaadd27bfebbbfe259\", \"blink_platform_unittests\": \"392970ad5b85438d481f6975359e89d3220d8860\", \"blink_unittests\": \"d04124f8fc619b984c4cd5e82a2ca9e6b881825e\", \"boringssl_crypto_tests\": \"8178d6f6a490bfbcf32527cb87dc7d84aeb1a2fb\", \"boringssl_ssl_tests\": \"0d6224c230a6a3747618fc48427f087a2c06bf2d\", \"browser_switcher_bho_unittests\": \"a838f45cf43d24a2720840ad4f21556534edcd85\", \"browser_tests\": \"48fbe5b734ac14dde30415e37ef3ef33646851e0\", \"capture_unittests\": \"0ce9e728084b09d3399cc93dd0ede27699c62f08\", \"cast_unittests\": \"1842e91e2d7728f1ef40f783c97b131e6e3bef08\", \"cc_unittests\": \"2492860dccc7e0ce2e049c217405dff1e4022df5\", \"chrome_app_unittests\": \"a2d079dc108b5e1fa94900d3c76fcab08dd1202b\", \"chrome_cleaner_unittests\": \"9163856e7d9de3c1b00aca99c54439dab0e6ebd2\", \"chrome_elf_unittests\": \"d07b1326ce7c59a4f9ce86cccf3d32b14fd8ea03\", \"chromedriver_unittests\": \"55c119df941a33644c2490494f73de9482212e94\", \"components_browsertests\": \"c16a06d6c50c89ee07cd35ceca8bac62e8126585\", \"components_unittests\": \"f240ebd2322f3f4e11d0dc4a145359071d346ecd\", \"compositor_unittests\": \"38cc0c7376d9fa977a934549f69b9ded73a200e7\", \"content_browsertests\": \"32e6e3494bd5abf456be48c5175659a131399acc\", \"content_unittests\": \"894e8fc96a68b9ff0dd333614b8f735ec1d3860b\", \"courgette_unittests\": \"643f3a4b586cc5f71a8e9d84b4a6e62dc2628e68\", \"crashpad_tests\": \"c2b51085f9aa5f491653cec0306e566b68ccfc02\", \"cronet_tests\": \"47b691c6153cd27886feb83a64d58cfd640f7cd0\", \"cronet_unittests\": \"d09e923b63026ee2ec4d8119529b33e5104b904f\", \"crypto_unittests\": \"558b6018ac56eb3762068155c111f1e60f33be02\", \"delayloads_unittests\": \"3b1d954773d78962fc69eaacd350ce8fe896cb6a\", \"device_unittests\": \"89828871e8a535cacfabcdfe91b3026375079cfb\", \"display_unittests\": \"ee513aadc3a8dca438eb6af4ed39b9bcb4458372\", \"elevation_service_unittests\": \"cec508616b50764c9d2ee286b8d85337867ca9be\", \"events_unittests\": \"7660f9769d0a58703d3a2476d148452c55155be7\", \"extensions_browsertests\": \"34e66c659fc47db5c0e6f41f70cb14f11c777d31\", \"extensions_unittests\": \"a63ae85700c9c7351238d00fb47ec4c5bfd905f0\", \"filesystem_service_unittests\": \"7855002704aa9986c81fdcc658efc46a03ab805e\", \"gcm_unit_tests\": \"44bfc2e97e1efa88a09a66f2e5b093310f8fef03\", \"gcp_unittests\": \"a952eb920a3591316cc326ba6a8a5bf634765439\", \"gfx_unittests\": \"cd7ed0fd38e25b5e8be8277b71c5dfd627725b9e\", \"gin_unittests\": \"6169f99c6cf535f9d87f2de4c2b4cc0412bcd63f\", \"google_apis_unittests\": \"6b1ff8b71e4f361193bfce0163566fc2ee0d5f4d\", \"gpu_unittests\": \"5cbc9279f0c98acf964682d3acea3495af382910\", \"gwp_asan_unittests\": \"08889ec643fa828318b178efc5e2ee027570dc65\", \"headless_browsertests\": \"c7c4204fb26f526e713c1d8426fa2c3d6de75f44\", \"headless_unittests\": \"1e9e054c362cc588172e5ecae4b7ece5f735ce7e\", \"install_static_unittests\": \"802f2f67dc5b93eff475a8a7ea1af3f42f0c80a9\", \"installer_util_unittests\": \"b74b28834fade50f2ca2003739f81e0c6ca0ecf8\", \"interactive_ui_tests\": \"f7926c7bfe30bc70b0ea6ffce7054f540942a136\", \"ipc_tests\": \"6c742bb73176b60feedbfec186c1eeda7b806b9b\", \"jingle_unittests\": \"78b87f5562c79cc4cc6204bfbe4aa411b22b7557\", \"latency_unittests\": \"1317fca91335e83935cb7c236224e6ca59bdcff2\", \"libjingle_xmpp_unittests\": \"cb2ce8b0a3a92fe4fb09b720b6dbe9f1f4012f0b\", \"liburlpattern_unittests\": \"5e3ab39c88e4d7cbff5dfae14d288ab9f23963b0\", \"media_blink_unittests\": \"a92fcec2cfb57663af74d66fe94dddf43e495a18\", \"media_unittests\": \"2c9035e2794c77d4b04198bdce6e79beb8f45ce3\", \"message_center_unittests\": \"ad87468af205df0455eee99e8720a542a9aea934\", \"midi_unittests\": \"fdefc70b123764c733eaa369419dbd868f3f0e5e\", \"mojo_core_unittests\": \"ef978b80878534c70f1356bc591403069a79aa23\", \"mojo_unittests\": \"9c2bb12fb94897968a9cf36109b7f092c0260200\", \"nacl_loader_unittests\": \"90505bb6e38e5119e0347da6cbd02b165aee3119\", \"native_theme_unittests\": \"83011db270ea8d9d621ec1d16656277df978dfcb\", \"net_unittests\": \"92efb8af7d6ab89cf0b60a9715e9ecf086e0211a\", \"notification_helper_unittests\": \"695db4ab632bff78da6689735c0b42110ae47be4\", \"pdf_unittests\": \"0398318c38a722470d05a9e4b3d947d32951c184\", \"perfetto_unittests\": \"03553a4b7ed4b34b01ac3c3b9bf476532675d839\", \"ppapi_unittests\": \"468eecfa15772e68f0a023a3faa13901e79af579\", \"printing_unittests\": \"8639d1bce58cc6cd71eaa0a0af7a8cda0ea1ec93\", \"remoting_unittests\": \"74d1061c886076c8091e971b13d768610f461b1f\", \"sbox_integration_tests\": \"61e63a800d728c0eb9c95290a94f7fd9eaaa13f1\", \"sbox_unittests\": \"8e80308e9456b57abe7453833255fccf58d29d65\", \"sbox_validation_tests\": \"1da2cea11bf92eeba94bd45704eaedf054efad03\", \"service_manager_unittests\": \"3b1f11cf0a105821da6df5bd8a7ef4e5812149e4\", \"services_unittests\": \"94ce7f9eadfda8a1345029a511ebf7683b219d89\", \"setup_unittests\": \"db8d91b8a0bfabde198529e24ddccdbc6f8538f7\", \"shell_dialogs_unittests\": \"556dc0e778ce8043469fb0061fe3b6d4a41f2558\", \"skia_unittests\": \"b5a6b67aae591f4e2c64d6ddf5712c9952e3cc94\", \"snapshot_unittests\": \"fa7ee4d25542c51675b9c09d90154f130fcf84c4\", \"sql_unittests\": \"f896b660d19a62073de0a60066ff88445c1dd63a\", \"storage_unittests\": \"ef44a95112d689f343694e2f3609cce8941d0485\", \"sync_integration_tests\": \"05436f0dfb495c801ab2eb7c7fd9b74455d77f81\", \"traffic_annotation_auditor_unittests\": \"d899a65493039465f1b0186f56a3fed4873a0ec7\", \"ui_base_unittests\": \"0dbd45c9ee5b76a6b283db5a266fe69c5a2d1c44\", \"ui_touch_selection_unittests\": \"a9af5e28d29b6e93b1e685d794df9355abdc5230\", \"unit_tests\": \"25b0df3c5f2979a61d5d1865397c273860465704\", \"updater_tests\": \"1db157a9137bb5ad05d744d58c6f06f971ff7b6c\", \"url_unittests\": \"06eee2422c6380b451bc65a5906fd9a8d66eb01c\", \"views_unittests\": \"e42af623a8d5c79a09a0c1ca2476fcdcba89e2aa\", \"viz_unittests\": \"5c50b55a23af7f5074fc2825a4fad3690aeb723c\", \"vr_common_unittests\": \"fede500b754d3ddbf86ce40651de260aba33cc3e\", \"vr_pixeltests\": \"084b3f6ce550b5af4fa2d9676e30b9484b7d5ef6\", \"weblayer_browsertests\": \"4de090c6480878e92ae5c4b50d0b11aee862a0a7\", \"weblayer_unittests\": \"382dac2c0fb2650bbfbaf93106e607fd67d708f8\", \"wm_unittests\": \"1fb7212cd038bcb14e50b95ef300f6454ce50eb2\", \"wtf_unittests\": \"eafc1e9d6f341123a8ecd0a2eec3eb117c32ca79\", \"zlib_unittests\": \"12ef791692b2ff61afbbe318ea00150158cfdd81\", \"zucchini_unittests\": \"b85dfa3c68d6bb43e5e448b3fa3accfb358a8d32\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-nlke\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611880842261693",
"status": "COMPLETED",
"status_changed_ts": "1611887715415345",
"tags": [
"build_address:luci.chromium.ci/win-asan/17058",
"builder:win-asan",
"buildset:commit/git/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc00c3119a62b7178c9ec1b6cbdc3957a4346edf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022244397272626560",
"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/8856814335358492096/+/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:5164649dec94be10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611887715419962",
"url": "https://ci.chromium.org/b/8856814335358492096",
"utcnow_ts": "1611887716624830"
}
}
[02:35:16.632] Invocation finished in 1h57m32.444364495s with status SUCCEEDED