[05:12:24.895] New invocation is queued and will start shortly
[05:12:26.046] Starting the invocation (attempt 1)
[05:12:26.082] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:12:26.082] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:12:26.082] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022136519049670976",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022136519049670976",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"gitiles_ref:refs/heads/master"
]
}
[05:12:27.617] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611983546228323",
"id": "8856706456988192640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611983547412204",
"tags": [
"build_address:luci.chromium.ci/win-asan/17081",
"builder:win-asan",
"buildset:commit/git/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022136519049670976",
"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/8856706456988192640/+/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": "1611983547412328",
"url": "https://ci.chromium.org/b/8856706456988192640",
"utcnow_ts": "1611983547600887"
}
}
[05:12:27.617] Task URL: https://ci.chromium.org/b/8856706456988192640
[05:12:27.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:2:0) after 1m0s
[05:12:34.766] Received PubSub notification, asking Buildbucket for the build status
[05:12:34.841] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:27.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:2:0)
[05:13:27.670] Timer tick, asking Buildbucket for the build status
[05:13:27.747] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:27.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:4:0) after 1m0s
[05:14:27.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:4:0)
[05:14:27.768] Timer tick, asking Buildbucket for the build status
[05:14:27.892] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:27.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:5:0) after 1m0s
[05:15:27.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:5:0)
[05:15:27.968] Timer tick, asking Buildbucket for the build status
[05:15:28.308] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:28.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:6:0) after 1m0s
[05:16:28.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:6:0)
[05:16:28.372] Timer tick, asking Buildbucket for the build status
[05:16:28.765] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:28.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:7:0) after 1m0s
[05:17:29.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:7:0)
[05:17:29.025] Timer tick, asking Buildbucket for the build status
[05:17:29.422] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:29.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:8:0) after 1m0s
[05:18:29.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:8:0)
[05:18:29.470] Timer tick, asking Buildbucket for the build status
[05:18:29.921] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:29.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:9:0) after 1m0s
[05:19:30.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:9:0)
[05:19:30.066] Timer tick, asking Buildbucket for the build status
[05:19:30.138] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:30.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:10:0) after 1m0s
[05:20:30.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:10:0)
[05:20:30.216] Timer tick, asking Buildbucket for the build status
[05:20:30.280] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:30.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:11:0) after 1m0s
[05:21:30.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:11:0)
[05:21:30.369] Timer tick, asking Buildbucket for the build status
[05:21:30.483] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:30.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:12:0) after 1m0s
[05:22:30.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:12:0)
[05:22:30.594] Timer tick, asking Buildbucket for the build status
[05:22:30.868] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:30.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:13:0) after 1m0s
[05:23:30.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:13:0)
[05:23:30.924] Timer tick, asking Buildbucket for the build status
[05:23:31.014] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:31.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:14:0) after 1m0s
[05:24:31.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:14:0)
[05:24:31.008] Timer tick, asking Buildbucket for the build status
[05:24:31.074] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:31.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:15:0) after 1m0s
[05:25:31.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:15:0)
[05:25:31.114] Timer tick, asking Buildbucket for the build status
[05:25:31.238] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:31.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:16:0) after 1m0s
[05:26:31.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:16:0)
[05:26:31.319] Timer tick, asking Buildbucket for the build status
[05:26:31.382] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:31.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:17:0) after 1m0s
[05:27:31.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:17:0)
[05:27:31.504] Timer tick, asking Buildbucket for the build status
[05:27:31.640] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:31.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:18:0) after 1m0s
[05:28:31.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:18:0)
[05:28:31.660] Timer tick, asking Buildbucket for the build status
[05:28:31.927] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:31.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:19:0) after 1m0s
[05:29:31.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:19:0)
[05:29:31.952] Timer tick, asking Buildbucket for the build status
[05:29:32.200] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:32.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:20:0) after 1m0s
[05:30:32.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:20:0)
[05:30:32.219] Timer tick, asking Buildbucket for the build status
[05:30:32.407] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:32.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:21:0) after 1m0s
[05:31:32.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:21:0)
[05:31:32.443] Timer tick, asking Buildbucket for the build status
[05:31:33.125] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:33.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:22:0) after 1m0s
[05:32:33.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:22:0)
[05:32:33.302] Timer tick, asking Buildbucket for the build status
[05:32:34.733] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:34.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:23:0) after 1m0s
[05:33:34.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:23:0)
[05:33:34.784] Timer tick, asking Buildbucket for the build status
[05:33:35.503] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:35.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:24:0) after 1m0s
[05:34:35.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:24:0)
[05:34:35.544] Timer tick, asking Buildbucket for the build status
[05:34:35.677] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:35.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:25:0) after 1m0s
[05:35:35.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:25:0)
[05:35:35.694] Timer tick, asking Buildbucket for the build status
[05:35:35.796] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:35.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:26:0) after 1m0s
[05:36:35.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:26:0)
[05:36:35.818] Timer tick, asking Buildbucket for the build status
[05:36:35.963] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:35.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:27:0) after 1m0s
[05:37:35.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:27:0)
[05:37:35.985] Timer tick, asking Buildbucket for the build status
[05:37:36.113] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:36.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:28:0) after 1m0s
[05:38:36.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:28:0)
[05:38:36.157] Timer tick, asking Buildbucket for the build status
[05:38:36.284] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:36.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:29:0) after 1m0s
[05:39:36.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:29:0)
[05:39:36.366] Timer tick, asking Buildbucket for the build status
[05:39:36.450] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:36.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:30:0) after 1m0s
[05:40:36.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:30:0)
[05:40:36.510] Timer tick, asking Buildbucket for the build status
[05:40:36.584] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:36.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:31:0) after 1m0s
[05:41:36.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:31:0)
[05:41:36.602] Timer tick, asking Buildbucket for the build status
[05:41:36.935] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:32:0) after 1m0s
[05:42:37.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:32:0)
[05:42:37.063] Timer tick, asking Buildbucket for the build status
[05:42:37.191] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:37.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:33:0) after 1m0s
[05:43:37.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:33:0)
[05:43:37.283] Timer tick, asking Buildbucket for the build status
[05:43:37.374] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:37.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:34:0) after 1m0s
[05:44:37.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:34:0)
[05:44:37.408] Timer tick, asking Buildbucket for the build status
[05:44:37.597] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:37.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:35:0) after 1m0s
[05:45:37.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:35:0)
[05:45:37.621] Timer tick, asking Buildbucket for the build status
[05:45:37.692] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:37.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:36:0) after 1m0s
[05:46:37.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:36:0)
[05:46:37.797] Timer tick, asking Buildbucket for the build status
[05:46:38.108] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:38.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:37:0) after 1m0s
[05:47:38.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:37:0)
[05:47:38.209] Timer tick, asking Buildbucket for the build status
[05:47:38.749] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:38.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:38:0) after 1m0s
[05:48:38.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:38:0)
[05:48:38.723] Timer tick, asking Buildbucket for the build status
[05:48:38.821] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:38.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:39:0) after 1m0s
[05:49:38.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:39:0)
[05:49:38.849] Timer tick, asking Buildbucket for the build status
[05:49:39.061] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:39.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:40:0) after 1m0s
[05:50:39.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:40:0)
[05:50:39.123] Timer tick, asking Buildbucket for the build status
[05:50:39.244] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:39.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:41:0) after 1m0s
[05:51:39.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:41:0)
[05:51:39.282] Timer tick, asking Buildbucket for the build status
[05:51:40.108] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:40.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:42:0) after 1m0s
[05:52:40.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:42:0)
[05:52:40.173] Timer tick, asking Buildbucket for the build status
[05:52:40.396] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:40.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:43:0) after 1m0s
[05:53:40.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:43:0)
[05:53:40.484] Timer tick, asking Buildbucket for the build status
[05:53:40.565] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:40.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:44:0) after 1m0s
[05:54:40.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:44:0)
[05:54:40.666] Timer tick, asking Buildbucket for the build status
[05:54:40.751] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:40.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:45:0) after 1m0s
[05:55:40.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:45:0)
[05:55:40.812] Timer tick, asking Buildbucket for the build status
[05:55:40.938] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:40.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:46:0) after 1m0s
[05:56:40.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:46:0)
[05:56:40.952] Timer tick, asking Buildbucket for the build status
[05:56:41.122] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:41.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:47:0) after 1m0s
[05:57:41.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:47:0)
[05:57:41.140] Timer tick, asking Buildbucket for the build status
[05:57:41.283] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:41.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:48:0) after 1m0s
[05:58:41.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:48:0)
[05:58:41.342] Timer tick, asking Buildbucket for the build status
[05:58:41.646] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:41.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:49:0) after 1m0s
[05:59:41.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:49:0)
[05:59:41.687] Timer tick, asking Buildbucket for the build status
[05:59:41.793] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:41.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:50:0) after 1m0s
[06:00:41.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:50:0)
[06:00:41.806] Timer tick, asking Buildbucket for the build status
[06:00:41.888] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:41.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:51:0) after 1m0s
[06:01:41.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:51:0)
[06:01:41.955] Timer tick, asking Buildbucket for the build status
[06:01:42.093] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:42.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:52:0) after 1m0s
[06:02:42.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:52:0)
[06:02:42.113] Timer tick, asking Buildbucket for the build status
[06:02:42.357] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:42.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:53:0) after 1m0s
[06:03:42.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:53:0)
[06:03:42.439] Timer tick, asking Buildbucket for the build status
[06:03:42.512] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:42.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:54:0) after 1m0s
[06:04:42.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:54:0)
[06:04:42.549] Timer tick, asking Buildbucket for the build status
[06:04:42.632] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:55:0) after 1m0s
[06:05:42.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:55:0)
[06:05:42.653] Timer tick, asking Buildbucket for the build status
[06:05:42.741] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:42.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:56:0) after 1m0s
[06:06:42.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:56:0)
[06:06:42.794] Timer tick, asking Buildbucket for the build status
[06:06:42.919] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:42.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:57:0) after 1m0s
[06:07:42.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:57:0)
[06:07:42.938] Timer tick, asking Buildbucket for the build status
[06:07:43.104] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:43.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:58:0) after 1m0s
[06:08:43.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:58:0)
[06:08:43.171] Timer tick, asking Buildbucket for the build status
[06:08:43.358] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:43.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:59:0) after 1m0s
[06:09:43.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:59:0)
[06:09:43.414] Timer tick, asking Buildbucket for the build status
[06:09:43.573] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:43.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:60:0) after 1m0s
[06:10:43.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:60:0)
[06:10:43.691] Timer tick, asking Buildbucket for the build status
[06:10:44.306] Build 8856706456988192640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022136519049670976:61:0) after 1m0s
[06:11:07.873] Received PubSub notification, asking Buildbucket for the build status
[06:11:08.121] Build 8856706456988192640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:11:08.121] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611987066981153",
"created_by": "project:chromium",
"created_ts": "1611983546228323",
"id": "8856706456988192640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\"}}",
"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\": \"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\", \"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-2fjn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17081, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"74f7be6d1fd020a432dee63222fa090e4d8df651\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\", \"got_revision_cp\": \"refs/heads/master@{#848870}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"f9a6148e0498abdbe74eb6edf6aac78667d29499\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33109}\", \"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\": \"4278a7641b47ba40c9906e364e8d3dda9b5bb3d1\", \"swarm_hashes_refs/heads/master(at){#848870}_without_patch\": {\"absl_hardening_tests\": \"54efe653eb29ffd0408a4310ba6170cd3f723d26\", \"accessibility_unittests\": \"9540eb0406d4cd5ea6ec4c8a56710190ea55160d\", \"angle_unittests\": \"4cacb0a4b087962cf644ffbb65eaa7eeea10d4fb\", \"app_shell_unittests\": \"22008069f4b893f947de7874d78f230e7bee8aaa\", \"aura_unittests\": \"a4a5bbf6f6e8f28d4d0a0f24e5bcc4ea10687f7e\", \"base_unittests\": \"cb9a5512177782fd46758f092efce914e7805fca\", \"base_util_unittests\": \"b8a938daa05583c3356c2b6658659f4a4496dc76\", \"blink_common_unittests\": \"f0d2c1f2577b818038c7398e6d7286a929c6464a\", \"blink_fuzzer_unittests\": \"b8d9c8da1aaca23075ae4cb77e93ce295d8b593f\", \"blink_heap_unittests\": \"12b760d0a09f50ac27f7ef4d6d9dfa80d53e91b7\", \"blink_platform_unittests\": \"9653eb429a75945fd4ec5f1c536d0eb00de17f9a\", \"blink_unittests\": \"934529a27bceff523139d770f47340df7c2bbe1c\", \"boringssl_crypto_tests\": \"3c8d2559da392fae7f9aeef8f796d574e470b898\", \"boringssl_ssl_tests\": \"537a3ff703d15263942349feea13c0091e9cebd5\", \"browser_switcher_bho_unittests\": \"5aa750a9772e4e130f025c48361cb62cba0e5597\", \"browser_tests\": \"59b7431ceca7708ca0d171648065d2f5afcbe717\", \"capture_unittests\": \"067e5c1cf159221d564460f8650b1e7abea664c6\", \"cast_unittests\": \"9968c19162b98dea522691758b94f1d7d5e77ba8\", \"cc_unittests\": \"2682a83747b01b57c05ce60b456c64fb3b9d39ff\", \"chrome_app_unittests\": \"03c1a069ebc80ba92f3d5d1c30ab73e3326c261b\", \"chrome_cleaner_unittests\": \"7c71fb68e5a718c87a4828672f00b2e15e2f7b5b\", \"chrome_elf_unittests\": \"b5ad2e473f88930bb77d00d3b04b40b97dd11f5a\", \"chromedriver_unittests\": \"cdeb024511caddc5be2ec6de35d81d4167f060b3\", \"components_browsertests\": \"809dec8974711691580e38501eae5472f2143c59\", \"components_unittests\": \"444aaa0df436e3ec2bb7db60e24fc40c509c5fb0\", \"compositor_unittests\": \"f6e25ac68b1794b70118e05270582f986da9045c\", \"content_browsertests\": \"5a347866af74a4c4c934af4151fdcbe704c37b72\", \"content_unittests\": \"23af63ec51a962e49db77c455b3e05b180775963\", \"courgette_unittests\": \"01836ce5c6dd616175cd1913a7397fdb7b914055\", \"crashpad_tests\": \"1bc71d38c563b9953a09ced2dfb7195ee06cb3a2\", \"cronet_tests\": \"4c1499b9404e086b1bd2ca41b5e03615e010282a\", \"cronet_unittests\": \"7cee9cd5fc95cbb6ee8599cf7078d2d540fea0e1\", \"crypto_unittests\": \"9ba1caa01ef2664436cec9cc0327c9eaeae91602\", \"delayloads_unittests\": \"4646e7029a7ed3d59df93ff5028d96318a664341\", \"device_unittests\": \"803a48aaf0fb92ccec166057b20cea9f08bcc998\", \"display_unittests\": \"50dc24adb1e31d684b85cbd575b40a3d954f6a2f\", \"elevation_service_unittests\": \"6a7a3d1dc30abdf020dd0222dcb7c7d5b12b0275\", \"events_unittests\": \"99ddce3085d6976aa340927b1c5b21c169fb7f64\", \"extensions_browsertests\": \"2263f87eb8321ce4fea07c432848437081aedc49\", \"extensions_unittests\": \"082c75a2e276538b0a495adb9397d0423371c568\", \"filesystem_service_unittests\": \"6eb5d28ae2beaffe8509e5cb83ba9ddaeabca912\", \"gcm_unit_tests\": \"c3faac7a23556a27c28f729b09f015b60bccad07\", \"gcp_unittests\": \"bfd01a8c76ea6ce4f5593d89b728d917ebd70314\", \"gfx_unittests\": \"70538119fd4dbaf4ee9eaef62de28270f4f6f6ed\", \"gin_unittests\": \"9ce5a157335b91d97148d59f85e5c34b22a8c229\", \"google_apis_unittests\": \"a68a5f6c6f55ea15b0bf52c114d5c08a68e98c81\", \"gpu_unittests\": \"f77b20583948734f9208c6518fbd7bc5deb59bc6\", \"gwp_asan_unittests\": \"d922626f4d63943e2b30c1dee963555c20d07e61\", \"headless_browsertests\": \"74f7264ea858e667694ea1b9765ac183d7f7daf9\", \"headless_unittests\": \"2092ad039c43cce6ea8ffbc5a0972edd1ab1dbb9\", \"install_static_unittests\": \"b4b79dbb9c2441af02e563595c15d290c4637487\", \"installer_util_unittests\": \"b65791c95ad1ff6966e871caa90c7f76ae05ac9b\", \"interactive_ui_tests\": \"df9fa0d928c1eccd6bf48c248efce189455c8b05\", \"ipc_tests\": \"b686e8935e0a979c0c0b3b4767f32422d0365a7a\", \"jingle_unittests\": \"bad27c64a9372e75a6b5c58ada03a6b77d06525f\", \"latency_unittests\": \"23bd8ae273fab16b1be22bf2c0cf57a29e87b1a6\", \"libjingle_xmpp_unittests\": \"1327d25f5573d93a4c711cfc01541512a5a724c5\", \"liburlpattern_unittests\": \"9d8a436360cafe877a842ac86e172549ed43b66e\", \"media_blink_unittests\": \"d9f7aaad4e4f4d3d899aae8945e24bf3a5564c74\", \"media_unittests\": \"81d8b3762236f182baa784ea8792fafceda4c501\", \"message_center_unittests\": \"cefd5cb446c463ca928ba51b1e6d674ef3714bc6\", \"midi_unittests\": \"e3855ab0472d27d8764da6194b748d40aee795d9\", \"mojo_core_unittests\": \"5e99d6e01d751cfa0fc244a36c25fcf7bf6954db\", \"mojo_unittests\": \"0bbedfc321305f5308d4d87d3ff608221355a6bb\", \"nacl_loader_unittests\": \"cfd07a17cf51606a82c99cd4d92c9ac7050b5610\", \"native_theme_unittests\": \"d003117af9ba80e40f820200941a960a9acf1d68\", \"net_unittests\": \"a0e7352c4ce4612013d432b30e9253a554632145\", \"notification_helper_unittests\": \"46d86182bd88e857d65200aa43beb8464c4e3aa1\", \"pdf_unittests\": \"d611cb54ad711010b83048f4063f1a2ac8850f87\", \"perfetto_unittests\": \"250b8a7a7bdb2c8185a5d9ec0f70562d44005242\", \"ppapi_unittests\": \"bac4242efaaa4936046dbd468ff02b06e2236387\", \"printing_unittests\": \"2fae86be379f77b683495068f225f36a6521cdfc\", \"remoting_unittests\": \"949e2f34c9f2729498bec8a820ab83458f48c3ca\", \"sbox_integration_tests\": \"b8e746a2f9de2048eed46435e17f422ecd6e14d0\", \"sbox_unittests\": \"e9728144e8bd0110aedb71bf34553d0b3c45f525\", \"sbox_validation_tests\": \"80fbe13df3a07fe477a7450b65ddc4aa83b228d2\", \"service_manager_unittests\": \"371d13bf73866c890b4bb9488f143d27f20cc09b\", \"services_unittests\": \"0b6b69a538b158b595639445b137833266658980\", \"setup_unittests\": \"10c7b9984c1dd160ed1e78a4b746c4b40caab5ae\", \"shell_dialogs_unittests\": \"abb6326231f2a25367696db51faab9f2c0aabde8\", \"skia_unittests\": \"0a8bd7317c4f4175a68b5d6fb8f74af3d10da17b\", \"snapshot_unittests\": \"7652f7a45444d73e22e3795bbccb805196ba9f95\", \"sql_unittests\": \"267040b731bfc2161f3dfa7b233b4d5d604cb3bf\", \"storage_unittests\": \"0e2d9f24b8ce9a276ede2b1b276400b71a231d3c\", \"sync_integration_tests\": \"c573bdae1c395f33183c39b357ef8c7c9c1c7a46\", \"traffic_annotation_auditor_unittests\": \"f7731a5bdc05e5f89a908c2e79bfc57d12bbe13e\", \"ui_base_unittests\": \"b06e084c6fe978f1c5071b93ce6873ab1cad73e8\", \"ui_touch_selection_unittests\": \"7379cda73534ed9e83e2208ff3b3d1539695f0bb\", \"unit_tests\": \"8cd34b042bac919b376e42e4c6a18da2099e9ca6\", \"updater_tests\": \"b865ee53c18b66fd0d31c7d8b442d0e8c9f93f59\", \"url_unittests\": \"fcaa983f6b8ad52539121b4e9b3a2a5658b84987\", \"views_unittests\": \"be3d28d5ec4f325dc847853adbf3feefe8a9859c\", \"viz_unittests\": \"8bda38b05fc79db8cbca80ac96212ba15a3f19a8\", \"vr_common_unittests\": \"7e93857232b669f3072dd2c4699eff005948c9ee\", \"vr_pixeltests\": \"2c1f9777572ecc8d3741ab11aaf16da9e21e2ca2\", \"weblayer_browsertests\": \"bfaa2809080182d1f6ef6707ccb14497491764b7\", \"weblayer_unittests\": \"8c64a50b3ecb16c86dc11d47bade4b945c958850\", \"wm_unittests\": \"8c7c94e45351ffc1738c5b4c291e54260aeeb396\", \"wtf_unittests\": \"92748534de8fb72855af0fd4ab5e7926b6303186\", \"zlib_unittests\": \"e5553eff791df2decc8f7026c12654aaaa409792\", \"zucchini_unittests\": \"84d957c3537bb5c8a9b4834f7e2c8e032ca6792d\"}}, \"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-7-2fjn\"], \"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\": [\"5673-2413400\"], \"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": "1611983554164656",
"status": "COMPLETED",
"status_changed_ts": "1611987067479062",
"tags": [
"build_address:luci.chromium.ci/win-asan/17081",
"builder:win-asan",
"buildset:commit/git/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4278a7641b47ba40c9906e364e8d3dda9b5bb3d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022136519049670976",
"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/8856706456988192640/+/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:516a867d4197e210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611987067483580",
"url": "https://ci.chromium.org/b/8856706456988192640",
"utcnow_ts": "1611987068101441"
}
}
[06:11:08.121] Invocation finished in 58m43.241650163s with status SUCCEEDED