[01:24:16.454] New invocation is queued and will start shortly
[01:24:17.542] Starting the invocation (attempt 1)
[01:24:17.605] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:24:17.605] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:24:17.605] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023872214783287648",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2336b6557478c544a81650258aab4b0e7af49c78\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9023872214783287648",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2336b6557478c544a81650258aab4b0e7af49c78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2336b6557478c544a81650258aab4b0e7af49c78",
"gitiles_ref:refs/heads/master"
]
}
[01:24:19.013] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610328257722728",
"id": "8858442152789600368",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2336b6557478c544a81650258aab4b0e7af49c78\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610328258774304",
"tags": [
"build_address:luci.chromium.ci/win-official/1356",
"builder:win-official",
"buildset:commit/git/2336b6557478c544a81650258aab4b0e7af49c78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2336b6557478c544a81650258aab4b0e7af49c78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023872214783287648",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858442152789600368/+/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": "1610328258774470",
"url": "https://ci.chromium.org/b/8858442152789600368",
"utcnow_ts": "1610328258996729"
}
}
[01:24:19.013] Task URL: https://ci.chromium.org/b/8858442152789600368
[01:24:19.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:2:0) after 1m0s
[01:24:58.521] Received PubSub notification, asking Buildbucket for the build status
[01:24:58.589] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:19.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:2:0)
[01:25:19.104] Timer tick, asking Buildbucket for the build status
[01:25:19.178] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:19.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:4:0) after 1m0s
[01:26:19.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:4:0)
[01:26:19.214] Timer tick, asking Buildbucket for the build status
[01:26:19.351] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:19.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:5:0) after 1m0s
[01:27:19.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:5:0)
[01:27:19.452] Timer tick, asking Buildbucket for the build status
[01:27:19.898] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:6:0) after 1m0s
[01:28:19.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:6:0)
[01:28:19.924] Timer tick, asking Buildbucket for the build status
[01:28:19.992] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:19.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:7:0) after 1m0s
[01:29:20.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:7:0)
[01:29:20.012] Timer tick, asking Buildbucket for the build status
[01:29:20.092] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:20.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:8:0) after 1m0s
[01:30:20.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:8:0)
[01:30:20.116] Timer tick, asking Buildbucket for the build status
[01:30:20.233] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:20.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:9:0) after 1m0s
[01:31:20.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:9:0)
[01:31:20.241] Timer tick, asking Buildbucket for the build status
[01:31:20.332] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:20.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:10:0) after 1m0s
[01:32:20.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:10:0)
[01:32:20.383] Timer tick, asking Buildbucket for the build status
[01:32:20.525] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:20.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:11:0) after 1m0s
[01:33:20.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:11:0)
[01:33:20.521] Timer tick, asking Buildbucket for the build status
[01:33:20.605] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:12:0) after 1m0s
[01:34:20.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:12:0)
[01:34:20.623] Timer tick, asking Buildbucket for the build status
[01:34:20.725] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:20.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:13:0) after 1m0s
[01:35:20.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:13:0)
[01:35:20.695] Timer tick, asking Buildbucket for the build status
[01:35:20.786] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:20.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:14:0) after 1m0s
[01:36:20.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:14:0)
[01:36:20.809] Timer tick, asking Buildbucket for the build status
[01:36:20.896] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:20.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:15:0) after 1m0s
[01:37:20.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:15:0)
[01:37:20.916] Timer tick, asking Buildbucket for the build status
[01:37:21.020] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:21.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:16:0) after 1m0s
[01:38:21.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:16:0)
[01:38:21.035] Timer tick, asking Buildbucket for the build status
[01:38:21.228] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:21.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:17:0) after 1m0s
[01:39:21.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:17:0)
[01:39:21.265] Timer tick, asking Buildbucket for the build status
[01:39:21.424] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:21.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:18:0) after 1m0s
[01:40:21.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:18:0)
[01:40:21.486] Timer tick, asking Buildbucket for the build status
[01:40:21.557] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:21.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:19:0) after 1m0s
[01:41:21.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:19:0)
[01:41:21.544] Timer tick, asking Buildbucket for the build status
[01:41:21.608] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:21.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:20:0) after 1m0s
[01:42:21.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:20:0)
[01:42:21.673] Timer tick, asking Buildbucket for the build status
[01:42:21.732] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:21.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:21:0) after 1m0s
[01:43:21.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:21:0)
[01:43:21.748] Timer tick, asking Buildbucket for the build status
[01:43:21.837] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:21.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:22:0) after 1m0s
[01:44:21.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:22:0)
[01:44:21.860] Timer tick, asking Buildbucket for the build status
[01:44:21.955] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:21.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:23:0) after 1m0s
[01:45:21.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:23:0)
[01:45:21.978] Timer tick, asking Buildbucket for the build status
[01:45:22.084] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:22.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:24:0) after 1m0s
[01:46:22.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:24:0)
[01:46:22.094] Timer tick, asking Buildbucket for the build status
[01:46:22.227] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:22.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:25:0) after 1m0s
[01:47:22.630] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:25:0)
[01:47:22.630] Timer tick, asking Buildbucket for the build status
[01:47:22.737] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:22.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:26:0) after 1m0s
[01:48:22.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:26:0)
[01:48:22.927] Timer tick, asking Buildbucket for the build status
[01:48:22.992] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:22.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:27:0) after 1m0s
[01:49:23.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:27:0)
[01:49:23.264] Timer tick, asking Buildbucket for the build status
[01:49:23.488] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:23.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:28:0) after 1m0s
[01:50:23.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:28:0)
[01:50:23.509] Timer tick, asking Buildbucket for the build status
[01:50:23.579] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:23.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:29:0) after 1m0s
[01:51:23.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:29:0)
[01:51:23.706] Timer tick, asking Buildbucket for the build status
[01:51:23.763] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:30:0) after 1m0s
[01:52:23.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:30:0)
[01:52:23.883] Timer tick, asking Buildbucket for the build status
[01:52:24.258] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:24.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:31:0) after 1m0s
[01:53:24.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:31:0)
[01:53:24.442] Timer tick, asking Buildbucket for the build status
[01:53:24.501] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:24.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:32:0) after 1m0s
[01:54:24.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:32:0)
[01:54:24.615] Timer tick, asking Buildbucket for the build status
[01:54:24.812] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:24.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:33:0) after 1m0s
[01:55:26.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:33:0)
[01:55:26.114] Timer tick, asking Buildbucket for the build status
[01:55:26.234] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:26.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:34:0) after 1m0s
[01:56:26.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:34:0)
[01:56:26.293] Timer tick, asking Buildbucket for the build status
[01:56:26.420] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:26.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:35:0) after 1m0s
[01:57:26.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:35:0)
[01:57:26.524] Timer tick, asking Buildbucket for the build status
[01:57:26.634] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:26.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:36:0) after 1m0s
[01:58:26.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:36:0)
[01:58:26.661] Timer tick, asking Buildbucket for the build status
[01:58:26.728] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:26.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:37:0) after 1m0s
[01:59:26.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:37:0)
[01:59:26.743] Timer tick, asking Buildbucket for the build status
[01:59:26.856] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:26.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:38:0) after 1m0s
[02:00:26.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:38:0)
[02:00:26.869] Timer tick, asking Buildbucket for the build status
[02:00:26.950] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:26.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:39:0) after 1m0s
[02:01:26.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:39:0)
[02:01:26.982] Timer tick, asking Buildbucket for the build status
[02:01:27.064] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:27.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:40:0) after 1m0s
[02:02:27.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:40:0)
[02:02:27.107] Timer tick, asking Buildbucket for the build status
[02:02:27.191] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:27.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:41:0) after 1m0s
[02:03:27.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:41:0)
[02:03:27.271] Timer tick, asking Buildbucket for the build status
[02:03:27.446] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:42:0) after 1m0s
[02:04:27.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:42:0)
[02:04:27.426] Timer tick, asking Buildbucket for the build status
[02:04:27.530] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:43:0) after 1m0s
[02:05:27.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:43:0)
[02:05:27.562] Timer tick, asking Buildbucket for the build status
[02:05:27.636] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:27.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:44:0) after 1m0s
[02:06:27.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:44:0)
[02:06:27.678] Timer tick, asking Buildbucket for the build status
[02:06:27.771] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:27.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:45:0) after 1m0s
[02:07:27.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:45:0)
[02:07:27.777] Timer tick, asking Buildbucket for the build status
[02:07:27.832] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:27.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:46:0) after 1m0s
[02:08:27.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:46:0)
[02:08:27.954] Timer tick, asking Buildbucket for the build status
[02:08:28.108] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:28.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:47:0) after 1m0s
[02:09:28.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:47:0)
[02:09:28.132] Timer tick, asking Buildbucket for the build status
[02:09:28.238] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:28.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:48:0) after 1m0s
[02:10:28.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:48:0)
[02:10:28.315] Timer tick, asking Buildbucket for the build status
[02:10:28.389] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:28.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:49:0) after 1m0s
[02:11:28.447] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:49:0)
[02:11:28.447] Timer tick, asking Buildbucket for the build status
[02:11:28.513] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:28.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:50:0) after 1m0s
[02:12:28.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:50:0)
[02:12:28.756] Timer tick, asking Buildbucket for the build status
[02:12:28.821] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:51:0) after 1m0s
[02:13:29.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:51:0)
[02:13:29.159] Timer tick, asking Buildbucket for the build status
[02:13:29.243] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:29.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:52:0) after 1m0s
[02:14:29.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:52:0)
[02:14:29.361] Timer tick, asking Buildbucket for the build status
[02:14:29.479] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:29.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:53:0) after 1m0s
[02:15:29.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:53:0)
[02:15:29.553] Timer tick, asking Buildbucket for the build status
[02:15:29.627] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:29.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:54:0) after 1m0s
[02:16:29.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:54:0)
[02:16:29.783] Timer tick, asking Buildbucket for the build status
[02:16:29.895] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:29.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:55:0) after 1m0s
[02:17:29.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:55:0)
[02:17:29.954] Timer tick, asking Buildbucket for the build status
[02:17:30.020] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:30.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:56:0) after 1m0s
[02:18:30.192] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:56:0)
[02:18:30.192] Timer tick, asking Buildbucket for the build status
[02:18:30.257] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:30.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:57:0) after 1m0s
[02:19:30.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:57:0)
[02:19:30.439] Timer tick, asking Buildbucket for the build status
[02:19:30.578] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:30.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:58:0) after 1m0s
[02:20:30.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:58:0)
[02:20:30.703] Timer tick, asking Buildbucket for the build status
[02:20:30.813] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:30.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:59:0) after 1m0s
[02:21:30.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:59:0)
[02:21:30.922] Timer tick, asking Buildbucket for the build status
[02:21:30.988] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:30.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:60:0) after 1m0s
[02:22:31.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:60:0)
[02:22:31.047] Timer tick, asking Buildbucket for the build status
[02:22:31.341] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:31.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:61:0) after 1m0s
[02:23:31.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:61:0)
[02:23:31.405] Timer tick, asking Buildbucket for the build status
[02:23:31.468] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:31.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:62:0) after 1m0s
[02:24:31.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:62:0)
[02:24:31.645] Timer tick, asking Buildbucket for the build status
[02:24:31.818] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:63:0) after 1m0s
[02:25:31.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:63:0)
[02:25:31.894] Timer tick, asking Buildbucket for the build status
[02:25:31.958] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:31.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:64:0) after 1m0s
[02:26:32.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:64:0)
[02:26:32.005] Timer tick, asking Buildbucket for the build status
[02:26:32.218] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:65:0) after 1m0s
[02:27:32.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:65:0)
[02:27:32.197] Timer tick, asking Buildbucket for the build status
[02:27:32.267] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:32.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:66:0) after 1m0s
[02:28:32.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:66:0)
[02:28:32.306] Timer tick, asking Buildbucket for the build status
[02:28:32.382] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:32.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:67:0) after 1m0s
[02:29:32.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:67:0)
[02:29:32.425] Timer tick, asking Buildbucket for the build status
[02:29:32.551] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:68:0) after 1m0s
[02:30:32.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:68:0)
[02:30:32.658] Timer tick, asking Buildbucket for the build status
[02:30:32.825] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:32.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:69:0) after 1m0s
[02:31:32.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:69:0)
[02:31:32.918] Timer tick, asking Buildbucket for the build status
[02:31:33.029] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:33.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:70:0) after 1m0s
[02:32:33.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:70:0)
[02:32:33.054] Timer tick, asking Buildbucket for the build status
[02:32:33.204] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:33.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:71:0) after 1m0s
[02:33:33.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:71:0)
[02:33:33.220] Timer tick, asking Buildbucket for the build status
[02:33:33.276] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:33.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:72:0) after 1m0s
[02:34:33.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:72:0)
[02:34:33.335] Timer tick, asking Buildbucket for the build status
[02:34:33.464] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:33.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:73:0) after 1m0s
[02:35:33.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:73:0)
[02:35:33.515] Timer tick, asking Buildbucket for the build status
[02:35:33.599] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:33.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:74:0) after 1m0s
[02:36:33.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:74:0)
[02:36:33.681] Timer tick, asking Buildbucket for the build status
[02:36:33.892] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:33.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:75:0) after 1m0s
[02:37:34.050] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:75:0)
[02:37:34.050] Timer tick, asking Buildbucket for the build status
[02:37:34.129] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:34.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:76:0) after 1m0s
[02:38:34.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:76:0)
[02:38:34.149] Timer tick, asking Buildbucket for the build status
[02:38:34.450] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:34.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:77:0) after 1m0s
[02:39:34.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:77:0)
[02:39:34.448] Timer tick, asking Buildbucket for the build status
[02:39:35.102] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:35.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:78:0) after 1m0s
[02:40:35.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:78:0)
[02:40:35.190] Timer tick, asking Buildbucket for the build status
[02:40:35.521] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:35.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:79:0) after 1m0s
[02:41:35.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:79:0)
[02:41:35.542] Timer tick, asking Buildbucket for the build status
[02:41:35.618] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:35.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:80:0) after 1m0s
[02:42:35.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:80:0)
[02:42:35.641] Timer tick, asking Buildbucket for the build status
[02:42:35.909] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:35.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:81:0) after 1m0s
[02:43:35.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:81:0)
[02:43:35.934] Timer tick, asking Buildbucket for the build status
[02:43:36.076] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:36.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:82:0) after 1m0s
[02:44:36.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:82:0)
[02:44:36.206] Timer tick, asking Buildbucket for the build status
[02:44:36.522] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:36.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:83:0) after 1m0s
[02:45:36.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:83:0)
[02:45:36.552] Timer tick, asking Buildbucket for the build status
[02:45:36.900] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:36.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:84:0) after 1m0s
[02:46:36.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:84:0)
[02:46:36.969] Timer tick, asking Buildbucket for the build status
[02:46:37.023] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:37.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:85:0) after 1m0s
[02:47:37.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:85:0)
[02:47:37.044] Timer tick, asking Buildbucket for the build status
[02:47:37.127] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:37.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:86:0) after 1m0s
[02:48:37.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:86:0)
[02:48:37.199] Timer tick, asking Buildbucket for the build status
[02:48:37.262] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:37.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:87:0) after 1m0s
[02:49:37.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:87:0)
[02:49:37.282] Timer tick, asking Buildbucket for the build status
[02:49:37.399] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:37.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:88:0) after 1m0s
[02:50:37.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:88:0)
[02:50:37.425] Timer tick, asking Buildbucket for the build status
[02:50:37.555] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:37.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:89:0) after 1m0s
[02:51:37.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:89:0)
[02:51:37.679] Timer tick, asking Buildbucket for the build status
[02:51:37.776] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:37.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:90:0) after 1m0s
[02:52:37.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:90:0)
[02:52:37.919] Timer tick, asking Buildbucket for the build status
[02:52:38.101] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:38.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:91:0) after 1m0s
[02:53:38.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:91:0)
[02:53:38.124] Timer tick, asking Buildbucket for the build status
[02:53:38.202] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:38.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:92:0) after 1m0s
[02:54:38.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:92:0)
[02:54:38.303] Timer tick, asking Buildbucket for the build status
[02:54:38.671] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:38.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:93:0) after 1m0s
[02:55:38.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:93:0)
[02:55:38.717] Timer tick, asking Buildbucket for the build status
[02:55:38.827] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:38.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:94:0) after 1m0s
[02:56:38.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:94:0)
[02:56:38.813] Timer tick, asking Buildbucket for the build status
[02:56:38.874] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:38.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:95:0) after 1m0s
[02:57:38.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:95:0)
[02:57:38.906] Timer tick, asking Buildbucket for the build status
[02:57:38.964] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:38.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:96:0) after 1m0s
[02:58:39.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:96:0)
[02:58:39.018] Timer tick, asking Buildbucket for the build status
[02:58:39.088] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:39.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:97:0) after 1m0s
[02:59:39.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:97:0)
[02:59:39.114] Timer tick, asking Buildbucket for the build status
[02:59:39.736] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:39.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:98:0) after 1m0s
[03:00:39.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:98:0)
[03:00:39.748] Timer tick, asking Buildbucket for the build status
[03:00:39.824] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:99:0) after 1m0s
[03:01:39.843] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:99:0)
[03:01:39.843] Timer tick, asking Buildbucket for the build status
[03:01:40.093] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:40.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:100:0) after 1m0s
[03:02:40.158] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:100:0)
[03:02:40.158] Timer tick, asking Buildbucket for the build status
[03:02:40.231] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:40.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:101:0) after 1m0s
[03:03:40.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:101:0)
[03:03:40.239] Timer tick, asking Buildbucket for the build status
[03:03:40.715] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:102:0) after 1m0s
[03:04:40.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:102:0)
[03:04:40.768] Timer tick, asking Buildbucket for the build status
[03:04:40.887] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:40.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:103:0) after 1m0s
[03:05:40.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:103:0)
[03:05:40.919] Timer tick, asking Buildbucket for the build status
[03:05:41.121] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:41.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:104:0) after 1m0s
[03:06:41.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:104:0)
[03:06:41.144] Timer tick, asking Buildbucket for the build status
[03:06:41.229] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:41.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:105:0) after 1m0s
[03:07:41.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:105:0)
[03:07:41.244] Timer tick, asking Buildbucket for the build status
[03:07:41.303] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:41.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:106:0) after 1m0s
[03:08:41.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:106:0)
[03:08:41.325] Timer tick, asking Buildbucket for the build status
[03:08:41.393] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:41.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:107:0) after 1m0s
[03:09:41.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:107:0)
[03:09:41.424] Timer tick, asking Buildbucket for the build status
[03:09:41.544] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:41.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:108:0) after 1m0s
[03:10:41.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:108:0)
[03:10:41.564] Timer tick, asking Buildbucket for the build status
[03:10:41.628] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:109:0) after 1m0s
[03:11:41.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:109:0)
[03:11:41.649] Timer tick, asking Buildbucket for the build status
[03:11:41.708] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:41.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:110:0) after 1m0s
[03:12:41.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:110:0)
[03:12:41.819] Timer tick, asking Buildbucket for the build status
[03:12:41.968] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:41.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:111:0) after 1m0s
[03:13:41.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:111:0)
[03:13:41.993] Timer tick, asking Buildbucket for the build status
[03:13:42.056] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:42.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:112:0) after 1m0s
[03:14:42.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:112:0)
[03:14:42.088] Timer tick, asking Buildbucket for the build status
[03:14:42.456] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:42.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:113:0) after 1m0s
[03:15:42.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:113:0)
[03:15:42.467] Timer tick, asking Buildbucket for the build status
[03:15:42.556] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:42.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:114:0) after 1m0s
[03:16:42.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:114:0)
[03:16:42.575] Timer tick, asking Buildbucket for the build status
[03:16:42.628] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:42.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:115:0) after 1m0s
[03:17:42.653] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:115:0)
[03:17:42.653] Timer tick, asking Buildbucket for the build status
[03:17:42.710] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:42.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:116:0) after 1m0s
[03:18:42.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:116:0)
[03:18:42.687] Timer tick, asking Buildbucket for the build status
[03:18:42.812] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:42.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:117:0) after 1m0s
[03:19:42.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:117:0)
[03:19:42.840] Timer tick, asking Buildbucket for the build status
[03:19:42.941] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:42.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:118:0) after 1m0s
[03:20:42.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:118:0)
[03:20:42.936] Timer tick, asking Buildbucket for the build status
[03:20:42.997] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:42.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:119:0) after 1m0s
[03:21:43.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:119:0)
[03:21:43.100] Timer tick, asking Buildbucket for the build status
[03:21:43.177] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:43.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:120:0) after 1m0s
[03:22:43.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:120:0)
[03:22:43.251] Timer tick, asking Buildbucket for the build status
[03:22:43.321] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:43.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:121:0) after 1m0s
[03:23:43.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:121:0)
[03:23:43.445] Timer tick, asking Buildbucket for the build status
[03:23:44.008] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:44.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:122:0) after 1m0s
[03:24:44.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:122:0)
[03:24:44.036] Timer tick, asking Buildbucket for the build status
[03:24:44.158] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:123:0) after 1m0s
[03:25:44.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:123:0)
[03:25:44.213] Timer tick, asking Buildbucket for the build status
[03:25:44.321] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:44.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:124:0) after 1m0s
[03:26:44.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:124:0)
[03:26:44.344] Timer tick, asking Buildbucket for the build status
[03:26:44.413] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:44.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:125:0) after 1m0s
[03:27:44.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:125:0)
[03:27:44.485] Timer tick, asking Buildbucket for the build status
[03:27:44.557] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:44.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:126:0) after 1m0s
[03:28:44.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:126:0)
[03:28:44.577] Timer tick, asking Buildbucket for the build status
[03:28:44.643] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:44.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:127:0) after 1m0s
[03:29:44.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:127:0)
[03:29:44.687] Timer tick, asking Buildbucket for the build status
[03:29:45.225] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:45.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:128:0) after 1m0s
[03:30:45.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:128:0)
[03:30:45.315] Timer tick, asking Buildbucket for the build status
[03:30:45.391] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:45.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:129:0) after 1m0s
[03:31:45.409] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:129:0)
[03:31:45.409] Timer tick, asking Buildbucket for the build status
[03:31:45.468] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:130:0) after 1m0s
[03:32:45.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:130:0)
[03:32:45.494] Timer tick, asking Buildbucket for the build status
[03:32:45.567] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:45.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:131:0) after 1m0s
[03:33:45.607] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:131:0)
[03:33:45.607] Timer tick, asking Buildbucket for the build status
[03:33:45.688] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:45.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:132:0) after 1m0s
[03:34:45.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:132:0)
[03:34:45.759] Timer tick, asking Buildbucket for the build status
[03:34:45.941] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:45.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:133:0) after 1m0s
[03:35:46.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:133:0)
[03:35:46.007] Timer tick, asking Buildbucket for the build status
[03:35:46.326] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:46.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:134:0) after 1m0s
[03:36:46.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:134:0)
[03:36:46.352] Timer tick, asking Buildbucket for the build status
[03:36:46.419] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:46.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:135:0) after 1m0s
[03:37:46.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:135:0)
[03:37:46.492] Timer tick, asking Buildbucket for the build status
[03:37:46.563] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:46.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:136:0) after 1m0s
[03:38:46.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:136:0)
[03:38:46.579] Timer tick, asking Buildbucket for the build status
[03:38:46.688] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:46.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:137:0) after 1m0s
[03:39:46.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:137:0)
[03:39:46.722] Timer tick, asking Buildbucket for the build status
[03:39:46.846] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:46.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:138:0) after 1m0s
[03:40:46.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:138:0)
[03:40:46.972] Timer tick, asking Buildbucket for the build status
[03:40:47.153] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:47.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:139:0) after 1m0s
[03:41:47.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:139:0)
[03:41:47.258] Timer tick, asking Buildbucket for the build status
[03:41:47.313] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:47.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:140:0) after 1m0s
[03:42:47.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:140:0)
[03:42:47.339] Timer tick, asking Buildbucket for the build status
[03:42:47.402] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:47.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:141:0) after 1m0s
[03:43:47.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:141:0)
[03:43:47.522] Timer tick, asking Buildbucket for the build status
[03:43:47.614] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:47.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:142:0) after 1m0s
[03:44:47.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:142:0)
[03:44:47.694] Timer tick, asking Buildbucket for the build status
[03:44:47.905] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:47.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:143:0) after 1m0s
[03:45:47.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:143:0)
[03:45:47.980] Timer tick, asking Buildbucket for the build status
[03:45:48.043] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:48.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:144:0) after 1m0s
[03:46:48.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:144:0)
[03:46:48.074] Timer tick, asking Buildbucket for the build status
[03:46:48.388] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:48.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:145:0) after 1m0s
[03:47:48.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:145:0)
[03:47:48.514] Timer tick, asking Buildbucket for the build status
[03:47:48.612] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:48.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:146:0) after 1m0s
[03:48:48.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:146:0)
[03:48:48.637] Timer tick, asking Buildbucket for the build status
[03:48:48.701] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:48.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:147:0) after 1m0s
[03:49:48.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:147:0)
[03:49:48.767] Timer tick, asking Buildbucket for the build status
[03:49:48.886] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:48.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:148:0) after 1m0s
[03:50:48.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:148:0)
[03:50:48.956] Timer tick, asking Buildbucket for the build status
[03:50:49.023] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:49.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:149:0) after 1m0s
[03:51:49.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:149:0)
[03:51:49.223] Timer tick, asking Buildbucket for the build status
[03:51:49.280] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:49.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:150:0) after 1m0s
[03:52:49.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:150:0)
[03:52:49.373] Timer tick, asking Buildbucket for the build status
[03:52:49.434] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:49.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:151:0) after 1m0s
[03:53:49.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:151:0)
[03:53:49.458] Timer tick, asking Buildbucket for the build status
[03:53:49.550] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:152:0) after 1m0s
[03:54:49.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:152:0)
[03:54:49.575] Timer tick, asking Buildbucket for the build status
[03:54:49.731] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:49.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:153:0) after 1m0s
[03:55:49.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:153:0)
[03:55:49.762] Timer tick, asking Buildbucket for the build status
[03:55:49.834] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:154:0) after 1m0s
[03:56:49.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:154:0)
[03:56:49.857] Timer tick, asking Buildbucket for the build status
[03:56:50.052] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:50.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:155:0) after 1m0s
[03:57:50.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:155:0)
[03:57:50.078] Timer tick, asking Buildbucket for the build status
[03:57:50.146] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:50.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:156:0) after 1m0s
[03:58:50.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:156:0)
[03:58:50.178] Timer tick, asking Buildbucket for the build status
[03:58:50.242] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:50.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:157:0) after 1m0s
[03:59:50.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:157:0)
[03:59:50.268] Timer tick, asking Buildbucket for the build status
[03:59:50.391] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:50.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:158:0) after 1m0s
[04:00:50.437] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:158:0)
[04:00:50.437] Timer tick, asking Buildbucket for the build status
[04:00:50.505] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:50.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:159:0) after 1m0s
[04:01:50.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:159:0)
[04:01:50.528] Timer tick, asking Buildbucket for the build status
[04:01:50.602] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:50.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:160:0) after 1m0s
[04:02:50.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:160:0)
[04:02:50.685] Timer tick, asking Buildbucket for the build status
[04:02:50.758] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:50.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:161:0) after 1m0s
[04:03:50.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:161:0)
[04:03:50.782] Timer tick, asking Buildbucket for the build status
[04:03:50.850] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:50.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:162:0) after 1m0s
[04:04:50.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:162:0)
[04:04:50.900] Timer tick, asking Buildbucket for the build status
[04:04:50.994] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:50.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:163:0) after 1m0s
[04:05:51.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:163:0)
[04:05:51.023] Timer tick, asking Buildbucket for the build status
[04:05:51.095] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:51.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:164:0) after 1m0s
[04:06:51.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:164:0)
[04:06:51.119] Timer tick, asking Buildbucket for the build status
[04:06:51.742] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:51.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:165:0) after 1m0s
[04:07:51.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:165:0)
[04:07:51.766] Timer tick, asking Buildbucket for the build status
[04:07:51.840] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:51.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:166:0) after 1m0s
[04:08:51.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:166:0)
[04:08:51.851] Timer tick, asking Buildbucket for the build status
[04:08:51.918] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:51.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:167:0) after 1m0s
[04:09:51.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:167:0)
[04:09:51.966] Timer tick, asking Buildbucket for the build status
[04:09:52.059] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:52.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:168:0) after 1m0s
[04:10:52.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:168:0)
[04:10:52.042] Timer tick, asking Buildbucket for the build status
[04:10:52.216] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:52.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:169:0) after 1m0s
[04:11:52.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:169:0)
[04:11:52.312] Timer tick, asking Buildbucket for the build status
[04:11:52.432] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:52.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:170:0) after 1m0s
[04:12:52.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:170:0)
[04:12:52.489] Timer tick, asking Buildbucket for the build status
[04:12:52.560] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:52.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:171:0) after 1m0s
[04:13:52.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:171:0)
[04:13:52.585] Timer tick, asking Buildbucket for the build status
[04:13:52.634] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:52.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:172:0) after 1m0s
[04:14:52.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:172:0)
[04:14:52.710] Timer tick, asking Buildbucket for the build status
[04:14:52.988] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:52.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:173:0) after 1m0s
[04:15:53.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:173:0)
[04:15:53.108] Timer tick, asking Buildbucket for the build status
[04:15:53.165] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:53.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:174:0) after 1m0s
[04:16:53.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:174:0)
[04:16:53.194] Timer tick, asking Buildbucket for the build status
[04:16:53.251] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:53.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:175:0) after 1m0s
[04:17:53.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:175:0)
[04:17:53.308] Timer tick, asking Buildbucket for the build status
[04:17:53.432] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:53.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:176:0) after 1m0s
[04:18:53.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:176:0)
[04:18:53.480] Timer tick, asking Buildbucket for the build status
[04:18:53.729] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:177:0) after 1m0s
[04:19:53.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:177:0)
[04:19:53.867] Timer tick, asking Buildbucket for the build status
[04:19:54.076] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:54.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:178:0) after 1m0s
[04:20:54.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:178:0)
[04:20:54.066] Timer tick, asking Buildbucket for the build status
[04:20:54.349] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:54.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:179:0) after 1m0s
[04:21:54.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:179:0)
[04:21:54.417] Timer tick, asking Buildbucket for the build status
[04:21:54.529] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:54.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:180:0) after 1m0s
[04:22:54.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:180:0)
[04:22:54.563] Timer tick, asking Buildbucket for the build status
[04:22:54.628] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:54.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:181:0) after 1m0s
[04:23:54.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:181:0)
[04:23:54.717] Timer tick, asking Buildbucket for the build status
[04:23:54.887] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:182:0) after 1m0s
[04:24:54.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:182:0)
[04:24:54.978] Timer tick, asking Buildbucket for the build status
[04:24:55.080] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:55.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:183:0) after 1m0s
[04:25:55.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:183:0)
[04:25:55.085] Timer tick, asking Buildbucket for the build status
[04:25:55.147] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:55.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:184:0) after 1m0s
[04:26:55.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:184:0)
[04:26:55.286] Timer tick, asking Buildbucket for the build status
[04:26:55.344] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:55.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:185:0) after 1m0s
[04:27:55.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:185:0)
[04:27:55.412] Timer tick, asking Buildbucket for the build status
[04:27:55.465] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:55.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:186:0) after 1m0s
[04:28:55.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:186:0)
[04:28:55.525] Timer tick, asking Buildbucket for the build status
[04:28:55.578] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:55.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:187:0) after 1m0s
[04:29:55.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:187:0)
[04:29:55.638] Timer tick, asking Buildbucket for the build status
[04:29:55.730] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:55.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:188:0) after 1m0s
[04:30:55.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:188:0)
[04:30:55.830] Timer tick, asking Buildbucket for the build status
[04:30:55.882] Build 8858442152789600368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:55.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023872214783287648:189:0) after 1m0s
[04:31:10.254] Received PubSub notification, asking Buildbucket for the build status
[04:31:10.613] Build 8858442152789600368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:31:10.613] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610339469711357",
"created_by": "project:chromium",
"created_ts": "1610328257722728",
"id": "8858442152789600368",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2336b6557478c544a81650258aab4b0e7af49c78\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"2336b6557478c544a81650258aab4b0e7af49c78\", \"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\": \"win-dbg-4-yywi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1356, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"2336b6557478c544a81650258aab4b0e7af49c78\", \"got_revision_cp\": \"refs/heads/master@{#841911}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"42082f9045e74e65b9e3a66b51093e0dc2f9375a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32929}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2336b6557478c544a81650258aab4b0e7af49c78\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-yywi\"], \"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\": [\"5657-0417a3f\"], \"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": "1610328297929566",
"status": "COMPLETED",
"status_changed_ts": "1610339470008306",
"tags": [
"build_address:luci.chromium.ci/win-official/1356",
"builder:win-official",
"buildset:commit/git/2336b6557478c544a81650258aab4b0e7af49c78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2336b6557478c544a81650258aab4b0e7af49c78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023872214783287648",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858442152789600368/+/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:5107dcc27dd55010",
"user_agent:luci-scheduler"
],
"updated_ts": "1610339470024040",
"url": "https://ci.chromium.org/b/8858442152789600368",
"utcnow_ts": "1610339470588475"
}
}
[04:31:10.613] Invocation finished in 3h6m54.176091248s with status SUCCEEDED