[04:05:02.412] New invocation is queued and will start shortly
[04:05:03.499] Starting the invocation (attempt 1)
[04:05:03.540] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:05:03.540] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[04:05:03.540] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9036364481630087808",
"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\":\"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@cd88c03a8837a5f2c1c1815ef1efde4d52332289\",\"title\":\"cd88c03a8837a5f2c1c1815ef1efde4d52332289\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}}",
"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:9036364481630087808",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"gitiles_ref:refs/heads/master"
]
}
[04:05:04.413] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1598414703654008",
"id": "8870934419659709008",
"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\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@cd88c03a8837a5f2c1c1815ef1efde4d52332289\", \"title\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598414704221049",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17584",
"builder:infra-continuous-win10-64",
"buildset:commit/git/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036364481630087808",
"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/8870934419659709008/+/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": "1598414704222333",
"url": "https://luci-milo-dev.appspot.com/b/8870934419659709008",
"utcnow_ts": "1598414704402841"
}
}
[04:05:04.413] Task URL: https://luci-milo-dev.appspot.com/b/8870934419659709008
[04:05:04.413] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:2:0) after 1m0s
[04:06:04.452] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:2:0)
[04:06:04.452] Timer tick, asking Buildbucket for the build status
[04:06:04.668] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:04.668] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:3:0) after 1m0s
[04:07:04.700] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:3:0)
[04:07:04.700] Timer tick, asking Buildbucket for the build status
[04:07:04.886] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:04.886] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:4:0) after 1m0s
[04:08:04.978] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:4:0)
[04:08:04.978] Timer tick, asking Buildbucket for the build status
[04:08:05.064] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:05.064] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:5:0) after 1m0s
[04:09:05.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:5:0)
[04:09:05.188] Timer tick, asking Buildbucket for the build status
[04:09:05.282] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:05.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:6:0) after 1m0s
[04:10:05.321] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:6:0)
[04:10:05.321] Timer tick, asking Buildbucket for the build status
[04:10:05.410] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:05.410] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:7:0) after 1m0s
[04:11:05.434] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:7:0)
[04:11:05.434] Timer tick, asking Buildbucket for the build status
[04:11:05.552] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:05.552] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:8:0) after 1m0s
[04:12:05.584] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:8:0)
[04:12:05.584] Timer tick, asking Buildbucket for the build status
[04:12:05.677] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:05.677] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:9:0) after 1m0s
[04:13:05.719] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:9:0)
[04:13:05.719] Timer tick, asking Buildbucket for the build status
[04:13:05.845] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:05.845] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:10:0) after 1m0s
[04:14:05.893] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:10:0)
[04:14:05.893] Timer tick, asking Buildbucket for the build status
[04:14:05.972] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:05.973] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:11:0) after 1m0s
[04:15:05.995] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:11:0)
[04:15:05.995] Timer tick, asking Buildbucket for the build status
[04:15:06.100] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:06.100] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:12:0) after 1m0s
[04:16:06.125] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:12:0)
[04:16:06.125] Timer tick, asking Buildbucket for the build status
[04:16:06.245] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:06.245] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:13:0) after 1m0s
[04:17:06.268] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:13:0)
[04:17:06.268] Timer tick, asking Buildbucket for the build status
[04:17:06.348] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:06.348] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:14:0) after 1m0s
[04:18:06.379] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:14:0)
[04:18:06.379] Timer tick, asking Buildbucket for the build status
[04:18:06.469] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:06.469] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:15:0) after 1m0s
[04:19:06.495] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:15:0)
[04:19:06.495] Timer tick, asking Buildbucket for the build status
[04:19:06.576] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:06.576] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:16:0) after 1m0s
[04:20:06.602] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:16:0)
[04:20:06.602] Timer tick, asking Buildbucket for the build status
[04:20:06.721] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:06.721] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:17:0) after 1m0s
[04:21:06.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:17:0)
[04:21:06.743] Timer tick, asking Buildbucket for the build status
[04:21:06.834] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:06.834] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:18:0) after 1m0s
[04:22:06.916] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:18:0)
[04:22:06.916] Timer tick, asking Buildbucket for the build status
[04:22:07.057] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:07.057] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:19:0) after 1m0s
[04:23:07.192] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:19:0)
[04:23:07.192] Timer tick, asking Buildbucket for the build status
[04:23:07.305] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:07.305] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:20:0) after 1m0s
[04:24:07.330] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:20:0)
[04:24:07.330] Timer tick, asking Buildbucket for the build status
[04:24:07.414] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:07.414] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:21:0) after 1m0s
[04:25:07.453] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:21:0)
[04:25:07.453] Timer tick, asking Buildbucket for the build status
[04:25:07.573] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:07.573] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:22:0) after 1m0s
[04:26:07.594] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:22:0)
[04:26:07.594] Timer tick, asking Buildbucket for the build status
[04:26:07.702] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:07.703] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:23:0) after 1m0s
[04:27:07.780] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:23:0)
[04:27:07.780] Timer tick, asking Buildbucket for the build status
[04:27:07.866] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:07.866] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:24:0) after 1m0s
[04:28:07.984] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:24:0)
[04:28:07.984] Timer tick, asking Buildbucket for the build status
[04:28:08.167] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:08.167] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:25:0) after 1m0s
[04:29:08.191] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:25:0)
[04:29:08.191] Timer tick, asking Buildbucket for the build status
[04:29:08.277] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:08.277] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:26:0) after 1m0s
[04:30:08.309] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:26:0)
[04:30:08.309] Timer tick, asking Buildbucket for the build status
[04:30:08.392] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:08.392] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:27:0) after 1m0s
[04:31:08.479] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:27:0)
[04:31:08.479] Timer tick, asking Buildbucket for the build status
[04:31:08.668] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:08.668] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:28:0) after 1m0s
[04:32:08.695] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:28:0)
[04:32:08.695] Timer tick, asking Buildbucket for the build status
[04:32:08.783] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:08.783] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:29:0) after 1m0s
[04:33:08.868] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:29:0)
[04:33:08.868] Timer tick, asking Buildbucket for the build status
[04:33:09.037] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:09.037] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:30:0) after 1m0s
[04:34:09.077] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:30:0)
[04:34:09.077] Timer tick, asking Buildbucket for the build status
[04:34:09.163] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:09.163] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:31:0) after 1m0s
[04:35:09.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:31:0)
[04:35:09.189] Timer tick, asking Buildbucket for the build status
[04:35:09.270] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:09.270] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:32:0) after 1m0s
[04:36:09.291] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:32:0)
[04:36:09.291] Timer tick, asking Buildbucket for the build status
[04:36:09.391] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:09.391] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:33:0) after 1m0s
[04:37:09.412] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:33:0)
[04:37:09.412] Timer tick, asking Buildbucket for the build status
[04:37:09.500] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:09.500] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:34:0) after 1m0s
[04:38:09.538] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:34:0)
[04:38:09.538] Timer tick, asking Buildbucket for the build status
[04:38:09.624] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:09.624] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:35:0) after 1m0s
[04:39:09.646] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:35:0)
[04:39:09.646] Timer tick, asking Buildbucket for the build status
[04:39:09.734] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:09.734] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:36:0) after 1m0s
[04:40:09.785] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:36:0)
[04:40:09.785] Timer tick, asking Buildbucket for the build status
[04:40:09.876] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:09.876] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:37:0) after 1m0s
[04:41:09.906] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:37:0)
[04:41:09.907] Timer tick, asking Buildbucket for the build status
[04:41:09.991] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:09.991] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:38:0) after 1m0s
[04:42:10.056] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:38:0)
[04:42:10.056] Timer tick, asking Buildbucket for the build status
[04:42:10.179] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:10.179] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:39:0) after 1m0s
[04:43:10.302] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:39:0)
[04:43:10.302] Timer tick, asking Buildbucket for the build status
[04:43:10.439] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:10.439] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:40:0) after 1m0s
[04:44:10.466] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:40:0)
[04:44:10.466] Timer tick, asking Buildbucket for the build status
[04:44:10.562] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:10.562] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:41:0) after 1m0s
[04:45:10.586] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:41:0)
[04:45:10.586] Timer tick, asking Buildbucket for the build status
[04:45:10.669] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:10.669] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:42:0) after 1m0s
[04:46:10.695] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:42:0)
[04:46:10.695] Timer tick, asking Buildbucket for the build status
[04:46:10.822] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:10.822] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:43:0) after 1m0s
[04:47:10.905] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:43:0)
[04:47:10.905] Timer tick, asking Buildbucket for the build status
[04:47:11.004] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:11.004] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:44:0) after 1m0s
[04:48:11.084] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:44:0)
[04:48:11.084] Timer tick, asking Buildbucket for the build status
[04:48:11.190] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:11.190] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:45:0) after 1m0s
[04:49:11.223] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:45:0)
[04:49:11.223] Timer tick, asking Buildbucket for the build status
[04:49:11.319] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:11.319] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:46:0) after 1m0s
[04:50:11.380] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:46:0)
[04:50:11.380] Timer tick, asking Buildbucket for the build status
[04:50:11.466] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:11.466] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:47:0) after 1m0s
[04:51:11.501] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:47:0)
[04:51:11.501] Timer tick, asking Buildbucket for the build status
[04:51:11.603] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:11.603] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:48:0) after 1m0s
[04:52:11.641] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:48:0)
[04:52:11.641] Timer tick, asking Buildbucket for the build status
[04:52:11.745] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:11.745] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:49:0) after 1m0s
[04:53:11.782] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:49:0)
[04:53:11.782] Timer tick, asking Buildbucket for the build status
[04:53:11.870] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:11.870] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:50:0) after 1m0s
[04:54:11.900] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:50:0)
[04:54:11.900] Timer tick, asking Buildbucket for the build status
[04:54:11.988] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:11.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:51:0) after 1m0s
[04:55:12.067] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:51:0)
[04:55:12.067] Timer tick, asking Buildbucket for the build status
[04:55:12.161] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:12.161] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:52:0) after 1m0s
[04:56:12.186] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:52:0)
[04:56:12.186] Timer tick, asking Buildbucket for the build status
[04:56:12.291] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:12.291] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:53:0) after 1m0s
[04:57:12.315] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:53:0)
[04:57:12.315] Timer tick, asking Buildbucket for the build status
[04:57:12.406] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:12.406] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:54:0) after 1m0s
[04:58:12.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:54:0)
[04:58:12.447] Timer tick, asking Buildbucket for the build status
[04:58:12.535] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:12.535] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:55:0) after 1m0s
[04:59:12.568] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:55:0)
[04:59:12.568] Timer tick, asking Buildbucket for the build status
[04:59:12.697] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:12.697] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:56:0) after 1m0s
[05:00:12.720] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:56:0)
[05:00:12.720] Timer tick, asking Buildbucket for the build status
[05:00:12.882] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:12.882] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:57:0) after 1m0s
[05:01:12.986] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:57:0)
[05:01:12.986] Timer tick, asking Buildbucket for the build status
[05:01:13.088] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:13.088] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:58:0) after 1m0s
[05:02:13.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:58:0)
[05:02:13.113] Timer tick, asking Buildbucket for the build status
[05:02:13.202] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:13.202] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:59:0) after 1m0s
[05:03:13.280] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:59:0)
[05:03:13.280] Timer tick, asking Buildbucket for the build status
[05:03:13.369] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:13.369] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:60:0) after 1m0s
[05:04:13.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:60:0)
[05:04:13.397] Timer tick, asking Buildbucket for the build status
[05:04:13.479] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:13.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:61:0) after 1m0s
[05:05:13.514] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:61:0)
[05:05:13.514] Timer tick, asking Buildbucket for the build status
[05:05:13.605] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:13.605] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:62:0) after 1m0s
[05:06:13.633] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:62:0)
[05:06:13.633] Timer tick, asking Buildbucket for the build status
[05:06:13.744] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:13.744] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:63:0) after 1m0s
[05:07:13.784] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:63:0)
[05:07:13.784] Timer tick, asking Buildbucket for the build status
[05:07:13.876] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:13.876] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:64:0) after 1m0s
[05:08:13.902] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:64:0)
[05:08:13.902] Timer tick, asking Buildbucket for the build status
[05:08:13.995] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:13.995] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:65:0) after 1m0s
[05:09:14.101] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:65:0)
[05:09:14.101] Timer tick, asking Buildbucket for the build status
[05:09:14.217] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:14.217] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:66:0) after 1m0s
[05:10:14.245] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:66:0)
[05:10:14.245] Timer tick, asking Buildbucket for the build status
[05:10:14.341] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:14.341] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:67:0) after 1m0s
[05:11:14.374] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:67:0)
[05:11:14.374] Timer tick, asking Buildbucket for the build status
[05:11:14.478] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:14.478] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:68:0) after 1m0s
[05:12:14.509] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:68:0)
[05:12:14.509] Timer tick, asking Buildbucket for the build status
[05:12:14.584] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:14.584] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:69:0) after 1m0s
[05:13:14.610] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:69:0)
[05:13:14.610] Timer tick, asking Buildbucket for the build status
[05:13:14.707] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:14.707] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:70:0) after 1m0s
[05:14:14.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:70:0)
[05:14:14.743] Timer tick, asking Buildbucket for the build status
[05:14:14.846] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:14.846] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:71:0) after 1m0s
[05:15:14.873] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:71:0)
[05:15:14.873] Timer tick, asking Buildbucket for the build status
[05:15:14.949] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:14.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:72:0) after 1m0s
[05:16:14.988] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:72:0)
[05:16:14.988] Timer tick, asking Buildbucket for the build status
[05:16:15.097] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:15.097] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:73:0) after 1m0s
[05:17:15.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:73:0)
[05:17:15.203] Timer tick, asking Buildbucket for the build status
[05:17:15.312] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:15.312] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:74:0) after 1m0s
[05:18:15.385] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:74:0)
[05:18:15.385] Timer tick, asking Buildbucket for the build status
[05:18:15.485] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:15.485] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:75:0) after 1m0s
[05:19:15.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:75:0)
[05:19:15.512] Timer tick, asking Buildbucket for the build status
[05:19:15.655] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:15.655] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:76:0) after 1m0s
[05:20:15.689] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:76:0)
[05:20:15.689] Timer tick, asking Buildbucket for the build status
[05:20:15.775] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:15.775] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:77:0) after 1m0s
[05:21:15.804] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:77:0)
[05:21:15.804] Timer tick, asking Buildbucket for the build status
[05:21:15.932] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:15.932] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:78:0) after 1m0s
[05:22:15.968] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:78:0)
[05:22:15.968] Timer tick, asking Buildbucket for the build status
[05:22:16.092] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:16.092] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:79:0) after 1m0s
[05:23:16.139] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:79:0)
[05:23:16.139] Timer tick, asking Buildbucket for the build status
[05:23:16.243] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:16.243] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:80:0) after 1m0s
[05:24:16.271] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:80:0)
[05:24:16.271] Timer tick, asking Buildbucket for the build status
[05:24:16.373] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:16.373] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:81:0) after 1m0s
[05:25:16.485] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:81:0)
[05:25:16.485] Timer tick, asking Buildbucket for the build status
[05:25:16.592] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:16.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:82:0) after 1m0s
[05:26:16.626] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:82:0)
[05:26:16.626] Timer tick, asking Buildbucket for the build status
[05:26:16.744] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:16.744] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:83:0) after 1m0s
[05:27:16.769] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:83:0)
[05:27:16.769] Timer tick, asking Buildbucket for the build status
[05:27:16.867] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:16.867] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:84:0) after 1m0s
[05:28:16.984] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:84:0)
[05:28:16.985] Timer tick, asking Buildbucket for the build status
[05:28:17.159] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:17.159] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:85:0) after 1m0s
[05:29:17.284] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:85:0)
[05:29:17.284] Timer tick, asking Buildbucket for the build status
[05:29:17.370] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:17.370] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:86:0) after 1m0s
[05:30:17.410] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:86:0)
[05:30:17.410] Timer tick, asking Buildbucket for the build status
[05:30:17.523] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:17.523] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:87:0) after 1m0s
[05:31:17.554] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:87:0)
[05:31:17.554] Timer tick, asking Buildbucket for the build status
[05:31:17.665] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:17.665] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:88:0) after 1m0s
[05:32:17.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:88:0)
[05:32:17.709] Timer tick, asking Buildbucket for the build status
[05:32:17.857] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:17.857] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:89:0) after 1m0s
[05:33:17.981] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:89:0)
[05:33:17.981] Timer tick, asking Buildbucket for the build status
[05:33:18.078] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:18.078] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:90:0) after 1m0s
[05:34:18.187] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:90:0)
[05:34:18.187] Timer tick, asking Buildbucket for the build status
[05:34:18.371] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:18.371] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:91:0) after 1m0s
[05:35:18.433] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:91:0)
[05:35:18.433] Timer tick, asking Buildbucket for the build status
[05:35:18.536] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:18.536] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:92:0) after 1m0s
[05:36:18.567] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:92:0)
[05:36:18.567] Timer tick, asking Buildbucket for the build status
[05:36:18.686] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:18.686] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:93:0) after 1m0s
[05:37:18.714] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:93:0)
[05:37:18.714] Timer tick, asking Buildbucket for the build status
[05:37:18.840] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:18.840] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:94:0) after 1m0s
[05:38:18.881] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:94:0)
[05:38:18.881] Timer tick, asking Buildbucket for the build status
[05:38:18.972] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:18.972] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:95:0) after 1m0s
[05:39:19.006] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:95:0)
[05:39:19.006] Timer tick, asking Buildbucket for the build status
[05:39:19.102] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:19.102] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:96:0) after 1m0s
[05:40:19.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:96:0)
[05:40:19.203] Timer tick, asking Buildbucket for the build status
[05:40:19.398] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:19.399] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:97:0) after 1m0s
[05:41:19.502] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:97:0)
[05:41:19.502] Timer tick, asking Buildbucket for the build status
[05:41:19.631] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:19.631] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:98:0) after 1m0s
[05:42:19.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:98:0)
[05:42:19.709] Timer tick, asking Buildbucket for the build status
[05:42:19.797] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:19.797] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:99:0) after 1m0s
[05:43:19.884] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:99:0)
[05:43:19.884] Timer tick, asking Buildbucket for the build status
[05:43:19.974] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:19.974] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:100:0) after 1m0s
[05:44:20.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:100:0)
[05:44:20.106] Timer tick, asking Buildbucket for the build status
[05:44:20.201] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:20.201] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:101:0) after 1m0s
[05:45:20.248] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:101:0)
[05:45:20.248] Timer tick, asking Buildbucket for the build status
[05:45:20.367] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:20.367] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:102:0) after 1m0s
[05:46:20.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:102:0)
[05:46:20.397] Timer tick, asking Buildbucket for the build status
[05:46:20.526] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:20.526] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:103:0) after 1m0s
[05:47:20.553] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:103:0)
[05:47:20.553] Timer tick, asking Buildbucket for the build status
[05:47:20.642] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:20.642] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:104:0) after 1m0s
[05:48:20.668] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:104:0)
[05:48:20.668] Timer tick, asking Buildbucket for the build status
[05:48:20.772] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:20.772] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:105:0) after 1m0s
[05:49:20.796] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:105:0)
[05:49:20.796] Timer tick, asking Buildbucket for the build status
[05:49:20.895] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:20.895] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:106:0) after 1m0s
[05:50:20.939] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:106:0)
[05:50:20.939] Timer tick, asking Buildbucket for the build status
[05:50:21.026] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:21.026] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:107:0) after 1m0s
[05:51:21.055] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:107:0)
[05:51:21.055] Timer tick, asking Buildbucket for the build status
[05:51:21.158] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:21.158] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:108:0) after 1m0s
[05:52:21.184] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:108:0)
[05:52:21.184] Timer tick, asking Buildbucket for the build status
[05:52:21.282] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:21.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:109:0) after 1m0s
[05:53:21.312] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:109:0)
[05:53:21.312] Timer tick, asking Buildbucket for the build status
[05:53:21.415] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:21.415] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:110:0) after 1m0s
[05:54:21.505] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:110:0)
[05:54:21.505] Timer tick, asking Buildbucket for the build status
[05:54:21.591] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:21.591] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:111:0) after 1m0s
[05:55:21.637] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:111:0)
[05:55:21.637] Timer tick, asking Buildbucket for the build status
[05:55:21.728] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:21.728] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:112:0) after 1m0s
[05:56:21.759] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:112:0)
[05:56:21.759] Timer tick, asking Buildbucket for the build status
[05:56:21.903] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:21.903] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:113:0) after 1m0s
[05:57:21.945] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:113:0)
[05:57:21.945] Timer tick, asking Buildbucket for the build status
[05:57:22.085] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:22.085] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:114:0) after 1m0s
[05:58:22.204] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:114:0)
[05:58:22.204] Timer tick, asking Buildbucket for the build status
[05:58:22.345] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:22.345] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:115:0) after 1m0s
[05:59:22.411] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:115:0)
[05:59:22.411] Timer tick, asking Buildbucket for the build status
[05:59:22.495] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:22.495] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:116:0) after 1m0s
[06:00:22.550] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:116:0)
[06:00:22.550] Timer tick, asking Buildbucket for the build status
[06:00:22.657] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:22.657] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:117:0) after 1m0s
[06:01:22.691] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:117:0)
[06:01:22.691] Timer tick, asking Buildbucket for the build status
[06:01:22.784] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:22.784] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:118:0) after 1m0s
[06:02:22.836] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:118:0)
[06:02:22.836] Timer tick, asking Buildbucket for the build status
[06:02:22.966] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:22.966] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:119:0) after 1m0s
[06:03:23.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:119:0)
[06:03:23.001] Timer tick, asking Buildbucket for the build status
[06:03:23.118] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:23.118] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:120:0) after 1m0s
[06:04:23.287] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:120:0)
[06:04:23.287] Timer tick, asking Buildbucket for the build status
[06:04:23.437] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:23.437] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:121:0) after 1m0s
[06:05:23.478] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:121:0)
[06:05:23.478] Timer tick, asking Buildbucket for the build status
[06:05:23.570] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:23.570] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:122:0) after 1m0s
[06:06:23.607] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:122:0)
[06:06:23.607] Timer tick, asking Buildbucket for the build status
[06:06:23.729] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:23.729] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:123:0) after 1m0s
[06:07:23.757] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:123:0)
[06:07:23.757] Timer tick, asking Buildbucket for the build status
[06:07:23.859] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:23.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:124:0) after 1m0s
[06:08:23.888] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:124:0)
[06:08:23.888] Timer tick, asking Buildbucket for the build status
[06:08:24.068] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:24.068] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:125:0) after 1m0s
[06:09:24.101] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:125:0)
[06:09:24.101] Timer tick, asking Buildbucket for the build status
[06:09:24.202] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:24.202] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:126:0) after 1m0s
[06:10:24.237] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:126:0)
[06:10:24.237] Timer tick, asking Buildbucket for the build status
[06:10:24.342] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:24.342] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:127:0) after 1m0s
[06:11:24.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:127:0)
[06:11:24.376] Timer tick, asking Buildbucket for the build status
[06:11:24.465] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:24.465] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:128:0) after 1m0s
[06:12:24.513] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:128:0)
[06:12:24.513] Timer tick, asking Buildbucket for the build status
[06:12:24.606] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:24.606] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:129:0) after 1m0s
[06:13:24.639] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:129:0)
[06:13:24.639] Timer tick, asking Buildbucket for the build status
[06:13:24.735] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:24.735] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:130:0) after 1m0s
[06:14:24.766] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:130:0)
[06:14:24.766] Timer tick, asking Buildbucket for the build status
[06:14:24.855] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:24.855] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:131:0) after 1m0s
[06:15:24.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:131:0)
[06:15:24.892] Timer tick, asking Buildbucket for the build status
[06:15:24.991] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:24.991] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:132:0) after 1m0s
[06:16:25.040] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:132:0)
[06:16:25.040] Timer tick, asking Buildbucket for the build status
[06:16:25.206] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:25.206] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:133:0) after 1m0s
[06:17:25.279] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:133:0)
[06:17:25.279] Timer tick, asking Buildbucket for the build status
[06:17:25.407] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:25.407] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:134:0) after 1m0s
[06:18:25.436] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:134:0)
[06:18:25.436] Timer tick, asking Buildbucket for the build status
[06:18:25.561] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:25.561] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:135:0) after 1m0s
[06:19:25.619] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:135:0)
[06:19:25.619] Timer tick, asking Buildbucket for the build status
[06:19:25.707] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:25.707] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:136:0) after 1m0s
[06:19:38.187] Received PubSub notification, asking Buildbucket for the build status
[06:19:38.257] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:25.747] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:136:0)
[06:20:25.747] Timer tick, asking Buildbucket for the build status
[06:20:25.840] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:25.840] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:138:0) after 1m0s
[06:21:25.873] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:138:0)
[06:21:25.873] Timer tick, asking Buildbucket for the build status
[06:21:26.126] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:26.126] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:139:0) after 1m0s
[06:22:26.176] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:139:0)
[06:22:26.176] Timer tick, asking Buildbucket for the build status
[06:22:26.566] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:26.566] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:140:0) after 1m0s
[06:23:26.617] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:140:0)
[06:23:26.617] Timer tick, asking Buildbucket for the build status
[06:23:26.902] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:26.902] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:141:0) after 1m0s
[06:24:26.993] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:141:0)
[06:24:26.993] Timer tick, asking Buildbucket for the build status
[06:24:27.265] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:27.265] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:142:0) after 1m0s
[06:25:27.293] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:142:0)
[06:25:27.293] Timer tick, asking Buildbucket for the build status
[06:25:27.594] Build 8870934419659709008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:27.594] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:143:0) after 1m0s
[06:26:27.723] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:143:0)
[06:26:27.723] Timer tick, asking Buildbucket for the build status
[06:26:27.825] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:27.825] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:144:0) after 1m0s
[06:27:27.899] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:144:0)
[06:27:27.899] Timer tick, asking Buildbucket for the build status
[06:27:28.141] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:28.141] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:145:0) after 1m0s
[06:28:28.230] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:145:0)
[06:28:28.230] Timer tick, asking Buildbucket for the build status
[06:28:28.693] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:28.693] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:146:0) after 1m0s
[06:29:28.728] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:146:0)
[06:29:28.728] Timer tick, asking Buildbucket for the build status
[06:29:29.015] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:29.015] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:147:0) after 1m0s
[06:30:29.058] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:147:0)
[06:30:29.058] Timer tick, asking Buildbucket for the build status
[06:30:29.420] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:29.420] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:148:0) after 1m0s
[06:31:29.499] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:148:0)
[06:31:29.499] Timer tick, asking Buildbucket for the build status
[06:31:29.810] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:29.862] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:149:0) after 1m0s
[06:31:51.267] Received PubSub notification, asking Buildbucket for the build status
[06:31:51.344] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:29.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:149:0)
[06:32:29.892] Timer tick, asking Buildbucket for the build status
[06:32:30.177] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:30.177] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:151:0) after 1m0s
[06:33:30.213] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:151:0)
[06:33:30.213] Timer tick, asking Buildbucket for the build status
[06:33:30.469] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:30.470] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:152:0) after 1m0s
[06:34:30.502] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:152:0)
[06:34:30.502] Timer tick, asking Buildbucket for the build status
[06:34:30.740] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:30.740] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:153:0) after 1m0s
[06:35:30.778] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:153:0)
[06:35:30.778] Timer tick, asking Buildbucket for the build status
[06:35:31.095] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:31.095] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:154:0) after 1m0s
[06:36:31.192] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:154:0)
[06:36:31.192] Timer tick, asking Buildbucket for the build status
[06:36:31.505] Build 8870934419659709008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:31.505] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:155:0) after 1m0s
[06:37:31.548] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036364481630087808:155:0)
[06:37:31.548] Timer tick, asking Buildbucket for the build status
[06:37:31.963] Build 8870934419659709008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:37:31.963] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1598423509711491",
"created_by": "project:infra",
"created_ts": "1598414703654008",
"id": "8870934419659709008",
"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\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@cd88c03a8837a5f2c1c1815ef1efde4d52332289\", \"title\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"cd88c03a8837a5f2c1c1815ef1efde4d52332289\", \"got_revision_cp\": \"refs/heads/master@{#34549}\"}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1598422559707479",
"status": "COMPLETED",
"status_changed_ts": "1598423510058332",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17584",
"builder:infra-continuous-win10-64",
"buildset:commit/git/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/cd88c03a8837a5f2c1c1815ef1efde4d52332289",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036364481630087808",
"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/8870934419659709008/+/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:4e41c25ab82c6610",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1598423510068983",
"url": "https://luci-milo-dev.appspot.com/b/8870934419659709008",
"utcnow_ts": "1598423851782566"
}
}
[06:37:31.963] Invocation finished in 2h32m29.572418582s with status SUCCEEDED