[03:34:58.404] New invocation is queued and will start shortly
[03:34:59.556] Starting the invocation (attempt 1)
[03:34:59.619] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:34:59.619] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:34:59.619] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029752794733464272",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"82269ba9019ea52c988d8401a8d319712e10a537\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029752794733464272",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/82269ba9019ea52c988d8401a8d319712e10a537",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82269ba9019ea52c988d8401a8d319712e10a537",
"gitiles_ref:refs/heads/master"
]
}
[03:35:00.389] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604720099731855",
"id": "8864322732662315984",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82269ba9019ea52c988d8401a8d319712e10a537\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604720100145479",
"tags": [
"build_address:luci.chromium.ci/win-asan/15508",
"builder:win-asan",
"buildset:commit/git/82269ba9019ea52c988d8401a8d319712e10a537",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82269ba9019ea52c988d8401a8d319712e10a537",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029752794733464272",
"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/8864322732662315984/+/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": "1604720100145681",
"url": "https://ci.chromium.org/b/8864322732662315984",
"utcnow_ts": "1604720100377791"
}
}
[03:35:00.389] Task URL: https://ci.chromium.org/b/8864322732662315984
[03:35:00.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:2:0) after 1m0s
[03:35:04.026] Received PubSub notification, asking Buildbucket for the build status
[03:35:04.098] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:00.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:2:0)
[03:36:00.407] Timer tick, asking Buildbucket for the build status
[03:36:00.515] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:00.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:4:0) after 1m0s
[03:37:00.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:4:0)
[03:37:00.594] Timer tick, asking Buildbucket for the build status
[03:37:00.738] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:00.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:5:0) after 1m0s
[03:38:00.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:5:0)
[03:38:00.802] Timer tick, asking Buildbucket for the build status
[03:38:00.908] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:00.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:6:0) after 1m0s
[03:39:00.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:6:0)
[03:39:00.959] Timer tick, asking Buildbucket for the build status
[03:39:01.417] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:01.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:7:0) after 1m0s
[03:40:01.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:7:0)
[03:40:01.524] Timer tick, asking Buildbucket for the build status
[03:40:01.680] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:01.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:8:0) after 1m0s
[03:41:01.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:8:0)
[03:41:01.700] Timer tick, asking Buildbucket for the build status
[03:41:01.865] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:01.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:9:0) after 1m0s
[03:42:02.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:9:0)
[03:42:02.201] Timer tick, asking Buildbucket for the build status
[03:42:02.293] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:02.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:10:0) after 1m0s
[03:43:02.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:10:0)
[03:43:02.334] Timer tick, asking Buildbucket for the build status
[03:43:02.421] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:02.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:11:0) after 1m0s
[03:44:02.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:11:0)
[03:44:02.429] Timer tick, asking Buildbucket for the build status
[03:44:02.639] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:02.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:12:0) after 1m0s
[03:45:02.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:12:0)
[03:45:02.715] Timer tick, asking Buildbucket for the build status
[03:45:02.835] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:02.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:13:0) after 1m0s
[03:46:02.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:13:0)
[03:46:02.936] Timer tick, asking Buildbucket for the build status
[03:46:03.067] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:03.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:14:0) after 1m0s
[03:47:03.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:14:0)
[03:47:03.106] Timer tick, asking Buildbucket for the build status
[03:47:03.176] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:03.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:15:0) after 1m0s
[03:48:03.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:15:0)
[03:48:03.249] Timer tick, asking Buildbucket for the build status
[03:48:03.326] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:03.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:16:0) after 1m0s
[03:49:03.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:16:0)
[03:49:03.352] Timer tick, asking Buildbucket for the build status
[03:49:03.434] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:03.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:17:0) after 1m0s
[03:50:03.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:17:0)
[03:50:03.459] Timer tick, asking Buildbucket for the build status
[03:50:03.619] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:03.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:18:0) after 1m0s
[03:51:03.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:18:0)
[03:51:03.670] Timer tick, asking Buildbucket for the build status
[03:51:03.740] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:03.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:19:0) after 1m0s
[03:52:03.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:19:0)
[03:52:03.846] Timer tick, asking Buildbucket for the build status
[03:52:03.920] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:03.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:20:0) after 1m0s
[03:53:04.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:20:0)
[03:53:04.014] Timer tick, asking Buildbucket for the build status
[03:53:04.106] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:04.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:21:0) after 1m0s
[03:54:04.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:21:0)
[03:54:04.154] Timer tick, asking Buildbucket for the build status
[03:54:04.452] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:22:0) after 1m0s
[03:55:04.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:22:0)
[03:55:04.562] Timer tick, asking Buildbucket for the build status
[03:55:04.756] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:23:0) after 1m0s
[03:56:04.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:23:0)
[03:56:04.847] Timer tick, asking Buildbucket for the build status
[03:56:04.959] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:04.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:24:0) after 1m0s
[03:57:05.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:24:0)
[03:57:05.130] Timer tick, asking Buildbucket for the build status
[03:57:05.317] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:05.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:25:0) after 1m0s
[03:58:07.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:25:0)
[03:58:07.125] Timer tick, asking Buildbucket for the build status
[03:58:07.193] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:07.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:26:0) after 1m0s
[03:59:09.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:26:0)
[03:59:09.136] Timer tick, asking Buildbucket for the build status
[03:59:09.214] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:09.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:27:0) after 1m0s
[04:00:09.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:27:0)
[04:00:09.587] Timer tick, asking Buildbucket for the build status
[04:00:09.771] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:09.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:28:0) after 1m0s
[04:01:11.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:28:0)
[04:01:11.121] Timer tick, asking Buildbucket for the build status
[04:01:11.202] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:11.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:29:0) after 1m0s
[04:02:11.440] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:29:0)
[04:02:11.440] Timer tick, asking Buildbucket for the build status
[04:02:18.802] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:18.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:30:0) after 1m0s
[04:03:18.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:30:0)
[04:03:18.881] Timer tick, asking Buildbucket for the build status
[04:03:18.966] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:18.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:31:0) after 1m0s
[04:04:18.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:31:0)
[04:04:18.999] Timer tick, asking Buildbucket for the build status
[04:04:19.159] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:19.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:32:0) after 1m0s
[04:05:19.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:32:0)
[04:05:19.183] Timer tick, asking Buildbucket for the build status
[04:05:19.301] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:19.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:33:0) after 1m0s
[04:06:19.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:33:0)
[04:06:19.370] Timer tick, asking Buildbucket for the build status
[04:06:20.039] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:20.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:34:0) after 1m0s
[04:07:20.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:34:0)
[04:07:20.214] Timer tick, asking Buildbucket for the build status
[04:07:20.307] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:20.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:35:0) after 1m0s
[04:08:20.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:35:0)
[04:08:20.719] Timer tick, asking Buildbucket for the build status
[04:08:20.947] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:20.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:36:0) after 1m0s
[04:09:21.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:36:0)
[04:09:21.044] Timer tick, asking Buildbucket for the build status
[04:09:21.114] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:21.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:37:0) after 1m0s
[04:10:21.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:37:0)
[04:10:21.104] Timer tick, asking Buildbucket for the build status
[04:10:21.258] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:21.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:38:0) after 1m0s
[04:11:21.315] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:38:0)
[04:11:21.315] Timer tick, asking Buildbucket for the build status
[04:11:21.407] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:21.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:39:0) after 1m0s
[04:12:21.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:39:0)
[04:12:21.512] Timer tick, asking Buildbucket for the build status
[04:12:21.575] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:21.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:40:0) after 1m0s
[04:13:21.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:40:0)
[04:13:21.624] Timer tick, asking Buildbucket for the build status
[04:13:24.505] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:24.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:41:0) after 1m0s
[04:14:24.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:41:0)
[04:14:24.552] Timer tick, asking Buildbucket for the build status
[04:14:24.619] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:24.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:42:0) after 1m0s
[04:15:24.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:42:0)
[04:15:24.670] Timer tick, asking Buildbucket for the build status
[04:15:24.803] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:24.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:43:0) after 1m0s
[04:16:24.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:43:0)
[04:16:24.858] Timer tick, asking Buildbucket for the build status
[04:16:25.040] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:25.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:44:0) after 1m0s
[04:17:25.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:44:0)
[04:17:25.107] Timer tick, asking Buildbucket for the build status
[04:17:25.201] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:25.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:45:0) after 1m0s
[04:18:25.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:45:0)
[04:18:25.290] Timer tick, asking Buildbucket for the build status
[04:18:25.375] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:25.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:46:0) after 1m0s
[04:19:25.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:46:0)
[04:19:25.453] Timer tick, asking Buildbucket for the build status
[04:19:25.526] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:25.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:47:0) after 1m0s
[04:20:25.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:47:0)
[04:20:25.547] Timer tick, asking Buildbucket for the build status
[04:20:25.804] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:25.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:48:0) after 1m0s
[04:21:25.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:48:0)
[04:21:25.857] Timer tick, asking Buildbucket for the build status
[04:21:25.930] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:25.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:49:0) after 1m0s
[04:22:26.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:49:0)
[04:22:26.122] Timer tick, asking Buildbucket for the build status
[04:22:26.354] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:26.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:50:0) after 1m0s
[04:23:26.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:50:0)
[04:23:26.570] Timer tick, asking Buildbucket for the build status
[04:23:26.707] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:26.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:51:0) after 1m0s
[04:24:26.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:51:0)
[04:24:26.729] Timer tick, asking Buildbucket for the build status
[04:24:26.859] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:26.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:52:0) after 1m0s
[04:25:26.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:52:0)
[04:25:26.989] Timer tick, asking Buildbucket for the build status
[04:25:27.288] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:27.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:53:0) after 1m0s
[04:26:27.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:53:0)
[04:26:27.368] Timer tick, asking Buildbucket for the build status
[04:26:27.507] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:27.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:54:0) after 1m0s
[04:27:27.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:54:0)
[04:27:27.549] Timer tick, asking Buildbucket for the build status
[04:27:27.674] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:27.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:55:0) after 1m0s
[04:28:27.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:55:0)
[04:28:27.782] Timer tick, asking Buildbucket for the build status
[04:28:27.894] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:27.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:56:0) after 1m0s
[04:29:27.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:56:0)
[04:29:27.953] Timer tick, asking Buildbucket for the build status
[04:29:28.062] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:28.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:57:0) after 1m0s
[04:30:28.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:57:0)
[04:30:28.086] Timer tick, asking Buildbucket for the build status
[04:30:28.460] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:28.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:58:0) after 1m0s
[04:31:28.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:58:0)
[04:31:28.631] Timer tick, asking Buildbucket for the build status
[04:31:28.740] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:28.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:59:0) after 1m0s
[04:32:28.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:59:0)
[04:32:28.762] Timer tick, asking Buildbucket for the build status
[04:32:28.851] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:28.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:60:0) after 1m0s
[04:33:28.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:60:0)
[04:33:28.881] Timer tick, asking Buildbucket for the build status
[04:33:29.037] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:61:0) after 1m0s
[04:34:29.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:61:0)
[04:34:29.149] Timer tick, asking Buildbucket for the build status
[04:34:29.250] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:62:0) after 1m0s
[04:35:29.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:62:0)
[04:35:29.385] Timer tick, asking Buildbucket for the build status
[04:35:29.554] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:29.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:63:0) after 1m0s
[04:36:29.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:63:0)
[04:36:29.651] Timer tick, asking Buildbucket for the build status
[04:36:29.807] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:29.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:64:0) after 1m0s
[04:37:29.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:64:0)
[04:37:29.886] Timer tick, asking Buildbucket for the build status
[04:37:29.974] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:65:0) after 1m0s
[04:38:30.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:65:0)
[04:38:30.105] Timer tick, asking Buildbucket for the build status
[04:38:30.276] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:30.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:66:0) after 1m0s
[04:39:30.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:66:0)
[04:39:30.347] Timer tick, asking Buildbucket for the build status
[04:39:30.668] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:30.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:67:0) after 1m0s
[04:40:30.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:67:0)
[04:40:30.719] Timer tick, asking Buildbucket for the build status
[04:40:30.825] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:30.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:68:0) after 1m0s
[04:41:30.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:68:0)
[04:41:30.878] Timer tick, asking Buildbucket for the build status
[04:41:31.156] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:31.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:69:0) after 1m0s
[04:42:31.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:69:0)
[04:42:31.205] Timer tick, asking Buildbucket for the build status
[04:42:31.405] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:31.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:70:0) after 1m0s
[04:43:31.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:70:0)
[04:43:31.488] Timer tick, asking Buildbucket for the build status
[04:43:31.792] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:31.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:71:0) after 1m0s
[04:44:31.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:71:0)
[04:44:31.818] Timer tick, asking Buildbucket for the build status
[04:44:32.361] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:72:0) after 1m0s
[04:45:32.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:72:0)
[04:45:32.458] Timer tick, asking Buildbucket for the build status
[04:45:32.599] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:32.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:73:0) after 1m0s
[04:46:32.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:73:0)
[04:46:32.685] Timer tick, asking Buildbucket for the build status
[04:46:32.956] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:32.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:74:0) after 1m0s
[04:47:32.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:74:0)
[04:47:32.996] Timer tick, asking Buildbucket for the build status
[04:47:33.103] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:33.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:75:0) after 1m0s
[04:48:33.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:75:0)
[04:48:33.138] Timer tick, asking Buildbucket for the build status
[04:48:33.324] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:33.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:76:0) after 1m0s
[04:49:33.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:76:0)
[04:49:33.383] Timer tick, asking Buildbucket for the build status
[04:49:33.552] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:33.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:77:0) after 1m0s
[04:50:33.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:77:0)
[04:50:33.591] Timer tick, asking Buildbucket for the build status
[04:50:33.755] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:33.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:78:0) after 1m0s
[04:51:33.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:78:0)
[04:51:33.798] Timer tick, asking Buildbucket for the build status
[04:51:34.171] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:34.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:79:0) after 1m0s
[04:52:34.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:79:0)
[04:52:34.200] Timer tick, asking Buildbucket for the build status
[04:52:34.335] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:34.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:80:0) after 1m0s
[04:53:34.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:80:0)
[04:53:34.409] Timer tick, asking Buildbucket for the build status
[04:53:34.602] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:34.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:81:0) after 1m0s
[04:54:34.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:81:0)
[04:54:34.619] Timer tick, asking Buildbucket for the build status
[04:54:34.751] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:34.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:82:0) after 1m0s
[04:55:34.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:82:0)
[04:55:34.867] Timer tick, asking Buildbucket for the build status
[04:55:35.112] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:35.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:83:0) after 1m0s
[04:56:35.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:83:0)
[04:56:35.141] Timer tick, asking Buildbucket for the build status
[04:56:35.341] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:35.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:84:0) after 1m0s
[04:57:35.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:84:0)
[04:57:35.443] Timer tick, asking Buildbucket for the build status
[04:57:35.694] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:35.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:85:0) after 1m0s
[04:58:35.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:85:0)
[04:58:35.875] Timer tick, asking Buildbucket for the build status
[04:58:35.990] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:35.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:86:0) after 1m0s
[04:59:36.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:86:0)
[04:59:36.146] Timer tick, asking Buildbucket for the build status
[04:59:36.286] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:36.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:87:0) after 1m0s
[05:00:36.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:87:0)
[05:00:36.479] Timer tick, asking Buildbucket for the build status
[05:00:37.801] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:37.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:88:0) after 1m0s
[05:01:37.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:88:0)
[05:01:37.989] Timer tick, asking Buildbucket for the build status
[05:01:38.123] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:38.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:89:0) after 1m0s
[05:02:38.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:89:0)
[05:02:38.256] Timer tick, asking Buildbucket for the build status
[05:02:38.461] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:38.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:90:0) after 1m0s
[05:03:38.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:90:0)
[05:03:38.633] Timer tick, asking Buildbucket for the build status
[05:03:38.708] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:38.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:91:0) after 1m0s
[05:04:38.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:91:0)
[05:04:38.765] Timer tick, asking Buildbucket for the build status
[05:04:38.842] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:38.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:92:0) after 1m0s
[05:05:38.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:92:0)
[05:05:38.898] Timer tick, asking Buildbucket for the build status
[05:05:39.038] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:39.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:93:0) after 1m0s
[05:06:39.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:93:0)
[05:06:39.157] Timer tick, asking Buildbucket for the build status
[05:06:39.266] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:39.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:94:0) after 1m0s
[05:07:39.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:94:0)
[05:07:39.397] Timer tick, asking Buildbucket for the build status
[05:07:39.923] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:39.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:95:0) after 1m0s
[05:08:40.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:95:0)
[05:08:40.118] Timer tick, asking Buildbucket for the build status
[05:08:40.307] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:40.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:96:0) after 1m0s
[05:09:40.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:96:0)
[05:09:40.398] Timer tick, asking Buildbucket for the build status
[05:09:40.473] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:40.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:97:0) after 1m0s
[05:10:40.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:97:0)
[05:10:40.565] Timer tick, asking Buildbucket for the build status
[05:10:41.249] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:41.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:98:0) after 1m0s
[05:11:41.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:98:0)
[05:11:41.365] Timer tick, asking Buildbucket for the build status
[05:11:42.087] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:42.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:99:0) after 1m0s
[05:12:42.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:99:0)
[05:12:42.117] Timer tick, asking Buildbucket for the build status
[05:12:42.507] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:42.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:100:0) after 1m0s
[05:13:42.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:100:0)
[05:13:42.550] Timer tick, asking Buildbucket for the build status
[05:13:42.658] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:42.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:101:0) after 1m0s
[05:14:42.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:101:0)
[05:14:42.680] Timer tick, asking Buildbucket for the build status
[05:14:42.960] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:42.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:102:0) after 1m0s
[05:15:43.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:102:0)
[05:15:43.143] Timer tick, asking Buildbucket for the build status
[05:15:43.764] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:43.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:103:0) after 1m0s
[05:16:43.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:103:0)
[05:16:43.828] Timer tick, asking Buildbucket for the build status
[05:16:43.976] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:43.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:104:0) after 1m0s
[05:17:44.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:104:0)
[05:17:44.254] Timer tick, asking Buildbucket for the build status
[05:17:44.327] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:44.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:105:0) after 1m0s
[05:18:44.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:105:0)
[05:18:44.496] Timer tick, asking Buildbucket for the build status
[05:18:44.653] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:44.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:106:0) after 1m0s
[05:19:44.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:106:0)
[05:19:44.793] Timer tick, asking Buildbucket for the build status
[05:19:44.869] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:44.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:107:0) after 1m0s
[05:20:45.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:107:0)
[05:20:45.063] Timer tick, asking Buildbucket for the build status
[05:20:45.440] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:45.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:108:0) after 1m0s
[05:21:45.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:108:0)
[05:21:45.523] Timer tick, asking Buildbucket for the build status
[05:21:45.622] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:45.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:109:0) after 1m0s
[05:22:45.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:109:0)
[05:22:45.830] Timer tick, asking Buildbucket for the build status
[05:22:46.213] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:46.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:110:0) after 1m0s
[05:23:46.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:110:0)
[05:23:46.274] Timer tick, asking Buildbucket for the build status
[05:23:46.555] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:46.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:111:0) after 1m0s
[05:24:46.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:111:0)
[05:24:46.562] Timer tick, asking Buildbucket for the build status
[05:24:46.634] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:46.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:112:0) after 1m0s
[05:25:46.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:112:0)
[05:25:46.726] Timer tick, asking Buildbucket for the build status
[05:25:46.850] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:46.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:113:0) after 1m0s
[05:26:46.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:113:0)
[05:26:46.977] Timer tick, asking Buildbucket for the build status
[05:26:47.051] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:47.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:114:0) after 1m0s
[05:27:47.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:114:0)
[05:27:47.134] Timer tick, asking Buildbucket for the build status
[05:27:47.266] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:47.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:115:0) after 1m0s
[05:28:47.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:115:0)
[05:28:47.299] Timer tick, asking Buildbucket for the build status
[05:28:47.417] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:47.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:116:0) after 1m0s
[05:29:47.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:116:0)
[05:29:47.510] Timer tick, asking Buildbucket for the build status
[05:29:47.615] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:117:0) after 1m0s
[05:30:47.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:117:0)
[05:30:47.690] Timer tick, asking Buildbucket for the build status
[05:30:48.127] Build 8864322732662315984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:48.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029752794733464272:118:0) after 1m0s
[05:31:14.610] Received PubSub notification, asking Buildbucket for the build status
[05:31:14.701] Build 8864322732662315984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:31:14.702] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604727073057512",
"created_by": "project:chromium",
"created_ts": "1604720099731855",
"id": "8864322732662315984",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82269ba9019ea52c988d8401a8d319712e10a537\"}}",
"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\": \"82269ba9019ea52c988d8401a8d319712e10a537\", \"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-4-h4bf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15508, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"a481bee281b16c9d16b1c7d2393a4e169514ac39\", \"got_dawn_revision\": \"56af9cbd3f3581fcb2a89d3b4a3b37b328cd00d4\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"82269ba9019ea52c988d8401a8d319712e10a537\", \"got_revision_cp\": \"refs/heads/master@{#825161}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"cee3c81ed40b7f7d46e003b83d1e39a64b67c8c4\", \"got_v8_revision_cp\": \"refs/heads/8.8.249@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"82269ba9019ea52c988d8401a8d319712e10a537\", \"swarm_hashes_refs/heads/master(at){#825161}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"b1b0bcad5b913b10d1a8cc9f327a0e718a8d489e\", \"angle_unittests\": \"8828e4528530702eb7c8f17b687d47f73c3b2f48\", \"app_shell_unittests\": \"a1524e189f18a1e2b1c4fcab69907587c7274547\", \"aura_unittests\": \"c2024ef8904a1de5d435ebeb4956917dcbdf6cd8\", \"base_unittests\": \"13ac703a6fb6f3f079ab53b43fcaa89c82877a34\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"28ad49ba19994abf52433deb3e5431c345a694ab\", \"blink_fuzzer_unittests\": \"cbfbeafe3a15e97b48fa78bb210ee0e690ec688d\", \"blink_heap_unittests\": \"d14cb9d31ce89333c43c1fa80682353636e45d3d\", \"blink_platform_unittests\": \"05323b9f8f2c15f4ddc3ee52b14989c285890738\", \"blink_unittests\": \"41486070a2f4920fd1765bf1808ab05705196494\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"5646bb1e4ef76d3ef3a40d09be7acfd8b843a719\", \"capture_unittests\": \"a234ecdb8aa97722c607e6a27ab140a8a1679e31\", \"cast_unittests\": \"8488ef2b5f05224a61f5b4043e4d15b56dae5855\", \"cc_unittests\": \"3e8857865d91012792ef3583028264ff4b207cb8\", \"chrome_app_unittests\": \"f16f935678f01843d01b7dc6ed460c6fa8389107\", \"chrome_cleaner_unittests\": \"e5a2daa1ebb2e3136e8fe64b756d6a22ea079a47\", \"chrome_elf_unittests\": \"52835a3d74cf8de885380fbac6b7f4d2ffbadfe5\", \"chromedriver_unittests\": \"dfb505a881e9544efae2f5b89f9047c1d846123a\", \"components_browsertests\": \"844bf9cbf695869c23db2e21ffd37ada34cddc1e\", \"components_unittests\": \"f2fb4a2d31e732745e281890a3ecff7c02daeb8a\", \"compositor_unittests\": \"beb2084bfe3d54840ff7d3c4320af666185a814c\", \"content_browsertests\": \"2f9ffa9ad3477849b502ad0d811aae29604d6dc4\", \"content_unittests\": \"f54444c8e69a3565b3249a65b832a5074d367eca\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"de2b4550d5968438f6286989187bf79480ee2cd5\", \"cronet_unittests\": \"3eda8fa9193bd6eaf852d425900303e645f95df2\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"072f4c50095dea036bac9a72b1478f90396712d9\", \"device_unittests\": \"8e13f0f15f51047bc473020d8e72bb4000be453e\", \"display_unittests\": \"bd5f4717e4f92619497e4f60aa7792e1d36fa5b0\", \"elevation_service_unittests\": \"c0432a0e11e242dfa1933215d2e70238a6501690\", \"events_unittests\": \"b8a178dfd688e6bc24c817072f9474f69f21e375\", \"extensions_browsertests\": \"492f121a8413f3f53e63f010bef37dabba5ada3c\", \"extensions_unittests\": \"95f284d42d7eea3d652396fe8ac6a60709ad4016\", \"filesystem_service_unittests\": \"c7deb0024a5d29221c32ecab629e89cf3cd1de2d\", \"gcm_unit_tests\": \"845a9ea3e92e065ccd486b47c0c546ba8949a03d\", \"gcp_unittests\": \"b2996f0dd295b438659741fa2cab16cd879c3873\", \"gfx_unittests\": \"4e614111a0c48f86253be9f8f6d2595f32e268f5\", \"gin_unittests\": \"323b6617a63055c4c870a8f9de0724c3faed84f8\", \"google_apis_unittests\": \"ed4db8caea72d8a2589997017c4a3af2fb8d09b5\", \"gpu_unittests\": \"6ab3e48a2ced500c479bcf3ab4b2ac1412d96ecd\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"63b217a39b1680aa4bbfa93be38ff5a3620c154c\", \"headless_unittests\": \"3e3a0a43e8a4fa7cc3b7901e593188729063e884\", \"install_static_unittests\": \"120842b303866c36440a4b4bfc7979287d7238b4\", \"installer_util_unittests\": \"04d85557765c2597738b1de344a5c4626ac5aa38\", \"interactive_ui_tests\": \"7fdf05cf80befbcdb55792739c86fbd816686f88\", \"ipc_tests\": \"317e639baa44fb49f9232b7aae9f6a17a1992bc0\", \"jingle_unittests\": \"f9ca284bec85652e7a12fa7ccd32f164c6bdf319\", \"latency_unittests\": \"c479a83d2d6b8ea1680232e8f90e520d75d30e64\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"3ce8f3d283d8b694c6fc71259c5b2c739e4dcafb\", \"media_unittests\": \"dda67d3b4768cf64923de7578867aa8c82069679\", \"message_center_unittests\": \"1e0c69f8a5a580df770703cb2bad7a86870a9db7\", \"midi_unittests\": \"23f67e4825357d6e5eeee48fb6f7e8b1743f15ef\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"8a175dedee6b41eb0990456dd6087006a8e0bb58\", \"nacl_loader_unittests\": \"32d51ee8f7920e077146c63a04389fdeabc01b84\", \"native_theme_unittests\": \"6b10f347768df0d89d23e9352d441db28dd0a057\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"d218b16f615bb3f15da5482240f25812c9536eef\", \"pdf_unittests\": \"c219a2cd9e2e6b80e485ca3a4ea44128c6012bbb\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"19a1964bf97e750e1f67bd5634f51d74f9f82f17\", \"printing_unittests\": \"6acea6877112cfc93b6156c92a2eca9cde2b708e\", \"remoting_unittests\": \"17d94321dcf908eaaca0b225d4f7c3c65d312f5d\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"171b6999eb73cf9b0ee4b0760e57468b4eb837d1\", \"services_unittests\": \"c271d3a9afca840d91616c59400547033975a58d\", \"setup_unittests\": \"0799fc34854ac5549f0c19906297afae33058d1d\", \"shell_dialogs_unittests\": \"6c69e6d42d2d97aa0be1e640b91f106a1bd4b092\", \"skia_unittests\": \"ca94d2c4b21a1142cedeeb32ae7616fd8f9786ce\", \"snapshot_unittests\": \"be2828dc2b72f2593f21391a9bbb4a4897b37e0c\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"a9cc6e77d93e73779e9cb66d97348e4ba928025a\", \"sync_integration_tests\": \"1750e92d48456a186930cda56642cbb53efe9619\", \"traffic_annotation_auditor_unittests\": \"b79cdccdb072b871fcd0bb88330b2b32eb00d866\", \"ui_base_unittests\": \"ad2d7de158c300b48b1b04ebe8c595d42469e441\", \"ui_touch_selection_unittests\": \"a8c464abb85ed1478d7f5787ca4709ff4c1ce47e\", \"unit_tests\": \"f8fe3e25fa68f65528ab9e70f2b9e108e6dc9803\", \"updater_tests\": \"93e0a8287f009bb1ce277e11d21de42f49e49507\", \"url_unittests\": \"6d7112f7fdbbb0d157debf716c193382c87fdd0d\", \"views_unittests\": \"ccda6cca20f7f3aecfddae2507d0a486921d1080\", \"viz_unittests\": \"bdce3a9e74997f012783dcb8629ff6156666518e\", \"vr_common_unittests\": \"8e4b16e75ec751fcde21c81b8c4ff357ded6900e\", \"vr_pixeltests\": \"ea0907e0c2d9f82c6aabe3b5afa727394925b491\", \"weblayer_browsertests\": \"ce2edb6544e8c261dde03bbfc093fe06569d9ec1\", \"weblayer_unittests\": \"3781ae62e8f672fa9d1bbd6d56e22b378fcdad5f\", \"wm_unittests\": \"15e6c9efa68f76f6cd8cd8eaf2f72afff4addf02\", \"wtf_unittests\": \"26702bcfa415564e6953387c6cd3a051b689602b\", \"zlib_unittests\": \"bc7f273c31debe9eb6780e640a2fbb01b16af2c3\", \"zucchini_unittests\": \"5de14c85af81babf49e0bce99fe4377d874c60df\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-4-h4bf\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604720102428077",
"status": "COMPLETED",
"status_changed_ts": "1604727073661038",
"tags": [
"build_address:luci.chromium.ci/win-asan/15508",
"builder:win-asan",
"buildset:commit/git/82269ba9019ea52c988d8401a8d319712e10a537",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82269ba9019ea52c988d8401a8d319712e10a537",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029752794733464272",
"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/8864322732662315984/+/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:4fb9970e2b5afd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604727073683586",
"url": "https://ci.chromium.org/b/8864322732662315984",
"utcnow_ts": "1604727074685762"
}
}
[05:31:14.703] Invocation finished in 1h56m16.329561485s with status SUCCEEDED