[16:48:12.378] New invocation is queued and will start shortly
[16:48:13.519] Starting the invocation (attempt 1)
[16:48:13.578] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:48:13.578] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:48:13.578] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018559461961479488",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"850fe2ef54c13a61b0d499f27b99e726259e6ecb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018559461961479488",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"gitiles_ref:refs/heads/master"
]
}
[16:48:14.564] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1615394893760201",
"id": "8853129399838916816",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"850fe2ef54c13a61b0d499f27b99e726259e6ecb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615394894299025",
"tags": [
"build_address:luci.chromium.ci/win-asan/17742",
"builder:win-asan",
"buildset:commit/git/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018559461961479488",
"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/8853129399838916816/+/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": "1615394894299143",
"url": "https://ci.chromium.org/b/8853129399838916816",
"utcnow_ts": "1615394894558522"
}
}
[16:48:14.564] Task URL: https://ci.chromium.org/b/8853129399838916816
[16:48:14.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:2:0) after 1m0s
[16:48:18.441] Received PubSub notification, asking Buildbucket for the build status
[16:48:18.652] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:14.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:2:0)
[16:49:14.627] Timer tick, asking Buildbucket for the build status
[16:49:14.730] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:14.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:4:0) after 1m0s
[16:50:14.710] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:4:0)
[16:50:14.710] Timer tick, asking Buildbucket for the build status
[16:50:14.811] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:14.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:5:0) after 1m0s
[16:51:14.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:5:0)
[16:51:14.830] Timer tick, asking Buildbucket for the build status
[16:51:15.018] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:6:0) after 1m0s
[16:52:15.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:6:0)
[16:52:15.059] Timer tick, asking Buildbucket for the build status
[16:52:15.124] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:15.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:7:0) after 1m0s
[16:53:15.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:7:0)
[16:53:15.142] Timer tick, asking Buildbucket for the build status
[16:53:15.267] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:15.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:8:0) after 1m0s
[16:54:15.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:8:0)
[16:54:15.316] Timer tick, asking Buildbucket for the build status
[16:54:15.426] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:15.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:9:0) after 1m0s
[16:55:15.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:9:0)
[16:55:15.463] Timer tick, asking Buildbucket for the build status
[16:55:15.527] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:15.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:10:0) after 1m0s
[16:56:15.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:10:0)
[16:56:15.552] Timer tick, asking Buildbucket for the build status
[16:56:15.744] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:11:0) after 1m0s
[16:57:15.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:11:0)
[16:57:15.763] Timer tick, asking Buildbucket for the build status
[16:57:15.826] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:15.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:12:0) after 1m0s
[16:58:15.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:12:0)
[16:58:15.841] Timer tick, asking Buildbucket for the build status
[16:58:15.902] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:15.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:13:0) after 1m0s
[16:59:15.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:13:0)
[16:59:15.872] Timer tick, asking Buildbucket for the build status
[16:59:15.958] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:14:0) after 1m0s
[17:00:15.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:14:0)
[17:00:15.972] Timer tick, asking Buildbucket for the build status
[17:00:16.084] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:16.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:15:0) after 1m0s
[17:01:16.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:15:0)
[17:01:16.107] Timer tick, asking Buildbucket for the build status
[17:01:16.180] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:16.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:16:0) after 1m0s
[17:02:16.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:16:0)
[17:02:16.245] Timer tick, asking Buildbucket for the build status
[17:02:16.418] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:16.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:17:0) after 1m0s
[17:03:16.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:17:0)
[17:03:16.400] Timer tick, asking Buildbucket for the build status
[17:03:16.464] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:16.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:18:0) after 1m0s
[17:04:16.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:18:0)
[17:04:16.527] Timer tick, asking Buildbucket for the build status
[17:04:16.599] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:16.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:19:0) after 1m0s
[17:05:16.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:19:0)
[17:05:16.705] Timer tick, asking Buildbucket for the build status
[17:05:16.802] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:16.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:20:0) after 1m0s
[17:06:16.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:20:0)
[17:06:16.813] Timer tick, asking Buildbucket for the build status
[17:06:17.050] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:17.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:21:0) after 1m0s
[17:07:17.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:21:0)
[17:07:17.065] Timer tick, asking Buildbucket for the build status
[17:07:17.167] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:17.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:22:0) after 1m0s
[17:08:17.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:22:0)
[17:08:17.263] Timer tick, asking Buildbucket for the build status
[17:08:17.345] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:17.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:23:0) after 1m0s
[17:09:17.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:23:0)
[17:09:17.407] Timer tick, asking Buildbucket for the build status
[17:09:17.750] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:17.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:24:0) after 1m0s
[17:10:17.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:24:0)
[17:10:17.865] Timer tick, asking Buildbucket for the build status
[17:10:17.973] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:17.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:25:0) after 1m0s
[17:11:18.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:25:0)
[17:11:18.010] Timer tick, asking Buildbucket for the build status
[17:11:18.096] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:18.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:26:0) after 1m0s
[17:12:18.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:26:0)
[17:12:18.141] Timer tick, asking Buildbucket for the build status
[17:12:18.403] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:18.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:27:0) after 1m0s
[17:13:18.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:27:0)
[17:13:18.425] Timer tick, asking Buildbucket for the build status
[17:13:18.516] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:18.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:28:0) after 1m0s
[17:14:18.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:28:0)
[17:14:18.559] Timer tick, asking Buildbucket for the build status
[17:14:18.672] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:18.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:29:0) after 1m0s
[17:15:18.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:29:0)
[17:15:18.668] Timer tick, asking Buildbucket for the build status
[17:15:18.742] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:18.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:30:0) after 1m0s
[17:16:18.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:30:0)
[17:16:18.753] Timer tick, asking Buildbucket for the build status
[17:16:19.111] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:19.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:31:0) after 1m0s
[17:17:19.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:31:0)
[17:17:19.157] Timer tick, asking Buildbucket for the build status
[17:17:19.240] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:19.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:32:0) after 1m0s
[17:18:19.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:32:0)
[17:18:19.302] Timer tick, asking Buildbucket for the build status
[17:18:19.436] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:19.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:33:0) after 1m0s
[17:19:19.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:33:0)
[17:19:19.461] Timer tick, asking Buildbucket for the build status
[17:19:19.568] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:19.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:34:0) after 1m0s
[17:20:19.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:34:0)
[17:20:19.608] Timer tick, asking Buildbucket for the build status
[17:20:19.689] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:19.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:35:0) after 1m0s
[17:21:19.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:35:0)
[17:21:19.725] Timer tick, asking Buildbucket for the build status
[17:21:19.802] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:19.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:36:0) after 1m0s
[17:22:19.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:36:0)
[17:22:19.932] Timer tick, asking Buildbucket for the build status
[17:22:20.047] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:20.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:37:0) after 1m0s
[17:23:20.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:37:0)
[17:23:20.092] Timer tick, asking Buildbucket for the build status
[17:23:20.217] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:20.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:38:0) after 1m0s
[17:24:20.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:38:0)
[17:24:20.303] Timer tick, asking Buildbucket for the build status
[17:24:20.520] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:20.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:39:0) after 1m0s
[17:25:20.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:39:0)
[17:25:20.669] Timer tick, asking Buildbucket for the build status
[17:25:20.757] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:20.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:40:0) after 1m0s
[17:26:20.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:40:0)
[17:26:20.918] Timer tick, asking Buildbucket for the build status
[17:26:21.119] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:41:0) after 1m0s
[17:27:21.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:41:0)
[17:27:21.199] Timer tick, asking Buildbucket for the build status
[17:27:21.302] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:21.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:42:0) after 1m0s
[17:28:21.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:42:0)
[17:28:21.386] Timer tick, asking Buildbucket for the build status
[17:28:21.492] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:21.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:43:0) after 1m0s
[17:29:21.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:43:0)
[17:29:21.549] Timer tick, asking Buildbucket for the build status
[17:29:21.644] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:21.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:44:0) after 1m0s
[17:30:21.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:44:0)
[17:30:21.676] Timer tick, asking Buildbucket for the build status
[17:30:21.773] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:21.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:45:0) after 1m0s
[17:31:21.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:45:0)
[17:31:21.840] Timer tick, asking Buildbucket for the build status
[17:31:22.059] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:22.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:46:0) after 1m0s
[17:32:22.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:46:0)
[17:32:22.115] Timer tick, asking Buildbucket for the build status
[17:32:22.330] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:22.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:47:0) after 1m0s
[17:33:22.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:47:0)
[17:33:22.470] Timer tick, asking Buildbucket for the build status
[17:33:22.832] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:22.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:48:0) after 1m0s
[17:34:22.832] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:48:0)
[17:34:22.832] Timer tick, asking Buildbucket for the build status
[17:34:23.007] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:23.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:49:0) after 1m0s
[17:35:23.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:49:0)
[17:35:23.070] Timer tick, asking Buildbucket for the build status
[17:35:23.197] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:23.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:50:0) after 1m0s
[17:36:23.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:50:0)
[17:36:23.249] Timer tick, asking Buildbucket for the build status
[17:36:23.335] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:23.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:51:0) after 1m0s
[17:37:23.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:51:0)
[17:37:23.361] Timer tick, asking Buildbucket for the build status
[17:37:23.467] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:23.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:52:0) after 1m0s
[17:38:23.613] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:52:0)
[17:38:23.613] Timer tick, asking Buildbucket for the build status
[17:38:23.737] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:23.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:53:0) after 1m0s
[17:39:23.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:53:0)
[17:39:23.839] Timer tick, asking Buildbucket for the build status
[17:39:23.922] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:23.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:54:0) after 1m0s
[17:40:24.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:54:0)
[17:40:24.014] Timer tick, asking Buildbucket for the build status
[17:40:24.124] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:24.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:55:0) after 1m0s
[17:41:24.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:55:0)
[17:41:24.200] Timer tick, asking Buildbucket for the build status
[17:41:24.271] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:24.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:56:0) after 1m0s
[17:42:24.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:56:0)
[17:42:24.302] Timer tick, asking Buildbucket for the build status
[17:42:24.532] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:24.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:57:0) after 1m0s
[17:43:24.708] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:57:0)
[17:43:24.708] Timer tick, asking Buildbucket for the build status
[17:43:25.251] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:25.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:58:0) after 1m0s
[17:44:25.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:58:0)
[17:44:25.360] Timer tick, asking Buildbucket for the build status
[17:44:25.770] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:25.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:59:0) after 1m0s
[17:45:25.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:59:0)
[17:45:25.954] Timer tick, asking Buildbucket for the build status
[17:45:26.046] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:26.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:60:0) after 1m0s
[17:46:26.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:60:0)
[17:46:26.139] Timer tick, asking Buildbucket for the build status
[17:46:26.355] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:26.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:61:0) after 1m0s
[17:47:26.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:61:0)
[17:47:26.392] Timer tick, asking Buildbucket for the build status
[17:47:26.527] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:26.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:62:0) after 1m0s
[17:48:26.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:62:0)
[17:48:26.552] Timer tick, asking Buildbucket for the build status
[17:48:26.644] Build 8853129399838916816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018559461961479488:63:0) after 1m0s
[17:49:14.324] Received PubSub notification, asking Buildbucket for the build status
[17:49:14.414] Build 8853129399838916816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:49:14.414] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615398549314109",
"created_by": "project:chromium",
"created_ts": "1615394893760201",
"id": "8853129399838916816",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"850fe2ef54c13a61b0d499f27b99e726259e6ecb\"}}",
"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\": \"850fe2ef54c13a61b0d499f27b99e726259e6ecb\", \"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-8-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17742, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"b2f547f4f423f492c4483d901d1b3ad5f3ad8798\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"850fe2ef54c13a61b0d499f27b99e726259e6ecb\", \"got_revision_cp\": \"refs/heads/master@{#861592}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"1eba7bc10f6caa3878c5a1fd9f45ee5056ae62ed\", \"got_v8_revision_cp\": \"refs/heads/9.1.89@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"850fe2ef54c13a61b0d499f27b99e726259e6ecb\", \"swarm_hashes_refs/heads/master(at){#861592}_without_patch\": {\"absl_hardening_tests\": \"bd549f83710be3ac77f6ac6a227d84b2b9d49909\", \"accessibility_unittests\": \"d9ae364adf361d7e22b2ac68b25fd2dd66899098\", \"angle_unittests\": \"3862f4afe956809927201e589b0a5040af1e064e\", \"app_shell_unittests\": \"7c3eed29e8194f9de9d921cf1347058f3c7f3414\", \"aura_unittests\": \"0d679513de8c5cc94f71ceb40583960a736a58fc\", \"base_unittests\": \"6480e96ae217ff59bfa5e46479e38bb4f1eeb189\", \"base_util_unittests\": \"510c4ef9ce6344b2106ddef0033b3f2d832a492e\", \"blink_common_unittests\": \"e8b76a192b56f70516feea7c32d0c4fea9a5ed76\", \"blink_fuzzer_unittests\": \"bb8640f6fa0020885579887a7c579855837929aa\", \"blink_heap_unittests\": \"3072426723e0c5f4e795e356d1b7f929a7bfd1db\", \"blink_platform_unittests\": \"bb3720214bfbbf800198348b4d5cf0810cddbfba\", \"blink_unittests\": \"0c74fa20259dfbe551c5caee4c90cbeb56609105\", \"boringssl_crypto_tests\": \"008871d283ef58013b368aa176a514ebb15efa49\", \"boringssl_ssl_tests\": \"830c20f051732f8cd9f5272d98157b5240910858\", \"browser_switcher_bho_unittests\": \"9eb17c46c54b7603770bae7362ceb2d1bd30c9ab\", \"browser_tests\": \"198a643e34e99306581b3191c06d864cec9f43a6\", \"capture_unittests\": \"51ec3214540c22c6ab3348e653ffac08f87fcd77\", \"cast_unittests\": \"8b76e0f87c1ada1c68cf5e528a3f6fdd1cfb7faa\", \"cc_unittests\": \"b5809a7de11cc946f2537c7063de60fcf51f4b99\", \"chrome_app_unittests\": \"c301a64cc4329051882d3c260834030dac3416d9\", \"chrome_cleaner_unittests\": \"d12c086b7877b25782b88896b7a9565919bcd2cb\", \"chrome_elf_unittests\": \"dfd26baaced107e8b02ee2661f50593bef2b2c97\", \"chromedriver_unittests\": \"c914919e77a15ccba8ab0733b675c520a36c1750\", \"color_unittests\": \"5d13158da796b77b8b8e6e07f2859c03bac98726\", \"components_browsertests\": \"526e57f699f838dd9c9b9aa5a5ca55f653584887\", \"components_unittests\": \"4abecd14de15ec2aee3d20d509f39504bb480f62\", \"compositor_unittests\": \"e499216650a0c67335a94eb373442e86121e7ce1\", \"content_browsertests\": \"6b67082e9c2a6c74dcb332f86cff17d4d4510128\", \"content_unittests\": \"206d94a37afa9a28232ceca1eb03c7c766779ecd\", \"courgette_unittests\": \"74bcaa9264a7e1904d3bb41a143a1d8bf9203c08\", \"crashpad_tests\": \"033724b8d5f13e21679e792ede4f72fa0e3df982\", \"cronet_tests\": \"06007fc57ee2a3600b54749e8c7d79b024cac786\", \"cronet_unittests\": \"9c9d5df81b121d4fcd81e7f61d16c1c52e82f027\", \"crypto_unittests\": \"ceecbe3d9926cdf0712633c82e1eb1611a5edcdd\", \"delayloads_unittests\": \"e9178a44d80fef461bdc45ad4987ee821cbd9b19\", \"device_unittests\": \"d94bebd5a785c26f9282161faa7a21dc976af605\", \"display_unittests\": \"f35fef4e8fb6d6aad3b68a880481d7f4d372bebb\", \"elevation_service_unittests\": \"106d6630125dae8e6dd7643daf8c1c34f5514d8a\", \"events_unittests\": \"691ac198a7d20d75bce79c0135e0d8a734aa2d67\", \"extensions_browsertests\": \"22d63e2aea28af44b7a2f07fdcf042ef5862d087\", \"extensions_unittests\": \"eb7c94ed0125d0e00bf4f255425159b2038e5ec3\", \"filesystem_service_unittests\": \"e89a83320f5a72045bd6b104b222b447de20ff7a\", \"gcm_unit_tests\": \"5b5f6ee372d690e1d30d662516e4234ba55b0b65\", \"gcp_unittests\": \"76bc71c19bbe22beff0e6f3fe314c844f75c34b5\", \"gfx_unittests\": \"33eae50ab4f0e138bad15cbc411c23b20f15bc52\", \"gin_unittests\": \"53e358d66f4d265196172138e44216080dc1bf00\", \"google_apis_unittests\": \"a2bba4760c11b87193796f14b9bfe7d3550161da\", \"gpu_unittests\": \"49f8422e405216628b4da6e3bac87dbadc146e5a\", \"gwp_asan_unittests\": \"9cfee60ab124cf411c0a72526478db3a8ab885d3\", \"headless_browsertests\": \"356231396cc3fc91f6e478298cb2c756fb11aa04\", \"headless_unittests\": \"722dae2e544021404c7a695ed6ab68b465b2ddd1\", \"install_static_unittests\": \"519eec4207e9ecfd6a4ca0c9c397a4f3cf1a8419\", \"installer_util_unittests\": \"5611cedfb172832d457879f66a40df1154ad8f7d\", \"interactive_ui_tests\": \"58d64e8816f861e306f4a3856a97baef5fdb7b49\", \"ipc_tests\": \"253314f06eb930c2384ccbfa05ef14327c253664\", \"jingle_unittests\": \"f4ff9ffa80632d70573956a33cca08bdb739e17e\", \"latency_unittests\": \"fa1539ac7ab8ed3d96e168fd13f6f5bbae9fc362\", \"libjingle_xmpp_unittests\": \"b65cb830a3493277035aa57de504b9f6bef34913\", \"liburlpattern_unittests\": \"68a04a39ec4e17ec6c8652347f11c7eb094840d0\", \"media_blink_unittests\": \"c065ff4427344f52a3341cd0799443d42b02b80b\", \"media_unittests\": \"2b4197f173cdf693c60818dd293d60528bf165fd\", \"message_center_unittests\": \"46639f08dcd2969420c5b297b5c44c01955703ec\", \"midi_unittests\": \"0dc88be101fad4a9fd52f49325884e9711cfa80d\", \"mojo_core_unittests\": \"b485546fee263cc742ded8d8c4eabc47f3a81893\", \"mojo_unittests\": \"75d9c4fd271759f164329ac010b21779d67d6041\", \"nacl_loader_unittests\": \"4ef78b55fee0ec4c6dd397610390554f1570edb3\", \"native_theme_unittests\": \"c9af15c94394586ed3627b51ff449c95c73be1b4\", \"net_unittests\": \"4b37bc912644a5349e749c60a4837c0dadce2d8a\", \"notification_helper_unittests\": \"89cd70eafdebe9fc6543b7ebf466ccf0901bffff\", \"pdf_unittests\": \"9647c90d054bd5707dc52b1b7020df12d6b6f544\", \"perfetto_unittests\": \"47af1bc0b438743525b11707d17a54006845b151\", \"ppapi_unittests\": \"ab73fce0da91f09c17b0beaee81bfc1e12a015fe\", \"printing_unittests\": \"e76cf3eeb8bad0881746725afe4c004887be8b0a\", \"remoting_unittests\": \"24cc86c115ff1c02cc90853c21d392e18979f48e\", \"sbox_integration_tests\": \"2fde677e9f146c01ee3011d62d5f9e6891249c2b\", \"sbox_unittests\": \"78a9f77a8e70c9eb967417993918937cd9c45a55\", \"sbox_validation_tests\": \"ac0c1de2caebf2c9dd7a373f5336e3eddc6ee01d\", \"service_manager_unittests\": \"31e7e1cb32f8cf8cbc1f386c068eae94357d0fde\", \"services_unittests\": \"7ffbf7323ee88571c0fb868049060f3d1c58a6ec\", \"setup_unittests\": \"e7b4e96a23e358589454eaee0352bc3593230fab\", \"shell_dialogs_unittests\": \"eb80516f5e431aa3af18281179ae0d33de79bc1a\", \"skia_unittests\": \"6a01bc9d8e6db2214b7f0ffa3c6c2077e9302c4f\", \"snapshot_unittests\": \"c9c93e36fc714a0e152f34c20f70d3b958e5723f\", \"sql_unittests\": \"c4f5b6978fcce50d760de3268470aa85c8dbd6d0\", \"storage_unittests\": \"729003b34f72bf502f007b17d281e56f3d699e38\", \"sync_integration_tests\": \"713f958b7e6c7008f16408def904e76ccf202bad\", \"traffic_annotation_auditor_unittests\": \"10a538fea29e0f5f4fe471e20b2297553b135bd9\", \"ui_base_unittests\": \"9cd34ccc41df405c6968da00d89bbfef0fbcf048\", \"ui_touch_selection_unittests\": \"d0e4526cf15d47f55669de26482dd9664fd1865b\", \"unit_tests\": \"0c439a5f021038bc9652d5065db6a6e3b270ad10\", \"updater_tests\": \"112b00e4b3825c382d89562ba29682a96baa5740\", \"url_unittests\": \"79bf2d284a745570d0cacaea19f3c4133f11f5d3\", \"views_unittests\": \"0ba81d140ecb236c66c5e6e078da481d4d61cbf0\", \"viz_unittests\": \"aeba35da0cdbef2642b3f2c6c53f4d59155f7012\", \"vr_common_unittests\": \"1b1bd875fc9bb7164e703dc77720e609e6075911\", \"vr_pixeltests\": \"eda478546bb28a9a9ec4b87f6f53c620dd32721d\", \"weblayer_browsertests\": \"551bf8f2896c27585181c90e1c51ce7cb7003606\", \"weblayer_unittests\": \"ce19a4f6dd3183374581627b1e67e843cf4743b8\", \"wm_unittests\": \"96be954f8e242ef27ecba924b4472dff8ee1eab5\", \"wtf_unittests\": \"ecc3b9c7c6cf4305f627eca412ea12d02d2eaae2\", \"zlib_unittests\": \"e53142252d6b4c0daf3079a99e48c4cd7f40e98e\", \"zucchini_unittests\": \"d9bbf073c78346f6d2d2c214ee63e4ced706d80a\"}}, \"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-8-2xaw\"], \"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\": [\"5746-91ff3bd\"], \"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": "1615394897698660",
"status": "COMPLETED",
"status_changed_ts": "1615398549736122",
"tags": [
"build_address:luci.chromium.ci/win-asan/17742",
"builder:win-asan",
"buildset:commit/git/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/850fe2ef54c13a61b0d499f27b99e726259e6ecb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018559461961479488",
"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/8853129399838916816/+/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:5235db7cb9702810",
"user_agent:luci-scheduler"
],
"updated_ts": "1615398549742039",
"url": "https://ci.chromium.org/b/8853129399838916816",
"utcnow_ts": "1615398554401244"
}
}
[17:49:14.414] Invocation finished in 1h1m2.061349385s with status SUCCEEDED