Status: SUCCEEDED
Triggered by: -
Duration: 1 hour
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": "c2fa700a26097fad11d88b39b538afee608339f5"
}

Incoming tags

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

Debug log (UTC)

[01:19:22.142] New invocation is queued and will start shortly
[01:19:23.295] Starting the invocation (attempt 1)
[01:19:23.359] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[01:19:23.360] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[01:19:23.360] Buildbucket request:
{
  "bucket": "luci.infra.ci",
  "client_operation_id": "9024234911259595632",
  "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\":\"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\",\"title\":\"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c2fa700a26097fad11d88b39b538afee608339f5\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c2fa700a26097fad11d88b39b538afee608339f5\",\"title\":\"c2fa700a26097fad11d88b39b538afee608339f5\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c2fa700a26097fad11d88b39b538afee608339f5\"}}",
  "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:9024234911259595632",
    "scheduler_job_id:infra/infra-continuous-win10-64",
    "user_agent:luci-scheduler-dev",
    "buildset:commit/git/c2fa700a26097fad11d88b39b538afee608339f5",
    "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5",
    "gitiles_ref:refs/heads/master"
  ]
}
[01:19:24.089] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1609982363452789",
    "id": "8858804849219630528",
    "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\": \"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\", \"title\": \"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c2fa700a26097fad11d88b39b538afee608339f5\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c2fa700a26097fad11d88b39b538afee608339f5\", \"title\": \"c2fa700a26097fad11d88b39b538afee608339f5\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c2fa700a26097fad11d88b39b538afee608339f5\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1609982363924296",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18277",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/c2fa700a26097fad11d88b39b538afee608339f5",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9024234911259595632",
      "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/8858804849219630528/+/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": "1609982363924408",
    "url": "https://luci-milo-dev.appspot.com/b/8858804849219630528",
    "utcnow_ts": "1609982364024212"
  }
}
[01:19:24.089] Task URL: https://luci-milo-dev.appspot.com/b/8858804849219630528
[01:19:24.089] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:2:0) after 1m0s
[01:20:24.106] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:2:0)
[01:20:24.106] Timer tick, asking Buildbucket for the build status
[01:20:24.185] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:24.185] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:3:0) after 1m0s
[01:21:24.297] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:3:0)
[01:21:24.297] Timer tick, asking Buildbucket for the build status
[01:21:24.371] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:24.371] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:4:0) after 1m0s
[01:22:24.398] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:4:0)
[01:22:24.398] Timer tick, asking Buildbucket for the build status
[01:22:24.588] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:24.588] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:5:0) after 1m0s
[01:23:24.621] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:5:0)
[01:23:24.621] Timer tick, asking Buildbucket for the build status
[01:23:24.704] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:24.704] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:6:0) after 1m0s
[01:24:24.722] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:6:0)
[01:24:24.722] Timer tick, asking Buildbucket for the build status
[01:24:24.822] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:24.822] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:7:0) after 1m0s
[01:25:24.887] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:7:0)
[01:25:24.887] Timer tick, asking Buildbucket for the build status
[01:25:24.979] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:24.979] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:8:0) after 1m0s
[01:26:24.999] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:8:0)
[01:26:24.999] Timer tick, asking Buildbucket for the build status
[01:26:25.152] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:25.152] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:9:0) after 1m0s
[01:27:25.212] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:9:0)
[01:27:25.212] Timer tick, asking Buildbucket for the build status
[01:27:25.302] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:25.302] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:10:0) after 1m0s
[01:28:25.397] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:10:0)
[01:28:25.397] Timer tick, asking Buildbucket for the build status
[01:28:25.469] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:25.469] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:11:0) after 1m0s
[01:29:25.488] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:11:0)
[01:29:25.488] Timer tick, asking Buildbucket for the build status
[01:29:25.571] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:25.571] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:12:0) after 1m0s
[01:30:25.598] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:12:0)
[01:30:25.598] Timer tick, asking Buildbucket for the build status
[01:30:25.744] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:25.744] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:13:0) after 1m0s
[01:31:25.800] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:13:0)
[01:31:25.800] Timer tick, asking Buildbucket for the build status
[01:31:25.882] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:25.882] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:14:0) after 1m0s
[01:32:25.999] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:14:0)
[01:32:25.999] Timer tick, asking Buildbucket for the build status
[01:32:26.082] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:26.082] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:15:0) after 1m0s
[01:33:26.211] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:15:0)
[01:33:26.211] Timer tick, asking Buildbucket for the build status
[01:33:26.299] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:26.299] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:16:0) after 1m0s
[01:34:26.408] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:16:0)
[01:34:26.408] Timer tick, asking Buildbucket for the build status
[01:34:26.502] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:26.502] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:17:0) after 1m0s
[01:35:26.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:17:0)
[01:35:26.603] Timer tick, asking Buildbucket for the build status
[01:35:26.688] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:26.688] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:18:0) after 1m0s
[01:36:26.713] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:18:0)
[01:36:26.713] Timer tick, asking Buildbucket for the build status
[01:36:26.811] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:26.811] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:19:0) after 1m0s
[01:37:26.905] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:19:0)
[01:37:26.905] Timer tick, asking Buildbucket for the build status
[01:37:26.990] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:26.990] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:20:0) after 1m0s
[01:38:27.100] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:20:0)
[01:38:27.100] Timer tick, asking Buildbucket for the build status
[01:38:27.188] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:27.188] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:21:0) after 1m0s
[01:39:27.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:21:0)
[01:39:27.307] Timer tick, asking Buildbucket for the build status
[01:39:27.447] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:27.447] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:22:0) after 1m0s
[01:40:27.489] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:22:0)
[01:40:27.489] Timer tick, asking Buildbucket for the build status
[01:40:27.649] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:27.649] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:23:0) after 1m0s
[01:41:27.693] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:23:0)
[01:41:27.693] Timer tick, asking Buildbucket for the build status
[01:41:28.670] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:28.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:24:0) after 1m0s
[01:42:28.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:24:0)
[01:42:28.709] Timer tick, asking Buildbucket for the build status
[01:42:28.819] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:28.819] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:25:0) after 1m0s
[01:43:28.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:25:0)
[01:43:28.890] Timer tick, asking Buildbucket for the build status
[01:43:28.965] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:28.965] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:26:0) after 1m0s
[01:44:28.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:26:0)
[01:44:28.989] Timer tick, asking Buildbucket for the build status
[01:44:29.140] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:29.140] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:27:0) after 1m0s
[01:45:29.200] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:27:0)
[01:45:29.200] Timer tick, asking Buildbucket for the build status
[01:45:29.349] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:29.349] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:28:0) after 1m0s
[01:46:29.389] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:28:0)
[01:46:29.389] Timer tick, asking Buildbucket for the build status
[01:46:29.488] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:29.488] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:29:0) after 1m0s
[01:47:29.588] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:29:0)
[01:47:29.588] Timer tick, asking Buildbucket for the build status
[01:47:29.676] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:29.676] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:30:0) after 1m0s
[01:48:29.701] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:30:0)
[01:48:29.701] Timer tick, asking Buildbucket for the build status
[01:48:29.784] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:29.784] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:31:0) after 1m0s
[01:49:29.902] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:31:0)
[01:49:29.902] Timer tick, asking Buildbucket for the build status
[01:49:29.987] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:29.987] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:32:0) after 1m0s
[01:50:30.095] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:32:0)
[01:50:30.095] Timer tick, asking Buildbucket for the build status
[01:50:30.176] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:30.176] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:33:0) after 1m0s
[01:51:30.200] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:33:0)
[01:51:30.200] Timer tick, asking Buildbucket for the build status
[01:51:30.282] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:30.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:34:0) after 1m0s
[01:52:30.390] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:34:0)
[01:52:30.390] Timer tick, asking Buildbucket for the build status
[01:52:30.472] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:30.472] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:35:0) after 1m0s
[01:53:30.507] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:35:0)
[01:53:30.507] Timer tick, asking Buildbucket for the build status
[01:53:30.606] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:30.606] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:36:0) after 1m0s
[01:54:30.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:36:0)
[01:54:30.707] Timer tick, asking Buildbucket for the build status
[01:54:30.831] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:30.831] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:37:0) after 1m0s
[01:55:30.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:37:0)
[01:55:30.890] Timer tick, asking Buildbucket for the build status
[01:55:31.063] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:31.063] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:38:0) after 1m0s
[01:56:31.114] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:38:0)
[01:56:31.114] Timer tick, asking Buildbucket for the build status
[01:56:31.202] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:31.202] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:39:0) after 1m0s
[01:57:31.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:39:0)
[01:57:31.298] Timer tick, asking Buildbucket for the build status
[01:57:31.388] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:31.388] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:40:0) after 1m0s
[01:58:31.508] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:40:0)
[01:58:31.508] Timer tick, asking Buildbucket for the build status
[01:58:31.669] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:31.669] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:41:0) after 1m0s
[01:59:31.791] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:41:0)
[01:59:31.791] Timer tick, asking Buildbucket for the build status
[01:59:31.944] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:31.944] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:42:0) after 1m0s
[02:00:31.974] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:42:0)
[02:00:31.974] Timer tick, asking Buildbucket for the build status
[02:00:32.073] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:32.073] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:43:0) after 1m0s
[02:01:32.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:43:0)
[02:01:32.113] Timer tick, asking Buildbucket for the build status
[02:01:32.235] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:32.235] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:44:0) after 1m0s
[02:02:32.268] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:44:0)
[02:02:32.268] Timer tick, asking Buildbucket for the build status
[02:02:32.361] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:32.361] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:45:0) after 1m0s
[02:03:32.383] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:45:0)
[02:03:32.383] Timer tick, asking Buildbucket for the build status
[02:03:32.475] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:32.475] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:46:0) after 1m0s
[02:04:32.497] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:46:0)
[02:04:32.497] Timer tick, asking Buildbucket for the build status
[02:04:32.586] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:32.586] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:47:0) after 1m0s
[02:05:32.616] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:47:0)
[02:05:32.616] Timer tick, asking Buildbucket for the build status
[02:05:32.727] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:32.727] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:48:0) after 1m0s
[02:06:32.802] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:48:0)
[02:06:32.802] Timer tick, asking Buildbucket for the build status
[02:06:32.946] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:32.946] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:49:0) after 1m0s
[02:07:32.991] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:49:0)
[02:07:32.991] Timer tick, asking Buildbucket for the build status
[02:07:33.073] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:33.073] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:50:0) after 1m0s
[02:08:33.124] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:50:0)
[02:08:33.124] Timer tick, asking Buildbucket for the build status
[02:08:33.227] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:33.227] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:51:0) after 1m0s
[02:09:33.293] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:51:0)
[02:09:33.293] Timer tick, asking Buildbucket for the build status
[02:09:33.441] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:33.441] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:52:0) after 1m0s
[02:10:33.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:52:0)
[02:10:33.464] Timer tick, asking Buildbucket for the build status
[02:10:33.552] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:33.552] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:53:0) after 1m0s
[02:11:33.595] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:53:0)
[02:11:33.595] Timer tick, asking Buildbucket for the build status
[02:11:33.705] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:33.705] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:54:0) after 1m0s
[02:12:33.792] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:54:0)
[02:12:33.792] Timer tick, asking Buildbucket for the build status
[02:12:33.941] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:33.941] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:55:0) after 1m0s
[02:13:33.962] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:55:0)
[02:13:33.962] Timer tick, asking Buildbucket for the build status
[02:13:34.106] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:34.106] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:56:0) after 1m0s
[02:14:34.207] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:56:0)
[02:14:34.208] Timer tick, asking Buildbucket for the build status
[02:14:34.285] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:34.285] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:57:0) after 1m0s
[02:15:34.391] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:57:0)
[02:15:34.391] Timer tick, asking Buildbucket for the build status
[02:15:34.539] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:34.539] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:58:0) after 1m0s
[02:16:34.591] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:58:0)
[02:16:34.591] Timer tick, asking Buildbucket for the build status
[02:16:34.701] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:34.701] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:59:0) after 1m0s
[02:17:34.819] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:59:0)
[02:17:34.819] Timer tick, asking Buildbucket for the build status
[02:17:34.959] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:34.959] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:60:0) after 1m0s
[02:18:35.008] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:60:0)
[02:18:35.008] Timer tick, asking Buildbucket for the build status
[02:18:35.236] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:35.236] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:61:0) after 1m0s
[02:19:35.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:61:0)
[02:19:35.290] Timer tick, asking Buildbucket for the build status
[02:19:35.376] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:35.376] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:62:0) after 1m0s
[02:20:35.411] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:62:0)
[02:20:35.411] Timer tick, asking Buildbucket for the build status
[02:20:35.548] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:35.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:63:0) after 1m0s
[02:21:35.609] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:63:0)
[02:21:35.609] Timer tick, asking Buildbucket for the build status
[02:21:35.688] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:35.688] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:64:0) after 1m0s
[02:22:35.791] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:64:0)
[02:22:35.791] Timer tick, asking Buildbucket for the build status
[02:22:35.873] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:35.873] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:65:0) after 1m0s
[02:23:35.901] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:65:0)
[02:23:35.901] Timer tick, asking Buildbucket for the build status
[02:23:35.987] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:35.987] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:66:0) after 1m0s
[02:24:36.115] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:66:0)
[02:24:36.115] Timer tick, asking Buildbucket for the build status
[02:24:36.196] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:36.196] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:67:0) after 1m0s
[02:25:36.226] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:67:0)
[02:25:36.226] Timer tick, asking Buildbucket for the build status
[02:25:36.316] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:36.316] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:68:0) after 1m0s
[02:26:36.406] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:68:0)
[02:26:36.406] Timer tick, asking Buildbucket for the build status
[02:26:36.482] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:36.482] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:69:0) after 1m0s
[02:27:36.610] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:69:0)
[02:27:36.610] Timer tick, asking Buildbucket for the build status
[02:27:36.693] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:36.693] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:70:0) after 1m0s
[02:28:36.725] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:70:0)
[02:28:36.725] Timer tick, asking Buildbucket for the build status
[02:28:36.813] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:36.813] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:71:0) after 1m0s
[02:29:36.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:71:0)
[02:29:36.891] Timer tick, asking Buildbucket for the build status
[02:29:36.962] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:36.962] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:72:0) after 1m0s
[02:30:37.005] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:72:0)
[02:30:37.005] Timer tick, asking Buildbucket for the build status
[02:30:37.082] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:37.082] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:73:0) after 1m0s
[02:31:37.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:73:0)
[02:31:37.194] Timer tick, asking Buildbucket for the build status
[02:31:37.353] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:37.353] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:74:0) after 1m0s
[02:32:37.409] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:74:0)
[02:32:37.409] Timer tick, asking Buildbucket for the build status
[02:32:37.491] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:37.491] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:75:0) after 1m0s
[02:33:37.604] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:75:0)
[02:33:37.604] Timer tick, asking Buildbucket for the build status
[02:33:37.739] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:37.739] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:76:0) after 1m0s
[02:34:37.794] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:76:0)
[02:34:37.794] Timer tick, asking Buildbucket for the build status
[02:34:37.943] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:37.943] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:77:0) after 1m0s
[02:35:38.009] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:77:0)
[02:35:38.009] Timer tick, asking Buildbucket for the build status
[02:35:38.139] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:38.140] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:78:0) after 1m0s
[02:36:38.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:78:0)
[02:36:38.194] Timer tick, asking Buildbucket for the build status
[02:36:38.262] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:38.262] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:79:0) after 1m0s
[02:37:38.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:79:0)
[02:37:38.290] Timer tick, asking Buildbucket for the build status
[02:37:38.459] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:38.459] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:80:0) after 1m0s
[02:38:38.479] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:80:0)
[02:38:38.479] Timer tick, asking Buildbucket for the build status
[02:38:38.556] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:38.556] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:81:0) after 1m0s
[02:39:38.580] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:81:0)
[02:39:38.580] Timer tick, asking Buildbucket for the build status
[02:39:38.657] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:38.657] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:82:0) after 1m0s
[02:40:38.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:82:0)
[02:40:38.708] Timer tick, asking Buildbucket for the build status
[02:40:38.776] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:38.776] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:83:0) after 1m0s
[02:41:38.799] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:83:0)
[02:41:38.799] Timer tick, asking Buildbucket for the build status
[02:41:38.900] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:38.900] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:84:0) after 1m0s
[02:42:39.004] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:84:0)
[02:42:39.004] Timer tick, asking Buildbucket for the build status
[02:42:39.149] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:39.149] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:85:0) after 1m0s
[02:43:39.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:85:0)
[02:43:39.194] Timer tick, asking Buildbucket for the build status
[02:43:39.258] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:39.258] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:86:0) after 1m0s
[02:44:39.308] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:86:0)
[02:44:39.308] Timer tick, asking Buildbucket for the build status
[02:44:39.450] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:39.450] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:87:0) after 1m0s
[02:45:39.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:87:0)
[02:45:39.504] Timer tick, asking Buildbucket for the build status
[02:45:39.579] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:39.579] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:88:0) after 1m0s
[02:46:39.607] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:88:0)
[02:46:39.607] Timer tick, asking Buildbucket for the build status
[02:46:39.694] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:39.694] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:89:0) after 1m0s
[02:47:39.719] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:89:0)
[02:47:39.719] Timer tick, asking Buildbucket for the build status
[02:47:39.789] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:39.789] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:90:0) after 1m0s
[02:48:39.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:90:0)
[02:48:39.891] Timer tick, asking Buildbucket for the build status
[02:48:40.072] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:40.072] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:91:0) after 1m0s
[02:49:40.111] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:91:0)
[02:49:40.111] Timer tick, asking Buildbucket for the build status
[02:49:40.196] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:40.196] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:92:0) after 1m0s
[02:50:40.223] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:92:0)
[02:50:40.223] Timer tick, asking Buildbucket for the build status
[02:50:40.313] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:40.313] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:93:0) after 1m0s
[02:51:40.341] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:93:0)
[02:51:40.341] Timer tick, asking Buildbucket for the build status
[02:51:40.422] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:40.422] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:94:0) after 1m0s
[02:52:40.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:94:0)
[02:52:40.504] Timer tick, asking Buildbucket for the build status
[02:52:40.582] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:40.582] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:95:0) after 1m0s
[02:53:40.621] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:95:0)
[02:53:40.621] Timer tick, asking Buildbucket for the build status
[02:53:40.721] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:40.721] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:96:0) after 1m0s
[02:54:40.745] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:96:0)
[02:54:40.745] Timer tick, asking Buildbucket for the build status
[02:54:40.826] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:40.826] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:97:0) after 1m0s
[02:55:40.913] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:97:0)
[02:55:40.913] Timer tick, asking Buildbucket for the build status
[02:55:41.043] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:41.043] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:98:0) after 1m0s
[02:56:41.125] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:98:0)
[02:56:41.125] Timer tick, asking Buildbucket for the build status
[02:56:41.208] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:41.208] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:99:0) after 1m0s
[02:57:41.296] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:99:0)
[02:57:41.296] Timer tick, asking Buildbucket for the build status
[02:57:41.383] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:41.383] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:100:0) after 1m0s
[02:58:41.421] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:100:0)
[02:58:41.421] Timer tick, asking Buildbucket for the build status
[02:58:41.526] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:41.526] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:101:0) after 1m0s
[02:59:41.594] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:101:0)
[02:59:41.594] Timer tick, asking Buildbucket for the build status
[02:59:41.686] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:41.686] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:102:0) after 1m0s
[03:00:41.730] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:102:0)
[03:00:41.730] Timer tick, asking Buildbucket for the build status
[03:00:41.834] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:41.834] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:103:0) after 1m0s
[03:01:41.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:103:0)
[03:01:41.892] Timer tick, asking Buildbucket for the build status
[03:01:42.067] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:42.067] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:104:0) after 1m0s
[03:02:42.114] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:104:0)
[03:02:42.114] Timer tick, asking Buildbucket for the build status
[03:02:42.203] Build 8858804849219630528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:42.203] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:105:0) after 1m0s
[03:03:30.801] Received PubSub notification, asking Buildbucket for the build status
[03:03:30.888] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:42.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:105:0)
[03:03:42.307] Timer tick, asking Buildbucket for the build status
[03:03:42.380] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:42.380] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:107:0) after 1m0s
[03:04:42.412] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:107:0)
[03:04:42.412] Timer tick, asking Buildbucket for the build status
[03:04:42.496] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:42.497] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:108:0) after 1m0s
[03:05:42.601] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:108:0)
[03:05:42.601] Timer tick, asking Buildbucket for the build status
[03:05:42.681] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:42.681] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:109:0) after 1m0s
[03:06:42.791] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:109:0)
[03:06:42.791] Timer tick, asking Buildbucket for the build status
[03:06:42.870] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:42.870] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:110:0) after 1m0s
[03:07:42.905] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:110:0)
[03:07:42.905] Timer tick, asking Buildbucket for the build status
[03:07:42.988] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:42.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:111:0) after 1m0s
[03:08:43.101] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:111:0)
[03:08:43.101] Timer tick, asking Buildbucket for the build status
[03:08:43.184] Build 8858804849219630528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:43.184] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9024234911259595632:112:0) after 1m0s
[03:09:30.247] Received PubSub notification, asking Buildbucket for the build status
[03:09:30.333] Build 8858804849219630528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:09:30.333] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "completed_ts": "1609988968058819",
    "created_by": "project:infra",
    "created_ts": "1609982363452789",
    "id": "8858804849219630528",
    "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\": \"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\", \"title\": \"64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/64eb9b8b24aea2d2cba3d4eda0e0be40ac10058a\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c2fa700a26097fad11d88b39b538afee608339f5\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c2fa700a26097fad11d88b39b538afee608339f5\", \"title\": \"c2fa700a26097fad11d88b39b538afee608339f5\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c2fa700a26097fad11d88b39b538afee608339f5\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"got_revision\": \"c2fa700a26097fad11d88b39b538afee608339f5\", \"got_revision_cp\": \"refs/heads/master@{#37358}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-8e8v\"], \"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\": [\"5657-0417a3f\"], \"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": "1609988608886182",
    "status": "COMPLETED",
    "status_changed_ts": "1609988968748229",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18277",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/c2fa700a26097fad11d88b39b538afee608339f5",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c2fa700a26097fad11d88b39b538afee608339f5",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9024234911259595632",
      "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/8858804849219630528/+/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:50f33ed30add4e10",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1609988968764650",
    "url": "https://luci-milo-dev.appspot.com/b/8858804849219630528",
    "utcnow_ts": "1609988970326334"
  }
}
[03:09:30.333] Invocation finished in 1h50m8.210268685s with status SUCCEEDED