[19:26:21.032] New invocation is queued and will start shortly
[19:26:22.205] Starting the invocation (attempt 1)
[19:26:22.237] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:26:22.240] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:26:22.240] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027880999919643232",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"64b26aa6090db81354a37e02a975664c8a3c9633\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027880999919643232",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/64b26aa6090db81354a37e02a975664c8a3c9633",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64b26aa6090db81354a37e02a975664c8a3c9633",
"gitiles_ref:refs/heads/master"
]
}
[19:26:23.572] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606505182383828",
"id": "8862450937835561392",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"64b26aa6090db81354a37e02a975664c8a3c9633\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606505183363553",
"tags": [
"build_address:luci.chromium.ci/win-asan/15891",
"builder:win-asan",
"buildset:commit/git/64b26aa6090db81354a37e02a975664c8a3c9633",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64b26aa6090db81354a37e02a975664c8a3c9633",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027880999919643232",
"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/8862450937835561392/+/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": "1606505183363701",
"url": "https://ci.chromium.org/b/8862450937835561392",
"utcnow_ts": "1606505183563666"
}
}
[19:26:23.572] Task URL: https://ci.chromium.org/b/8862450937835561392
[19:26:23.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:2:0) after 1m0s
[19:26:26.086] Received PubSub notification, asking Buildbucket for the build status
[19:26:26.587] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:23.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:2:0)
[19:27:23.622] Timer tick, asking Buildbucket for the build status
[19:27:23.723] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:23.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:4:0) after 1m0s
[19:28:23.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:4:0)
[19:28:23.857] Timer tick, asking Buildbucket for the build status
[19:28:23.957] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:23.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:5:0) after 1m0s
[19:29:24.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:5:0)
[19:29:24.041] Timer tick, asking Buildbucket for the build status
[19:29:24.982] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:6:0) after 1m0s
[19:30:25.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:6:0)
[19:30:25.062] Timer tick, asking Buildbucket for the build status
[19:30:25.222] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:25.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:7:0) after 1m0s
[19:31:25.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:7:0)
[19:31:25.220] Timer tick, asking Buildbucket for the build status
[19:31:25.463] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:25.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:8:0) after 1m0s
[19:32:25.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:8:0)
[19:32:25.680] Timer tick, asking Buildbucket for the build status
[19:32:25.749] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:25.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:9:0) after 1m0s
[19:33:25.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:9:0)
[19:33:25.827] Timer tick, asking Buildbucket for the build status
[19:33:26.010] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:26.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:10:0) after 1m0s
[19:34:25.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:10:0)
[19:34:25.994] Timer tick, asking Buildbucket for the build status
[19:34:26.226] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:26.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:11:0) after 1m0s
[19:35:26.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:11:0)
[19:35:26.375] Timer tick, asking Buildbucket for the build status
[19:35:26.467] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:26.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:12:0) after 1m0s
[19:36:26.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:12:0)
[19:36:26.487] Timer tick, asking Buildbucket for the build status
[19:36:27.491] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:27.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:13:0) after 1m0s
[19:37:27.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:13:0)
[19:37:27.577] Timer tick, asking Buildbucket for the build status
[19:37:27.677] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:27.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:14:0) after 1m0s
[19:38:27.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:14:0)
[19:38:27.739] Timer tick, asking Buildbucket for the build status
[19:38:27.896] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:27.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:15:0) after 1m0s
[19:39:28.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:15:0)
[19:39:28.053] Timer tick, asking Buildbucket for the build status
[19:39:28.217] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:28.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:16:0) after 1m0s
[19:40:28.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:16:0)
[19:40:28.242] Timer tick, asking Buildbucket for the build status
[19:40:28.612] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:17:0) after 1m0s
[19:41:28.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:17:0)
[19:41:28.663] Timer tick, asking Buildbucket for the build status
[19:41:28.809] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:28.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:18:0) after 1m0s
[19:42:28.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:18:0)
[19:42:28.881] Timer tick, asking Buildbucket for the build status
[19:42:29.004] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:29.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:19:0) after 1m0s
[19:43:29.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:19:0)
[19:43:29.049] Timer tick, asking Buildbucket for the build status
[19:43:29.589] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:29.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:20:0) after 1m0s
[19:44:29.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:20:0)
[19:44:29.737] Timer tick, asking Buildbucket for the build status
[19:44:30.821] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:30.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:21:0) after 1m0s
[19:45:30.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:21:0)
[19:45:30.872] Timer tick, asking Buildbucket for the build status
[19:45:31.054] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:31.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:22:0) after 1m0s
[19:46:31.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:22:0)
[19:46:31.082] Timer tick, asking Buildbucket for the build status
[19:46:31.274] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:31.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:23:0) after 1m0s
[19:47:31.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:23:0)
[19:47:31.292] Timer tick, asking Buildbucket for the build status
[19:47:31.521] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:24:0) after 1m0s
[19:48:31.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:24:0)
[19:48:31.531] Timer tick, asking Buildbucket for the build status
[19:48:31.791] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:31.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:25:0) after 1m0s
[19:49:31.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:25:0)
[19:49:31.817] Timer tick, asking Buildbucket for the build status
[19:49:32.306] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:32.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:26:0) after 1m0s
[19:50:32.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:26:0)
[19:50:32.395] Timer tick, asking Buildbucket for the build status
[19:50:32.502] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:27:0) after 1m0s
[19:51:32.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:27:0)
[19:51:32.489] Timer tick, asking Buildbucket for the build status
[19:51:32.757] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:32.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:28:0) after 1m0s
[19:52:32.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:28:0)
[19:52:32.876] Timer tick, asking Buildbucket for the build status
[19:52:33.032] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:33.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:29:0) after 1m0s
[19:53:33.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:29:0)
[19:53:33.142] Timer tick, asking Buildbucket for the build status
[19:53:33.238] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:33.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:30:0) after 1m0s
[19:54:33.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:30:0)
[19:54:33.250] Timer tick, asking Buildbucket for the build status
[19:54:33.323] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:33.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:31:0) after 1m0s
[19:55:33.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:31:0)
[19:55:33.382] Timer tick, asking Buildbucket for the build status
[19:55:33.497] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:33.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:32:0) after 1m0s
[19:56:33.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:32:0)
[19:56:33.503] Timer tick, asking Buildbucket for the build status
[19:56:33.759] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:33:0) after 1m0s
[19:57:33.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:33:0)
[19:57:33.819] Timer tick, asking Buildbucket for the build status
[19:57:34.211] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:34.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:34:0) after 1m0s
[19:58:34.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:34:0)
[19:58:34.240] Timer tick, asking Buildbucket for the build status
[19:58:34.315] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:34.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:35:0) after 1m0s
[19:59:34.374] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:35:0)
[19:59:34.374] Timer tick, asking Buildbucket for the build status
[19:59:34.726] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:34.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:36:0) after 1m0s
[20:00:34.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:36:0)
[20:00:34.745] Timer tick, asking Buildbucket for the build status
[20:00:35.754] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:35.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:37:0) after 1m0s
[20:01:35.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:37:0)
[20:01:35.836] Timer tick, asking Buildbucket for the build status
[20:01:35.909] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:35.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:38:0) after 1m0s
[20:02:35.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:38:0)
[20:02:35.963] Timer tick, asking Buildbucket for the build status
[20:02:36.094] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:36.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:39:0) after 1m0s
[20:03:36.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:39:0)
[20:03:36.099] Timer tick, asking Buildbucket for the build status
[20:03:36.264] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:36.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:40:0) after 1m0s
[20:04:36.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:40:0)
[20:04:36.307] Timer tick, asking Buildbucket for the build status
[20:04:36.653] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:36.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:41:0) after 1m0s
[20:05:36.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:41:0)
[20:05:36.642] Timer tick, asking Buildbucket for the build status
[20:05:36.758] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:36.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:42:0) after 1m0s
[20:06:36.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:42:0)
[20:06:36.782] Timer tick, asking Buildbucket for the build status
[20:06:37.419] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:37.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:43:0) after 1m0s
[20:07:37.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:43:0)
[20:07:37.493] Timer tick, asking Buildbucket for the build status
[20:07:37.815] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:37.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:44:0) after 1m0s
[20:08:37.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:44:0)
[20:08:37.841] Timer tick, asking Buildbucket for the build status
[20:08:38.782] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:38.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:45:0) after 1m0s
[20:09:38.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:45:0)
[20:09:38.854] Timer tick, asking Buildbucket for the build status
[20:09:38.938] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:38.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:46:0) after 1m0s
[20:10:38.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:46:0)
[20:10:38.989] Timer tick, asking Buildbucket for the build status
[20:10:39.162] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:47:0) after 1m0s
[20:11:39.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:47:0)
[20:11:39.250] Timer tick, asking Buildbucket for the build status
[20:11:39.425] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:39.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:48:0) after 1m0s
[20:12:39.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:48:0)
[20:12:39.465] Timer tick, asking Buildbucket for the build status
[20:12:40.065] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:40.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:49:0) after 1m0s
[20:13:40.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:49:0)
[20:13:40.116] Timer tick, asking Buildbucket for the build status
[20:13:40.216] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:40.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:50:0) after 1m0s
[20:14:40.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:50:0)
[20:14:40.271] Timer tick, asking Buildbucket for the build status
[20:14:40.379] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:40.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:51:0) after 1m0s
[20:15:40.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:51:0)
[20:15:40.654] Timer tick, asking Buildbucket for the build status
[20:15:42.003] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:42.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:52:0) after 1m0s
[20:16:42.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:52:0)
[20:16:42.175] Timer tick, asking Buildbucket for the build status
[20:16:42.279] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:42.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:53:0) after 1m0s
[20:17:42.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:53:0)
[20:17:42.378] Timer tick, asking Buildbucket for the build status
[20:17:42.651] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:42.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:54:0) after 1m0s
[20:18:42.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:54:0)
[20:18:42.841] Timer tick, asking Buildbucket for the build status
[20:18:42.956] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:42.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:55:0) after 1m0s
[20:19:43.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:55:0)
[20:19:43.003] Timer tick, asking Buildbucket for the build status
[20:19:43.116] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:43.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:56:0) after 1m0s
[20:20:43.268] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:56:0)
[20:20:43.268] Timer tick, asking Buildbucket for the build status
[20:20:43.335] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:43.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:57:0) after 1m0s
[20:21:43.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:57:0)
[20:21:43.417] Timer tick, asking Buildbucket for the build status
[20:21:43.690] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:43.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:58:0) after 1m0s
[20:22:43.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:58:0)
[20:22:43.821] Timer tick, asking Buildbucket for the build status
[20:22:44.270] Build 8862450937835561392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:44.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027880999919643232:59:0) after 1m0s
[20:23:12.094] Received PubSub notification, asking Buildbucket for the build status
[20:23:12.269] Build 8862450937835561392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:23:12.269] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606508591185157",
"created_by": "project:chromium",
"created_ts": "1606505182383828",
"id": "8862450937835561392",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"64b26aa6090db81354a37e02a975664c8a3c9633\"}}",
"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\": \"64b26aa6090db81354a37e02a975664c8a3c9633\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15891, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"a5da17cd4e19649288b9634e7fff32455403b856\", \"got_dawn_revision\": \"e96986149080ca37e82788c907f439bc070aaa7b\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"64b26aa6090db81354a37e02a975664c8a3c9633\", \"got_revision_cp\": \"refs/heads/master@{#831631}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"9eaea2245f5c5133f2e05fcf0ad0062d009ca383\", \"got_v8_revision_cp\": \"refs/heads/8.9.64@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"64b26aa6090db81354a37e02a975664c8a3c9633\", \"swarm_hashes_refs/heads/master(at){#831631}_without_patch\": {\"absl_hardening_tests\": \"6d1f9c1692dac73cdc49b33656bb6b87a34a9442\", \"accessibility_unittests\": \"f81628132fd6ce6fd888c2627254b00ddf50748c\", \"angle_unittests\": \"1405222563d46f81b4fd0387a93e25fc965d8575\", \"app_shell_unittests\": \"e1303ce344af4a81577a1d1adcbf0359b0ca5145\", \"aura_unittests\": \"6db2e8cd8e551eb94510e722a4add2a610f11ffa\", \"base_unittests\": \"0f8ac94bc5a175d9d8abee329a51c79ce5e4a18c\", \"base_util_unittests\": \"cec6bdb091fb6a1e8acaaca361796eeea736de8e\", \"blink_common_unittests\": \"3bbdefc6369d3653e9f3bf942c2ce17141c85b0f\", \"blink_fuzzer_unittests\": \"d2cc9188793a0745ac252f00da9b06a9497b0bb3\", \"blink_heap_unittests\": \"ff18ecc51648883dd673c9ebc139b4cb937d6087\", \"blink_platform_unittests\": \"24e63332aee109cdcd38d74920ed7cb06c280762\", \"blink_unittests\": \"014139f37a3073867b052f982e188f44fe07fc34\", \"boringssl_crypto_tests\": \"4eb2ccc3b581db2a1af79cefabe161e375271171\", \"boringssl_ssl_tests\": \"1dbeaf4ca60053bf03620b6e0ab8e10814dd92fa\", \"browser_switcher_bho_unittests\": \"e510541545cd780a27f79f1dc0510c8bdee8fae3\", \"browser_tests\": \"1ab2427c1778f3f06607763beca9de73c980f4b4\", \"capture_unittests\": \"1246409a36afce55ba2c49343f384bc74e065e51\", \"cast_unittests\": \"1c4517828864840395362998657d8e7105703c84\", \"cc_unittests\": \"4d0bd55dfd9f5a3e8be59a97593f3ed987fbd6c3\", \"chrome_app_unittests\": \"9f0b5151c1739eae2f9d302d190ca849f69de349\", \"chrome_cleaner_unittests\": \"396239020b9032b6190244eac9307758c1ae67f5\", \"chrome_elf_unittests\": \"7821498a2476af096353955b0d88ca1feabaf285\", \"chromedriver_unittests\": \"5c8a16535b15622ef03eaa28b5e6f64a20f2c3b1\", \"components_browsertests\": \"511bb8d12773c6dc054bdeea9b02cb2529ec51dd\", \"components_unittests\": \"2d9872db240e174353f00fa2d576e8f9683de242\", \"compositor_unittests\": \"e4d85001edba720f9fa40dfe5c8d19a9d2e7f89d\", \"content_browsertests\": \"0fa7104d1e16352e161c03166036c35e14a82764\", \"content_unittests\": \"215d5056c06d3d83ec1b407d0dbdb5e3bd473563\", \"courgette_unittests\": \"d95879a597019ac598c42abe118512178396c053\", \"crashpad_tests\": \"ed3453b16b97457113929f7f0447b9ade4e162f2\", \"cronet_tests\": \"89e5c0f1e770f76a16d37f98ce99d84b0211a583\", \"cronet_unittests\": \"e1611f8cabe18875f2fe35acc541e275f710e966\", \"crypto_unittests\": \"63150b8345b31563cdcec286212ede7f471dc26a\", \"delayloads_unittests\": \"a863a5f11701366fef86ee6dd8536568ca885d58\", \"device_unittests\": \"3aa2de1dcd33b23c05af8595fc1af4fe2a0dcf9c\", \"display_unittests\": \"c49da048e63179c12e5dcc67605768f3c2ea2c96\", \"elevation_service_unittests\": \"fe571697e56d29854ab0969b6897465054570630\", \"events_unittests\": \"ec36bc3749dac77ec7f24a5a9e6caa8bc424dc61\", \"extensions_browsertests\": \"c2f9eab2baed23cad6ed2b350e08ab8b509ef9f7\", \"extensions_unittests\": \"7986aa85abf9b42ea57635a2528c65efcdc62d41\", \"filesystem_service_unittests\": \"8e9c487641dea6518f93bdf970fadd06f34a156a\", \"gcm_unit_tests\": \"62d0affa267089f019a95b9444410af869fb522d\", \"gcp_unittests\": \"1bb963127c56a7784b2af684997e9fa49ecaeb23\", \"gfx_unittests\": \"583327e8ae65a9ecd3974ea8e2864f7d9e465980\", \"gin_unittests\": \"914c3546732ac5f763f054e4e7e3e2734b684ce3\", \"google_apis_unittests\": \"0776fe05ee776af19afed0d9ea7c3a03950fe0c3\", \"gpu_unittests\": \"5201d237a645bbecf7cc397ff8d5f525ab7338ab\", \"gwp_asan_unittests\": \"45fc74d15372f37a63df5b22138c9baf4ad2fd40\", \"headless_browsertests\": \"fb58731cc2493abf796115abf4c90b76f0f45d50\", \"headless_unittests\": \"bccad071030c75654576e7bc2f2127ed0c2d7706\", \"install_static_unittests\": \"de3a345f6dd22549dd89700d9a387c1151d9e81a\", \"installer_util_unittests\": \"54d36cc0708b6d2fed695e63c8f19604f4e28970\", \"interactive_ui_tests\": \"04cb69bcb07087af3b5b99b7469da90162508598\", \"ipc_tests\": \"e6d7cc2e96f8b8779bfa608166e8ee0dbc9fae5e\", \"jingle_unittests\": \"0a5bf2d6a7e3fc5cd5a9eb513d4cb5a38632ef55\", \"latency_unittests\": \"a3fae62b2964e19c0e6a32b6a351cea0e72a3ee1\", \"libjingle_xmpp_unittests\": \"dcd414b06b384ce2dd023798cdb13d219283e9d7\", \"liburlpattern_unittests\": \"9eccb7fa28762246c126173db032346bb0bbd622\", \"media_blink_unittests\": \"b11f59071dc662233b17e4a31a92656119251ee0\", \"media_unittests\": \"88eb26410fc70d27e232fcd6317ccb6a63e246a7\", \"message_center_unittests\": \"2444346107a551f39f26f5cc762ec2eeb85ed34c\", \"midi_unittests\": \"8e1d06c3ce1e88e0a610f6979c8a617b60456c2c\", \"mojo_core_unittests\": \"2b5a193de7f881b3d9ea2ea22a4d2504ffc516a7\", \"mojo_unittests\": \"870a0a36930d9a4a230c33d34f2ca99022b874c2\", \"nacl_loader_unittests\": \"82b10cdec9e3ef5c429e1dfb1418f2044b5f18d0\", \"native_theme_unittests\": \"c03030af3e4a02874953e7799cd2d362c4e800d2\", \"net_unittests\": \"abad39a8731979f4daf665c1879e0a15c5caca09\", \"notification_helper_unittests\": \"2dd3487dfffded084e3adafd13ca3dcea0081e51\", \"pdf_unittests\": \"195b40f67c00133be5600defbbe1bf17930d3b9f\", \"perfetto_unittests\": \"a38a827906cd978ef145b72cf28add6257a002c7\", \"ppapi_unittests\": \"25831e7694f6164b743199eafaf6a51bb89424ce\", \"printing_unittests\": \"50542bfb3722c1daeaaa96478174a6197105b85c\", \"remoting_unittests\": \"a89ee6d6654cdfa179dd0eea6aef172139911586\", \"sbox_integration_tests\": \"84fa34d5217c81cdc1a6534a56c2e670d748d86c\", \"sbox_unittests\": \"e1f7c15e341efc49e4980bd70e01e6e790388a15\", \"sbox_validation_tests\": \"c4f535f5c7b131eb6de55cf3483f07ffeb26a2b6\", \"service_manager_unittests\": \"0092e9e61b56e0562b768021dcaa8cadfee8b06c\", \"services_unittests\": \"883cde1661e1af44bb8719b387e3294ab55b3c38\", \"setup_unittests\": \"ef78d2996d1a62f69e1cfafd0e26cc247d4d9825\", \"shell_dialogs_unittests\": \"9d588972e627898bb87e3dd1dbe0034fd2dac5bc\", \"skia_unittests\": \"9fb01b477f1d56fde6e32b1bd2bc8d076622fe8d\", \"snapshot_unittests\": \"1c42ad70ad13d9f0845a3c849e50e45e49f6d7ca\", \"sql_unittests\": \"1650921ed8ca9558b34c22649f1908d91799bff8\", \"storage_unittests\": \"518341a1eead1b9dd90403853e9a4b4b29803ef3\", \"sync_integration_tests\": \"861dcdb2d37b0aff3660b5ab340cc50b9a8a8ff1\", \"traffic_annotation_auditor_unittests\": \"fcb16d3e48ad5e2664577bc4c8d142863a16dd22\", \"ui_base_unittests\": \"5a1a58c6a17e0d2f2fc900c03e0b796285fc903f\", \"ui_touch_selection_unittests\": \"cd4bfcaa949f3f235fb253c275db427525579181\", \"unit_tests\": \"91e8039122e891cd294c6cc168b04d0b08ba81fa\", \"updater_tests\": \"0acf911a523f487caa394c04855fb6b3122cd1ed\", \"url_unittests\": \"753f99c67f8a9fb226ede1f8f54341d5c9bc1471\", \"views_unittests\": \"61fb675061491d8605a5045d89f9f98636d361f0\", \"viz_unittests\": \"df2490ec554d041b63354e29686b806f6b7a19ec\", \"vr_common_unittests\": \"878629e3d04fa7d4a45848fbb3fa8e5ba24cfa6e\", \"vr_pixeltests\": \"8fefdde87d594ee7e754e7ac1047ea9825885759\", \"weblayer_browsertests\": \"ad9df20700c90b38fdbf069b7e43bc5a88f02846\", \"weblayer_unittests\": \"d3227a13cd031ddc4ea91073d35ddd2821d1d6b8\", \"wm_unittests\": \"5fa2dbab40309a14e0d186cd000478179e346796\", \"wtf_unittests\": \"a0c4427b9184cf09c8869608acb06b218935e06e\", \"zlib_unittests\": \"fe2df27e9163c7b59bcc7f64ae502aea9c81aabf\", \"zucchini_unittests\": \"db88e52f9cafbaa1fa442a315f3e2378cac2306e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-4-qhsy\"], \"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\": [\"5640-d0eb544\"], \"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": "1606505185497407",
"status": "COMPLETED",
"status_changed_ts": "1606508591760708",
"tags": [
"build_address:luci.chromium.ci/win-asan/15891",
"builder:win-asan",
"buildset:commit/git/64b26aa6090db81354a37e02a975664c8a3c9633",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64b26aa6090db81354a37e02a975664c8a3c9633",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027880999919643232",
"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/8862450937835561392/+/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:5023fd41f835d010",
"user_agent:luci-scheduler"
],
"updated_ts": "1606508591765189",
"url": "https://ci.chromium.org/b/8862450937835561392",
"utcnow_ts": "1606508592257695"
}
}
[20:23:12.269] Invocation finished in 56m51.257304018s with status SUCCEEDED