[16:47:40.831] New invocation is queued and will start shortly
[16:47:42.022] Starting the invocation (attempt 1)
[16:47:42.077] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:47:42.084] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:47:42.084] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029974712814480368",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11c73e5dceb07e653808ae91b2905106507b971c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029974712814480368",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/11c73e5dceb07e653808ae91b2905106507b971c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c73e5dceb07e653808ae91b2905106507b971c",
"gitiles_ref:refs/heads/master"
]
}
[16:47:43.471] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604508462304089",
"id": "8864544650589073952",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11c73e5dceb07e653808ae91b2905106507b971c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604508463287256",
"tags": [
"build_address:luci.chromium.ci/win-asan/15458",
"builder:win-asan",
"buildset:commit/git/11c73e5dceb07e653808ae91b2905106507b971c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c73e5dceb07e653808ae91b2905106507b971c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029974712814480368",
"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/8864544650589073952/+/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": "1604508463287387",
"url": "https://ci.chromium.org/b/8864544650589073952",
"utcnow_ts": "1604508463463603"
}
}
[16:47:43.471] Task URL: https://ci.chromium.org/b/8864544650589073952
[16:47:43.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:2:0) after 1m0s
[16:47:49.833] Received PubSub notification, asking Buildbucket for the build status
[16:47:49.945] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:43.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:2:0)
[16:48:43.816] Timer tick, asking Buildbucket for the build status
[16:48:43.933] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:43.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:4:0) after 1m0s
[16:49:44.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:4:0)
[16:49:44.079] Timer tick, asking Buildbucket for the build status
[16:49:46.809] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:46.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:5:0) after 1m0s
[16:50:46.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:5:0)
[16:50:46.868] Timer tick, asking Buildbucket for the build status
[16:50:47.002] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:47.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:6:0) after 1m0s
[16:51:47.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:6:0)
[16:51:47.085] Timer tick, asking Buildbucket for the build status
[16:51:47.286] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:47.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:7:0) after 1m0s
[16:52:47.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:7:0)
[16:52:47.437] Timer tick, asking Buildbucket for the build status
[16:52:47.623] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:47.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:8:0) after 1m0s
[16:53:47.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:8:0)
[16:53:47.708] Timer tick, asking Buildbucket for the build status
[16:53:48.009] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:48.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:9:0) after 1m0s
[16:54:48.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:9:0)
[16:54:48.084] Timer tick, asking Buildbucket for the build status
[16:54:48.786] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:48.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:10:0) after 1m0s
[16:55:48.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:10:0)
[16:55:48.829] Timer tick, asking Buildbucket for the build status
[16:55:48.907] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:48.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:11:0) after 1m0s
[16:56:48.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:11:0)
[16:56:48.979] Timer tick, asking Buildbucket for the build status
[16:56:49.398] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:49.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:12:0) after 1m0s
[16:57:49.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:12:0)
[16:57:49.523] Timer tick, asking Buildbucket for the build status
[16:57:49.660] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:49.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:13:0) after 1m0s
[16:58:49.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:13:0)
[16:58:49.721] Timer tick, asking Buildbucket for the build status
[16:58:49.796] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:49.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:14:0) after 1m0s
[16:59:49.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:14:0)
[16:59:49.865] Timer tick, asking Buildbucket for the build status
[16:59:50.308] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:50.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:15:0) after 1m0s
[17:00:50.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:15:0)
[17:00:50.448] Timer tick, asking Buildbucket for the build status
[17:00:50.543] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:50.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:16:0) after 1m0s
[17:01:50.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:16:0)
[17:01:50.684] Timer tick, asking Buildbucket for the build status
[17:01:50.757] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:50.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:17:0) after 1m0s
[17:02:50.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:17:0)
[17:02:50.799] Timer tick, asking Buildbucket for the build status
[17:02:51.055] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:51.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:18:0) after 1m0s
[17:03:51.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:18:0)
[17:03:51.153] Timer tick, asking Buildbucket for the build status
[17:03:51.226] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:19:0) after 1m0s
[17:04:51.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:19:0)
[17:04:51.328] Timer tick, asking Buildbucket for the build status
[17:04:51.396] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:51.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:20:0) after 1m0s
[17:05:51.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:20:0)
[17:05:51.470] Timer tick, asking Buildbucket for the build status
[17:05:51.535] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:51.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:21:0) after 1m0s
[17:06:51.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:21:0)
[17:06:51.589] Timer tick, asking Buildbucket for the build status
[17:06:51.659] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:51.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:22:0) after 1m0s
[17:07:51.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:22:0)
[17:07:51.651] Timer tick, asking Buildbucket for the build status
[17:07:51.793] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:23:0) after 1m0s
[17:08:51.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:23:0)
[17:08:51.818] Timer tick, asking Buildbucket for the build status
[17:08:51.878] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:51.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:24:0) after 1m0s
[17:09:51.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:24:0)
[17:09:51.880] Timer tick, asking Buildbucket for the build status
[17:09:52.619] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:52.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:25:0) after 1m0s
[17:10:52.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:25:0)
[17:10:52.691] Timer tick, asking Buildbucket for the build status
[17:10:52.884] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:52.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:26:0) after 1m0s
[17:11:52.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:26:0)
[17:11:52.910] Timer tick, asking Buildbucket for the build status
[17:11:53.370] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:27:0) after 1m0s
[17:12:53.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:27:0)
[17:12:53.398] Timer tick, asking Buildbucket for the build status
[17:12:53.530] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:53.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:28:0) after 1m0s
[17:13:53.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:28:0)
[17:13:53.534] Timer tick, asking Buildbucket for the build status
[17:13:53.884] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:53.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:29:0) after 1m0s
[17:14:53.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:29:0)
[17:14:53.918] Timer tick, asking Buildbucket for the build status
[17:14:54.073] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:54.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:30:0) after 1m0s
[17:15:54.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:30:0)
[17:15:54.074] Timer tick, asking Buildbucket for the build status
[17:15:54.212] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:31:0) after 1m0s
[17:16:54.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:31:0)
[17:16:54.213] Timer tick, asking Buildbucket for the build status
[17:16:54.325] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:54.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:32:0) after 1m0s
[17:17:54.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:32:0)
[17:17:54.370] Timer tick, asking Buildbucket for the build status
[17:17:57.050] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:57.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:33:0) after 1m0s
[17:18:57.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:33:0)
[17:18:57.213] Timer tick, asking Buildbucket for the build status
[17:18:57.590] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:57.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:34:0) after 1m0s
[17:19:57.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:34:0)
[17:19:57.740] Timer tick, asking Buildbucket for the build status
[17:19:57.874] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:57.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:35:0) after 1m0s
[17:20:57.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:35:0)
[17:20:57.879] Timer tick, asking Buildbucket for the build status
[17:20:58.038] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:58.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:36:0) after 1m0s
[17:21:58.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:36:0)
[17:21:58.112] Timer tick, asking Buildbucket for the build status
[17:21:58.541] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:58.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:37:0) after 1m0s
[17:22:58.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:37:0)
[17:22:58.635] Timer tick, asking Buildbucket for the build status
[17:22:58.954] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:58.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:38:0) after 1m0s
[17:23:59.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:38:0)
[17:23:59.034] Timer tick, asking Buildbucket for the build status
[17:23:59.321] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:59.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:39:0) after 1m0s
[17:24:59.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:39:0)
[17:24:59.341] Timer tick, asking Buildbucket for the build status
[17:24:59.541] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:59.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:40:0) after 1m0s
[17:25:59.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:40:0)
[17:25:59.626] Timer tick, asking Buildbucket for the build status
[17:25:59.709] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:59.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:41:0) after 1m0s
[17:26:59.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:41:0)
[17:26:59.741] Timer tick, asking Buildbucket for the build status
[17:26:59.832] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:42:0) after 1m0s
[17:27:59.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:42:0)
[17:27:59.867] Timer tick, asking Buildbucket for the build status
[17:28:00.532] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:00.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:43:0) after 1m0s
[17:29:00.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:43:0)
[17:29:00.579] Timer tick, asking Buildbucket for the build status
[17:29:00.696] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:00.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:44:0) after 1m0s
[17:30:01.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:44:0)
[17:30:01.520] Timer tick, asking Buildbucket for the build status
[17:30:01.646] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:01.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:45:0) after 1m0s
[17:31:01.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:45:0)
[17:31:01.683] Timer tick, asking Buildbucket for the build status
[17:31:01.816] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:01.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:46:0) after 1m0s
[17:32:01.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:46:0)
[17:32:01.824] Timer tick, asking Buildbucket for the build status
[17:32:03.931] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:03.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:47:0) after 1m0s
[17:33:04.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:47:0)
[17:33:04.009] Timer tick, asking Buildbucket for the build status
[17:33:04.312] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:04.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:48:0) after 1m0s
[17:34:04.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:48:0)
[17:34:04.346] Timer tick, asking Buildbucket for the build status
[17:34:05.380] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:05.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:49:0) after 1m0s
[17:35:05.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:49:0)
[17:35:05.425] Timer tick, asking Buildbucket for the build status
[17:35:05.580] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:50:0) after 1m0s
[17:36:05.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:50:0)
[17:36:05.627] Timer tick, asking Buildbucket for the build status
[17:36:06.621] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:51:0) after 1m0s
[17:37:06.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:51:0)
[17:37:06.662] Timer tick, asking Buildbucket for the build status
[17:37:06.808] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:06.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:52:0) after 1m0s
[17:38:06.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:52:0)
[17:38:06.805] Timer tick, asking Buildbucket for the build status
[17:38:07.473] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:07.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:53:0) after 1m0s
[17:39:07.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:53:0)
[17:39:07.546] Timer tick, asking Buildbucket for the build status
[17:39:07.790] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:54:0) after 1m0s
[17:40:07.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:54:0)
[17:40:07.837] Timer tick, asking Buildbucket for the build status
[17:40:07.974] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:07.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:55:0) after 1m0s
[17:41:08.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:55:0)
[17:41:08.001] Timer tick, asking Buildbucket for the build status
[17:41:09.289] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:09.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:56:0) after 1m0s
[17:42:09.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:56:0)
[17:42:09.343] Timer tick, asking Buildbucket for the build status
[17:42:12.092] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:12.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:57:0) after 1m0s
[17:43:12.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:57:0)
[17:43:12.141] Timer tick, asking Buildbucket for the build status
[17:43:12.270] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:12.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:58:0) after 1m0s
[17:44:12.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:58:0)
[17:44:12.299] Timer tick, asking Buildbucket for the build status
[17:44:12.682] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:12.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:59:0) after 1m0s
[17:45:12.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:59:0)
[17:45:12.691] Timer tick, asking Buildbucket for the build status
[17:45:12.819] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:12.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:60:0) after 1m0s
[17:46:12.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:60:0)
[17:46:12.885] Timer tick, asking Buildbucket for the build status
[17:46:12.955] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:12.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:61:0) after 1m0s
[17:47:13.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:61:0)
[17:47:13.006] Timer tick, asking Buildbucket for the build status
[17:47:13.299] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:13.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:62:0) after 1m0s
[17:48:13.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:62:0)
[17:48:13.362] Timer tick, asking Buildbucket for the build status
[17:48:13.490] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:13.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:63:0) after 1m0s
[17:49:13.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:63:0)
[17:49:13.551] Timer tick, asking Buildbucket for the build status
[17:49:13.633] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:13.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:64:0) after 1m0s
[17:50:13.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:64:0)
[17:50:13.689] Timer tick, asking Buildbucket for the build status
[17:50:13.767] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:13.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:65:0) after 1m0s
[17:51:13.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:65:0)
[17:51:13.878] Timer tick, asking Buildbucket for the build status
[17:51:14.151] Build 8864544650589073952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:14.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029974712814480368:66:0) after 1m0s
[17:51:57.610] Received PubSub notification, asking Buildbucket for the build status
[17:51:57.705] Build 8864544650589073952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:51:57.705] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604512316344557",
"created_by": "project:chromium",
"created_ts": "1604508462304089",
"id": "8864544650589073952",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11c73e5dceb07e653808ae91b2905106507b971c\"}}",
"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\": \"11c73e5dceb07e653808ae91b2905106507b971c\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15458, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"265c5fa9a7e07ef0a0af6ed61d5682dae4fc31bd\", \"got_dawn_revision\": \"9d6265bc072546e92c1cea293e209e079d7345fb\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"11c73e5dceb07e653808ae91b2905106507b971c\", \"got_revision_cp\": \"refs/heads/master@{#824013}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"19f01495a8a18f2d222c29367901c7c1045ba4a2\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11c73e5dceb07e653808ae91b2905106507b971c\", \"swarm_hashes_refs/heads/master(at){#824013}_without_patch\": {\"absl_hardening_tests\": \"c318892627e26109f8310f261dd37371506bd8e1\", \"accessibility_unittests\": \"f72d2db786940087500e3e7440fc6d60461c0625\", \"angle_unittests\": \"036c034a7fa20aad93cb365c780355bbfb07d47c\", \"app_shell_unittests\": \"9639af80747d830ee20e4c531242dff6830a5729\", \"aura_unittests\": \"bb90325f6cac890493d33721c4397cb9fd28fb8e\", \"base_unittests\": \"f3ff3fb0d1ed534af65cf1f0934022ae7d143ced\", \"base_util_unittests\": \"e1db6a1bfed767a685176ff5c87b64ca01b7427e\", \"blink_common_unittests\": \"1cd66a6a6221697edfe844fe41e8359a76dbea3b\", \"blink_fuzzer_unittests\": \"7fb95cb5c74adef3cf49a21926a473429d25ac22\", \"blink_heap_unittests\": \"1d1677acaf6ea19e07474a515eb9ea308a4482b0\", \"blink_platform_unittests\": \"bbae1a7a3bb16c9ed92a8fa90ba9bdae2e7387b8\", \"blink_unittests\": \"3c43196cefb462d85abbcfa6fb96884fdd5323c1\", \"boringssl_crypto_tests\": \"025af658ad4f68e6fafc3d78cf434e231f7d84d1\", \"boringssl_ssl_tests\": \"87ac68db9593042c5bc04955da9aedae68bce363\", \"browser_switcher_bho_unittests\": \"63e70489f0739b6f6d8560bb39f9637db4f4fc7d\", \"browser_tests\": \"3a855e0aa59cd5832cfaafce042e7b3eae06b3ca\", \"capture_unittests\": \"d89aaf76d96f76bf11845ebd3029ab7a238070fd\", \"cast_unittests\": \"a5b164656e3ddb9662c88334ab0549235faecb2b\", \"cc_unittests\": \"51d72074dd180e6b20003ca3c30cf935840ac8f2\", \"chrome_app_unittests\": \"95604aedf267d0d423f9c297f65d49131c5172fe\", \"chrome_cleaner_unittests\": \"57b6057ebcd4a12ab01b8c0582f185cd13830adb\", \"chrome_elf_unittests\": \"1be34a1d0da2f4029035f4283b22ca1fada3c7c5\", \"chromedriver_unittests\": \"81db0ccd265482962e4ccc6895a925f9d871f30c\", \"components_browsertests\": \"08ff6d1ccc383f77955c2f638bbe5fbcc168091d\", \"components_unittests\": \"7c53788d92aaa1a740b566b61d97a1874def5642\", \"compositor_unittests\": \"64cdfabccf6f57474cb1a8a975eb842d2838a23f\", \"content_browsertests\": \"1e43e480dee1cc6b48888a2624738f675882068b\", \"content_unittests\": \"ba8fb72763368342718d015fdaf0ce38638d8f65\", \"courgette_unittests\": \"b38c274c5a5455b74925ca124ded5f319ec14e82\", \"crashpad_tests\": \"6833d47e6cd05ab80bd0d4f62b8ca940e9e8dfe1\", \"cronet_tests\": \"3dad7c672e50b7049d2d4d76231f07050546d57d\", \"cronet_unittests\": \"ff93f2bc6ad845b232ce31a4ae5bac9c638ff9b0\", \"crypto_unittests\": \"7548151402b840d0ecacc0ec9a1b1c963e70b40e\", \"delayloads_unittests\": \"fd0e532ccf83ddfeab9cb0ad0241c626de85c032\", \"device_unittests\": \"e34bc15e7451a98b2668222f5808640e1c00bd9a\", \"display_unittests\": \"388b2bb4bf39367a27f7638701963185690fdcd4\", \"elevation_service_unittests\": \"72bd70d35c79090d7e0a4a1b02d364881dbd52b9\", \"events_unittests\": \"ca7cceb1137f100809f7276b9b80fdcdd9a8dc97\", \"extensions_browsertests\": \"34d51c23fc73e817eda727b77388ea8396044f4a\", \"extensions_unittests\": \"68216629515f59f78418b61397bbb717b0adc63e\", \"filesystem_service_unittests\": \"7bf8240fc9038498c9785914a237a966f6d8a92d\", \"gcm_unit_tests\": \"d3c3f68a2aea333cdf70111f25e1a054b1ca288f\", \"gcp_unittests\": \"194864af9c759017fa467ba5390aa921300b89b0\", \"gfx_unittests\": \"8f427992c49a06810615140a7cb754c21334fba4\", \"gin_unittests\": \"fd82e5cc7ba9f18a237e73378d47798bb55dd6ce\", \"google_apis_unittests\": \"34316c97da592e7a522e95ec8ad66f3eca5485a1\", \"gpu_unittests\": \"57f2c0b917316224c094ad7da2fa220df32641e7\", \"gwp_asan_unittests\": \"bf20e67807aae11a34b2b69222ac635c74756caa\", \"headless_browsertests\": \"48d51a658684c23056fe67c6befdbe4959b696d8\", \"headless_unittests\": \"ef011d10ef35949e353e5d0c7321d6b04ed659e9\", \"install_static_unittests\": \"1b359b8822acb0c22860523d307d16d88932c283\", \"installer_util_unittests\": \"25ac7b3cd3e8035f356a888e70dffee762614046\", \"interactive_ui_tests\": \"5f0665e878b17cb6f7b504b13d3458ed3156fcad\", \"ipc_tests\": \"f36dfff6820db28d897bc9eeb5f88a1bb8fbf2ce\", \"jingle_unittests\": \"a322aee3947b8f025ae1c1cf86751596565ba2bc\", \"latency_unittests\": \"c2d7e30d76146324db1eaf543db93a2d385af2fa\", \"libjingle_xmpp_unittests\": \"780ec3c30985e6a96d2f5bc8707617a5b89bd5bf\", \"liburlpattern_unittests\": \"5b014aa0eac6dab7e7281a28fe944ec8e0b03eeb\", \"media_blink_unittests\": \"025f2c20c805957f863a8b30c7d370a45c26c5c3\", \"media_unittests\": \"00c63c2e374f2ec71d43d5cbfaddfff01eafabfa\", \"message_center_unittests\": \"3ebb4dba0a786b7d224e7a340e3b3e0b7d7d6ea2\", \"midi_unittests\": \"4fe89f13799185f97b46ce11279b8ec38633db69\", \"mojo_core_unittests\": \"b68d1d69f3bb01dbae8bb6af0c32aa5a94cb9893\", \"mojo_unittests\": \"eae0e6fee0c329405ad4ed96dd99cad5c4ba97dc\", \"nacl_loader_unittests\": \"7f0e30be0af2ac70c28f20d32f19fe529bccc9bf\", \"native_theme_unittests\": \"620d64102867da14148a3cdd724975fc5ec70d64\", \"net_unittests\": \"7e5c745dfd0ee4903473d76559de30192cd3434e\", \"notification_helper_unittests\": \"041f84c7a5d5ad7e723e3515f046c31513e7b6f1\", \"pdf_unittests\": \"79ef2494b2152d1e58f2aa29eefca2086e0109ef\", \"perfetto_unittests\": \"a8fce4f9bc7a54dc278d9e538e7b142872f85fd6\", \"ppapi_unittests\": \"0e123e4db4fb50528c195be0994dfb196ab4f2c4\", \"printing_unittests\": \"559ff2c5f2896ee27ff501c42712d4b825de73fb\", \"remoting_unittests\": \"cd3953cd0428e84722ecf5febbd961dc1844d3e2\", \"sbox_integration_tests\": \"6fd6a82357b00ae4bebd2405639bf2c378cc5df1\", \"sbox_unittests\": \"09ffa5c2a9d0b3f2c6002b4f96f2fc9a2c80eb1c\", \"sbox_validation_tests\": \"09eae9677cbb08f02bddb0987054006fdcb4639e\", \"service_manager_unittests\": \"80d0f8c9707f531d4bc9e5878468fae4ee230d63\", \"services_unittests\": \"a6c5b6ff40cee18ddddcc80d8bba09af8f02c483\", \"setup_unittests\": \"b9ee208105c370984c4b8367dc545918a6043dad\", \"shell_dialogs_unittests\": \"b35c8c20d3fbc649264b6dbdc1a2bdbc4f02a1ba\", \"skia_unittests\": \"f5af68e8da50c08d24f861e19e2369c49b806fca\", \"snapshot_unittests\": \"9e6ce448bf2b0a974d9a69e810a9fec943e8514e\", \"sql_unittests\": \"364fe8a67297994035fb37d3a8f9493ea5e4394b\", \"storage_unittests\": \"5f0a690181afa0dec18c3d58d1d1c78490df4a90\", \"sync_integration_tests\": \"ea99b2cd6a34ff9c1c21054a62945798026fb71f\", \"traffic_annotation_auditor_unittests\": \"4439ad6d93c440d578dc21e9947ee102a59c15aa\", \"ui_base_unittests\": \"261ab07ec917bbaf226a85e9a5fc6f99c3005257\", \"ui_touch_selection_unittests\": \"ba458789d07f543c6b4d9cbbb7c0f06d2bea6e4a\", \"unit_tests\": \"ee1e67320d2a37edffacaecf0c965e45107f2741\", \"updater_tests\": \"2f52fb3c9ce1db188a35aa7c22cd3d786ac837e3\", \"url_unittests\": \"1040982aee728dfa9845940743acc66838317d68\", \"views_unittests\": \"49b29d36b7979be3cb076d7ccc1a2aed98a44de6\", \"viz_unittests\": \"bdb7f2aef031d704aa8e05d3ca0d9f66a3dc4ef2\", \"vr_common_unittests\": \"b3a727048302ee008ddcbb641a776e3f4487d947\", \"vr_pixeltests\": \"2b3c0932481f4a7c422d462c828b43594ac04cdc\", \"weblayer_browsertests\": \"6e8de2c040842fab966d87048c7b04f4e4bd24bd\", \"weblayer_unittests\": \"824f9634738d2dbdb715d3a642a0c35bc57b56b0\", \"wm_unittests\": \"00318adc39dc9d7133f363ea859544f405504d48\", \"wtf_unittests\": \"c82e4b19c87268399c754891a0ff6a0a0e4197d4\", \"zlib_unittests\": \"81e3169a5fdbcc42f642f0c49f9b6a51543722fd\", \"zucchini_unittests\": \"da5cbaec75b97d1c72642956775783cf8cdf28d9\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"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": "1604508467952966",
"status": "COMPLETED",
"status_changed_ts": "1604512316650165",
"tags": [
"build_address:luci.chromium.ci/win-asan/15458",
"builder:win-asan",
"buildset:commit/git/11c73e5dceb07e653808ae91b2905106507b971c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c73e5dceb07e653808ae91b2905106507b971c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029974712814480368",
"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/8864544650589073952/+/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:4facf9bb030e7c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604512316669696",
"url": "https://ci.chromium.org/b/8864544650589073952",
"utcnow_ts": "1604512317695944"
}
}
[17:51:57.705] Invocation finished in 1h4m16.907385071s with status SUCCEEDED