[12:22:47.212] New invocation is queued and will start shortly
[12:22:48.430] Starting the invocation (attempt 1)
[12:22:48.474] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:22:48.474] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:22:48.474] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021837651491567840",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021837651491567840",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"gitiles_ref:refs/heads/master"
]
}
[12:22:50.218] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612268568643075",
"id": "8856407589325302960",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612268569738553",
"tags": [
"build_address:luci.chromium.ci/win-asan/17130",
"builder:win-asan",
"buildset:commit/git/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021837651491567840",
"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/8856407589325302960/+/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": "1612268569738685",
"url": "https://ci.chromium.org/b/8856407589325302960",
"utcnow_ts": "1612268570164421"
}
}
[12:22:50.218] Task URL: https://ci.chromium.org/b/8856407589325302960
[12:22:50.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:2:0) after 1m0s
[12:23:50.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:2:0)
[12:23:50.242] Timer tick, asking Buildbucket for the build status
[12:23:50.634] Build 8856407589325302960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:23:50.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:3:0) after 1m0s
[12:24:50.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:3:0)
[12:24:50.684] Timer tick, asking Buildbucket for the build status
[12:24:50.780] Build 8856407589325302960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:24:50.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:4:0) after 1m0s
[12:25:50.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:4:0)
[12:25:50.860] Timer tick, asking Buildbucket for the build status
[12:25:50.974] Build 8856407589325302960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:50.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:5:0) after 1m0s
[12:26:51.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:5:0)
[12:26:51.042] Timer tick, asking Buildbucket for the build status
[12:26:51.211] Build 8856407589325302960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:26:51.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:6:0) after 1m0s
[12:27:11.863] Received PubSub notification, asking Buildbucket for the build status
[12:27:11.951] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:51.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:6:0)
[12:27:51.258] Timer tick, asking Buildbucket for the build status
[12:27:51.417] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:51.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:8:0) after 1m0s
[12:28:51.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:8:0)
[12:28:51.461] Timer tick, asking Buildbucket for the build status
[12:28:51.570] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:51.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:9:0) after 1m0s
[12:29:51.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:9:0)
[12:29:51.667] Timer tick, asking Buildbucket for the build status
[12:29:51.799] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:51.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:10:0) after 1m0s
[12:30:51.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:10:0)
[12:30:51.818] Timer tick, asking Buildbucket for the build status
[12:30:51.916] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:51.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:11:0) after 1m0s
[12:31:52.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:11:0)
[12:31:52.006] Timer tick, asking Buildbucket for the build status
[12:31:52.058] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:52.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:12:0) after 1m0s
[12:32:52.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:12:0)
[12:32:52.058] Timer tick, asking Buildbucket for the build status
[12:32:52.214] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:13:0) after 1m0s
[12:33:52.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:13:0)
[12:33:52.229] Timer tick, asking Buildbucket for the build status
[12:33:52.281] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:52.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:14:0) after 1m0s
[12:34:52.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:14:0)
[12:34:52.346] Timer tick, asking Buildbucket for the build status
[12:34:52.403] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:52.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:15:0) after 1m0s
[12:35:52.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:15:0)
[12:35:52.681] Timer tick, asking Buildbucket for the build status
[12:35:52.755] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:52.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:16:0) after 1m0s
[12:36:52.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:16:0)
[12:36:52.923] Timer tick, asking Buildbucket for the build status
[12:36:52.997] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:52.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:17:0) after 1m0s
[12:37:53.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:17:0)
[12:37:53.134] Timer tick, asking Buildbucket for the build status
[12:37:53.262] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:53.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:18:0) after 1m0s
[12:38:53.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:18:0)
[12:38:53.413] Timer tick, asking Buildbucket for the build status
[12:38:53.519] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:53.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:19:0) after 1m0s
[12:39:53.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:19:0)
[12:39:53.558] Timer tick, asking Buildbucket for the build status
[12:39:53.678] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:53.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:20:0) after 1m0s
[12:40:53.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:20:0)
[12:40:53.813] Timer tick, asking Buildbucket for the build status
[12:40:53.875] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:53.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:21:0) after 1m0s
[12:41:54.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:21:0)
[12:41:54.068] Timer tick, asking Buildbucket for the build status
[12:41:54.177] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:54.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:22:0) after 1m0s
[12:42:54.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:22:0)
[12:42:54.356] Timer tick, asking Buildbucket for the build status
[12:42:54.641] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:54.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:23:0) after 1m0s
[12:43:54.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:23:0)
[12:43:54.905] Timer tick, asking Buildbucket for the build status
[12:43:55.222] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:55.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:24:0) after 1m0s
[12:44:55.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:24:0)
[12:44:55.327] Timer tick, asking Buildbucket for the build status
[12:44:55.514] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:55.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:25:0) after 1m0s
[12:45:55.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:25:0)
[12:45:55.629] Timer tick, asking Buildbucket for the build status
[12:45:55.727] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:55.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:26:0) after 1m0s
[12:46:55.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:26:0)
[12:46:55.720] Timer tick, asking Buildbucket for the build status
[12:46:56.129] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:56.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:27:0) after 1m0s
[12:47:56.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:27:0)
[12:47:56.174] Timer tick, asking Buildbucket for the build status
[12:47:56.297] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:56.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:28:0) after 1m0s
[12:48:56.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:28:0)
[12:48:56.496] Timer tick, asking Buildbucket for the build status
[12:48:56.624] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:56.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:29:0) after 1m0s
[12:49:56.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:29:0)
[12:49:56.675] Timer tick, asking Buildbucket for the build status
[12:49:56.724] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:56.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:30:0) after 1m0s
[12:50:57.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:30:0)
[12:50:57.131] Timer tick, asking Buildbucket for the build status
[12:50:57.338] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:57.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:31:0) after 1m0s
[12:51:57.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:31:0)
[12:51:57.339] Timer tick, asking Buildbucket for the build status
[12:51:57.406] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:57.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:32:0) after 1m0s
[12:52:57.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:32:0)
[12:52:57.600] Timer tick, asking Buildbucket for the build status
[12:52:58.008] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:58.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:33:0) after 1m0s
[12:53:58.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:33:0)
[12:53:58.116] Timer tick, asking Buildbucket for the build status
[12:53:58.234] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:58.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:34:0) after 1m0s
[12:54:58.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:34:0)
[12:54:58.343] Timer tick, asking Buildbucket for the build status
[12:54:58.521] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:58.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:35:0) after 1m0s
[12:55:58.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:35:0)
[12:55:58.674] Timer tick, asking Buildbucket for the build status
[12:55:58.932] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:58.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:36:0) after 1m0s
[12:56:58.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:36:0)
[12:56:58.952] Timer tick, asking Buildbucket for the build status
[12:56:59.118] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:59.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:37:0) after 1m0s
[12:57:59.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:37:0)
[12:57:59.205] Timer tick, asking Buildbucket for the build status
[12:57:59.422] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:59.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:38:0) after 1m0s
[12:59:02.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:38:0)
[12:59:02.236] Timer tick, asking Buildbucket for the build status
[12:59:02.339] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:39:0) after 1m0s
[13:00:02.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:39:0)
[13:00:02.593] Timer tick, asking Buildbucket for the build status
[13:00:03.307] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:03.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:40:0) after 1m0s
[13:01:03.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:40:0)
[13:01:03.388] Timer tick, asking Buildbucket for the build status
[13:01:03.607] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:03.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:41:0) after 1m0s
[13:02:03.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:41:0)
[13:02:03.726] Timer tick, asking Buildbucket for the build status
[13:02:03.833] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:03.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:42:0) after 1m0s
[13:03:03.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:42:0)
[13:03:03.996] Timer tick, asking Buildbucket for the build status
[13:03:04.521] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:04.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:43:0) after 1m0s
[13:04:04.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:43:0)
[13:04:04.904] Timer tick, asking Buildbucket for the build status
[13:04:05.113] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:05.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:44:0) after 1m0s
[13:05:05.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:44:0)
[13:05:05.184] Timer tick, asking Buildbucket for the build status
[13:05:05.384] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:05.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:45:0) after 1m0s
[13:06:05.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:45:0)
[13:06:05.793] Timer tick, asking Buildbucket for the build status
[13:06:05.920] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:05.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:46:0) after 1m0s
[13:07:06.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:46:0)
[13:07:06.131] Timer tick, asking Buildbucket for the build status
[13:07:06.243] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:06.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:47:0) after 1m0s
[13:08:06.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:47:0)
[13:08:06.417] Timer tick, asking Buildbucket for the build status
[13:08:06.517] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:06.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:48:0) after 1m0s
[13:09:06.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:48:0)
[13:09:06.847] Timer tick, asking Buildbucket for the build status
[13:09:06.948] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:06.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:49:0) after 1m0s
[13:10:07.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:49:0)
[13:10:07.040] Timer tick, asking Buildbucket for the build status
[13:10:07.619] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:07.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:50:0) after 1m0s
[13:11:07.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:50:0)
[13:11:07.809] Timer tick, asking Buildbucket for the build status
[13:11:08.117] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:08.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:51:0) after 1m0s
[13:12:08.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:51:0)
[13:12:08.294] Timer tick, asking Buildbucket for the build status
[13:12:08.350] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:08.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:52:0) after 1m0s
[13:13:08.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:52:0)
[13:13:08.487] Timer tick, asking Buildbucket for the build status
[13:13:08.830] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:08.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:53:0) after 1m0s
[13:14:08.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:53:0)
[13:14:08.895] Timer tick, asking Buildbucket for the build status
[13:14:09.038] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:09.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:54:0) after 1m0s
[13:15:09.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:54:0)
[13:15:09.193] Timer tick, asking Buildbucket for the build status
[13:15:09.321] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:09.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:55:0) after 1m0s
[13:16:09.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:55:0)
[13:16:09.565] Timer tick, asking Buildbucket for the build status
[13:16:09.951] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:09.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:56:0) after 1m0s
[13:17:10.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:56:0)
[13:17:10.007] Timer tick, asking Buildbucket for the build status
[13:17:10.297] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:57:0) after 1m0s
[13:18:10.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:57:0)
[13:18:10.532] Timer tick, asking Buildbucket for the build status
[13:18:10.748] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:10.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:58:0) after 1m0s
[13:19:11.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:58:0)
[13:19:11.021] Timer tick, asking Buildbucket for the build status
[13:19:11.201] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:11.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:59:0) after 1m0s
[13:20:11.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:59:0)
[13:20:11.230] Timer tick, asking Buildbucket for the build status
[13:20:11.418] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:11.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:60:0) after 1m0s
[13:21:11.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:60:0)
[13:21:11.450] Timer tick, asking Buildbucket for the build status
[13:21:11.535] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:11.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:61:0) after 1m0s
[13:22:11.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:61:0)
[13:22:11.576] Timer tick, asking Buildbucket for the build status
[13:22:11.706] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:11.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:62:0) after 1m0s
[13:23:11.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:62:0)
[13:23:11.751] Timer tick, asking Buildbucket for the build status
[13:23:11.859] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:11.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:63:0) after 1m0s
[13:24:11.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:63:0)
[13:24:11.902] Timer tick, asking Buildbucket for the build status
[13:24:11.962] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:11.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:64:0) after 1m0s
[13:25:12.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:64:0)
[13:25:12.022] Timer tick, asking Buildbucket for the build status
[13:25:12.081] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:12.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:65:0) after 1m0s
[13:26:12.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:65:0)
[13:26:12.110] Timer tick, asking Buildbucket for the build status
[13:26:12.179] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:12.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:66:0) after 1m0s
[13:27:12.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:66:0)
[13:27:12.222] Timer tick, asking Buildbucket for the build status
[13:27:12.286] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:12.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:67:0) after 1m0s
[13:28:12.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:67:0)
[13:28:12.427] Timer tick, asking Buildbucket for the build status
[13:28:12.563] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:12.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:68:0) after 1m0s
[13:29:12.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:68:0)
[13:29:12.647] Timer tick, asking Buildbucket for the build status
[13:29:12.710] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:12.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:69:0) after 1m0s
[13:30:12.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:69:0)
[13:30:12.804] Timer tick, asking Buildbucket for the build status
[13:30:12.892] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:12.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:70:0) after 1m0s
[13:31:12.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:70:0)
[13:31:12.992] Timer tick, asking Buildbucket for the build status
[13:31:13.058] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:13.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:71:0) after 1m0s
[13:32:13.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:71:0)
[13:32:13.116] Timer tick, asking Buildbucket for the build status
[13:32:13.248] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:13.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:72:0) after 1m0s
[13:33:13.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:72:0)
[13:33:13.278] Timer tick, asking Buildbucket for the build status
[13:33:13.378] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:13.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:73:0) after 1m0s
[13:34:13.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:73:0)
[13:34:13.411] Timer tick, asking Buildbucket for the build status
[13:34:13.725] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:13.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:74:0) after 1m0s
[13:35:13.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:74:0)
[13:35:13.765] Timer tick, asking Buildbucket for the build status
[13:35:13.867] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:13.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:75:0) after 1m0s
[13:36:13.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:75:0)
[13:36:13.904] Timer tick, asking Buildbucket for the build status
[13:36:14.055] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:14.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:76:0) after 1m0s
[13:37:14.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:76:0)
[13:37:14.137] Timer tick, asking Buildbucket for the build status
[13:37:14.375] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:14.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:77:0) after 1m0s
[13:38:14.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:77:0)
[13:38:14.498] Timer tick, asking Buildbucket for the build status
[13:38:14.641] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:14.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:78:0) after 1m0s
[13:39:14.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:78:0)
[13:39:14.686] Timer tick, asking Buildbucket for the build status
[13:39:14.846] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:14.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:79:0) after 1m0s
[13:40:15.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:79:0)
[13:40:15.025] Timer tick, asking Buildbucket for the build status
[13:40:15.126] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:15.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:80:0) after 1m0s
[13:41:15.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:80:0)
[13:41:15.254] Timer tick, asking Buildbucket for the build status
[13:41:15.378] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:15.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:81:0) after 1m0s
[13:42:15.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:81:0)
[13:42:15.403] Timer tick, asking Buildbucket for the build status
[13:42:16.204] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:82:0) after 1m0s
[13:43:16.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:82:0)
[13:43:16.227] Timer tick, asking Buildbucket for the build status
[13:43:16.331] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:16.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:83:0) after 1m0s
[13:44:16.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:83:0)
[13:44:16.421] Timer tick, asking Buildbucket for the build status
[13:44:17.402] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:17.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:84:0) after 1m0s
[13:45:17.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:84:0)
[13:45:17.525] Timer tick, asking Buildbucket for the build status
[13:45:17.638] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:17.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:85:0) after 1m0s
[13:46:17.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:85:0)
[13:46:17.700] Timer tick, asking Buildbucket for the build status
[13:46:17.835] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:17.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:86:0) after 1m0s
[13:47:17.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:86:0)
[13:47:17.822] Timer tick, asking Buildbucket for the build status
[13:47:17.944] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:17.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:87:0) after 1m0s
[13:48:18.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:87:0)
[13:48:18.001] Timer tick, asking Buildbucket for the build status
[13:48:18.117] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:18.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:88:0) after 1m0s
[13:49:18.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:88:0)
[13:49:18.110] Timer tick, asking Buildbucket for the build status
[13:49:18.855] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:18.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:89:0) after 1m0s
[13:50:18.907] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:89:0)
[13:50:18.907] Timer tick, asking Buildbucket for the build status
[13:50:18.977] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:18.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:90:0) after 1m0s
[13:51:19.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:90:0)
[13:51:19.002] Timer tick, asking Buildbucket for the build status
[13:51:19.079] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:19.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:91:0) after 1m0s
[13:52:19.090] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:91:0)
[13:52:19.090] Timer tick, asking Buildbucket for the build status
[13:52:19.174] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:92:0) after 1m0s
[13:53:19.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:92:0)
[13:53:19.295] Timer tick, asking Buildbucket for the build status
[13:53:19.762] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:19.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:93:0) after 1m0s
[13:54:19.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:93:0)
[13:54:19.838] Timer tick, asking Buildbucket for the build status
[13:54:19.916] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:19.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:94:0) after 1m0s
[13:55:19.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:94:0)
[13:55:19.906] Timer tick, asking Buildbucket for the build status
[13:55:20.438] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:20.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:95:0) after 1m0s
[13:56:20.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:95:0)
[13:56:20.551] Timer tick, asking Buildbucket for the build status
[13:56:20.630] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:20.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:96:0) after 1m0s
[13:57:20.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:96:0)
[13:57:20.722] Timer tick, asking Buildbucket for the build status
[13:57:20.792] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:20.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:97:0) after 1m0s
[13:58:20.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:97:0)
[13:58:20.906] Timer tick, asking Buildbucket for the build status
[13:58:21.157] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:21.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:98:0) after 1m0s
[13:59:21.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:98:0)
[13:59:21.228] Timer tick, asking Buildbucket for the build status
[13:59:21.353] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:21.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:99:0) after 1m0s
[14:00:21.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:99:0)
[14:00:21.418] Timer tick, asking Buildbucket for the build status
[14:00:21.527] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:21.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:100:0) after 1m0s
[14:01:21.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:100:0)
[14:01:21.603] Timer tick, asking Buildbucket for the build status
[14:01:21.888] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:21.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:101:0) after 1m0s
[14:02:22.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:101:0)
[14:02:22.025] Timer tick, asking Buildbucket for the build status
[14:02:22.213] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:22.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:102:0) after 1m0s
[14:03:22.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:102:0)
[14:03:22.264] Timer tick, asking Buildbucket for the build status
[14:03:22.397] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:22.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:103:0) after 1m0s
[14:04:22.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:103:0)
[14:04:22.429] Timer tick, asking Buildbucket for the build status
[14:04:22.589] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:22.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:104:0) after 1m0s
[14:05:22.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:104:0)
[14:05:22.589] Timer tick, asking Buildbucket for the build status
[14:05:22.734] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:22.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:105:0) after 1m0s
[14:06:22.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:105:0)
[14:06:22.820] Timer tick, asking Buildbucket for the build status
[14:06:23.042] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:23.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:106:0) after 1m0s
[14:07:23.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:106:0)
[14:07:23.069] Timer tick, asking Buildbucket for the build status
[14:07:24.043] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:24.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:107:0) after 1m0s
[14:08:24.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:107:0)
[14:08:24.148] Timer tick, asking Buildbucket for the build status
[14:08:24.801] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:24.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:108:0) after 1m0s
[14:09:24.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:108:0)
[14:09:24.809] Timer tick, asking Buildbucket for the build status
[14:09:24.933] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:24.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:109:0) after 1m0s
[14:10:25.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:109:0)
[14:10:25.027] Timer tick, asking Buildbucket for the build status
[14:10:25.093] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:25.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:110:0) after 1m0s
[14:11:25.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:110:0)
[14:11:25.229] Timer tick, asking Buildbucket for the build status
[14:11:25.336] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:25.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:111:0) after 1m0s
[14:12:25.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:111:0)
[14:12:25.380] Timer tick, asking Buildbucket for the build status
[14:12:25.481] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:25.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:112:0) after 1m0s
[14:13:25.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:112:0)
[14:13:25.632] Timer tick, asking Buildbucket for the build status
[14:13:25.750] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:25.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:113:0) after 1m0s
[14:14:25.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:113:0)
[14:14:25.750] Timer tick, asking Buildbucket for the build status
[14:14:25.888] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:25.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:114:0) after 1m0s
[14:15:25.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:114:0)
[14:15:25.953] Timer tick, asking Buildbucket for the build status
[14:15:26.064] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:26.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:115:0) after 1m0s
[14:16:26.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:115:0)
[14:16:26.109] Timer tick, asking Buildbucket for the build status
[14:16:26.440] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:26.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:116:0) after 1m0s
[14:17:26.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:116:0)
[14:17:26.464] Timer tick, asking Buildbucket for the build status
[14:17:26.662] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:26.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:117:0) after 1m0s
[14:18:26.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:117:0)
[14:18:26.684] Timer tick, asking Buildbucket for the build status
[14:18:26.898] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:26.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:118:0) after 1m0s
[14:19:27.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:118:0)
[14:19:27.026] Timer tick, asking Buildbucket for the build status
[14:19:27.117] Build 8856407589325302960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:27.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021837651491567840:119:0) after 1m0s
[14:19:35.386] Received PubSub notification, asking Buildbucket for the build status
[14:19:35.491] Build 8856407589325302960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:19:35.491] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612275568208699",
"created_by": "project:chromium",
"created_ts": "1612268568643075",
"id": "8856407589325302960",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\"}}",
"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\": \"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\", \"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-2-30ob\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17130, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"43e39e1e8e387644f22d87c7a846e57172bd1312\", \"got_dawn_revision\": \"9a2174a37cfdc771a9c7a494e6fb773c541bd941\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\", \"got_revision_cp\": \"refs/heads/master@{#849555}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"079f7c53751ac589cf05880522b3fa2fcb5b5645\", \"got_v8_revision_cp\": \"refs/heads/9.0.109@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"d7b0ed805ab80d65412c50b1771866d3fa72a7b9\", \"swarm_hashes_refs/heads/master(at){#849555}_without_patch\": {\"absl_hardening_tests\": \"1726408473e9e22f85bc6812521f41950f255d8d\", \"accessibility_unittests\": \"274fe9af61a9331818ce8452bd021879e3f7a45a\", \"angle_unittests\": \"ea23e7f781a6b80b99a72a10dba77abbd6b4ffd8\", \"app_shell_unittests\": \"f81bcc37c6795d5171b54a71f54f9057d9f744a0\", \"aura_unittests\": \"d69cc5062abe234b89a83af0dab84a2b4e532d27\", \"base_unittests\": \"7f4f2668dc7121d3c522b6ee67b0781b17bd935a\", \"base_util_unittests\": \"d911f30504db7f149eec9de9565facfcfd7ad9fc\", \"blink_common_unittests\": \"d632c1d2d2f105318ef3177c323000cffc076e51\", \"blink_fuzzer_unittests\": \"fa1656a0b5325a3f6187e2c3e5d609b22501d09c\", \"blink_heap_unittests\": \"a4901e12dc6d1a85679ae443653b0c17981fa2fc\", \"blink_platform_unittests\": \"562573730ace9c2cc65ef946869d241e639572b8\", \"blink_unittests\": \"f28dd3c25c25394d0eff457bcf45d121eb65600e\", \"boringssl_crypto_tests\": \"edf2e10614e4d7fbabb6e2b4e56a2630204c35a1\", \"boringssl_ssl_tests\": \"f061c32389acaf2905500266add5eb654ecd8ea7\", \"browser_switcher_bho_unittests\": \"88ab1df89fcd45ad1435f45abbc651a56ffdf7a8\", \"browser_tests\": \"820b2422a19e76e748578e27f8e8393bbc288400\", \"capture_unittests\": \"41f14296cea7615c7b4725b81d5769ca544880a9\", \"cast_unittests\": \"1beeaa2a397f56eb23f01b92ccad4d3715a19e54\", \"cc_unittests\": \"7c20993b68326d7da010b359476b12f17d8049b8\", \"chrome_app_unittests\": \"f588a21aee2473b06ccb24deaa97747f0c1aedba\", \"chrome_cleaner_unittests\": \"ff0aa9fa7c0d8f7092213473c7089f8f4c8088e6\", \"chrome_elf_unittests\": \"e837ada42556dc16cd05e6aca395e2c86ebd4305\", \"chromedriver_unittests\": \"f9dad1c8f868e1a3e06a0dafb1b4ddf55016cf4c\", \"components_browsertests\": \"37f502a2bfa7ae2bb1af47620a9e8b48115d355c\", \"components_unittests\": \"389e4f15286fd22c8b7d55f1cec2b1225ea42a5b\", \"compositor_unittests\": \"fa84707c08ecfa8f3d5290cfbfd6af0fc753cf8d\", \"content_browsertests\": \"d3ee1edf6092c2d2e79e72fc969cd56f00018f79\", \"content_unittests\": \"7efe7f1a1c662db3c08711f9860115c69bb9a76a\", \"courgette_unittests\": \"9560636e129ef54e040b686330bc90577209603c\", \"crashpad_tests\": \"b66e6e1b90acab1eba13d89e7e792d7d638931f1\", \"cronet_tests\": \"9641c5f2e780ea71250ecdc98d95c220c202a5a5\", \"cronet_unittests\": \"7adb1876b5681a4d22caef8a43f2baddde4adc11\", \"crypto_unittests\": \"be3d8d8ae68e229a11699aa2ce6ffff67d5a2891\", \"delayloads_unittests\": \"73997253e6dac9ad04217f730609ab6c8a37dec2\", \"device_unittests\": \"54836b52fd6405b8572fe92abf8750116ab983a4\", \"display_unittests\": \"0436cd89b5165803f91ddbb326699f5607fb8e95\", \"elevation_service_unittests\": \"7eb8f9cbb45d0ce399d7f17719369c29549a53e7\", \"events_unittests\": \"91fa4f3ad38f5eeab26b0a24759855afd5f4a6de\", \"extensions_browsertests\": \"1a721f1ccba0a8b9094d3bb9ef011587edc4d242\", \"extensions_unittests\": \"caf2ecfbcd5e74e8ae78d79591dac6ba873c3655\", \"filesystem_service_unittests\": \"180fea9c2ab961e538acb24dd742fcb637dc521f\", \"gcm_unit_tests\": \"a58ce13a813ca90ebdffb76a10ec4c90958afd52\", \"gcp_unittests\": \"936d232be1d55c3f7aa0383b91e7cc011de18aeb\", \"gfx_unittests\": \"2b1557ba0f45f9807f48e6702433e4a4eaf1d342\", \"gin_unittests\": \"c8a8d34983fe69b2ee6b73dfee03403e5a34a2f5\", \"google_apis_unittests\": \"42d316f79c93e7399b98ad80c68779fa63052b0f\", \"gpu_unittests\": \"d44486b15a8f36a6b3f9436e4bfe86799dcd82b4\", \"gwp_asan_unittests\": \"274019a9a50d17638738f5f56172318033a1766e\", \"headless_browsertests\": \"597c8b6739baa3832fe26b401de21214f5d8faaa\", \"headless_unittests\": \"24c6f1fe68d43264cd4e946f18bd278e92a2d38a\", \"install_static_unittests\": \"de4f61419988d00ee482297f926de2016af7cac1\", \"installer_util_unittests\": \"7448fa5ace785535202076cf25826c15316cc997\", \"interactive_ui_tests\": \"bc7b3e3001622f5d4cfa80d44545844038d1f8db\", \"ipc_tests\": \"19c57755c8afe6f27ffa55472e9c8cd5169964fd\", \"jingle_unittests\": \"8720f362340ecfe337deebbf11a0be0e000676e6\", \"latency_unittests\": \"43ee2b795d9ce604912688e0da68f26891d8cb36\", \"libjingle_xmpp_unittests\": \"fb81887492bc2124d09936f957193c29d24a0e47\", \"liburlpattern_unittests\": \"8a6519df76d7b835e16a0bb23c4b6aecb08fdf2c\", \"media_blink_unittests\": \"c36366011860412eac259d5b505f5310b6bfd4e4\", \"media_unittests\": \"a64e956601332350d4b3765bc5f233a7199fc1a2\", \"message_center_unittests\": \"c9d7ce47802cbe941b0273857e46e80569b41d1b\", \"midi_unittests\": \"a7aba47ee99e6c0800c6366d74415a79de889132\", \"mojo_core_unittests\": \"e981b3f2ed86ee1e0a459978c20571a19920bd68\", \"mojo_unittests\": \"a20d6c32379878ffd29f49b5c2fd7a2f87544aeb\", \"nacl_loader_unittests\": \"d6ebfed30b79275316a65ee12ae2f48116413947\", \"native_theme_unittests\": \"0fad6c78ff82e28ac46a413f1a521d9cf36c44e8\", \"net_unittests\": \"a953ccb7254aa97952ca7a1b8d6d8bb9e743b71e\", \"notification_helper_unittests\": \"d8c833192f0e6aa8c8eacd9860961b2d1b2cea15\", \"pdf_unittests\": \"198880d058cce21e3412e23caad467b43982c047\", \"perfetto_unittests\": \"8625b7542f05d72eaf2638b55a5d8e03b9758226\", \"ppapi_unittests\": \"4769d60587ffe8120ab8e789a4941293bbfefa2c\", \"printing_unittests\": \"0590330aa08bf028397d6992859456ea37d25819\", \"remoting_unittests\": \"fbc4f246b2de78accde6da139b042ac88dfe9eb6\", \"sbox_integration_tests\": \"21ee6a037cb7da1ff0feeb741ff94595c613d372\", \"sbox_unittests\": \"0a42b578c4fa4815e44f943630a5b76b94a53141\", \"sbox_validation_tests\": \"03106d5ea08dfff43ceab6bd769ae52e28ac65a9\", \"service_manager_unittests\": \"85222a1a442254e8a90bfffb0f9657e10c938427\", \"services_unittests\": \"a2a1b8c9f1f6891c73bb4bd4a98d401b8068e6ce\", \"setup_unittests\": \"309e629a3621080f931ed5e8b8ec081e5d770157\", \"shell_dialogs_unittests\": \"8fe5489c22f6b8783b385a073a48c3876a177cac\", \"skia_unittests\": \"6b292b4afa1e9cd32dd37a34e32d300ff8828dc3\", \"snapshot_unittests\": \"2385be43a282f069b7d1ac902b1f26dbfb24e729\", \"sql_unittests\": \"f681d2cd85d2e0543860113ad252300499a2a9ef\", \"storage_unittests\": \"af86b1102889cddf47f6500c8ceed5affa6fabf7\", \"sync_integration_tests\": \"542401c2d6e5d97670303ffaf48958fd26112984\", \"traffic_annotation_auditor_unittests\": \"cf12724f76b0661d542c03cbb7b15d391c2d70aa\", \"ui_base_unittests\": \"539ced1df072a5f175109a70714263bca86b805d\", \"ui_touch_selection_unittests\": \"66af0c0d737b7f25592efb58f502c4f6783bca34\", \"unit_tests\": \"4916f641755849a5ab854bebcd39bc431f03606a\", \"updater_tests\": \"37bf994a1af3e82359a4b23147a2c7e5060bbaaf\", \"url_unittests\": \"e8f33a5551472cf3b8fd69209c5a77c316906e01\", \"views_unittests\": \"a4ce132e85259db27403ab53880548c2f45ad3f4\", \"viz_unittests\": \"10874952491b9dbdbb503ac7e31432d5c3c5c3d9\", \"vr_common_unittests\": \"a7359b1114c0316d927faa6e403046bcc9eeb727\", \"vr_pixeltests\": \"f2595d2a8dc9ea5daf039d7525112561398cd979\", \"weblayer_browsertests\": \"152aa62de53c95066e33c7005ceb67d26af8122e\", \"weblayer_unittests\": \"0d1fe2a747753090fd4f6903f568e84a01ae7de6\", \"wm_unittests\": \"fd8101dbdbb85daa2789d0c6d96ceb92e8cfedf9\", \"wtf_unittests\": \"09e9b11a1f6415b88d9cf75b0262f9897bccf75c\", \"zlib_unittests\": \"9345de151e6e1e5571f055e4fb7eec6965f80741\", \"zucchini_unittests\": \"d571109f4423f275add2933062286100dfb7b720\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-2-30ob\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612268831037388",
"status": "COMPLETED",
"status_changed_ts": "1612275568741567",
"tags": [
"build_address:luci.chromium.ci/win-asan/17130",
"builder:win-asan",
"buildset:commit/git/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7b0ed805ab80d65412c50b1771866d3fa72a7b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021837651491567840",
"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/8856407589325302960/+/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:517b838f19ac7210",
"user_agent:luci-scheduler"
],
"updated_ts": "1612275568746158",
"url": "https://ci.chromium.org/b/8856407589325302960",
"utcnow_ts": "1612275575450821"
}
}
[14:19:35.491] Invocation finished in 1h56m48.298228538s with status SUCCEEDED