[18:55:38.193] New invocation is queued and will start shortly
[18:55:39.277] Starting the invocation (attempt 1)
[18:55:39.314] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:55:39.314] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:55:39.314] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018098459899382592",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"28132782c5e00a6d4d39275b7879536e43213f66\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018098459899382592",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/28132782c5e00a6d4d39275b7879536e43213f66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28132782c5e00a6d4d39275b7879536e43213f66",
"gitiles_ref:refs/heads/master"
]
}
[18:55:40.567] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615834539439144",
"id": "8852668397931477568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"28132782c5e00a6d4d39275b7879536e43213f66\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615834540259469",
"tags": [
"build_address:luci.chromium.ci/win-asan/17806",
"builder:win-asan",
"buildset:commit/git/28132782c5e00a6d4d39275b7879536e43213f66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28132782c5e00a6d4d39275b7879536e43213f66",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018098459899382592",
"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/8852668397931477568/+/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": "1615834540259640",
"url": "https://ci.chromium.org/b/8852668397931477568",
"utcnow_ts": "1615834540536610"
}
}
[18:55:40.567] Task URL: https://ci.chromium.org/b/8852668397931477568
[18:55:40.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:2:0) after 1m0s
[18:56:40.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:2:0)
[18:56:40.606] Timer tick, asking Buildbucket for the build status
[18:56:40.698] Build 8852668397931477568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:3:0) after 1m0s
[18:57:40.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:3:0)
[18:57:40.855] Timer tick, asking Buildbucket for the build status
[18:57:42.076] Build 8852668397931477568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:42.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:4:0) after 1m0s
[18:58:28.816] Received PubSub notification, asking Buildbucket for the build status
[18:58:28.862] Build status: STARTED
[18:58:42.190] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:4:0)
[18:58:42.190] Timer tick, asking Buildbucket for the build status
[18:58:42.327] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:42.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:6:0) after 1m0s
[18:59:42.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:6:0)
[18:59:42.433] Timer tick, asking Buildbucket for the build status
[18:59:42.500] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:42.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:7:0) after 1m0s
[19:00:42.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:7:0)
[19:00:42.528] Timer tick, asking Buildbucket for the build status
[19:00:42.629] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:42.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:8:0) after 1m0s
[19:01:42.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:8:0)
[19:01:42.714] Timer tick, asking Buildbucket for the build status
[19:01:42.798] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:42.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:9:0) after 1m0s
[19:02:42.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:9:0)
[19:02:42.856] Timer tick, asking Buildbucket for the build status
[19:02:42.938] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:42.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:10:0) after 1m0s
[19:03:42.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:10:0)
[19:03:42.957] Timer tick, asking Buildbucket for the build status
[19:03:43.037] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:43.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:11:0) after 1m0s
[19:04:43.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:11:0)
[19:04:43.155] Timer tick, asking Buildbucket for the build status
[19:04:43.236] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:43.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:12:0) after 1m0s
[19:05:43.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:12:0)
[19:05:43.321] Timer tick, asking Buildbucket for the build status
[19:05:44.300] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:44.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:13:0) after 1m0s
[19:06:44.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:13:0)
[19:06:44.310] Timer tick, asking Buildbucket for the build status
[19:06:44.421] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:44.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:14:0) after 1m0s
[19:07:44.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:14:0)
[19:07:44.499] Timer tick, asking Buildbucket for the build status
[19:07:44.626] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:44.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:15:0) after 1m0s
[19:08:44.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:15:0)
[19:08:44.853] Timer tick, asking Buildbucket for the build status
[19:08:44.953] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:44.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:16:0) after 1m0s
[19:09:45.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:16:0)
[19:09:45.218] Timer tick, asking Buildbucket for the build status
[19:09:45.337] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:45.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:17:0) after 1m0s
[19:10:45.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:17:0)
[19:10:45.552] Timer tick, asking Buildbucket for the build status
[19:10:45.832] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:45.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:18:0) after 1m0s
[19:11:45.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:18:0)
[19:11:45.932] Timer tick, asking Buildbucket for the build status
[19:11:47.965] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:47.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:19:0) after 1m0s
[19:12:48.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:19:0)
[19:12:48.282] Timer tick, asking Buildbucket for the build status
[19:12:48.373] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:48.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:20:0) after 1m0s
[19:13:48.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:20:0)
[19:13:48.559] Timer tick, asking Buildbucket for the build status
[19:13:48.742] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:48.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:21:0) after 1m0s
[19:14:49.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:21:0)
[19:14:49.153] Timer tick, asking Buildbucket for the build status
[19:14:49.241] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:49.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:22:0) after 1m0s
[19:15:49.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:22:0)
[19:15:49.235] Timer tick, asking Buildbucket for the build status
[19:15:52.210] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:52.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:23:0) after 1m0s
[19:16:52.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:23:0)
[19:16:52.373] Timer tick, asking Buildbucket for the build status
[19:16:55.374] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:55.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:24:0) after 1m0s
[19:17:56.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:24:0)
[19:17:56.270] Timer tick, asking Buildbucket for the build status
[19:17:56.383] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:56.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:25:0) after 1m0s
[19:18:56.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:25:0)
[19:18:56.391] Timer tick, asking Buildbucket for the build status
[19:18:56.511] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:56.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:26:0) after 1m0s
[19:19:56.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:26:0)
[19:19:56.537] Timer tick, asking Buildbucket for the build status
[19:19:56.801] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:56.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:27:0) after 1m0s
[19:20:56.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:27:0)
[19:20:56.831] Timer tick, asking Buildbucket for the build status
[19:20:56.914] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:28:0) after 1m0s
[19:21:56.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:28:0)
[19:21:56.992] Timer tick, asking Buildbucket for the build status
[19:21:57.086] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:57.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:29:0) after 1m0s
[19:22:57.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:29:0)
[19:22:57.262] Timer tick, asking Buildbucket for the build status
[19:22:57.375] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:57.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:30:0) after 1m0s
[19:23:57.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:30:0)
[19:23:57.741] Timer tick, asking Buildbucket for the build status
[19:23:57.830] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:57.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:31:0) after 1m0s
[19:24:58.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:31:0)
[19:24:58.053] Timer tick, asking Buildbucket for the build status
[19:24:58.120] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:58.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:32:0) after 1m0s
[19:25:58.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:32:0)
[19:25:58.139] Timer tick, asking Buildbucket for the build status
[19:25:58.257] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:58.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:33:0) after 1m0s
[19:26:58.297] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:33:0)
[19:26:58.297] Timer tick, asking Buildbucket for the build status
[19:26:58.375] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:58.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:34:0) after 1m0s
[19:27:58.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:34:0)
[19:27:58.373] Timer tick, asking Buildbucket for the build status
[19:27:58.441] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:35:0) after 1m0s
[19:28:58.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:35:0)
[19:28:58.469] Timer tick, asking Buildbucket for the build status
[19:28:58.769] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:58.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:36:0) after 1m0s
[19:29:58.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:36:0)
[19:29:58.818] Timer tick, asking Buildbucket for the build status
[19:29:58.925] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:58.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:37:0) after 1m0s
[19:30:59.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:37:0)
[19:30:59.016] Timer tick, asking Buildbucket for the build status
[19:30:59.648] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:59.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:38:0) after 1m0s
[19:31:59.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:38:0)
[19:31:59.680] Timer tick, asking Buildbucket for the build status
[19:32:00.635] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:00.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:39:0) after 1m0s
[19:33:00.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:39:0)
[19:33:00.785] Timer tick, asking Buildbucket for the build status
[19:33:01.109] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:01.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:40:0) after 1m0s
[19:34:01.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:40:0)
[19:34:01.400] Timer tick, asking Buildbucket for the build status
[19:34:01.562] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:01.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:41:0) after 1m0s
[19:35:01.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:41:0)
[19:35:01.670] Timer tick, asking Buildbucket for the build status
[19:35:01.732] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:01.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:42:0) after 1m0s
[19:36:01.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:42:0)
[19:36:01.783] Timer tick, asking Buildbucket for the build status
[19:36:02.197] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:02.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:43:0) after 1m0s
[19:37:02.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:43:0)
[19:37:02.270] Timer tick, asking Buildbucket for the build status
[19:37:02.381] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:02.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:44:0) after 1m0s
[19:38:02.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:44:0)
[19:38:02.445] Timer tick, asking Buildbucket for the build status
[19:38:02.509] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:02.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:45:0) after 1m0s
[19:39:02.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:45:0)
[19:39:02.524] Timer tick, asking Buildbucket for the build status
[19:39:02.616] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:02.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:46:0) after 1m0s
[19:40:02.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:46:0)
[19:40:02.837] Timer tick, asking Buildbucket for the build status
[19:40:02.910] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:02.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:47:0) after 1m0s
[19:41:03.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:47:0)
[19:41:03.120] Timer tick, asking Buildbucket for the build status
[19:41:03.261] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:03.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:48:0) after 1m0s
[19:42:03.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:48:0)
[19:42:03.347] Timer tick, asking Buildbucket for the build status
[19:42:03.425] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:03.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:49:0) after 1m0s
[19:43:03.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:49:0)
[19:43:03.538] Timer tick, asking Buildbucket for the build status
[19:43:03.604] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:03.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:50:0) after 1m0s
[19:44:03.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:50:0)
[19:44:03.717] Timer tick, asking Buildbucket for the build status
[19:44:03.840] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:03.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:51:0) after 1m0s
[19:45:03.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:51:0)
[19:45:03.947] Timer tick, asking Buildbucket for the build status
[19:45:04.137] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:52:0) after 1m0s
[19:46:04.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:52:0)
[19:46:04.135] Timer tick, asking Buildbucket for the build status
[19:46:04.573] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:04.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:53:0) after 1m0s
[19:47:04.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:53:0)
[19:47:04.678] Timer tick, asking Buildbucket for the build status
[19:47:04.770] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:04.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:54:0) after 1m0s
[19:48:04.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:54:0)
[19:48:04.835] Timer tick, asking Buildbucket for the build status
[19:48:05.331] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:05.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:55:0) after 1m0s
[19:49:05.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:55:0)
[19:49:05.346] Timer tick, asking Buildbucket for the build status
[19:49:05.580] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:56:0) after 1m0s
[19:50:05.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:56:0)
[19:50:05.734] Timer tick, asking Buildbucket for the build status
[19:50:07.170] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:07.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:57:0) after 1m0s
[19:51:07.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:57:0)
[19:51:07.172] Timer tick, asking Buildbucket for the build status
[19:51:07.342] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:07.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:58:0) after 1m0s
[19:52:07.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:58:0)
[19:52:07.414] Timer tick, asking Buildbucket for the build status
[19:52:08.492] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:08.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:59:0) after 1m0s
[19:53:08.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:59:0)
[19:53:08.510] Timer tick, asking Buildbucket for the build status
[19:53:08.619] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:08.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:60:0) after 1m0s
[19:54:08.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:60:0)
[19:54:08.708] Timer tick, asking Buildbucket for the build status
[19:54:08.784] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:08.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:61:0) after 1m0s
[19:55:09.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:61:0)
[19:55:09.033] Timer tick, asking Buildbucket for the build status
[19:55:09.122] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:09.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:62:0) after 1m0s
[19:56:09.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:62:0)
[19:56:09.447] Timer tick, asking Buildbucket for the build status
[19:56:09.568] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:09.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:63:0) after 1m0s
[19:57:09.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:63:0)
[19:57:09.626] Timer tick, asking Buildbucket for the build status
[19:57:09.692] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:09.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:64:0) after 1m0s
[19:58:09.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:64:0)
[19:58:09.697] Timer tick, asking Buildbucket for the build status
[19:58:09.786] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:09.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:65:0) after 1m0s
[19:59:09.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:65:0)
[19:59:09.877] Timer tick, asking Buildbucket for the build status
[19:59:10.161] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:10.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:66:0) after 1m0s
[20:00:10.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:66:0)
[20:00:10.289] Timer tick, asking Buildbucket for the build status
[20:00:10.578] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:10.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:67:0) after 1m0s
[20:01:10.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:67:0)
[20:01:10.657] Timer tick, asking Buildbucket for the build status
[20:01:10.805] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:10.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:68:0) after 1m0s
[20:02:11.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:68:0)
[20:02:11.194] Timer tick, asking Buildbucket for the build status
[20:02:11.295] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:11.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:69:0) after 1m0s
[20:03:11.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:69:0)
[20:03:11.741] Timer tick, asking Buildbucket for the build status
[20:03:11.833] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:11.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:70:0) after 1m0s
[20:04:11.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:70:0)
[20:04:11.989] Timer tick, asking Buildbucket for the build status
[20:04:12.071] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:12.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:71:0) after 1m0s
[20:05:12.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:71:0)
[20:05:12.236] Timer tick, asking Buildbucket for the build status
[20:05:12.354] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:12.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:72:0) after 1m0s
[20:06:12.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:72:0)
[20:06:12.592] Timer tick, asking Buildbucket for the build status
[20:06:12.842] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:12.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:73:0) after 1m0s
[20:07:13.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:73:0)
[20:07:13.078] Timer tick, asking Buildbucket for the build status
[20:07:13.213] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:13.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:74:0) after 1m0s
[20:08:13.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:74:0)
[20:08:13.619] Timer tick, asking Buildbucket for the build status
[20:08:13.855] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:13.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:75:0) after 1m0s
[20:09:13.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:75:0)
[20:09:13.902] Timer tick, asking Buildbucket for the build status
[20:09:14.225] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:14.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:76:0) after 1m0s
[20:10:14.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:76:0)
[20:10:14.251] Timer tick, asking Buildbucket for the build status
[20:10:14.604] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:14.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:77:0) after 1m0s
[20:11:15.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:77:0)
[20:11:15.836] Timer tick, asking Buildbucket for the build status
[20:11:15.989] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:15.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:78:0) after 1m0s
[20:12:16.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:78:0)
[20:12:16.357] Timer tick, asking Buildbucket for the build status
[20:12:16.439] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:16.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:79:0) after 1m0s
[20:13:16.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:79:0)
[20:13:16.587] Timer tick, asking Buildbucket for the build status
[20:13:16.737] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:16.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:80:0) after 1m0s
[20:14:16.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:80:0)
[20:14:16.919] Timer tick, asking Buildbucket for the build status
[20:14:16.997] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:16.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:81:0) after 1m0s
[20:15:17.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:81:0)
[20:15:17.023] Timer tick, asking Buildbucket for the build status
[20:15:17.140] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:17.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:82:0) after 1m0s
[20:16:17.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:82:0)
[20:16:17.162] Timer tick, asking Buildbucket for the build status
[20:16:17.517] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:17.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:83:0) after 1m0s
[20:17:17.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:83:0)
[20:17:17.839] Timer tick, asking Buildbucket for the build status
[20:17:17.948] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:17.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:84:0) after 1m0s
[20:18:18.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:84:0)
[20:18:18.262] Timer tick, asking Buildbucket for the build status
[20:18:18.572] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:18.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:85:0) after 1m0s
[20:19:18.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:85:0)
[20:19:18.726] Timer tick, asking Buildbucket for the build status
[20:19:18.849] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:18.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:86:0) after 1m0s
[20:20:19.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:86:0)
[20:20:19.036] Timer tick, asking Buildbucket for the build status
[20:20:19.139] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:19.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:87:0) after 1m0s
[20:21:19.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:87:0)
[20:21:19.275] Timer tick, asking Buildbucket for the build status
[20:21:20.009] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:20.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:88:0) after 1m0s
[20:22:20.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:88:0)
[20:22:20.505] Timer tick, asking Buildbucket for the build status
[20:22:20.678] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:20.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:89:0) after 1m0s
[20:23:20.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:89:0)
[20:23:20.737] Timer tick, asking Buildbucket for the build status
[20:23:20.838] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:20.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:90:0) after 1m0s
[20:24:21.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:90:0)
[20:24:21.027] Timer tick, asking Buildbucket for the build status
[20:24:21.197] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:21.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:91:0) after 1m0s
[20:25:21.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:91:0)
[20:25:21.230] Timer tick, asking Buildbucket for the build status
[20:25:21.363] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:21.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:92:0) after 1m0s
[20:26:21.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:92:0)
[20:26:21.403] Timer tick, asking Buildbucket for the build status
[20:26:21.540] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:21.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:93:0) after 1m0s
[20:27:21.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:93:0)
[20:27:21.557] Timer tick, asking Buildbucket for the build status
[20:27:21.635] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:21.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:94:0) after 1m0s
[20:28:21.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:94:0)
[20:28:21.614] Timer tick, asking Buildbucket for the build status
[20:28:21.753] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:21.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:95:0) after 1m0s
[20:29:21.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:95:0)
[20:29:21.870] Timer tick, asking Buildbucket for the build status
[20:29:21.963] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:21.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:96:0) after 1m0s
[20:30:21.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:96:0)
[20:30:21.954] Timer tick, asking Buildbucket for the build status
[20:30:22.075] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:22.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:97:0) after 1m0s
[20:31:22.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:97:0)
[20:31:22.091] Timer tick, asking Buildbucket for the build status
[20:31:22.307] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:22.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:98:0) after 1m0s
[20:32:22.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:98:0)
[20:32:22.380] Timer tick, asking Buildbucket for the build status
[20:32:22.507] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:22.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:99:0) after 1m0s
[20:33:22.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:99:0)
[20:33:22.529] Timer tick, asking Buildbucket for the build status
[20:33:22.621] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:22.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:100:0) after 1m0s
[20:34:22.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:100:0)
[20:34:22.650] Timer tick, asking Buildbucket for the build status
[20:34:23.149] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:23.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:101:0) after 1m0s
[20:35:23.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:101:0)
[20:35:23.206] Timer tick, asking Buildbucket for the build status
[20:35:23.295] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:23.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:102:0) after 1m0s
[20:36:23.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:102:0)
[20:36:23.346] Timer tick, asking Buildbucket for the build status
[20:36:23.414] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:23.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:103:0) after 1m0s
[20:37:23.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:103:0)
[20:37:23.452] Timer tick, asking Buildbucket for the build status
[20:37:23.586] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:23.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:104:0) after 1m0s
[20:38:23.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:104:0)
[20:38:23.936] Timer tick, asking Buildbucket for the build status
[20:38:24.013] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:24.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:105:0) after 1m0s
[20:39:24.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:105:0)
[20:39:24.816] Timer tick, asking Buildbucket for the build status
[20:39:24.925] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:24.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:106:0) after 1m0s
[20:40:25.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:106:0)
[20:40:25.501] Timer tick, asking Buildbucket for the build status
[20:40:25.620] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:25.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:107:0) after 1m0s
[20:41:25.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:107:0)
[20:41:25.987] Timer tick, asking Buildbucket for the build status
[20:41:27.581] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:27.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:108:0) after 1m0s
[20:42:27.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:108:0)
[20:42:27.672] Timer tick, asking Buildbucket for the build status
[20:42:28.409] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:28.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:109:0) after 1m0s
[20:43:28.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:109:0)
[20:43:28.443] Timer tick, asking Buildbucket for the build status
[20:43:28.603] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:28.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:110:0) after 1m0s
[20:44:28.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:110:0)
[20:44:28.633] Timer tick, asking Buildbucket for the build status
[20:44:28.724] Build 8852668397931477568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:28.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:111:0) after 1m0s
[20:45:28.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018098459899382592:111:0)
[20:45:28.777] Timer tick, asking Buildbucket for the build status
[20:45:28.868] Build 8852668397931477568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:45:28.869] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615841124699293",
"created_by": "project:chromium",
"created_ts": "1615834539439144",
"id": "8852668397931477568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"28132782c5e00a6d4d39275b7879536e43213f66\"}}",
"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\": \"28132782c5e00a6d4d39275b7879536e43213f66\", \"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-10-dcpw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17806, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"a11d65a172f885042cf4fdab5bfd124d174f5190\", \"got_dawn_revision\": \"8c40cad1c92d7e85154bbae4cb92539e2200d139\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"28132782c5e00a6d4d39275b7879536e43213f66\", \"got_revision_cp\": \"refs/heads/master@{#862896}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"9becce304a5e9b05bff62eef6c5e53b944120eb2\", \"got_v8_revision_cp\": \"refs/heads/9.1.125@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": true, \"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\": \"28132782c5e00a6d4d39275b7879536e43213f66\", \"swarm_hashes_refs/heads/master(at){#862896}_without_patch\": {\"absl_hardening_tests\": \"4f2326aa90d3e83a50ca93104195e7aa8a7e123e\", \"accessibility_unittests\": \"b3272c42d10895e3b8e3d566f49e26a8900f391e\", \"angle_unittests\": \"9c0d417c4cb0e3e0acb1423ef8866dac6363d442\", \"app_shell_unittests\": \"8ec7ce6b612109737bad857d36df896a72264c70\", \"aura_unittests\": \"a2ea5766d57b689340f2ec81111680f1084b437b\", \"base_unittests\": \"f689629642494e25585e3a0596f2b0a3af370fec\", \"base_util_unittests\": \"0c5e05d3fd71c8a090dce49437a2f17a44a110f3\", \"blink_common_unittests\": \"99e9e6db5cf95ce8bd870679a3038816fc3a3790\", \"blink_fuzzer_unittests\": \"72cbb1ef2dfe34be6e9d64e767a449a84804c66f\", \"blink_heap_unittests\": \"25fd9ec296f87bc3827e237355d7d11a2b9bce50\", \"blink_platform_unittests\": \"09f582b47f93ec9d0e6f51817395e7577a317d18\", \"blink_unittests\": \"78af3cfd2c6b4eac8b60eb3192b19f094c6c1418\", \"boringssl_crypto_tests\": \"7f145f1dfad04e50411a432fb883829d69e1c9ce\", \"boringssl_ssl_tests\": \"258c6127dd76dcfbfc028e6f22306f0cd0acb07d\", \"browser_switcher_bho_unittests\": \"25d21bbe582c442f5b4331b41539f19adbd3801f\", \"browser_tests\": \"33618d66d80459528b37880869357d5d7d672d55\", \"capture_unittests\": \"c8f07a94e45e05a8339daca149b9cdb0cefb8c38\", \"cast_unittests\": \"07657e523499f4fa580ffc38821bd474dbcf5dc0\", \"cc_unittests\": \"0b98c995b149b831bccf27cbd69ba50ca3e6d5a6\", \"chrome_app_unittests\": \"35f2dbd0b509581c85355d204c47fd53e22aa215\", \"chrome_cleaner_unittests\": \"97cbed52c8fe89102fc6dd12e6fb083889f2c170\", \"chrome_elf_unittests\": \"7a3382c10a9884c50303a25787d5b03ced1eb9df\", \"chromedriver_unittests\": \"7e775684b00e8623fb30c89546af34873f305872\", \"color_unittests\": \"e5f6174b3885c5862bff34425af2dc0306fd9409\", \"components_browsertests\": \"be22ae959c4e05cf1f253b28d79b6f4be7af8b0c\", \"components_unittests\": \"f2c6984c3323f34798e2b327e83f62f7fa0e14e3\", \"compositor_unittests\": \"2c47f187ca98f70d25eb8e93c70b712e960d6ea9\", \"content_browsertests\": \"6c30710ddc4575247068af15d9cffe4c80cc4f93\", \"content_unittests\": \"34b82106e8e1218f024fcf4b7adfee7eede2ad14\", \"courgette_unittests\": \"5d8407677a1e666550d55c7f397f0e4c991d87c9\", \"crashpad_tests\": \"f1a228e4a9312d1104185b1e32573b41570b254a\", \"cronet_tests\": \"b74a81faad205c9a9041dbc9c9dd26c741c072c0\", \"cronet_unittests\": \"1cc95932b90227ccf40194d289804a3ed66ffb27\", \"crypto_unittests\": \"263b5f92f876da107bcc3dcb58b7116d508257e7\", \"delayloads_unittests\": \"94ea0ea68470d856c31bbe44548c7faf3a895e4c\", \"device_unittests\": \"462ef1b8336d44e3de5eb1db62a6aa10c9e44e8f\", \"display_unittests\": \"5bcb980c4983d0269ea0c66daf32ffff7d36ec46\", \"elevation_service_unittests\": \"f14cb771de20fc244f8d8afc0d0275c193cd92d2\", \"events_unittests\": \"bab6643cbee007f8b2fa3a6097ec3b806ba19736\", \"extensions_browsertests\": \"ca609604d769a696127fdc6e11dc89b6a8f09f29\", \"extensions_unittests\": \"7e37df4d13b3be46d4c0aa7e8943749cfce6c821\", \"filesystem_service_unittests\": \"95386f74be0c2be84920eec3c3751123e78ec778\", \"gcm_unit_tests\": \"566900500e451cf475b3b72ce6d38bfee71d7c94\", \"gcp_unittests\": \"03881ee13f435e2467429ab169981a2c05535916\", \"gfx_unittests\": \"f8c17b8f67539059a0c07836652504474a36697d\", \"gin_unittests\": \"71d139bc8b3c4ce6fe42532e03e96ea41e9f7a5d\", \"google_apis_unittests\": \"d74efe9c05b9616dad7b0991568a38adcce52cb6\", \"gpu_unittests\": \"502cf29851df7d93c832908044569ae05bd08e5c\", \"gwp_asan_unittests\": \"4737b8cf902b60877f2ebd76753109c0860b7bec\", \"headless_browsertests\": \"cdf11ecdeaa207a695a3e2777c667ab8d53da037\", \"headless_unittests\": \"60fd7789757e5e1af5a47a26a80537d094bdfc2b\", \"install_static_unittests\": \"2362bd2946dbf83805b3c1558e7fe79e3ddca431\", \"installer_util_unittests\": \"7bd2f04dbd63b438bcf2768c9bff90cac14aacdd\", \"interactive_ui_tests\": \"fc33b9996fe6d8fd811bb422905501639b9363bb\", \"ipc_tests\": \"91ee9174648f4a77df367cc3d65264435dd9570f\", \"jingle_unittests\": \"5b6482148ed63c6e2d2683f643b6e504b902ac51\", \"latency_unittests\": \"319f7e0bc36c3f9591a2a776fb3bde656f38ef1e\", \"libjingle_xmpp_unittests\": \"78e8501d596b6cfa8945460217c2825b888e19f4\", \"liburlpattern_unittests\": \"8d04fbf4a7e6a81c155a2ed51d4233a8f6017124\", \"media_blink_unittests\": \"b1ec6f2f1752c1578a135db52bb98b603aefd02a\", \"media_unittests\": \"d9e2a173eaa170da9e2d37aa241ccd6e4556fff4\", \"message_center_unittests\": \"598d0dc36bf519f1b418b8f5099341ac129510b6\", \"midi_unittests\": \"c7a54dcd608a9478583f3da6f0e488780926506e\", \"mojo_core_unittests\": \"41d7f55d6a1db835af73ea027a2ac8cbcb843d1a\", \"mojo_unittests\": \"355b3798c66fd369f9c1ac3148d1aff7d73a61a3\", \"nacl_loader_unittests\": \"6927c15b9b7a78275269864ba8f607d577bfa88b\", \"native_theme_unittests\": \"364cc3614abc1f98aa90f12122e32b3743e2cc52\", \"net_unittests\": \"94bd65d4ef2d626aa991da4f80e9a131ade5ff83\", \"notification_helper_unittests\": \"df733826f41de47724b8512fc6a20751fdfbbd88\", \"pdf_unittests\": \"f8528881222560b064c08148df2a72e8f5e7f933\", \"perfetto_unittests\": \"05f24311827594c8f84baf88519f778db5835427\", \"ppapi_unittests\": \"f919426dead4abd95344ec6468226426a6f8b147\", \"printing_unittests\": \"f467c80ffa0faff97461f14308311579fa29f852\", \"remoting_unittests\": \"a6e753efbb5357583b486395f84ba0ffe60ac8f2\", \"sbox_integration_tests\": \"a6c8fe6bb91eb75714b9de20ac6835d4e0cd4055\", \"sbox_unittests\": \"82f464a736a70a39f1eb24bf32b1c3a50f6d53c9\", \"sbox_validation_tests\": \"5f457ecec4eec769305b89403805525f682e6e77\", \"service_manager_unittests\": \"86dcb4aac60e13701b3afd727730abd626645545\", \"services_unittests\": \"afa35b43e7354dad5a1404cef9804097171bae82\", \"setup_unittests\": \"e364ae8526f62592eb898577cc3fdfa36fc27288\", \"shell_dialogs_unittests\": \"4e2953ad25b88a7ac24fd5f6ef338b0b6e345690\", \"skia_unittests\": \"f417b959a2f3527dd4df99da8829deb9b5fffdbf\", \"snapshot_unittests\": \"ca90624aec708afa186954181b0891ca483c0c1b\", \"sql_unittests\": \"079d31eab77a2ae8ca66fedee88cf7e9510719b2\", \"storage_unittests\": \"79d2518ff3f36a2b34aa115050056a3139e94e95\", \"sync_integration_tests\": \"6dbfc7dc6dc9047b16f996d17d4714c1d96fd1b4\", \"traffic_annotation_auditor_unittests\": \"0c65723be566145676f21e72d167d9854a21e396\", \"ui_base_unittests\": \"79bdb1ab480e0aae33ba0d2b7fe422e792bc444b\", \"ui_touch_selection_unittests\": \"79b1be334eb80cc1612d56cbc79a69c2037fd13c\", \"unit_tests\": \"bbce7fd5eab8f89bfd64e157f8ce7b582ca798a6\", \"updater_tests\": \"ea34da28cd856583739b5c24950ef4d2b387a83f\", \"url_unittests\": \"b962d79dbb4a140accfa7049c831e237c0641217\", \"views_unittests\": \"9f5d0b217dcccdaed85e325089dbe9d6298eb167\", \"viz_unittests\": \"3907056d1be1228060102d625813d85a6ea5fd10\", \"vr_common_unittests\": \"a2b53226968b241be86e8d9bf937699db3d2aab0\", \"vr_pixeltests\": \"3a4a01493805c43b2994770ab24dc0df9c6a83fb\", \"weblayer_browsertests\": \"f4a89009ec0ddf8c82ce630397782bfecf4c8ba6\", \"weblayer_unittests\": \"125bafb3308e2169896ef2f6a8f9291af6ce6a9e\", \"wm_unittests\": \"a03511a41ba65ec70d32349b31b2463ada0b5363\", \"wtf_unittests\": \"03312ff61758d93824b5d1c331ac3fa5e66109e4\", \"zlib_unittests\": \"7571abe51e3390078c624fdc46ef84d465707eb6\", \"zucchini_unittests\": \"d252da16e2cd0332f9f70f5491bcaf501433d83d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-10-dcpw\"], \"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\": [\"5754-8c4f760\"], \"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": "1615834708140924",
"status": "COMPLETED",
"status_changed_ts": "1615841125590351",
"tags": [
"build_address:luci.chromium.ci/win-asan/17806",
"builder:win-asan",
"buildset:commit/git/28132782c5e00a6d4d39275b7879536e43213f66",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28132782c5e00a6d4d39275b7879536e43213f66",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018098459899382592",
"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/8852668397931477568/+/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:52500ff24df1d410",
"user_agent:luci-scheduler"
],
"updated_ts": "1615841125609644",
"url": "https://ci.chromium.org/b/8852668397931477568",
"utcnow_ts": "1615841128860014"
}
}
[20:45:28.869] Invocation finished in 1h49m50.689971375s with status SUCCEEDED