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

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "win32-official"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/chromium/src",
  "revision": "736b3020a9b126596deb041256e053c40e83baae"
}

Incoming tags

  • buildset:commit/git/736b3020a9b126596deb041256e053c40e83baae
  • buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/736b3020a9b126596deb041256e053c40e83baae
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[06:13:09.801] New invocation is queued and will start shortly
[06:13:11.047] Starting the invocation (attempt 1)
[06:13:11.098] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:13:11.106] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:13:11.106] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9030377021032552656",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"736b3020a9b126596deb041256e053c40e83baae\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9030377021032552656",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/736b3020a9b126596deb041256e053c40e83baae",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/736b3020a9b126596deb041256e053c40e83baae",
    "gitiles_ref:refs/heads/master"
  ]
}
[06:13:11.744] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1604124791197840",
    "id": "8864946958904308032",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"736b3020a9b126596deb041256e053c40e83baae\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1604124791568377",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/847",
      "builder:win32-official",
      "buildset:commit/git/736b3020a9b126596deb041256e053c40e83baae",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/736b3020a9b126596deb041256e053c40e83baae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030377021032552656",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864946958904308032/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1604124791568494",
    "url": "https://ci.chromium.org/b/8864946958904308032",
    "utcnow_ts": "1604124791736033"
  }
}
[06:13:11.744] Task URL: https://ci.chromium.org/b/8864946958904308032
[06:13:11.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:2:0) after 1m0s
[06:14:11.789] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:2:0)
[06:14:11.789] Timer tick, asking Buildbucket for the build status
[06:14:11.893] Build 8864946958904308032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:11.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:3:0) after 1m0s
[06:15:11.919] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:3:0)
[06:15:11.919] Timer tick, asking Buildbucket for the build status
[06:15:12.010] Build 8864946958904308032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:12.010] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:4:0) after 1m0s
[06:16:12.036] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:4:0)
[06:16:12.036] Timer tick, asking Buildbucket for the build status
[06:16:12.321] Build 8864946958904308032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:12.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:5:0) after 1m0s
[06:16:35.807] Received PubSub notification, asking Buildbucket for the build status
[06:16:36.164] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:12.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:5:0)
[06:17:12.453] Timer tick, asking Buildbucket for the build status
[06:17:12.554] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:12.554] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:7:0) after 1m0s
[06:18:12.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:7:0)
[06:18:12.588] Timer tick, asking Buildbucket for the build status
[06:18:12.662] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:12.662] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:8:0) after 1m0s
[06:19:12.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:8:0)
[06:19:12.726] Timer tick, asking Buildbucket for the build status
[06:19:12.888] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:12.888] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:9:0) after 1m0s
[06:20:13.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:9:0)
[06:20:13.001] Timer tick, asking Buildbucket for the build status
[06:20:13.285] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:13.285] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:10:0) after 1m0s
[06:21:13.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:10:0)
[06:21:13.314] Timer tick, asking Buildbucket for the build status
[06:21:13.456] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:13.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:11:0) after 1m0s
[06:22:13.483] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:11:0)
[06:22:13.483] Timer tick, asking Buildbucket for the build status
[06:22:13.585] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:13.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:12:0) after 1m0s
[06:23:13.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:12:0)
[06:23:13.631] Timer tick, asking Buildbucket for the build status
[06:23:13.857] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:13.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:13:0) after 1m0s
[06:24:13.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:13:0)
[06:24:13.918] Timer tick, asking Buildbucket for the build status
[06:24:13.996] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:13.996] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:14:0) after 1m0s
[06:25:14.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:14:0)
[06:25:14.043] Timer tick, asking Buildbucket for the build status
[06:25:14.118] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:14.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:15:0) after 1m0s
[06:26:14.115] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:15:0)
[06:26:14.115] Timer tick, asking Buildbucket for the build status
[06:26:14.194] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:14.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:16:0) after 1m0s
[06:27:14.294] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:16:0)
[06:27:14.294] Timer tick, asking Buildbucket for the build status
[06:27:14.394] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:14.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:17:0) after 1m0s
[06:28:14.450] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:17:0)
[06:28:14.450] Timer tick, asking Buildbucket for the build status
[06:28:14.542] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:18:0) after 1m0s
[06:29:14.563] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:18:0)
[06:29:14.563] Timer tick, asking Buildbucket for the build status
[06:29:14.640] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:14.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:19:0) after 1m0s
[06:30:14.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:19:0)
[06:30:14.668] Timer tick, asking Buildbucket for the build status
[06:30:14.800] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.800] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:20:0) after 1m0s
[06:31:14.831] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:20:0)
[06:31:14.831] Timer tick, asking Buildbucket for the build status
[06:31:14.916] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:14.916] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:21:0) after 1m0s
[06:32:14.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:21:0)
[06:32:14.970] Timer tick, asking Buildbucket for the build status
[06:32:15.049] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:15.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:22:0) after 1m0s
[06:33:15.074] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:22:0)
[06:33:15.074] Timer tick, asking Buildbucket for the build status
[06:33:15.193] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:15.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:23:0) after 1m0s
[06:34:15.259] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:23:0)
[06:34:15.259] Timer tick, asking Buildbucket for the build status
[06:34:15.331] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:15.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:24:0) after 1m0s
[06:35:15.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:24:0)
[06:35:15.399] Timer tick, asking Buildbucket for the build status
[06:35:15.470] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:25:0) after 1m0s
[06:36:15.513] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:25:0)
[06:36:15.513] Timer tick, asking Buildbucket for the build status
[06:36:17.179] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:17.180] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:26:0) after 1m0s
[06:37:17.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:26:0)
[06:37:17.168] Timer tick, asking Buildbucket for the build status
[06:37:17.295] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:17.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:27:0) after 1m0s
[06:38:17.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:27:0)
[06:38:17.312] Timer tick, asking Buildbucket for the build status
[06:38:17.436] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:17.436] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:28:0) after 1m0s
[06:39:17.458] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:28:0)
[06:39:17.458] Timer tick, asking Buildbucket for the build status
[06:39:17.519] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:17.519] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:29:0) after 1m0s
[06:40:17.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:29:0)
[06:40:17.546] Timer tick, asking Buildbucket for the build status
[06:40:17.605] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:17.605] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:30:0) after 1m0s
[06:41:17.657] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:30:0)
[06:41:17.657] Timer tick, asking Buildbucket for the build status
[06:41:17.900] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:17.900] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:31:0) after 1m0s
[06:42:17.942] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:31:0)
[06:42:17.942] Timer tick, asking Buildbucket for the build status
[06:42:18.357] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:18.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:32:0) after 1m0s
[06:43:18.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:32:0)
[06:43:18.390] Timer tick, asking Buildbucket for the build status
[06:43:18.542] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:18.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:33:0) after 1m0s
[06:44:18.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:33:0)
[06:44:18.595] Timer tick, asking Buildbucket for the build status
[06:44:18.660] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:18.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:34:0) after 1m0s
[06:45:18.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:34:0)
[06:45:18.752] Timer tick, asking Buildbucket for the build status
[06:45:18.812] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:18.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:35:0) after 1m0s
[06:46:18.889] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:35:0)
[06:46:18.889] Timer tick, asking Buildbucket for the build status
[06:46:18.950] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.950] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:36:0) after 1m0s
[06:47:18.974] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:36:0)
[06:47:18.974] Timer tick, asking Buildbucket for the build status
[06:47:19.056] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:19.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:37:0) after 1m0s
[06:48:19.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:37:0)
[06:48:19.084] Timer tick, asking Buildbucket for the build status
[06:48:19.521] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:19.521] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:38:0) after 1m0s
[06:49:19.594] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:38:0)
[06:49:19.594] Timer tick, asking Buildbucket for the build status
[06:49:19.669] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:19.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:39:0) after 1m0s
[06:50:19.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:39:0)
[06:50:19.707] Timer tick, asking Buildbucket for the build status
[06:50:20.156] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:20.156] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:40:0) after 1m0s
[06:51:20.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:40:0)
[06:51:20.227] Timer tick, asking Buildbucket for the build status
[06:51:20.297] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:20.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:41:0) after 1m0s
[06:52:20.321] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:41:0)
[06:52:20.321] Timer tick, asking Buildbucket for the build status
[06:52:20.425] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:20.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:42:0) after 1m0s
[06:53:20.445] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:42:0)
[06:53:20.445] Timer tick, asking Buildbucket for the build status
[06:53:20.561] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:20.561] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:43:0) after 1m0s
[06:54:20.604] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:43:0)
[06:54:20.604] Timer tick, asking Buildbucket for the build status
[06:54:20.991] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:20.991] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:44:0) after 1m0s
[06:55:21.072] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:44:0)
[06:55:21.072] Timer tick, asking Buildbucket for the build status
[06:55:21.213] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:21.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:45:0) after 1m0s
[06:56:21.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:45:0)
[06:56:21.268] Timer tick, asking Buildbucket for the build status
[06:56:21.330] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:21.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:46:0) after 1m0s
[06:57:21.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:46:0)
[06:57:21.453] Timer tick, asking Buildbucket for the build status
[06:57:21.579] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:21.579] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:47:0) after 1m0s
[06:58:21.566] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:47:0)
[06:58:21.566] Timer tick, asking Buildbucket for the build status
[06:58:21.685] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:21.685] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:48:0) after 1m0s
[06:59:21.715] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:48:0)
[06:59:21.715] Timer tick, asking Buildbucket for the build status
[06:59:21.795] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:21.796] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:49:0) after 1m0s
[07:00:21.891] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:49:0)
[07:00:21.891] Timer tick, asking Buildbucket for the build status
[07:00:22.222] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:22.222] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:50:0) after 1m0s
[07:01:22.347] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:50:0)
[07:01:22.347] Timer tick, asking Buildbucket for the build status
[07:01:22.486] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:22.486] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:51:0) after 1m0s
[07:02:22.663] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:51:0)
[07:02:22.663] Timer tick, asking Buildbucket for the build status
[07:02:23.160] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:23.160] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:52:0) after 1m0s
[07:03:23.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:52:0)
[07:03:23.218] Timer tick, asking Buildbucket for the build status
[07:03:23.684] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:23.684] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:53:0) after 1m0s
[07:04:23.764] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:53:0)
[07:04:23.764] Timer tick, asking Buildbucket for the build status
[07:04:23.826] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:23.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:54:0) after 1m0s
[07:05:23.854] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:54:0)
[07:05:23.854] Timer tick, asking Buildbucket for the build status
[07:05:23.915] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:23.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:55:0) after 1m0s
[07:06:23.973] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:55:0)
[07:06:23.973] Timer tick, asking Buildbucket for the build status
[07:06:24.034] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:24.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:56:0) after 1m0s
[07:07:24.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:56:0)
[07:07:24.076] Timer tick, asking Buildbucket for the build status
[07:07:24.364] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:24.364] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:57:0) after 1m0s
[07:08:26.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:57:0)
[07:08:26.190] Timer tick, asking Buildbucket for the build status
[07:08:26.310] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:26.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:58:0) after 1m0s
[07:09:26.333] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:58:0)
[07:09:26.333] Timer tick, asking Buildbucket for the build status
[07:09:26.427] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:26.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:59:0) after 1m0s
[07:10:26.483] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:59:0)
[07:10:26.483] Timer tick, asking Buildbucket for the build status
[07:10:26.685] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:26.685] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:60:0) after 1m0s
[07:11:26.690] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:60:0)
[07:11:26.690] Timer tick, asking Buildbucket for the build status
[07:11:26.905] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:26.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:61:0) after 1m0s
[07:12:26.997] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:61:0)
[07:12:26.997] Timer tick, asking Buildbucket for the build status
[07:12:27.081] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:27.081] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:62:0) after 1m0s
[07:13:27.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:62:0)
[07:13:27.130] Timer tick, asking Buildbucket for the build status
[07:13:27.259] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:27.259] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:63:0) after 1m0s
[07:14:27.255] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:63:0)
[07:14:27.255] Timer tick, asking Buildbucket for the build status
[07:14:27.488] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:27.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:64:0) after 1m0s
[07:15:27.534] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:64:0)
[07:15:27.534] Timer tick, asking Buildbucket for the build status
[07:15:27.881] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:27.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:65:0) after 1m0s
[07:16:27.906] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:65:0)
[07:16:27.906] Timer tick, asking Buildbucket for the build status
[07:16:27.987] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:27.987] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:66:0) after 1m0s
[07:17:28.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:66:0)
[07:17:28.046] Timer tick, asking Buildbucket for the build status
[07:17:28.175] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:67:0) after 1m0s
[07:18:28.193] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:67:0)
[07:18:28.193] Timer tick, asking Buildbucket for the build status
[07:18:28.306] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:28.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:68:0) after 1m0s
[07:19:28.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:68:0)
[07:19:28.332] Timer tick, asking Buildbucket for the build status
[07:19:29.597] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:29.597] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:69:0) after 1m0s
[07:20:29.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:69:0)
[07:20:29.684] Timer tick, asking Buildbucket for the build status
[07:20:29.760] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:29.760] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:70:0) after 1m0s
[07:21:29.827] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:70:0)
[07:21:29.827] Timer tick, asking Buildbucket for the build status
[07:21:29.918] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:29.918] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:71:0) after 1m0s
[07:22:29.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:71:0)
[07:22:29.935] Timer tick, asking Buildbucket for the build status
[07:22:30.000] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:30.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:72:0) after 1m0s
[07:23:30.096] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:72:0)
[07:23:30.096] Timer tick, asking Buildbucket for the build status
[07:23:30.360] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:30.360] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:73:0) after 1m0s
[07:24:30.452] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:73:0)
[07:24:30.452] Timer tick, asking Buildbucket for the build status
[07:24:30.586] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:30.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:74:0) after 1m0s
[07:25:30.648] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:74:0)
[07:25:30.648] Timer tick, asking Buildbucket for the build status
[07:25:30.798] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:30.798] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:75:0) after 1m0s
[07:26:30.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:75:0)
[07:26:30.810] Timer tick, asking Buildbucket for the build status
[07:26:30.895] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:30.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:76:0) after 1m0s
[07:27:30.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:76:0)
[07:27:30.890] Timer tick, asking Buildbucket for the build status
[07:27:31.169] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:31.169] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:77:0) after 1m0s
[07:28:31.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:77:0)
[07:28:31.268] Timer tick, asking Buildbucket for the build status
[07:28:31.363] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:31.363] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:78:0) after 1m0s
[07:29:31.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:78:0)
[07:29:31.423] Timer tick, asking Buildbucket for the build status
[07:29:32.122] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:32.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:79:0) after 1m0s
[07:30:32.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:79:0)
[07:30:32.190] Timer tick, asking Buildbucket for the build status
[07:30:33.257] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:33.257] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:80:0) after 1m0s
[07:31:33.313] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:80:0)
[07:31:33.313] Timer tick, asking Buildbucket for the build status
[07:31:33.490] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:33.490] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:81:0) after 1m0s
[07:32:33.537] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:81:0)
[07:32:33.537] Timer tick, asking Buildbucket for the build status
[07:32:33.649] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:33.649] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:82:0) after 1m0s
[07:33:33.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:82:0)
[07:33:33.658] Timer tick, asking Buildbucket for the build status
[07:33:33.772] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:83:0) after 1m0s
[07:34:33.807] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:83:0)
[07:34:33.807] Timer tick, asking Buildbucket for the build status
[07:34:33.915] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:33.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:84:0) after 1m0s
[07:35:33.969] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:84:0)
[07:35:33.969] Timer tick, asking Buildbucket for the build status
[07:35:34.029] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:34.029] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:85:0) after 1m0s
[07:36:34.026] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:85:0)
[07:36:34.026] Timer tick, asking Buildbucket for the build status
[07:36:34.096] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:34.097] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:86:0) after 1m0s
[07:37:34.172] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:86:0)
[07:37:34.172] Timer tick, asking Buildbucket for the build status
[07:37:34.244] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:34.244] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:87:0) after 1m0s
[07:38:34.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:87:0)
[07:38:34.318] Timer tick, asking Buildbucket for the build status
[07:38:34.518] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:34.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:88:0) after 1m0s
[07:39:34.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:88:0)
[07:39:34.669] Timer tick, asking Buildbucket for the build status
[07:39:34.727] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:34.727] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:89:0) after 1m0s
[07:40:34.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:89:0)
[07:40:34.756] Timer tick, asking Buildbucket for the build status
[07:40:35.079] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:35.079] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:90:0) after 1m0s
[07:41:35.103] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:90:0)
[07:41:35.103] Timer tick, asking Buildbucket for the build status
[07:41:35.160] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:35.160] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:91:0) after 1m0s
[07:42:35.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:91:0)
[07:42:35.194] Timer tick, asking Buildbucket for the build status
[07:42:35.266] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:35.266] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:92:0) after 1m0s
[07:43:35.302] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:92:0)
[07:43:35.302] Timer tick, asking Buildbucket for the build status
[07:43:35.432] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:35.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:93:0) after 1m0s
[07:44:35.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:93:0)
[07:44:35.461] Timer tick, asking Buildbucket for the build status
[07:44:35.679] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:35.679] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:94:0) after 1m0s
[07:45:35.701] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:94:0)
[07:45:35.701] Timer tick, asking Buildbucket for the build status
[07:45:35.793] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:35.793] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:95:0) after 1m0s
[07:46:35.898] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:95:0)
[07:46:35.898] Timer tick, asking Buildbucket for the build status
[07:46:35.956] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:35.956] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:96:0) after 1m0s
[07:47:36.051] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:96:0)
[07:47:36.051] Timer tick, asking Buildbucket for the build status
[07:47:36.257] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:97:0) after 1m0s
[07:48:36.286] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:97:0)
[07:48:36.286] Timer tick, asking Buildbucket for the build status
[07:48:36.559] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:36.559] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:98:0) after 1m0s
[07:49:36.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:98:0)
[07:49:36.588] Timer tick, asking Buildbucket for the build status
[07:49:36.965] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:36.965] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:99:0) after 1m0s
[07:50:37.021] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:99:0)
[07:50:37.021] Timer tick, asking Buildbucket for the build status
[07:50:37.298] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:37.298] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:100:0) after 1m0s
[07:51:37.362] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:100:0)
[07:51:37.362] Timer tick, asking Buildbucket for the build status
[07:51:37.423] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:37.423] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:101:0) after 1m0s
[07:52:37.474] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:101:0)
[07:52:37.474] Timer tick, asking Buildbucket for the build status
[07:52:37.890] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:37.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:102:0) after 1m0s
[07:53:37.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:102:0)
[07:53:37.990] Timer tick, asking Buildbucket for the build status
[07:53:38.103] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:103:0) after 1m0s
[07:54:38.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:103:0)
[07:54:38.198] Timer tick, asking Buildbucket for the build status
[07:54:38.322] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:104:0) after 1m0s
[07:55:38.578] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:104:0)
[07:55:38.578] Timer tick, asking Buildbucket for the build status
[07:55:38.676] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:38.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:105:0) after 1m0s
[07:56:38.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:105:0)
[07:56:38.762] Timer tick, asking Buildbucket for the build status
[07:56:38.825] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:38.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:106:0) after 1m0s
[07:57:38.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:106:0)
[07:57:38.835] Timer tick, asking Buildbucket for the build status
[07:57:38.941] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:38.941] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:107:0) after 1m0s
[07:58:38.975] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:107:0)
[07:58:38.975] Timer tick, asking Buildbucket for the build status
[07:58:39.092] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:39.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:108:0) after 1m0s
[07:59:39.166] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:108:0)
[07:59:39.166] Timer tick, asking Buildbucket for the build status
[07:59:39.241] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:39.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:109:0) after 1m0s
[08:00:39.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:109:0)
[08:00:39.325] Timer tick, asking Buildbucket for the build status
[08:00:39.413] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:39.413] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:110:0) after 1m0s
[08:01:39.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:110:0)
[08:01:39.442] Timer tick, asking Buildbucket for the build status
[08:01:39.719] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:39.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:111:0) after 1m0s
[08:02:39.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:111:0)
[08:02:39.750] Timer tick, asking Buildbucket for the build status
[08:02:39.950] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:112:0) after 1m0s
[08:03:40.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:112:0)
[08:03:40.064] Timer tick, asking Buildbucket for the build status
[08:03:40.194] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:40.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:113:0) after 1m0s
[08:04:40.264] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:113:0)
[08:04:40.264] Timer tick, asking Buildbucket for the build status
[08:04:40.444] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:40.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:114:0) after 1m0s
[08:05:40.470] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:114:0)
[08:05:40.470] Timer tick, asking Buildbucket for the build status
[08:05:40.675] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:40.675] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:115:0) after 1m0s
[08:06:40.753] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:115:0)
[08:06:40.753] Timer tick, asking Buildbucket for the build status
[08:06:40.848] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:40.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:116:0) after 1m0s
[08:07:40.927] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:116:0)
[08:07:40.927] Timer tick, asking Buildbucket for the build status
[08:07:40.982] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:40.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:117:0) after 1m0s
[08:08:41.062] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:117:0)
[08:08:41.062] Timer tick, asking Buildbucket for the build status
[08:08:41.546] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:41.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:118:0) after 1m0s
[08:09:41.600] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:118:0)
[08:09:41.600] Timer tick, asking Buildbucket for the build status
[08:09:41.666] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:41.666] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:119:0) after 1m0s
[08:10:41.692] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:119:0)
[08:10:41.692] Timer tick, asking Buildbucket for the build status
[08:10:41.882] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:120:0) after 1m0s
[08:11:41.917] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:120:0)
[08:11:41.917] Timer tick, asking Buildbucket for the build status
[08:11:41.982] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:121:0) after 1m0s
[08:12:42.137] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:121:0)
[08:12:42.137] Timer tick, asking Buildbucket for the build status
[08:12:42.264] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:42.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:122:0) after 1m0s
[08:13:42.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:122:0)
[08:13:42.296] Timer tick, asking Buildbucket for the build status
[08:13:42.691] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:42.691] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:123:0) after 1m0s
[08:14:42.795] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:123:0)
[08:14:42.795] Timer tick, asking Buildbucket for the build status
[08:14:43.289] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:43.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:124:0) after 1m0s
[08:15:43.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:124:0)
[08:15:43.312] Timer tick, asking Buildbucket for the build status
[08:15:43.380] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:43.380] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:125:0) after 1m0s
[08:16:43.501] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:125:0)
[08:16:43.501] Timer tick, asking Buildbucket for the build status
[08:16:43.577] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:43.577] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:126:0) after 1m0s
[08:17:43.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:126:0)
[08:17:43.574] Timer tick, asking Buildbucket for the build status
[08:17:43.653] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:43.653] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:127:0) after 1m0s
[08:18:43.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:127:0)
[08:18:43.694] Timer tick, asking Buildbucket for the build status
[08:18:43.796] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:43.796] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:128:0) after 1m0s
[08:19:43.876] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:128:0)
[08:19:43.876] Timer tick, asking Buildbucket for the build status
[08:19:43.957] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:43.957] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:129:0) after 1m0s
[08:20:44.005] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:129:0)
[08:20:44.005] Timer tick, asking Buildbucket for the build status
[08:20:44.069] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:44.069] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:130:0) after 1m0s
[08:21:44.116] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:130:0)
[08:21:44.116] Timer tick, asking Buildbucket for the build status
[08:21:44.180] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:44.180] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:131:0) after 1m0s
[08:22:44.271] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:131:0)
[08:22:44.271] Timer tick, asking Buildbucket for the build status
[08:22:44.355] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:44.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:132:0) after 1m0s
[08:23:44.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:132:0)
[08:23:44.438] Timer tick, asking Buildbucket for the build status
[08:23:44.547] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:44.547] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:133:0) after 1m0s
[08:24:44.648] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:133:0)
[08:24:44.648] Timer tick, asking Buildbucket for the build status
[08:24:44.803] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:44.804] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:134:0) after 1m0s
[08:25:44.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:134:0)
[08:25:44.859] Timer tick, asking Buildbucket for the build status
[08:25:45.466] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:45.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:135:0) after 1m0s
[08:26:45.530] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:135:0)
[08:26:45.530] Timer tick, asking Buildbucket for the build status
[08:26:45.585] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:45.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:136:0) after 1m0s
[08:27:45.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:136:0)
[08:27:45.614] Timer tick, asking Buildbucket for the build status
[08:27:45.677] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:45.677] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:137:0) after 1m0s
[08:28:45.703] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:137:0)
[08:28:45.703] Timer tick, asking Buildbucket for the build status
[08:28:45.811] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:45.811] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:138:0) after 1m0s
[08:29:45.925] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:138:0)
[08:29:45.925] Timer tick, asking Buildbucket for the build status
[08:29:45.991] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:45.991] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:139:0) after 1m0s
[08:30:46.117] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:139:0)
[08:30:46.117] Timer tick, asking Buildbucket for the build status
[08:30:46.201] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:46.201] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:140:0) after 1m0s
[08:31:46.298] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:140:0)
[08:31:46.298] Timer tick, asking Buildbucket for the build status
[08:31:46.359] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:46.359] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:141:0) after 1m0s
[08:32:46.501] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:141:0)
[08:32:46.501] Timer tick, asking Buildbucket for the build status
[08:32:46.711] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:46.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:142:0) after 1m0s
[08:33:46.844] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:142:0)
[08:33:46.844] Timer tick, asking Buildbucket for the build status
[08:33:46.971] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:46.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:143:0) after 1m0s
[08:34:46.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:143:0)
[08:34:46.986] Timer tick, asking Buildbucket for the build status
[08:34:47.070] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:47.070] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:144:0) after 1m0s
[08:35:47.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:144:0)
[08:35:47.200] Timer tick, asking Buildbucket for the build status
[08:35:47.272] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:145:0) after 1m0s
[08:36:47.327] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:145:0)
[08:36:47.327] Timer tick, asking Buildbucket for the build status
[08:36:47.407] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:47.407] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:146:0) after 1m0s
[08:37:47.506] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:146:0)
[08:37:47.506] Timer tick, asking Buildbucket for the build status
[08:37:47.581] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:47.581] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:147:0) after 1m0s
[08:38:47.625] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:147:0)
[08:38:47.625] Timer tick, asking Buildbucket for the build status
[08:38:47.732] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:47.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:148:0) after 1m0s
[08:39:47.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:148:0)
[08:39:47.758] Timer tick, asking Buildbucket for the build status
[08:39:47.865] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:47.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:149:0) after 1m0s
[08:40:47.892] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:149:0)
[08:40:47.893] Timer tick, asking Buildbucket for the build status
[08:40:47.954] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:47.954] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:150:0) after 1m0s
[08:41:47.968] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:150:0)
[08:41:47.968] Timer tick, asking Buildbucket for the build status
[08:41:48.191] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:48.191] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:151:0) after 1m0s
[08:42:48.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:151:0)
[08:42:48.182] Timer tick, asking Buildbucket for the build status
[08:42:48.360] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:48.360] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:152:0) after 1m0s
[08:43:48.400] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:152:0)
[08:43:48.401] Timer tick, asking Buildbucket for the build status
[08:43:48.623] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:48.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:153:0) after 1m0s
[08:44:48.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:153:0)
[08:44:48.710] Timer tick, asking Buildbucket for the build status
[08:44:48.776] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:48.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:154:0) after 1m0s
[08:45:48.806] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:154:0)
[08:45:48.806] Timer tick, asking Buildbucket for the build status
[08:45:48.872] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:48.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:155:0) after 1m0s
[08:46:48.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:155:0)
[08:46:48.905] Timer tick, asking Buildbucket for the build status
[08:46:48.968] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:48.968] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:156:0) after 1m0s
[08:47:49.020] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:156:0)
[08:47:49.020] Timer tick, asking Buildbucket for the build status
[08:47:49.171] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:49.171] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:157:0) after 1m0s
[08:48:49.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:157:0)
[08:48:49.189] Timer tick, asking Buildbucket for the build status
[08:48:49.290] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:49.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:158:0) after 1m0s
[08:49:49.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:158:0)
[08:49:49.351] Timer tick, asking Buildbucket for the build status
[08:49:49.431] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:49.431] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:159:0) after 1m0s
[08:50:49.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:159:0)
[08:50:49.461] Timer tick, asking Buildbucket for the build status
[08:50:49.584] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:49.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:160:0) after 1m0s
[08:51:49.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:160:0)
[08:51:49.677] Timer tick, asking Buildbucket for the build status
[08:51:49.747] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:49.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:161:0) after 1m0s
[08:52:49.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:161:0)
[08:52:49.803] Timer tick, asking Buildbucket for the build status
[08:52:49.872] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:49.873] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:162:0) after 1m0s
[08:53:49.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:162:0)
[08:53:49.903] Timer tick, asking Buildbucket for the build status
[08:53:50.007] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:50.007] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:163:0) after 1m0s
[08:54:50.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:163:0)
[08:54:50.066] Timer tick, asking Buildbucket for the build status
[08:54:50.281] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:50.281] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:164:0) after 1m0s
[08:55:50.317] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:164:0)
[08:55:50.317] Timer tick, asking Buildbucket for the build status
[08:55:50.398] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:50.398] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:165:0) after 1m0s
[08:56:50.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:165:0)
[08:56:50.426] Timer tick, asking Buildbucket for the build status
[08:56:50.567] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:50.567] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:166:0) after 1m0s
[08:57:50.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:166:0)
[08:57:50.588] Timer tick, asking Buildbucket for the build status
[08:57:50.727] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:50.727] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:167:0) after 1m0s
[08:58:50.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:167:0)
[08:58:50.767] Timer tick, asking Buildbucket for the build status
[08:58:51.588] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:51.588] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:168:0) after 1m0s
[08:59:51.617] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:168:0)
[08:59:51.617] Timer tick, asking Buildbucket for the build status
[08:59:51.727] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:51.727] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:169:0) after 1m0s
[09:00:51.775] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:169:0)
[09:00:51.775] Timer tick, asking Buildbucket for the build status
[09:00:51.887] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:51.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:170:0) after 1m0s
[09:01:52.209] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:170:0)
[09:01:52.209] Timer tick, asking Buildbucket for the build status
[09:01:52.272] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:171:0) after 1m0s
[09:02:52.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:171:0)
[09:02:52.316] Timer tick, asking Buildbucket for the build status
[09:02:52.503] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:52.503] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:172:0) after 1m0s
[09:03:52.617] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:172:0)
[09:03:52.617] Timer tick, asking Buildbucket for the build status
[09:03:53.711] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:53.711] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:173:0) after 1m0s
[09:04:53.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:173:0)
[09:04:53.756] Timer tick, asking Buildbucket for the build status
[09:04:53.827] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:53.827] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:174:0) after 1m0s
[09:05:53.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:174:0)
[09:05:53.934] Timer tick, asking Buildbucket for the build status
[09:05:54.053] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:54.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:175:0) after 1m0s
[09:06:54.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:175:0)
[09:06:54.176] Timer tick, asking Buildbucket for the build status
[09:06:54.258] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:54.258] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:176:0) after 1m0s
[09:07:54.360] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:176:0)
[09:07:54.360] Timer tick, asking Buildbucket for the build status
[09:07:54.421] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:54.421] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:177:0) after 1m0s
[09:08:54.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:177:0)
[09:08:54.424] Timer tick, asking Buildbucket for the build status
[09:08:54.593] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:54.593] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:178:0) after 1m0s
[09:09:54.635] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:178:0)
[09:09:54.635] Timer tick, asking Buildbucket for the build status
[09:09:54.989] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:54.989] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:179:0) after 1m0s
[09:10:55.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:179:0)
[09:10:55.078] Timer tick, asking Buildbucket for the build status
[09:10:55.186] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:55.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:180:0) after 1m0s
[09:11:55.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:180:0)
[09:11:55.244] Timer tick, asking Buildbucket for the build status
[09:11:55.312] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:55.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:181:0) after 1m0s
[09:12:55.402] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:181:0)
[09:12:55.402] Timer tick, asking Buildbucket for the build status
[09:12:55.489] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:55.489] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:182:0) after 1m0s
[09:13:55.518] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:182:0)
[09:13:55.518] Timer tick, asking Buildbucket for the build status
[09:13:55.629] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:55.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:183:0) after 1m0s
[09:15:00.930] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:183:0)
[09:15:00.930] Timer tick, asking Buildbucket for the build status
[09:15:01.014] Build 8864946958904308032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:01.014] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9030377021032552656:184:0) after 1m0s
[09:15:42.436] Received PubSub notification, asking Buildbucket for the build status
[09:15:42.515] Build 8864946958904308032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:15:42.515] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1604135741563723",
    "created_by": "project:chromium",
    "created_ts": "1604124791197840",
    "id": "8864946958904308032",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"736b3020a9b126596deb041256e053c40e83baae\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"736b3020a9b126596deb041256e053c40e83baae\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-1-8fme\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 847, \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"736b3020a9b126596deb041256e053c40e83baae\", \"got_revision_cp\": \"refs/heads/master@{#822943}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"96789f0aa67d93ea125191724666dab1be5a639c\", \"got_v8_revision_cp\": \"refs/heads/8.8.213@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"736b3020a9b126596deb041256e053c40e83baae\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-1-8fme\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1604124994843772",
    "status": "COMPLETED",
    "status_changed_ts": "1604135742043063",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/847",
      "builder:win32-official",
      "buildset:commit/git/736b3020a9b126596deb041256e053c40e83baae",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/736b3020a9b126596deb041256e053c40e83baae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9030377021032552656",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864946958904308032/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:4f961b5d1d4ba910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1604135742055193",
    "url": "https://ci.chromium.org/b/8864946958904308032",
    "utcnow_ts": "1604135742498583"
  }
}
[09:15:42.515] Invocation finished in 3h2m32.731999524s with status SUCCEEDED