[08:38:07.114] New invocation is queued and will start shortly
[08:38:10.306] Starting the invocation (attempt 1)
[08:38:10.368] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:38:10.368] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:38:10.368] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018137310770773424",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018137310770773424",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"gitiles_ref:refs/heads/master"
]
}
[08:38:11.124] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615797490492446",
"id": "8852707246567717152",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615797490897723",
"tags": [
"build_address:luci.chromium.ci/win-asan/17798",
"builder:win-asan",
"buildset:commit/git/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018137310770773424",
"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/8852707246567717152/+/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": "1615797490897835",
"url": "https://ci.chromium.org/b/8852707246567717152",
"utcnow_ts": "1615797491116230"
}
}
[08:38:11.124] Task URL: https://ci.chromium.org/b/8852707246567717152
[08:38:11.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:2:0) after 1m0s
[08:38:41.911] Received PubSub notification, asking Buildbucket for the build status
[08:38:41.974] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:12.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:2:0)
[08:39:12.755] Timer tick, asking Buildbucket for the build status
[08:39:12.890] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:12.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:4:0) after 1m0s
[08:40:13.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:4:0)
[08:40:13.247] Timer tick, asking Buildbucket for the build status
[08:40:13.344] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:13.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:5:0) after 1m0s
[08:41:13.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:5:0)
[08:41:13.507] Timer tick, asking Buildbucket for the build status
[08:41:13.734] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:6:0) after 1m0s
[08:42:13.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:6:0)
[08:42:13.898] Timer tick, asking Buildbucket for the build status
[08:42:13.991] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:13.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:7:0) after 1m0s
[08:43:14.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:7:0)
[08:43:14.117] Timer tick, asking Buildbucket for the build status
[08:43:14.197] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:14.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:8:0) after 1m0s
[08:44:14.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:8:0)
[08:44:14.480] Timer tick, asking Buildbucket for the build status
[08:44:14.576] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:14.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:9:0) after 1m0s
[08:45:15.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:9:0)
[08:45:15.025] Timer tick, asking Buildbucket for the build status
[08:45:15.225] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:10:0) after 1m0s
[08:46:15.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:10:0)
[08:46:15.275] Timer tick, asking Buildbucket for the build status
[08:46:15.431] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:15.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:11:0) after 1m0s
[08:47:15.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:11:0)
[08:47:15.841] Timer tick, asking Buildbucket for the build status
[08:47:16.051] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:16.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:12:0) after 1m0s
[08:48:16.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:12:0)
[08:48:16.133] Timer tick, asking Buildbucket for the build status
[08:48:16.248] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:16.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:13:0) after 1m0s
[08:49:16.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:13:0)
[08:49:16.295] Timer tick, asking Buildbucket for the build status
[08:49:16.544] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:16.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:14:0) after 1m0s
[08:50:16.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:14:0)
[08:50:16.593] Timer tick, asking Buildbucket for the build status
[08:50:16.723] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:16.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:15:0) after 1m0s
[08:51:16.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:15:0)
[08:51:16.700] Timer tick, asking Buildbucket for the build status
[08:51:16.794] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:16.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:16:0) after 1m0s
[08:52:16.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:16:0)
[08:52:16.801] Timer tick, asking Buildbucket for the build status
[08:52:16.884] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:16.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:17:0) after 1m0s
[08:53:16.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:17:0)
[08:53:16.930] Timer tick, asking Buildbucket for the build status
[08:53:17.412] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:17.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:18:0) after 1m0s
[08:54:17.426] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:18:0)
[08:54:17.426] Timer tick, asking Buildbucket for the build status
[08:54:17.569] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:19:0) after 1m0s
[08:55:17.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:19:0)
[08:55:17.639] Timer tick, asking Buildbucket for the build status
[08:55:17.707] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:17.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:20:0) after 1m0s
[08:56:17.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:20:0)
[08:56:17.841] Timer tick, asking Buildbucket for the build status
[08:56:17.924] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:17.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:21:0) after 1m0s
[08:57:18.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:21:0)
[08:57:18.050] Timer tick, asking Buildbucket for the build status
[08:57:18.211] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:18.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:22:0) after 1m0s
[08:58:18.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:22:0)
[08:58:18.266] Timer tick, asking Buildbucket for the build status
[08:58:18.358] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:18.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:23:0) after 1m0s
[08:59:18.405] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:23:0)
[08:59:18.405] Timer tick, asking Buildbucket for the build status
[08:59:18.554] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:18.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:24:0) after 1m0s
[09:00:18.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:24:0)
[09:00:18.635] Timer tick, asking Buildbucket for the build status
[09:00:18.723] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:18.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:25:0) after 1m0s
[09:01:19.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:25:0)
[09:01:19.057] Timer tick, asking Buildbucket for the build status
[09:01:19.163] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:19.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:26:0) after 1m0s
[09:02:19.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:26:0)
[09:02:19.303] Timer tick, asking Buildbucket for the build status
[09:02:19.401] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:19.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:27:0) after 1m0s
[09:03:19.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:27:0)
[09:03:19.510] Timer tick, asking Buildbucket for the build status
[09:03:19.591] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:28:0) after 1m0s
[09:04:20.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:28:0)
[09:04:20.136] Timer tick, asking Buildbucket for the build status
[09:04:20.253] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:20.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:29:0) after 1m0s
[09:05:20.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:29:0)
[09:05:20.274] Timer tick, asking Buildbucket for the build status
[09:05:20.377] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:20.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:30:0) after 1m0s
[09:06:20.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:30:0)
[09:06:20.514] Timer tick, asking Buildbucket for the build status
[09:06:20.757] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:20.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:31:0) after 1m0s
[09:07:20.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:31:0)
[09:07:20.982] Timer tick, asking Buildbucket for the build status
[09:07:21.089] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:21.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:32:0) after 1m0s
[09:08:21.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:32:0)
[09:08:21.334] Timer tick, asking Buildbucket for the build status
[09:08:21.697] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:21.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:33:0) after 1m0s
[09:09:21.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:33:0)
[09:09:21.869] Timer tick, asking Buildbucket for the build status
[09:09:22.116] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:34:0) after 1m0s
[09:10:22.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:34:0)
[09:10:22.305] Timer tick, asking Buildbucket for the build status
[09:10:22.470] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:22.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:35:0) after 1m0s
[09:11:22.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:35:0)
[09:11:22.578] Timer tick, asking Buildbucket for the build status
[09:11:23.054] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:23.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:36:0) after 1m0s
[09:12:23.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:36:0)
[09:12:23.196] Timer tick, asking Buildbucket for the build status
[09:12:24.195] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:24.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:37:0) after 1m0s
[09:13:24.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:37:0)
[09:13:24.303] Timer tick, asking Buildbucket for the build status
[09:13:25.277] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:25.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:38:0) after 1m0s
[09:14:25.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:38:0)
[09:14:25.470] Timer tick, asking Buildbucket for the build status
[09:14:25.780] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:25.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:39:0) after 1m0s
[09:15:25.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:39:0)
[09:15:25.785] Timer tick, asking Buildbucket for the build status
[09:15:25.896] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:40:0) after 1m0s
[09:16:26.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:40:0)
[09:16:26.055] Timer tick, asking Buildbucket for the build status
[09:16:26.160] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:26.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:41:0) after 1m0s
[09:17:26.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:41:0)
[09:17:26.360] Timer tick, asking Buildbucket for the build status
[09:17:26.447] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:26.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:42:0) after 1m0s
[09:18:26.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:42:0)
[09:18:26.546] Timer tick, asking Buildbucket for the build status
[09:18:26.705] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:26.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:43:0) after 1m0s
[09:19:26.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:43:0)
[09:19:26.786] Timer tick, asking Buildbucket for the build status
[09:19:26.911] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:26.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:44:0) after 1m0s
[09:20:27.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:44:0)
[09:20:27.652] Timer tick, asking Buildbucket for the build status
[09:20:27.725] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:27.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:45:0) after 1m0s
[09:21:27.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:45:0)
[09:21:27.727] Timer tick, asking Buildbucket for the build status
[09:21:27.807] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:27.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:46:0) after 1m0s
[09:22:27.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:46:0)
[09:22:27.806] Timer tick, asking Buildbucket for the build status
[09:22:28.045] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:28.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:47:0) after 1m0s
[09:23:28.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:47:0)
[09:23:28.112] Timer tick, asking Buildbucket for the build status
[09:23:28.189] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:28.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:48:0) after 1m0s
[09:24:28.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:48:0)
[09:24:28.200] Timer tick, asking Buildbucket for the build status
[09:24:28.432] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:28.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:49:0) after 1m0s
[09:25:28.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:49:0)
[09:25:28.488] Timer tick, asking Buildbucket for the build status
[09:25:28.600] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:28.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:50:0) after 1m0s
[09:26:28.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:50:0)
[09:26:28.668] Timer tick, asking Buildbucket for the build status
[09:26:28.902] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:28.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:51:0) after 1m0s
[09:27:28.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:51:0)
[09:27:28.972] Timer tick, asking Buildbucket for the build status
[09:27:29.250] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:52:0) after 1m0s
[09:28:29.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:52:0)
[09:28:29.432] Timer tick, asking Buildbucket for the build status
[09:28:29.509] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:53:0) after 1m0s
[09:29:29.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:53:0)
[09:29:29.631] Timer tick, asking Buildbucket for the build status
[09:29:29.764] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:29.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:54:0) after 1m0s
[09:30:29.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:54:0)
[09:30:29.841] Timer tick, asking Buildbucket for the build status
[09:30:29.974] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:55:0) after 1m0s
[09:31:30.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:55:0)
[09:31:30.077] Timer tick, asking Buildbucket for the build status
[09:31:30.406] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:30.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:56:0) after 1m0s
[09:32:30.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:56:0)
[09:32:30.423] Timer tick, asking Buildbucket for the build status
[09:32:30.492] Build 8852707246567717152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:30.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018137310770773424:57:0) after 1m0s
[09:32:58.761] Received PubSub notification, asking Buildbucket for the build status
[09:32:58.878] Build 8852707246567717152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:32:58.878] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615800777557289",
"created_by": "project:chromium",
"created_ts": "1615797490492446",
"id": "8852707246567717152",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\"}}",
"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\": \"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\", \"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-7-faks\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17798, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"cd881848f3bbcda0ecf24a4cd6f5ae97d38088f9\", \"got_dawn_revision\": \"d89814ed7a119a9564c68cb4f3bd1759bc9e5c52\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\", \"got_revision_cp\": \"refs/heads/master@{#862746}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"5cdf55ff2084d8aa719fe74fbe1622b61ff64294\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"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\": \"c75f29ad46d9944128a4c10e5db0c45c935f1a8b\", \"swarm_hashes_refs/heads/master(at){#862746}_without_patch\": {\"absl_hardening_tests\": \"08a7b230d2fd9b5388ef38db6134dbe0e0cf2601\", \"accessibility_unittests\": \"394136365ccf3b482fd8dc6928f5c383c722bb45\", \"angle_unittests\": \"74742d72d1970ffee44f6c16453d909ede7a4af3\", \"app_shell_unittests\": \"14ebeb6f8fc479fc34b2a5182e6a37cb42a635ad\", \"aura_unittests\": \"7121780a25722385fc5bb32bc46039934396d9ba\", \"base_unittests\": \"ce47f18125f3fc1e1be5141c9900225275097244\", \"base_util_unittests\": \"3c0842ec9961665e1c11c871c00e796b0e9b1914\", \"blink_common_unittests\": \"96c237e1af7391b17f89e7b69223f1e2f6308bd0\", \"blink_fuzzer_unittests\": \"e8b7f9cbb3afad06d8959fa5c829501fa6ceb6f9\", \"blink_heap_unittests\": \"32b3c5f5edce96f7a318d777b8801af104563746\", \"blink_platform_unittests\": \"96396fa5038c419d67cbc23f1f8f5ecdc4b15410\", \"blink_unittests\": \"1feec50319988661cf7e8e0be8d80cff40225adb\", \"boringssl_crypto_tests\": \"4f38fa4699c6895e2fae3b0ee09a2cc91c63b683\", \"boringssl_ssl_tests\": \"89f2fa68eb48e0e8f689bb85dd09ed1bdb3e56f4\", \"browser_switcher_bho_unittests\": \"1272233825fd17cc924931972bcdf61cbcc4b894\", \"browser_tests\": \"72167989eb5034553ef5fe29bb19e723b6c6c0fe\", \"capture_unittests\": \"73b42d872387a983319b219b49c25e1880d0fb60\", \"cast_unittests\": \"5653ddf8f7b705bc2da91748503c471862cacdaf\", \"cc_unittests\": \"d921ac76df250d4fca9f35e400362a73b9d9067f\", \"chrome_app_unittests\": \"1e826d97c82b44314ac34579a387bbd32659c1ef\", \"chrome_cleaner_unittests\": \"f4cadf1d61fbff8323085d14617f4975ff1f425a\", \"chrome_elf_unittests\": \"e21e28a1cabb6dbdcf570b490b0234abcdfcb11b\", \"chromedriver_unittests\": \"344e460fb0f773dd9dc935dff5c914610094890c\", \"color_unittests\": \"87fbe60bd6f55670ae091b9344bbadd8ee3f3982\", \"components_browsertests\": \"d69e08e42da086905b6b3ffdafb79a2b39be1cae\", \"components_unittests\": \"75b750591f94f4cf3abb559c7e9d7eaa2f849ef3\", \"compositor_unittests\": \"a70250adfdbd4f816a9077274cd302f2814eca4d\", \"content_browsertests\": \"a33142067a13cd41e614dc1a4a7a81a706e17a2e\", \"content_unittests\": \"410ecca277f02cd6a543814eb985ca783cfddd38\", \"courgette_unittests\": \"d72542338355c8d8880f56bf853ec2351049f4ab\", \"crashpad_tests\": \"ef0f3ad0bc1d6c21da4bba7fb87bf1ba4b1f0449\", \"cronet_tests\": \"789af6d219d9c2a9d3b60c56fa9d0ad89ae4165c\", \"cronet_unittests\": \"1b4a032d1de48e3f7b27b5244ba1e2d1a9ec9fa6\", \"crypto_unittests\": \"6466dca4ccb3f1a6919862b2c4698af69677bfb4\", \"delayloads_unittests\": \"b6343bd6a3f95d2c0e806bf2a991647903776e7d\", \"device_unittests\": \"3a78fc832b48857c102c6185e1a82d80c83211bf\", \"display_unittests\": \"3f216290472aad6b206896bd16f1a7a6c2b14d69\", \"elevation_service_unittests\": \"6c55ced6386194fe7dc63ca42569e2e28d17dd0b\", \"events_unittests\": \"f4b4ae386011c816d13dc72050c3bc57e8ddbff1\", \"extensions_browsertests\": \"cfd46a658f398659aff1afe4892314c94ba5acb2\", \"extensions_unittests\": \"249e180e79b2298541caa63d9c67c50576cb9a4f\", \"filesystem_service_unittests\": \"90a73adad6ac1edb76a11a4db45b15ae0e459edc\", \"gcm_unit_tests\": \"a7d1e46d62f0dbedf2fec204ba017b0e04664288\", \"gcp_unittests\": \"11da17e82714f4a7f19240b8c5e71776ba799801\", \"gfx_unittests\": \"223e60752e1dce5f3acf949b9c7eb5701f604fe9\", \"gin_unittests\": \"ebb95cc9342fe71d0cf882741270323b57912312\", \"google_apis_unittests\": \"92d0241d07b6d45c768e45464cb9dfe02487f6ec\", \"gpu_unittests\": \"ea85b36dd013e4cff52934923433e00198626f70\", \"gwp_asan_unittests\": \"60efb8626fe269e38577e0387d90b522a9020ec8\", \"headless_browsertests\": \"9035bb86ba16cf837a3c04414579ae27307b0491\", \"headless_unittests\": \"c643f4577c352e8de3f5c716de0c34fa6640d6e6\", \"install_static_unittests\": \"47c08ecd78d5a65ef7bf814b74b562737f6e9a3a\", \"installer_util_unittests\": \"c70e7bbb9dc3964723324ee0edac480c0749a7d8\", \"interactive_ui_tests\": \"142948bc6a4f48259e3b236552470973fdf20b8c\", \"ipc_tests\": \"0c079c6256b5a99b762c3787223239193b45d2a4\", \"jingle_unittests\": \"38261b8021f1b04dc965494775f27f500c246068\", \"latency_unittests\": \"b68848b638e2eb95175b978a855f22521de123ec\", \"libjingle_xmpp_unittests\": \"f9aacd061be550e88d1fc70ccc2b7fb2a2ec3f4b\", \"liburlpattern_unittests\": \"14a4f3ea4326e8f4a168cae1e7f0cc7daddd862a\", \"media_blink_unittests\": \"3956c490cf4fd005505f8493719ee13ec793cd75\", \"media_unittests\": \"8c551cea571a9b39beced5f54806b59df4afec13\", \"message_center_unittests\": \"202e09eada35e0a8d77d155819363444e9b65c46\", \"midi_unittests\": \"74b4b79a21cada8225a4f3960d1105409f505135\", \"mojo_core_unittests\": \"875c852221d33fab41bfed0f8805b457a2d193a2\", \"mojo_unittests\": \"0969f64a0e161891e1526504b4e831b93f5b233d\", \"nacl_loader_unittests\": \"4a0dfa3d27e519c80452933c6fdcf616f74fc2c6\", \"native_theme_unittests\": \"d6d25cb3274706cdd9d3b868026349e6bd11d5c4\", \"net_unittests\": \"b9691ea8f257062d26b787b449d20dee8245d4f6\", \"notification_helper_unittests\": \"e2b7ebea5809df1a0dc39fdc9ffb5ca356583b6a\", \"pdf_unittests\": \"aa2d6b46ec3ea4daef8030c9f02d12fe96c0b6aa\", \"perfetto_unittests\": \"47cf227bc80870fd05e8666d918b7785566d6e67\", \"ppapi_unittests\": \"080d4de0d3811e3445730d08468a434595d034ec\", \"printing_unittests\": \"618adc1cd0414ef6f8f42ef43bc20d03b3898622\", \"remoting_unittests\": \"ab06b3d83535cbc9a8e0be64d3296a96412fbc78\", \"sbox_integration_tests\": \"3e72cb87fa88f37dac2a2b06e9be2db1ea86c1b0\", \"sbox_unittests\": \"2f3fafa261ada9ef58e9ab1ad5c0cb7398807cb5\", \"sbox_validation_tests\": \"0d255f3a775653dc1cd018527d260028707f8b4a\", \"service_manager_unittests\": \"2eae12b0bbcc3cd56e5aa606fd7f7fe5455359ba\", \"services_unittests\": \"52b5dfb0461fa0051546529f03be6abbee88945c\", \"setup_unittests\": \"a0662d5fb06fac29d07581b784f11f87f0ba152e\", \"shell_dialogs_unittests\": \"f1599e06bf636971e4b81faed78034aff5d51348\", \"skia_unittests\": \"2ce0d4dcb1740235c1da451fdedd771dd3ea70a6\", \"snapshot_unittests\": \"dcf6e5aefd51347b26f68ba15c9d880fcbd3ba65\", \"sql_unittests\": \"ac6bb65964c05d27c104e8d50a399e0dd53922d7\", \"storage_unittests\": \"add2a6f060727dfa7f56a1d4279207e98948a30a\", \"sync_integration_tests\": \"db6ef5478924511afcc382069d509b3f118f5859\", \"traffic_annotation_auditor_unittests\": \"b87f8f088fd6ab66fce329881a2ef0ae558cabce\", \"ui_base_unittests\": \"37763f99df0414c6384a9f66c3bceec45d88553c\", \"ui_touch_selection_unittests\": \"0ce99f6d75d4fbd158b485fe821095346f9c5977\", \"unit_tests\": \"36557808f70afa192664f00480a93f88d6cde751\", \"updater_tests\": \"8a2a637b22d13fc89ce33e63548b8e376a2b3716\", \"url_unittests\": \"d782655597ac0bdb5a7af16bf3fe355516d9c857\", \"views_unittests\": \"a9637f4318aaac6488b065ffb62d00da921e1090\", \"viz_unittests\": \"f46e95256ba5f345992cc4c03cc2b2b7ad6ce526\", \"vr_common_unittests\": \"bc58f68cdb5bb0c70c61216b6ece21927be2b165\", \"vr_pixeltests\": \"ff6b678ca1d06283b7d2ebb874b95693f9824da9\", \"weblayer_browsertests\": \"c913b52e270ed27742a82ad64ef49fd6d8737287\", \"weblayer_unittests\": \"cf84f6af4731f83aa10839318ae1c051992b7c47\", \"wm_unittests\": \"fe2549e40adca1b3e888fa5a20ab0ffc6472aa6a\", \"wtf_unittests\": \"8f13dc963c3a1065c395d515b380f0bb2379feaa\", \"zlib_unittests\": \"46f0060fe1d7dcbd332a84fe57771d3a117fd717\", \"zucchini_unittests\": \"bcd248373452f0b35fb3ad17ac4f455b4034abd5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"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-7-faks\"], \"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\": [\"5754-8c4f760\"], \"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": "1615797520030542",
"status": "COMPLETED",
"status_changed_ts": "1615800778025804",
"tags": [
"build_address:luci.chromium.ci/win-asan/17798",
"builder:win-asan",
"buildset:commit/git/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c75f29ad46d9944128a4c10e5db0c45c935f1a8b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018137310770773424",
"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/8852707246567717152/+/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:524ddb01325fb710",
"user_agent:luci-scheduler"
],
"updated_ts": "1615800778039819",
"url": "https://ci.chromium.org/b/8852707246567717152",
"utcnow_ts": "1615800778849668"
}
}
[09:32:58.878] Invocation finished in 54m51.778591646s with status SUCCEEDED