[23:43:16.149] New invocation is queued and will start shortly
[23:43:17.246] Starting the invocation (attempt 1)
[23:43:17.334] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[23:43:17.351] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[23:43:17.352] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9019982899926754576",
"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\":\"eb82da051f0112b81f6bfdedc849418a2073d3ad\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@eb82da051f0112b81f6bfdedc849418a2073d3ad\",\"title\":\"eb82da051f0112b81f6bfdedc849418a2073d3ad\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/eb82da051f0112b81f6bfdedc849418a2073d3ad\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\",\"title\":\"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"41a39d580b801747c7e37be68df9f4ce348c57fd\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@41a39d580b801747c7e37be68df9f4ce348c57fd\",\"title\":\"41a39d580b801747c7e37be68df9f4ce348c57fd\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/41a39d580b801747c7e37be68df9f4ce348c57fd\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c50b1e07f86183bc737bdea4bf2c64db37384e60\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c50b1e07f86183bc737bdea4bf2c64db37384e60\",\"title\":\"c50b1e07f86183bc737bdea4bf2c64db37384e60\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/c50b1e07f86183bc737bdea4bf2c64db37384e60\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"ca2389b577053bc43e7701a4b258f70b51f85aed\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ca2389b577053bc43e7701a4b258f70b51f85aed\",\"title\":\"ca2389b577053bc43e7701a4b258f70b51f85aed\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/ca2389b577053bc43e7701a4b258f70b51f85aed\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\",\"title\":\"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"079d6fd5364a75f334a34ad7359f7aed4ef627be\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@079d6fd5364a75f334a34ad7359f7aed4ef627be\",\"title\":\"079d6fd5364a75f334a34ad7359f7aed4ef627be\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/079d6fd5364a75f334a34ad7359f7aed4ef627be\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"622248c321175ec240f31f4770943381b614378b\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@622248c321175ec240f31f4770943381b614378b\",\"title\":\"622248c321175ec240f31f4770943381b614378b\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/622248c321175ec240f31f4770943381b614378b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\",\"title\":\"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\",\"title\":\"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\",\"title\":\"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\",\"title\":\"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"04f38e41316ff9712f952faa8067b893f2456f6c\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@04f38e41316ff9712f952faa8067b893f2456f6c\",\"title\":\"04f38e41316ff9712f952faa8067b893f2456f6c\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"04f38e41316ff9712f952faa8067b893f2456f6c\"}}",
"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:9019982899926754576",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/04f38e41316ff9712f952faa8067b893f2456f6c",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c",
"gitiles_ref:refs/heads/master"
]
}
[23:43:18.232] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1614037397471482",
"id": "8854552837868082432",
"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\": \"eb82da051f0112b81f6bfdedc849418a2073d3ad\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@eb82da051f0112b81f6bfdedc849418a2073d3ad\", \"title\": \"eb82da051f0112b81f6bfdedc849418a2073d3ad\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/eb82da051f0112b81f6bfdedc849418a2073d3ad\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\", \"title\": \"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"41a39d580b801747c7e37be68df9f4ce348c57fd\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@41a39d580b801747c7e37be68df9f4ce348c57fd\", \"title\": \"41a39d580b801747c7e37be68df9f4ce348c57fd\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/41a39d580b801747c7e37be68df9f4ce348c57fd\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c50b1e07f86183bc737bdea4bf2c64db37384e60\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c50b1e07f86183bc737bdea4bf2c64db37384e60\", \"title\": \"c50b1e07f86183bc737bdea4bf2c64db37384e60\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c50b1e07f86183bc737bdea4bf2c64db37384e60\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"ca2389b577053bc43e7701a4b258f70b51f85aed\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ca2389b577053bc43e7701a4b258f70b51f85aed\", \"title\": \"ca2389b577053bc43e7701a4b258f70b51f85aed\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/ca2389b577053bc43e7701a4b258f70b51f85aed\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\", \"title\": \"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"079d6fd5364a75f334a34ad7359f7aed4ef627be\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@079d6fd5364a75f334a34ad7359f7aed4ef627be\", \"title\": \"079d6fd5364a75f334a34ad7359f7aed4ef627be\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/079d6fd5364a75f334a34ad7359f7aed4ef627be\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"622248c321175ec240f31f4770943381b614378b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@622248c321175ec240f31f4770943381b614378b\", \"title\": \"622248c321175ec240f31f4770943381b614378b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/622248c321175ec240f31f4770943381b614378b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\", \"title\": \"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\", \"title\": \"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\", \"title\": \"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\", \"title\": \"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"04f38e41316ff9712f952faa8067b893f2456f6c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@04f38e41316ff9712f952faa8067b893f2456f6c\", \"title\": \"04f38e41316ff9712f952faa8067b893f2456f6c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"04f38e41316ff9712f952faa8067b893f2456f6c\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614037398095577",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18678",
"builder:infra-continuous-win10-64",
"buildset:commit/git/04f38e41316ff9712f952faa8067b893f2456f6c",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019982899926754576",
"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/8854552837868082432/+/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": "1614037398095687",
"url": "https://luci-milo-dev.appspot.com/b/8854552837868082432",
"utcnow_ts": "1614037398215293"
}
}
[23:43:18.232] Task URL: https://luci-milo-dev.appspot.com/b/8854552837868082432
[23:43:18.232] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:2:0) after 1m0s
[23:44:18.264] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:2:0)
[23:44:18.264] Timer tick, asking Buildbucket for the build status
[23:44:18.410] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:18.410] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:3:0) after 1m0s
[23:45:18.458] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:3:0)
[23:45:18.458] Timer tick, asking Buildbucket for the build status
[23:45:18.565] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:18.565] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:4:0) after 1m0s
[23:46:18.589] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:4:0)
[23:46:18.589] Timer tick, asking Buildbucket for the build status
[23:46:18.681] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:18.681] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:5:0) after 1m0s
[23:47:18.761] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:5:0)
[23:47:18.761] Timer tick, asking Buildbucket for the build status
[23:47:18.859] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:18.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:6:0) after 1m0s
[23:48:18.924] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:6:0)
[23:48:18.924] Timer tick, asking Buildbucket for the build status
[23:48:19.039] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:19.039] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:7:0) after 1m0s
[23:49:19.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:7:0)
[23:49:19.113] Timer tick, asking Buildbucket for the build status
[23:49:19.216] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:19.216] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:8:0) after 1m0s
[23:50:19.237] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:8:0)
[23:50:19.237] Timer tick, asking Buildbucket for the build status
[23:50:19.347] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:19.347] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:9:0) after 1m0s
[23:51:19.434] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:9:0)
[23:51:19.434] Timer tick, asking Buildbucket for the build status
[23:51:19.575] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:19.575] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:10:0) after 1m0s
[23:52:19.616] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:10:0)
[23:52:19.616] Timer tick, asking Buildbucket for the build status
[23:52:19.716] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:19.716] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:11:0) after 1m0s
[23:53:19.761] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:11:0)
[23:53:19.761] Timer tick, asking Buildbucket for the build status
[23:53:19.898] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:19.898] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:12:0) after 1m0s
[23:54:19.971] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:12:0)
[23:54:19.971] Timer tick, asking Buildbucket for the build status
[23:54:20.081] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:20.081] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:13:0) after 1m0s
[23:55:20.102] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:13:0)
[23:55:20.102] Timer tick, asking Buildbucket for the build status
[23:55:20.201] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:20.201] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:14:0) after 1m0s
[23:56:20.268] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:14:0)
[23:56:20.268] Timer tick, asking Buildbucket for the build status
[23:56:20.419] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:20.419] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:15:0) after 1m0s
[23:57:20.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:15:0)
[23:57:20.447] Timer tick, asking Buildbucket for the build status
[23:57:20.548] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:20.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:16:0) after 1m0s
[23:58:20.574] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:16:0)
[23:58:20.574] Timer tick, asking Buildbucket for the build status
[23:58:20.680] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:20.680] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:17:0) after 1m0s
[23:59:20.730] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:17:0)
[23:59:20.730] Timer tick, asking Buildbucket for the build status
[23:59:20.830] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:20.830] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:18:0) after 1m0s
[00:00:20.852] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:18:0)
[00:00:20.852] Timer tick, asking Buildbucket for the build status
[00:00:20.964] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:20.964] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:19:0) after 1m0s
[00:01:21.067] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:19:0)
[00:01:21.067] Timer tick, asking Buildbucket for the build status
[00:01:21.175] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:21.175] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:20:0) after 1m0s
[00:02:21.221] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:20:0)
[00:02:21.221] Timer tick, asking Buildbucket for the build status
[00:02:21.326] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:21.326] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:21:0) after 1m0s
[00:03:21.357] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:21:0)
[00:03:21.357] Timer tick, asking Buildbucket for the build status
[00:03:21.504] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:21.504] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:22:0) after 1m0s
[00:04:21.614] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:22:0)
[00:04:21.614] Timer tick, asking Buildbucket for the build status
[00:04:21.741] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:21.742] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:23:0) after 1m0s
[00:05:21.822] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:23:0)
[00:05:21.822] Timer tick, asking Buildbucket for the build status
[00:05:21.972] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:21.972] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:24:0) after 1m0s
[00:06:22.060] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:24:0)
[00:06:22.060] Timer tick, asking Buildbucket for the build status
[00:06:22.153] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:22.153] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:25:0) after 1m0s
[00:07:22.234] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:25:0)
[00:07:22.234] Timer tick, asking Buildbucket for the build status
[00:07:22.348] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:22.348] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:26:0) after 1m0s
[00:08:22.418] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:26:0)
[00:08:22.418] Timer tick, asking Buildbucket for the build status
[00:08:22.534] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:22.534] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:27:0) after 1m0s
[00:09:22.560] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:27:0)
[00:09:22.560] Timer tick, asking Buildbucket for the build status
[00:09:22.683] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:22.683] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:28:0) after 1m0s
[00:10:22.756] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:28:0)
[00:10:22.756] Timer tick, asking Buildbucket for the build status
[00:10:22.852] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:22.852] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:29:0) after 1m0s
[00:11:22.933] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:29:0)
[00:11:22.933] Timer tick, asking Buildbucket for the build status
[00:11:23.035] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:23.035] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:30:0) after 1m0s
[00:12:23.081] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:30:0)
[00:12:23.081] Timer tick, asking Buildbucket for the build status
[00:12:23.235] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:23.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:31:0) after 1m0s
[00:13:23.330] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:31:0)
[00:13:23.330] Timer tick, asking Buildbucket for the build status
[00:13:23.434] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:23.434] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:32:0) after 1m0s
[00:14:23.526] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:32:0)
[00:14:23.526] Timer tick, asking Buildbucket for the build status
[00:14:23.640] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:23.640] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:33:0) after 1m0s
[00:15:23.741] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:33:0)
[00:15:23.741] Timer tick, asking Buildbucket for the build status
[00:15:23.847] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:23.847] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:34:0) after 1m0s
[00:16:23.875] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:34:0)
[00:16:23.875] Timer tick, asking Buildbucket for the build status
[00:16:23.979] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:23.979] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:35:0) after 1m0s
[00:17:24.069] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:35:0)
[00:17:24.069] Timer tick, asking Buildbucket for the build status
[00:17:24.188] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:24.188] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:36:0) after 1m0s
[00:18:24.272] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:36:0)
[00:18:24.272] Timer tick, asking Buildbucket for the build status
[00:18:24.394] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:24.394] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:37:0) after 1m0s
[00:19:24.423] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:37:0)
[00:19:24.423] Timer tick, asking Buildbucket for the build status
[00:19:24.569] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:24.569] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:38:0) after 1m0s
[00:20:24.671] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:38:0)
[00:20:24.671] Timer tick, asking Buildbucket for the build status
[00:20:24.783] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:24.783] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:39:0) after 1m0s
[00:21:24.828] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:39:0)
[00:21:24.828] Timer tick, asking Buildbucket for the build status
[00:21:24.917] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:24.917] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:40:0) after 1m0s
[00:22:24.969] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:40:0)
[00:22:24.969] Timer tick, asking Buildbucket for the build status
[00:22:25.063] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:25.063] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:41:0) after 1m0s
[00:23:25.173] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:41:0)
[00:23:25.173] Timer tick, asking Buildbucket for the build status
[00:23:25.271] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:25.271] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:42:0) after 1m0s
[00:24:25.295] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:42:0)
[00:24:25.295] Timer tick, asking Buildbucket for the build status
[00:24:25.389] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:25.389] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:43:0) after 1m0s
[00:25:25.465] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:43:0)
[00:25:25.465] Timer tick, asking Buildbucket for the build status
[00:25:25.568] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:25.568] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:44:0) after 1m0s
[00:26:25.611] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:44:0)
[00:26:25.611] Timer tick, asking Buildbucket for the build status
[00:26:25.723] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:25.724] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:45:0) after 1m0s
[00:27:25.758] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:45:0)
[00:27:25.758] Timer tick, asking Buildbucket for the build status
[00:27:25.911] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:25.911] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:46:0) after 1m0s
[00:28:25.957] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:46:0)
[00:28:25.957] Timer tick, asking Buildbucket for the build status
[00:28:26.059] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:26.059] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:47:0) after 1m0s
[00:29:26.103] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:47:0)
[00:29:26.103] Timer tick, asking Buildbucket for the build status
[00:29:26.263] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:26.263] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:48:0) after 1m0s
[00:30:26.314] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:48:0)
[00:30:26.314] Timer tick, asking Buildbucket for the build status
[00:30:26.452] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:26.452] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:49:0) after 1m0s
[00:31:26.480] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:49:0)
[00:31:26.480] Timer tick, asking Buildbucket for the build status
[00:31:26.601] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:26.601] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:50:0) after 1m0s
[00:32:26.670] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:50:0)
[00:32:26.670] Timer tick, asking Buildbucket for the build status
[00:32:26.768] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:26.768] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:51:0) after 1m0s
[00:33:26.860] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:51:0)
[00:33:26.860] Timer tick, asking Buildbucket for the build status
[00:33:26.962] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:26.962] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:52:0) after 1m0s
[00:34:27.064] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:52:0)
[00:34:27.064] Timer tick, asking Buildbucket for the build status
[00:34:27.186] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:27.186] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:53:0) after 1m0s
[00:35:27.212] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:53:0)
[00:35:27.212] Timer tick, asking Buildbucket for the build status
[00:35:27.333] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:27.333] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:54:0) after 1m0s
[00:36:27.419] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:54:0)
[00:36:27.419] Timer tick, asking Buildbucket for the build status
[00:36:27.539] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:27.539] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:55:0) after 1m0s
[00:37:27.583] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:55:0)
[00:37:27.583] Timer tick, asking Buildbucket for the build status
[00:37:27.692] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:27.692] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:56:0) after 1m0s
[00:38:27.721] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:56:0)
[00:38:27.721] Timer tick, asking Buildbucket for the build status
[00:38:27.847] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:27.847] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:57:0) after 1m0s
[00:39:27.940] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:57:0)
[00:39:27.940] Timer tick, asking Buildbucket for the build status
[00:39:28.062] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:28.062] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:58:0) after 1m0s
[00:40:28.093] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:58:0)
[00:40:28.093] Timer tick, asking Buildbucket for the build status
[00:40:28.192] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:28.192] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:59:0) after 1m0s
[00:41:28.274] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:59:0)
[00:41:28.274] Timer tick, asking Buildbucket for the build status
[00:41:28.386] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:28.386] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:60:0) after 1m0s
[00:42:28.408] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:60:0)
[00:42:28.408] Timer tick, asking Buildbucket for the build status
[00:42:28.593] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:28.593] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:61:0) after 1m0s
[00:43:28.631] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:61:0)
[00:43:28.631] Timer tick, asking Buildbucket for the build status
[00:43:28.744] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:28.744] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:62:0) after 1m0s
[00:44:28.763] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:62:0)
[00:44:28.763] Timer tick, asking Buildbucket for the build status
[00:44:28.887] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:28.887] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:63:0) after 1m0s
[00:45:28.922] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:63:0)
[00:45:28.922] Timer tick, asking Buildbucket for the build status
[00:45:29.045] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:29.045] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:64:0) after 1m0s
[00:46:29.075] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:64:0)
[00:46:29.075] Timer tick, asking Buildbucket for the build status
[00:46:29.271] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:29.271] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:65:0) after 1m0s
[00:47:29.304] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:65:0)
[00:47:29.304] Timer tick, asking Buildbucket for the build status
[00:47:29.412] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:29.412] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:66:0) after 1m0s
[00:48:29.528] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:66:0)
[00:48:29.528] Timer tick, asking Buildbucket for the build status
[00:48:29.693] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:29.693] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:67:0) after 1m0s
[00:49:29.729] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:67:0)
[00:49:29.729] Timer tick, asking Buildbucket for the build status
[00:49:29.841] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:29.841] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:68:0) after 1m0s
[00:50:29.933] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:68:0)
[00:50:29.933] Timer tick, asking Buildbucket for the build status
[00:50:30.023] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:30.023] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:69:0) after 1m0s
[00:51:30.145] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:69:0)
[00:51:30.145] Timer tick, asking Buildbucket for the build status
[00:51:30.259] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:30.259] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:70:0) after 1m0s
[00:52:30.328] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:70:0)
[00:52:30.328] Timer tick, asking Buildbucket for the build status
[00:52:30.435] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:30.435] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:71:0) after 1m0s
[00:53:30.529] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:71:0)
[00:53:30.529] Timer tick, asking Buildbucket for the build status
[00:53:30.637] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:30.637] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:72:0) after 1m0s
[00:54:30.677] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:72:0)
[00:54:30.677] Timer tick, asking Buildbucket for the build status
[00:54:30.787] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:30.787] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:73:0) after 1m0s
[00:55:30.856] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:73:0)
[00:55:30.856] Timer tick, asking Buildbucket for the build status
[00:55:30.956] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:30.956] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:74:0) after 1m0s
[00:56:31.035] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:74:0)
[00:56:31.035] Timer tick, asking Buildbucket for the build status
[00:56:31.285] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:31.285] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:75:0) after 1m0s
[00:57:31.329] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:75:0)
[00:57:31.329] Timer tick, asking Buildbucket for the build status
[00:57:31.433] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:31.433] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:76:0) after 1m0s
[00:58:31.458] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:76:0)
[00:58:31.458] Timer tick, asking Buildbucket for the build status
[00:58:31.558] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:31.558] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:77:0) after 1m0s
[00:59:31.671] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:77:0)
[00:59:31.671] Timer tick, asking Buildbucket for the build status
[00:59:31.774] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:31.774] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:78:0) after 1m0s
[01:00:31.862] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:78:0)
[01:00:31.862] Timer tick, asking Buildbucket for the build status
[01:00:31.983] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:31.983] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:79:0) after 1m0s
[01:01:32.060] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:79:0)
[01:01:32.061] Timer tick, asking Buildbucket for the build status
[01:01:32.185] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:32.185] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:80:0) after 1m0s
[01:02:32.227] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:80:0)
[01:02:32.227] Timer tick, asking Buildbucket for the build status
[01:02:32.342] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:32.342] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:81:0) after 1m0s
[01:03:32.373] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:81:0)
[01:03:32.373] Timer tick, asking Buildbucket for the build status
[01:03:32.473] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:32.473] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:82:0) after 1m0s
[01:04:32.518] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:82:0)
[01:04:32.518] Timer tick, asking Buildbucket for the build status
[01:04:32.651] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:32.651] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:83:0) after 1m0s
[01:05:32.731] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:83:0)
[01:05:32.731] Timer tick, asking Buildbucket for the build status
[01:05:32.857] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:32.857] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:84:0) after 1m0s
[01:06:32.970] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:84:0)
[01:06:32.970] Timer tick, asking Buildbucket for the build status
[01:06:33.095] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:33.095] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:85:0) after 1m0s
[01:07:33.126] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:85:0)
[01:07:33.126] Timer tick, asking Buildbucket for the build status
[01:07:33.237] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:33.237] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:86:0) after 1m0s
[01:08:33.262] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:86:0)
[01:08:33.262] Timer tick, asking Buildbucket for the build status
[01:08:33.371] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:33.371] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:87:0) after 1m0s
[01:09:33.471] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:87:0)
[01:09:33.471] Timer tick, asking Buildbucket for the build status
[01:09:33.585] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:33.585] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:88:0) after 1m0s
[01:10:33.670] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:88:0)
[01:10:33.670] Timer tick, asking Buildbucket for the build status
[01:10:33.770] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:33.770] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:89:0) after 1m0s
[01:11:33.818] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:89:0)
[01:11:33.818] Timer tick, asking Buildbucket for the build status
[01:11:33.934] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:33.934] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:90:0) after 1m0s
[01:12:33.965] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:90:0)
[01:12:33.965] Timer tick, asking Buildbucket for the build status
[01:12:34.097] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:34.097] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:91:0) after 1m0s
[01:13:34.160] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:91:0)
[01:13:34.160] Timer tick, asking Buildbucket for the build status
[01:13:34.265] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:34.265] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:92:0) after 1m0s
[01:14:34.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:92:0)
[01:14:34.369] Timer tick, asking Buildbucket for the build status
[01:14:34.473] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:34.473] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:93:0) after 1m0s
[01:15:34.558] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:93:0)
[01:15:34.558] Timer tick, asking Buildbucket for the build status
[01:15:34.663] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:34.663] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:94:0) after 1m0s
[01:16:34.718] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:94:0)
[01:16:34.718] Timer tick, asking Buildbucket for the build status
[01:16:34.831] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:34.831] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:95:0) after 1m0s
[01:17:34.868] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:95:0)
[01:17:34.868] Timer tick, asking Buildbucket for the build status
[01:17:34.959] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:34.959] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:96:0) after 1m0s
[01:18:35.058] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:96:0)
[01:18:35.058] Timer tick, asking Buildbucket for the build status
[01:18:35.172] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:35.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:97:0) after 1m0s
[01:19:35.225] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:97:0)
[01:19:35.225] Timer tick, asking Buildbucket for the build status
[01:19:35.368] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:35.368] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:98:0) after 1m0s
[01:20:35.393] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:98:0)
[01:20:35.393] Timer tick, asking Buildbucket for the build status
[01:20:35.484] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:35.484] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:99:0) after 1m0s
[01:21:35.533] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:99:0)
[01:21:35.533] Timer tick, asking Buildbucket for the build status
[01:21:35.640] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:35.640] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:100:0) after 1m0s
[01:22:35.690] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:100:0)
[01:22:35.690] Timer tick, asking Buildbucket for the build status
[01:22:35.785] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:35.785] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:101:0) after 1m0s
[01:23:35.871] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:101:0)
[01:23:35.871] Timer tick, asking Buildbucket for the build status
[01:23:35.972] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:35.972] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:102:0) after 1m0s
[01:24:36.000] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:102:0)
[01:24:36.000] Timer tick, asking Buildbucket for the build status
[01:24:36.168] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:36.168] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:103:0) after 1m0s
[01:25:36.260] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:103:0)
[01:25:36.260] Timer tick, asking Buildbucket for the build status
[01:25:36.365] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:36.365] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:104:0) after 1m0s
[01:26:36.457] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:104:0)
[01:26:36.457] Timer tick, asking Buildbucket for the build status
[01:26:36.588] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:36.588] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:105:0) after 1m0s
[01:27:36.629] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:105:0)
[01:27:36.629] Timer tick, asking Buildbucket for the build status
[01:27:36.734] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:36.734] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:106:0) after 1m0s
[01:28:36.830] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:106:0)
[01:28:36.830] Timer tick, asking Buildbucket for the build status
[01:28:36.934] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:36.934] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:107:0) after 1m0s
[01:29:36.978] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:107:0)
[01:29:36.978] Timer tick, asking Buildbucket for the build status
[01:29:37.077] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:37.077] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:108:0) after 1m0s
[01:30:37.130] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:108:0)
[01:30:37.130] Timer tick, asking Buildbucket for the build status
[01:30:37.241] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:37.241] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:109:0) after 1m0s
[01:31:37.265] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:109:0)
[01:31:37.265] Timer tick, asking Buildbucket for the build status
[01:31:37.377] Build 8854552837868082432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:37.377] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:110:0) after 1m0s
[01:32:06.264] Received PubSub notification, asking Buildbucket for the build status
[01:32:06.361] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:37.477] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:110:0)
[01:32:37.477] Timer tick, asking Buildbucket for the build status
[01:32:37.614] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:37.614] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:112:0) after 1m0s
[01:33:37.720] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:112:0)
[01:33:37.720] Timer tick, asking Buildbucket for the build status
[01:33:37.828] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:37.828] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:113:0) after 1m0s
[01:34:37.925] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:113:0)
[01:34:37.925] Timer tick, asking Buildbucket for the build status
[01:34:38.065] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:38.065] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:114:0) after 1m0s
[01:35:38.127] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:114:0)
[01:35:38.127] Timer tick, asking Buildbucket for the build status
[01:35:38.242] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:38.242] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:115:0) after 1m0s
[01:36:38.272] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:115:0)
[01:36:38.272] Timer tick, asking Buildbucket for the build status
[01:36:38.381] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:38.381] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:116:0) after 1m0s
[01:37:38.403] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:116:0)
[01:37:38.403] Timer tick, asking Buildbucket for the build status
[01:37:38.575] Build 8854552837868082432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:38.575] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9019982899926754576:117:0) after 1m0s
[01:37:58.928] Received PubSub notification, asking Buildbucket for the build status
[01:37:59.032] Build 8854552837868082432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:37:59.032] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1614044277472562",
"created_by": "project:infra",
"created_ts": "1614037397471482",
"id": "8854552837868082432",
"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\": \"eb82da051f0112b81f6bfdedc849418a2073d3ad\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@eb82da051f0112b81f6bfdedc849418a2073d3ad\", \"title\": \"eb82da051f0112b81f6bfdedc849418a2073d3ad\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/eb82da051f0112b81f6bfdedc849418a2073d3ad\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\", \"title\": \"0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0afc7c77bdcc58e6195c98aa02fcc9a3c0ad657b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"41a39d580b801747c7e37be68df9f4ce348c57fd\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@41a39d580b801747c7e37be68df9f4ce348c57fd\", \"title\": \"41a39d580b801747c7e37be68df9f4ce348c57fd\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/41a39d580b801747c7e37be68df9f4ce348c57fd\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c50b1e07f86183bc737bdea4bf2c64db37384e60\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c50b1e07f86183bc737bdea4bf2c64db37384e60\", \"title\": \"c50b1e07f86183bc737bdea4bf2c64db37384e60\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c50b1e07f86183bc737bdea4bf2c64db37384e60\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"ca2389b577053bc43e7701a4b258f70b51f85aed\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ca2389b577053bc43e7701a4b258f70b51f85aed\", \"title\": \"ca2389b577053bc43e7701a4b258f70b51f85aed\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/ca2389b577053bc43e7701a4b258f70b51f85aed\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\", \"title\": \"a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/a96e61e2c2310dced95f3fa2f6062e837d7f0c5b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"079d6fd5364a75f334a34ad7359f7aed4ef627be\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@079d6fd5364a75f334a34ad7359f7aed4ef627be\", \"title\": \"079d6fd5364a75f334a34ad7359f7aed4ef627be\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/079d6fd5364a75f334a34ad7359f7aed4ef627be\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"622248c321175ec240f31f4770943381b614378b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@622248c321175ec240f31f4770943381b614378b\", \"title\": \"622248c321175ec240f31f4770943381b614378b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/622248c321175ec240f31f4770943381b614378b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\", \"title\": \"b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b8c2b8803e63af387cbc8a5e6b7b974426f5a0f6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\", \"title\": \"4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/4d6cb7232cec7f97cbce3f16ac603d7d79aa810e\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\", \"title\": \"f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f72565f5b80b6b6496e7e3ae49bdad8e7ccce794\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\", \"title\": \"7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/7609c25cfa3e3f4bd9a7458ebc0f4ac9e9107778\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"04f38e41316ff9712f952faa8067b893f2456f6c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@04f38e41316ff9712f952faa8067b893f2456f6c\", \"title\": \"04f38e41316ff9712f952faa8067b893f2456f6c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"04f38e41316ff9712f952faa8067b893f2456f6c\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"04f38e41316ff9712f952faa8067b893f2456f6c\", \"got_revision_cp\": \"refs/heads/master@{#38721}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"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-y7r8\"], \"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\": [\"5709-d3c4474\"], \"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": "1614043921902439",
"status": "COMPLETED",
"status_changed_ts": "1614043922444084",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18678",
"builder:infra-continuous-win10-64",
"buildset:commit/git/04f38e41316ff9712f952faa8067b893f2456f6c",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/04f38e41316ff9712f952faa8067b893f2456f6c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019982899926754576",
"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/8854552837868082432/+/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:51e4f1bbc2150910",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1614044277472904",
"url": "https://luci-milo-dev.appspot.com/b/8854552837868082432",
"utcnow_ts": "1614044279023691"
}
}
[01:37:59.032] Invocation finished in 1h54m42.907962607s with status SUCCEEDED