Status: SUCCEEDED
Triggered by: -
Duration: 2 hours
Actions:

Definition (rev db79390766c74b5c78e905f2f711f95842d49a9d)

buildbucket: <
  server: "cr-buildbucket-dev.appspot.com"
  bucket: "luci.infra.ci"
  builder: "infra-continuous-win10-64"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/infra/infra",
  "revision": "f32403e519ed8b6a2cf5a4f77abef6d2085e305f"
}

Incoming tags

  • buildset:commit/git/f32403e519ed8b6a2cf5a4f77abef6d2085e305f
  • buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[23:55:28.078] New invocation is queued and will start shortly
[23:55:29.170] Starting the invocation (attempt 1)
[23:55:29.211] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[23:55:29.211] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[23:55:29.212] Buildbucket request:
{
  "bucket": "luci.infra.ci",
  "client_operation_id": "9022428250527031888",
  "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\":\"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\",\"title\":\"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"619ca277f716d62095b31c35f9d5df6479924dc3\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@619ca277f716d62095b31c35f9d5df6479924dc3\",\"title\":\"619ca277f716d62095b31c35f9d5df6479924dc3\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/619ca277f716d62095b31c35f9d5df6479924dc3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\",\"title\":\"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\",\"title\":\"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@06b49d32ed5a4106608af4f5e43ba15f8f129e8c\",\"title\":\"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"97e000bc683c3ef46838f010b6371af66b4bf14e\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@97e000bc683c3ef46838f010b6371af66b4bf14e\",\"title\":\"97e000bc683c3ef46838f010b6371af66b4bf14e\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/97e000bc683c3ef46838f010b6371af66b4bf14e\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b75077cbfda4f0bab60ceef91edbd05f88f91ae8\",\"title\":\"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"83a86e36d2fe3722a2130dc4e28e5cd95829d919\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@83a86e36d2fe3722a2130dc4e28e5cd95829d919\",\"title\":\"83a86e36d2fe3722a2130dc4e28e5cd95829d919\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/83a86e36d2fe3722a2130dc4e28e5cd95829d919\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\",\"title\":\"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f32403e519ed8b6a2cf5a4f77abef6d2085e305f\",\"title\":\"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}}",
  "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:9022428250527031888",
    "scheduler_job_id:infra/infra-continuous-win10-64",
    "user_agent:luci-scheduler-dev",
    "buildset:commit/git/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
    "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:55:29.984] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1611705329316520",
    "id": "8856998188564963984",
    "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\": \"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\", \"title\": \"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"619ca277f716d62095b31c35f9d5df6479924dc3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@619ca277f716d62095b31c35f9d5df6479924dc3\", \"title\": \"619ca277f716d62095b31c35f9d5df6479924dc3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/619ca277f716d62095b31c35f9d5df6479924dc3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\", \"title\": \"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\", \"title\": \"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@06b49d32ed5a4106608af4f5e43ba15f8f129e8c\", \"title\": \"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"97e000bc683c3ef46838f010b6371af66b4bf14e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@97e000bc683c3ef46838f010b6371af66b4bf14e\", \"title\": \"97e000bc683c3ef46838f010b6371af66b4bf14e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/97e000bc683c3ef46838f010b6371af66b4bf14e\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b75077cbfda4f0bab60ceef91edbd05f88f91ae8\", \"title\": \"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"83a86e36d2fe3722a2130dc4e28e5cd95829d919\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@83a86e36d2fe3722a2130dc4e28e5cd95829d919\", \"title\": \"83a86e36d2fe3722a2130dc4e28e5cd95829d919\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/83a86e36d2fe3722a2130dc4e28e5cd95829d919\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\", \"title\": \"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f32403e519ed8b6a2cf5a4f77abef6d2085e305f\", \"title\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611705329850572",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18437",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022428250527031888",
      "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/8856998188564963984/+/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": "1611705329850681",
    "url": "https://luci-milo-dev.appspot.com/b/8856998188564963984",
    "utcnow_ts": "1611705329973700"
  }
}
[23:55:29.984] Task URL: https://luci-milo-dev.appspot.com/b/8856998188564963984
[23:55:29.984] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:2:0) after 1m0s
[23:56:30.009] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:2:0)
[23:56:30.009] Timer tick, asking Buildbucket for the build status
[23:56:30.102] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:30.102] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:3:0) after 1m0s
[23:57:30.134] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:3:0)
[23:57:30.134] Timer tick, asking Buildbucket for the build status
[23:57:30.240] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:30.240] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:4:0) after 1m0s
[23:58:30.690] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:4:0)
[23:58:30.690] Timer tick, asking Buildbucket for the build status
[23:58:30.793] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:30.793] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:5:0) after 1m0s
[23:59:30.854] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:5:0)
[23:59:30.854] Timer tick, asking Buildbucket for the build status
[23:59:30.938] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:30.938] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:6:0) after 1m0s
[00:00:31.067] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:6:0)
[00:00:31.068] Timer tick, asking Buildbucket for the build status
[00:00:31.209] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:31.210] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:7:0) after 1m0s
[00:01:31.289] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:7:0)
[00:01:31.290] Timer tick, asking Buildbucket for the build status
[00:01:31.421] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:31.421] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:8:0) after 1m0s
[00:02:31.523] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:8:0)
[00:02:31.523] Timer tick, asking Buildbucket for the build status
[00:02:31.636] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:31.636] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:9:0) after 1m0s
[00:03:31.669] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:9:0)
[00:03:31.669] Timer tick, asking Buildbucket for the build status
[00:03:31.788] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:31.788] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:10:0) after 1m0s
[00:04:31.811] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:10:0)
[00:04:31.811] Timer tick, asking Buildbucket for the build status
[00:04:31.934] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:31.934] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:11:0) after 1m0s
[00:05:31.955] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:11:0)
[00:05:31.955] Timer tick, asking Buildbucket for the build status
[00:05:32.112] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:32.112] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:12:0) after 1m0s
[00:06:32.165] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:12:0)
[00:06:32.165] Timer tick, asking Buildbucket for the build status
[00:06:32.279] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:32.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:13:0) after 1m0s
[00:07:32.308] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:13:0)
[00:07:32.308] Timer tick, asking Buildbucket for the build status
[00:07:32.434] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:32.434] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:14:0) after 1m0s
[00:08:32.462] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:14:0)
[00:08:32.462] Timer tick, asking Buildbucket for the build status
[00:08:32.570] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:32.570] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:15:0) after 1m0s
[00:09:32.592] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:15:0)
[00:09:32.592] Timer tick, asking Buildbucket for the build status
[00:09:32.748] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:32.748] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:16:0) after 1m0s
[00:10:32.767] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:16:0)
[00:10:32.767] Timer tick, asking Buildbucket for the build status
[00:10:32.890] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:32.890] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:17:0) after 1m0s
[00:11:32.967] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:17:0)
[00:11:32.967] Timer tick, asking Buildbucket for the build status
[00:11:33.108] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:33.108] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:18:0) after 1m0s
[00:12:33.143] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:18:0)
[00:12:33.143] Timer tick, asking Buildbucket for the build status
[00:12:33.249] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:33.249] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:19:0) after 1m0s
[00:13:33.278] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:19:0)
[00:13:33.278] Timer tick, asking Buildbucket for the build status
[00:13:33.380] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:33.380] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:20:0) after 1m0s
[00:14:33.408] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:20:0)
[00:14:33.408] Timer tick, asking Buildbucket for the build status
[00:14:33.529] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:33.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:21:0) after 1m0s
[00:15:33.548] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:21:0)
[00:15:33.548] Timer tick, asking Buildbucket for the build status
[00:15:33.641] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:33.641] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:22:0) after 1m0s
[00:16:33.782] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:22:0)
[00:16:33.782] Timer tick, asking Buildbucket for the build status
[00:16:33.881] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:33.881] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:23:0) after 1m0s
[00:17:33.911] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:23:0)
[00:17:33.911] Timer tick, asking Buildbucket for the build status
[00:17:34.038] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:34.038] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:24:0) after 1m0s
[00:18:34.066] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:24:0)
[00:18:34.066] Timer tick, asking Buildbucket for the build status
[00:18:34.172] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:34.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:25:0) after 1m0s
[00:19:34.336] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:25:0)
[00:19:34.336] Timer tick, asking Buildbucket for the build status
[00:19:34.482] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:34.482] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:26:0) after 1m0s
[00:20:34.794] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:26:0)
[00:20:34.794] Timer tick, asking Buildbucket for the build status
[00:20:35.037] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:35.037] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:27:0) after 1m0s
[00:21:35.151] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:27:0)
[00:21:35.151] Timer tick, asking Buildbucket for the build status
[00:21:35.304] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:35.304] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:28:0) after 1m0s
[00:22:35.486] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:28:0)
[00:22:35.486] Timer tick, asking Buildbucket for the build status
[00:22:35.596] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:35.596] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:29:0) after 1m0s
[00:23:35.761] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:29:0)
[00:23:35.761] Timer tick, asking Buildbucket for the build status
[00:23:35.869] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:35.869] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:30:0) after 1m0s
[00:24:36.079] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:30:0)
[00:24:36.080] Timer tick, asking Buildbucket for the build status
[00:24:36.184] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:36.184] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:31:0) after 1m0s
[00:25:36.323] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:31:0)
[00:25:36.323] Timer tick, asking Buildbucket for the build status
[00:25:36.521] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:36.521] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:32:0) after 1m0s
[00:26:36.796] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:32:0)
[00:26:36.796] Timer tick, asking Buildbucket for the build status
[00:26:36.897] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:36.897] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:33:0) after 1m0s
[00:27:36.961] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:33:0)
[00:27:36.961] Timer tick, asking Buildbucket for the build status
[00:27:37.069] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:37.069] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:34:0) after 1m0s
[00:28:37.283] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:34:0)
[00:28:37.283] Timer tick, asking Buildbucket for the build status
[00:28:37.376] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:37.376] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:35:0) after 1m0s
[00:29:37.553] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:35:0)
[00:29:37.553] Timer tick, asking Buildbucket for the build status
[00:29:37.676] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:37.676] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:36:0) after 1m0s
[00:30:37.767] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:36:0)
[00:30:37.767] Timer tick, asking Buildbucket for the build status
[00:30:37.853] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:37.853] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:37:0) after 1m0s
[00:31:38.033] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:37:0)
[00:31:38.033] Timer tick, asking Buildbucket for the build status
[00:31:38.211] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:38.211] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:38:0) after 1m0s
[00:32:38.396] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:38:0)
[00:32:38.396] Timer tick, asking Buildbucket for the build status
[00:32:38.513] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:38.513] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:39:0) after 1m0s
[00:33:38.701] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:39:0)
[00:33:38.701] Timer tick, asking Buildbucket for the build status
[00:33:38.828] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:38.828] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:40:0) after 1m0s
[00:34:39.091] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:40:0)
[00:34:39.091] Timer tick, asking Buildbucket for the build status
[00:34:39.467] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:39.467] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:41:0) after 1m0s
[00:35:39.533] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:41:0)
[00:35:39.533] Timer tick, asking Buildbucket for the build status
[00:35:39.631] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:39.631] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:42:0) after 1m0s
[00:36:39.655] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:42:0)
[00:36:39.655] Timer tick, asking Buildbucket for the build status
[00:36:40.158] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:40.158] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:43:0) after 1m0s
[00:37:40.293] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:43:0)
[00:37:40.293] Timer tick, asking Buildbucket for the build status
[00:37:40.411] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:40.411] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:44:0) after 1m0s
[00:38:40.522] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:44:0)
[00:38:40.522] Timer tick, asking Buildbucket for the build status
[00:38:40.861] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:40.861] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:45:0) after 1m0s
[00:39:40.965] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:45:0)
[00:39:40.965] Timer tick, asking Buildbucket for the build status
[00:39:41.142] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:41.143] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:46:0) after 1m0s
[00:40:41.164] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:46:0)
[00:40:41.164] Timer tick, asking Buildbucket for the build status
[00:40:41.397] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:41.397] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:47:0) after 1m0s
[00:41:41.497] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:47:0)
[00:41:41.497] Timer tick, asking Buildbucket for the build status
[00:41:41.943] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:41.943] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:48:0) after 1m0s
[00:42:42.092] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:48:0)
[00:42:42.092] Timer tick, asking Buildbucket for the build status
[00:42:42.266] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:42.266] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:49:0) after 1m0s
[00:43:42.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:49:0)
[00:43:42.397] Timer tick, asking Buildbucket for the build status
[00:43:42.628] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:42.628] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:50:0) after 1m0s
[00:44:42.735] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:50:0)
[00:44:42.735] Timer tick, asking Buildbucket for the build status
[00:44:42.853] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:42.853] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:51:0) after 1m0s
[00:45:42.900] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:51:0)
[00:45:42.900] Timer tick, asking Buildbucket for the build status
[00:45:43.190] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:43.190] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:52:0) after 1m0s
[00:46:43.288] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:52:0)
[00:46:43.288] Timer tick, asking Buildbucket for the build status
[00:46:43.686] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:43.686] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:53:0) after 1m0s
[00:47:43.896] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:53:0)
[00:47:43.896] Timer tick, asking Buildbucket for the build status
[00:47:44.239] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:44.239] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:54:0) after 1m0s
[00:48:44.338] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:54:0)
[00:48:44.338] Timer tick, asking Buildbucket for the build status
[00:48:44.474] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:44.474] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:55:0) after 1m0s
[00:49:44.507] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:55:0)
[00:49:44.507] Timer tick, asking Buildbucket for the build status
[00:49:44.817] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:44.817] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:56:0) after 1m0s
[00:50:44.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:56:0)
[00:50:44.898] Timer tick, asking Buildbucket for the build status
[00:50:45.014] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:45.014] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:57:0) after 1m0s
[00:51:45.095] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:57:0)
[00:51:45.096] Timer tick, asking Buildbucket for the build status
[00:51:45.428] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:45.428] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:58:0) after 1m0s
[00:52:45.588] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:58:0)
[00:52:45.588] Timer tick, asking Buildbucket for the build status
[00:52:45.717] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:45.717] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:59:0) after 1m0s
[00:53:45.859] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:59:0)
[00:53:45.859] Timer tick, asking Buildbucket for the build status
[00:53:46.020] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:46.020] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:60:0) after 1m0s
[00:54:46.092] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:60:0)
[00:54:46.092] Timer tick, asking Buildbucket for the build status
[00:54:46.412] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:46.412] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:61:0) after 1m0s
[00:55:46.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:61:0)
[00:55:46.464] Timer tick, asking Buildbucket for the build status
[00:55:46.828] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:46.828] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:62:0) after 1m0s
[00:56:47.062] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:62:0)
[00:56:47.062] Timer tick, asking Buildbucket for the build status
[00:56:47.178] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:47.178] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:63:0) after 1m0s
[00:57:47.256] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:63:0)
[00:57:47.256] Timer tick, asking Buildbucket for the build status
[00:57:47.427] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:47.427] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:64:0) after 1m0s
[00:58:47.599] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:64:0)
[00:58:47.599] Timer tick, asking Buildbucket for the build status
[00:58:47.764] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:47.764] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:65:0) after 1m0s
[00:59:47.866] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:65:0)
[00:59:47.866] Timer tick, asking Buildbucket for the build status
[00:59:47.975] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:47.975] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:66:0) after 1m0s
[01:00:48.080] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:66:0)
[01:00:48.080] Timer tick, asking Buildbucket for the build status
[01:00:48.436] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:48.436] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:67:0) after 1m0s
[01:01:48.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:67:0)
[01:01:48.597] Timer tick, asking Buildbucket for the build status
[01:01:48.797] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:48.797] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:68:0) after 1m0s
[01:02:48.824] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:68:0)
[01:02:48.824] Timer tick, asking Buildbucket for the build status
[01:02:48.987] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:48.987] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:69:0) after 1m0s
[01:03:49.064] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:69:0)
[01:03:49.064] Timer tick, asking Buildbucket for the build status
[01:03:49.623] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:49.623] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:70:0) after 1m0s
[01:04:49.806] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:70:0)
[01:04:49.806] Timer tick, asking Buildbucket for the build status
[01:04:50.108] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:50.108] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:71:0) after 1m0s
[01:05:50.167] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:71:0)
[01:05:50.167] Timer tick, asking Buildbucket for the build status
[01:05:50.608] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:50.608] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:72:0) after 1m0s
[01:06:50.704] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:72:0)
[01:06:50.704] Timer tick, asking Buildbucket for the build status
[01:06:51.030] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:51.030] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:73:0) after 1m0s
[01:07:51.105] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:73:0)
[01:07:51.105] Timer tick, asking Buildbucket for the build status
[01:07:51.480] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:51.480] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:74:0) after 1m0s
[01:08:52.757] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:74:0)
[01:08:52.757] Timer tick, asking Buildbucket for the build status
[01:08:53.346] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:53.346] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:75:0) after 1m0s
[01:09:53.413] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:75:0)
[01:09:53.413] Timer tick, asking Buildbucket for the build status
[01:09:53.806] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:53.806] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:76:0) after 1m0s
[01:10:53.886] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:76:0)
[01:10:53.887] Timer tick, asking Buildbucket for the build status
[01:10:54.007] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:54.007] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:77:0) after 1m0s
[01:11:54.109] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:77:0)
[01:11:54.109] Timer tick, asking Buildbucket for the build status
[01:11:54.249] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:54.249] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:78:0) after 1m0s
[01:12:54.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:78:0)
[01:12:54.376] Timer tick, asking Buildbucket for the build status
[01:12:54.777] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:54.777] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:79:0) after 1m0s
[01:13:54.819] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:79:0)
[01:13:54.819] Timer tick, asking Buildbucket for the build status
[01:13:55.083] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:55.083] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:80:0) after 1m0s
[01:14:55.107] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:80:0)
[01:14:55.107] Timer tick, asking Buildbucket for the build status
[01:14:55.449] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:55.449] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:81:0) after 1m0s
[01:15:55.585] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:81:0)
[01:15:55.585] Timer tick, asking Buildbucket for the build status
[01:15:55.957] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:55.957] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:82:0) after 1m0s
[01:16:56.069] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:82:0)
[01:16:56.069] Timer tick, asking Buildbucket for the build status
[01:16:56.453] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:56.453] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:83:0) after 1m0s
[01:17:56.480] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:83:0)
[01:17:56.480] Timer tick, asking Buildbucket for the build status
[01:17:56.767] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:56.767] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:84:0) after 1m0s
[01:18:56.999] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:84:0)
[01:18:56.999] Timer tick, asking Buildbucket for the build status
[01:18:57.532] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:57.532] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:85:0) after 1m0s
[01:19:57.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:85:0)
[01:19:57.603] Timer tick, asking Buildbucket for the build status
[01:19:57.827] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:57.827] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:86:0) after 1m0s
[01:20:57.874] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:86:0)
[01:20:57.874] Timer tick, asking Buildbucket for the build status
[01:20:58.148] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:58.148] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:87:0) after 1m0s
[01:21:58.191] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:87:0)
[01:21:58.191] Timer tick, asking Buildbucket for the build status
[01:21:58.451] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:58.451] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:88:0) after 1m0s
[01:22:58.487] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:88:0)
[01:22:58.487] Timer tick, asking Buildbucket for the build status
[01:22:58.711] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:58.711] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:89:0) after 1m0s
[01:23:58.783] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:89:0)
[01:23:58.783] Timer tick, asking Buildbucket for the build status
[01:23:59.063] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:59.063] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:90:0) after 1m0s
[01:24:59.099] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:90:0)
[01:24:59.099] Timer tick, asking Buildbucket for the build status
[01:24:59.415] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:59.415] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:91:0) after 1m0s
[01:25:59.479] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:91:0)
[01:25:59.479] Timer tick, asking Buildbucket for the build status
[01:25:59.680] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:59.680] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:92:0) after 1m0s
[01:26:59.780] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:92:0)
[01:26:59.780] Timer tick, asking Buildbucket for the build status
[01:27:00.257] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:00.257] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:93:0) after 1m0s
[01:28:00.284] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:93:0)
[01:28:00.284] Timer tick, asking Buildbucket for the build status
[01:28:00.534] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:00.534] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:94:0) after 1m0s
[01:29:00.557] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:94:0)
[01:29:00.557] Timer tick, asking Buildbucket for the build status
[01:29:00.908] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:00.908] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:95:0) after 1m0s
[01:30:00.944] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:95:0)
[01:30:00.945] Timer tick, asking Buildbucket for the build status
[01:30:01.213] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:01.213] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:96:0) after 1m0s
[01:31:01.242] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:96:0)
[01:31:01.242] Timer tick, asking Buildbucket for the build status
[01:31:01.538] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:01.538] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:97:0) after 1m0s
[01:32:01.589] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:97:0)
[01:32:01.589] Timer tick, asking Buildbucket for the build status
[01:32:01.832] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:01.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:98:0) after 1m0s
[01:33:01.869] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:98:0)
[01:33:01.869] Timer tick, asking Buildbucket for the build status
[01:33:02.114] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:02.114] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:99:0) after 1m0s
[01:34:02.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:99:0)
[01:34:02.194] Timer tick, asking Buildbucket for the build status
[01:34:02.447] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:02.447] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:100:0) after 1m0s
[01:35:02.477] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:100:0)
[01:35:02.477] Timer tick, asking Buildbucket for the build status
[01:35:02.670] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:02.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:101:0) after 1m0s
[01:36:02.693] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:101:0)
[01:36:02.693] Timer tick, asking Buildbucket for the build status
[01:36:03.000] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:03.000] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:102:0) after 1m0s
[01:37:03.076] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:102:0)
[01:37:03.076] Timer tick, asking Buildbucket for the build status
[01:37:03.712] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:03.712] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:103:0) after 1m0s
[01:38:03.788] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:103:0)
[01:38:03.788] Timer tick, asking Buildbucket for the build status
[01:38:04.057] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:04.057] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:104:0) after 1m0s
[01:39:04.166] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:104:0)
[01:39:04.166] Timer tick, asking Buildbucket for the build status
[01:39:04.483] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:04.483] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:105:0) after 1m0s
[01:40:04.598] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:105:0)
[01:40:04.598] Timer tick, asking Buildbucket for the build status
[01:40:04.825] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:04.825] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:106:0) after 1m0s
[01:41:04.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:106:0)
[01:41:04.890] Timer tick, asking Buildbucket for the build status
[01:41:05.234] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:05.234] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:107:0) after 1m0s
[01:42:05.292] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:107:0)
[01:42:05.293] Timer tick, asking Buildbucket for the build status
[01:42:05.613] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:05.613] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:108:0) after 1m0s
[01:43:05.687] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:108:0)
[01:43:05.687] Timer tick, asking Buildbucket for the build status
[01:43:05.981] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:05.982] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:109:0) after 1m0s
[01:44:06.076] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:109:0)
[01:44:06.076] Timer tick, asking Buildbucket for the build status
[01:44:06.396] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:06.396] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:110:0) after 1m0s
[01:45:06.421] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:110:0)
[01:45:06.421] Timer tick, asking Buildbucket for the build status
[01:45:06.729] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:06.729] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:111:0) after 1m0s
[01:46:06.772] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:111:0)
[01:46:06.772] Timer tick, asking Buildbucket for the build status
[01:46:06.975] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:06.975] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:112:0) after 1m0s
[01:47:07.002] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:112:0)
[01:47:07.002] Timer tick, asking Buildbucket for the build status
[01:47:07.274] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:07.274] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:113:0) after 1m0s
[01:48:07.300] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:113:0)
[01:48:07.300] Timer tick, asking Buildbucket for the build status
[01:48:07.603] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:07.603] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:114:0) after 1m0s
[01:49:07.703] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:114:0)
[01:49:07.703] Timer tick, asking Buildbucket for the build status
[01:49:07.978] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:07.978] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:115:0) after 1m0s
[01:50:08.115] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:115:0)
[01:50:08.115] Timer tick, asking Buildbucket for the build status
[01:50:08.411] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:08.411] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:116:0) after 1m0s
[01:51:08.482] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:116:0)
[01:51:08.482] Timer tick, asking Buildbucket for the build status
[01:51:08.829] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:08.829] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:117:0) after 1m0s
[01:52:08.907] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:117:0)
[01:52:08.907] Timer tick, asking Buildbucket for the build status
[01:52:09.116] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:09.116] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:118:0) after 1m0s
[01:53:09.182] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:118:0)
[01:53:09.182] Timer tick, asking Buildbucket for the build status
[01:53:09.414] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:09.414] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:119:0) after 1m0s
[01:54:09.472] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:119:0)
[01:54:09.472] Timer tick, asking Buildbucket for the build status
[01:54:09.644] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:09.644] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:120:0) after 1m0s
[01:55:09.677] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:120:0)
[01:55:09.677] Timer tick, asking Buildbucket for the build status
[01:55:09.932] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:09.932] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:121:0) after 1m0s
[01:56:09.941] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:121:0)
[01:56:09.941] Timer tick, asking Buildbucket for the build status
[01:56:10.229] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:10.229] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:122:0) after 1m0s
[01:57:10.280] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:122:0)
[01:57:10.280] Timer tick, asking Buildbucket for the build status
[01:57:10.596] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:10.596] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:123:0) after 1m0s
[01:58:10.700] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:123:0)
[01:58:10.700] Timer tick, asking Buildbucket for the build status
[01:58:10.999] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:10.999] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:124:0) after 1m0s
[01:59:11.104] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:124:0)
[01:59:11.104] Timer tick, asking Buildbucket for the build status
[01:59:11.383] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:11.383] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:125:0) after 1m0s
[02:00:11.481] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:125:0)
[02:00:11.481] Timer tick, asking Buildbucket for the build status
[02:00:11.767] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:11.767] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:126:0) after 1m0s
[02:01:11.818] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:126:0)
[02:01:11.818] Timer tick, asking Buildbucket for the build status
[02:01:12.073] Build 8856998188564963984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:12.073] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:127:0) after 1m0s
[02:01:30.690] Received PubSub notification, asking Buildbucket for the build status
[02:01:30.834] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:12.169] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:127:0)
[02:02:12.169] Timer tick, asking Buildbucket for the build status
[02:02:12.517] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:12.517] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:129:0) after 1m0s
[02:03:12.608] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:129:0)
[02:03:12.609] Timer tick, asking Buildbucket for the build status
[02:03:13.064] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:13.064] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:130:0) after 1m0s
[02:04:13.173] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:130:0)
[02:04:13.173] Timer tick, asking Buildbucket for the build status
[02:04:13.606] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:13.607] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:131:0) after 1m0s
[02:05:13.702] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:131:0)
[02:05:13.702] Timer tick, asking Buildbucket for the build status
[02:05:13.906] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:13.906] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:132:0) after 1m0s
[02:06:13.959] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:132:0)
[02:06:13.959] Timer tick, asking Buildbucket for the build status
[02:06:14.581] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:14.581] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:133:0) after 1m0s
[02:07:14.665] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:133:0)
[02:07:14.665] Timer tick, asking Buildbucket for the build status
[02:07:14.978] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:14.978] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:134:0) after 1m0s
[02:08:15.016] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:134:0)
[02:08:15.016] Timer tick, asking Buildbucket for the build status
[02:08:15.398] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:15.398] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:135:0) after 1m0s
[02:09:15.459] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:135:0)
[02:09:15.459] Timer tick, asking Buildbucket for the build status
[02:09:15.687] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:15.687] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:136:0) after 1m0s
[02:10:15.780] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:136:0)
[02:10:15.780] Timer tick, asking Buildbucket for the build status
[02:10:16.072] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:16.072] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:137:0) after 1m0s
[02:11:16.164] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:137:0)
[02:11:16.164] Timer tick, asking Buildbucket for the build status
[02:11:16.483] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:16.483] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:138:0) after 1m0s
[02:12:16.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:138:0)
[02:12:16.512] Timer tick, asking Buildbucket for the build status
[02:12:16.787] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:16.787] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:139:0) after 1m0s
[02:13:16.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:139:0)
[02:13:16.809] Timer tick, asking Buildbucket for the build status
[02:13:17.492] Build 8856998188564963984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:17.492] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022428250527031888:140:0) after 1m0s
[02:13:41.441] Received PubSub notification, asking Buildbucket for the build status
[02:13:41.620] Build 8856998188564963984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:13:41.620] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "completed_ts": "1611713617733640",
    "created_by": "project:infra",
    "created_ts": "1611705329316520",
    "id": "8856998188564963984",
    "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\": \"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\", \"title\": \"f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f65e6d2a2b7b4805d35541303f50e2a42f9ec74d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"619ca277f716d62095b31c35f9d5df6479924dc3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@619ca277f716d62095b31c35f9d5df6479924dc3\", \"title\": \"619ca277f716d62095b31c35f9d5df6479924dc3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/619ca277f716d62095b31c35f9d5df6479924dc3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\", \"title\": \"9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/9b9ca56f0080e630a870dd2c90f8e69f54d5dd98\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\", \"title\": \"bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/bb20c4dc8c4f4d1ea8c69d9ac59bd0b8cef9381f\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@06b49d32ed5a4106608af4f5e43ba15f8f129e8c\", \"title\": \"06b49d32ed5a4106608af4f5e43ba15f8f129e8c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/06b49d32ed5a4106608af4f5e43ba15f8f129e8c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"97e000bc683c3ef46838f010b6371af66b4bf14e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@97e000bc683c3ef46838f010b6371af66b4bf14e\", \"title\": \"97e000bc683c3ef46838f010b6371af66b4bf14e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/97e000bc683c3ef46838f010b6371af66b4bf14e\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@b75077cbfda4f0bab60ceef91edbd05f88f91ae8\", \"title\": \"b75077cbfda4f0bab60ceef91edbd05f88f91ae8\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/b75077cbfda4f0bab60ceef91edbd05f88f91ae8\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"83a86e36d2fe3722a2130dc4e28e5cd95829d919\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@83a86e36d2fe3722a2130dc4e28e5cd95829d919\", \"title\": \"83a86e36d2fe3722a2130dc4e28e5cd95829d919\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/83a86e36d2fe3722a2130dc4e28e5cd95829d919\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\", \"title\": \"1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/1ed9f8c5bddb70fe3ae2637f8f596dfe1c7bdc95\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f32403e519ed8b6a2cf5a4f77abef6d2085e305f\", \"title\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"got_revision\": \"f32403e519ed8b6a2cf5a4f77abef6d2085e305f\", \"got_revision_cp\": \"refs/heads/master@{#37934}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-6aax\"], \"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\": [\"5672-4713de1\"], \"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": "1611712887240929",
    "status": "COMPLETED",
    "status_changed_ts": "1611713618054304",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18437",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/f32403e519ed8b6a2cf5a4f77abef6d2085e305f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022428250527031888",
      "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/8856998188564963984/+/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:5159f13225463410",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1611713618144817",
    "url": "https://luci-milo-dev.appspot.com/b/8856998188564963984",
    "utcnow_ts": "1611713621610227"
  }
}
[02:13:41.620] Invocation finished in 2h18m13.558255372s with status SUCCEEDED