[15:44:16.620] New invocation is queued and will start shortly
[15:44:18.979] Starting the invocation (attempt 1)
[15:44:19.104] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:44:19.128] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:44:19.128] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025448853482354608",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"67eba39027358ac4b99651c30db81e89684f37f8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025448853482354608",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/67eba39027358ac4b99651c30db81e89684f37f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67eba39027358ac4b99651c30db81e89684f37f8",
"gitiles_ref:refs/heads/master"
]
}
[15:44:21.100] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608824660474553",
"id": "8860018788777063200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"67eba39027358ac4b99651c30db81e89684f37f8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608824660893908",
"tags": [
"build_address:luci.chromium.ci/win-asan/16425",
"builder:win-asan",
"buildset:commit/git/67eba39027358ac4b99651c30db81e89684f37f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67eba39027358ac4b99651c30db81e89684f37f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025448853482354608",
"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/8860018788777063200/+/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": "1608824660894039",
"url": "https://ci.chromium.org/b/8860018788777063200",
"utcnow_ts": "1608824661091004"
}
}
[15:44:21.101] Task URL: https://ci.chromium.org/b/8860018788777063200
[15:44:21.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:2:0) after 1m0s
[15:45:37.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:2:0)
[15:45:37.106] Timer tick, asking Buildbucket for the build status
[15:45:37.275] Build 8860018788777063200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:37.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:3:0) after 1m0s
[15:46:37.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:3:0)
[15:46:37.331] Timer tick, asking Buildbucket for the build status
[15:46:37.603] Build 8860018788777063200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:37.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:4:0) after 1m0s
[15:47:37.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:4:0)
[15:47:37.674] Timer tick, asking Buildbucket for the build status
[15:47:37.761] Build 8860018788777063200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:37.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:5:0) after 1m0s
[15:48:37.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:5:0)
[15:48:37.766] Timer tick, asking Buildbucket for the build status
[15:48:37.831] Build 8860018788777063200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:37.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:6:0) after 1m0s
[15:49:37.406] Received PubSub notification, asking Buildbucket for the build status
[15:49:37.641] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:37.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:6:0)
[15:49:37.850] Timer tick, asking Buildbucket for the build status
[15:49:37.926] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:37.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:8:0) after 1m0s
[15:50:37.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:8:0)
[15:50:37.980] Timer tick, asking Buildbucket for the build status
[15:50:38.404] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:38.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:9:0) after 1m0s
[15:51:38.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:9:0)
[15:51:38.460] Timer tick, asking Buildbucket for the build status
[15:51:38.545] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:38.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:10:0) after 1m0s
[15:52:38.560] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:10:0)
[15:52:38.560] Timer tick, asking Buildbucket for the build status
[15:52:38.909] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:38.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:11:0) after 1m0s
[15:53:38.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:11:0)
[15:53:38.984] Timer tick, asking Buildbucket for the build status
[15:53:39.102] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:39.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:12:0) after 1m0s
[15:54:39.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:12:0)
[15:54:39.175] Timer tick, asking Buildbucket for the build status
[15:54:39.235] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:39.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:13:0) after 1m0s
[15:55:39.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:13:0)
[15:55:39.323] Timer tick, asking Buildbucket for the build status
[15:55:39.408] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:14:0) after 1m0s
[15:56:39.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:14:0)
[15:56:39.489] Timer tick, asking Buildbucket for the build status
[15:56:39.625] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:39.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:15:0) after 1m0s
[15:57:39.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:15:0)
[15:57:39.730] Timer tick, asking Buildbucket for the build status
[15:57:39.788] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:39.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:16:0) after 1m0s
[15:58:39.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:16:0)
[15:58:39.911] Timer tick, asking Buildbucket for the build status
[15:58:39.963] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:39.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:17:0) after 1m0s
[15:59:39.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:17:0)
[15:59:39.995] Timer tick, asking Buildbucket for the build status
[15:59:40.382] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:40.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:18:0) after 1m0s
[16:00:40.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:18:0)
[16:00:40.368] Timer tick, asking Buildbucket for the build status
[16:00:40.480] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:40.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:19:0) after 1m0s
[16:01:40.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:19:0)
[16:01:40.633] Timer tick, asking Buildbucket for the build status
[16:01:40.695] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:40.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:20:0) after 1m0s
[16:02:40.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:20:0)
[16:02:40.884] Timer tick, asking Buildbucket for the build status
[16:02:40.936] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:40.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:21:0) after 1m0s
[16:03:41.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:21:0)
[16:03:41.562] Timer tick, asking Buildbucket for the build status
[16:03:41.905] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:41.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:22:0) after 1m0s
[16:04:42.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:22:0)
[16:04:42.217] Timer tick, asking Buildbucket for the build status
[16:04:42.338] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:42.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:23:0) after 1m0s
[16:05:42.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:23:0)
[16:05:42.547] Timer tick, asking Buildbucket for the build status
[16:05:42.631] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:42.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:24:0) after 1m0s
[16:06:42.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:24:0)
[16:06:42.774] Timer tick, asking Buildbucket for the build status
[16:06:43.036] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:43.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:25:0) after 1m0s
[16:07:43.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:25:0)
[16:07:43.062] Timer tick, asking Buildbucket for the build status
[16:07:43.431] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:43.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:26:0) after 1m0s
[16:08:43.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:26:0)
[16:08:43.460] Timer tick, asking Buildbucket for the build status
[16:08:43.526] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:43.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:27:0) after 1m0s
[16:09:43.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:27:0)
[16:09:43.582] Timer tick, asking Buildbucket for the build status
[16:09:43.633] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:43.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:28:0) after 1m0s
[16:10:43.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:28:0)
[16:10:43.637] Timer tick, asking Buildbucket for the build status
[16:10:43.782] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:43.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:29:0) after 1m0s
[16:11:43.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:29:0)
[16:11:43.892] Timer tick, asking Buildbucket for the build status
[16:11:44.137] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:44.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:30:0) after 1m0s
[16:12:44.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:30:0)
[16:12:44.131] Timer tick, asking Buildbucket for the build status
[16:12:44.193] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:44.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:31:0) after 1m0s
[16:13:44.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:31:0)
[16:13:44.301] Timer tick, asking Buildbucket for the build status
[16:13:44.373] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:44.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:32:0) after 1m0s
[16:14:44.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:32:0)
[16:14:44.461] Timer tick, asking Buildbucket for the build status
[16:14:44.539] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:33:0) after 1m0s
[16:15:44.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:33:0)
[16:15:44.624] Timer tick, asking Buildbucket for the build status
[16:15:44.744] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:44.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:34:0) after 1m0s
[16:16:44.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:34:0)
[16:16:44.819] Timer tick, asking Buildbucket for the build status
[16:16:45.120] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:45.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:35:0) after 1m0s
[16:17:45.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:35:0)
[16:17:45.316] Timer tick, asking Buildbucket for the build status
[16:17:45.429] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:45.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:36:0) after 1m0s
[16:18:45.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:36:0)
[16:18:45.477] Timer tick, asking Buildbucket for the build status
[16:18:45.783] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:45.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:37:0) after 1m0s
[16:19:45.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:37:0)
[16:19:45.830] Timer tick, asking Buildbucket for the build status
[16:19:45.887] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:45.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:38:0) after 1m0s
[16:20:45.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:38:0)
[16:20:45.917] Timer tick, asking Buildbucket for the build status
[16:20:46.501] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:46.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:39:0) after 1m0s
[16:21:46.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:39:0)
[16:21:46.678] Timer tick, asking Buildbucket for the build status
[16:21:46.776] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:46.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:40:0) after 1m0s
[16:22:46.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:40:0)
[16:22:46.840] Timer tick, asking Buildbucket for the build status
[16:22:46.985] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:46.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:41:0) after 1m0s
[16:23:47.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:41:0)
[16:23:47.038] Timer tick, asking Buildbucket for the build status
[16:23:47.124] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:47.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:42:0) after 1m0s
[16:24:47.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:42:0)
[16:24:47.529] Timer tick, asking Buildbucket for the build status
[16:24:47.674] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:47.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:43:0) after 1m0s
[16:25:47.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:43:0)
[16:25:47.825] Timer tick, asking Buildbucket for the build status
[16:25:47.916] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:47.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:44:0) after 1m0s
[16:26:48.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:44:0)
[16:26:48.008] Timer tick, asking Buildbucket for the build status
[16:26:48.056] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:45:0) after 1m0s
[16:27:48.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:45:0)
[16:27:48.089] Timer tick, asking Buildbucket for the build status
[16:27:48.146] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:48.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:46:0) after 1m0s
[16:28:48.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:46:0)
[16:28:48.296] Timer tick, asking Buildbucket for the build status
[16:28:48.431] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:48.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:47:0) after 1m0s
[16:29:48.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:47:0)
[16:29:48.486] Timer tick, asking Buildbucket for the build status
[16:29:48.534] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:48.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:48:0) after 1m0s
[16:30:48.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:48:0)
[16:30:48.579] Timer tick, asking Buildbucket for the build status
[16:30:48.665] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:48.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:49:0) after 1m0s
[16:31:48.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:49:0)
[16:31:48.725] Timer tick, asking Buildbucket for the build status
[16:31:48.790] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:48.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:50:0) after 1m0s
[16:32:48.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:50:0)
[16:32:48.874] Timer tick, asking Buildbucket for the build status
[16:32:49.040] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:49.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:51:0) after 1m0s
[16:33:49.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:51:0)
[16:33:49.063] Timer tick, asking Buildbucket for the build status
[16:33:49.252] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:49.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:52:0) after 1m0s
[16:34:49.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:52:0)
[16:34:49.248] Timer tick, asking Buildbucket for the build status
[16:34:49.309] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:49.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:53:0) after 1m0s
[16:35:50.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:53:0)
[16:35:50.685] Timer tick, asking Buildbucket for the build status
[16:35:51.109] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:51.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:54:0) after 1m0s
[16:36:51.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:54:0)
[16:36:51.167] Timer tick, asking Buildbucket for the build status
[16:36:51.236] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:51.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:55:0) after 1m0s
[16:37:51.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:55:0)
[16:37:51.262] Timer tick, asking Buildbucket for the build status
[16:37:51.320] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:51.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:56:0) after 1m0s
[16:38:51.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:56:0)
[16:38:51.339] Timer tick, asking Buildbucket for the build status
[16:38:51.392] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:57:0) after 1m0s
[16:39:51.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:57:0)
[16:39:51.495] Timer tick, asking Buildbucket for the build status
[16:39:51.556] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:51.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:58:0) after 1m0s
[16:40:51.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:58:0)
[16:40:51.668] Timer tick, asking Buildbucket for the build status
[16:40:51.764] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:51.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:59:0) after 1m0s
[16:41:51.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:59:0)
[16:41:51.818] Timer tick, asking Buildbucket for the build status
[16:41:51.875] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:60:0) after 1m0s
[16:42:51.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:60:0)
[16:42:51.987] Timer tick, asking Buildbucket for the build status
[16:42:52.110] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:52.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:61:0) after 1m0s
[16:43:52.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:61:0)
[16:43:52.191] Timer tick, asking Buildbucket for the build status
[16:43:52.379] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:52.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:62:0) after 1m0s
[16:44:52.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:62:0)
[16:44:52.468] Timer tick, asking Buildbucket for the build status
[16:44:52.681] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:52.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:63:0) after 1m0s
[16:45:52.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:63:0)
[16:45:52.923] Timer tick, asking Buildbucket for the build status
[16:45:53.064] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:53.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:64:0) after 1m0s
[16:46:53.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:64:0)
[16:46:53.095] Timer tick, asking Buildbucket for the build status
[16:46:53.164] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:53.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:65:0) after 1m0s
[16:47:53.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:65:0)
[16:47:53.208] Timer tick, asking Buildbucket for the build status
[16:47:53.418] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:53.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:66:0) after 1m0s
[16:48:53.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:66:0)
[16:48:53.467] Timer tick, asking Buildbucket for the build status
[16:48:53.521] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:53.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:67:0) after 1m0s
[16:49:53.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:67:0)
[16:49:53.504] Timer tick, asking Buildbucket for the build status
[16:49:53.598] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:53.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:68:0) after 1m0s
[16:50:53.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:68:0)
[16:50:53.639] Timer tick, asking Buildbucket for the build status
[16:50:53.908] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:53.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:69:0) after 1m0s
[16:51:53.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:69:0)
[16:51:53.886] Timer tick, asking Buildbucket for the build status
[16:51:53.950] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:53.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:70:0) after 1m0s
[16:52:54.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:70:0)
[16:52:54.033] Timer tick, asking Buildbucket for the build status
[16:52:54.315] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:54.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:71:0) after 1m0s
[16:53:54.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:71:0)
[16:53:54.408] Timer tick, asking Buildbucket for the build status
[16:53:54.558] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:54.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:72:0) after 1m0s
[16:54:54.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:72:0)
[16:54:54.600] Timer tick, asking Buildbucket for the build status
[16:54:54.987] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:54.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:73:0) after 1m0s
[16:55:54.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:73:0)
[16:55:54.969] Timer tick, asking Buildbucket for the build status
[16:55:55.072] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:55.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:74:0) after 1m0s
[16:56:55.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:74:0)
[16:56:55.121] Timer tick, asking Buildbucket for the build status
[16:56:55.219] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:55.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:75:0) after 1m0s
[16:57:55.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:75:0)
[16:57:55.258] Timer tick, asking Buildbucket for the build status
[16:57:55.339] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:76:0) after 1m0s
[16:58:55.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:76:0)
[16:58:55.448] Timer tick, asking Buildbucket for the build status
[16:58:55.809] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:77:0) after 1m0s
[16:59:55.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:77:0)
[16:59:55.891] Timer tick, asking Buildbucket for the build status
[16:59:56.317] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:56.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:78:0) after 1m0s
[17:00:56.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:78:0)
[17:00:56.444] Timer tick, asking Buildbucket for the build status
[17:00:56.550] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:56.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:79:0) after 1m0s
[17:01:57.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:79:0)
[17:01:57.192] Timer tick, asking Buildbucket for the build status
[17:01:57.378] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:57.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:80:0) after 1m0s
[17:02:57.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:80:0)
[17:02:57.716] Timer tick, asking Buildbucket for the build status
[17:02:57.880] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:57.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:81:0) after 1m0s
[17:03:58.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:81:0)
[17:03:58.506] Timer tick, asking Buildbucket for the build status
[17:03:58.739] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:58.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:82:0) after 1m0s
[17:04:59.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:82:0)
[17:04:59.085] Timer tick, asking Buildbucket for the build status
[17:04:59.212] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:59.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:83:0) after 1m0s
[17:05:59.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:83:0)
[17:05:59.365] Timer tick, asking Buildbucket for the build status
[17:05:59.477] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:59.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:84:0) after 1m0s
[17:06:59.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:84:0)
[17:06:59.532] Timer tick, asking Buildbucket for the build status
[17:06:59.928] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:59.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:85:0) after 1m0s
[17:07:59.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:85:0)
[17:07:59.949] Timer tick, asking Buildbucket for the build status
[17:08:00.235] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:00.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:86:0) after 1m0s
[17:09:00.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:86:0)
[17:09:00.256] Timer tick, asking Buildbucket for the build status
[17:09:00.332] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:00.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:87:0) after 1m0s
[17:10:00.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:87:0)
[17:10:00.353] Timer tick, asking Buildbucket for the build status
[17:10:00.490] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:00.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:88:0) after 1m0s
[17:11:01.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:88:0)
[17:11:01.157] Timer tick, asking Buildbucket for the build status
[17:11:01.503] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:01.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:89:0) after 1m0s
[17:12:01.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:89:0)
[17:12:01.831] Timer tick, asking Buildbucket for the build status
[17:12:01.924] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:01.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:90:0) after 1m0s
[17:13:02.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:90:0)
[17:13:02.025] Timer tick, asking Buildbucket for the build status
[17:13:02.100] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:02.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:91:0) after 1m0s
[17:14:02.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:91:0)
[17:14:02.657] Timer tick, asking Buildbucket for the build status
[17:14:02.762] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:02.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:92:0) after 1m0s
[17:15:02.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:92:0)
[17:15:02.888] Timer tick, asking Buildbucket for the build status
[17:15:02.979] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:02.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:93:0) after 1m0s
[17:16:03.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:93:0)
[17:16:03.008] Timer tick, asking Buildbucket for the build status
[17:16:03.458] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:03.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:94:0) after 1m0s
[17:17:03.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:94:0)
[17:17:03.530] Timer tick, asking Buildbucket for the build status
[17:17:03.811] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:03.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:95:0) after 1m0s
[17:18:03.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:95:0)
[17:18:03.837] Timer tick, asking Buildbucket for the build status
[17:18:03.947] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:03.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:96:0) after 1m0s
[17:19:03.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:96:0)
[17:19:03.926] Timer tick, asking Buildbucket for the build status
[17:19:04.143] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:04.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:97:0) after 1m0s
[17:20:04.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:97:0)
[17:20:04.328] Timer tick, asking Buildbucket for the build status
[17:20:04.448] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:04.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:98:0) after 1m0s
[17:21:04.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:98:0)
[17:21:04.505] Timer tick, asking Buildbucket for the build status
[17:21:04.839] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:04.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:99:0) after 1m0s
[17:22:04.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:99:0)
[17:22:04.824] Timer tick, asking Buildbucket for the build status
[17:22:05.742] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:05.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:100:0) after 1m0s
[17:23:05.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:100:0)
[17:23:05.810] Timer tick, asking Buildbucket for the build status
[17:23:06.264] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:06.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:101:0) after 1m0s
[17:24:06.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:101:0)
[17:24:06.359] Timer tick, asking Buildbucket for the build status
[17:24:07.076] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:07.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:102:0) after 1m0s
[17:25:07.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:102:0)
[17:25:07.087] Timer tick, asking Buildbucket for the build status
[17:25:07.175] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:07.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:103:0) after 1m0s
[17:26:07.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:103:0)
[17:26:07.224] Timer tick, asking Buildbucket for the build status
[17:26:07.291] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:07.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:104:0) after 1m0s
[17:27:07.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:104:0)
[17:27:07.415] Timer tick, asking Buildbucket for the build status
[17:27:07.767] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:07.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:105:0) after 1m0s
[17:28:07.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:105:0)
[17:28:07.797] Timer tick, asking Buildbucket for the build status
[17:28:07.865] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:106:0) after 1m0s
[17:29:07.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:106:0)
[17:29:07.918] Timer tick, asking Buildbucket for the build status
[17:29:07.997] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:07.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:107:0) after 1m0s
[17:30:08.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:107:0)
[17:30:08.094] Timer tick, asking Buildbucket for the build status
[17:30:08.283] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:08.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:108:0) after 1m0s
[17:31:08.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:108:0)
[17:31:08.317] Timer tick, asking Buildbucket for the build status
[17:31:08.392] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:109:0) after 1m0s
[17:32:08.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:109:0)
[17:32:08.452] Timer tick, asking Buildbucket for the build status
[17:32:08.683] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:08.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:110:0) after 1m0s
[17:33:08.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:110:0)
[17:33:08.693] Timer tick, asking Buildbucket for the build status
[17:33:08.796] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:08.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:111:0) after 1m0s
[17:34:08.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:111:0)
[17:34:08.853] Timer tick, asking Buildbucket for the build status
[17:34:08.930] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:08.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:112:0) after 1m0s
[17:35:09.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:112:0)
[17:35:09.067] Timer tick, asking Buildbucket for the build status
[17:35:09.168] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:09.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:113:0) after 1m0s
[17:36:09.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:113:0)
[17:36:09.191] Timer tick, asking Buildbucket for the build status
[17:36:09.592] Build 8860018788777063200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:09.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025448853482354608:114:0) after 1m0s
[17:36:30.656] Received PubSub notification, asking Buildbucket for the build status
[17:36:30.721] Build 8860018788777063200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:36:30.721] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608831389572835",
"created_by": "project:chromium",
"created_ts": "1608824660474553",
"id": "8860018788777063200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"67eba39027358ac4b99651c30db81e89684f37f8\"}}",
"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\": \"67eba39027358ac4b99651c30db81e89684f37f8\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16425, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"cde0e3ab3d710ca9838d226873462c5f093f60bd\", \"got_dawn_revision\": \"700809a7f75bab9df6d1195153ea1cbfb078046c\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"67eba39027358ac4b99651c30db81e89684f37f8\", \"got_revision_cp\": \"refs/heads/master@{#839244}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"789bfeb2a1563cefd3c2dbf98d0e08edbaddbf28\", \"got_v8_revision_cp\": \"refs/heads/8.9.188@{#1}\", \"got_webrtc_revision\": \"fec83cc8602580ce1c078f7cd4e7f4d2be4ac850\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32877}\", \"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\": \"67eba39027358ac4b99651c30db81e89684f37f8\", \"swarm_hashes_refs/heads/master(at){#839244}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"7d0a55b00275fa9588a503fa6f7e09d289fd2c47\", \"angle_unittests\": \"67cd23f99a5073ad7c8b5b3f06dcdc0ce55ee69a\", \"app_shell_unittests\": \"09f63f5372a1f86b73f4723fc21b72517292c2eb\", \"aura_unittests\": \"6f830de594e1704f27eeaec0187d4c1f14623e1b\", \"base_unittests\": \"e4a41f788bc9fce6eaa8930a80427275a9b311d7\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"651c40f92195c266084d7b5ae490e8c8a8e70142\", \"blink_fuzzer_unittests\": \"890542ef54cef3f5552f1635468f02871e1964f9\", \"blink_heap_unittests\": \"9d17a9509aa85111517184d4f2fa9fc14e1864bc\", \"blink_platform_unittests\": \"22b24e13a6417020cd2f46db0c463941a1c37ff0\", \"blink_unittests\": \"83723012cb9188b2159cf561ffd15b36a2a8d284\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"24a028cb2c2898ddb9686057fa4ca7c2207e6fbf\", \"capture_unittests\": \"d9c1880d4b2759fd93b947bf855b6d0b89777531\", \"cast_unittests\": \"3aeed45bf6b14c1ed3d34e658933064169b42cd6\", \"cc_unittests\": \"e14eee720e3f46464f3cd5cec7cc2b7e8eaffe13\", \"chrome_app_unittests\": \"597dd7b1135e0f50524c2ecb8df8f968a682db0a\", \"chrome_cleaner_unittests\": \"49c9a9d39d84062e3e50ae4c71f75ec6f5a444a7\", \"chrome_elf_unittests\": \"d7dbf93a339fc24036967e056af7acf5aa3f68e4\", \"chromedriver_unittests\": \"e42481fc5dba24a447087d34a9b3f00f6a8121cf\", \"components_browsertests\": \"648d80f39a4e11c2137de6bce281504c7ae5aed5\", \"components_unittests\": \"c8d73f4a86241699593f8ac3f2ac9f71236d3d6b\", \"compositor_unittests\": \"e1d269dfbc72ede1b828351297af5cbc1090e613\", \"content_browsertests\": \"d9fdbd6d85b1971bc91e207a7ea1f43fdb263c4d\", \"content_unittests\": \"949118bd9034ed1546cacc04549bdcecdf66eb80\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"42306de6bc0a9e370d0af711b6144b02d405132a\", \"cronet_unittests\": \"baedfee418e3573dbbd2715ef8071caf00e0008d\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"cea084b5761e24c94d604bb116015381f27d3a5a\", \"device_unittests\": \"3bca1a8e09d2d21d3c685417e53aeea985b52d0e\", \"display_unittests\": \"4c751897a0fdf1f82ded067ce1c7c30a4849857e\", \"elevation_service_unittests\": \"3d989ee14d742e603b1b1ee6a292032dae1288b4\", \"events_unittests\": \"f3baf68fe194767fe38a7aad1322d97a2655db8b\", \"extensions_browsertests\": \"1af67612727b327e013e4cca5bb828ad89f6c33f\", \"extensions_unittests\": \"77178facb66a9ab43664feb62a018527ef9a4b60\", \"filesystem_service_unittests\": \"ad643e4ab3e0696cce39bd415a38d0fab5220f9d\", \"gcm_unit_tests\": \"b44716eb2b0260f73432322e4f4ea36341112344\", \"gcp_unittests\": \"222211b9c6ccddb160969611b813795f5804ec01\", \"gfx_unittests\": \"5ec6414eb1420d1674dc78883aee4864f4ce37d3\", \"gin_unittests\": \"04f7e3fd4d22d04b26616c5e4d9567dc2275c86d\", \"google_apis_unittests\": \"5e7ad49de41cf8b66a9d149a4219eade9ef3a819\", \"gpu_unittests\": \"e59595c843ae78331b331f74866947d95f0e7cee\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"2bb9586a740de4483692eea4e67c8ea0c8212ffa\", \"headless_unittests\": \"15f1453a39c4ef2ed5f59bdd3fb29218d7fb51d2\", \"install_static_unittests\": \"dbe67ad51cbd2c5819bbb6f002b027aa1114b09d\", \"installer_util_unittests\": \"f7968408490d6cc7a06e7c33a2ae75c46503ff6b\", \"interactive_ui_tests\": \"d8704c7182cd2ff1e9e7c517ae33a1514ad2f666\", \"ipc_tests\": \"99e2c4ff9f7e7e28456f14bcdd517f543d012247\", \"jingle_unittests\": \"7773ef92d7dd8ef8aca5bc1f152c024197bfd77f\", \"latency_unittests\": \"11d58eb3c757086f39e861dac62f6f9e19d3f602\", \"libjingle_xmpp_unittests\": \"2ca994cb2da85c1c6fd970340d7618f54a90e9c3\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"6c954477b60aa38e7c990b03bfda0a9434b8e6c1\", \"media_unittests\": \"b633dac64f1eb5769f133094af82570821ca7719\", \"message_center_unittests\": \"951a89a964e023d604c27bdd4b15ea7af353f637\", \"midi_unittests\": \"135cf2ff92e76ecc53e8ac69eb28f006ba502668\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"c8c0464ef2a6d4b172398ff3a4443ed2b8bd1d1e\", \"nacl_loader_unittests\": \"747510d4ab6fd936c7721e3ba0a6ab59d6bb8db6\", \"native_theme_unittests\": \"120ab8a1975ee892adbfb6a4435aa49b241f6886\", \"net_unittests\": \"174af46ccf001969f8170a643cf29fcf07e28d7a\", \"notification_helper_unittests\": \"5fb95e2ecf9db30b8de140f48b8c1c52b5e18bc4\", \"pdf_unittests\": \"373b8678573e5ab5a7061a8447afca614eedab8e\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"7f8d0ba4edc3797860624939eca837ef542fa559\", \"printing_unittests\": \"533fbf3fce15e3be01e39e6abf33b1151c267d33\", \"remoting_unittests\": \"035c909f064275abaa19c7c8a3d5842d7593b4c4\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"7ea207dd06c97113b7c1a1194d302d201cc5492a\", \"services_unittests\": \"c927f35808c906df39da4d8cd1690c6a2d44af7b\", \"setup_unittests\": \"0ef32934ff016a7604002f7fd6dc8e69fda3a0d4\", \"shell_dialogs_unittests\": \"436d7dc1ebbd556cad674dc34467a3e56423ec0f\", \"skia_unittests\": \"a8c9226af9023bb4d9938d591269613be7c1cd58\", \"snapshot_unittests\": \"f65f2a4dcfd2ea6bd00c3126e5949424e3102aec\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"67981bc27b30bad4adfa37e7b25aeea07c55bbb5\", \"sync_integration_tests\": \"238c26bb99752f5dbb590468bf2b24e67793ce4a\", \"traffic_annotation_auditor_unittests\": \"3f34342a60a5a98b898c5e1a338714f05fa8f51c\", \"ui_base_unittests\": \"83c37ffcf6d48607246f55cee25475860fe18c9e\", \"ui_touch_selection_unittests\": \"8c8966f216ae25e7efe6cb2eec7b4c54465e37ff\", \"unit_tests\": \"e8ba75c14209b5fa3bfe44bdfbf618065a192a8f\", \"updater_tests\": \"370a0f09e017078f1887d0d8fb66c8445fd1c65c\", \"url_unittests\": \"36ba39195cb043b45bc22d4352af6dfd9e6fb6a6\", \"views_unittests\": \"b29dda1bddc80af50f2a20f82e890dc0d0af41ae\", \"viz_unittests\": \"7f9631b0b9b5f40a8b2ec2ddd26aa893d9c92b0b\", \"vr_common_unittests\": \"d99155aab00c9bcb0979ac39650bce9e50ac931b\", \"vr_pixeltests\": \"7f0e5120db28079a9b85b138c5aec3cf6cebdbd4\", \"weblayer_browsertests\": \"eab02f8ec9b3a3a36b45a8caa05f07be6c706be6\", \"weblayer_unittests\": \"37b1e0b758a2c8925e42dccf5ef4a0cf874f59dc\", \"wm_unittests\": \"e854899fede55b634836a83dabd7ec241968ce73\", \"wtf_unittests\": \"8665f5b88621aa1f792394146cf17fbc0e80cc64\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608824976615513",
"status": "COMPLETED",
"status_changed_ts": "1608831390181862",
"tags": [
"build_address:luci.chromium.ci/win-asan/16425",
"builder:win-asan",
"buildset:commit/git/67eba39027358ac4b99651c30db81e89684f37f8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/67eba39027358ac4b99651c30db81e89684f37f8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025448853482354608",
"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/8860018788777063200/+/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:50ae3e3aabc87e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608831390198374",
"url": "https://ci.chromium.org/b/8860018788777063200",
"utcnow_ts": "1608831390714298"
}
}
[17:36:30.721] Invocation finished in 1h52m14.117264153s with status SUCCEEDED