[04:36:44.608] New invocation is queued and will start shortly
[04:36:45.724] Starting the invocation (attempt 1)
[04:36:45.785] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:36:45.785] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:36:45.785] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018605481620545504",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"93a25bf536943b56a26a6288f249639ec10d8a10\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018605481620545504",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/93a25bf536943b56a26a6288f249639ec10d8a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93a25bf536943b56a26a6288f249639ec10d8a10",
"gitiles_ref:refs/heads/master"
]
}
[04:36:46.833] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615351005908513",
"id": "8853175419586912320",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"93a25bf536943b56a26a6288f249639ec10d8a10\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615351006628570",
"tags": [
"build_address:luci.chromium.ci/win-asan/17732",
"builder:win-asan",
"buildset:commit/git/93a25bf536943b56a26a6288f249639ec10d8a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93a25bf536943b56a26a6288f249639ec10d8a10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018605481620545504",
"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/8853175419586912320/+/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": "1615351006628676",
"url": "https://ci.chromium.org/b/8853175419586912320",
"utcnow_ts": "1615351006824103"
}
}
[04:36:46.833] Task URL: https://ci.chromium.org/b/8853175419586912320
[04:36:46.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:2:0) after 1m0s
[04:36:56.546] Received PubSub notification, asking Buildbucket for the build status
[04:36:56.621] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:46.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:2:0)
[04:37:46.855] Timer tick, asking Buildbucket for the build status
[04:37:46.911] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:46.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:4:0) after 1m0s
[04:38:46.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:4:0)
[04:38:46.949] Timer tick, asking Buildbucket for the build status
[04:38:47.045] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:47.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:5:0) after 1m0s
[04:39:47.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:5:0)
[04:39:47.114] Timer tick, asking Buildbucket for the build status
[04:39:47.543] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:47.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:6:0) after 1m0s
[04:40:47.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:6:0)
[04:40:47.605] Timer tick, asking Buildbucket for the build status
[04:40:47.743] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:47.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:7:0) after 1m0s
[04:41:47.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:7:0)
[04:41:47.850] Timer tick, asking Buildbucket for the build status
[04:41:48.237] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:8:0) after 1m0s
[04:42:48.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:8:0)
[04:42:48.331] Timer tick, asking Buildbucket for the build status
[04:42:48.405] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:48.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:9:0) after 1m0s
[04:43:48.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:9:0)
[04:43:48.411] Timer tick, asking Buildbucket for the build status
[04:43:48.477] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:48.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:10:0) after 1m0s
[04:44:49.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:10:0)
[04:44:49.065] Timer tick, asking Buildbucket for the build status
[04:44:49.204] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:49.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:11:0) after 1m0s
[04:45:49.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:11:0)
[04:45:49.236] Timer tick, asking Buildbucket for the build status
[04:45:49.375] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:49.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:12:0) after 1m0s
[04:46:49.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:12:0)
[04:46:49.394] Timer tick, asking Buildbucket for the build status
[04:46:49.714] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:49.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:13:0) after 1m0s
[04:47:49.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:13:0)
[04:47:49.755] Timer tick, asking Buildbucket for the build status
[04:47:49.817] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:49.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:14:0) after 1m0s
[04:48:49.833] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:14:0)
[04:48:49.833] Timer tick, asking Buildbucket for the build status
[04:48:49.935] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:49.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:15:0) after 1m0s
[04:49:49.967] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:15:0)
[04:49:49.967] Timer tick, asking Buildbucket for the build status
[04:49:50.038] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:50.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:16:0) after 1m0s
[04:50:50.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:16:0)
[04:50:50.044] Timer tick, asking Buildbucket for the build status
[04:50:50.147] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:50.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:17:0) after 1m0s
[04:51:50.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:17:0)
[04:51:50.258] Timer tick, asking Buildbucket for the build status
[04:51:50.330] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:50.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:18:0) after 1m0s
[04:52:50.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:18:0)
[04:52:50.511] Timer tick, asking Buildbucket for the build status
[04:52:50.718] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:50.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:19:0) after 1m0s
[04:53:50.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:19:0)
[04:53:50.770] Timer tick, asking Buildbucket for the build status
[04:53:51.017] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:51.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:20:0) after 1m0s
[04:54:51.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:20:0)
[04:54:51.106] Timer tick, asking Buildbucket for the build status
[04:54:51.207] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:51.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:21:0) after 1m0s
[04:55:51.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:21:0)
[04:55:51.272] Timer tick, asking Buildbucket for the build status
[04:55:51.348] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:51.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:22:0) after 1m0s
[04:56:51.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:22:0)
[04:56:51.390] Timer tick, asking Buildbucket for the build status
[04:56:51.474] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:51.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:23:0) after 1m0s
[04:57:51.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:23:0)
[04:57:51.489] Timer tick, asking Buildbucket for the build status
[04:57:51.617] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:24:0) after 1m0s
[04:58:51.622] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:24:0)
[04:58:51.622] Timer tick, asking Buildbucket for the build status
[04:58:51.726] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:51.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:25:0) after 1m0s
[04:59:51.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:25:0)
[04:59:51.793] Timer tick, asking Buildbucket for the build status
[04:59:51.958] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:51.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:26:0) after 1m0s
[05:00:52.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:26:0)
[05:00:52.024] Timer tick, asking Buildbucket for the build status
[05:00:52.121] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:52.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:27:0) after 1m0s
[05:01:52.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:27:0)
[05:01:52.129] Timer tick, asking Buildbucket for the build status
[05:01:52.223] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:52.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:28:0) after 1m0s
[05:02:52.268] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:28:0)
[05:02:52.268] Timer tick, asking Buildbucket for the build status
[05:02:52.344] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:52.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:29:0) after 1m0s
[05:03:52.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:29:0)
[05:03:52.404] Timer tick, asking Buildbucket for the build status
[05:03:52.506] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:52.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:30:0) after 1m0s
[05:04:52.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:30:0)
[05:04:52.524] Timer tick, asking Buildbucket for the build status
[05:04:52.649] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:52.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:31:0) after 1m0s
[05:05:52.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:31:0)
[05:05:52.633] Timer tick, asking Buildbucket for the build status
[05:05:52.757] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:52.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:32:0) after 1m0s
[05:06:52.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:32:0)
[05:06:52.759] Timer tick, asking Buildbucket for the build status
[05:06:52.858] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:33:0) after 1m0s
[05:07:52.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:33:0)
[05:07:52.869] Timer tick, asking Buildbucket for the build status
[05:07:52.936] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:52.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:34:0) after 1m0s
[05:08:52.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:34:0)
[05:08:52.992] Timer tick, asking Buildbucket for the build status
[05:08:53.114] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:35:0) after 1m0s
[05:09:53.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:35:0)
[05:09:53.182] Timer tick, asking Buildbucket for the build status
[05:09:53.352] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:53.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:36:0) after 1m0s
[05:10:53.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:36:0)
[05:10:53.364] Timer tick, asking Buildbucket for the build status
[05:10:53.443] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:37:0) after 1m0s
[05:11:53.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:37:0)
[05:11:53.532] Timer tick, asking Buildbucket for the build status
[05:11:53.739] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:53.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:38:0) after 1m0s
[05:12:53.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:38:0)
[05:12:53.791] Timer tick, asking Buildbucket for the build status
[05:12:53.909] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:53.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:39:0) after 1m0s
[05:13:53.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:39:0)
[05:13:53.935] Timer tick, asking Buildbucket for the build status
[05:13:54.034] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:54.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:40:0) after 1m0s
[05:14:54.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:40:0)
[05:14:54.072] Timer tick, asking Buildbucket for the build status
[05:14:54.145] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:54.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:41:0) after 1m0s
[05:15:54.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:41:0)
[05:15:54.261] Timer tick, asking Buildbucket for the build status
[05:15:54.352] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:54.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:42:0) after 1m0s
[05:16:54.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:42:0)
[05:16:54.356] Timer tick, asking Buildbucket for the build status
[05:16:54.597] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:54.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:43:0) after 1m0s
[05:17:54.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:43:0)
[05:17:54.678] Timer tick, asking Buildbucket for the build status
[05:17:54.851] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:54.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:44:0) after 1m0s
[05:18:54.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:44:0)
[05:18:54.879] Timer tick, asking Buildbucket for the build status
[05:18:55.040] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:55.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:45:0) after 1m0s
[05:19:55.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:45:0)
[05:19:55.010] Timer tick, asking Buildbucket for the build status
[05:19:55.111] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:55.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:46:0) after 1m0s
[05:20:55.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:46:0)
[05:20:55.123] Timer tick, asking Buildbucket for the build status
[05:20:55.251] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:55.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:47:0) after 1m0s
[05:21:55.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:47:0)
[05:21:55.274] Timer tick, asking Buildbucket for the build status
[05:21:55.357] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:55.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:48:0) after 1m0s
[05:22:55.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:48:0)
[05:22:55.416] Timer tick, asking Buildbucket for the build status
[05:22:55.543] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:55.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:49:0) after 1m0s
[05:23:55.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:49:0)
[05:23:55.524] Timer tick, asking Buildbucket for the build status
[05:23:55.588] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:55.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:50:0) after 1m0s
[05:24:55.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:50:0)
[05:24:55.584] Timer tick, asking Buildbucket for the build status
[05:24:55.674] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:55.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:51:0) after 1m0s
[05:25:55.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:51:0)
[05:25:55.725] Timer tick, asking Buildbucket for the build status
[05:25:55.799] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:55.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:52:0) after 1m0s
[05:26:55.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:52:0)
[05:26:55.852] Timer tick, asking Buildbucket for the build status
[05:26:55.942] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:55.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:53:0) after 1m0s
[05:27:55.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:53:0)
[05:27:55.959] Timer tick, asking Buildbucket for the build status
[05:27:56.035] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:54:0) after 1m0s
[05:28:56.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:54:0)
[05:28:56.092] Timer tick, asking Buildbucket for the build status
[05:28:56.179] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:56.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:55:0) after 1m0s
[05:29:56.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:55:0)
[05:29:56.191] Timer tick, asking Buildbucket for the build status
[05:29:56.265] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:56.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:56:0) after 1m0s
[05:30:56.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:56:0)
[05:30:56.362] Timer tick, asking Buildbucket for the build status
[05:30:56.440] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:56.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:57:0) after 1m0s
[05:31:56.462] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:57:0)
[05:31:56.462] Timer tick, asking Buildbucket for the build status
[05:31:56.558] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:56.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:58:0) after 1m0s
[05:32:56.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:58:0)
[05:32:56.544] Timer tick, asking Buildbucket for the build status
[05:32:56.653] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:56.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:59:0) after 1m0s
[05:33:56.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:59:0)
[05:33:56.673] Timer tick, asking Buildbucket for the build status
[05:33:56.749] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:56.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:60:0) after 1m0s
[05:34:56.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:60:0)
[05:34:56.781] Timer tick, asking Buildbucket for the build status
[05:34:56.859] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:56.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:61:0) after 1m0s
[05:35:56.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:61:0)
[05:35:56.858] Timer tick, asking Buildbucket for the build status
[05:35:56.928] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:56.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:62:0) after 1m0s
[05:36:56.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:62:0)
[05:36:56.934] Timer tick, asking Buildbucket for the build status
[05:36:57.047] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:57.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:63:0) after 1m0s
[05:37:57.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:63:0)
[05:37:57.124] Timer tick, asking Buildbucket for the build status
[05:37:57.202] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:57.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:64:0) after 1m0s
[05:38:57.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:64:0)
[05:38:57.216] Timer tick, asking Buildbucket for the build status
[05:38:57.286] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:57.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:65:0) after 1m0s
[05:39:57.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:65:0)
[05:39:57.364] Timer tick, asking Buildbucket for the build status
[05:39:57.458] Build 8853175419586912320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:57.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018605481620545504:66:0) after 1m0s
[05:40:38.345] Received PubSub notification, asking Buildbucket for the build status
[05:40:38.432] Build 8853175419586912320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:40:38.432] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615354837444388",
"created_by": "project:chromium",
"created_ts": "1615351005908513",
"id": "8853175419586912320",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"93a25bf536943b56a26a6288f249639ec10d8a10\"}}",
"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\": \"93a25bf536943b56a26a6288f249639ec10d8a10\", \"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-8-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17732, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"2b7fdb62837eb5de4fede39f62c2d554b16cdbd5\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"93a25bf536943b56a26a6288f249639ec10d8a10\", \"got_revision_cp\": \"refs/heads/master@{#861429}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"0ad3c03922a83ecbc413bf73ded37511642e75c8\", \"got_v8_revision_cp\": \"refs/heads/9.1.86@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"93a25bf536943b56a26a6288f249639ec10d8a10\", \"swarm_hashes_refs/heads/master(at){#861429}_without_patch\": {\"absl_hardening_tests\": \"dbf90e764cc2e897327ba1c48ad2130b6969d30e\", \"accessibility_unittests\": \"45842a3d1fd75e3e3397c561f7b9bd993fe46bc2\", \"angle_unittests\": \"dc81bb5f7818e6c881a9533ea7f88e0d2395ea2f\", \"app_shell_unittests\": \"331d9237f3708f1f46ecbb2db6ef345a9965a1a1\", \"aura_unittests\": \"d1c1dd32021ea6ac2f0490310fd5362a92a40648\", \"base_unittests\": \"ac67f78cc5dd435d8864abe3a0dd5e272de55ab4\", \"base_util_unittests\": \"2c251e0eec8629a011f1824d1a823831b289e14f\", \"blink_common_unittests\": \"eddb44d5086e096637c5c6276e133b3e9edd44f1\", \"blink_fuzzer_unittests\": \"b905c3733c481a4dc20d529a03a53de03e67ba1d\", \"blink_heap_unittests\": \"42135834cf5faf83d05a6bb4eb1834c376aaf8a9\", \"blink_platform_unittests\": \"76f8351411f644411fa1681bb46eeb82998b7e4c\", \"blink_unittests\": \"1a18b76c14263b7490b1660928d6c50c04b90012\", \"boringssl_crypto_tests\": \"02df64b2154ac8e9b1cadc0d3a7f8537741bdf4c\", \"boringssl_ssl_tests\": \"bdbc665548292459fcc138c7072dd639e99776e1\", \"browser_switcher_bho_unittests\": \"f674ec6df75f295b2033bca79d6291a00f954a5d\", \"browser_tests\": \"8d4ab2234c8f2a66b144ff1a31e6b7cda613cfa5\", \"capture_unittests\": \"8537f165215378498b2ddd6bcd7d7fd743b4d740\", \"cast_unittests\": \"55d3d66e23733c8c421142c22885a8a5c1fcbe9f\", \"cc_unittests\": \"7e0855de81b399f4bbb753791c31f16f1fa49e29\", \"chrome_app_unittests\": \"9f7c0fc745e20313ee92bc6066579b7b7c821b38\", \"chrome_cleaner_unittests\": \"ffd072e16479139717d29b731d81652a7d19e029\", \"chrome_elf_unittests\": \"b1b5f9d00618d01c13b1a02d14d98d0ccabc15da\", \"chromedriver_unittests\": \"ddf47dccb1b8334c138d92c8447fa010682b8f31\", \"color_unittests\": \"14ce0450b6d0a05c33f7529e85f3a647365cd655\", \"components_browsertests\": \"53e18a8a16a4d7de5d3823bc01a4bcc11706d26b\", \"components_unittests\": \"57c1113257506f300cb9437b746fa0f210c492e3\", \"compositor_unittests\": \"8f2c69844022c16045de31ae9cf366ef8e165f2d\", \"content_browsertests\": \"3f5090c8ae5fa0558225cb61b244f01e4a1d3177\", \"content_unittests\": \"e466882fbe0f72297fafff81af1da138d562b4e8\", \"courgette_unittests\": \"46d45cf84c92b8522ac395a4aee456d95abf08d8\", \"crashpad_tests\": \"b85a9239961c84961a5ca07cdc9e1cb0acea92b2\", \"cronet_tests\": \"5e5060f4d515e64edee376d2e774a91f6fd17c4c\", \"cronet_unittests\": \"0c1c1d39e6a84577780ef18843d4795d2dd985d0\", \"crypto_unittests\": \"39681841d9f6e0f4ea4fd7fe0b9a5fc68c1176a3\", \"delayloads_unittests\": \"aebabebd2d37f8c05a928020da46bbd35512f6a6\", \"device_unittests\": \"2d6b6ba5228157a2cf6ab626773e065ec02816b9\", \"display_unittests\": \"3fcc5968710db8195a6e11fe700a4096b669a520\", \"elevation_service_unittests\": \"d15da1aad434d2a6aac2d1be525339a81fd6b520\", \"events_unittests\": \"ba014adc48da0b9345442fab8c33834587b6880f\", \"extensions_browsertests\": \"4ba4f64e6ce749e4ab6a308a6e6bf3538493d50b\", \"extensions_unittests\": \"e4cdafec3d8ccc43338fdbf93fc3990c0355d6f3\", \"filesystem_service_unittests\": \"be4738e352120b3973d6c15d64e84828de52cdf9\", \"gcm_unit_tests\": \"e70b8d97c0b0621117f85462048621aabfc9b2d7\", \"gcp_unittests\": \"17becf442ddf6aaed84ab22cf8984918700e073d\", \"gfx_unittests\": \"8e3ecacc5b542e8467e87b81c1979e814d4b7b90\", \"gin_unittests\": \"23f9883529a276d7d0b1eff6377d6a83cb5cfe8c\", \"google_apis_unittests\": \"cdb5b1ad650b9715852ffb9f126171b2784d7b08\", \"gpu_unittests\": \"cd3970098cc0ac2a2fa666444c20aa13270b3906\", \"gwp_asan_unittests\": \"68950c1e080b7e149cd69d67c3adc9a51ed5da32\", \"headless_browsertests\": \"39ce40d5bb41baad83ea1e1239832e69e016c83b\", \"headless_unittests\": \"76cba1fd5af7afb5b9902339c743e88f9eea6bed\", \"install_static_unittests\": \"643c6c4d5ea3c0bfcd755bac2e9799072887c4ec\", \"installer_util_unittests\": \"5d652e2caa242304ec41809aae5b038742aa6627\", \"interactive_ui_tests\": \"69000668b7041cad979087abb037888cb65d55c6\", \"ipc_tests\": \"ddcab054113dc03ab8fdcdf8808bb5f3e0a7475c\", \"jingle_unittests\": \"6e4f563c5d83dbd11d152ee2cf8f0940c192547d\", \"latency_unittests\": \"7b8b7691a2bce63e5a22f6a99378456f81e2bac2\", \"libjingle_xmpp_unittests\": \"29393fc49b179c592ec9b3620a091c3d765a57ae\", \"liburlpattern_unittests\": \"603665a7e45685b2b7ec6c4d635c9e8920e7829c\", \"media_blink_unittests\": \"7a87330bb9547e26c0a611e5c227fce00796ec3f\", \"media_unittests\": \"340350f41f72290ce40dc6c2d2567661f733e086\", \"message_center_unittests\": \"1656cf2790cd256d12209a1ce79fb8153f75b7ad\", \"midi_unittests\": \"4db3971475133496ac37ce51c499b43cc0f5105a\", \"mojo_core_unittests\": \"2fe92f11a7b50f1b97e19ea792d4356b9bd8552c\", \"mojo_unittests\": \"45bddf9d72badd66833f90513d4ec1628c259e92\", \"nacl_loader_unittests\": \"8a68e140f7954ba8b776f1136c2047b28eaa1354\", \"native_theme_unittests\": \"b815532dad17148937d627df23f343451a8ff79d\", \"net_unittests\": \"83d5cec084b9543b39953606a3fdc48c1fa6a099\", \"notification_helper_unittests\": \"ba2971b91a32c05a07878da71678326029537d91\", \"pdf_unittests\": \"8d1765c07286d562302027220d55edea67ed6230\", \"perfetto_unittests\": \"50b5a2bb80afd42620c75ffb62ad54061f6945a8\", \"ppapi_unittests\": \"de636b17016364af8527e73bdf4cc763683aa44e\", \"printing_unittests\": \"e5c60db9767eb8530e109e99f43d94fd03c0bf84\", \"remoting_unittests\": \"d138d5865953ead9e15404fe909612864db5d7a3\", \"sbox_integration_tests\": \"a2b022f505c4d06531cc6bd477d7a5b659ba93df\", \"sbox_unittests\": \"8e0489d582a7a30af2c3635ba09e4d8b10e7a4b7\", \"sbox_validation_tests\": \"bb7fbfeb29b7a7a842cbab7c59ce929ed3db071b\", \"service_manager_unittests\": \"9ae9ecffe1d3cf4690e8cc7f29b0e4b5e0b190b3\", \"services_unittests\": \"9e1cd867babcb4a0ef263f467d9a7ca5fece40ef\", \"setup_unittests\": \"402e7e73ce23ffdab9d0fc219d5b6516ef18ea79\", \"shell_dialogs_unittests\": \"f82e11ec58f527be2ac7cc883dc8c36cb9b937c3\", \"skia_unittests\": \"728405cee3b75b5cf8d9a7616796c6bf8dacdc78\", \"snapshot_unittests\": \"443c99c4666f007fbb3f2c66832316794bdd98fa\", \"sql_unittests\": \"482c736662aa94dee1ed59c17bd17018da9a721c\", \"storage_unittests\": \"375cbd980591d40a1847b7ca7732e1e1ce5d13f1\", \"sync_integration_tests\": \"89532f1527444f5716599ffc552b3802b693af8a\", \"traffic_annotation_auditor_unittests\": \"64a463053a35d8e26549ad54796fc11d40142378\", \"ui_base_unittests\": \"cb88f40c24aaf8d48acae05a487f46393d3ce683\", \"ui_touch_selection_unittests\": \"d0fe8e0a530adabc819655886b2c0e08e05056e2\", \"unit_tests\": \"6b2a0294ff72381bc5cbead43a0ca79b1ba7c78f\", \"updater_tests\": \"52cc2748bff955007621537d726979bbe729b9f5\", \"url_unittests\": \"ea5070d205c17a586da105a2b59526a47c8d296b\", \"views_unittests\": \"f8d4db6647dc0d695b37d614190d60a36151ecc3\", \"viz_unittests\": \"07855c45ec4de5d3ea5de4656c7b892c588eb0d1\", \"vr_common_unittests\": \"c0fdb8a5b261fd6af3bae3bd210cc086cfc05483\", \"vr_pixeltests\": \"6321ec630c7dfd18189f0d9229b9be4583f46536\", \"weblayer_browsertests\": \"0412c5bffc87cbfa56464698ec1e3d3c8740b72c\", \"weblayer_unittests\": \"27881f8036fd7a1cb71175efb8e30217707ae9e3\", \"wm_unittests\": \"f48c368b7d35ca80ba7105d6bc206c1086118a50\", \"wtf_unittests\": \"d60ebbfdff272d7bd86c81fe1a2915ce8fb3e400\", \"zlib_unittests\": \"8b4f7bafe45bf8c7d970f6332eea2423d1a21b88\", \"zucchini_unittests\": \"c8dfc1d703535fd3233f145b7615fbe0edc88cf2\"}}, \"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-8-2xaw\"], \"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\": [\"5746-91ff3bd\"], \"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": "1615351015775994",
"status": "COMPLETED",
"status_changed_ts": "1615354837941062",
"tags": [
"build_address:luci.chromium.ci/win-asan/17732",
"builder:win-asan",
"buildset:commit/git/93a25bf536943b56a26a6288f249639ec10d8a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93a25bf536943b56a26a6288f249639ec10d8a10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018605481620545504",
"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/8853175419586912320/+/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:52333dcf1f3cf210",
"user_agent:luci-scheduler"
],
"updated_ts": "1615354837954314",
"url": "https://ci.chromium.org/b/8853175419586912320",
"utcnow_ts": "1615354838419532"
}
}
[05:40:38.432] Invocation finished in 1h3m53.846814068s with status SUCCEEDED