[18:19:10.119] New invocation is queued and will start shortly
[18:19:11.264] Starting the invocation (attempt 1)
[18:19:11.308] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:19:11.309] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:19:11.309] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019640902690350512",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019640902690350512",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"gitiles_ref:refs/heads/master"
]
}
[18:19:12.432] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614363551415261",
"id": "8854210840669425984",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614363552153564",
"tags": [
"build_address:luci.chromium.ci/win-asan/17550",
"builder:win-asan",
"buildset:commit/git/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019640902690350512",
"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/8854210840669425984/+/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": "1614363552153678",
"url": "https://ci.chromium.org/b/8854210840669425984",
"utcnow_ts": "1614363552389924"
}
}
[18:19:12.432] Task URL: https://ci.chromium.org/b/8854210840669425984
[18:19:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:2:0) after 1m0s
[18:19:21.834] Received PubSub notification, asking Buildbucket for the build status
[18:19:22.017] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:12.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:2:0)
[18:20:12.450] Timer tick, asking Buildbucket for the build status
[18:20:12.900] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:12.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:4:0) after 1m0s
[18:21:12.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:4:0)
[18:21:12.921] Timer tick, asking Buildbucket for the build status
[18:21:13.018] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:13.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:5:0) after 1m0s
[18:22:13.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:5:0)
[18:22:13.059] Timer tick, asking Buildbucket for the build status
[18:22:13.150] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:13.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:6:0) after 1m0s
[18:23:13.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:6:0)
[18:23:13.213] Timer tick, asking Buildbucket for the build status
[18:23:13.284] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:13.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:7:0) after 1m0s
[18:24:13.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:7:0)
[18:24:13.388] Timer tick, asking Buildbucket for the build status
[18:24:13.464] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:13.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:8:0) after 1m0s
[18:25:13.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:8:0)
[18:25:13.646] Timer tick, asking Buildbucket for the build status
[18:25:13.736] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:13.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:9:0) after 1m0s
[18:26:13.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:9:0)
[18:26:13.872] Timer tick, asking Buildbucket for the build status
[18:26:13.953] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:13.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:10:0) after 1m0s
[18:27:14.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:10:0)
[18:27:14.067] Timer tick, asking Buildbucket for the build status
[18:27:14.269] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:14.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:11:0) after 1m0s
[18:28:14.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:11:0)
[18:28:14.256] Timer tick, asking Buildbucket for the build status
[18:28:14.374] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:14.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:12:0) after 1m0s
[18:29:14.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:12:0)
[18:29:14.519] Timer tick, asking Buildbucket for the build status
[18:29:14.596] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:14.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:13:0) after 1m0s
[18:30:14.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:13:0)
[18:30:14.600] Timer tick, asking Buildbucket for the build status
[18:30:15.181] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:15.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:14:0) after 1m0s
[18:31:15.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:14:0)
[18:31:15.179] Timer tick, asking Buildbucket for the build status
[18:31:15.281] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:15.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:15:0) after 1m0s
[18:32:15.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:15:0)
[18:32:15.292] Timer tick, asking Buildbucket for the build status
[18:32:15.367] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:15.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:16:0) after 1m0s
[18:33:15.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:16:0)
[18:33:15.378] Timer tick, asking Buildbucket for the build status
[18:33:15.567] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:15.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:17:0) after 1m0s
[18:34:15.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:17:0)
[18:34:15.563] Timer tick, asking Buildbucket for the build status
[18:34:15.753] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:15.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:18:0) after 1m0s
[18:35:15.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:18:0)
[18:35:15.831] Timer tick, asking Buildbucket for the build status
[18:35:15.935] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:15.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:19:0) after 1m0s
[18:36:15.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:19:0)
[18:36:15.999] Timer tick, asking Buildbucket for the build status
[18:36:16.068] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:16.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:20:0) after 1m0s
[18:37:16.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:20:0)
[18:37:16.098] Timer tick, asking Buildbucket for the build status
[18:37:16.168] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:16.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:21:0) after 1m0s
[18:38:16.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:21:0)
[18:38:16.214] Timer tick, asking Buildbucket for the build status
[18:38:16.517] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:16.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:22:0) after 1m0s
[18:39:16.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:22:0)
[18:39:16.552] Timer tick, asking Buildbucket for the build status
[18:39:16.652] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:16.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:23:0) after 1m0s
[18:40:16.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:23:0)
[18:40:16.668] Timer tick, asking Buildbucket for the build status
[18:40:16.781] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:16.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:24:0) after 1m0s
[18:41:16.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:24:0)
[18:41:16.809] Timer tick, asking Buildbucket for the build status
[18:41:16.900] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:16.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:25:0) after 1m0s
[18:42:16.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:25:0)
[18:42:16.943] Timer tick, asking Buildbucket for the build status
[18:42:17.021] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:17.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:26:0) after 1m0s
[18:43:17.061] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:26:0)
[18:43:17.061] Timer tick, asking Buildbucket for the build status
[18:43:17.150] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:17.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:27:0) after 1m0s
[18:44:17.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:27:0)
[18:44:17.203] Timer tick, asking Buildbucket for the build status
[18:44:17.286] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:17.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:28:0) after 1m0s
[18:45:17.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:28:0)
[18:45:17.340] Timer tick, asking Buildbucket for the build status
[18:45:17.903] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:17.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:29:0) after 1m0s
[18:46:17.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:29:0)
[18:46:17.900] Timer tick, asking Buildbucket for the build status
[18:46:17.980] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:17.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:30:0) after 1m0s
[18:47:18.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:30:0)
[18:47:18.018] Timer tick, asking Buildbucket for the build status
[18:47:18.111] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:31:0) after 1m0s
[18:48:18.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:31:0)
[18:48:18.091] Timer tick, asking Buildbucket for the build status
[18:48:18.192] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:18.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:32:0) after 1m0s
[18:49:18.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:32:0)
[18:49:18.229] Timer tick, asking Buildbucket for the build status
[18:49:18.344] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:18.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:33:0) after 1m0s
[18:50:18.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:33:0)
[18:50:18.361] Timer tick, asking Buildbucket for the build status
[18:50:18.482] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:34:0) after 1m0s
[18:51:18.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:34:0)
[18:51:18.471] Timer tick, asking Buildbucket for the build status
[18:51:18.551] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:18.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:35:0) after 1m0s
[18:52:18.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:35:0)
[18:52:18.573] Timer tick, asking Buildbucket for the build status
[18:52:18.687] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:18.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:36:0) after 1m0s
[18:53:18.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:36:0)
[18:53:18.704] Timer tick, asking Buildbucket for the build status
[18:53:18.797] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:18.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:37:0) after 1m0s
[18:54:18.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:37:0)
[18:54:18.821] Timer tick, asking Buildbucket for the build status
[18:54:18.962] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:18.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:38:0) after 1m0s
[18:55:18.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:38:0)
[18:55:18.978] Timer tick, asking Buildbucket for the build status
[18:55:19.089] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:19.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:39:0) after 1m0s
[18:56:19.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:39:0)
[18:56:19.111] Timer tick, asking Buildbucket for the build status
[18:56:19.197] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:19.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:40:0) after 1m0s
[18:57:19.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:40:0)
[18:57:19.256] Timer tick, asking Buildbucket for the build status
[18:57:19.485] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:19.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:41:0) after 1m0s
[18:58:19.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:41:0)
[18:58:19.543] Timer tick, asking Buildbucket for the build status
[18:58:19.828] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:19.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:42:0) after 1m0s
[18:59:19.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:42:0)
[18:59:19.818] Timer tick, asking Buildbucket for the build status
[18:59:20.125] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:20.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:43:0) after 1m0s
[19:00:20.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:43:0)
[19:00:20.181] Timer tick, asking Buildbucket for the build status
[19:00:20.496] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:20.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:44:0) after 1m0s
[19:01:20.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:44:0)
[19:01:20.549] Timer tick, asking Buildbucket for the build status
[19:01:20.626] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:20.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:45:0) after 1m0s
[19:02:20.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:45:0)
[19:02:20.666] Timer tick, asking Buildbucket for the build status
[19:02:20.750] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:20.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:46:0) after 1m0s
[19:03:20.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:46:0)
[19:03:20.768] Timer tick, asking Buildbucket for the build status
[19:03:21.614] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:21.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:47:0) after 1m0s
[19:04:21.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:47:0)
[19:04:21.768] Timer tick, asking Buildbucket for the build status
[19:04:22.231] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:22.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:48:0) after 1m0s
[19:05:22.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:48:0)
[19:05:22.479] Timer tick, asking Buildbucket for the build status
[19:05:22.565] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:49:0) after 1m0s
[19:06:22.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:49:0)
[19:06:22.684] Timer tick, asking Buildbucket for the build status
[19:06:22.783] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:22.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:50:0) after 1m0s
[19:07:22.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:50:0)
[19:07:22.831] Timer tick, asking Buildbucket for the build status
[19:07:22.960] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:22.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:51:0) after 1m0s
[19:08:23.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:51:0)
[19:08:23.039] Timer tick, asking Buildbucket for the build status
[19:08:23.137] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:23.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:52:0) after 1m0s
[19:09:23.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:52:0)
[19:09:23.184] Timer tick, asking Buildbucket for the build status
[19:09:23.371] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:23.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:53:0) after 1m0s
[19:10:23.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:53:0)
[19:10:23.432] Timer tick, asking Buildbucket for the build status
[19:10:23.590] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:54:0) after 1m0s
[19:11:23.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:54:0)
[19:11:23.618] Timer tick, asking Buildbucket for the build status
[19:11:23.815] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:23.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:55:0) after 1m0s
[19:12:23.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:55:0)
[19:12:23.844] Timer tick, asking Buildbucket for the build status
[19:12:23.921] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:56:0) after 1m0s
[19:13:23.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:56:0)
[19:13:23.992] Timer tick, asking Buildbucket for the build status
[19:13:24.290] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:24.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:57:0) after 1m0s
[19:14:24.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:57:0)
[19:14:24.431] Timer tick, asking Buildbucket for the build status
[19:14:25.990] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:25.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:58:0) after 1m0s
[19:15:26.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:58:0)
[19:15:26.820] Timer tick, asking Buildbucket for the build status
[19:15:26.909] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:26.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:59:0) after 1m0s
[19:16:27.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:59:0)
[19:16:27.183] Timer tick, asking Buildbucket for the build status
[19:16:27.278] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:27.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:60:0) after 1m0s
[19:17:27.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:60:0)
[19:17:27.630] Timer tick, asking Buildbucket for the build status
[19:17:27.729] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:27.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:61:0) after 1m0s
[19:18:27.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:61:0)
[19:18:27.806] Timer tick, asking Buildbucket for the build status
[19:18:27.995] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:27.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:62:0) after 1m0s
[19:19:28.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:62:0)
[19:19:28.066] Timer tick, asking Buildbucket for the build status
[19:19:28.536] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:28.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:63:0) after 1m0s
[19:20:29.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:63:0)
[19:20:29.646] Timer tick, asking Buildbucket for the build status
[19:20:29.734] Build 8854210840669425984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:29.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019640902690350512:64:0) after 1m0s
[19:20:57.189] Received PubSub notification, asking Buildbucket for the build status
[19:20:57.412] Build 8854210840669425984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:20:57.412] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614367254814190",
"created_by": "project:chromium",
"created_ts": "1614363551415261",
"id": "8854210840669425984",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\"}}",
"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\": \"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\", \"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-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17550, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"23462996035db5276d7afc60fd023d95ddc5e996\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\", \"got_revision_cp\": \"refs/heads/master@{#858191}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155\", \"swarm_hashes_refs/heads/master(at){#858191}_without_patch\": {\"absl_hardening_tests\": \"22c4ef32ad78da5446eb11905d1993c0417e7eed\", \"accessibility_unittests\": \"f2b398852b594ba889d47f2c7918e874e7212e4d\", \"angle_unittests\": \"5d967be4f799ee03a122c41594cb2056fc9b6b06\", \"app_shell_unittests\": \"e05d1e544a61bcacde8a2f65e66ae3a6ec53b40d\", \"aura_unittests\": \"dc91901c00a9cff79d05567466ccb8ba2d4e44b6\", \"base_unittests\": \"69febafc56e06234a53005b49af5c39c30940995\", \"base_util_unittests\": \"5c5d664f884d27dca7ae902729254b963d484cb0\", \"blink_common_unittests\": \"e118ba148a44925cdf72d7ff66c296a5dc347a29\", \"blink_fuzzer_unittests\": \"302b17823b4c5f168e21c34895fd12df3b70b594\", \"blink_heap_unittests\": \"31aff60e258feb0236549d5e2642122af23dc753\", \"blink_platform_unittests\": \"b64463c7d83cfa4be36bf09f102f80733a982f5b\", \"blink_unittests\": \"9c8b21975aa2005823bfb066c185b4e539d15111\", \"boringssl_crypto_tests\": \"7109778fe3bf46ef6dfa774d9d9835e80c4f0b8c\", \"boringssl_ssl_tests\": \"ea49708f3da9f8ac0f481bdb9f980a8e168d8df6\", \"browser_switcher_bho_unittests\": \"6be71c67fc664be6b83dac7f83ef0f1f252c3073\", \"browser_tests\": \"42123d263e1e6587c619c30cf8f80600124b9d43\", \"capture_unittests\": \"ee4bc09d9ea319c4bf4b72a4f457727c089f2764\", \"cast_unittests\": \"336aea880335c8d66134d5ea01bf83395bd144f3\", \"cc_unittests\": \"eddcab8f1a18a4aba4f7f675d7e6e041b3db5327\", \"chrome_app_unittests\": \"e4129243f679967927096b260c9afb67cb8273e1\", \"chrome_cleaner_unittests\": \"0067b3235eb5d2ed4c95d301d68ddcd9ad21c3d6\", \"chrome_elf_unittests\": \"fbe744af8b54d19354eb4339b1b1a917214079dd\", \"chromedriver_unittests\": \"511711727dd8bb1cec42be8d9dab76206f900129\", \"color_unittests\": \"efd0185832402d6d8c357efa487fc1256633adca\", \"components_browsertests\": \"d188d645bfb93aefda8a45968c5028807df4b577\", \"components_unittests\": \"d808238c919160496b1d09b71c3e55a96f4c7b2b\", \"compositor_unittests\": \"f42062c9952637c424b02348fe2ff1222efdc125\", \"content_browsertests\": \"198be4d39b2bc11ed83163ba43e781a708d5a155\", \"content_unittests\": \"fa18c29c39ec5390fc44d41693684fca5a797c06\", \"courgette_unittests\": \"71824731a73b3376672b4fe332073578414dfabe\", \"crashpad_tests\": \"9d163eb1c75c851c51b15d7e16d5962174c6c31b\", \"cronet_tests\": \"7841c748486b25207a975d5cf9d49baa20d9417f\", \"cronet_unittests\": \"a2477c197c4b00c08fb158fdee6dde0d9c0122fd\", \"crypto_unittests\": \"788bc7590f583350b7a43cdb4902ab096e019e92\", \"delayloads_unittests\": \"b1b2428ebaf06d36641caabd1cdfc82e2b56f859\", \"device_unittests\": \"eb69ccae62102c13bc831bc84cea03b853ed3c71\", \"display_unittests\": \"4b70e28631de5e07d7b1726c7f62dcf81c4e56f4\", \"elevation_service_unittests\": \"076b9e9e7faf20deda4638743a36f0c896083578\", \"events_unittests\": \"7b77615d72221790bdc6902bda273f5e3f5fbd7b\", \"extensions_browsertests\": \"91384d218c93ed9595627bf378ce168501f664af\", \"extensions_unittests\": \"607498f5ea38e8fda27f96d4e747bed636e780ea\", \"filesystem_service_unittests\": \"dfdd85d2be38c2484d5dc69a829b0953a861b8e9\", \"gcm_unit_tests\": \"b7fdec9e2007b85de8df583574022d8ff70e9b81\", \"gcp_unittests\": \"b541071e77a7ceb034200beef31387187ac24f3e\", \"gfx_unittests\": \"a2138b02249dbdef1ace91d176216ef94a3d87d7\", \"gin_unittests\": \"49ec16f50a792a9a4c65f804ca58aa2fc4796236\", \"google_apis_unittests\": \"51cb3bc9167b917d2131f042e2d26b3a5404c4e3\", \"gpu_unittests\": \"862e8df3cd9abaf6c50ee2b1f64d281e071d04af\", \"gwp_asan_unittests\": \"745f51923ff210837bc774888c9074370d2f24d0\", \"headless_browsertests\": \"9a02228e83e1466a8845244fd8c60a92d1bad779\", \"headless_unittests\": \"111221b3eea6d62614a127928d8e19cd511e4ca5\", \"install_static_unittests\": \"e5a1f5f7ddadedbbed483dd188adc0d0172aa7cd\", \"installer_util_unittests\": \"3c6267ef25c846fc587043ed4e02797234fd10eb\", \"interactive_ui_tests\": \"dfdfb381c241713513efdfef2f0173120c42fb31\", \"ipc_tests\": \"c3c0184afeb68fc6622ddbb2105b55e40c584fcc\", \"jingle_unittests\": \"88cfe86a9a3d40d3da5181be18d2af7247803bab\", \"latency_unittests\": \"0a1199de3ed2c9d2b16ba861152dc25d59608898\", \"libjingle_xmpp_unittests\": \"2ee5a8568c7bb86fa027823380eeb7848e0558b4\", \"liburlpattern_unittests\": \"7e3dcfd1a0460c6be5aefecb5c9f0e4ccef7aed0\", \"media_blink_unittests\": \"febc4656b0ac5d021c21f19d93d2dbddabdc93ea\", \"media_unittests\": \"be0d1263744227d24f0bb5250d631c31b66623e4\", \"message_center_unittests\": \"625b48b5a09881e5315b3040d12ecc86a93d3394\", \"midi_unittests\": \"d39ebcaf709f0d9444c94a64d4fa827d974c944e\", \"mojo_core_unittests\": \"7838cb0ba0393697b96eae3bcd77cfde9a7accc4\", \"mojo_unittests\": \"db4ebbbcad81eaad9e9d756960622773d07a1403\", \"nacl_loader_unittests\": \"399ab8c06521122424b2aa1a25b82c4468410ee2\", \"native_theme_unittests\": \"1b3b757d18ca27ddbba1e1d65acf05d85e6cfdd6\", \"net_unittests\": \"1caddae1730b291eb84a596b467ad422e37b256e\", \"notification_helper_unittests\": \"46ed1960831c4c4e5c0c0fbce36c5d6977488f3d\", \"pdf_unittests\": \"63dc9ebad19b8b375daa3e186f8d3c10dda2a55b\", \"perfetto_unittests\": \"6a3c3a0a55230bde3d9af2975c7b1a7c2ae7d026\", \"ppapi_unittests\": \"63ccd48b78a9e2e580c5aa58540955c6087b8ad1\", \"printing_unittests\": \"86637b7fffe857b07fa79c885262f1adbf0c39ca\", \"remoting_unittests\": \"7e79a0d646af262d14829c888ec1b16910fc0fc5\", \"sbox_integration_tests\": \"c93b33e0f7bcac99abb2c16f08a8e7e38e3bcb02\", \"sbox_unittests\": \"6b17a59e8ed88a43179297c71f14d1c9a7b559dd\", \"sbox_validation_tests\": \"45b615d199e250bbfb089a1d4aada150139c1a5e\", \"service_manager_unittests\": \"487043896fb6f5c6f80335097283ecc9205f4bd9\", \"services_unittests\": \"407249f23fa1abe9b49d7993d61aad2f61b9bd26\", \"setup_unittests\": \"1ef1548770c7322e176036d4c0d303acb3e7113e\", \"shell_dialogs_unittests\": \"8df63f239ac519540bd0a871ce1bf209771f9d2b\", \"skia_unittests\": \"6f8b70c4057a7322d8a01aa2bd842bf8003f8f45\", \"snapshot_unittests\": \"a9f309cefe43f15d0943271dbeae4b95b4c9743a\", \"sql_unittests\": \"0a52efcfc3619c26e690415644d0b47074d8fec2\", \"storage_unittests\": \"9b36d9340b04cf021ebd9426cb5c892c9eeac896\", \"sync_integration_tests\": \"fdb1710c58344033c0c878dfb5cbe3ecd2ef1599\", \"traffic_annotation_auditor_unittests\": \"566cb8beb3409bec15ea5ec1c54432c5fe4c7dfe\", \"ui_base_unittests\": \"c003be05def5ba85d34395d145c7edbdda914bcc\", \"ui_touch_selection_unittests\": \"6d1b61674f61d2ecbdf1fda08fdba1c92a4f56ce\", \"unit_tests\": \"d91bae869f08166c3c43b75668ba5d6ffacaf96e\", \"updater_tests\": \"b01c6c95ade0d72dc6d745509c29b755f1deee06\", \"url_unittests\": \"013bbcc291e2fb20dae2aca8727258fd964859ba\", \"views_unittests\": \"d48176288bd46f71de4fc5646be792762081f162\", \"viz_unittests\": \"7ce7a0aa1c715610e28eb65bc411304d06bde57c\", \"vr_common_unittests\": \"ca807981c5a40960d59261d40164268c6c5572ee\", \"vr_pixeltests\": \"ff024b993be2c7b91af7c24d81ec635ead55695a\", \"weblayer_browsertests\": \"754a3a75113e746fc6922ce767d798642979d266\", \"weblayer_unittests\": \"ffbf95fe725a9e6f0c870a0895438ae545d81b55\", \"wm_unittests\": \"1cb81d04bbe1291ee78ac6a772c0e52fc213de58\", \"wtf_unittests\": \"bb3579a4bb370419eda2655f03bf198d91fb6a35\", \"zlib_unittests\": \"304e5304ebb2551374cb7f429c7a799557921172\", \"zucchini_unittests\": \"efcfe88cceff59ac54654106693c71c8b9336237\"}}, \"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-3-xpf4\"], \"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\": [\"5712-339372b\"], \"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": "1614363561191026",
"status": "COMPLETED",
"status_changed_ts": "1614367255026753",
"tags": [
"build_address:luci.chromium.ci/win-asan/17550",
"builder:win-asan",
"buildset:commit/git/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e0e4cd2e1fa36fa8d27fb90b23bfbc8e859b155",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019640902690350512",
"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/8854210840669425984/+/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:51f8628d1d0dcb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614367255030783",
"url": "https://ci.chromium.org/b/8854210840669425984",
"utcnow_ts": "1614367257405361"
}
}
[19:20:57.412] Invocation finished in 1h1m47.307937455s with status SUCCEEDED