[19:15:40.259] New invocation is queued and will start shortly
[19:15:41.379] Starting the invocation (attempt 1)
[19:15:41.424] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:15:41.424] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:15:41.424] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020271526646247392",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"01a2b121b12d389611987bf4082d495c905b0fb3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020271526646247392",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/01a2b121b12d389611987bf4082d495c905b0fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01a2b121b12d389611987bf4082d495c905b0fb3",
"gitiles_ref:refs/heads/master"
]
}
[19:15:42.161] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613762141564169",
"id": "8854841464605494256",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"01a2b121b12d389611987bf4082d495c905b0fb3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613762142033391",
"tags": [
"build_address:luci.chromium.ci/win-asan/17432",
"builder:win-asan",
"buildset:commit/git/01a2b121b12d389611987bf4082d495c905b0fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01a2b121b12d389611987bf4082d495c905b0fb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020271526646247392",
"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/8854841464605494256/+/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": "1613762142033500",
"url": "https://ci.chromium.org/b/8854841464605494256",
"utcnow_ts": "1613762142152250"
}
}
[19:15:42.161] Task URL: https://ci.chromium.org/b/8854841464605494256
[19:15:42.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:2:0) after 1m0s
[19:16:42.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:2:0)
[19:16:42.480] Timer tick, asking Buildbucket for the build status
[19:16:42.627] Build 8854841464605494256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:42.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:3:0) after 1m0s
[19:17:42.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:3:0)
[19:17:42.775] Timer tick, asking Buildbucket for the build status
[19:17:42.906] Build 8854841464605494256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:42.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:4:0) after 1m0s
[19:18:43.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:4:0)
[19:18:43.057] Timer tick, asking Buildbucket for the build status
[19:18:43.496] Build 8854841464605494256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:43.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:5:0) after 1m0s
[19:19:43.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:5:0)
[19:19:43.596] Timer tick, asking Buildbucket for the build status
[19:19:44.033] Build 8854841464605494256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:44.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:6:0) after 1m0s
[19:20:44.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:6:0)
[19:20:44.118] Timer tick, asking Buildbucket for the build status
[19:20:44.202] Build 8854841464605494256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:44.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:7:0) after 1m0s
[19:20:51.513] Received PubSub notification, asking Buildbucket for the build status
[19:20:51.581] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:44.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:7:0)
[19:21:44.295] Timer tick, asking Buildbucket for the build status
[19:21:44.543] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:44.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:9:0) after 1m0s
[19:22:45.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:9:0)
[19:22:45.137] Timer tick, asking Buildbucket for the build status
[19:22:45.211] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:45.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:10:0) after 1m0s
[19:23:45.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:10:0)
[19:23:45.399] Timer tick, asking Buildbucket for the build status
[19:23:45.497] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:45.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:11:0) after 1m0s
[19:24:45.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:11:0)
[19:24:45.705] Timer tick, asking Buildbucket for the build status
[19:24:45.821] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:45.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:12:0) after 1m0s
[19:25:46.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:12:0)
[19:25:46.113] Timer tick, asking Buildbucket for the build status
[19:25:46.214] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:46.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:13:0) after 1m0s
[19:26:46.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:13:0)
[19:26:46.341] Timer tick, asking Buildbucket for the build status
[19:26:46.695] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:46.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:14:0) after 1m0s
[19:27:46.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:14:0)
[19:27:46.825] Timer tick, asking Buildbucket for the build status
[19:27:46.891] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:46.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:15:0) after 1m0s
[19:28:47.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:15:0)
[19:28:47.045] Timer tick, asking Buildbucket for the build status
[19:28:47.129] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:47.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:16:0) after 1m0s
[19:29:47.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:16:0)
[19:29:47.358] Timer tick, asking Buildbucket for the build status
[19:29:47.595] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:47.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:17:0) after 1m0s
[19:30:47.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:17:0)
[19:30:47.736] Timer tick, asking Buildbucket for the build status
[19:30:47.941] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:18:0) after 1m0s
[19:31:48.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:18:0)
[19:31:48.329] Timer tick, asking Buildbucket for the build status
[19:31:48.451] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:48.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:19:0) after 1m0s
[19:32:48.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:19:0)
[19:32:48.583] Timer tick, asking Buildbucket for the build status
[19:32:48.908] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:48.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:20:0) after 1m0s
[19:33:48.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:20:0)
[19:33:48.906] Timer tick, asking Buildbucket for the build status
[19:33:48.977] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:48.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:21:0) after 1m0s
[19:34:49.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:21:0)
[19:34:49.117] Timer tick, asking Buildbucket for the build status
[19:34:49.186] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:49.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:22:0) after 1m0s
[19:35:49.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:22:0)
[19:35:49.295] Timer tick, asking Buildbucket for the build status
[19:35:49.381] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:49.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:23:0) after 1m0s
[19:36:49.420] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:23:0)
[19:36:49.420] Timer tick, asking Buildbucket for the build status
[19:36:49.484] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:49.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:24:0) after 1m0s
[19:37:49.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:24:0)
[19:37:49.487] Timer tick, asking Buildbucket for the build status
[19:37:49.606] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:49.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:25:0) after 1m0s
[19:38:49.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:25:0)
[19:38:49.700] Timer tick, asking Buildbucket for the build status
[19:38:49.836] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:49.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:26:0) after 1m0s
[19:39:50.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:26:0)
[19:39:50.052] Timer tick, asking Buildbucket for the build status
[19:39:50.144] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:50.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:27:0) after 1m0s
[19:40:50.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:27:0)
[19:40:50.242] Timer tick, asking Buildbucket for the build status
[19:40:50.419] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:50.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:28:0) after 1m0s
[19:41:50.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:28:0)
[19:41:50.486] Timer tick, asking Buildbucket for the build status
[19:41:50.784] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:50.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:29:0) after 1m0s
[19:42:50.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:29:0)
[19:42:50.828] Timer tick, asking Buildbucket for the build status
[19:42:50.910] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:50.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:30:0) after 1m0s
[19:43:50.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:30:0)
[19:43:50.963] Timer tick, asking Buildbucket for the build status
[19:43:51.209] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:51.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:31:0) after 1m0s
[19:44:51.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:31:0)
[19:44:51.236] Timer tick, asking Buildbucket for the build status
[19:44:51.361] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:51.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:32:0) after 1m0s
[19:45:51.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:32:0)
[19:45:51.537] Timer tick, asking Buildbucket for the build status
[19:45:51.835] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:51.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:33:0) after 1m0s
[19:46:51.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:33:0)
[19:46:51.899] Timer tick, asking Buildbucket for the build status
[19:46:51.989] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:51.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:34:0) after 1m0s
[19:47:52.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:34:0)
[19:47:52.015] Timer tick, asking Buildbucket for the build status
[19:47:52.276] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:52.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:35:0) after 1m0s
[19:48:52.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:35:0)
[19:48:52.305] Timer tick, asking Buildbucket for the build status
[19:48:52.498] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:52.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:36:0) after 1m0s
[19:49:52.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:36:0)
[19:49:52.623] Timer tick, asking Buildbucket for the build status
[19:49:52.704] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:52.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:37:0) after 1m0s
[19:50:52.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:37:0)
[19:50:52.736] Timer tick, asking Buildbucket for the build status
[19:50:52.830] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:52.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:38:0) after 1m0s
[19:51:52.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:38:0)
[19:51:52.899] Timer tick, asking Buildbucket for the build status
[19:51:53.321] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:53.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:39:0) after 1m0s
[19:52:53.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:39:0)
[19:52:53.400] Timer tick, asking Buildbucket for the build status
[19:52:53.480] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:53.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:40:0) after 1m0s
[19:53:53.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:40:0)
[19:53:53.526] Timer tick, asking Buildbucket for the build status
[19:53:53.641] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:53.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:41:0) after 1m0s
[19:54:53.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:41:0)
[19:54:53.672] Timer tick, asking Buildbucket for the build status
[19:54:53.744] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:53.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:42:0) after 1m0s
[19:55:53.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:42:0)
[19:55:53.795] Timer tick, asking Buildbucket for the build status
[19:55:54.230] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:54.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:43:0) after 1m0s
[19:56:54.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:43:0)
[19:56:54.291] Timer tick, asking Buildbucket for the build status
[19:56:54.549] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:54.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:44:0) after 1m0s
[19:57:54.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:44:0)
[19:57:54.569] Timer tick, asking Buildbucket for the build status
[19:57:54.644] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:54.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:45:0) after 1m0s
[19:58:54.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:45:0)
[19:58:54.680] Timer tick, asking Buildbucket for the build status
[19:58:54.781] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:54.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:46:0) after 1m0s
[19:59:54.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:46:0)
[19:59:54.804] Timer tick, asking Buildbucket for the build status
[19:59:54.949] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:54.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:47:0) after 1m0s
[20:00:54.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:47:0)
[20:00:54.999] Timer tick, asking Buildbucket for the build status
[20:00:55.837] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:55.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:48:0) after 1m0s
[20:01:55.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:48:0)
[20:01:55.857] Timer tick, asking Buildbucket for the build status
[20:01:55.998] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:55.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:49:0) after 1m0s
[20:02:56.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:49:0)
[20:02:56.118] Timer tick, asking Buildbucket for the build status
[20:02:56.512] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:56.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:50:0) after 1m0s
[20:03:56.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:50:0)
[20:03:56.544] Timer tick, asking Buildbucket for the build status
[20:03:56.620] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:56.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:51:0) after 1m0s
[20:04:56.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:51:0)
[20:04:56.667] Timer tick, asking Buildbucket for the build status
[20:04:56.780] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:56.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:52:0) after 1m0s
[20:05:56.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:52:0)
[20:05:56.843] Timer tick, asking Buildbucket for the build status
[20:05:56.963] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:56.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:53:0) after 1m0s
[20:06:57.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:53:0)
[20:06:57.010] Timer tick, asking Buildbucket for the build status
[20:06:57.089] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:57.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:54:0) after 1m0s
[20:07:57.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:54:0)
[20:07:57.076] Timer tick, asking Buildbucket for the build status
[20:07:57.148] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:57.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:55:0) after 1m0s
[20:08:57.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:55:0)
[20:08:57.214] Timer tick, asking Buildbucket for the build status
[20:08:57.292] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:57.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:56:0) after 1m0s
[20:09:57.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:56:0)
[20:09:57.319] Timer tick, asking Buildbucket for the build status
[20:09:57.401] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:57.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:57:0) after 1m0s
[20:10:57.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:57:0)
[20:10:57.456] Timer tick, asking Buildbucket for the build status
[20:10:58.106] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:58.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:58:0) after 1m0s
[20:11:58.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:58:0)
[20:11:58.232] Timer tick, asking Buildbucket for the build status
[20:11:58.526] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:58.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:59:0) after 1m0s
[20:12:58.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:59:0)
[20:12:58.618] Timer tick, asking Buildbucket for the build status
[20:12:58.687] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:58.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:60:0) after 1m0s
[20:13:58.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:60:0)
[20:13:58.764] Timer tick, asking Buildbucket for the build status
[20:13:58.851] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:58.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:61:0) after 1m0s
[20:14:58.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:61:0)
[20:14:58.934] Timer tick, asking Buildbucket for the build status
[20:14:59.044] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:59.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:62:0) after 1m0s
[20:15:59.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:62:0)
[20:15:59.116] Timer tick, asking Buildbucket for the build status
[20:15:59.318] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:59.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:63:0) after 1m0s
[20:16:59.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:63:0)
[20:16:59.365] Timer tick, asking Buildbucket for the build status
[20:16:59.441] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:59.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:64:0) after 1m0s
[20:17:59.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:64:0)
[20:17:59.468] Timer tick, asking Buildbucket for the build status
[20:17:59.560] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:59.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:65:0) after 1m0s
[20:18:59.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:65:0)
[20:18:59.597] Timer tick, asking Buildbucket for the build status
[20:18:59.670] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:59.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:66:0) after 1m0s
[20:19:59.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:66:0)
[20:19:59.742] Timer tick, asking Buildbucket for the build status
[20:19:59.848] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:59.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:67:0) after 1m0s
[20:20:59.912] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:67:0)
[20:20:59.912] Timer tick, asking Buildbucket for the build status
[20:21:00.092] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:00.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:68:0) after 1m0s
[20:22:00.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:68:0)
[20:22:00.098] Timer tick, asking Buildbucket for the build status
[20:22:00.313] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:00.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:69:0) after 1m0s
[20:23:00.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:69:0)
[20:23:00.436] Timer tick, asking Buildbucket for the build status
[20:23:00.533] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:00.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:70:0) after 1m0s
[20:24:00.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:70:0)
[20:24:00.913] Timer tick, asking Buildbucket for the build status
[20:24:01.038] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:01.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:71:0) after 1m0s
[20:25:01.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:71:0)
[20:25:01.079] Timer tick, asking Buildbucket for the build status
[20:25:01.157] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:01.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:72:0) after 1m0s
[20:26:02.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:72:0)
[20:26:02.472] Timer tick, asking Buildbucket for the build status
[20:26:02.658] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:02.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:73:0) after 1m0s
[20:27:02.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:73:0)
[20:27:02.676] Timer tick, asking Buildbucket for the build status
[20:27:02.758] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:02.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:74:0) after 1m0s
[20:28:02.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:74:0)
[20:28:02.841] Timer tick, asking Buildbucket for the build status
[20:28:02.960] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:02.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:75:0) after 1m0s
[20:29:02.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:75:0)
[20:29:02.969] Timer tick, asking Buildbucket for the build status
[20:29:03.814] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:03.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:76:0) after 1m0s
[20:30:03.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:76:0)
[20:30:03.840] Timer tick, asking Buildbucket for the build status
[20:30:04.020] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:04.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:77:0) after 1m0s
[20:31:04.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:77:0)
[20:31:04.369] Timer tick, asking Buildbucket for the build status
[20:31:04.534] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:04.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:78:0) after 1m0s
[20:32:04.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:78:0)
[20:32:04.651] Timer tick, asking Buildbucket for the build status
[20:32:04.780] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:04.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:79:0) after 1m0s
[20:33:04.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:79:0)
[20:33:04.901] Timer tick, asking Buildbucket for the build status
[20:33:05.023] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:05.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:80:0) after 1m0s
[20:34:05.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:80:0)
[20:34:05.140] Timer tick, asking Buildbucket for the build status
[20:34:05.336] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:05.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:81:0) after 1m0s
[20:35:05.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:81:0)
[20:35:05.434] Timer tick, asking Buildbucket for the build status
[20:35:05.547] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:05.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:82:0) after 1m0s
[20:36:05.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:82:0)
[20:36:05.587] Timer tick, asking Buildbucket for the build status
[20:36:05.721] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:05.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:83:0) after 1m0s
[20:37:05.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:83:0)
[20:37:05.785] Timer tick, asking Buildbucket for the build status
[20:37:06.117] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:06.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:84:0) after 1m0s
[20:38:06.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:84:0)
[20:38:06.199] Timer tick, asking Buildbucket for the build status
[20:38:06.833] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:06.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:85:0) after 1m0s
[20:39:06.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:85:0)
[20:39:06.870] Timer tick, asking Buildbucket for the build status
[20:39:07.003] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:86:0) after 1m0s
[20:40:07.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:86:0)
[20:40:07.049] Timer tick, asking Buildbucket for the build status
[20:40:07.296] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:07.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:87:0) after 1m0s
[20:41:07.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:87:0)
[20:41:07.338] Timer tick, asking Buildbucket for the build status
[20:41:07.499] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:07.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:88:0) after 1m0s
[20:42:07.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:88:0)
[20:42:07.620] Timer tick, asking Buildbucket for the build status
[20:42:07.720] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:07.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:89:0) after 1m0s
[20:43:07.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:89:0)
[20:43:07.775] Timer tick, asking Buildbucket for the build status
[20:43:07.906] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:90:0) after 1m0s
[20:44:07.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:90:0)
[20:44:07.942] Timer tick, asking Buildbucket for the build status
[20:44:08.111] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:08.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:91:0) after 1m0s
[20:45:08.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:91:0)
[20:45:08.289] Timer tick, asking Buildbucket for the build status
[20:45:08.492] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:08.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:92:0) after 1m0s
[20:46:08.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:92:0)
[20:46:08.587] Timer tick, asking Buildbucket for the build status
[20:46:08.981] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:08.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:93:0) after 1m0s
[20:47:09.083] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:93:0)
[20:47:09.083] Timer tick, asking Buildbucket for the build status
[20:47:09.172] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:09.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:94:0) after 1m0s
[20:48:09.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:94:0)
[20:48:09.391] Timer tick, asking Buildbucket for the build status
[20:48:09.822] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:09.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:95:0) after 1m0s
[20:49:09.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:95:0)
[20:49:09.839] Timer tick, asking Buildbucket for the build status
[20:49:09.926] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:09.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:96:0) after 1m0s
[20:50:09.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:96:0)
[20:50:09.994] Timer tick, asking Buildbucket for the build status
[20:50:10.529] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:10.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:97:0) after 1m0s
[20:51:10.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:97:0)
[20:51:10.806] Timer tick, asking Buildbucket for the build status
[20:51:11.136] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:11.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:98:0) after 1m0s
[20:52:11.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:98:0)
[20:52:11.238] Timer tick, asking Buildbucket for the build status
[20:52:11.642] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:11.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:99:0) after 1m0s
[20:53:11.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:99:0)
[20:53:11.696] Timer tick, asking Buildbucket for the build status
[20:53:11.773] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:11.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:100:0) after 1m0s
[20:54:11.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:100:0)
[20:54:11.867] Timer tick, asking Buildbucket for the build status
[20:54:11.980] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:11.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:101:0) after 1m0s
[20:55:12.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:101:0)
[20:55:12.191] Timer tick, asking Buildbucket for the build status
[20:55:12.589] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:12.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:102:0) after 1m0s
[20:56:12.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:102:0)
[20:56:12.683] Timer tick, asking Buildbucket for the build status
[20:56:12.810] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:103:0) after 1m0s
[20:57:12.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:103:0)
[20:57:12.831] Timer tick, asking Buildbucket for the build status
[20:57:12.928] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:12.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:104:0) after 1m0s
[20:58:12.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:104:0)
[20:58:12.956] Timer tick, asking Buildbucket for the build status
[20:58:13.319] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:13.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:105:0) after 1m0s
[20:59:13.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:105:0)
[20:59:13.341] Timer tick, asking Buildbucket for the build status
[20:59:13.423] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:106:0) after 1m0s
[21:00:13.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:106:0)
[21:00:13.502] Timer tick, asking Buildbucket for the build status
[21:00:14.168] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:14.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:107:0) after 1m0s
[21:01:14.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:107:0)
[21:01:14.265] Timer tick, asking Buildbucket for the build status
[21:01:14.387] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:14.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:108:0) after 1m0s
[21:02:14.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:108:0)
[21:02:14.486] Timer tick, asking Buildbucket for the build status
[21:02:14.603] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:109:0) after 1m0s
[21:03:14.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:109:0)
[21:03:14.677] Timer tick, asking Buildbucket for the build status
[21:03:14.772] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:14.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:110:0) after 1m0s
[21:04:14.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:110:0)
[21:04:14.825] Timer tick, asking Buildbucket for the build status
[21:04:15.124] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:15.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:111:0) after 1m0s
[21:05:15.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:111:0)
[21:05:15.118] Timer tick, asking Buildbucket for the build status
[21:05:15.260] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:15.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:112:0) after 1m0s
[21:06:15.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:112:0)
[21:06:15.359] Timer tick, asking Buildbucket for the build status
[21:06:15.475] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:15.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:113:0) after 1m0s
[21:07:15.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:113:0)
[21:07:15.524] Timer tick, asking Buildbucket for the build status
[21:07:15.660] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:15.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:114:0) after 1m0s
[21:08:15.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:114:0)
[21:08:15.731] Timer tick, asking Buildbucket for the build status
[21:08:15.828] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:15.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:115:0) after 1m0s
[21:09:15.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:115:0)
[21:09:15.864] Timer tick, asking Buildbucket for the build status
[21:09:15.943] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:15.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:116:0) after 1m0s
[21:10:16.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:116:0)
[21:10:16.031] Timer tick, asking Buildbucket for the build status
[21:10:16.150] Build 8854841464605494256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:16.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020271526646247392:117:0) after 1m0s
[21:10:26.815] Received PubSub notification, asking Buildbucket for the build status
[21:10:26.981] Build 8854841464605494256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:10:26.981] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613769025355001",
"created_by": "project:chromium",
"created_ts": "1613762141564169",
"id": "8854841464605494256",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"01a2b121b12d389611987bf4082d495c905b0fb3\"}}",
"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\": \"01a2b121b12d389611987bf4082d495c905b0fb3\", \"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-9-d206\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17432, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"76d0e38bd706dbba287a25ba3fcde11e1f6fd516\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"01a2b121b12d389611987bf4082d495c905b0fb3\", \"got_revision_cp\": \"refs/heads/master@{#855807}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3ab17bd731f6d171c0a4a2ce68ebe7c0d33b0871\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"01a2b121b12d389611987bf4082d495c905b0fb3\", \"swarm_hashes_refs/heads/master(at){#855807}_without_patch\": {\"absl_hardening_tests\": \"2b4bd37b962c972fc4be21f615e0f5895f87ba3a\", \"accessibility_unittests\": \"c86e590646539b09c0b943d0cfcac096373721e0\", \"angle_unittests\": \"4b54fee7d0dd440cfbc056377dc34972790c958a\", \"app_shell_unittests\": \"9719219bd9034df37b110ed9d14cbb2977556651\", \"aura_unittests\": \"741fde0f8b138dc4ff4bba2d54641cfd1989797f\", \"base_unittests\": \"fb1aca1767703c570511ccd63ab0cc9f251891c9\", \"base_util_unittests\": \"bfe90f3761ee914f489da4a335abafc4d9152036\", \"blink_common_unittests\": \"43fed7fc53aaf30c978983f011633d585269639e\", \"blink_fuzzer_unittests\": \"2e11699496bd4748fbb15dc6b3d475deb52712cd\", \"blink_heap_unittests\": \"8f927726b871dfbb4a577009f1623d7b170ca439\", \"blink_platform_unittests\": \"fc6449da094f95a50634cc3429d7912f20dbdf39\", \"blink_unittests\": \"2e4dcd66a951be7d0ff505e07f5ed6500979a3be\", \"boringssl_crypto_tests\": \"fbd9afceb1749179f00449b4d90578791a31e980\", \"boringssl_ssl_tests\": \"46b282c754ba6d882672dac2702127d6bb8d85e7\", \"browser_switcher_bho_unittests\": \"caf23beba87cd9264584b441edc4fd30508d8b53\", \"browser_tests\": \"c00e73066f690397a064de2011286045efe218c5\", \"capture_unittests\": \"96f35fbaeea5a0e74323546efbe640bd1ffaf1e1\", \"cast_unittests\": \"bf521843d4151f6aac4844bfd701fab8b9580bfe\", \"cc_unittests\": \"de95f628ef29aca8da22259ec08c96f0f80e9d10\", \"chrome_app_unittests\": \"ef672e97fbb671240b0bb82fb707740154392bc0\", \"chrome_cleaner_unittests\": \"973d4b097bd878344c2ea1643d4781bcc275dd02\", \"chrome_elf_unittests\": \"b73d6f41220795f25e670333d14642038758eede\", \"chromedriver_unittests\": \"77c4f971ea2eec69c2c2e14b742d8b9f412bdc14\", \"components_browsertests\": \"c8b665aeeddc1ce9012b830f94f4a84127c28fac\", \"components_unittests\": \"f568228b3e03fdd70678a29cdc8f650a81f96439\", \"compositor_unittests\": \"e0e1972ada433b994954a304cf754be280824903\", \"content_browsertests\": \"b110e74ecc68ed392859cf7aa547053cc9d2e2a9\", \"content_unittests\": \"ffb72bc4e4290a7dff6ae149595a7700dfdd0b90\", \"courgette_unittests\": \"fdf5868f5aaed06b1e87bfef9e8565763a3309b8\", \"crashpad_tests\": \"a32ecccb8a565966c5b9ac4036deeab5c76bb3e3\", \"cronet_tests\": \"636b68870aa24c15c9f2b5cb110eb1b43c5b164e\", \"cronet_unittests\": \"1bca7d68cbc36c2ff84a2fe7466a38868cb2f171\", \"crypto_unittests\": \"082312dbe03e40dc9100d68a9dca2aa57162d87d\", \"delayloads_unittests\": \"01a9da69c88a0e3ff6e869c707dbf1f6379a3826\", \"device_unittests\": \"8b75d528f37c369b84012d5c7e36b8c836bea2fc\", \"display_unittests\": \"e7bc3db54362f228c6096cf7d28f1b1ce3fbdb68\", \"elevation_service_unittests\": \"fb13f76de4922b83a3268993dab84f707a7cecc2\", \"events_unittests\": \"9d5ca25f47a2a422f836b7d5d0f2f0d05bf22d26\", \"extensions_browsertests\": \"d01e2053d2396b2d87343275ce9bacc69ed409d7\", \"extensions_unittests\": \"852e45fbda90987ccf8a5302ab47e0b9f749901a\", \"filesystem_service_unittests\": \"0472abf6280c3f3680a1d3cd322599ac833b7307\", \"gcm_unit_tests\": \"198ec3cef14a026fc6fae75179aefd4afb0a5baa\", \"gcp_unittests\": \"9d9080d81ee94641382e02f13c7d00450d4640d2\", \"gfx_unittests\": \"39536545097c6c7c4af1808cb20c45ec7be1eb36\", \"gin_unittests\": \"6ff436061a068a767c8865c6f417da801533b57e\", \"google_apis_unittests\": \"b6e04e2906246639a3c6b528cb0b73c2a73960bf\", \"gpu_unittests\": \"ce982579f92a1b6518562d12a5e89d6e9e9448c2\", \"gwp_asan_unittests\": \"4c10f24471331502fcaacbda7dd633a1d0309a44\", \"headless_browsertests\": \"490f3f5762ce3944d6c62eb15d2e7ad66596a015\", \"headless_unittests\": \"bd8a38796f528e12dcb09b7e983cbeb792237d0f\", \"install_static_unittests\": \"35d5f07640da274d68f4ac984e329224dabba6ec\", \"installer_util_unittests\": \"3007ca35b24c19c536ceeb3c50d85d2d89c7ad4e\", \"interactive_ui_tests\": \"7c9ee62e371343a27491129f4a5973616ad1c980\", \"ipc_tests\": \"333d2be1d1b76f8aa4059d33f21dbb81a81bef90\", \"jingle_unittests\": \"19c67ede9c87b42db3b91552c69f6617c447c9b5\", \"latency_unittests\": \"615a9ac585d1d182b7b87378d102e98b0b1f62ef\", \"libjingle_xmpp_unittests\": \"a6aabbba3e27de57c61034369f1d5c4da3f6de60\", \"liburlpattern_unittests\": \"2d5badcddd1f7a62bd5e52e88064555049a2c935\", \"media_blink_unittests\": \"c1f80e972722469f644fb2de3c4207820dc4712d\", \"media_unittests\": \"6eb80c0eb544041b57170618c01f8e3fd7f0ceaa\", \"message_center_unittests\": \"83f2137b451dd0450409cfd7810b43a89ec4e42e\", \"midi_unittests\": \"62746e7ac26230c0436bca53bef3e0cc1a885272\", \"mojo_core_unittests\": \"ce85970d8a61a6cfe4b42fe8dacbc11b02077767\", \"mojo_unittests\": \"ff1085819b63eb4e5bb0941c5dc8a6a32143a23a\", \"nacl_loader_unittests\": \"268da314f85308f5d2406221ab8fe484eb6e1f02\", \"native_theme_unittests\": \"f2ed1a404c1a5c138ecd97d5307fd2b0688f2107\", \"net_unittests\": \"f3a3763e8d5b85aed96237cef537a5716a62ae7d\", \"notification_helper_unittests\": \"8f0f98fc605f92f8a49a3ff528dec955a6e543d4\", \"pdf_unittests\": \"1e2a04acb94417fbb44e58591e5402b0683a9b8a\", \"perfetto_unittests\": \"f60e35e151d01da5a37c45f2ed0e8f54a0d88266\", \"ppapi_unittests\": \"480ca3005030ab0be42b6f068159151731082b06\", \"printing_unittests\": \"c61f47ef5359adc0e56bf54889c22b930b2901f5\", \"remoting_unittests\": \"997bbe5eccaf9095e3a06d5dbbb2118757700ddc\", \"sbox_integration_tests\": \"a6479c324560065417ec39be08fff6c05d5d368b\", \"sbox_unittests\": \"8a36713f46c301314e3825ab5f93d83826f6630f\", \"sbox_validation_tests\": \"1f16127f7759c0910e3c3b9657b240abe155f5d6\", \"service_manager_unittests\": \"c97da1da6063048cf0ac9b6d1d90d2931ec0e244\", \"services_unittests\": \"48b1c3a2aaf2123bd4a6ca8d68c8224acfdcdd74\", \"setup_unittests\": \"24d631e4a170293f54e22340a09427e129493e9b\", \"shell_dialogs_unittests\": \"ed5f2c7b7f93529db790169986d874fc9a0d6044\", \"skia_unittests\": \"05e2da9cc25436debb0ba2d60440462db334ca57\", \"snapshot_unittests\": \"2b2a4f2bd21ebd4950d1b7f99d09166c0b6b2748\", \"sql_unittests\": \"32bb260bd833b41ac6f1fdcae6a075e44d3d3c00\", \"storage_unittests\": \"374b44df4d91c89adb6068dadf0f66c5e14d325f\", \"sync_integration_tests\": \"b7c0d9634d1c5e7ca350d24dbf72fb7b1756d87e\", \"traffic_annotation_auditor_unittests\": \"dc66b43a2e17f63f35931a2ccaef54eaddd35665\", \"ui_base_unittests\": \"928e68199572d353afaa498683847749b5baf515\", \"ui_touch_selection_unittests\": \"fe95c00448d661fd1781544fcd3f1c06ec82ba6a\", \"unit_tests\": \"284e3bc6404939ff5a27d7d7de54004669a3a3f8\", \"updater_tests\": \"581c958b3a75fe1f1145f0c6a36cd2c8f6e84dcc\", \"url_unittests\": \"b8f20ea9a6384170e6bfdaa0b1c5c142b85e8878\", \"views_unittests\": \"933463724dee2c762f1c657ea9685c6e274be5a0\", \"viz_unittests\": \"a8c9172c7c4ded085eec31008fcb1a7db6d5f6ed\", \"vr_common_unittests\": \"480c5fd0c62123870765c52c8b1b4873cd2bfcde\", \"vr_pixeltests\": \"c045a4a33c3398883ece7528d6cc3fd68ba0621d\", \"weblayer_browsertests\": \"2215fcc971d595ed4d43d7da3afe4b5ed729ac8f\", \"weblayer_unittests\": \"aba864b6104fc4d1803d484bd0110356dc522c97\", \"wm_unittests\": \"027db2fe2c6c248e22674a1502e215ceb4460e5a\", \"wtf_unittests\": \"7417e9da2b75c515bc264454a228990e6d5a5c3a\", \"zlib_unittests\": \"89124f3432fc4124ff231047a308d65b5f31f664\", \"zucchini_unittests\": \"473aca37f282d696b9162ef2450ead63db3a15b1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-9-d206\"], \"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\": [\"5706-397711c\"], \"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": "1613762450897743",
"status": "COMPLETED",
"status_changed_ts": "1613769025642435",
"tags": [
"build_address:luci.chromium.ci/win-asan/17432",
"builder:win-asan",
"buildset:commit/git/01a2b121b12d389611987bf4082d495c905b0fb3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/01a2b121b12d389611987bf4082d495c905b0fb3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020271526646247392",
"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/8854841464605494256/+/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:51d489a9013a3810",
"user_agent:luci-scheduler"
],
"updated_ts": "1613769025648482",
"url": "https://ci.chromium.org/b/8854841464605494256",
"utcnow_ts": "1613769026968491"
}
}
[21:10:26.981] Invocation finished in 1h54m46.747576723s with status SUCCEEDED