[07:50:16.168] New invocation is queued and will start shortly
[07:50:17.239] Starting the invocation (attempt 1)
[07:50:17.308] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:50:17.311] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[07:50:17.311] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9023666736128708736",
"parameters_json": "{\"builder_name\":\"infra-continuous-win10-64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"26febd402c08267fdf61be858d0b6bb33a571d46\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@26febd402c08267fdf61be858d0b6bb33a571d46\",\"title\":\"26febd402c08267fdf61be858d0b6bb33a571d46\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"26febd402c08267fdf61be858d0b6bb33a571d46\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
},
"tags": [
"builder:infra-continuous-win10-64",
"scheduler_invocation_id:9023666736128708736",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/26febd402c08267fdf61be858d0b6bb33a571d46",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46",
"gitiles_ref:refs/heads/master"
]
}
[07:50:17.877] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1610524217426031",
"id": "8858236674146719280",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"26febd402c08267fdf61be858d0b6bb33a571d46\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@26febd402c08267fdf61be858d0b6bb33a571d46\", \"title\": \"26febd402c08267fdf61be858d0b6bb33a571d46\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"26febd402c08267fdf61be858d0b6bb33a571d46\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610524217760691",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18328",
"builder:infra-continuous-win10-64",
"buildset:commit/git/26febd402c08267fdf61be858d0b6bb33a571d46",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023666736128708736",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8858236674146719280/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1610524217760794",
"url": "https://luci-milo-dev.appspot.com/b/8858236674146719280",
"utcnow_ts": "1610524217868192"
}
}
[07:50:17.877] Task URL: https://luci-milo-dev.appspot.com/b/8858236674146719280
[07:50:17.877] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:2:0) after 1m0s
[07:51:17.895] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:2:0)
[07:51:17.895] Timer tick, asking Buildbucket for the build status
[07:51:17.961] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:17.961] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:3:0) after 1m0s
[07:52:17.986] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:3:0)
[07:52:17.986] Timer tick, asking Buildbucket for the build status
[07:52:18.061] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:18.061] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:4:0) after 1m0s
[07:53:18.165] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:4:0)
[07:53:18.165] Timer tick, asking Buildbucket for the build status
[07:53:18.322] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:18.322] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:5:0) after 1m0s
[07:54:18.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:5:0)
[07:54:18.397] Timer tick, asking Buildbucket for the build status
[07:54:18.472] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:18.472] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:6:0) after 1m0s
[07:55:18.490] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:6:0)
[07:55:18.490] Timer tick, asking Buildbucket for the build status
[07:55:18.705] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:18.705] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:7:0) after 1m0s
[07:56:18.726] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:7:0)
[07:56:18.726] Timer tick, asking Buildbucket for the build status
[07:56:18.801] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:18.801] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:8:0) after 1m0s
[07:57:18.856] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:8:0)
[07:57:18.856] Timer tick, asking Buildbucket for the build status
[07:57:18.938] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:18.938] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:9:0) after 1m0s
[07:58:18.985] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:9:0)
[07:58:18.985] Timer tick, asking Buildbucket for the build status
[07:58:19.053] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:19.053] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:10:0) after 1m0s
[07:59:19.074] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:10:0)
[07:59:19.074] Timer tick, asking Buildbucket for the build status
[07:59:19.163] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:19.163] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:11:0) after 1m0s
[08:00:19.190] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:11:0)
[08:00:19.190] Timer tick, asking Buildbucket for the build status
[08:00:19.279] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:19.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:12:0) after 1m0s
[08:01:19.358] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:12:0)
[08:01:19.358] Timer tick, asking Buildbucket for the build status
[08:01:19.440] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:01:19.440] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:13:0) after 1m0s
[08:02:19.469] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:13:0)
[08:02:19.469] Timer tick, asking Buildbucket for the build status
[08:02:19.598] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:02:19.598] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:14:0) after 1m0s
[08:03:19.686] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:14:0)
[08:03:19.686] Timer tick, asking Buildbucket for the build status
[08:03:19.835] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:03:19.835] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:15:0) after 1m0s
[08:04:19.872] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:15:0)
[08:04:19.872] Timer tick, asking Buildbucket for the build status
[08:04:20.032] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:20.032] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:16:0) after 1m0s
[08:05:20.059] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:16:0)
[08:05:20.060] Timer tick, asking Buildbucket for the build status
[08:05:20.154] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:20.154] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:17:0) after 1m0s
[08:06:20.267] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:17:0)
[08:06:20.267] Timer tick, asking Buildbucket for the build status
[08:06:20.424] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:20.424] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:18:0) after 1m0s
[08:07:20.444] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:18:0)
[08:07:20.444] Timer tick, asking Buildbucket for the build status
[08:07:20.530] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:20.530] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:19:0) after 1m0s
[08:08:20.587] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:19:0)
[08:08:20.587] Timer tick, asking Buildbucket for the build status
[08:08:20.730] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:20.730] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:20:0) after 1m0s
[08:09:20.768] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:20:0)
[08:09:20.768] Timer tick, asking Buildbucket for the build status
[08:09:20.849] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:20.849] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:21:0) after 1m0s
[08:10:20.887] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:21:0)
[08:10:20.887] Timer tick, asking Buildbucket for the build status
[08:10:20.960] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:20.960] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:22:0) after 1m0s
[08:11:21.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:22:0)
[08:11:21.118] Timer tick, asking Buildbucket for the build status
[08:11:21.212] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:21.212] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:23:0) after 1m0s
[08:12:21.231] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:23:0)
[08:12:21.231] Timer tick, asking Buildbucket for the build status
[08:12:21.332] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:21.332] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:24:0) after 1m0s
[08:13:21.390] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:24:0)
[08:13:21.390] Timer tick, asking Buildbucket for the build status
[08:13:21.472] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:21.472] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:25:0) after 1m0s
[08:14:21.558] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:25:0)
[08:14:21.558] Timer tick, asking Buildbucket for the build status
[08:14:21.632] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:21.633] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:26:0) after 1m0s
[08:15:21.664] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:26:0)
[08:15:21.664] Timer tick, asking Buildbucket for the build status
[08:15:21.763] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:21.763] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:27:0) after 1m0s
[08:16:21.799] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:27:0)
[08:16:21.799] Timer tick, asking Buildbucket for the build status
[08:16:21.882] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:21.882] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:28:0) after 1m0s
[08:17:21.970] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:28:0)
[08:17:21.970] Timer tick, asking Buildbucket for the build status
[08:17:22.132] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:22.132] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:29:0) after 1m0s
[08:18:22.175] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:29:0)
[08:18:22.175] Timer tick, asking Buildbucket for the build status
[08:18:22.270] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:22.270] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:30:0) after 1m0s
[08:19:22.292] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:30:0)
[08:19:22.292] Timer tick, asking Buildbucket for the build status
[08:19:22.362] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:22.362] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:31:0) after 1m0s
[08:20:22.469] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:31:0)
[08:20:22.469] Timer tick, asking Buildbucket for the build status
[08:20:22.559] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:22.559] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:32:0) after 1m0s
[08:21:22.581] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:32:0)
[08:21:22.581] Timer tick, asking Buildbucket for the build status
[08:21:22.661] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:22.661] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:33:0) after 1m0s
[08:22:22.688] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:33:0)
[08:22:22.688] Timer tick, asking Buildbucket for the build status
[08:22:22.778] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:22.778] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:34:0) after 1m0s
[08:23:22.868] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:34:0)
[08:23:22.870] Timer tick, asking Buildbucket for the build status
[08:23:23.009] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:23.009] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:35:0) after 1m0s
[08:24:23.070] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:35:0)
[08:24:23.070] Timer tick, asking Buildbucket for the build status
[08:24:23.167] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:23.167] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:36:0) after 1m0s
[08:25:23.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:36:0)
[08:25:23.188] Timer tick, asking Buildbucket for the build status
[08:25:23.261] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:23.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:37:0) after 1m0s
[08:26:23.304] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:37:0)
[08:26:23.304] Timer tick, asking Buildbucket for the build status
[08:26:23.380] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:23.380] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:38:0) after 1m0s
[08:27:23.491] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:38:0)
[08:27:23.491] Timer tick, asking Buildbucket for the build status
[08:27:23.628] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:23.628] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:39:0) after 1m0s
[08:28:23.700] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:39:0)
[08:28:23.700] Timer tick, asking Buildbucket for the build status
[08:28:23.795] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:23.795] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:40:0) after 1m0s
[08:29:23.897] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:40:0)
[08:29:23.897] Timer tick, asking Buildbucket for the build status
[08:29:24.033] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:24.033] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:41:0) after 1m0s
[08:30:24.088] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:41:0)
[08:30:24.088] Timer tick, asking Buildbucket for the build status
[08:30:24.153] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:24.153] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:42:0) after 1m0s
[08:31:24.207] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:42:0)
[08:31:24.207] Timer tick, asking Buildbucket for the build status
[08:31:24.299] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:24.299] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:43:0) after 1m0s
[08:32:24.320] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:43:0)
[08:32:24.320] Timer tick, asking Buildbucket for the build status
[08:32:24.485] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:24.485] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:44:0) after 1m0s
[08:33:24.592] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:44:0)
[08:33:24.592] Timer tick, asking Buildbucket for the build status
[08:33:24.717] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:24.717] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:45:0) after 1m0s
[08:34:24.756] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:45:0)
[08:34:24.756] Timer tick, asking Buildbucket for the build status
[08:34:24.945] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:24.945] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:46:0) after 1m0s
[08:35:25.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:46:0)
[08:35:25.001] Timer tick, asking Buildbucket for the build status
[08:35:25.067] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:25.067] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:47:0) after 1m0s
[08:36:25.088] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:47:0)
[08:36:25.088] Timer tick, asking Buildbucket for the build status
[08:36:25.165] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:25.165] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:48:0) after 1m0s
[08:37:25.270] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:48:0)
[08:37:25.270] Timer tick, asking Buildbucket for the build status
[08:37:25.338] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:25.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:49:0) after 1m0s
[08:38:25.370] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:49:0)
[08:38:25.370] Timer tick, asking Buildbucket for the build status
[08:38:25.434] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:25.434] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:50:0) after 1m0s
[08:39:25.488] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:50:0)
[08:39:25.488] Timer tick, asking Buildbucket for the build status
[08:39:25.641] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:25.641] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:51:0) after 1m0s
[08:40:25.672] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:51:0)
[08:40:25.672] Timer tick, asking Buildbucket for the build status
[08:40:25.743] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:25.743] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:52:0) after 1m0s
[08:41:25.766] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:52:0)
[08:41:25.766] Timer tick, asking Buildbucket for the build status
[08:41:25.929] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:25.929] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:53:0) after 1m0s
[08:42:25.974] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:53:0)
[08:42:25.974] Timer tick, asking Buildbucket for the build status
[08:42:26.039] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:26.039] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:54:0) after 1m0s
[08:43:26.062] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:54:0)
[08:43:26.062] Timer tick, asking Buildbucket for the build status
[08:43:26.133] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:26.133] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:55:0) after 1m0s
[08:44:26.169] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:55:0)
[08:44:26.169] Timer tick, asking Buildbucket for the build status
[08:44:26.261] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:26.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:56:0) after 1m0s
[08:45:26.359] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:56:0)
[08:45:26.359] Timer tick, asking Buildbucket for the build status
[08:45:26.430] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:26.430] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:57:0) after 1m0s
[08:46:26.472] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:57:0)
[08:46:26.472] Timer tick, asking Buildbucket for the build status
[08:46:26.605] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:26.605] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:58:0) after 1m0s
[08:47:26.669] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:58:0)
[08:47:26.669] Timer tick, asking Buildbucket for the build status
[08:47:26.738] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:26.738] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:59:0) after 1m0s
[08:48:26.806] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:59:0)
[08:48:26.806] Timer tick, asking Buildbucket for the build status
[08:48:26.921] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:26.921] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:60:0) after 1m0s
[08:49:26.957] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:60:0)
[08:49:26.957] Timer tick, asking Buildbucket for the build status
[08:49:27.027] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:27.027] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:61:0) after 1m0s
[08:50:27.048] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:61:0)
[08:50:27.048] Timer tick, asking Buildbucket for the build status
[08:50:27.125] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:27.125] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:62:0) after 1m0s
[08:51:27.205] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:62:0)
[08:51:27.205] Timer tick, asking Buildbucket for the build status
[08:51:27.281] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:27.281] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:63:0) after 1m0s
[08:52:27.367] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:63:0)
[08:52:27.367] Timer tick, asking Buildbucket for the build status
[08:52:27.533] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:27.533] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:64:0) after 1m0s
[08:53:27.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:64:0)
[08:53:27.597] Timer tick, asking Buildbucket for the build status
[08:53:27.662] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:27.662] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:65:0) after 1m0s
[08:54:27.681] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:65:0)
[08:54:27.681] Timer tick, asking Buildbucket for the build status
[08:54:27.755] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:27.755] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:66:0) after 1m0s
[08:55:27.802] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:66:0)
[08:55:27.802] Timer tick, asking Buildbucket for the build status
[08:55:27.878] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:27.878] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:67:0) after 1m0s
[08:56:27.958] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:67:0)
[08:56:27.958] Timer tick, asking Buildbucket for the build status
[08:56:28.032] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:28.032] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:68:0) after 1m0s
[08:57:28.173] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:68:0)
[08:57:28.173] Timer tick, asking Buildbucket for the build status
[08:57:28.260] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:28.260] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:69:0) after 1m0s
[08:58:28.285] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:69:0)
[08:58:28.285] Timer tick, asking Buildbucket for the build status
[08:58:28.347] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:28.347] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:70:0) after 1m0s
[08:59:28.371] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:70:0)
[08:59:28.371] Timer tick, asking Buildbucket for the build status
[08:59:28.451] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:28.451] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:71:0) after 1m0s
[09:00:28.477] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:71:0)
[09:00:28.477] Timer tick, asking Buildbucket for the build status
[09:00:28.616] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:28.616] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:72:0) after 1m0s
[09:01:28.689] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:72:0)
[09:01:28.689] Timer tick, asking Buildbucket for the build status
[09:01:28.766] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:01:28.766] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:73:0) after 1m0s
[09:02:28.801] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:73:0)
[09:02:28.801] Timer tick, asking Buildbucket for the build status
[09:02:28.886] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:02:28.886] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:74:0) after 1m0s
[09:03:28.971] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:74:0)
[09:03:28.971] Timer tick, asking Buildbucket for the build status
[09:03:29.049] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:03:29.049] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:75:0) after 1m0s
[09:04:29.161] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:75:0)
[09:04:29.161] Timer tick, asking Buildbucket for the build status
[09:04:29.272] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:29.272] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:76:0) after 1m0s
[09:05:29.316] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:76:0)
[09:05:29.316] Timer tick, asking Buildbucket for the build status
[09:05:29.406] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:29.406] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:77:0) after 1m0s
[09:06:29.501] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:77:0)
[09:06:29.501] Timer tick, asking Buildbucket for the build status
[09:06:29.646] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:29.646] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:78:0) after 1m0s
[09:07:29.669] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:78:0)
[09:07:29.669] Timer tick, asking Buildbucket for the build status
[09:07:29.814] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:29.814] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:79:0) after 1m0s
[09:08:29.874] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:79:0)
[09:08:29.874] Timer tick, asking Buildbucket for the build status
[09:08:29.948] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:29.948] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:80:0) after 1m0s
[09:09:30.060] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:80:0)
[09:09:30.060] Timer tick, asking Buildbucket for the build status
[09:09:30.144] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:30.144] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:81:0) after 1m0s
[09:10:30.205] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:81:0)
[09:10:30.205] Timer tick, asking Buildbucket for the build status
[09:10:30.278] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:30.278] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:82:0) after 1m0s
[09:11:30.312] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:82:0)
[09:11:30.312] Timer tick, asking Buildbucket for the build status
[09:11:30.397] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:30.397] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:83:0) after 1m0s
[09:12:30.422] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:83:0)
[09:12:30.422] Timer tick, asking Buildbucket for the build status
[09:12:30.498] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:30.499] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:84:0) after 1m0s
[09:13:30.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:84:0)
[09:13:30.605] Timer tick, asking Buildbucket for the build status
[09:13:30.688] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:30.688] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:85:0) after 1m0s
[09:14:30.726] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:85:0)
[09:14:30.726] Timer tick, asking Buildbucket for the build status
[09:14:30.801] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:30.801] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:86:0) after 1m0s
[09:15:30.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:86:0)
[09:15:30.890] Timer tick, asking Buildbucket for the build status
[09:15:30.968] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:30.968] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:87:0) after 1m0s
[09:16:31.059] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:87:0)
[09:16:31.059] Timer tick, asking Buildbucket for the build status
[09:16:31.143] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:31.143] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:88:0) after 1m0s
[09:17:31.204] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:88:0)
[09:17:31.204] Timer tick, asking Buildbucket for the build status
[09:17:31.269] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:31.269] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:89:0) after 1m0s
[09:18:31.304] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:89:0)
[09:18:31.304] Timer tick, asking Buildbucket for the build status
[09:18:31.382] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:31.382] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:90:0) after 1m0s
[09:19:31.412] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:90:0)
[09:19:31.412] Timer tick, asking Buildbucket for the build status
[09:19:31.523] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:31.523] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:91:0) after 1m0s
[09:20:31.544] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:91:0)
[09:20:31.544] Timer tick, asking Buildbucket for the build status
[09:20:31.608] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:31.608] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:92:0) after 1m0s
[09:21:31.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:92:0)
[09:21:31.707] Timer tick, asking Buildbucket for the build status
[09:21:31.835] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:31.835] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:93:0) after 1m0s
[09:22:31.859] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:93:0)
[09:22:31.859] Timer tick, asking Buildbucket for the build status
[09:22:31.944] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:31.944] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:94:0) after 1m0s
[09:23:31.972] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:94:0)
[09:23:31.972] Timer tick, asking Buildbucket for the build status
[09:23:32.042] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:32.042] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:95:0) after 1m0s
[09:24:32.104] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:95:0)
[09:24:32.104] Timer tick, asking Buildbucket for the build status
[09:24:32.185] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:32.185] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:96:0) after 1m0s
[09:25:32.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:96:0)
[09:25:32.298] Timer tick, asking Buildbucket for the build status
[09:25:32.372] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:32.372] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:97:0) after 1m0s
[09:26:32.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:97:0)
[09:26:32.397] Timer tick, asking Buildbucket for the build status
[09:26:32.475] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:32.475] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:98:0) after 1m0s
[09:27:32.557] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:98:0)
[09:27:32.557] Timer tick, asking Buildbucket for the build status
[09:27:32.626] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:32.626] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:99:0) after 1m0s
[09:28:32.666] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:99:0)
[09:28:32.666] Timer tick, asking Buildbucket for the build status
[09:28:32.766] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:32.766] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:100:0) after 1m0s
[09:29:32.859] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:100:0)
[09:29:32.859] Timer tick, asking Buildbucket for the build status
[09:29:32.967] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:32.967] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:101:0) after 1m0s
[09:30:32.996] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:101:0)
[09:30:32.996] Timer tick, asking Buildbucket for the build status
[09:30:33.120] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:33.120] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:102:0) after 1m0s
[09:31:33.187] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:102:0)
[09:31:33.187] Timer tick, asking Buildbucket for the build status
[09:31:33.268] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:33.268] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:103:0) after 1m0s
[09:32:33.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:103:0)
[09:32:33.372] Timer tick, asking Buildbucket for the build status
[09:32:33.445] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:33.445] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:104:0) after 1m0s
[09:33:33.482] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:104:0)
[09:33:33.482] Timer tick, asking Buildbucket for the build status
[09:33:33.549] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:33.549] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:105:0) after 1m0s
[09:34:33.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:105:0)
[09:34:33.603] Timer tick, asking Buildbucket for the build status
[09:34:33.669] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:33.669] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:106:0) after 1m0s
[09:35:33.770] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:106:0)
[09:35:33.770] Timer tick, asking Buildbucket for the build status
[09:35:33.925] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:33.925] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:107:0) after 1m0s
[09:36:34.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:107:0)
[09:36:34.001] Timer tick, asking Buildbucket for the build status
[09:36:34.073] Build 8858236674146719280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:34.073] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:108:0) after 1m0s
[09:36:45.070] Received PubSub notification, asking Buildbucket for the build status
[09:36:45.147] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:34.097] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:108:0)
[09:37:34.097] Timer tick, asking Buildbucket for the build status
[09:37:34.165] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:34.165] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:110:0) after 1m0s
[09:38:34.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:110:0)
[09:38:34.194] Timer tick, asking Buildbucket for the build status
[09:38:34.365] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:34.365] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:111:0) after 1m0s
[09:39:34.472] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:111:0)
[09:39:34.472] Timer tick, asking Buildbucket for the build status
[09:39:34.547] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:34.547] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:112:0) after 1m0s
[09:40:34.571] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:112:0)
[09:40:34.571] Timer tick, asking Buildbucket for the build status
[09:40:34.755] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:34.755] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:113:0) after 1m0s
[09:41:34.782] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:113:0)
[09:41:34.782] Timer tick, asking Buildbucket for the build status
[09:41:34.856] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:34.856] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:114:0) after 1m0s
[09:42:34.884] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:114:0)
[09:42:34.884] Timer tick, asking Buildbucket for the build status
[09:42:34.963] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:34.963] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:115:0) after 1m0s
[09:43:34.991] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:115:0)
[09:43:34.991] Timer tick, asking Buildbucket for the build status
[09:43:35.098] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:35.098] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:116:0) after 1m0s
[09:44:35.206] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:116:0)
[09:44:35.206] Timer tick, asking Buildbucket for the build status
[09:44:35.321] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:35.321] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:117:0) after 1m0s
[09:45:35.345] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:117:0)
[09:45:35.345] Timer tick, asking Buildbucket for the build status
[09:45:35.419] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:35.419] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:118:0) after 1m0s
[09:46:35.506] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:118:0)
[09:46:35.506] Timer tick, asking Buildbucket for the build status
[09:46:35.585] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:35.585] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:119:0) after 1m0s
[09:47:35.615] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:119:0)
[09:47:35.615] Timer tick, asking Buildbucket for the build status
[09:47:35.752] Build 8858236674146719280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:35.752] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9023666736128708736:120:0) after 1m0s
[09:48:34.016] Received PubSub notification, asking Buildbucket for the build status
[09:48:34.113] Build 8858236674146719280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:48:34.113] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1610531310439475",
"created_by": "project:infra",
"created_ts": "1610524217426031",
"id": "8858236674146719280",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"26febd402c08267fdf61be858d0b6bb33a571d46\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@26febd402c08267fdf61be858d0b6bb33a571d46\", \"title\": \"26febd402c08267fdf61be858d0b6bb33a571d46\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"26febd402c08267fdf61be858d0b6bb33a571d46\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"26febd402c08267fdf61be858d0b6bb33a571d46\", \"got_revision_cp\": \"refs/heads/master@{#37616}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-a75g\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5662-90e54b5\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1610530598802540",
"status": "COMPLETED",
"status_changed_ts": "1610531310747377",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18328",
"builder:infra-continuous-win10-64",
"buildset:commit/git/26febd402c08267fdf61be858d0b6bb33a571d46",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/26febd402c08267fdf61be858d0b6bb33a571d46",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023666736128708736",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8858236674146719280/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:51138ada84ec6d10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1610531310762237",
"url": "https://luci-milo-dev.appspot.com/b/8858236674146719280",
"utcnow_ts": "1610531314104180"
}
}
[09:48:34.113] Invocation finished in 1h58m17.961197058s with status SUCCEEDED