[05:57:54.284] New invocation is queued and will start shortly
[05:57:55.393] Starting the invocation (attempt 1)
[05:57:55.432] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:57:55.435] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[05:57:55.435] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9027931862928103312",
"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\":\"d9c799cede2f26d962e63b0046bd59f337ec47fc\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d9c799cede2f26d962e63b0046bd59f337ec47fc\",\"title\":\"d9c799cede2f26d962e63b0046bd59f337ec47fc\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"d9c799cede2f26d962e63b0046bd59f337ec47fc\"}}",
"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:9027931862928103312",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"gitiles_ref:refs/heads/master"
]
}
[05:57:57.603] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1606456675588706",
"id": "8862501800897116288",
"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\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d9c799cede2f26d962e63b0046bd59f337ec47fc\", \"title\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606456677285696",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18089",
"builder:infra-continuous-win10-64",
"buildset:commit/git/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027931862928103312",
"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/8862501800897116288/+/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": "1606456677286087",
"url": "https://luci-milo-dev.appspot.com/b/8862501800897116288",
"utcnow_ts": "1606456677578513"
}
}
[05:57:57.603] Task URL: https://luci-milo-dev.appspot.com/b/8862501800897116288
[05:57:57.603] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:2:0) after 1m0s
[05:58:57.664] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:2:0)
[05:58:57.664] Timer tick, asking Buildbucket for the build status
[05:58:57.762] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:57.762] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:3:0) after 1m0s
[05:59:57.782] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:3:0)
[05:59:57.782] Timer tick, asking Buildbucket for the build status
[05:59:57.859] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:57.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:4:0) after 1m0s
[06:00:57.876] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:4:0)
[06:00:57.876] Timer tick, asking Buildbucket for the build status
[06:00:57.970] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:57.970] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:5:0) after 1m0s
[06:01:57.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:5:0)
[06:01:57.989] Timer tick, asking Buildbucket for the build status
[06:01:58.101] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:58.101] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:6:0) after 1m0s
[06:02:58.123] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:6:0)
[06:02:58.123] Timer tick, asking Buildbucket for the build status
[06:02:58.211] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:58.211] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:7:0) after 1m0s
[06:03:58.233] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:7:0)
[06:03:58.233] Timer tick, asking Buildbucket for the build status
[06:03:58.360] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:58.360] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:8:0) after 1m0s
[06:04:58.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:8:0)
[06:04:58.447] Timer tick, asking Buildbucket for the build status
[06:04:58.683] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:58.683] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:9:0) after 1m0s
[06:05:58.786] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:9:0)
[06:05:58.786] Timer tick, asking Buildbucket for the build status
[06:05:58.999] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:58.999] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:10:0) after 1m0s
[06:06:59.096] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:10:0)
[06:06:59.096] Timer tick, asking Buildbucket for the build status
[06:06:59.288] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:59.288] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:11:0) after 1m0s
[06:07:59.396] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:11:0)
[06:07:59.396] Timer tick, asking Buildbucket for the build status
[06:07:59.529] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:59.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:12:0) after 1m0s
[06:08:59.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:12:0)
[06:08:59.605] Timer tick, asking Buildbucket for the build status
[06:08:59.728] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:59.728] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:13:0) after 1m0s
[06:09:59.762] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:13:0)
[06:09:59.762] Timer tick, asking Buildbucket for the build status
[06:09:59.930] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:59.930] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:14:0) after 1m0s
[06:10:59.948] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:14:0)
[06:10:59.948] Timer tick, asking Buildbucket for the build status
[06:11:00.214] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:00.214] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:15:0) after 1m0s
[06:12:00.323] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:15:0)
[06:12:00.323] Timer tick, asking Buildbucket for the build status
[06:12:00.493] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:00.493] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:16:0) after 1m0s
[06:13:00.515] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:16:0)
[06:13:00.515] Timer tick, asking Buildbucket for the build status
[06:13:00.883] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:00.883] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:17:0) after 1m0s
[06:14:00.958] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:17:0)
[06:14:00.958] Timer tick, asking Buildbucket for the build status
[06:14:01.048] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:01.048] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:18:0) after 1m0s
[06:15:01.073] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:18:0)
[06:15:01.073] Timer tick, asking Buildbucket for the build status
[06:15:01.289] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:01.289] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:19:0) after 1m0s
[06:16:01.398] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:19:0)
[06:16:01.398] Timer tick, asking Buildbucket for the build status
[06:16:01.530] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:01.530] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:20:0) after 1m0s
[06:17:01.553] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:20:0)
[06:17:01.553] Timer tick, asking Buildbucket for the build status
[06:17:01.667] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:01.667] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:21:0) after 1m0s
[06:18:01.695] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:21:0)
[06:18:01.695] Timer tick, asking Buildbucket for the build status
[06:18:01.832] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:01.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:22:0) after 1m0s
[06:19:01.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:22:0)
[06:19:01.867] Timer tick, asking Buildbucket for the build status
[06:19:02.108] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:02.108] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:23:0) after 1m0s
[06:20:02.228] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:23:0)
[06:20:02.228] Timer tick, asking Buildbucket for the build status
[06:20:02.306] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:02.306] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:24:0) after 1m0s
[06:21:02.350] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:24:0)
[06:21:02.350] Timer tick, asking Buildbucket for the build status
[06:21:02.431] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:02.431] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:25:0) after 1m0s
[06:23:05.757] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:25:0)
[06:23:05.757] Timer tick, asking Buildbucket for the build status
[06:23:06.091] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:06.091] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:26:0) after 1m0s
[06:24:06.394] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:26:0)
[06:24:06.394] Timer tick, asking Buildbucket for the build status
[06:24:06.479] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:06.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:27:0) after 1m0s
[06:25:06.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:27:0)
[06:25:06.809] Timer tick, asking Buildbucket for the build status
[06:25:07.401] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:07.401] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:28:0) after 1m0s
[06:26:07.783] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:28:0)
[06:26:07.783] Timer tick, asking Buildbucket for the build status
[06:26:08.316] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:08.316] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:29:0) after 1m0s
[06:27:08.640] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:29:0)
[06:27:08.640] Timer tick, asking Buildbucket for the build status
[06:27:09.235] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:27:09.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:30:0) after 1m0s
[06:28:09.453] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:30:0)
[06:28:09.453] Timer tick, asking Buildbucket for the build status
[06:28:09.532] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:28:09.532] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:31:0) after 1m0s
[06:29:09.689] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:31:0)
[06:29:09.689] Timer tick, asking Buildbucket for the build status
[06:29:10.099] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:29:10.099] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:32:0) after 1m0s
[06:30:10.387] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:32:0)
[06:30:10.387] Timer tick, asking Buildbucket for the build status
[06:30:10.563] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:30:10.564] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:33:0) after 1m0s
[06:31:10.775] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:33:0)
[06:31:10.775] Timer tick, asking Buildbucket for the build status
[06:31:11.224] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:31:11.224] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:34:0) after 1m0s
[06:32:11.386] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:34:0)
[06:32:11.386] Timer tick, asking Buildbucket for the build status
[06:32:11.934] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:32:11.934] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:35:0) after 1m0s
[06:33:12.141] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:35:0)
[06:33:12.141] Timer tick, asking Buildbucket for the build status
[06:33:12.390] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:33:12.390] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:36:0) after 1m0s
[06:34:12.587] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:36:0)
[06:34:12.587] Timer tick, asking Buildbucket for the build status
[06:34:13.083] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:34:13.083] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:37:0) after 1m0s
[06:35:13.215] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:37:0)
[06:35:13.215] Timer tick, asking Buildbucket for the build status
[06:35:13.456] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:35:13.456] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:38:0) after 1m0s
[06:36:13.498] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:38:0)
[06:36:13.498] Timer tick, asking Buildbucket for the build status
[06:36:13.616] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:36:13.616] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:39:0) after 1m0s
[06:37:13.712] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:39:0)
[06:37:13.712] Timer tick, asking Buildbucket for the build status
[06:37:13.800] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:37:13.800] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:40:0) after 1m0s
[06:38:13.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:40:0)
[06:38:13.898] Timer tick, asking Buildbucket for the build status
[06:38:13.979] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:13.979] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:41:0) after 1m0s
[06:39:14.002] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:41:0)
[06:39:14.002] Timer tick, asking Buildbucket for the build status
[06:39:14.138] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:39:14.138] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:42:0) after 1m0s
[06:40:14.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:42:0)
[06:40:14.203] Timer tick, asking Buildbucket for the build status
[06:40:14.271] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:40:14.271] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:43:0) after 1m0s
[06:41:14.295] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:43:0)
[06:41:14.295] Timer tick, asking Buildbucket for the build status
[06:41:14.370] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:41:14.370] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:44:0) after 1m0s
[06:42:14.399] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:44:0)
[06:42:14.399] Timer tick, asking Buildbucket for the build status
[06:42:14.607] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:14.607] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:45:0) after 1m0s
[06:43:14.627] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:45:0)
[06:43:14.627] Timer tick, asking Buildbucket for the build status
[06:43:14.737] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:14.737] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:46:0) after 1m0s
[06:44:14.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:46:0)
[06:44:14.798] Timer tick, asking Buildbucket for the build status
[06:44:14.884] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:14.884] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:47:0) after 1m0s
[06:45:14.918] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:47:0)
[06:45:14.918] Timer tick, asking Buildbucket for the build status
[06:45:14.990] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:14.990] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:48:0) after 1m0s
[06:46:15.109] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:48:0)
[06:46:15.109] Timer tick, asking Buildbucket for the build status
[06:46:15.181] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:15.181] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:49:0) after 1m0s
[06:47:15.309] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:49:0)
[06:47:15.309] Timer tick, asking Buildbucket for the build status
[06:47:15.384] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:15.384] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:50:0) after 1m0s
[06:48:15.487] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:50:0)
[06:48:15.487] Timer tick, asking Buildbucket for the build status
[06:48:15.608] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:15.608] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:51:0) after 1m0s
[06:49:15.687] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:51:0)
[06:49:15.687] Timer tick, asking Buildbucket for the build status
[06:49:15.808] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:15.808] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:52:0) after 1m0s
[06:50:15.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:52:0)
[06:50:15.890] Timer tick, asking Buildbucket for the build status
[06:50:16.018] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:16.018] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:53:0) after 1m0s
[06:51:16.040] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:53:0)
[06:51:16.040] Timer tick, asking Buildbucket for the build status
[06:51:16.242] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:51:16.242] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:54:0) after 1m0s
[06:52:16.306] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:54:0)
[06:52:16.306] Timer tick, asking Buildbucket for the build status
[06:52:16.372] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:52:16.372] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:55:0) after 1m0s
[06:53:16.396] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:55:0)
[06:53:16.396] Timer tick, asking Buildbucket for the build status
[06:53:16.477] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:16.477] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:56:0) after 1m0s
[06:54:16.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:56:0)
[06:54:16.504] Timer tick, asking Buildbucket for the build status
[06:54:16.581] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:16.581] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:57:0) after 1m0s
[06:55:16.686] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:57:0)
[06:55:16.686] Timer tick, asking Buildbucket for the build status
[06:55:16.886] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:16.886] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:58:0) after 1m0s
[06:56:17.003] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:58:0)
[06:56:17.003] Timer tick, asking Buildbucket for the build status
[06:56:17.087] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:17.087] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:59:0) after 1m0s
[06:57:17.112] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:59:0)
[06:57:17.112] Timer tick, asking Buildbucket for the build status
[06:57:17.195] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:17.195] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:60:0) after 1m0s
[06:58:17.303] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:60:0)
[06:58:17.303] Timer tick, asking Buildbucket for the build status
[06:58:17.454] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:17.454] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:61:0) after 1m0s
[06:59:17.499] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:61:0)
[06:59:17.499] Timer tick, asking Buildbucket for the build status
[06:59:17.604] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:17.604] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:62:0) after 1m0s
[07:00:17.646] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:62:0)
[07:00:17.646] Timer tick, asking Buildbucket for the build status
[07:00:17.751] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:17.751] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:63:0) after 1m0s
[07:01:17.786] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:63:0)
[07:01:17.786] Timer tick, asking Buildbucket for the build status
[07:01:17.874] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:17.874] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:64:0) after 1m0s
[07:02:17.893] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:64:0)
[07:02:17.893] Timer tick, asking Buildbucket for the build status
[07:02:17.991] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:17.991] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:65:0) after 1m0s
[07:03:18.103] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:65:0)
[07:03:18.103] Timer tick, asking Buildbucket for the build status
[07:03:18.267] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:18.267] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:66:0) after 1m0s
[07:04:18.291] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:66:0)
[07:04:18.291] Timer tick, asking Buildbucket for the build status
[07:04:18.375] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:18.375] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:67:0) after 1m0s
[07:05:18.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:67:0)
[07:05:18.447] Timer tick, asking Buildbucket for the build status
[07:05:18.547] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:18.547] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:68:0) after 1m0s
[07:06:18.595] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:68:0)
[07:06:18.595] Timer tick, asking Buildbucket for the build status
[07:06:18.746] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:18.746] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:69:0) after 1m0s
[07:07:18.773] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:69:0)
[07:07:18.773] Timer tick, asking Buildbucket for the build status
[07:07:18.894] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:18.894] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:70:0) after 1m0s
[07:08:18.946] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:70:0)
[07:08:18.946] Timer tick, asking Buildbucket for the build status
[07:08:19.078] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:19.078] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:71:0) after 1m0s
[07:09:19.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:71:0)
[07:09:19.106] Timer tick, asking Buildbucket for the build status
[07:09:19.256] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:19.256] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:72:0) after 1m0s
[07:10:19.280] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:72:0)
[07:10:19.280] Timer tick, asking Buildbucket for the build status
[07:10:19.400] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:19.400] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:73:0) after 1m0s
[07:11:19.427] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:73:0)
[07:11:19.427] Timer tick, asking Buildbucket for the build status
[07:11:19.537] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:19.537] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:74:0) after 1m0s
[07:12:19.631] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:74:0)
[07:12:19.631] Timer tick, asking Buildbucket for the build status
[07:12:19.707] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:19.707] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:75:0) after 1m0s
[07:13:19.859] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:75:0)
[07:13:19.859] Timer tick, asking Buildbucket for the build status
[07:13:19.983] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:19.983] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:76:0) after 1m0s
[07:14:20.062] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:76:0)
[07:14:20.062] Timer tick, asking Buildbucket for the build status
[07:14:20.261] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:20.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:77:0) after 1m0s
[07:15:20.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:77:0)
[07:15:20.447] Timer tick, asking Buildbucket for the build status
[07:15:20.527] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:20.527] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:78:0) after 1m0s
[07:16:20.601] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:78:0)
[07:16:20.601] Timer tick, asking Buildbucket for the build status
[07:16:20.711] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:20.711] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:79:0) after 1m0s
[07:17:20.949] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:79:0)
[07:17:20.949] Timer tick, asking Buildbucket for the build status
[07:17:21.058] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:21.058] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:80:0) after 1m0s
[07:18:21.132] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:80:0)
[07:18:21.132] Timer tick, asking Buildbucket for the build status
[07:18:21.516] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:21.516] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:81:0) after 1m0s
[07:19:21.711] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:81:0)
[07:19:21.711] Timer tick, asking Buildbucket for the build status
[07:19:21.930] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:21.930] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:82:0) after 1m0s
[07:20:22.093] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:82:0)
[07:20:22.093] Timer tick, asking Buildbucket for the build status
[07:20:22.343] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:22.343] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:83:0) after 1m0s
[07:21:22.401] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:83:0)
[07:21:22.401] Timer tick, asking Buildbucket for the build status
[07:21:22.493] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:22.493] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:84:0) after 1m0s
[07:22:22.517] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:84:0)
[07:22:22.517] Timer tick, asking Buildbucket for the build status
[07:22:22.796] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:22.796] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:85:0) after 1m0s
[07:23:23.013] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:85:0)
[07:23:23.013] Timer tick, asking Buildbucket for the build status
[07:23:23.311] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:23.311] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:86:0) after 1m0s
[07:24:23.338] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:86:0)
[07:24:23.338] Timer tick, asking Buildbucket for the build status
[07:24:23.545] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:23.545] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:87:0) after 1m0s
[07:25:23.594] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:87:0)
[07:25:23.594] Timer tick, asking Buildbucket for the build status
[07:25:23.859] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:23.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:88:0) after 1m0s
[07:26:23.937] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:88:0)
[07:26:23.937] Timer tick, asking Buildbucket for the build status
[07:26:24.184] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:24.184] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:89:0) after 1m0s
[07:27:24.211] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:89:0)
[07:27:24.211] Timer tick, asking Buildbucket for the build status
[07:27:24.340] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:24.340] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:90:0) after 1m0s
[07:28:24.371] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:90:0)
[07:28:24.371] Timer tick, asking Buildbucket for the build status
[07:28:24.502] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:24.502] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:91:0) after 1m0s
[07:29:24.609] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:91:0)
[07:29:24.609] Timer tick, asking Buildbucket for the build status
[07:29:25.001] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:25.001] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:92:0) after 1m0s
[07:30:25.123] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:92:0)
[07:30:25.123] Timer tick, asking Buildbucket for the build status
[07:30:25.212] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:25.212] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:93:0) after 1m0s
[07:31:25.274] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:93:0)
[07:31:25.274] Timer tick, asking Buildbucket for the build status
[07:31:25.389] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:25.389] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:94:0) after 1m0s
[07:32:25.513] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:94:0)
[07:32:25.513] Timer tick, asking Buildbucket for the build status
[07:32:25.650] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:25.650] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:95:0) after 1m0s
[07:33:25.738] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:95:0)
[07:33:25.738] Timer tick, asking Buildbucket for the build status
[07:33:25.995] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:25.995] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:96:0) after 1m0s
[07:34:26.098] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:96:0)
[07:34:26.098] Timer tick, asking Buildbucket for the build status
[07:34:26.340] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:26.340] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:97:0) after 1m0s
[07:35:26.365] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:97:0)
[07:35:26.365] Timer tick, asking Buildbucket for the build status
[07:35:26.529] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:26.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:98:0) after 1m0s
[07:36:26.646] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:98:0)
[07:36:26.646] Timer tick, asking Buildbucket for the build status
[07:36:26.740] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:26.740] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:99:0) after 1m0s
[07:37:26.933] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:99:0)
[07:37:26.933] Timer tick, asking Buildbucket for the build status
[07:37:27.026] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:27.026] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:100:0) after 1m0s
[07:38:27.049] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:100:0)
[07:38:27.049] Timer tick, asking Buildbucket for the build status
[07:38:27.208] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:38:27.208] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:101:0) after 1m0s
[07:39:27.293] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:101:0)
[07:39:27.294] Timer tick, asking Buildbucket for the build status
[07:39:27.533] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:39:27.533] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:102:0) after 1m0s
[07:40:27.607] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:102:0)
[07:40:27.607] Timer tick, asking Buildbucket for the build status
[07:40:27.835] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:40:27.835] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:103:0) after 1m0s
[07:41:27.914] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:103:0)
[07:41:27.914] Timer tick, asking Buildbucket for the build status
[07:41:28.058] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:28.058] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:104:0) after 1m0s
[07:42:28.089] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:104:0)
[07:42:28.089] Timer tick, asking Buildbucket for the build status
[07:42:28.200] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:28.200] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:105:0) after 1m0s
[07:43:28.237] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:105:0)
[07:43:28.237] Timer tick, asking Buildbucket for the build status
[07:43:28.334] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:28.334] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:106:0) after 1m0s
[07:44:28.366] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:106:0)
[07:44:28.366] Timer tick, asking Buildbucket for the build status
[07:44:28.524] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:28.524] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:107:0) after 1m0s
[07:45:28.622] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:107:0)
[07:45:28.622] Timer tick, asking Buildbucket for the build status
[07:45:28.793] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:28.793] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:108:0) after 1m0s
[07:46:28.912] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:108:0)
[07:46:28.912] Timer tick, asking Buildbucket for the build status
[07:46:29.021] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:29.021] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:109:0) after 1m0s
[07:47:29.146] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:109:0)
[07:47:29.146] Timer tick, asking Buildbucket for the build status
[07:47:29.248] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:29.248] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:110:0) after 1m0s
[07:48:29.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:110:0)
[07:48:29.369] Timer tick, asking Buildbucket for the build status
[07:48:29.493] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:29.493] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:111:0) after 1m0s
[07:49:29.527] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:111:0)
[07:49:29.527] Timer tick, asking Buildbucket for the build status
[07:49:29.617] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:49:29.617] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:112:0) after 1m0s
[07:50:29.737] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:112:0)
[07:50:29.737] Timer tick, asking Buildbucket for the build status
[07:50:29.858] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:50:29.858] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:113:0) after 1m0s
[07:51:29.942] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:113:0)
[07:51:29.942] Timer tick, asking Buildbucket for the build status
[07:51:30.083] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:30.083] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:114:0) after 1m0s
[07:52:30.136] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:114:0)
[07:52:30.136] Timer tick, asking Buildbucket for the build status
[07:52:30.367] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:30.367] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:115:0) after 1m0s
[07:53:30.494] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:115:0)
[07:53:30.494] Timer tick, asking Buildbucket for the build status
[07:53:30.918] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:30.918] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:116:0) after 1m0s
[07:54:31.011] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:116:0)
[07:54:31.011] Timer tick, asking Buildbucket for the build status
[07:54:31.092] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:31.092] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:117:0) after 1m0s
[07:55:31.198] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:117:0)
[07:55:31.198] Timer tick, asking Buildbucket for the build status
[07:55:31.268] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:31.269] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:118:0) after 1m0s
[07:56:31.380] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:118:0)
[07:56:31.380] Timer tick, asking Buildbucket for the build status
[07:56:31.468] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:31.468] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:119:0) after 1m0s
[07:57:31.559] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:119:0)
[07:57:31.559] Timer tick, asking Buildbucket for the build status
[07:57:31.654] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:31.654] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:120:0) after 1m0s
[07:58:31.734] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:120:0)
[07:58:31.734] Timer tick, asking Buildbucket for the build status
[07:58:31.923] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:31.923] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:121:0) after 1m0s
[07:59:32.135] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:121:0)
[07:59:32.135] Timer tick, asking Buildbucket for the build status
[07:59:32.241] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:32.241] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:122:0) after 1m0s
[08:00:32.305] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:122:0)
[08:00:32.305] Timer tick, asking Buildbucket for the build status
[08:00:32.482] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:32.482] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:123:0) after 1m0s
[08:01:32.514] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:123:0)
[08:01:32.514] Timer tick, asking Buildbucket for the build status
[08:01:32.613] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:01:32.613] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:124:0) after 1m0s
[08:02:32.690] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:124:0)
[08:02:32.690] Timer tick, asking Buildbucket for the build status
[08:02:32.863] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:02:32.863] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:125:0) after 1m0s
[08:03:33.044] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:125:0)
[08:03:33.044] Timer tick, asking Buildbucket for the build status
[08:03:33.141] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:03:33.141] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:126:0) after 1m0s
[08:04:33.171] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:126:0)
[08:04:33.171] Timer tick, asking Buildbucket for the build status
[08:04:33.273] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:33.273] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:127:0) after 1m0s
[08:05:33.396] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:127:0)
[08:05:33.396] Timer tick, asking Buildbucket for the build status
[08:05:33.559] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:33.559] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:128:0) after 1m0s
[08:06:33.589] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:128:0)
[08:06:33.589] Timer tick, asking Buildbucket for the build status
[08:06:33.702] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:33.702] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:129:0) after 1m0s
[08:07:33.751] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:129:0)
[08:07:33.751] Timer tick, asking Buildbucket for the build status
[08:07:33.873] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:33.873] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:130:0) after 1m0s
[08:08:33.936] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:130:0)
[08:08:33.936] Timer tick, asking Buildbucket for the build status
[08:08:34.023] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:34.023] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:131:0) after 1m0s
[08:09:34.108] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:131:0)
[08:09:34.108] Timer tick, asking Buildbucket for the build status
[08:09:34.314] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:34.314] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:132:0) after 1m0s
[08:10:34.337] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:132:0)
[08:10:34.337] Timer tick, asking Buildbucket for the build status
[08:10:34.472] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:34.472] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:133:0) after 1m0s
[08:11:34.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:133:0)
[08:11:34.512] Timer tick, asking Buildbucket for the build status
[08:11:34.624] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:34.624] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:134:0) after 1m0s
[08:12:34.662] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:134:0)
[08:12:34.662] Timer tick, asking Buildbucket for the build status
[08:12:34.840] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:34.840] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:135:0) after 1m0s
[08:13:34.874] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:135:0)
[08:13:34.874] Timer tick, asking Buildbucket for the build status
[08:13:35.046] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:35.046] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:136:0) after 1m0s
[08:14:35.099] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:136:0)
[08:14:35.099] Timer tick, asking Buildbucket for the build status
[08:14:35.282] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:35.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:137:0) after 1m0s
[08:15:35.417] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:137:0)
[08:15:35.417] Timer tick, asking Buildbucket for the build status
[08:15:35.500] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:35.500] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:138:0) after 1m0s
[08:16:35.671] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:138:0)
[08:16:35.671] Timer tick, asking Buildbucket for the build status
[08:16:35.840] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:35.840] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:139:0) after 1m0s
[08:17:35.876] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:139:0)
[08:17:35.876] Timer tick, asking Buildbucket for the build status
[08:17:36.069] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:36.069] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:140:0) after 1m0s
[08:18:36.121] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:140:0)
[08:18:36.121] Timer tick, asking Buildbucket for the build status
[08:18:36.247] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:36.247] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:141:0) after 1m0s
[08:19:36.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:141:0)
[08:19:36.298] Timer tick, asking Buildbucket for the build status
[08:19:36.425] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:36.425] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:142:0) after 1m0s
[08:20:36.456] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:142:0)
[08:20:36.456] Timer tick, asking Buildbucket for the build status
[08:20:36.658] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:36.658] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:143:0) after 1m0s
[08:21:36.756] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:143:0)
[08:21:36.756] Timer tick, asking Buildbucket for the build status
[08:21:36.862] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:36.862] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:144:0) after 1m0s
[08:22:36.969] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:144:0)
[08:22:36.969] Timer tick, asking Buildbucket for the build status
[08:22:37.215] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:37.215] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:145:0) after 1m0s
[08:23:37.256] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:145:0)
[08:23:37.256] Timer tick, asking Buildbucket for the build status
[08:23:37.370] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:37.370] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:146:0) after 1m0s
[08:24:37.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:146:0)
[08:24:37.464] Timer tick, asking Buildbucket for the build status
[08:24:37.567] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:37.567] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:147:0) after 1m0s
[08:25:37.606] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:147:0)
[08:25:37.606] Timer tick, asking Buildbucket for the build status
[08:25:37.715] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:37.715] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:148:0) after 1m0s
[08:26:37.764] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:148:0)
[08:26:37.764] Timer tick, asking Buildbucket for the build status
[08:26:37.856] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:37.856] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:149:0) after 1m0s
[08:27:37.897] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:149:0)
[08:27:37.897] Timer tick, asking Buildbucket for the build status
[08:27:38.085] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:38.085] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:150:0) after 1m0s
[08:28:38.114] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:150:0)
[08:28:38.114] Timer tick, asking Buildbucket for the build status
[08:28:38.303] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:38.303] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:151:0) after 1m0s
[08:29:38.400] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:151:0)
[08:29:38.400] Timer tick, asking Buildbucket for the build status
[08:29:38.541] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:38.541] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:152:0) after 1m0s
[08:30:38.598] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:152:0)
[08:30:38.598] Timer tick, asking Buildbucket for the build status
[08:30:38.801] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:38.801] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:153:0) after 1m0s
[08:31:38.907] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:153:0)
[08:31:38.907] Timer tick, asking Buildbucket for the build status
[08:31:39.012] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:39.012] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:154:0) after 1m0s
[08:32:39.098] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:154:0)
[08:32:39.098] Timer tick, asking Buildbucket for the build status
[08:32:39.329] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:39.329] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:155:0) after 1m0s
[08:33:39.359] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:155:0)
[08:33:39.359] Timer tick, asking Buildbucket for the build status
[08:33:39.479] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:39.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:156:0) after 1m0s
[08:34:39.565] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:156:0)
[08:34:39.565] Timer tick, asking Buildbucket for the build status
[08:34:39.682] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:39.682] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:157:0) after 1m0s
[08:35:39.712] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:157:0)
[08:35:39.712] Timer tick, asking Buildbucket for the build status
[08:35:39.858] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:39.858] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:158:0) after 1m0s
[08:36:39.975] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:158:0)
[08:36:39.975] Timer tick, asking Buildbucket for the build status
[08:36:40.138] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:40.138] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:159:0) after 1m0s
[08:37:40.235] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:159:0)
[08:37:40.235] Timer tick, asking Buildbucket for the build status
[08:37:40.322] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:40.322] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:160:0) after 1m0s
[08:38:40.424] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:160:0)
[08:38:40.424] Timer tick, asking Buildbucket for the build status
[08:38:40.545] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:40.545] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:161:0) after 1m0s
[08:39:40.651] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:161:0)
[08:39:40.651] Timer tick, asking Buildbucket for the build status
[08:39:40.790] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:40.790] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:162:0) after 1m0s
[08:40:40.958] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:162:0)
[08:40:40.958] Timer tick, asking Buildbucket for the build status
[08:40:41.093] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:41.093] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:163:0) after 1m0s
[08:41:41.124] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:163:0)
[08:41:41.124] Timer tick, asking Buildbucket for the build status
[08:41:41.231] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:41.231] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:164:0) after 1m0s
[08:42:41.264] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:164:0)
[08:42:41.264] Timer tick, asking Buildbucket for the build status
[08:42:41.341] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:41.341] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:165:0) after 1m0s
[08:43:41.408] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:165:0)
[08:43:41.408] Timer tick, asking Buildbucket for the build status
[08:43:41.486] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:41.486] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:166:0) after 1m0s
[08:44:41.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:166:0)
[08:44:41.603] Timer tick, asking Buildbucket for the build status
[08:44:41.732] Build 8862501800897116288: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:41.732] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:167:0) after 1m0s
[08:44:56.868] Received PubSub notification, asking Buildbucket for the build status
[08:44:57.009] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:41.768] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:167:0)
[08:45:41.768] Timer tick, asking Buildbucket for the build status
[08:45:42.104] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:42.104] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:169:0) after 1m0s
[08:46:42.207] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:169:0)
[08:46:42.207] Timer tick, asking Buildbucket for the build status
[08:46:42.339] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:42.339] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:170:0) after 1m0s
[08:47:42.496] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:170:0)
[08:47:42.496] Timer tick, asking Buildbucket for the build status
[08:47:42.587] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:42.587] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:171:0) after 1m0s
[08:48:42.675] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:171:0)
[08:48:42.675] Timer tick, asking Buildbucket for the build status
[08:48:42.749] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:42.749] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:172:0) after 1m0s
[08:49:42.857] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:172:0)
[08:49:42.857] Timer tick, asking Buildbucket for the build status
[08:49:43.009] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:43.009] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:173:0) after 1m0s
[08:50:43.071] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:173:0)
[08:50:43.071] Timer tick, asking Buildbucket for the build status
[08:50:43.197] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:43.197] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:174:0) after 1m0s
[08:51:43.313] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:174:0)
[08:51:43.313] Timer tick, asking Buildbucket for the build status
[08:51:43.506] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:43.506] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:175:0) after 1m0s
[08:52:43.594] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:175:0)
[08:52:43.594] Timer tick, asking Buildbucket for the build status
[08:52:43.808] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:43.808] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:176:0) after 1m0s
[08:53:43.835] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:176:0)
[08:53:43.835] Timer tick, asking Buildbucket for the build status
[08:53:43.994] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:43.994] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:177:0) after 1m0s
[08:54:44.098] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:177:0)
[08:54:44.098] Timer tick, asking Buildbucket for the build status
[08:54:44.235] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:44.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:178:0) after 1m0s
[08:55:44.261] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:178:0)
[08:55:44.261] Timer tick, asking Buildbucket for the build status
[08:55:44.336] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:44.336] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:179:0) after 1m0s
[08:56:44.395] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:179:0)
[08:56:44.395] Timer tick, asking Buildbucket for the build status
[08:56:44.498] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:44.498] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:180:0) after 1m0s
[08:57:44.535] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:180:0)
[08:57:44.535] Timer tick, asking Buildbucket for the build status
[08:57:44.615] Build 8862501800897116288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:44.615] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027931862928103312:181:0) after 1m0s
[08:57:57.199] Received PubSub notification, asking Buildbucket for the build status
[08:57:57.284] Build 8862501800897116288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:57:57.284] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1606467474532662",
"created_by": "project:infra",
"created_ts": "1606456675588706",
"id": "8862501800897116288",
"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\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d9c799cede2f26d962e63b0046bd59f337ec47fc\", \"title\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"d9c799cede2f26d962e63b0046bd59f337ec47fc\", \"got_revision_cp\": \"refs/heads/master@{#36747}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_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-16j9\"], \"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\": [\"5644-1d40e7d\"], \"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": "1606466693537099",
"status": "COMPLETED",
"status_changed_ts": "1606467474877823",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18089",
"builder:infra-continuous-win10-64",
"buildset:commit/git/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d9c799cede2f26d962e63b0046bd59f337ec47fc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027931862928103312",
"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/8862501800897116288/+/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:50211923e7eccb10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1606467474890239",
"url": "https://luci-milo-dev.appspot.com/b/8862501800897116288",
"utcnow_ts": "1606467477276922"
}
}
[08:57:57.284] Invocation finished in 3h0m3.016673851s with status SUCCEEDED