[12:24:06.148] New invocation is queued and will start shortly
[12:24:07.241] Starting the invocation (attempt 1)
[12:24:07.333] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[12:24:07.333] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[12:24:07.333] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9027635774575224384",
"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\":\"fcd680108095c2a9aa26c54109180156e143f207\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fcd680108095c2a9aa26c54109180156e143f207\",\"title\":\"fcd680108095c2a9aa26c54109180156e143f207\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"fcd680108095c2a9aa26c54109180156e143f207\"}}",
"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:9027635774575224384",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/fcd680108095c2a9aa26c54109180156e143f207",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207",
"gitiles_ref:refs/heads/master"
]
}
[12:24:07.950] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1606739047423996",
"id": "8862205712567306112",
"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\": \"fcd680108095c2a9aa26c54109180156e143f207\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fcd680108095c2a9aa26c54109180156e143f207\", \"title\": \"fcd680108095c2a9aa26c54109180156e143f207\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"fcd680108095c2a9aa26c54109180156e143f207\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606739047862908",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18097",
"builder:infra-continuous-win10-64",
"buildset:commit/git/fcd680108095c2a9aa26c54109180156e143f207",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027635774575224384",
"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/8862205712567306112/+/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": "1606739047863026",
"url": "https://luci-milo-dev.appspot.com/b/8862205712567306112",
"utcnow_ts": "1606739047942540"
}
}
[12:24:07.950] Task URL: https://luci-milo-dev.appspot.com/b/8862205712567306112
[12:24:07.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:2:0) after 1m0s
[12:25:07.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:2:0)
[12:25:07.989] Timer tick, asking Buildbucket for the build status
[12:25:08.076] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:08.076] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:3:0) after 1m0s
[12:26:08.103] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:3:0)
[12:26:08.103] Timer tick, asking Buildbucket for the build status
[12:26:08.211] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:26:08.211] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:4:0) after 1m0s
[12:27:08.236] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:4:0)
[12:27:08.236] Timer tick, asking Buildbucket for the build status
[12:27:08.318] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:27:08.318] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:5:0) after 1m0s
[12:28:08.394] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:5:0)
[12:28:08.394] Timer tick, asking Buildbucket for the build status
[12:28:08.505] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:28:08.505] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:6:0) after 1m0s
[12:29:08.526] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:6:0)
[12:29:08.526] Timer tick, asking Buildbucket for the build status
[12:29:08.692] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:29:08.692] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:7:0) after 1m0s
[12:30:08.744] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:7:0)
[12:30:08.744] Timer tick, asking Buildbucket for the build status
[12:30:08.831] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:30:08.831] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:8:0) after 1m0s
[12:31:08.855] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:8:0)
[12:31:08.855] Timer tick, asking Buildbucket for the build status
[12:31:08.939] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:31:08.939] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:9:0) after 1m0s
[12:32:09.023] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:9:0)
[12:32:09.023] Timer tick, asking Buildbucket for the build status
[12:32:09.169] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:32:09.169] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:10:0) after 1m0s
[12:33:09.189] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:10:0)
[12:33:09.189] Timer tick, asking Buildbucket for the build status
[12:33:09.281] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:33:09.281] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:11:0) after 1m0s
[12:34:09.401] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:11:0)
[12:34:09.401] Timer tick, asking Buildbucket for the build status
[12:34:09.600] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:34:09.600] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:12:0) after 1m0s
[12:35:09.626] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:12:0)
[12:35:09.626] Timer tick, asking Buildbucket for the build status
[12:35:09.705] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:35:09.705] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:13:0) after 1m0s
[12:36:09.788] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:13:0)
[12:36:09.788] Timer tick, asking Buildbucket for the build status
[12:36:09.864] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:36:09.864] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:14:0) after 1m0s
[12:37:09.886] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:14:0)
[12:37:09.886] Timer tick, asking Buildbucket for the build status
[12:37:09.983] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:37:09.983] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:15:0) after 1m0s
[12:38:10.100] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:15:0)
[12:38:10.100] Timer tick, asking Buildbucket for the build status
[12:38:10.261] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:10.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:16:0) after 1m0s
[12:39:10.414] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:16:0)
[12:39:10.414] Timer tick, asking Buildbucket for the build status
[12:39:10.487] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:10.487] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:17:0) after 1m0s
[12:40:10.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:17:0)
[12:40:10.605] Timer tick, asking Buildbucket for the build status
[12:40:10.685] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:10.685] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:18:0) after 1m0s
[12:41:10.817] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:18:0)
[12:41:10.817] Timer tick, asking Buildbucket for the build status
[12:41:10.915] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:10.915] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:19:0) after 1m0s
[12:42:11.012] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:19:0)
[12:42:11.012] Timer tick, asking Buildbucket for the build status
[12:42:11.105] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:11.105] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:20:0) after 1m0s
[12:43:11.192] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:20:0)
[12:43:11.192] Timer tick, asking Buildbucket for the build status
[12:43:11.366] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:11.366] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:21:0) after 1m0s
[12:44:11.411] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:21:0)
[12:44:11.411] Timer tick, asking Buildbucket for the build status
[12:44:11.498] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:11.498] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:22:0) after 1m0s
[12:45:11.602] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:22:0)
[12:45:11.602] Timer tick, asking Buildbucket for the build status
[12:45:11.692] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:45:11.692] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:23:0) after 1m0s
[12:46:11.792] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:23:0)
[12:46:11.792] Timer tick, asking Buildbucket for the build status
[12:46:11.891] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:46:11.891] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:24:0) after 1m0s
[12:47:12.007] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:24:0)
[12:47:12.007] Timer tick, asking Buildbucket for the build status
[12:47:12.099] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:47:12.099] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:25:0) after 1m0s
[12:48:12.127] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:25:0)
[12:48:12.127] Timer tick, asking Buildbucket for the build status
[12:48:12.205] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:48:12.205] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:26:0) after 1m0s
[12:49:12.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:26:0)
[12:49:12.307] Timer tick, asking Buildbucket for the build status
[12:49:12.388] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:49:12.388] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:27:0) after 1m0s
[12:50:12.513] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:27:0)
[12:50:12.513] Timer tick, asking Buildbucket for the build status
[12:50:12.605] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:50:12.605] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:28:0) after 1m0s
[12:51:12.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:28:0)
[12:51:12.709] Timer tick, asking Buildbucket for the build status
[12:51:12.850] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:51:12.850] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:29:0) after 1m0s
[12:52:12.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:29:0)
[12:52:12.877] Timer tick, asking Buildbucket for the build status
[12:52:12.957] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:52:12.957] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:30:0) after 1m0s
[12:53:12.984] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:30:0)
[12:53:12.984] Timer tick, asking Buildbucket for the build status
[12:53:13.200] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:53:13.200] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:31:0) after 1m0s
[12:54:13.301] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:31:0)
[12:54:13.301] Timer tick, asking Buildbucket for the build status
[12:54:13.403] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:54:13.403] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:32:0) after 1m0s
[12:55:13.501] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:32:0)
[12:55:13.501] Timer tick, asking Buildbucket for the build status
[12:55:13.670] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:55:13.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:33:0) after 1m0s
[12:56:13.791] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:33:0)
[12:56:13.791] Timer tick, asking Buildbucket for the build status
[12:56:13.881] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:56:13.881] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:34:0) after 1m0s
[12:57:13.903] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:34:0)
[12:57:13.903] Timer tick, asking Buildbucket for the build status
[12:57:14.059] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:57:14.059] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:35:0) after 1m0s
[12:58:14.090] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:35:0)
[12:58:14.090] Timer tick, asking Buildbucket for the build status
[12:58:14.193] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:58:14.193] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:36:0) after 1m0s
[12:59:14.224] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:36:0)
[12:59:14.224] Timer tick, asking Buildbucket for the build status
[12:59:14.301] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:14.301] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:37:0) after 1m0s
[13:00:14.399] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:37:0)
[13:00:14.399] Timer tick, asking Buildbucket for the build status
[13:00:14.564] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:00:14.564] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:38:0) after 1m0s
[13:01:14.613] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:38:0)
[13:01:14.613] Timer tick, asking Buildbucket for the build status
[13:01:14.697] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:01:14.697] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:39:0) after 1m0s
[13:02:14.724] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:39:0)
[13:02:14.724] Timer tick, asking Buildbucket for the build status
[13:02:14.845] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:14.845] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:40:0) after 1m0s
[13:03:14.885] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:40:0)
[13:03:14.885] Timer tick, asking Buildbucket for the build status
[13:03:14.986] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:14.986] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:41:0) after 1m0s
[13:04:15.018] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:41:0)
[13:04:15.018] Timer tick, asking Buildbucket for the build status
[13:04:15.144] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:15.144] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:42:0) after 1m0s
[13:05:15.217] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:42:0)
[13:05:15.217] Timer tick, asking Buildbucket for the build status
[13:05:15.314] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:15.314] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:43:0) after 1m0s
[13:06:15.407] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:43:0)
[13:06:15.407] Timer tick, asking Buildbucket for the build status
[13:06:15.497] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:06:15.497] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:44:0) after 1m0s
[13:07:15.601] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:44:0)
[13:07:15.601] Timer tick, asking Buildbucket for the build status
[13:07:15.775] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:15.775] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:45:0) after 1m0s
[13:08:15.805] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:45:0)
[13:08:15.805] Timer tick, asking Buildbucket for the build status
[13:08:15.883] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:15.883] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:46:0) after 1m0s
[13:09:16.011] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:46:0)
[13:09:16.011] Timer tick, asking Buildbucket for the build status
[13:09:16.178] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:16.178] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:47:0) after 1m0s
[13:10:16.213] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:47:0)
[13:10:16.213] Timer tick, asking Buildbucket for the build status
[13:10:16.289] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:16.289] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:48:0) after 1m0s
[13:11:16.318] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:48:0)
[13:11:16.318] Timer tick, asking Buildbucket for the build status
[13:11:16.641] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:16.641] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:49:0) after 1m0s
[13:12:16.704] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:49:0)
[13:12:16.704] Timer tick, asking Buildbucket for the build status
[13:12:16.787] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:16.787] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:50:0) after 1m0s
[13:13:16.915] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:50:0)
[13:13:16.915] Timer tick, asking Buildbucket for the build status
[13:13:17.002] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:17.002] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:51:0) after 1m0s
[13:14:17.044] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:51:0)
[13:14:17.044] Timer tick, asking Buildbucket for the build status
[13:14:17.135] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:17.135] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:52:0) after 1m0s
[13:15:17.215] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:52:0)
[13:15:17.215] Timer tick, asking Buildbucket for the build status
[13:15:17.327] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:17.327] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:53:0) after 1m0s
[13:16:17.351] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:53:0)
[13:16:17.351] Timer tick, asking Buildbucket for the build status
[13:16:17.433] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:17.433] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:54:0) after 1m0s
[13:17:17.458] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:54:0)
[13:17:17.458] Timer tick, asking Buildbucket for the build status
[13:17:17.596] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:17:17.596] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:55:0) after 1m0s
[13:18:17.751] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:55:0)
[13:18:17.751] Timer tick, asking Buildbucket for the build status
[13:18:17.859] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:18:17.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:56:0) after 1m0s
[13:19:17.917] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:56:0)
[13:19:17.917] Timer tick, asking Buildbucket for the build status
[13:19:17.993] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:19:17.993] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:57:0) after 1m0s
[13:20:18.094] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:57:0)
[13:20:18.094] Timer tick, asking Buildbucket for the build status
[13:20:18.181] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:20:18.181] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:58:0) after 1m0s
[13:21:18.210] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:58:0)
[13:21:18.210] Timer tick, asking Buildbucket for the build status
[13:21:18.368] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:21:18.368] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:59:0) after 1m0s
[13:22:18.412] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:59:0)
[13:22:18.412] Timer tick, asking Buildbucket for the build status
[13:22:18.490] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:22:18.490] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:60:0) after 1m0s
[13:23:18.514] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:60:0)
[13:23:18.514] Timer tick, asking Buildbucket for the build status
[13:23:18.594] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:23:18.594] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:61:0) after 1m0s
[13:24:18.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:61:0)
[13:24:18.709] Timer tick, asking Buildbucket for the build status
[13:24:18.843] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:24:18.843] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:62:0) after 1m0s
[13:25:18.918] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:62:0)
[13:25:18.918] Timer tick, asking Buildbucket for the build status
[13:25:18.996] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:25:18.996] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:63:0) after 1m0s
[13:26:19.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:63:0)
[13:26:19.114] Timer tick, asking Buildbucket for the build status
[13:26:19.335] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:26:19.335] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:64:0) after 1m0s
[13:27:19.419] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:64:0)
[13:27:19.419] Timer tick, asking Buildbucket for the build status
[13:27:19.506] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:27:19.506] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:65:0) after 1m0s
[13:28:19.617] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:65:0)
[13:28:19.617] Timer tick, asking Buildbucket for the build status
[13:28:19.776] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:28:19.776] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:66:0) after 1m0s
[13:29:19.816] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:66:0)
[13:29:19.816] Timer tick, asking Buildbucket for the build status
[13:29:19.909] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:29:19.909] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:67:0) after 1m0s
[13:30:19.993] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:67:0)
[13:30:19.993] Timer tick, asking Buildbucket for the build status
[13:30:20.075] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:30:20.075] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:68:0) after 1m0s
[13:31:20.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:68:0)
[13:31:20.113] Timer tick, asking Buildbucket for the build status
[13:31:20.204] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:20.204] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:69:0) after 1m0s
[13:32:20.303] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:69:0)
[13:32:20.303] Timer tick, asking Buildbucket for the build status
[13:32:20.376] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:20.376] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:70:0) after 1m0s
[13:33:20.407] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:70:0)
[13:33:20.407] Timer tick, asking Buildbucket for the build status
[13:33:20.488] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:20.488] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:71:0) after 1m0s
[13:34:20.515] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:71:0)
[13:34:20.515] Timer tick, asking Buildbucket for the build status
[13:34:20.625] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:20.625] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:72:0) after 1m0s
[13:35:20.703] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:72:0)
[13:35:20.703] Timer tick, asking Buildbucket for the build status
[13:35:20.860] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:35:20.860] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:73:0) after 1m0s
[13:36:20.908] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:73:0)
[13:36:20.908] Timer tick, asking Buildbucket for the build status
[13:36:20.984] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:36:20.984] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:74:0) after 1m0s
[13:37:21.028] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:74:0)
[13:37:21.028] Timer tick, asking Buildbucket for the build status
[13:37:21.111] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:37:21.111] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:75:0) after 1m0s
[13:38:21.225] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:75:0)
[13:38:21.225] Timer tick, asking Buildbucket for the build status
[13:38:21.325] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:38:21.325] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:76:0) after 1m0s
[13:39:21.416] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:76:0)
[13:39:21.416] Timer tick, asking Buildbucket for the build status
[13:39:21.579] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:39:21.580] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:77:0) after 1m0s
[13:40:21.692] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:77:0)
[13:40:21.692] Timer tick, asking Buildbucket for the build status
[13:40:21.877] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:40:21.877] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:78:0) after 1m0s
[13:41:21.923] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:78:0)
[13:41:21.923] Timer tick, asking Buildbucket for the build status
[13:41:22.703] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:41:22.703] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:79:0) after 1m0s
[13:42:22.728] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:79:0)
[13:42:22.728] Timer tick, asking Buildbucket for the build status
[13:42:22.810] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:22.810] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:80:0) after 1m0s
[13:43:22.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:80:0)
[13:43:22.891] Timer tick, asking Buildbucket for the build status
[13:43:23.059] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:23.059] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:81:0) after 1m0s
[13:44:23.108] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:81:0)
[13:44:23.108] Timer tick, asking Buildbucket for the build status
[13:44:23.221] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:23.221] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:82:0) after 1m0s
[13:45:23.250] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:82:0)
[13:45:23.250] Timer tick, asking Buildbucket for the build status
[13:45:23.375] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:23.375] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:83:0) after 1m0s
[13:46:23.404] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:83:0)
[13:46:23.404] Timer tick, asking Buildbucket for the build status
[13:46:23.548] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:23.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:84:0) after 1m0s
[13:47:23.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:84:0)
[13:47:23.597] Timer tick, asking Buildbucket for the build status
[13:47:23.790] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:23.790] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:85:0) after 1m0s
[13:48:23.834] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:85:0)
[13:48:23.834] Timer tick, asking Buildbucket for the build status
[13:48:23.987] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:23.987] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:86:0) after 1m0s
[13:49:24.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:86:0)
[13:49:24.106] Timer tick, asking Buildbucket for the build status
[13:49:24.311] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:24.311] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:87:0) after 1m0s
[13:50:24.335] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:87:0)
[13:50:24.335] Timer tick, asking Buildbucket for the build status
[13:50:24.641] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:24.641] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:88:0) after 1m0s
[13:51:24.694] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:88:0)
[13:51:24.694] Timer tick, asking Buildbucket for the build status
[13:51:24.926] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:24.926] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:89:0) after 1m0s
[13:52:24.957] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:89:0)
[13:52:24.957] Timer tick, asking Buildbucket for the build status
[13:52:25.069] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:25.069] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:90:0) after 1m0s
[13:53:25.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:90:0)
[13:53:25.106] Timer tick, asking Buildbucket for the build status
[13:53:25.224] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:25.224] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:91:0) after 1m0s
[13:54:25.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:91:0)
[13:54:25.298] Timer tick, asking Buildbucket for the build status
[13:54:25.483] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:25.483] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:92:0) after 1m0s
[13:55:25.508] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:92:0)
[13:55:25.508] Timer tick, asking Buildbucket for the build status
[13:55:25.640] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:25.640] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:93:0) after 1m0s
[13:56:25.716] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:93:0)
[13:56:25.716] Timer tick, asking Buildbucket for the build status
[13:56:25.889] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:25.889] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:94:0) after 1m0s
[13:57:26.006] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:94:0)
[13:57:26.006] Timer tick, asking Buildbucket for the build status
[13:57:26.143] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:26.143] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:95:0) after 1m0s
[13:58:26.204] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:95:0)
[13:58:26.204] Timer tick, asking Buildbucket for the build status
[13:58:26.300] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:26.300] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:96:0) after 1m0s
[13:59:26.449] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:96:0)
[13:59:26.449] Timer tick, asking Buildbucket for the build status
[13:59:26.594] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:26.594] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:97:0) after 1m0s
[14:00:26.634] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:97:0)
[14:00:26.634] Timer tick, asking Buildbucket for the build status
[14:00:26.848] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:26.848] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:98:0) after 1m0s
[14:01:26.908] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:98:0)
[14:01:26.908] Timer tick, asking Buildbucket for the build status
[14:01:27.093] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:27.093] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:99:0) after 1m0s
[14:02:27.221] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:99:0)
[14:02:27.221] Timer tick, asking Buildbucket for the build status
[14:02:27.382] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:27.382] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:100:0) after 1m0s
[14:03:27.424] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:100:0)
[14:03:27.424] Timer tick, asking Buildbucket for the build status
[14:03:27.561] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:27.561] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:101:0) after 1m0s
[14:04:27.612] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:101:0)
[14:04:27.612] Timer tick, asking Buildbucket for the build status
[14:04:27.791] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:27.791] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:102:0) after 1m0s
[14:05:27.817] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:102:0)
[14:05:27.817] Timer tick, asking Buildbucket for the build status
[14:05:27.992] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:27.992] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:103:0) after 1m0s
[14:06:28.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:103:0)
[14:06:28.106] Timer tick, asking Buildbucket for the build status
[14:06:28.263] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:28.263] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:104:0) after 1m0s
[14:07:28.346] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:104:0)
[14:07:28.346] Timer tick, asking Buildbucket for the build status
[14:07:28.503] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:28.503] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:105:0) after 1m0s
[14:08:28.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:105:0)
[14:08:28.605] Timer tick, asking Buildbucket for the build status
[14:08:28.777] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:28.777] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:106:0) after 1m0s
[14:09:28.821] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:106:0)
[14:09:28.821] Timer tick, asking Buildbucket for the build status
[14:09:29.022] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:29.022] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:107:0) after 1m0s
[14:10:29.053] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:107:0)
[14:10:29.053] Timer tick, asking Buildbucket for the build status
[14:10:29.171] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:29.171] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:108:0) after 1m0s
[14:11:29.226] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:108:0)
[14:11:29.226] Timer tick, asking Buildbucket for the build status
[14:11:29.340] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:29.340] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:109:0) after 1m0s
[14:12:29.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:109:0)
[14:12:29.373] Timer tick, asking Buildbucket for the build status
[14:12:29.494] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:29.494] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:110:0) after 1m0s
[14:13:29.611] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:110:0)
[14:13:29.611] Timer tick, asking Buildbucket for the build status
[14:13:29.804] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:29.804] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:111:0) after 1m0s
[14:14:29.909] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:111:0)
[14:14:29.909] Timer tick, asking Buildbucket for the build status
[14:14:30.016] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:30.016] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:112:0) after 1m0s
[14:15:30.142] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:112:0)
[14:15:30.142] Timer tick, asking Buildbucket for the build status
[14:15:30.256] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:30.256] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:113:0) after 1m0s
[14:16:30.315] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:113:0)
[14:16:30.315] Timer tick, asking Buildbucket for the build status
[14:16:30.435] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:30.435] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:114:0) after 1m0s
[14:17:30.465] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:114:0)
[14:17:30.465] Timer tick, asking Buildbucket for the build status
[14:17:30.588] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:30.588] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:115:0) after 1m0s
[14:18:30.639] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:115:0)
[14:18:30.639] Timer tick, asking Buildbucket for the build status
[14:18:30.779] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:30.779] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:116:0) after 1m0s
[14:19:30.827] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:116:0)
[14:19:30.827] Timer tick, asking Buildbucket for the build status
[14:19:30.945] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:30.945] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:117:0) after 1m0s
[14:20:30.993] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:117:0)
[14:20:30.993] Timer tick, asking Buildbucket for the build status
[14:20:31.113] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:31.113] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:118:0) after 1m0s
[14:21:31.148] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:118:0)
[14:21:31.148] Timer tick, asking Buildbucket for the build status
[14:21:31.354] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:31.354] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:119:0) after 1m0s
[14:22:31.415] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:119:0)
[14:22:31.415] Timer tick, asking Buildbucket for the build status
[14:22:31.529] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:31.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:120:0) after 1m0s
[14:23:31.622] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:120:0)
[14:23:31.622] Timer tick, asking Buildbucket for the build status
[14:23:31.749] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:31.749] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:121:0) after 1m0s
[14:24:31.803] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:121:0)
[14:24:31.803] Timer tick, asking Buildbucket for the build status
[14:24:31.921] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:31.921] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:122:0) after 1m0s
[14:25:32.006] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:122:0)
[14:25:32.006] Timer tick, asking Buildbucket for the build status
[14:25:32.118] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:32.118] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:123:0) after 1m0s
[14:26:32.148] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:123:0)
[14:26:32.148] Timer tick, asking Buildbucket for the build status
[14:26:32.260] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:32.260] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:124:0) after 1m0s
[14:27:32.311] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:124:0)
[14:27:32.311] Timer tick, asking Buildbucket for the build status
[14:27:32.436] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:32.436] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:125:0) after 1m0s
[14:28:32.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:125:0)
[14:28:32.504] Timer tick, asking Buildbucket for the build status
[14:28:32.617] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:32.617] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:126:0) after 1m0s
[14:29:32.648] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:126:0)
[14:29:32.648] Timer tick, asking Buildbucket for the build status
[14:29:32.763] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:32.763] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:127:0) after 1m0s
[14:30:32.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:127:0)
[14:30:32.809] Timer tick, asking Buildbucket for the build status
[14:30:33.136] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:33.136] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:128:0) after 1m0s
[14:31:33.223] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:128:0)
[14:31:33.223] Timer tick, asking Buildbucket for the build status
[14:31:33.412] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:33.412] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:129:0) after 1m0s
[14:32:33.454] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:129:0)
[14:32:33.454] Timer tick, asking Buildbucket for the build status
[14:32:33.628] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:33.628] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:130:0) after 1m0s
[14:33:33.653] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:130:0)
[14:33:33.653] Timer tick, asking Buildbucket for the build status
[14:33:33.759] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:33.759] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:131:0) after 1m0s
[14:34:33.802] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:131:0)
[14:34:33.802] Timer tick, asking Buildbucket for the build status
[14:34:33.913] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:34:33.913] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:132:0) after 1m0s
[14:35:33.956] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:132:0)
[14:35:33.956] Timer tick, asking Buildbucket for the build status
[14:35:34.083] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:34.083] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:133:0) after 1m0s
[14:36:34.193] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:133:0)
[14:36:34.193] Timer tick, asking Buildbucket for the build status
[14:36:34.312] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:34.312] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:134:0) after 1m0s
[14:37:34.429] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:134:0)
[14:37:34.429] Timer tick, asking Buildbucket for the build status
[14:37:34.551] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:37:34.551] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:135:0) after 1m0s
[14:38:34.621] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:135:0)
[14:38:34.622] Timer tick, asking Buildbucket for the build status
[14:38:34.736] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:38:34.736] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:136:0) after 1m0s
[14:39:34.816] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:136:0)
[14:39:34.816] Timer tick, asking Buildbucket for the build status
[14:39:34.984] Build 8862205712567306112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:34.984] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:137:0) after 1m0s
[14:39:53.496] Received PubSub notification, asking Buildbucket for the build status
[14:39:53.658] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:35.062] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:137:0)
[14:40:35.062] Timer tick, asking Buildbucket for the build status
[14:40:35.171] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:35.171] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:139:0) after 1m0s
[14:41:35.218] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:139:0)
[14:41:35.218] Timer tick, asking Buildbucket for the build status
[14:41:35.332] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:35.332] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:140:0) after 1m0s
[14:42:35.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:140:0)
[14:42:35.369] Timer tick, asking Buildbucket for the build status
[14:42:35.493] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:35.493] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:141:0) after 1m0s
[14:43:35.623] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:141:0)
[14:43:35.623] Timer tick, asking Buildbucket for the build status
[14:43:35.740] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:35.740] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:142:0) after 1m0s
[14:44:35.791] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:142:0)
[14:44:35.791] Timer tick, asking Buildbucket for the build status
[14:44:35.939] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:35.939] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:143:0) after 1m0s
[14:45:35.968] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:143:0)
[14:45:35.968] Timer tick, asking Buildbucket for the build status
[14:45:36.107] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:36.107] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:144:0) after 1m0s
[14:46:36.153] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:144:0)
[14:46:36.153] Timer tick, asking Buildbucket for the build status
[14:46:36.277] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:36.277] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:145:0) after 1m0s
[14:47:36.323] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:145:0)
[14:47:36.323] Timer tick, asking Buildbucket for the build status
[14:47:36.439] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:36.439] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:146:0) after 1m0s
[14:48:36.469] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:146:0)
[14:48:36.469] Timer tick, asking Buildbucket for the build status
[14:48:36.578] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:36.578] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:147:0) after 1m0s
[14:49:36.610] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:147:0)
[14:49:36.610] Timer tick, asking Buildbucket for the build status
[14:49:36.789] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:36.789] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:148:0) after 1m0s
[14:50:36.821] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:148:0)
[14:50:36.821] Timer tick, asking Buildbucket for the build status
[14:50:36.921] Build 8862205712567306112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:36.921] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9027635774575224384:149:0) after 1m0s
[14:51:34.416] Received PubSub notification, asking Buildbucket for the build status
[14:51:34.582] Build 8862205712567306112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:51:34.582] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1606747890741987",
"created_by": "project:infra",
"created_ts": "1606739047423996",
"id": "8862205712567306112",
"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\": \"fcd680108095c2a9aa26c54109180156e143f207\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fcd680108095c2a9aa26c54109180156e143f207\", \"title\": \"fcd680108095c2a9aa26c54109180156e143f207\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"fcd680108095c2a9aa26c54109180156e143f207\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"fcd680108095c2a9aa26c54109180156e143f207\", \"got_revision_cp\": \"refs/heads/master@{#36755}\"}, \"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-kpqc\"], \"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\": [\"5645-449b779\"], \"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": "1606747188915532",
"status": "COMPLETED",
"status_changed_ts": "1606747891145200",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18097",
"builder:infra-continuous-win10-64",
"buildset:commit/git/fcd680108095c2a9aa26c54109180156e143f207",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fcd680108095c2a9aa26c54109180156e143f207",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027635774575224384",
"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/8862205712567306112/+/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:5031edbf1d790510",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1606747891185252",
"url": "https://luci-milo-dev.appspot.com/b/8862205712567306112",
"utcnow_ts": "1606747894565887"
}
}
[14:51:34.583] Invocation finished in 2h27m28.45806508s with status SUCCEEDED