[18:44:37.784] New invocation is queued and will start shortly
[18:44:38.942] Starting the invocation (attempt 1)
[18:44:38.981] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:44:38.982] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:44:38.982] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020635867451613056",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5aa6c24a1c7ae624605b804e1d9520fa2e193704\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020635867451613056",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"gitiles_ref:refs/heads/master"
]
}
[18:44:39.736] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613414679082001",
"id": "8855205805425244704",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5aa6c24a1c7ae624605b804e1d9520fa2e193704\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613414679500734",
"tags": [
"build_address:luci.chromium.ci/win-asan/17362",
"builder:win-asan",
"buildset:commit/git/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020635867451613056",
"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/8855205805425244704/+/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": "1613414679500846",
"url": "https://ci.chromium.org/b/8855205805425244704",
"utcnow_ts": "1613414679725096"
}
}
[18:44:39.736] Task URL: https://ci.chromium.org/b/8855205805425244704
[18:44:39.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:2:0) after 1m0s
[18:44:42.860] Received PubSub notification, asking Buildbucket for the build status
[18:44:42.980] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:39.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:2:0)
[18:45:39.798] Timer tick, asking Buildbucket for the build status
[18:45:39.902] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:39.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:4:0) after 1m0s
[18:46:39.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:4:0)
[18:46:39.974] Timer tick, asking Buildbucket for the build status
[18:46:40.229] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:40.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:5:0) after 1m0s
[18:47:40.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:5:0)
[18:47:40.358] Timer tick, asking Buildbucket for the build status
[18:47:40.462] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:40.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:6:0) after 1m0s
[18:48:40.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:6:0)
[18:48:40.566] Timer tick, asking Buildbucket for the build status
[18:48:40.872] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:7:0) after 1m0s
[18:49:40.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:7:0)
[18:49:40.909] Timer tick, asking Buildbucket for the build status
[18:49:41.318] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:41.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:8:0) after 1m0s
[18:50:41.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:8:0)
[18:50:41.369] Timer tick, asking Buildbucket for the build status
[18:50:41.452] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:41.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:9:0) after 1m0s
[18:51:41.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:9:0)
[18:51:41.507] Timer tick, asking Buildbucket for the build status
[18:51:41.586] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:41.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:10:0) after 1m0s
[18:52:41.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:10:0)
[18:52:41.623] Timer tick, asking Buildbucket for the build status
[18:52:41.705] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:41.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:11:0) after 1m0s
[18:53:41.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:11:0)
[18:53:41.759] Timer tick, asking Buildbucket for the build status
[18:53:41.878] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:41.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:12:0) after 1m0s
[18:54:41.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:12:0)
[18:54:41.900] Timer tick, asking Buildbucket for the build status
[18:54:42.082] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:42.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:13:0) after 1m0s
[18:55:42.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:13:0)
[18:55:42.209] Timer tick, asking Buildbucket for the build status
[18:55:42.292] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:42.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:14:0) after 1m0s
[18:56:42.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:14:0)
[18:56:42.413] Timer tick, asking Buildbucket for the build status
[18:56:42.492] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:15:0) after 1m0s
[18:57:42.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:15:0)
[18:57:42.565] Timer tick, asking Buildbucket for the build status
[18:57:42.640] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:42.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:16:0) after 1m0s
[18:58:42.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:16:0)
[18:58:42.703] Timer tick, asking Buildbucket for the build status
[18:58:42.996] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:42.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:17:0) after 1m0s
[18:59:43.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:17:0)
[18:59:43.041] Timer tick, asking Buildbucket for the build status
[18:59:43.471] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:43.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:18:0) after 1m0s
[19:00:43.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:18:0)
[19:00:43.493] Timer tick, asking Buildbucket for the build status
[19:00:43.580] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:43.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:19:0) after 1m0s
[19:01:43.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:19:0)
[19:01:43.629] Timer tick, asking Buildbucket for the build status
[19:01:43.733] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:43.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:20:0) after 1m0s
[19:02:43.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:20:0)
[19:02:43.771] Timer tick, asking Buildbucket for the build status
[19:02:43.954] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:43.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:21:0) after 1m0s
[19:03:44.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:21:0)
[19:03:44.010] Timer tick, asking Buildbucket for the build status
[19:03:44.157] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:44.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:22:0) after 1m0s
[19:04:44.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:22:0)
[19:04:44.193] Timer tick, asking Buildbucket for the build status
[19:04:44.296] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:44.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:23:0) after 1m0s
[19:05:44.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:23:0)
[19:05:44.349] Timer tick, asking Buildbucket for the build status
[19:05:44.442] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:44.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:24:0) after 1m0s
[19:06:44.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:24:0)
[19:06:44.475] Timer tick, asking Buildbucket for the build status
[19:06:44.562] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:44.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:25:0) after 1m0s
[19:07:44.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:25:0)
[19:07:44.548] Timer tick, asking Buildbucket for the build status
[19:07:44.645] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:44.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:26:0) after 1m0s
[19:08:44.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:26:0)
[19:08:44.629] Timer tick, asking Buildbucket for the build status
[19:08:44.736] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:44.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:27:0) after 1m0s
[19:09:44.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:27:0)
[19:09:44.755] Timer tick, asking Buildbucket for the build status
[19:09:45.275] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:45.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:28:0) after 1m0s
[19:10:45.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:28:0)
[19:10:45.308] Timer tick, asking Buildbucket for the build status
[19:10:45.646] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:45.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:29:0) after 1m0s
[19:11:45.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:29:0)
[19:11:45.656] Timer tick, asking Buildbucket for the build status
[19:11:45.744] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:45.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:30:0) after 1m0s
[19:12:45.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:30:0)
[19:12:45.791] Timer tick, asking Buildbucket for the build status
[19:12:45.888] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:45.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:31:0) after 1m0s
[19:13:46.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:31:0)
[19:13:46.277] Timer tick, asking Buildbucket for the build status
[19:13:46.609] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:46.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:32:0) after 1m0s
[19:14:46.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:32:0)
[19:14:46.738] Timer tick, asking Buildbucket for the build status
[19:14:46.851] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:46.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:33:0) after 1m0s
[19:15:47.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:33:0)
[19:15:47.029] Timer tick, asking Buildbucket for the build status
[19:15:47.133] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:47.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:34:0) after 1m0s
[19:16:47.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:34:0)
[19:16:47.248] Timer tick, asking Buildbucket for the build status
[19:16:47.329] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:47.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:35:0) after 1m0s
[19:17:47.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:35:0)
[19:17:47.459] Timer tick, asking Buildbucket for the build status
[19:17:47.554] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:47.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:36:0) after 1m0s
[19:18:47.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:36:0)
[19:18:47.587] Timer tick, asking Buildbucket for the build status
[19:18:47.855] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:37:0) after 1m0s
[19:19:47.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:37:0)
[19:19:47.870] Timer tick, asking Buildbucket for the build status
[19:19:48.089] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:48.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:38:0) after 1m0s
[19:20:48.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:38:0)
[19:20:48.148] Timer tick, asking Buildbucket for the build status
[19:20:48.278] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:48.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:39:0) after 1m0s
[19:21:48.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:39:0)
[19:21:48.357] Timer tick, asking Buildbucket for the build status
[19:21:48.439] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:48.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:40:0) after 1m0s
[19:22:48.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:40:0)
[19:22:48.582] Timer tick, asking Buildbucket for the build status
[19:22:48.816] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:48.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:41:0) after 1m0s
[19:23:48.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:41:0)
[19:23:48.971] Timer tick, asking Buildbucket for the build status
[19:23:49.156] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:49.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:42:0) after 1m0s
[19:24:49.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:42:0)
[19:24:49.352] Timer tick, asking Buildbucket for the build status
[19:24:49.469] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:49.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:43:0) after 1m0s
[19:25:49.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:43:0)
[19:25:49.554] Timer tick, asking Buildbucket for the build status
[19:25:49.640] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:49.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:44:0) after 1m0s
[19:26:49.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:44:0)
[19:26:49.734] Timer tick, asking Buildbucket for the build status
[19:26:50.173] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:50.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:45:0) after 1m0s
[19:27:50.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:45:0)
[19:27:50.264] Timer tick, asking Buildbucket for the build status
[19:27:50.359] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:50.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:46:0) after 1m0s
[19:28:50.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:46:0)
[19:28:50.380] Timer tick, asking Buildbucket for the build status
[19:28:50.465] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:50.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:47:0) after 1m0s
[19:29:50.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:47:0)
[19:29:50.533] Timer tick, asking Buildbucket for the build status
[19:29:50.730] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:50.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:48:0) after 1m0s
[19:30:50.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:48:0)
[19:30:50.786] Timer tick, asking Buildbucket for the build status
[19:30:51.106] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:51.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:49:0) after 1m0s
[19:31:51.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:49:0)
[19:31:51.137] Timer tick, asking Buildbucket for the build status
[19:31:51.267] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:51.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:50:0) after 1m0s
[19:32:51.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:50:0)
[19:32:51.238] Timer tick, asking Buildbucket for the build status
[19:32:51.530] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:51.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:51:0) after 1m0s
[19:33:51.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:51:0)
[19:33:51.521] Timer tick, asking Buildbucket for the build status
[19:33:51.617] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:52:0) after 1m0s
[19:34:51.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:52:0)
[19:34:51.636] Timer tick, asking Buildbucket for the build status
[19:34:51.774] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:51.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:53:0) after 1m0s
[19:35:51.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:53:0)
[19:35:51.816] Timer tick, asking Buildbucket for the build status
[19:35:52.393] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:52.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:54:0) after 1m0s
[19:36:52.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:54:0)
[19:36:52.422] Timer tick, asking Buildbucket for the build status
[19:36:52.512] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:52.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:55:0) after 1m0s
[19:37:52.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:55:0)
[19:37:52.574] Timer tick, asking Buildbucket for the build status
[19:37:52.675] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:52.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:56:0) after 1m0s
[19:38:52.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:56:0)
[19:38:52.726] Timer tick, asking Buildbucket for the build status
[19:38:52.825] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:52.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:57:0) after 1m0s
[19:39:52.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:57:0)
[19:39:52.922] Timer tick, asking Buildbucket for the build status
[19:39:53.046] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:53.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:58:0) after 1m0s
[19:40:53.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:58:0)
[19:40:53.070] Timer tick, asking Buildbucket for the build status
[19:40:53.361] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:53.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:59:0) after 1m0s
[19:41:53.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:59:0)
[19:41:53.416] Timer tick, asking Buildbucket for the build status
[19:41:53.497] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:53.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:60:0) after 1m0s
[19:42:53.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:60:0)
[19:42:53.561] Timer tick, asking Buildbucket for the build status
[19:42:53.671] Build 8855205805425244704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:53.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020635867451613056:61:0) after 1m0s
[19:43:20.871] Received PubSub notification, asking Buildbucket for the build status
[19:43:20.959] Build 8855205805425244704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:43:20.959] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613418199214052",
"created_by": "project:chromium",
"created_ts": "1613414679082001",
"id": "8855205805425244704",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5aa6c24a1c7ae624605b804e1d9520fa2e193704\"}}",
"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\": \"5aa6c24a1c7ae624605b804e1d9520fa2e193704\", \"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-0-6l07\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17362, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-1\", \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"5aa6c24a1c7ae624605b804e1d9520fa2e193704\", \"got_revision_cp\": \"refs/heads/master@{#854089}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"9487add212656838843049bd712e74270290cfbf\", \"got_v8_revision_cp\": \"refs/heads/9.0.175@{#1}\", \"got_webrtc_revision\": \"a24f3d035f7d9acee551d5547f4fb16838cf98d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33258}\", \"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\": \"5aa6c24a1c7ae624605b804e1d9520fa2e193704\", \"swarm_hashes_refs/heads/master(at){#854089}_without_patch\": {\"absl_hardening_tests\": \"afdaf8fb9e7e3bbe086ac4f3edb0886c18d6bb6c\", \"accessibility_unittests\": \"84a5e446c6fd02cf6dfefbe452540c07862debf6\", \"angle_unittests\": \"c1047ff7deefb7e201e8b976c1760ba3367b390f\", \"app_shell_unittests\": \"03104e6cdca6077a676b2035ac236824dc1896de\", \"aura_unittests\": \"fa4f9d883ca43c3260361de9dbd1352793707049\", \"base_unittests\": \"2af05f2e8ed5c90470a39fba09c470596fdfb3cd\", \"base_util_unittests\": \"14de1c0b724bb8bccd71a0ec0b98e583477da4d9\", \"blink_common_unittests\": \"4e55020619575f4510844851225bb2d86fb3543b\", \"blink_fuzzer_unittests\": \"b211638e086d91850cd589845bde62224177d275\", \"blink_heap_unittests\": \"83d16e083c19b522332dd095474ee7f63afc8c23\", \"blink_platform_unittests\": \"8e208e4083a49247b2de4e7425922961a65171c4\", \"blink_unittests\": \"6a865bd34f78f0e775e6c02b7323513fc0b3e8f0\", \"boringssl_crypto_tests\": \"7aeb4bb05dc84266e5c60e77ed80589758a5c0e4\", \"boringssl_ssl_tests\": \"15cf89cefde1d8cf8190eff5f6c558c3c2af8802\", \"browser_switcher_bho_unittests\": \"ea72cb516837fb745fdfc936b6ac589a282d50be\", \"browser_tests\": \"c5b40874c201d241ad3541a70113911fd1fc53d0\", \"capture_unittests\": \"77997eef1a11dc63fc887cd049092840cbd90236\", \"cast_unittests\": \"3a275af514549c6f52a0857009ed6e3cbecce7a2\", \"cc_unittests\": \"c45d38a8c809102e3912d51b6638451227fd64a2\", \"chrome_app_unittests\": \"8489d521f60d678c5898b5d50f42d4762afcad50\", \"chrome_cleaner_unittests\": \"dc7c9e5deb66365d0c34cc49e858a00227835004\", \"chrome_elf_unittests\": \"e5dd10923e7e89c39476c1e039cfcd2bb1881988\", \"chromedriver_unittests\": \"414867b6c0be56f1450225ac5f89e47d4679969f\", \"components_browsertests\": \"b824fc4b17e5735348df00432d25febff39583f4\", \"components_unittests\": \"8cd69268658ab109ba3a50a181a6bed9e2e3ba82\", \"compositor_unittests\": \"5bf21d25012699e8227f6459a85a6a1db5f94d75\", \"content_browsertests\": \"80f93946b45216daa553d43dec7f47fdded64308\", \"content_unittests\": \"9a504a0e495ffd7156513f8447a88e57ef2f316a\", \"courgette_unittests\": \"15ab31fbf368ccc8a38180cdc3bf3c4954ffd39c\", \"crashpad_tests\": \"30c378b0f9d3b0de0e07f2f843e79d2b9ccb256e\", \"cronet_tests\": \"fff78f0d1039d08581b0b3e36fee985c92e0160a\", \"cronet_unittests\": \"898fbcc40dc1648d176cba156acde44efd4a963f\", \"crypto_unittests\": \"62b6c6040f2fd3c38f74f3591184cf492f6f36d6\", \"delayloads_unittests\": \"4ac6f875fc71b4a6dba355eb7e67611e690e80f7\", \"device_unittests\": \"e8b3f8e2a1ca232fd03059c876fa5807fd60844d\", \"display_unittests\": \"58a82182487b81eb90596520c0a68cbc1f75a2f5\", \"elevation_service_unittests\": \"48307cf45b446f55fd6bdd67216728e1e972df5a\", \"events_unittests\": \"d2d0243c3383f9273b96c8ae572ad2b2c130f23f\", \"extensions_browsertests\": \"7cfd651c720ef907833dedf029c486066304128a\", \"extensions_unittests\": \"2e52f7251b56983b561a3200fc7250c87dcfe9b6\", \"filesystem_service_unittests\": \"1710061b7747fc61dba1e0f9f89d3141cdeb445f\", \"gcm_unit_tests\": \"cc31315cbab55b61526250677f6d657a8cb134c4\", \"gcp_unittests\": \"0174bab567bcc43ed5f4880f895e5a3f86f07555\", \"gfx_unittests\": \"a4667091629ea36a2a96586da0f37dea01c00d71\", \"gin_unittests\": \"ea18983c11998b9a986f023ab99de4096833c118\", \"google_apis_unittests\": \"0312c99b343ff1c1ffa9096e8bef70f6b55d6791\", \"gpu_unittests\": \"86511738db15f0034dbabf4773505f4f2609d14f\", \"gwp_asan_unittests\": \"20294debdff08d5d56f1f82fee493ec5dfa3b27b\", \"headless_browsertests\": \"9245f31bf1cf913960a4723da41468c1180df4d9\", \"headless_unittests\": \"63ee92c826984064fa608172eda9eac873b24b84\", \"install_static_unittests\": \"fdc8b0c64bb4c23a3a482b04d8bd4e60c9b576d6\", \"installer_util_unittests\": \"a387f99066985d179c060044784233c96426f912\", \"interactive_ui_tests\": \"9abfdbdc7230b963a062271d4f947791cbdd3147\", \"ipc_tests\": \"8cf1d6beb363efef4eddcac23c8a9994856a2c81\", \"jingle_unittests\": \"607ea35fb7f36f1f5b7740c0f6a4435f822319d8\", \"latency_unittests\": \"d9e83e09b2ecfbecc0d310bd6576240b918faefe\", \"libjingle_xmpp_unittests\": \"69206b862e1fca6938cb899469af50fa7004ac4a\", \"liburlpattern_unittests\": \"f1ddfa2880eb9781485dbeeadcf0e941d03af116\", \"media_blink_unittests\": \"e9f60387236d5f4d4a570749454455a09d074434\", \"media_unittests\": \"3a175d0e02f574aaa888759628cdfeeab781b22d\", \"message_center_unittests\": \"e12ec5f1e98a80bfb4f54470427128be5ecaecac\", \"midi_unittests\": \"51604c433ce50800a7c557dbd17b77651a6520b2\", \"mojo_core_unittests\": \"52f45d71dc7ad51d7a8d3ad7b9e3bf593f715fef\", \"mojo_unittests\": \"6654d8373463804ee42a30cd70582e0376000051\", \"nacl_loader_unittests\": \"4650ab899c69c6b13fd0b51e21cd522e246090ee\", \"native_theme_unittests\": \"40722f9562641ff74db740d635ddc75765d9e182\", \"net_unittests\": \"fb50e6df3fb61de8258632f912f1d64b42e027df\", \"notification_helper_unittests\": \"10b15f06c3e0d0296d4a26dd304377275464e5b4\", \"pdf_unittests\": \"82f174c3ca539d5e141663589ba3f93c733cbc6d\", \"perfetto_unittests\": \"0763773394380063857cc00e412e8da64753cd7b\", \"ppapi_unittests\": \"66a9bf53f992176027901a76d81b462be18f5357\", \"printing_unittests\": \"f5fac7d3e424a8ec08fd41f7764d63a5c40fc4ea\", \"remoting_unittests\": \"8964e0c164616daee8c72ecad62fce20487d5c97\", \"sbox_integration_tests\": \"993a6c4aa066cb3c357c2dfa103e8de70697c668\", \"sbox_unittests\": \"da2be722a6332d30119a9981941aef5bd205cbf1\", \"sbox_validation_tests\": \"7f70a8ceeda43afef32487de4c9d98e4758656c6\", \"service_manager_unittests\": \"9a11b75111527f95aa26820845ff149f0e5f17c7\", \"services_unittests\": \"43e39e01c2b42a910dee5ebe03590f650694d80e\", \"setup_unittests\": \"50d45f414f4e962991a2abdbeeef1c2519a1ef30\", \"shell_dialogs_unittests\": \"533a30d0dd4f06517ab1864da240246fe9c2a40a\", \"skia_unittests\": \"9dc53e63f833d8572b289b2b9e92984011fbbc49\", \"snapshot_unittests\": \"db7ca35ff3e701dfb3d45d0ebb3653d585b3a0e2\", \"sql_unittests\": \"76d037e560ffc5be4d1688e891a029a3a9f53563\", \"storage_unittests\": \"f5f12786e145954e6e25e39128414d5704d377ab\", \"sync_integration_tests\": \"6aab8bb4d4a4e01336dd1643067924d433f0bcf8\", \"traffic_annotation_auditor_unittests\": \"f6f77f72f9b954cb1ccc16d933d3b7f0aa57f577\", \"ui_base_unittests\": \"2052682b88e73a95909e248d248bb358a628ee04\", \"ui_touch_selection_unittests\": \"fa749314bcf7d1652a7787194c2ce1ed1e57ed73\", \"unit_tests\": \"9e0369b717076bbc22fb848077e3c1c9b86f291b\", \"updater_tests\": \"f09d60545f17a2e7c7375a155b04d79bd63eb5b6\", \"url_unittests\": \"554ff354c736dc6c49bdc6a1083b4ea37e8da39e\", \"views_unittests\": \"ad17ce76e69b2928393409415874c9e37a25d488\", \"viz_unittests\": \"271ed84323b875b4adf766fe2e10f319814ffe2a\", \"vr_common_unittests\": \"fccc8940ce1f7517290470370858fe64caa1f527\", \"vr_pixeltests\": \"b8db8e8cf0514e05c0d79637d9fd90d6ca8774fc\", \"weblayer_browsertests\": \"4d22512749d7d462df995d825d5ff7094052a554\", \"weblayer_unittests\": \"0e9c47dd622e2c641cee3ae0696ddd17dcd16263\", \"wm_unittests\": \"954c6e7951d6c7bb33d72126e5f5a3ae5444014b\", \"wtf_unittests\": \"ec955060fcef39f99fff53bc5a82d08e6c3d30ea\", \"zlib_unittests\": \"f9960112c3c647cab72610de9abadfa3010e5532\", \"zucchini_unittests\": \"b1ac7069795b506f67b9405cf2b9c6ae731e2bfe\"}}, \"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-0-6l07\"], \"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\": [\"5696-2a606bc\"], \"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": "1613414682288705",
"status": "COMPLETED",
"status_changed_ts": "1613418199757399",
"tags": [
"build_address:luci.chromium.ci/win-asan/17362",
"builder:win-asan",
"buildset:commit/git/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5aa6c24a1c7ae624605b804e1d9520fa2e193704",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020635867451613056",
"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/8855205805425244704/+/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:51bfd3ce0ec7d110",
"user_agent:luci-scheduler"
],
"updated_ts": "1613418199764800",
"url": "https://ci.chromium.org/b/8855205805425244704",
"utcnow_ts": "1613418200947440"
}
}
[19:43:20.959] Invocation finished in 58m43.192414275s with status SUCCEEDED