[11:33:00.723] New invocation is queued and will start shortly
[11:33:01.901] Starting the invocation (attempt 1)
[11:33:01.941] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:33:01.941] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:33:01.941] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017763919561406352",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"059f64f440a11335c8efb36cb25764e082dc706a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9017763919561406352",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/059f64f440a11335c8efb36cb25764e082dc706a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/059f64f440a11335c8efb36cb25764e082dc706a",
"gitiles_ref:refs/heads/master"
]
}
[11:33:02.678] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616153582041482",
"id": "8852333857516231792",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"059f64f440a11335c8efb36cb25764e082dc706a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616153582436322",
"tags": [
"build_address:luci.chromium.ci/win-asan/17869",
"builder:win-asan",
"buildset:commit/git/059f64f440a11335c8efb36cb25764e082dc706a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/059f64f440a11335c8efb36cb25764e082dc706a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017763919561406352",
"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/8852333857516231792/+/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": "1616153582436428",
"url": "https://ci.chromium.org/b/8852333857516231792",
"utcnow_ts": "1616153582643183"
}
}
[11:33:02.678] Task URL: https://ci.chromium.org/b/8852333857516231792
[11:33:02.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:2:0) after 1m0s
[11:33:05.575] Received PubSub notification, asking Buildbucket for the build status
[11:33:05.659] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:02.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:2:0)
[11:34:02.691] Timer tick, asking Buildbucket for the build status
[11:34:02.782] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:02.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:4:0) after 1m0s
[11:35:02.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:4:0)
[11:35:02.804] Timer tick, asking Buildbucket for the build status
[11:35:02.957] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:02.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:5:0) after 1m0s
[11:36:02.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:5:0)
[11:36:02.973] Timer tick, asking Buildbucket for the build status
[11:36:03.044] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:03.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:6:0) after 1m0s
[11:37:03.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:6:0)
[11:37:03.035] Timer tick, asking Buildbucket for the build status
[11:37:03.441] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:03.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:7:0) after 1m0s
[11:38:03.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:7:0)
[11:38:03.511] Timer tick, asking Buildbucket for the build status
[11:38:03.772] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:03.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:8:0) after 1m0s
[11:39:03.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:8:0)
[11:39:03.797] Timer tick, asking Buildbucket for the build status
[11:39:04.004] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:04.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:9:0) after 1m0s
[11:40:04.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:9:0)
[11:40:04.039] Timer tick, asking Buildbucket for the build status
[11:40:04.315] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:04.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:10:0) after 1m0s
[11:41:04.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:10:0)
[11:41:04.435] Timer tick, asking Buildbucket for the build status
[11:41:04.604] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:04.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:11:0) after 1m0s
[11:42:04.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:11:0)
[11:42:04.675] Timer tick, asking Buildbucket for the build status
[11:42:04.746] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:04.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:12:0) after 1m0s
[11:43:04.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:12:0)
[11:43:04.810] Timer tick, asking Buildbucket for the build status
[11:43:04.885] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:04.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:13:0) after 1m0s
[11:44:05.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:13:0)
[11:44:05.039] Timer tick, asking Buildbucket for the build status
[11:44:05.125] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:05.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:14:0) after 1m0s
[11:45:05.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:14:0)
[11:45:05.279] Timer tick, asking Buildbucket for the build status
[11:45:05.350] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:05.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:15:0) after 1m0s
[11:46:05.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:15:0)
[11:46:05.457] Timer tick, asking Buildbucket for the build status
[11:46:05.671] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:16:0) after 1m0s
[11:47:05.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:16:0)
[11:47:05.772] Timer tick, asking Buildbucket for the build status
[11:47:05.836] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:05.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:17:0) after 1m0s
[11:48:05.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:17:0)
[11:48:05.933] Timer tick, asking Buildbucket for the build status
[11:48:06.002] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:06.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:18:0) after 1m0s
[11:49:06.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:18:0)
[11:49:06.109] Timer tick, asking Buildbucket for the build status
[11:49:06.268] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:06.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:19:0) after 1m0s
[11:50:06.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:19:0)
[11:50:06.308] Timer tick, asking Buildbucket for the build status
[11:50:06.430] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:06.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:20:0) after 1m0s
[11:51:06.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:20:0)
[11:51:06.425] Timer tick, asking Buildbucket for the build status
[11:51:06.500] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:06.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:21:0) after 1m0s
[11:52:06.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:21:0)
[11:52:06.566] Timer tick, asking Buildbucket for the build status
[11:52:06.652] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:06.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:22:0) after 1m0s
[11:53:06.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:22:0)
[11:53:06.672] Timer tick, asking Buildbucket for the build status
[11:53:06.811] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:06.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:23:0) after 1m0s
[11:54:06.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:23:0)
[11:54:06.889] Timer tick, asking Buildbucket for the build status
[11:54:07.020] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:07.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:24:0) after 1m0s
[11:55:07.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:24:0)
[11:55:07.082] Timer tick, asking Buildbucket for the build status
[11:55:07.192] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:07.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:25:0) after 1m0s
[11:56:07.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:25:0)
[11:56:07.445] Timer tick, asking Buildbucket for the build status
[11:56:07.517] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:07.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:26:0) after 1m0s
[11:57:07.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:26:0)
[11:57:07.629] Timer tick, asking Buildbucket for the build status
[11:57:07.698] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:07.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:27:0) after 1m0s
[11:58:07.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:27:0)
[11:58:07.756] Timer tick, asking Buildbucket for the build status
[11:58:07.897] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:28:0) after 1m0s
[11:59:07.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:28:0)
[11:59:07.954] Timer tick, asking Buildbucket for the build status
[11:59:08.236] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:08.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:29:0) after 1m0s
[12:00:08.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:29:0)
[12:00:08.319] Timer tick, asking Buildbucket for the build status
[12:00:08.435] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:08.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:30:0) after 1m0s
[12:01:09.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:30:0)
[12:01:09.555] Timer tick, asking Buildbucket for the build status
[12:01:10.782] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:10.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:31:0) after 1m0s
[12:02:10.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:31:0)
[12:02:10.949] Timer tick, asking Buildbucket for the build status
[12:02:11.045] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:11.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:32:0) after 1m0s
[12:03:11.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:32:0)
[12:03:11.088] Timer tick, asking Buildbucket for the build status
[12:03:11.980] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:11.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:33:0) after 1m0s
[12:04:12.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:33:0)
[12:04:12.069] Timer tick, asking Buildbucket for the build status
[12:04:12.218] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:12.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:34:0) after 1m0s
[12:05:12.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:34:0)
[12:05:12.354] Timer tick, asking Buildbucket for the build status
[12:05:12.430] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:12.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:35:0) after 1m0s
[12:06:12.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:35:0)
[12:06:12.551] Timer tick, asking Buildbucket for the build status
[12:06:12.640] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:12.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:36:0) after 1m0s
[12:07:12.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:36:0)
[12:07:12.886] Timer tick, asking Buildbucket for the build status
[12:07:12.962] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:12.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:37:0) after 1m0s
[12:08:13.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:37:0)
[12:08:13.006] Timer tick, asking Buildbucket for the build status
[12:08:13.317] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:13.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:38:0) after 1m0s
[12:09:13.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:38:0)
[12:09:13.468] Timer tick, asking Buildbucket for the build status
[12:09:13.709] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:13.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:39:0) after 1m0s
[12:10:13.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:39:0)
[12:10:13.789] Timer tick, asking Buildbucket for the build status
[12:10:13.946] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:13.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:40:0) after 1m0s
[12:11:14.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:40:0)
[12:11:14.047] Timer tick, asking Buildbucket for the build status
[12:11:14.134] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:41:0) after 1m0s
[12:12:14.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:41:0)
[12:12:14.246] Timer tick, asking Buildbucket for the build status
[12:12:14.373] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:14.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:42:0) after 1m0s
[12:13:14.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:42:0)
[12:13:14.458] Timer tick, asking Buildbucket for the build status
[12:13:14.541] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:14.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:43:0) after 1m0s
[12:14:14.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:43:0)
[12:14:14.677] Timer tick, asking Buildbucket for the build status
[12:14:14.778] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:14.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:44:0) after 1m0s
[12:15:14.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:44:0)
[12:15:14.782] Timer tick, asking Buildbucket for the build status
[12:15:14.853] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:45:0) after 1m0s
[12:16:14.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:45:0)
[12:16:14.869] Timer tick, asking Buildbucket for the build status
[12:16:14.959] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:14.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:46:0) after 1m0s
[12:17:15.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:46:0)
[12:17:15.029] Timer tick, asking Buildbucket for the build status
[12:17:15.112] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:15.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:47:0) after 1m0s
[12:18:15.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:47:0)
[12:18:15.198] Timer tick, asking Buildbucket for the build status
[12:18:15.540] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:15.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:48:0) after 1m0s
[12:19:15.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:48:0)
[12:19:15.574] Timer tick, asking Buildbucket for the build status
[12:19:15.733] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:15.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:49:0) after 1m0s
[12:20:15.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:49:0)
[12:20:15.840] Timer tick, asking Buildbucket for the build status
[12:20:15.921] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:50:0) after 1m0s
[12:21:15.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:50:0)
[12:21:15.931] Timer tick, asking Buildbucket for the build status
[12:21:16.015] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:16.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:51:0) after 1m0s
[12:22:16.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:51:0)
[12:22:16.044] Timer tick, asking Buildbucket for the build status
[12:22:16.142] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:16.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:52:0) after 1m0s
[12:23:16.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:52:0)
[12:23:16.192] Timer tick, asking Buildbucket for the build status
[12:23:16.292] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:16.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:53:0) after 1m0s
[12:24:16.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:53:0)
[12:24:16.353] Timer tick, asking Buildbucket for the build status
[12:24:16.495] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:16.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:54:0) after 1m0s
[12:25:16.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:54:0)
[12:25:16.574] Timer tick, asking Buildbucket for the build status
[12:25:16.813] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:16.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:55:0) after 1m0s
[12:26:16.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:55:0)
[12:26:16.835] Timer tick, asking Buildbucket for the build status
[12:26:16.908] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:16.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:56:0) after 1m0s
[12:27:16.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:56:0)
[12:27:16.938] Timer tick, asking Buildbucket for the build status
[12:27:17.019] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:17.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:57:0) after 1m0s
[12:28:17.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:57:0)
[12:28:17.005] Timer tick, asking Buildbucket for the build status
[12:28:17.126] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:17.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:58:0) after 1m0s
[12:29:17.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:58:0)
[12:29:17.155] Timer tick, asking Buildbucket for the build status
[12:29:17.224] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:17.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:59:0) after 1m0s
[12:30:17.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:59:0)
[12:30:17.252] Timer tick, asking Buildbucket for the build status
[12:30:17.494] Build 8852333857516231792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:17.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017763919561406352:60:0) after 1m0s
[12:31:01.962] Received PubSub notification, asking Buildbucket for the build status
[12:31:02.059] Build 8852333857516231792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:31:02.059] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616157051818434",
"created_by": "project:chromium",
"created_ts": "1616153582041482",
"id": "8852333857516231792",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"059f64f440a11335c8efb36cb25764e082dc706a\"}}",
"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\": \"059f64f440a11335c8efb36cb25764e082dc706a\", \"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-6-xj00\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17869, \"clang_revision\": \"llvmorg-13-init-4720-g7bafe336-1\", \"got_angle_revision\": \"ba0bd78574b21a297e22ee2f8ac1efdeff0a9026\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"059f64f440a11335c8efb36cb25764e082dc706a\", \"got_revision_cp\": \"refs/heads/master@{#864616}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"43315277e45e866e927722377d36b04ca3c1014b\", \"got_v8_revision_cp\": \"refs/heads/9.1.158@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"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\": \"059f64f440a11335c8efb36cb25764e082dc706a\", \"swarm_hashes_refs/heads/master(at){#864616}_without_patch\": {\"absl_hardening_tests\": \"a6aa2718aab453a86967e2687d3a57cc2637b468\", \"accessibility_unittests\": \"cf0020603a51149957526e41f3c04e094ba83a8a\", \"angle_unittests\": \"447dd0fc2063bdc82c7ed9cb8502fdb0ff71dad2\", \"app_shell_unittests\": \"ddee3d1bbb508cbcee8b38d2d9e95d879231b2bf\", \"aura_unittests\": \"93cfd2105f03f267a70fbd6f54c4bd1e4f248df2\", \"base_unittests\": \"9179ba7a65e667f951ae5357cd4f48f69412134c\", \"base_util_unittests\": \"26f58bfbb20c3c7e909f184faaf2d7f8b5e0d186\", \"blink_common_unittests\": \"ede37db20c4d22bace96964d46f640827b69ad5b\", \"blink_fuzzer_unittests\": \"dc2371c038f8e469d5861ab964527dbf1c8f9de1\", \"blink_heap_unittests\": \"3e80ec1efab74dbd33b492ef58707ba04b559b70\", \"blink_platform_unittests\": \"a0470c8267be479aaae23c5b91a1b7f1069e793a\", \"blink_unittests\": \"a2c342502a4aaa47d1eec414c4711696910b4618\", \"boringssl_crypto_tests\": \"d12540444d0bbc4a100e322f4611cb3fe3c1e066\", \"boringssl_ssl_tests\": \"7b6be2b25c17b0512d3fbf04aa3014d320f25b1d\", \"browser_switcher_bho_unittests\": \"2f508e05e1fb834ec28903ff3fcf6a6cf783afe9\", \"browser_tests\": \"96a064fab945decaeeb527b9196979839a9f4775\", \"capture_unittests\": \"cebb6ff5b748c6835246a2c51a24e1eee1769b5b\", \"cast_unittests\": \"415efc158c3c7dc344d5cf81ff0ff0bae4a6a391\", \"cc_unittests\": \"ecb154091f05e8ff1a90afda7c763a10dd7ce9fa\", \"chrome_app_unittests\": \"5343727b4ab8ca06bf8f733af8af21563ab61faa\", \"chrome_cleaner_unittests\": \"c9b479335e9d22a5d2842467833d7d15df4a3571\", \"chrome_elf_unittests\": \"13da1ef1819e3e851ba49fe2d066a33e3a20dfc2\", \"chromedriver_unittests\": \"7688a369142b01f66f3fa73b70d7fb1a5b44becf\", \"color_unittests\": \"8eea06d567c69e0fe1457ae20934b87f13594b57\", \"components_browsertests\": \"bd57ac818100b00a081bb1eaf442844e77b724e2\", \"components_unittests\": \"751540cf2e5524fa39f5199ec762aecf828ca231\", \"compositor_unittests\": \"9de8de68b346b9cd4e70e3b8d875e26ed143fa55\", \"content_browsertests\": \"d2de325314204c092998cc97d53586c09bc82591\", \"content_unittests\": \"8897f6702719b1ffd1fc5b90b23694bc44140afd\", \"courgette_unittests\": \"659342c5d53d743cf48b220685df468c02b57896\", \"crashpad_tests\": \"265c9ce6bb30d04e3c53e51b575a08f5b5a71098\", \"cronet_tests\": \"924163c9da748ea19f0dc737717ceb8302b9e0a5\", \"cronet_unittests\": \"9a28e6fd14d5780085f31e7cd5195ab96a5a2d7d\", \"crypto_unittests\": \"450d4e9d5378d3f46be95a6d99fdbd17221a4d34\", \"delayloads_unittests\": \"daa1f905f44796f39346426ede3925e78759311f\", \"device_unittests\": \"45de55f796edbdcf5784620eb3eeceba0077a313\", \"display_unittests\": \"5180efa4d5bb5dca5e10e2dbb0676675085fcd0a\", \"elevation_service_unittests\": \"55b35091294651b6ee04689a4ccfa10ef8094582\", \"events_unittests\": \"5f54a215da8da0e73d27b5b2afddf56a02c02b82\", \"extensions_browsertests\": \"52c477fe99634dcff335ba3f8e6fb039a87a3c73\", \"extensions_unittests\": \"cef98d27980f62389bea79ef3e2baa63e2297d7f\", \"filesystem_service_unittests\": \"7117ff882a8feff56db90d089e351b046091216e\", \"gcm_unit_tests\": \"70260d5fa35de96a20c146796f5dd4abcdb98939\", \"gcp_unittests\": \"e0488f45e486710461f4902a073829a0aa98cce4\", \"gfx_unittests\": \"a4e28b415d4539adea41fcbe6433ebc5d78af259\", \"gin_unittests\": \"c0fd9641b4d95f583961153187eb05986c32f9de\", \"google_apis_unittests\": \"3931da1156c92e93eab107ad69fa68b5b5a9284a\", \"gpu_unittests\": \"6f105898374a2ec6721596eaa9286e0f50d4a205\", \"gwp_asan_unittests\": \"677664b27e19c47c0b7a00409c70cd79077510df\", \"headless_browsertests\": \"d8e40a208db46b8c741316bde781ebbd2828b092\", \"headless_unittests\": \"2a485f9f2260f902717d133d1fe0b5dfcf965536\", \"install_static_unittests\": \"506438aa032b558691cc06c1b4e9d66609946691\", \"installer_util_unittests\": \"7ad15daa9fb858425a5d36342615d2accd3cc0b0\", \"interactive_ui_tests\": \"d82f4154b6f4804ca973fc46384cd9b8c52ca366\", \"ipc_tests\": \"28ef540f54a617e9f174b6f4376524922bfc7d91\", \"jingle_unittests\": \"9567c963363ce5914def51459588afe0f3237a2c\", \"latency_unittests\": \"9d037cb46d6b1b6439bee0bc1ea99d210b466e80\", \"libjingle_xmpp_unittests\": \"693988631502fe3a35c7dedac184b1822bf365b0\", \"liburlpattern_unittests\": \"bc88467f7f3e4adb15c7564a72e5996330cc6445\", \"media_blink_unittests\": \"2dd0b18d83d47e5d2765d503526e7a2890210f78\", \"media_unittests\": \"bbcb2e1f45b9fcd6b16c036695cbac8a0a6f5206\", \"message_center_unittests\": \"4d51cfb8ba1bf8c5b445a48dfb04c6ca4b50c363\", \"midi_unittests\": \"7855245987ada33ea99eac3665fc47a13a7a23fc\", \"mojo_core_unittests\": \"02b2d1ad5b266834d41c7fee2a0a44066aca8e54\", \"mojo_unittests\": \"0e5b3739731e074c538fb4d140a5e677e5cdc629\", \"nacl_loader_unittests\": \"04be7ea2616a9eb203490db178da08ab98fdd859\", \"native_theme_unittests\": \"9aced3b90cf3b33b21b9bed4cbef4ac6ef6b3843\", \"net_unittests\": \"7f1185c776bf7734f7a60a9522205f1f5c42b9e9\", \"notification_helper_unittests\": \"5562c8eee8ba68c18a717a5a99c7c839786ddcc7\", \"pdf_unittests\": \"cd8515620b6e0592d9bac3f180396bb2c875f510\", \"perfetto_unittests\": \"c680341063149227f792b33f633f7c751e252e96\", \"ppapi_unittests\": \"edecd33dc32a4020d03fac5088b2151b23d09489\", \"printing_unittests\": \"62b7875671832c3313c1ac4147830122488160fd\", \"remoting_unittests\": \"b0e051310a0204a6315a22ce078af0cfc5202a46\", \"sbox_integration_tests\": \"352b895399de8f1e30a62b26adece4ee0ef2f3d8\", \"sbox_unittests\": \"e8e29580b670e85ae387451422781bffcf875cec\", \"sbox_validation_tests\": \"68924e5877495c74d89a1b3ce6008f3f5ac2f63e\", \"service_manager_unittests\": \"f48bb73abd8cd223d6f4365c88cf0e0175397560\", \"services_unittests\": \"846945438f72826e4e580867e60cec66fc0424e4\", \"setup_unittests\": \"bb68a858b24ebf1b06e9df5ec1343ac1dd9a8e09\", \"shell_dialogs_unittests\": \"71a53730bb2b293edf717c89018eb4f13d751428\", \"skia_unittests\": \"5bb2ab602d7a73214472fb3dce0808d7802561ab\", \"snapshot_unittests\": \"2d6c1c96d2486e45e7b448b4aa1783564d43cc1d\", \"sql_unittests\": \"1b574a26b4d22f8a553b92fff5ffa4b654aeb791\", \"storage_unittests\": \"6d3da3fe269e2d7cf148d75eec27131f4579287a\", \"sync_integration_tests\": \"72b6227f88bd2d737d7a0aa6ab48e9167130a708\", \"traffic_annotation_auditor_unittests\": \"291cea1700e3b08b35da0b9c9f7489b2ab4202e2\", \"ui_base_unittests\": \"ccb3118667d4b3e0cffea9fcdf19f1c39c34fd95\", \"ui_touch_selection_unittests\": \"cf47d7b7886d363b591a489ad4cdfd95fc0d67d6\", \"unit_tests\": \"622fa345003678ff979e1d5d12443c14c5d4163c\", \"updater_tests\": \"304670886351fa587a9701ed1a1b59242ced38a6\", \"url_unittests\": \"5b24f86d7fc8a3bcc2a6d3f5d609f59e73bf2e9e\", \"views_unittests\": \"2800a1e103dfa630454d1410120d7c436bf5d307\", \"viz_unittests\": \"f317d0a314f98747a894633a570e1b94513e1f19\", \"vr_common_unittests\": \"d0f837beeaf196e9fb234599a395ca211efa6e89\", \"vr_pixeltests\": \"2f47562ae24fbd27a313e0e74f3b5ba65a992389\", \"weblayer_browsertests\": \"dc25f8a79ccb8416ee82cfe619286c3268bc1420\", \"weblayer_unittests\": \"8b9027887c962f3527dc971b6861d8535b52f548\", \"wm_unittests\": \"f777b08cb733c09390ac605e5c09a8e6783ef722\", \"wtf_unittests\": \"a07334da8892bb1bfa8b90c0cff87b553ffb7ffc\", \"zlib_unittests\": \"e7ed5a5cda4cf7d513685d40e1cb211f03e1fdf9\", \"zucchini_unittests\": \"cf07292e0fbe4026ef86146af5472193e45946b0\"}}, \"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-6-xj00\"], \"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\", \"2.7\", \"2.7.13\"], \"server_version\": [\"5776-cb9e157\"], \"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": "1616153584039468",
"status": "COMPLETED",
"status_changed_ts": "1616157052121583",
"tags": [
"build_address:luci.chromium.ci/win-asan/17869",
"builder:win-asan",
"buildset:commit/git/059f64f440a11335c8efb36cb25764e082dc706a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/059f64f440a11335c8efb36cb25764e082dc706a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017763919561406352",
"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/8852333857516231792/+/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:52631424bd871c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1616157052128493",
"url": "https://ci.chromium.org/b/8852333857516231792",
"utcnow_ts": "1616157062041485"
}
}
[12:31:02.059] Invocation finished in 58m1.352143065s with status SUCCEEDED