[01:56:44.760] New invocation is queued and will start shortly
[01:56:45.877] Starting the invocation (attempt 1)
[01:56:45.909] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:56:45.909] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:56:45.909] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020065099245694528",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020065099245694528",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"gitiles_ref:refs/heads/master"
]
}
[01:56:47.133] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613959006093677",
"id": "8854635037185135344",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613959006779421",
"tags": [
"build_address:luci.chromium.ci/win-asan/17461",
"builder:win-asan",
"buildset:commit/git/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020065099245694528",
"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/8854635037185135344/+/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": "1613959006779545",
"url": "https://ci.chromium.org/b/8854635037185135344",
"utcnow_ts": "1613959007109920"
}
}
[01:56:47.133] Task URL: https://ci.chromium.org/b/8854635037185135344
[01:56:47.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:2:0) after 1m0s
[01:56:57.269] Received PubSub notification, asking Buildbucket for the build status
[01:56:57.346] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:47.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:2:0)
[01:57:47.149] Timer tick, asking Buildbucket for the build status
[01:57:47.366] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:47.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:4:0) after 1m0s
[01:58:47.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:4:0)
[01:58:47.354] Timer tick, asking Buildbucket for the build status
[01:58:47.427] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:47.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:5:0) after 1m0s
[01:59:47.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:5:0)
[01:59:47.421] Timer tick, asking Buildbucket for the build status
[01:59:47.634] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:47.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:6:0) after 1m0s
[02:00:47.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:6:0)
[02:00:47.703] Timer tick, asking Buildbucket for the build status
[02:00:47.824] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:47.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:7:0) after 1m0s
[02:01:47.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:7:0)
[02:01:47.840] Timer tick, asking Buildbucket for the build status
[02:01:47.916] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:47.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:8:0) after 1m0s
[02:02:48.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:8:0)
[02:02:48.003] Timer tick, asking Buildbucket for the build status
[02:02:48.221] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:48.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:9:0) after 1m0s
[02:03:48.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:9:0)
[02:03:48.258] Timer tick, asking Buildbucket for the build status
[02:03:48.336] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:48.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:10:0) after 1m0s
[02:04:48.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:10:0)
[02:04:48.360] Timer tick, asking Buildbucket for the build status
[02:04:48.427] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:48.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:11:0) after 1m0s
[02:05:48.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:11:0)
[02:05:48.481] Timer tick, asking Buildbucket for the build status
[02:05:48.561] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:48.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:12:0) after 1m0s
[02:06:48.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:12:0)
[02:06:48.563] Timer tick, asking Buildbucket for the build status
[02:06:48.672] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:48.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:13:0) after 1m0s
[02:07:48.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:13:0)
[02:07:48.726] Timer tick, asking Buildbucket for the build status
[02:07:48.800] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:48.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:14:0) after 1m0s
[02:08:48.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:14:0)
[02:08:48.815] Timer tick, asking Buildbucket for the build status
[02:08:49.118] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:15:0) after 1m0s
[02:09:49.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:15:0)
[02:09:49.134] Timer tick, asking Buildbucket for the build status
[02:09:49.204] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:49.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:16:0) after 1m0s
[02:10:49.243] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:16:0)
[02:10:49.243] Timer tick, asking Buildbucket for the build status
[02:10:49.325] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:49.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:17:0) after 1m0s
[02:11:49.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:17:0)
[02:11:49.409] Timer tick, asking Buildbucket for the build status
[02:11:49.502] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:49.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:18:0) after 1m0s
[02:12:49.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:18:0)
[02:12:49.548] Timer tick, asking Buildbucket for the build status
[02:12:49.627] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:49.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:19:0) after 1m0s
[02:13:49.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:19:0)
[02:13:49.691] Timer tick, asking Buildbucket for the build status
[02:13:49.994] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:49.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:20:0) after 1m0s
[02:14:50.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:20:0)
[02:14:50.013] Timer tick, asking Buildbucket for the build status
[02:14:50.134] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:50.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:21:0) after 1m0s
[02:15:50.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:21:0)
[02:15:50.153] Timer tick, asking Buildbucket for the build status
[02:15:50.285] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:50.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:22:0) after 1m0s
[02:16:50.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:22:0)
[02:16:50.300] Timer tick, asking Buildbucket for the build status
[02:16:50.386] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:50.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:23:0) after 1m0s
[02:17:50.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:23:0)
[02:17:50.526] Timer tick, asking Buildbucket for the build status
[02:17:50.609] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:50.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:24:0) after 1m0s
[02:18:52.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:24:0)
[02:18:52.530] Timer tick, asking Buildbucket for the build status
[02:18:52.706] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:52.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:25:0) after 1m0s
[02:19:52.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:25:0)
[02:19:52.680] Timer tick, asking Buildbucket for the build status
[02:19:52.748] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:26:0) after 1m0s
[02:20:52.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:26:0)
[02:20:52.755] Timer tick, asking Buildbucket for the build status
[02:20:52.822] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:52.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:27:0) after 1m0s
[02:21:52.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:27:0)
[02:21:52.844] Timer tick, asking Buildbucket for the build status
[02:21:52.930] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:52.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:28:0) after 1m0s
[02:22:52.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:28:0)
[02:22:52.949] Timer tick, asking Buildbucket for the build status
[02:22:53.017] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:53.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:29:0) after 1m0s
[02:23:53.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:29:0)
[02:23:53.111] Timer tick, asking Buildbucket for the build status
[02:23:53.397] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:53.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:30:0) after 1m0s
[02:24:54.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:30:0)
[02:24:54.785] Timer tick, asking Buildbucket for the build status
[02:24:55.039] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:55.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:31:0) after 1m0s
[02:25:55.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:31:0)
[02:25:55.082] Timer tick, asking Buildbucket for the build status
[02:25:55.138] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:55.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:32:0) after 1m0s
[02:26:55.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:32:0)
[02:26:55.146] Timer tick, asking Buildbucket for the build status
[02:26:55.346] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:55.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:33:0) after 1m0s
[02:27:55.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:33:0)
[02:27:55.409] Timer tick, asking Buildbucket for the build status
[02:27:55.492] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:55.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:34:0) after 1m0s
[02:28:55.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:34:0)
[02:28:55.537] Timer tick, asking Buildbucket for the build status
[02:28:55.608] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:55.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:35:0) after 1m0s
[02:29:55.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:35:0)
[02:29:55.648] Timer tick, asking Buildbucket for the build status
[02:29:55.722] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:55.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:36:0) after 1m0s
[02:30:55.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:36:0)
[02:30:55.774] Timer tick, asking Buildbucket for the build status
[02:30:55.927] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:55.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:37:0) after 1m0s
[02:31:55.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:37:0)
[02:31:55.978] Timer tick, asking Buildbucket for the build status
[02:31:56.199] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:56.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:38:0) after 1m0s
[02:32:56.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:38:0)
[02:32:56.230] Timer tick, asking Buildbucket for the build status
[02:32:56.358] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:56.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:39:0) after 1m0s
[02:33:56.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:39:0)
[02:33:56.403] Timer tick, asking Buildbucket for the build status
[02:33:56.485] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:56.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:40:0) after 1m0s
[02:34:56.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:40:0)
[02:34:56.511] Timer tick, asking Buildbucket for the build status
[02:34:56.602] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:56.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:41:0) after 1m0s
[02:35:56.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:41:0)
[02:35:56.651] Timer tick, asking Buildbucket for the build status
[02:35:56.923] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:56.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:42:0) after 1m0s
[02:36:56.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:42:0)
[02:36:56.943] Timer tick, asking Buildbucket for the build status
[02:36:57.034] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:57.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:43:0) after 1m0s
[02:37:57.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:43:0)
[02:37:57.046] Timer tick, asking Buildbucket for the build status
[02:37:57.120] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:57.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:44:0) after 1m0s
[02:38:57.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:44:0)
[02:38:57.135] Timer tick, asking Buildbucket for the build status
[02:38:57.202] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:57.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:45:0) after 1m0s
[02:39:57.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:45:0)
[02:39:57.249] Timer tick, asking Buildbucket for the build status
[02:39:57.449] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:57.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:46:0) after 1m0s
[02:40:57.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:46:0)
[02:40:57.477] Timer tick, asking Buildbucket for the build status
[02:40:57.568] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:57.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:47:0) after 1m0s
[02:41:57.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:47:0)
[02:41:57.617] Timer tick, asking Buildbucket for the build status
[02:41:57.720] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:57.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:48:0) after 1m0s
[02:42:57.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:48:0)
[02:42:57.735] Timer tick, asking Buildbucket for the build status
[02:42:58.019] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:58.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:49:0) after 1m0s
[02:43:58.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:49:0)
[02:43:58.038] Timer tick, asking Buildbucket for the build status
[02:43:58.104] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:58.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:50:0) after 1m0s
[02:44:58.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:50:0)
[02:44:58.127] Timer tick, asking Buildbucket for the build status
[02:44:58.316] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:58.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:51:0) after 1m0s
[02:45:58.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:51:0)
[02:45:58.348] Timer tick, asking Buildbucket for the build status
[02:45:58.422] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:58.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:52:0) after 1m0s
[02:46:58.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:52:0)
[02:46:58.441] Timer tick, asking Buildbucket for the build status
[02:46:58.524] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:58.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:53:0) after 1m0s
[02:47:58.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:53:0)
[02:47:58.605] Timer tick, asking Buildbucket for the build status
[02:47:58.696] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:58.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:54:0) after 1m0s
[02:48:58.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:54:0)
[02:48:58.758] Timer tick, asking Buildbucket for the build status
[02:48:58.920] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:58.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:55:0) after 1m0s
[02:49:59.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:55:0)
[02:49:59.006] Timer tick, asking Buildbucket for the build status
[02:49:59.082] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:59.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:56:0) after 1m0s
[02:50:59.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:56:0)
[02:50:59.114] Timer tick, asking Buildbucket for the build status
[02:50:59.207] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:59.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:57:0) after 1m0s
[02:51:59.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:57:0)
[02:51:59.295] Timer tick, asking Buildbucket for the build status
[02:51:59.551] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:59.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:58:0) after 1m0s
[02:52:59.643] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:58:0)
[02:52:59.643] Timer tick, asking Buildbucket for the build status
[02:52:59.730] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:59.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:59:0) after 1m0s
[02:53:59.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:59:0)
[02:53:59.801] Timer tick, asking Buildbucket for the build status
[02:53:59.869] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:59.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:60:0) after 1m0s
[02:54:59.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:60:0)
[02:54:59.886] Timer tick, asking Buildbucket for the build status
[02:54:59.956] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:59.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:61:0) after 1m0s
[02:56:00.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:61:0)
[02:56:00.086] Timer tick, asking Buildbucket for the build status
[02:56:00.162] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:00.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:62:0) after 1m0s
[02:57:00.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:62:0)
[02:57:00.358] Timer tick, asking Buildbucket for the build status
[02:57:00.436] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:00.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:63:0) after 1m0s
[02:58:00.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:63:0)
[02:58:00.497] Timer tick, asking Buildbucket for the build status
[02:58:00.571] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:00.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:64:0) after 1m0s
[02:59:00.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:64:0)
[02:59:00.667] Timer tick, asking Buildbucket for the build status
[02:59:00.756] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:00.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:65:0) after 1m0s
[03:00:02.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:65:0)
[03:00:02.163] Timer tick, asking Buildbucket for the build status
[03:00:02.246] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:02.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:66:0) after 1m0s
[03:01:02.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:66:0)
[03:01:02.506] Timer tick, asking Buildbucket for the build status
[03:01:02.700] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:02.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:67:0) after 1m0s
[03:02:02.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:67:0)
[03:02:02.755] Timer tick, asking Buildbucket for the build status
[03:02:02.866] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:02.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:68:0) after 1m0s
[03:03:03.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:68:0)
[03:03:03.003] Timer tick, asking Buildbucket for the build status
[03:03:03.205] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:03.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:69:0) after 1m0s
[03:04:03.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:69:0)
[03:04:03.329] Timer tick, asking Buildbucket for the build status
[03:04:03.407] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:03.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:70:0) after 1m0s
[03:05:03.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:70:0)
[03:05:03.446] Timer tick, asking Buildbucket for the build status
[03:05:03.617] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:03.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:71:0) after 1m0s
[03:06:03.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:71:0)
[03:06:03.714] Timer tick, asking Buildbucket for the build status
[03:06:03.813] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:03.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:72:0) after 1m0s
[03:07:03.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:72:0)
[03:07:03.988] Timer tick, asking Buildbucket for the build status
[03:07:04.087] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:04.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:73:0) after 1m0s
[03:08:04.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:73:0)
[03:08:04.201] Timer tick, asking Buildbucket for the build status
[03:08:04.305] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:04.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:74:0) after 1m0s
[03:09:04.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:74:0)
[03:09:04.341] Timer tick, asking Buildbucket for the build status
[03:09:04.485] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:04.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:75:0) after 1m0s
[03:10:04.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:75:0)
[03:10:04.512] Timer tick, asking Buildbucket for the build status
[03:10:04.591] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:04.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:76:0) after 1m0s
[03:11:04.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:76:0)
[03:11:04.810] Timer tick, asking Buildbucket for the build status
[03:11:05.241] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:05.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:77:0) after 1m0s
[03:12:05.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:77:0)
[03:12:05.266] Timer tick, asking Buildbucket for the build status
[03:12:05.373] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:05.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:78:0) after 1m0s
[03:13:05.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:78:0)
[03:13:05.385] Timer tick, asking Buildbucket for the build status
[03:13:05.538] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:05.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:79:0) after 1m0s
[03:14:05.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:79:0)
[03:14:05.582] Timer tick, asking Buildbucket for the build status
[03:14:05.688] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:05.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:80:0) after 1m0s
[03:15:05.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:80:0)
[03:15:05.782] Timer tick, asking Buildbucket for the build status
[03:15:05.863] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:05.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:81:0) after 1m0s
[03:16:05.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:81:0)
[03:16:05.982] Timer tick, asking Buildbucket for the build status
[03:16:06.411] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:06.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:82:0) after 1m0s
[03:17:06.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:82:0)
[03:17:06.547] Timer tick, asking Buildbucket for the build status
[03:17:06.657] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:06.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:83:0) after 1m0s
[03:18:06.710] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:83:0)
[03:18:06.710] Timer tick, asking Buildbucket for the build status
[03:18:06.793] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:06.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:84:0) after 1m0s
[03:19:06.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:84:0)
[03:19:06.785] Timer tick, asking Buildbucket for the build status
[03:19:07.426] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:07.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:85:0) after 1m0s
[03:20:07.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:85:0)
[03:20:07.445] Timer tick, asking Buildbucket for the build status
[03:20:07.536] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:07.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:86:0) after 1m0s
[03:21:07.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:86:0)
[03:21:07.554] Timer tick, asking Buildbucket for the build status
[03:21:07.628] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:07.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:87:0) after 1m0s
[03:22:07.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:87:0)
[03:22:07.764] Timer tick, asking Buildbucket for the build status
[03:22:08.283] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:08.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:88:0) after 1m0s
[03:23:08.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:88:0)
[03:23:08.356] Timer tick, asking Buildbucket for the build status
[03:23:08.453] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:08.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:89:0) after 1m0s
[03:24:08.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:89:0)
[03:24:08.545] Timer tick, asking Buildbucket for the build status
[03:24:08.631] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:08.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:90:0) after 1m0s
[03:25:08.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:90:0)
[03:25:08.656] Timer tick, asking Buildbucket for the build status
[03:25:08.738] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:08.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:91:0) after 1m0s
[03:26:08.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:91:0)
[03:26:08.792] Timer tick, asking Buildbucket for the build status
[03:26:08.867] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:92:0) after 1m0s
[03:27:08.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:92:0)
[03:27:08.918] Timer tick, asking Buildbucket for the build status
[03:27:09.302] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:09.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:93:0) after 1m0s
[03:28:09.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:93:0)
[03:28:09.366] Timer tick, asking Buildbucket for the build status
[03:28:09.469] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:09.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:94:0) after 1m0s
[03:29:09.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:94:0)
[03:29:09.534] Timer tick, asking Buildbucket for the build status
[03:29:09.615] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:09.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:95:0) after 1m0s
[03:30:09.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:95:0)
[03:30:09.768] Timer tick, asking Buildbucket for the build status
[03:30:10.052] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:10.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:96:0) after 1m0s
[03:31:10.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:96:0)
[03:31:10.159] Timer tick, asking Buildbucket for the build status
[03:31:10.417] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:10.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:97:0) after 1m0s
[03:32:10.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:97:0)
[03:32:10.500] Timer tick, asking Buildbucket for the build status
[03:32:10.649] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:10.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:98:0) after 1m0s
[03:33:10.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:98:0)
[03:33:10.663] Timer tick, asking Buildbucket for the build status
[03:33:11.020] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:11.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:99:0) after 1m0s
[03:34:11.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:99:0)
[03:34:11.041] Timer tick, asking Buildbucket for the build status
[03:34:11.154] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:11.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:100:0) after 1m0s
[03:35:11.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:100:0)
[03:35:11.174] Timer tick, asking Buildbucket for the build status
[03:35:11.266] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:11.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:101:0) after 1m0s
[03:36:11.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:101:0)
[03:36:11.286] Timer tick, asking Buildbucket for the build status
[03:36:11.375] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:102:0) after 1m0s
[03:37:11.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:102:0)
[03:37:11.429] Timer tick, asking Buildbucket for the build status
[03:37:11.639] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:11.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:103:0) after 1m0s
[03:38:11.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:103:0)
[03:38:11.633] Timer tick, asking Buildbucket for the build status
[03:38:11.715] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:11.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:104:0) after 1m0s
[03:39:11.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:104:0)
[03:39:11.994] Timer tick, asking Buildbucket for the build status
[03:39:12.085] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:12.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:105:0) after 1m0s
[03:40:12.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:105:0)
[03:40:12.120] Timer tick, asking Buildbucket for the build status
[03:40:12.324] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:12.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:106:0) after 1m0s
[03:41:12.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:106:0)
[03:41:12.347] Timer tick, asking Buildbucket for the build status
[03:41:12.515] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:12.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:107:0) after 1m0s
[03:42:12.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:107:0)
[03:42:12.518] Timer tick, asking Buildbucket for the build status
[03:42:12.623] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:12.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:108:0) after 1m0s
[03:43:12.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:108:0)
[03:43:12.714] Timer tick, asking Buildbucket for the build status
[03:43:12.897] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:12.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:109:0) after 1m0s
[03:44:12.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:109:0)
[03:44:12.945] Timer tick, asking Buildbucket for the build status
[03:44:13.031] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:13.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:110:0) after 1m0s
[03:45:13.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:110:0)
[03:45:13.098] Timer tick, asking Buildbucket for the build status
[03:45:13.182] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:13.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:111:0) after 1m0s
[03:46:13.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:111:0)
[03:46:13.274] Timer tick, asking Buildbucket for the build status
[03:46:13.359] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:13.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:112:0) after 1m0s
[03:47:13.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:112:0)
[03:47:13.419] Timer tick, asking Buildbucket for the build status
[03:47:13.527] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:13.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:113:0) after 1m0s
[03:48:13.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:113:0)
[03:48:13.609] Timer tick, asking Buildbucket for the build status
[03:48:13.818] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:13.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:114:0) after 1m0s
[03:49:13.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:114:0)
[03:49:13.894] Timer tick, asking Buildbucket for the build status
[03:49:14.212] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:14.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:115:0) after 1m0s
[03:50:14.237] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:115:0)
[03:50:14.237] Timer tick, asking Buildbucket for the build status
[03:50:14.328] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:14.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:116:0) after 1m0s
[03:51:14.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:116:0)
[03:51:14.352] Timer tick, asking Buildbucket for the build status
[03:51:14.440] Build 8854635037185135344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:14.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020065099245694528:117:0) after 1m0s
[03:51:33.657] Received PubSub notification, asking Buildbucket for the build status
[03:51:33.778] Build 8854635037185135344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:51:33.778] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613965892766422",
"created_by": "project:chromium",
"created_ts": "1613959006093677",
"id": "8854635037185135344",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\"}}",
"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\": \"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\", \"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-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17461, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"c342647f5ad18f896d25bc25b5593dfa75085b3c\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\", \"got_revision_cp\": \"refs/heads/master@{#856157}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#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\": \"33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7\", \"swarm_hashes_refs/heads/master(at){#856157}_without_patch\": {\"absl_hardening_tests\": \"e04f1674c79d473a3e2ec7f43b98ab10afe8a948\", \"accessibility_unittests\": \"60fde4fb704951f0e4b6120a08f3026a58b4cd0c\", \"angle_unittests\": \"3ca3abdf3f27d2d308125caa1a0934dfefe0393e\", \"app_shell_unittests\": \"01bcbabc4cd629c699710023aa536f46be42a277\", \"aura_unittests\": \"c589de933761dbb201ca526b0a88e52d5553421e\", \"base_unittests\": \"1ceb22df0f743b895465b4bef1cb2600b451aa3c\", \"base_util_unittests\": \"4a24ae9205265c61bfb1a9220c14f27d1b9d590c\", \"blink_common_unittests\": \"532eaf00dc0d71aff3acfc63ab12253cfbfb2f85\", \"blink_fuzzer_unittests\": \"9a4358fb9009024802d8a96efcd0b39a3982b913\", \"blink_heap_unittests\": \"f87a5b37d66c582fdeba85a0d2237ba2df084260\", \"blink_platform_unittests\": \"46fdfeafdcc4b444be74489339c6c486eed1ef28\", \"blink_unittests\": \"265830791a44fe84f77718ab39d9f9660de9b2ac\", \"boringssl_crypto_tests\": \"2b0ecd2bff56d19ca45e48454a413c50a1b09777\", \"boringssl_ssl_tests\": \"8b3a5f3ddcb4b2e816e8227b339488d56dfa6f56\", \"browser_switcher_bho_unittests\": \"1211ef2ee8fb1f6eef648516423e73cdf0d102f9\", \"browser_tests\": \"23a1e593ff9acd4048ffc19295a3323722cc0101\", \"capture_unittests\": \"463c7875ea01e39ad85973bd4ab7447f6dc316bc\", \"cast_unittests\": \"c9ba3110d39aa63f21e515b4701052e48abd7b3f\", \"cc_unittests\": \"757eaa1578dbcc2b311a08bc2264e5e8df3004d1\", \"chrome_app_unittests\": \"e84b320e815e8c36b630f1288f8dd3a4d95c0569\", \"chrome_cleaner_unittests\": \"55e2f47cd864115643d7551ea3c064e2464eb5fc\", \"chrome_elf_unittests\": \"990559d195b12b1d46ef99d6eecb673b739f9395\", \"chromedriver_unittests\": \"b55667b821613b2a0e1b581ec011bbfb3ee4f28c\", \"components_browsertests\": \"347ae60e2bc13bb36709081d0989940e806306d4\", \"components_unittests\": \"8db7d240e3fb5982829b033ba6fcced7956edd7f\", \"compositor_unittests\": \"75b51f4364b41045608d81185ff226c8121d111c\", \"content_browsertests\": \"787c31ab7261c44d3909b3a315852db5a39af337\", \"content_unittests\": \"9ef01a7a6a9dbd41c65f13acbf91b19f63af65d1\", \"courgette_unittests\": \"3a8374677f99fe0e5c5776e38619bfada7d55a1d\", \"crashpad_tests\": \"7404d2fd388f46939e5fb883f9612ee165874e0f\", \"cronet_tests\": \"9a83294f13ad35a6cf82fdebc717dfbac040d35a\", \"cronet_unittests\": \"4979a12864a1c4e1330e7ce891d4369a2e32a4ad\", \"crypto_unittests\": \"bb7ab6223d44490aed5b625810f3bb94c6364428\", \"delayloads_unittests\": \"ebe8f91bbe3f78543baa6dba78d16df2905b7587\", \"device_unittests\": \"8cd1554c524da4b25c2f4a292f6e0148defbc2c3\", \"display_unittests\": \"0c4f5d584e2c1c5eeff2180855204802fdae2639\", \"elevation_service_unittests\": \"77606ce444ac91f16b54d56744458dbacceaa05d\", \"events_unittests\": \"c991ea16fdfe95c05a85b1385fecc7372cacb0a8\", \"extensions_browsertests\": \"8b6e9891070d1b3db0d4cf7284a5ac7b5834cb6f\", \"extensions_unittests\": \"bafc3a70271330aaf1a855b49c7e27de0cd20006\", \"filesystem_service_unittests\": \"894e8d9357c459cbee6bb5caa66fe77b9dcf7971\", \"gcm_unit_tests\": \"24851e5cf10fc135255713fac97c693863cf0a73\", \"gcp_unittests\": \"e0c05bf8662a7251b9f760e09adedffcaf385847\", \"gfx_unittests\": \"de4731e4450e4ae75f8402a6842184c59e009ca0\", \"gin_unittests\": \"4870a5d97c4ee8fa44241007482db1c691266529\", \"google_apis_unittests\": \"c7d3521637b26bdfac5393d97b0e280bd8bde35a\", \"gpu_unittests\": \"c4d4a70221cf2fa879a1a32b3f9bcde0969f3917\", \"gwp_asan_unittests\": \"c00f048445175ea5a75d5a5c9d055469a4f4a0e0\", \"headless_browsertests\": \"4ae99c139894e1a7385ade762927611158d7fec6\", \"headless_unittests\": \"d0755afc79198e312ec366198a15f14b7c73b431\", \"install_static_unittests\": \"8202ce095aef2ad17f9d4fb46b5808e883f0276e\", \"installer_util_unittests\": \"a64a22cf3226a853d38365b130ecac0558fdba86\", \"interactive_ui_tests\": \"e3d1384bbc053ecd5a636278a9f1bf7c6427b3de\", \"ipc_tests\": \"3d021fd03e790946e8fb17d066ac2cf55385e4cd\", \"jingle_unittests\": \"2387f7f8ccaf3b5e86c265186b2747625bcbec3a\", \"latency_unittests\": \"810a5adc2e5f3a5f4d7e0e85c967d34de4c093c6\", \"libjingle_xmpp_unittests\": \"1838b44993b93f95f7ac96d3353eea76732d49b2\", \"liburlpattern_unittests\": \"c0d6dbc61365d645cf1f0d3e3bac5a1d4c05a510\", \"media_blink_unittests\": \"e066afb8b076eaec68bf9ca9f3d5d0c41448d995\", \"media_unittests\": \"5bd587da2220262879c4c10b9c88911223de3e6b\", \"message_center_unittests\": \"e7af6702af68d48b454bb58d40605529ee1c148d\", \"midi_unittests\": \"ef799d0780a0fd3a9692026fb544836f013c613c\", \"mojo_core_unittests\": \"f06ee34a8e63aa33bd666172a5eeb4cbdae01946\", \"mojo_unittests\": \"7b097d711609976cbe792e70b9b01422e472f3fd\", \"nacl_loader_unittests\": \"7cfd952ed0ef829cabdd319f0af127a1fa9a792d\", \"native_theme_unittests\": \"0b69c3d475061b683ff6b60101272ada5bceaba7\", \"net_unittests\": \"ee6230e4671b3460bde0ccfb2bf6bc122e624afc\", \"notification_helper_unittests\": \"460283c90a88e7cf91d65170b11e0e474e0c44e2\", \"pdf_unittests\": \"e28ab56eaa6062634b8b7d40003f5cfcaf704834\", \"perfetto_unittests\": \"b29ca25b2015564b48607123201865eb7a0deb08\", \"ppapi_unittests\": \"b34098b8a46f08dda6fc9542717cc9149f6d4340\", \"printing_unittests\": \"e8a3ca52099d20d1f232ac02e8319a59b5b18c4b\", \"remoting_unittests\": \"5170aeb7e8223aea4658d678cfff6936828fb440\", \"sbox_integration_tests\": \"3995e50329370ea0713d1b92ee85bf47a43cc2fe\", \"sbox_unittests\": \"4f22d4da6535f959b0d550c8cf0b5aabb427af7f\", \"sbox_validation_tests\": \"c5e991b12786e38905ad66add06f53bdbb7abee0\", \"service_manager_unittests\": \"84e59031c18384eede41ef5a79400408a363417b\", \"services_unittests\": \"f453af0bc7475b65629b152d3b339eb952792d75\", \"setup_unittests\": \"e5b7ce1c0661e4138cd162daeca42af49e637f03\", \"shell_dialogs_unittests\": \"cd8c86519caa47b729174489c60b22ba03702336\", \"skia_unittests\": \"80c5fcbe9de85e38a92a4e3fcddf4efac133b38a\", \"snapshot_unittests\": \"3d4608341a3e58d085c0a00848f5e5a5f94ac549\", \"sql_unittests\": \"5b323fa2f39d43d5c9dc9b266449c526ff2bf153\", \"storage_unittests\": \"ebc709b46eb2d4ae3b3abb18f1bca7c3880467c7\", \"sync_integration_tests\": \"e974bdb36677f9308a3bf1da2ecb74608a5d69cb\", \"traffic_annotation_auditor_unittests\": \"774059a4d1525c99a60dd3eee241c4046b561136\", \"ui_base_unittests\": \"140fe24860100d1af7f5e98df62a559f6c8f4e28\", \"ui_touch_selection_unittests\": \"a2d815c1c3f5aeb3235e44615b6dc3ba49f40bea\", \"unit_tests\": \"f8305f026996431781443b25e46009b72eff3900\", \"updater_tests\": \"8898b14a7e645be60ca282306ca25fda5b67858d\", \"url_unittests\": \"6902a7d04e4fa2df1a806861575fd250457a55e2\", \"views_unittests\": \"129f48cf993c10ea7f00ba69aaa321293ee7d983\", \"viz_unittests\": \"0f983774e3957eee8450e4124771a6648e4db96a\", \"vr_common_unittests\": \"09a62256609e36c412860c44f051f72019b2b8f8\", \"vr_pixeltests\": \"1bc1707f779efbf32c0478f47175200003a12be5\", \"weblayer_browsertests\": \"caef55bd293318c81c7deaea9971c6a120287e15\", \"weblayer_unittests\": \"9215802a233daf0c9ac6fb095de8d9ff05e45a97\", \"wm_unittests\": \"8b3fc474690bcdbfbc990d0dd32fabedfc8067bb\", \"wtf_unittests\": \"e2edc6ee55b57931c606cea43aee2b1f4b05fb0f\", \"zlib_unittests\": \"d17ddf218a891d025d74dea3cd99a9a800ef8238\", \"zucchini_unittests\": \"9907891d20b99c8b09101c204aa768f0902fbb25\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xpf4\"], \"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": "1613959016544069",
"status": "COMPLETED",
"status_changed_ts": "1613965893136653",
"tags": [
"build_address:luci.chromium.ci/win-asan/17461",
"builder:win-asan",
"buildset:commit/git/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/33ab7c82cdba3fdf97b1628d585ec49a8c4e37b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020065099245694528",
"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/8854635037185135344/+/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:51e045953a8f7910",
"user_agent:luci-scheduler"
],
"updated_ts": "1613965893141710",
"url": "https://ci.chromium.org/b/8854635037185135344",
"utcnow_ts": "1613965893770945"
}
}
[03:51:33.778] Invocation finished in 1h54m49.034140685s with status SUCCEEDED