[00:30:40.377] New invocation is queued and will start shortly
[00:30:41.458] Starting the invocation (attempt 1)
[00:30:41.502] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[00:30:41.502] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[00:30:41.502] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9028949017205578912",
"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\":\"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8dbde6c72f95854f5f54bdef720b7598ba840b5\",\"title\":\"b8dbde6c72f95854f5f54bdef720b7598ba840b5\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}}",
"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:9028949017205578912",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"gitiles_ref:refs/heads/master"
]
}
[00:30:42.609] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1605486641641798",
"id": "8863518955212541456",
"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\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8dbde6c72f95854f5f54bdef720b7598ba840b5\", \"title\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605486642399808",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18027",
"builder:infra-continuous-win10-64",
"buildset:commit/git/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028949017205578912",
"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/8863518955212541456/+/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": "1605486642399975",
"url": "https://luci-milo-dev.appspot.com/b/8863518955212541456",
"utcnow_ts": "1605486642595490"
}
}
[00:30:42.609] Task URL: https://luci-milo-dev.appspot.com/b/8863518955212541456
[00:30:42.609] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:2:0) after 1m0s
[00:31:42.638] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:2:0)
[00:31:42.638] Timer tick, asking Buildbucket for the build status
[00:31:42.736] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:42.736] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:3:0) after 1m0s
[00:32:42.759] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:3:0)
[00:32:42.759] Timer tick, asking Buildbucket for the build status
[00:32:42.846] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:42.846] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:4:0) after 1m0s
[00:33:42.868] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:4:0)
[00:33:42.868] Timer tick, asking Buildbucket for the build status
[00:33:42.995] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:42.995] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:5:0) after 1m0s
[00:34:43.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:5:0)
[00:34:43.118] Timer tick, asking Buildbucket for the build status
[00:34:43.227] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:43.227] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:6:0) after 1m0s
[00:35:43.345] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:6:0)
[00:35:43.345] Timer tick, asking Buildbucket for the build status
[00:35:43.451] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:43.451] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:7:0) after 1m0s
[00:36:43.575] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:7:0)
[00:36:43.575] Timer tick, asking Buildbucket for the build status
[00:36:43.699] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:43.699] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:8:0) after 1m0s
[00:37:43.802] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:8:0)
[00:37:43.802] Timer tick, asking Buildbucket for the build status
[00:37:43.905] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:43.905] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:9:0) after 1m0s
[00:38:43.945] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:9:0)
[00:38:43.945] Timer tick, asking Buildbucket for the build status
[00:38:44.049] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:44.049] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:10:0) after 1m0s
[00:39:44.072] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:10:0)
[00:39:44.072] Timer tick, asking Buildbucket for the build status
[00:39:44.177] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:44.178] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:11:0) after 1m0s
[00:40:44.233] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:11:0)
[00:40:44.233] Timer tick, asking Buildbucket for the build status
[00:40:44.427] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:44.428] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:12:0) after 1m0s
[00:41:44.483] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:12:0)
[00:41:44.483] Timer tick, asking Buildbucket for the build status
[00:41:44.612] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:44.612] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:13:0) after 1m0s
[00:42:44.665] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:13:0)
[00:42:44.665] Timer tick, asking Buildbucket for the build status
[00:42:44.838] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:44.838] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:14:0) after 1m0s
[00:43:44.922] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:14:0)
[00:43:44.922] Timer tick, asking Buildbucket for the build status
[00:43:45.082] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:45.082] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:15:0) after 1m0s
[00:44:45.173] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:15:0)
[00:44:45.173] Timer tick, asking Buildbucket for the build status
[00:44:45.291] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:45.291] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:16:0) after 1m0s
[00:45:45.336] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:16:0)
[00:45:45.336] Timer tick, asking Buildbucket for the build status
[00:45:45.462] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:45.462] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:17:0) after 1m0s
[00:46:45.499] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:17:0)
[00:46:45.499] Timer tick, asking Buildbucket for the build status
[00:46:45.614] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:45.614] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:18:0) after 1m0s
[00:47:45.704] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:18:0)
[00:47:45.704] Timer tick, asking Buildbucket for the build status
[00:47:45.849] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:45.849] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:19:0) after 1m0s
[00:48:45.881] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:19:0)
[00:48:45.881] Timer tick, asking Buildbucket for the build status
[00:48:46.075] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:46.075] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:20:0) after 1m0s
[00:49:46.112] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:20:0)
[00:49:46.112] Timer tick, asking Buildbucket for the build status
[00:49:46.207] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:46.207] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:21:0) after 1m0s
[00:50:46.229] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:21:0)
[00:50:46.229] Timer tick, asking Buildbucket for the build status
[00:50:46.361] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:46.361] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:22:0) after 1m0s
[00:51:46.384] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:22:0)
[00:51:46.384] Timer tick, asking Buildbucket for the build status
[00:51:46.480] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:46.480] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:23:0) after 1m0s
[00:52:46.592] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:23:0)
[00:52:46.592] Timer tick, asking Buildbucket for the build status
[00:52:46.684] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:46.684] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:24:0) after 1m0s
[00:53:46.715] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:24:0)
[00:53:46.715] Timer tick, asking Buildbucket for the build status
[00:53:46.807] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:46.807] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:25:0) after 1m0s
[00:54:46.839] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:25:0)
[00:54:46.839] Timer tick, asking Buildbucket for the build status
[00:54:46.954] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:46.954] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:26:0) after 1m0s
[00:55:46.978] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:26:0)
[00:55:46.978] Timer tick, asking Buildbucket for the build status
[00:55:47.113] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:47.113] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:27:0) after 1m0s
[00:56:47.145] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:27:0)
[00:56:47.145] Timer tick, asking Buildbucket for the build status
[00:56:47.244] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:47.244] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:28:0) after 1m0s
[00:57:47.299] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:28:0)
[00:57:47.300] Timer tick, asking Buildbucket for the build status
[00:57:47.397] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:47.397] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:29:0) after 1m0s
[00:58:47.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:29:0)
[00:58:47.512] Timer tick, asking Buildbucket for the build status
[00:58:47.620] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:47.620] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:30:0) after 1m0s
[00:59:47.712] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:30:0)
[00:59:47.712] Timer tick, asking Buildbucket for the build status
[00:59:47.816] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:47.816] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:31:0) after 1m0s
[01:00:47.843] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:31:0)
[01:00:47.843] Timer tick, asking Buildbucket for the build status
[01:00:48.001] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:48.001] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:32:0) after 1m0s
[01:01:48.078] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:32:0)
[01:01:48.078] Timer tick, asking Buildbucket for the build status
[01:01:48.193] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:48.193] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:33:0) after 1m0s
[01:02:48.296] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:33:0)
[01:02:48.296] Timer tick, asking Buildbucket for the build status
[01:02:48.401] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:48.401] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:34:0) after 1m0s
[01:03:48.427] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:34:0)
[01:03:48.427] Timer tick, asking Buildbucket for the build status
[01:03:48.542] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:48.542] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:35:0) after 1m0s
[01:04:48.616] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:35:0)
[01:04:48.616] Timer tick, asking Buildbucket for the build status
[01:04:48.734] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:48.734] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:36:0) after 1m0s
[01:05:48.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:36:0)
[01:05:48.798] Timer tick, asking Buildbucket for the build status
[01:05:48.913] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:48.913] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:37:0) after 1m0s
[01:06:48.959] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:37:0)
[01:06:48.959] Timer tick, asking Buildbucket for the build status
[01:06:49.068] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:49.068] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:38:0) after 1m0s
[01:07:49.116] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:38:0)
[01:07:49.116] Timer tick, asking Buildbucket for the build status
[01:07:49.232] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:49.233] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:39:0) after 1m0s
[01:08:49.255] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:39:0)
[01:08:49.255] Timer tick, asking Buildbucket for the build status
[01:08:49.378] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:49.378] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:40:0) after 1m0s
[01:09:49.413] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:40:0)
[01:09:49.413] Timer tick, asking Buildbucket for the build status
[01:09:49.519] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:49.519] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:41:0) after 1m0s
[01:10:49.550] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:41:0)
[01:10:49.550] Timer tick, asking Buildbucket for the build status
[01:10:49.766] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:49.766] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:42:0) after 1m0s
[01:11:49.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:42:0)
[01:11:49.809] Timer tick, asking Buildbucket for the build status
[01:11:49.923] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:49.923] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:43:0) after 1m0s
[01:12:49.997] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:43:0)
[01:12:49.997] Timer tick, asking Buildbucket for the build status
[01:12:50.109] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:50.109] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:44:0) after 1m0s
[01:13:50.169] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:44:0)
[01:13:50.169] Timer tick, asking Buildbucket for the build status
[01:13:50.261] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:50.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:45:0) after 1m0s
[01:14:50.873] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:45:0)
[01:14:50.873] Timer tick, asking Buildbucket for the build status
[01:14:50.973] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:50.973] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:46:0) after 1m0s
[01:15:51.085] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:46:0)
[01:15:51.085] Timer tick, asking Buildbucket for the build status
[01:15:51.235] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:51.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:47:0) after 1m0s
[01:16:51.315] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:47:0)
[01:16:51.315] Timer tick, asking Buildbucket for the build status
[01:16:51.433] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:51.433] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:48:0) after 1m0s
[01:17:51.477] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:48:0)
[01:17:51.477] Timer tick, asking Buildbucket for the build status
[01:17:51.580] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:51.580] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:49:0) after 1m0s
[01:18:51.607] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:49:0)
[01:18:51.607] Timer tick, asking Buildbucket for the build status
[01:18:51.718] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:51.718] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:50:0) after 1m0s
[01:19:51.772] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:50:0)
[01:19:51.772] Timer tick, asking Buildbucket for the build status
[01:19:51.863] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:51.863] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:51:0) after 1m0s
[01:20:51.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:51:0)
[01:20:51.892] Timer tick, asking Buildbucket for the build status
[01:20:51.989] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:51.989] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:52:0) after 1m0s
[01:21:52.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:52:0)
[01:21:52.118] Timer tick, asking Buildbucket for the build status
[01:21:52.247] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:52.247] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:53:0) after 1m0s
[01:22:52.271] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:53:0)
[01:22:52.271] Timer tick, asking Buildbucket for the build status
[01:22:52.460] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:52.460] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:54:0) after 1m0s
[01:23:52.506] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:54:0)
[01:23:52.506] Timer tick, asking Buildbucket for the build status
[01:23:52.609] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:52.609] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:55:0) after 1m0s
[01:24:52.713] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:55:0)
[01:24:52.713] Timer tick, asking Buildbucket for the build status
[01:24:52.899] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:52.899] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:56:0) after 1m0s
[01:25:52.922] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:56:0)
[01:25:52.922] Timer tick, asking Buildbucket for the build status
[01:25:53.010] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:53.010] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:57:0) after 1m0s
[01:26:53.116] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:57:0)
[01:26:53.116] Timer tick, asking Buildbucket for the build status
[01:26:53.232] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:53.232] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:58:0) after 1m0s
[01:27:53.318] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:58:0)
[01:27:53.318] Timer tick, asking Buildbucket for the build status
[01:27:53.432] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:53.432] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:59:0) after 1m0s
[01:28:53.471] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:59:0)
[01:28:53.471] Timer tick, asking Buildbucket for the build status
[01:28:53.583] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:53.583] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:60:0) after 1m0s
[01:29:53.622] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:60:0)
[01:29:53.622] Timer tick, asking Buildbucket for the build status
[01:29:53.731] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:53.731] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:61:0) after 1m0s
[01:30:53.742] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:61:0)
[01:30:53.742] Timer tick, asking Buildbucket for the build status
[01:30:53.916] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:53.916] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:62:0) after 1m0s
[01:31:54.000] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:62:0)
[01:31:54.000] Timer tick, asking Buildbucket for the build status
[01:31:54.138] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:54.138] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:63:0) after 1m0s
[01:32:54.161] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:63:0)
[01:32:54.161] Timer tick, asking Buildbucket for the build status
[01:32:54.257] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:54.257] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:64:0) after 1m0s
[01:33:54.318] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:64:0)
[01:33:54.318] Timer tick, asking Buildbucket for the build status
[01:33:54.430] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:54.430] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:65:0) after 1m0s
[01:34:54.500] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:65:0)
[01:34:54.500] Timer tick, asking Buildbucket for the build status
[01:34:54.626] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:54.626] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:66:0) after 1m0s
[01:35:54.663] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:66:0)
[01:35:54.663] Timer tick, asking Buildbucket for the build status
[01:35:54.777] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:54.778] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:67:0) after 1m0s
[01:36:54.800] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:67:0)
[01:36:54.800] Timer tick, asking Buildbucket for the build status
[01:36:54.920] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:54.920] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:68:0) after 1m0s
[01:37:55.037] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:68:0)
[01:37:55.037] Timer tick, asking Buildbucket for the build status
[01:37:55.144] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:55.144] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:69:0) after 1m0s
[01:38:55.314] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:69:0)
[01:38:55.314] Timer tick, asking Buildbucket for the build status
[01:38:55.434] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:55.434] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:70:0) after 1m0s
[01:39:55.521] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:70:0)
[01:39:55.521] Timer tick, asking Buildbucket for the build status
[01:39:55.834] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:55.834] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:71:0) after 1m0s
[01:40:55.865] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:71:0)
[01:40:55.865] Timer tick, asking Buildbucket for the build status
[01:40:56.182] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:56.182] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:72:0) after 1m0s
[01:41:56.208] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:72:0)
[01:41:56.208] Timer tick, asking Buildbucket for the build status
[01:41:56.524] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:56.524] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:73:0) after 1m0s
[01:42:56.604] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:73:0)
[01:42:56.604] Timer tick, asking Buildbucket for the build status
[01:42:56.988] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:56.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:74:0) after 1m0s
[01:43:57.098] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:74:0)
[01:43:57.098] Timer tick, asking Buildbucket for the build status
[01:43:57.458] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:57.459] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:75:0) after 1m0s
[01:44:57.513] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:75:0)
[01:44:57.514] Timer tick, asking Buildbucket for the build status
[01:44:58.113] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:58.113] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:76:0) after 1m0s
[01:45:58.158] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:76:0)
[01:45:58.158] Timer tick, asking Buildbucket for the build status
[01:45:58.520] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:58.520] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:77:0) after 1m0s
[01:46:58.622] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:77:0)
[01:46:58.622] Timer tick, asking Buildbucket for the build status
[01:46:59.011] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:59.011] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:78:0) after 1m0s
[01:47:59.101] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:78:0)
[01:47:59.101] Timer tick, asking Buildbucket for the build status
[01:47:59.475] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:59.475] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:79:0) after 1m0s
[01:48:59.501] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:79:0)
[01:48:59.501] Timer tick, asking Buildbucket for the build status
[01:48:59.871] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:59.871] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:80:0) after 1m0s
[01:49:59.923] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:80:0)
[01:49:59.923] Timer tick, asking Buildbucket for the build status
[01:50:00.456] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:00.456] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:81:0) after 1m0s
[01:51:00.483] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:81:0)
[01:51:00.483] Timer tick, asking Buildbucket for the build status
[01:51:00.873] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:00.873] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:82:0) after 1m0s
[01:52:00.922] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:82:0)
[01:52:00.922] Timer tick, asking Buildbucket for the build status
[01:52:01.367] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:01.368] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:83:0) after 1m0s
[01:53:06.462] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:83:0)
[01:53:06.462] Timer tick, asking Buildbucket for the build status
[01:53:06.762] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:06.762] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:84:0) after 1m0s
[01:54:06.887] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:84:0)
[01:54:06.887] Timer tick, asking Buildbucket for the build status
[01:54:07.045] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:07.045] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:85:0) after 1m0s
[01:55:07.115] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:85:0)
[01:55:07.115] Timer tick, asking Buildbucket for the build status
[01:55:07.467] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:07.467] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:86:0) after 1m0s
[01:56:07.516] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:86:0)
[01:56:07.516] Timer tick, asking Buildbucket for the build status
[01:56:07.629] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:07.629] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:87:0) after 1m0s
[01:57:08.107] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:87:0)
[01:57:08.107] Timer tick, asking Buildbucket for the build status
[01:57:08.446] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:08.446] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:88:0) after 1m0s
[01:58:08.517] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:88:0)
[01:58:08.517] Timer tick, asking Buildbucket for the build status
[01:58:08.882] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:08.882] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:89:0) after 1m0s
[01:59:08.913] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:89:0)
[01:59:08.913] Timer tick, asking Buildbucket for the build status
[01:59:09.069] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:09.069] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:90:0) after 1m0s
[02:00:09.799] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:90:0)
[02:00:09.799] Timer tick, asking Buildbucket for the build status
[02:00:10.294] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:10.294] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:91:0) after 1m0s
[02:01:10.410] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:91:0)
[02:01:10.410] Timer tick, asking Buildbucket for the build status
[02:01:10.820] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:10.820] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:92:0) after 1m0s
[02:02:10.880] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:92:0)
[02:02:10.880] Timer tick, asking Buildbucket for the build status
[02:02:11.053] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:11.053] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:93:0) after 1m0s
[02:03:11.108] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:93:0)
[02:03:11.108] Timer tick, asking Buildbucket for the build status
[02:03:11.547] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:11.547] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:94:0) after 1m0s
[02:04:11.626] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:94:0)
[02:04:11.626] Timer tick, asking Buildbucket for the build status
[02:04:11.762] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:11.762] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:95:0) after 1m0s
[02:05:11.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:95:0)
[02:05:11.798] Timer tick, asking Buildbucket for the build status
[02:05:12.305] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:12.305] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:96:0) after 1m0s
[02:06:12.419] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:96:0)
[02:06:12.419] Timer tick, asking Buildbucket for the build status
[02:06:12.654] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:12.654] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:97:0) after 1m0s
[02:07:12.706] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:97:0)
[02:07:12.706] Timer tick, asking Buildbucket for the build status
[02:07:13.183] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:13.183] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:98:0) after 1m0s
[02:08:13.381] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:98:0)
[02:08:13.381] Timer tick, asking Buildbucket for the build status
[02:08:13.547] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:13.547] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:99:0) after 1m0s
[02:09:13.783] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:99:0)
[02:09:13.783] Timer tick, asking Buildbucket for the build status
[02:09:13.901] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:13.901] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:100:0) after 1m0s
[02:10:14.123] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:100:0)
[02:10:14.123] Timer tick, asking Buildbucket for the build status
[02:10:14.637] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:14.637] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:101:0) after 1m0s
[02:11:14.844] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:101:0)
[02:11:14.844] Timer tick, asking Buildbucket for the build status
[02:11:14.948] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:14.948] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:102:0) after 1m0s
[02:12:15.074] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:102:0)
[02:12:15.074] Timer tick, asking Buildbucket for the build status
[02:12:15.165] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:15.165] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:103:0) after 1m0s
[02:13:15.284] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:103:0)
[02:13:15.284] Timer tick, asking Buildbucket for the build status
[02:13:15.473] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:15.473] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:104:0) after 1m0s
[02:14:15.612] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:104:0)
[02:14:15.612] Timer tick, asking Buildbucket for the build status
[02:14:15.976] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:15.976] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:105:0) after 1m0s
[02:15:16.016] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:105:0)
[02:15:16.016] Timer tick, asking Buildbucket for the build status
[02:15:16.116] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:16.116] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:106:0) after 1m0s
[02:16:16.154] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:106:0)
[02:16:16.154] Timer tick, asking Buildbucket for the build status
[02:16:16.479] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:16.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:107:0) after 1m0s
[02:17:16.566] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:107:0)
[02:17:16.567] Timer tick, asking Buildbucket for the build status
[02:17:16.670] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:16.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:108:0) after 1m0s
[02:18:16.711] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:108:0)
[02:18:16.711] Timer tick, asking Buildbucket for the build status
[02:18:17.009] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:17.009] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:109:0) after 1m0s
[02:19:17.103] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:109:0)
[02:19:17.103] Timer tick, asking Buildbucket for the build status
[02:19:17.217] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:17.217] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:110:0) after 1m0s
[02:20:17.246] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:110:0)
[02:20:17.246] Timer tick, asking Buildbucket for the build status
[02:20:17.712] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:17.712] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:111:0) after 1m0s
[02:21:17.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:111:0)
[02:21:17.743] Timer tick, asking Buildbucket for the build status
[02:21:17.917] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:17.917] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:112:0) after 1m0s
[02:22:18.000] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:112:0)
[02:22:18.000] Timer tick, asking Buildbucket for the build status
[02:22:18.444] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:18.444] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:113:0) after 1m0s
[02:23:18.536] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:113:0)
[02:23:18.536] Timer tick, asking Buildbucket for the build status
[02:23:19.275] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:19.275] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:114:0) after 1m0s
[02:24:19.315] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:114:0)
[02:24:19.315] Timer tick, asking Buildbucket for the build status
[02:24:19.670] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:19.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:115:0) after 1m0s
[02:25:19.699] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:115:0)
[02:25:19.699] Timer tick, asking Buildbucket for the build status
[02:25:19.981] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:19.981] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:116:0) after 1m0s
[02:26:20.011] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:116:0)
[02:26:20.011] Timer tick, asking Buildbucket for the build status
[02:26:20.235] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:20.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:117:0) after 1m0s
[02:27:20.312] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:117:0)
[02:27:20.312] Timer tick, asking Buildbucket for the build status
[02:27:20.625] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:20.625] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:118:0) after 1m0s
[02:28:20.715] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:118:0)
[02:28:20.715] Timer tick, asking Buildbucket for the build status
[02:28:20.999] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:20.999] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:119:0) after 1m0s
[02:29:21.028] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:119:0)
[02:29:21.029] Timer tick, asking Buildbucket for the build status
[02:29:21.344] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:21.344] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:120:0) after 1m0s
[02:30:21.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:120:0)
[02:30:21.372] Timer tick, asking Buildbucket for the build status
[02:30:21.752] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:21.753] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:121:0) after 1m0s
[02:31:21.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:121:0)
[02:31:21.798] Timer tick, asking Buildbucket for the build status
[02:31:22.107] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:22.107] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:122:0) after 1m0s
[02:32:22.199] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:122:0)
[02:32:22.199] Timer tick, asking Buildbucket for the build status
[02:32:22.791] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:22.791] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:123:0) after 1m0s
[02:33:22.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:123:0)
[02:33:22.898] Timer tick, asking Buildbucket for the build status
[02:33:23.506] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:23.506] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:124:0) after 1m0s
[02:34:23.530] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:124:0)
[02:34:23.530] Timer tick, asking Buildbucket for the build status
[02:34:23.862] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:23.862] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:125:0) after 1m0s
[02:35:23.912] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:125:0)
[02:35:23.912] Timer tick, asking Buildbucket for the build status
[02:35:24.178] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:24.178] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:126:0) after 1m0s
[02:36:24.208] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:126:0)
[02:36:24.208] Timer tick, asking Buildbucket for the build status
[02:36:24.514] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:24.514] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:127:0) after 1m0s
[02:37:24.617] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:127:0)
[02:37:24.617] Timer tick, asking Buildbucket for the build status
[02:37:24.982] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:24.982] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:128:0) after 1m0s
[02:38:25.123] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:128:0)
[02:38:25.123] Timer tick, asking Buildbucket for the build status
[02:38:25.414] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:25.414] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:129:0) after 1m0s
[02:39:25.498] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:129:0)
[02:39:25.498] Timer tick, asking Buildbucket for the build status
[02:39:25.857] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:25.858] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:130:0) after 1m0s
[02:40:25.947] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:130:0)
[02:40:25.947] Timer tick, asking Buildbucket for the build status
[02:40:26.318] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:26.318] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:131:0) after 1m0s
[02:41:26.358] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:131:0)
[02:41:26.358] Timer tick, asking Buildbucket for the build status
[02:41:26.828] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:26.828] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:132:0) after 1m0s
[02:42:26.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:132:0)
[02:42:26.867] Timer tick, asking Buildbucket for the build status
[02:42:27.172] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:27.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:133:0) after 1m0s
[02:43:27.211] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:133:0)
[02:43:27.211] Timer tick, asking Buildbucket for the build status
[02:43:27.531] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:27.531] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:134:0) after 1m0s
[02:44:27.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:134:0)
[02:44:27.597] Timer tick, asking Buildbucket for the build status
[02:44:27.909] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:27.909] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:135:0) after 1m0s
[02:45:28.017] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:135:0)
[02:45:28.017] Timer tick, asking Buildbucket for the build status
[02:45:28.340] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:28.340] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:136:0) after 1m0s
[02:46:28.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:136:0)
[02:46:28.372] Timer tick, asking Buildbucket for the build status
[02:46:28.768] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:28.768] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:137:0) after 1m0s
[02:47:28.812] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:137:0)
[02:47:28.812] Timer tick, asking Buildbucket for the build status
[02:47:29.060] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:29.060] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:138:0) after 1m0s
[02:48:29.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:138:0)
[02:48:29.118] Timer tick, asking Buildbucket for the build status
[02:48:29.373] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:29.373] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:139:0) after 1m0s
[02:49:29.402] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:139:0)
[02:49:29.402] Timer tick, asking Buildbucket for the build status
[02:49:29.829] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:29.829] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:140:0) after 1m0s
[02:50:29.856] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:140:0)
[02:50:29.856] Timer tick, asking Buildbucket for the build status
[02:50:30.240] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:30.240] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:141:0) after 1m0s
[02:51:30.304] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:141:0)
[02:51:30.304] Timer tick, asking Buildbucket for the build status
[02:51:30.594] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:30.594] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:142:0) after 1m0s
[02:52:30.704] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:142:0)
[02:52:30.704] Timer tick, asking Buildbucket for the build status
[02:52:30.994] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:30.994] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:143:0) after 1m0s
[02:53:31.108] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:143:0)
[02:53:31.108] Timer tick, asking Buildbucket for the build status
[02:53:31.386] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:31.386] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:144:0) after 1m0s
[02:54:31.495] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:144:0)
[02:54:31.495] Timer tick, asking Buildbucket for the build status
[02:54:31.805] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:31.805] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:145:0) after 1m0s
[02:55:31.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:145:0)
[02:55:31.898] Timer tick, asking Buildbucket for the build status
[02:55:32.353] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:32.354] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:146:0) after 1m0s
[02:56:32.395] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:146:0)
[02:56:32.396] Timer tick, asking Buildbucket for the build status
[02:56:32.643] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:32.643] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:147:0) after 1m0s
[02:57:32.673] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:147:0)
[02:57:32.673] Timer tick, asking Buildbucket for the build status
[02:57:32.950] Build 8863518955212541456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:32.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:148:0) after 1m0s
[02:57:56.718] Received PubSub notification, asking Buildbucket for the build status
[02:57:56.863] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.005] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:148:0)
[02:58:33.005] Timer tick, asking Buildbucket for the build status
[02:58:33.264] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.264] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:150:0) after 1m0s
[02:59:33.294] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:150:0)
[02:59:33.294] Timer tick, asking Buildbucket for the build status
[02:59:33.436] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:33.436] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:151:0) after 1m0s
[03:00:33.462] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:151:0)
[03:00:33.462] Timer tick, asking Buildbucket for the build status
[03:00:33.805] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:33.806] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:152:0) after 1m0s
[03:01:33.842] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:152:0)
[03:01:33.842] Timer tick, asking Buildbucket for the build status
[03:01:34.121] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:34.121] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:153:0) after 1m0s
[03:02:34.199] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:153:0)
[03:02:34.199] Timer tick, asking Buildbucket for the build status
[03:02:34.496] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:34.496] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:154:0) after 1m0s
[03:03:34.619] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:154:0)
[03:03:34.619] Timer tick, asking Buildbucket for the build status
[03:03:34.895] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:34.895] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:155:0) after 1m0s
[03:04:35.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:155:0)
[03:04:35.001] Timer tick, asking Buildbucket for the build status
[03:04:35.356] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:35.356] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:156:0) after 1m0s
[03:05:35.395] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:156:0)
[03:05:35.395] Timer tick, asking Buildbucket for the build status
[03:05:35.808] Build 8863518955212541456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:35.808] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9028949017205578912:157:0) after 1m0s
[03:06:11.528] Received PubSub notification, asking Buildbucket for the build status
[03:06:11.659] Build 8863518955212541456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:06:11.659] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1605495970182807",
"created_by": "project:infra",
"created_ts": "1605486641641798",
"failure_reason": "BUILD_FAILURE",
"id": "8863518955212541456",
"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\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b8dbde6c72f95854f5f54bdef720b7598ba840b5\", \"title\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\"}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('infra go tests') (retcode: 1)\"}, \"properties\": {\"got_revision\": \"b8dbde6c72f95854f5f54bdef720b7598ba840b5\", \"got_revision_cp\": \"refs/heads/master@{#36436}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-sgx2\"], \"image\": [\"chrome-win10-1703-20101600-6f576df2987\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"Step('infra go tests') (retcode: 1)\"}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1605495472852586",
"status": "COMPLETED",
"status_changed_ts": "1605495474617591",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18027",
"builder:infra-continuous-win10-64",
"buildset:commit/git/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/b8dbde6c72f95854f5f54bdef720b7598ba840b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028949017205578912",
"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/8863518955212541456/+/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:4fe74794ad28f210",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1605495970246355",
"url": "https://luci-milo-dev.appspot.com/b/8863518955212541456",
"utcnow_ts": "1605495971650732"
}
}
[03:06:11.659] Invocation finished in 2h35m31.302106907s with status FAILED