[05:13:24.781] New invocation is queued and will start shortly
[05:13:26.010] Starting the invocation (attempt 1)
[05:13:26.062] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:13:26.063] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:13:26.063] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029927795366173280",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029927795366173280",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"gitiles_ref:refs/heads/master"
]
}
[05:13:27.280] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604553206159666",
"id": "8864497733257279744",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604553206869980",
"tags": [
"build_address:luci.chromium.ci/win-asan/15470",
"builder:win-asan",
"buildset:commit/git/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029927795366173280",
"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/8864497733257279744/+/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": "1604553206876384",
"url": "https://ci.chromium.org/b/8864497733257279744",
"utcnow_ts": "1604553207231120"
}
}
[05:13:27.280] Task URL: https://ci.chromium.org/b/8864497733257279744
[05:13:27.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:2:0) after 1m0s
[05:13:35.038] Received PubSub notification, asking Buildbucket for the build status
[05:13:35.136] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:27.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:2:0)
[05:14:27.567] Timer tick, asking Buildbucket for the build status
[05:14:27.842] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:27.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:4:0) after 1m0s
[05:15:27.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:4:0)
[05:15:27.904] Timer tick, asking Buildbucket for the build status
[05:15:28.085] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:28.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:5:0) after 1m0s
[05:16:28.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:5:0)
[05:16:28.132] Timer tick, asking Buildbucket for the build status
[05:16:28.594] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:28.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:6:0) after 1m0s
[05:17:28.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:6:0)
[05:17:28.664] Timer tick, asking Buildbucket for the build status
[05:17:28.881] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:28.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:7:0) after 1m0s
[05:18:28.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:7:0)
[05:18:28.919] Timer tick, asking Buildbucket for the build status
[05:18:29.192] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:29.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:8:0) after 1m0s
[05:19:29.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:8:0)
[05:19:29.223] Timer tick, asking Buildbucket for the build status
[05:19:29.297] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:29.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:9:0) after 1m0s
[05:20:29.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:9:0)
[05:20:29.327] Timer tick, asking Buildbucket for the build status
[05:20:29.394] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:29.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:10:0) after 1m0s
[05:21:29.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:10:0)
[05:21:29.454] Timer tick, asking Buildbucket for the build status
[05:21:29.531] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:29.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:11:0) after 1m0s
[05:22:29.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:11:0)
[05:22:29.559] Timer tick, asking Buildbucket for the build status
[05:22:29.629] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:29.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:12:0) after 1m0s
[05:23:29.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:12:0)
[05:23:29.601] Timer tick, asking Buildbucket for the build status
[05:23:29.756] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:29.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:13:0) after 1m0s
[05:24:29.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:13:0)
[05:24:29.749] Timer tick, asking Buildbucket for the build status
[05:24:29.893] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:29.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:14:0) after 1m0s
[05:25:29.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:14:0)
[05:25:29.900] Timer tick, asking Buildbucket for the build status
[05:25:30.034] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:30.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:15:0) after 1m0s
[05:26:30.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:15:0)
[05:26:30.078] Timer tick, asking Buildbucket for the build status
[05:26:30.274] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:30.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:16:0) after 1m0s
[05:27:30.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:16:0)
[05:27:30.306] Timer tick, asking Buildbucket for the build status
[05:27:30.432] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:30.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:17:0) after 1m0s
[05:28:30.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:17:0)
[05:28:30.422] Timer tick, asking Buildbucket for the build status
[05:28:30.552] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:30.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:18:0) after 1m0s
[05:29:30.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:18:0)
[05:29:30.604] Timer tick, asking Buildbucket for the build status
[05:29:30.677] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:30.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:19:0) after 1m0s
[05:30:30.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:19:0)
[05:30:30.667] Timer tick, asking Buildbucket for the build status
[05:30:30.956] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:30.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:20:0) after 1m0s
[05:31:30.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:20:0)
[05:31:30.981] Timer tick, asking Buildbucket for the build status
[05:31:31.107] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:31.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:21:0) after 1m0s
[05:32:31.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:21:0)
[05:32:31.138] Timer tick, asking Buildbucket for the build status
[05:32:31.264] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:22:0) after 1m0s
[05:33:31.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:22:0)
[05:33:31.418] Timer tick, asking Buildbucket for the build status
[05:33:31.725] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:31.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:23:0) after 1m0s
[05:34:31.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:23:0)
[05:34:31.792] Timer tick, asking Buildbucket for the build status
[05:34:32.315] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:32.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:24:0) after 1m0s
[05:35:32.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:24:0)
[05:35:32.417] Timer tick, asking Buildbucket for the build status
[05:35:32.856] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:32.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:25:0) after 1m0s
[05:36:32.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:25:0)
[05:36:32.891] Timer tick, asking Buildbucket for the build status
[05:36:33.056] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:33.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:26:0) after 1m0s
[05:37:33.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:26:0)
[05:37:33.085] Timer tick, asking Buildbucket for the build status
[05:37:33.256] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:33.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:27:0) after 1m0s
[05:38:33.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:27:0)
[05:38:33.287] Timer tick, asking Buildbucket for the build status
[05:38:33.430] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:33.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:28:0) after 1m0s
[05:39:33.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:28:0)
[05:39:33.464] Timer tick, asking Buildbucket for the build status
[05:39:33.661] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:33.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:29:0) after 1m0s
[05:40:33.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:29:0)
[05:40:33.718] Timer tick, asking Buildbucket for the build status
[05:40:33.864] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:33.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:30:0) after 1m0s
[05:41:33.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:30:0)
[05:41:33.886] Timer tick, asking Buildbucket for the build status
[05:41:34.028] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:34.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:31:0) after 1m0s
[05:42:34.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:31:0)
[05:42:34.209] Timer tick, asking Buildbucket for the build status
[05:42:34.362] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:34.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:32:0) after 1m0s
[05:43:34.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:32:0)
[05:43:34.432] Timer tick, asking Buildbucket for the build status
[05:43:34.887] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:34.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:33:0) after 1m0s
[05:44:34.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:33:0)
[05:44:34.931] Timer tick, asking Buildbucket for the build status
[05:44:35.027] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:35.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:34:0) after 1m0s
[05:45:35.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:34:0)
[05:45:35.208] Timer tick, asking Buildbucket for the build status
[05:45:35.287] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:35.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:35:0) after 1m0s
[05:46:35.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:35:0)
[05:46:35.336] Timer tick, asking Buildbucket for the build status
[05:46:35.416] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:35.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:36:0) after 1m0s
[05:47:35.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:36:0)
[05:47:35.623] Timer tick, asking Buildbucket for the build status
[05:47:36.405] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:36.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:37:0) after 1m0s
[05:48:36.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:37:0)
[05:48:36.526] Timer tick, asking Buildbucket for the build status
[05:48:36.675] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:36.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:38:0) after 1m0s
[05:49:36.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:38:0)
[05:49:36.764] Timer tick, asking Buildbucket for the build status
[05:49:36.932] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:36.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:39:0) after 1m0s
[05:50:37.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:39:0)
[05:50:37.063] Timer tick, asking Buildbucket for the build status
[05:50:37.261] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:37.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:40:0) after 1m0s
[05:51:37.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:40:0)
[05:51:37.351] Timer tick, asking Buildbucket for the build status
[05:51:37.597] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:37.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:41:0) after 1m0s
[05:52:37.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:41:0)
[05:52:37.664] Timer tick, asking Buildbucket for the build status
[05:52:37.842] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:37.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:42:0) after 1m0s
[05:53:37.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:42:0)
[05:53:37.909] Timer tick, asking Buildbucket for the build status
[05:53:38.883] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:38.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:43:0) after 1m0s
[05:54:39.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:43:0)
[05:54:39.182] Timer tick, asking Buildbucket for the build status
[05:54:39.301] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:39.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:44:0) after 1m0s
[05:55:39.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:44:0)
[05:55:39.333] Timer tick, asking Buildbucket for the build status
[05:55:39.461] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:39.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:45:0) after 1m0s
[05:56:39.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:45:0)
[05:56:39.513] Timer tick, asking Buildbucket for the build status
[05:56:39.652] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:39.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:46:0) after 1m0s
[05:57:39.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:46:0)
[05:57:39.685] Timer tick, asking Buildbucket for the build status
[05:57:39.895] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:39.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:47:0) after 1m0s
[05:58:39.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:47:0)
[05:58:39.955] Timer tick, asking Buildbucket for the build status
[05:58:40.258] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:40.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:48:0) after 1m0s
[05:59:40.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:48:0)
[05:59:40.308] Timer tick, asking Buildbucket for the build status
[05:59:40.545] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:40.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:49:0) after 1m0s
[06:00:40.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:49:0)
[06:00:40.574] Timer tick, asking Buildbucket for the build status
[06:00:40.664] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:40.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:50:0) after 1m0s
[06:01:46.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:50:0)
[06:01:46.475] Timer tick, asking Buildbucket for the build status
[06:01:46.870] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:46.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:51:0) after 1m0s
[06:02:46.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:51:0)
[06:02:46.946] Timer tick, asking Buildbucket for the build status
[06:02:47.088] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:47.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:52:0) after 1m0s
[06:03:47.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:52:0)
[06:03:47.114] Timer tick, asking Buildbucket for the build status
[06:03:47.544] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:47.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:53:0) after 1m0s
[06:04:47.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:53:0)
[06:04:47.620] Timer tick, asking Buildbucket for the build status
[06:04:48.549] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:48.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:54:0) after 1m0s
[06:05:48.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:54:0)
[06:05:48.572] Timer tick, asking Buildbucket for the build status
[06:05:48.667] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:48.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:55:0) after 1m0s
[06:06:48.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:55:0)
[06:06:48.765] Timer tick, asking Buildbucket for the build status
[06:06:49.012] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:49.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:56:0) after 1m0s
[06:07:49.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:56:0)
[06:07:49.059] Timer tick, asking Buildbucket for the build status
[06:07:49.526] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:49.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:57:0) after 1m0s
[06:08:49.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:57:0)
[06:08:49.538] Timer tick, asking Buildbucket for the build status
[06:08:49.722] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:49.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:58:0) after 1m0s
[06:09:49.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:58:0)
[06:09:49.809] Timer tick, asking Buildbucket for the build status
[06:09:49.961] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:49.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:59:0) after 1m0s
[06:10:49.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:59:0)
[06:10:49.985] Timer tick, asking Buildbucket for the build status
[06:10:50.149] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:50.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:60:0) after 1m0s
[06:11:50.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:60:0)
[06:11:50.164] Timer tick, asking Buildbucket for the build status
[06:11:50.304] Build 8864497733257279744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:50.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029927795366173280:61:0) after 1m0s
[06:12:04.271] Received PubSub notification, asking Buildbucket for the build status
[06:12:04.524] Build 8864497733257279744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:12:04.524] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604556721890032",
"created_by": "project:chromium",
"created_ts": "1604553206159666",
"id": "8864497733257279744",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\"}}",
"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\": \"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15470, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"658ede5d8c5caba6f5e2c4c0501bfbc345c7e2ef\", \"got_dawn_revision\": \"6564890116fd5629ad76948f12ad158d6f111cc3\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\", \"got_revision_cp\": \"refs/heads/master@{#824300}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ad54c71632cc0f18584a7009f1e6fc44f5453bc7\", \"got_v8_revision\": \"7ae0bc9f7258d206e0de93911c5987c3e04979b8\", \"got_v8_revision_cp\": \"refs/heads/8.8.228@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7677c1edce5a263b5c5d4f02653b0c986b2d3acc\", \"swarm_hashes_refs/heads/master(at){#824300}_without_patch\": {\"absl_hardening_tests\": \"c579cf9eccf1410e2f757b1fcde431fa927e87db\", \"accessibility_unittests\": \"a428884f17bc21009f6c0abf679186600700ace4\", \"angle_unittests\": \"0ca7e6ef04c358e1df78e9df5966f58fd2b0def1\", \"app_shell_unittests\": \"0e1bee4ba640bfddbed428550e138993ad63d656\", \"aura_unittests\": \"20062c21f4db430de3693a55840a1cbca5bbfb6f\", \"base_unittests\": \"20349b072f72db69909161ff87e164f05dd07000\", \"base_util_unittests\": \"0c0c819cdf4d3759ae64a2ca4b35bb81dd3ccac8\", \"blink_common_unittests\": \"eac854f5b7ef2c29963a57deab0e781d8c0a1e6f\", \"blink_fuzzer_unittests\": \"106995a802a5509aa2eb12bc952aa3ef3eb152dc\", \"blink_heap_unittests\": \"f682e4e829ee6789925a5a76e68d31cf8c022672\", \"blink_platform_unittests\": \"d6655709136d96e1454f51619ef94dbb6aef4f9c\", \"blink_unittests\": \"f099e462a779a41097e5eb317699fa84aea5247d\", \"boringssl_crypto_tests\": \"ac50efc9f2d8aa35c6c9394bb7416364463b3590\", \"boringssl_ssl_tests\": \"da5a1707c0c714032818baf1d34ef53fd54e3297\", \"browser_switcher_bho_unittests\": \"74c023527e602357538c652a70c8d14c3e1030b1\", \"browser_tests\": \"0a65b077655a77fb6312bd96c70d3684955a10ab\", \"capture_unittests\": \"1d68fc417592ae014c669aa3aa0e65b9b28ec2cd\", \"cast_unittests\": \"b37f9a99a9799ac7cafd592084ddf4782a3eb265\", \"cc_unittests\": \"7811f40f2a443846a860c6d796bc33584c732739\", \"chrome_app_unittests\": \"7f14d5730d1935cd54096286b7aac39d68558e7b\", \"chrome_cleaner_unittests\": \"f6072709ca0553dd0750c465426fc36f5e8882c9\", \"chrome_elf_unittests\": \"d8874b5e8ab00b6e7b50106061c9adc3c5be3675\", \"chromedriver_unittests\": \"c6ac9c53908d076f3974f4534363615ddba09290\", \"components_browsertests\": \"9aaac551d03ab48fbed06c7eb38ca2fa954a7044\", \"components_unittests\": \"e37bda4dfc8900bea2e451772ebfa88f79be12c9\", \"compositor_unittests\": \"36f393acdae03c90562a7f44c72c2661064a768b\", \"content_browsertests\": \"6bf23a1a33d25c5857d264b48cd3bd57707d5a36\", \"content_unittests\": \"c9198a7bab22e9f03970baaa415a188e8489159c\", \"courgette_unittests\": \"d7a82196ce78446f738f0cb51b36f09dc023ad30\", \"crashpad_tests\": \"5bac3dc10a8a7e617f8f7b2519a3e356e5df4542\", \"cronet_tests\": \"27d6cf3bbbcb637b4dd74a2fd41e4d7c45870884\", \"cronet_unittests\": \"1f6898a56b90d125b728b50bce94e2edaf6dbd7d\", \"crypto_unittests\": \"61bffc5c07292bc4b68893f407b06409fc3682f7\", \"delayloads_unittests\": \"c58d7a416269588a489d41997cfe034e28909cd3\", \"device_unittests\": \"8a28d4576896dd2eeb77bcd898963c8cb09b9f16\", \"display_unittests\": \"2524b9eb034b86d65fa008941bafbc37772aff79\", \"elevation_service_unittests\": \"55682fdf5fb418e442f362b23e09c37513f07a46\", \"events_unittests\": \"f979b099739a92e0c2da3fc25b90ad2f81e9b726\", \"extensions_browsertests\": \"3c1f5784a128179e28ad5433667da4f51c633ff0\", \"extensions_unittests\": \"70a32cf772c310ff913658c0a09a8209446bdaa2\", \"filesystem_service_unittests\": \"c41be6307a09f20b520896515ceb2af33da70fc4\", \"gcm_unit_tests\": \"3f13d3313557ab26a145a9a6d78b4564df81adb0\", \"gcp_unittests\": \"6d9fc8c3e88e8fe94b427ee6a05e673d68bad542\", \"gfx_unittests\": \"de1290e23a6003229e60ceededc16afa018299d6\", \"gin_unittests\": \"12d586d0258b4e3866fe3608eacb12deeed82858\", \"google_apis_unittests\": \"a709a63765f92cd9ec64b3d1ee7340c7252e9594\", \"gpu_unittests\": \"fbea5eaeb31bd30b759f5c0cdff574527a07f2aa\", \"gwp_asan_unittests\": \"bcab3c2fe02f43c50ef17bc364e2d3247b26c396\", \"headless_browsertests\": \"05a61255f632a231907cfedc8775d34b22fbf61f\", \"headless_unittests\": \"9c9538a47c85501cff05dfdbe45fb536e280e0ef\", \"install_static_unittests\": \"c1daf2250d2cf31fd278b2bf4cbabda5b3742d69\", \"installer_util_unittests\": \"5b137a5522cf397a7762c2f9ddf2014f1d3a8f01\", \"interactive_ui_tests\": \"94c2db76a85feff68eb617ee02f9511f75e957de\", \"ipc_tests\": \"b2e18b0dc7be31f125c8b4155421e86f58e49986\", \"jingle_unittests\": \"966b50074cae04d0a767aa4e3309387b3be80bd2\", \"latency_unittests\": \"601a8ea0b588d2116db42ce262a0c1d6c04eee10\", \"libjingle_xmpp_unittests\": \"e0bcb6c76f4d74e7c721929d8374739f297dae64\", \"liburlpattern_unittests\": \"f13d33fe5f86166691a060157499d416c819c89f\", \"media_blink_unittests\": \"56c3873830da962f2c177faa411090179e3919cf\", \"media_unittests\": \"179ebfbea2f1f9f683625bbd9bc3c5bb5661784f\", \"message_center_unittests\": \"3f077d7c3d375cb75cd035020bfabb44db48bd93\", \"midi_unittests\": \"b6434c392debd7fc1df43d5748fa8398a3ae9620\", \"mojo_core_unittests\": \"b17bf33030a7807c34d467485e1384c275f7926e\", \"mojo_unittests\": \"b30131419fe59ab1a2710bc32770ef049754e6a9\", \"nacl_loader_unittests\": \"af3d729142e38dbf8616229075af91114edeab48\", \"native_theme_unittests\": \"0bd0d19181466e097751319a78b128910a1fa8a0\", \"net_unittests\": \"0449485f8c7a7006097e13f06432f0155ecd6805\", \"notification_helper_unittests\": \"774b9495e54e35a81e8b2e89046944e93387ee8d\", \"pdf_unittests\": \"ed85b9ec75d3640f7b7b1ac6971f3dc4257be282\", \"perfetto_unittests\": \"cf381c31f2e864fb87f92012de2acdfece7ca4c9\", \"ppapi_unittests\": \"95b59a7b9233ab1b819e89e73d82397a1d3d2ba5\", \"printing_unittests\": \"d9c902568b4b5a49f4bf2a5ab9732b3c92b19a0d\", \"remoting_unittests\": \"6eca088b5bf4b222a3c6d4fe08af26f210ab7f2b\", \"sbox_integration_tests\": \"510fba7d91280a37e9162b6cff7283723bce9c12\", \"sbox_unittests\": \"5e0505dd87bedb5371338e5c3b0648d6851ad3cd\", \"sbox_validation_tests\": \"58d896eff96535fe20999193167aedb2b7decd64\", \"service_manager_unittests\": \"9cbefceeca30573a3ef57da20c29701aef95a72a\", \"services_unittests\": \"6bae90370478e4d12a22901b6364fae3aaf60632\", \"setup_unittests\": \"afe41ed2c1e429374dac8fa02a1aa9e1669ac71d\", \"shell_dialogs_unittests\": \"bbfa2844a727c9c6679ac868f2496fbc1496bc80\", \"skia_unittests\": \"ec60be309ce46198e98e02ad923975207af8e7ad\", \"snapshot_unittests\": \"cde4ce54a8150237df359e73d1c1267ef8ca6824\", \"sql_unittests\": \"81b8f72e2bfb60a9f9e971ba5d591c9f754f984b\", \"storage_unittests\": \"cdb63af827f6606f3bcbbbecaeff57a7be87bcc8\", \"sync_integration_tests\": \"1e2264decafbc16826b9e4477b44efd91c314e40\", \"traffic_annotation_auditor_unittests\": \"24b0c8a10f17647befbdd58e68efcd0cbde545d1\", \"ui_base_unittests\": \"e09650bef67bbddad3630cadd82b067bea53ee0c\", \"ui_touch_selection_unittests\": \"9611e9a0b21567d17bc932c26edcd6338c3b10bb\", \"unit_tests\": \"f7bb5cd7dd288e5cfbe10f1220131aa986e6a006\", \"updater_tests\": \"7caf187150f85c376259461b9c0b92cb2710ba31\", \"url_unittests\": \"d1b18bb6c8ae3dfdcc8834c4bcede87f63367ca0\", \"views_unittests\": \"1c654dfff2e0573da2ce8c1a738448ac869abfb4\", \"viz_unittests\": \"d96858314839ab781290838f6806a9adc8f09df3\", \"vr_common_unittests\": \"6212e65c84abf8d56d88db06e6a156ccab5f548b\", \"vr_pixeltests\": \"65655129525375243e2ade9bf94bcec491032784\", \"weblayer_browsertests\": \"98837af76f2b1f36963ee01794451224ba336f7e\", \"weblayer_unittests\": \"3791d97ff547ac8eef51d3b475d09efe6e2ab2d4\", \"wm_unittests\": \"a3bb52d0938c9984827627cfb37a27407820f7e1\", \"wtf_unittests\": \"cc9e10be514fc1b41d10d57c042f4d37ed65402b\", \"zlib_unittests\": \"53becd8bc685c18d75288e98730510d1c3af56c2\", \"zucchini_unittests\": \"0b6186f20859a4d2af745d6798dfc9c3ca6dca9e\"}}, \"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-5-vrjs\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5614-d862eaa\"], \"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": "1604553213964161",
"status": "COMPLETED",
"status_changed_ts": "1604556722749758",
"tags": [
"build_address:luci.chromium.ci/win-asan/15470",
"builder:win-asan",
"buildset:commit/git/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7677c1edce5a263b5c5d4f02653b0c986b2d3acc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029927795366173280",
"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/8864497733257279744/+/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:4fafa475d0b5ce10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604556722873054",
"url": "https://ci.chromium.org/b/8864497733257279744",
"utcnow_ts": "1604556724506026"
}
}
[06:12:04.524] Invocation finished in 58m39.760088038s with status SUCCEEDED