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": "10687ef7fa39c560b4aa877fa60391c3c4876e48"
}

Incoming tags

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

Debug log (UTC)

[02:16:25.617] New invocation is queued and will start shortly
[02:16:26.913] Starting the invocation (attempt 1)
[02:16:26.949] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:16:26.949] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:16:26.949] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9023144157886304384",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"10687ef7fa39c560b4aa877fa60391c3c4876e48\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9023144157886304384",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/10687ef7fa39c560b4aa877fa60391c3c4876e48",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10687ef7fa39c560b4aa877fa60391c3c4876e48",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:16:28.749] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:chromium",
    "created_ts": "1611022587088580",
    "id": "8857714095680345344",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10687ef7fa39c560b4aa877fa60391c3c4876e48\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611022588412663",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1366",
      "builder:win32-official",
      "buildset:commit/git/10687ef7fa39c560b4aa877fa60391c3c4876e48",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10687ef7fa39c560b4aa877fa60391c3c4876e48",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023144157886304384",
      "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/8857714095680345344/+/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": "1611022588413036",
    "url": "https://ci.chromium.org/b/8857714095680345344",
    "utcnow_ts": "1611022588715663"
  }
}
[02:16:28.749] Task URL: https://ci.chromium.org/b/8857714095680345344
[02:16:28.749] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:2:0) after 1m0s
[02:17:28.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:2:0)
[02:17:28.809] Timer tick, asking Buildbucket for the build status
[02:17:29.395] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:29.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:3:0) after 1m0s
[02:18:29.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:3:0)
[02:18:29.423] Timer tick, asking Buildbucket for the build status
[02:18:29.718] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:29.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:4:0) after 1m0s
[02:19:29.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:4:0)
[02:19:29.747] Timer tick, asking Buildbucket for the build status
[02:19:30.035] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:30.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:5:0) after 1m0s
[02:20:30.119] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:5:0)
[02:20:30.119] Timer tick, asking Buildbucket for the build status
[02:20:30.792] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:30.792] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:6:0) after 1m0s
[02:21:30.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:6:0)
[02:21:30.916] Timer tick, asking Buildbucket for the build status
[02:21:31.011] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:31.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:7:0) after 1m0s
[02:22:31.032] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:7:0)
[02:22:31.032] Timer tick, asking Buildbucket for the build status
[02:22:31.102] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:31.102] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:8:0) after 1m0s
[02:23:31.178] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:8:0)
[02:23:31.178] Timer tick, asking Buildbucket for the build status
[02:23:31.261] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:31.261] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:9:0) after 1m0s
[02:24:31.282] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:9:0)
[02:24:31.282] Timer tick, asking Buildbucket for the build status
[02:24:31.352] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:31.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:10:0) after 1m0s
[02:25:31.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:10:0)
[02:25:31.379] Timer tick, asking Buildbucket for the build status
[02:25:31.447] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:31.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:11:0) after 1m0s
[02:26:31.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:11:0)
[02:26:31.517] Timer tick, asking Buildbucket for the build status
[02:26:31.669] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:12:0) after 1m0s
[02:27:31.743] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:12:0)
[02:27:31.743] Timer tick, asking Buildbucket for the build status
[02:27:31.825] Build 8857714095680345344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:31.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:13:0) after 1m0s
[02:28:25.887] Received PubSub notification, asking Buildbucket for the build status
[02:28:25.964] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:31.839] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:13:0)
[02:28:31.839] Timer tick, asking Buildbucket for the build status
[02:28:31.914] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:31.914] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:15:0) after 1m0s
[02:29:31.946] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:15:0)
[02:29:31.946] Timer tick, asking Buildbucket for the build status
[02:29:32.022] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:16:0) after 1m0s
[02:30:32.061] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:16:0)
[02:30:32.061] Timer tick, asking Buildbucket for the build status
[02:30:32.838] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:32.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:17:0) after 1m0s
[02:31:32.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:17:0)
[02:31:32.926] Timer tick, asking Buildbucket for the build status
[02:31:33.042] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:33.042] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:18:0) after 1m0s
[02:32:33.146] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:18:0)
[02:32:33.147] Timer tick, asking Buildbucket for the build status
[02:32:33.201] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:33.201] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:19:0) after 1m0s
[02:33:33.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:19:0)
[02:33:33.341] Timer tick, asking Buildbucket for the build status
[02:33:33.424] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:33.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:20:0) after 1m0s
[02:34:33.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:20:0)
[02:34:33.490] Timer tick, asking Buildbucket for the build status
[02:34:33.546] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:33.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:21:0) after 1m0s
[02:35:33.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:21:0)
[02:35:33.633] Timer tick, asking Buildbucket for the build status
[02:35:33.759] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:22:0) after 1m0s
[02:36:33.779] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:22:0)
[02:36:33.779] Timer tick, asking Buildbucket for the build status
[02:36:33.878] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:33.878] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:23:0) after 1m0s
[02:37:33.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:23:0)
[02:37:33.903] Timer tick, asking Buildbucket for the build status
[02:37:33.966] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:33.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:24:0) after 1m0s
[02:38:34.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:24:0)
[02:38:34.044] Timer tick, asking Buildbucket for the build status
[02:38:34.094] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:34.094] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:25:0) after 1m0s
[02:39:34.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:25:0)
[02:39:34.218] Timer tick, asking Buildbucket for the build status
[02:39:34.486] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:34.486] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:26:0) after 1m0s
[02:40:34.506] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:26:0)
[02:40:34.506] Timer tick, asking Buildbucket for the build status
[02:40:34.557] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:34.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:27:0) after 1m0s
[02:41:34.597] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:27:0)
[02:41:34.597] Timer tick, asking Buildbucket for the build status
[02:41:34.733] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:34.733] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:28:0) after 1m0s
[02:42:34.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:28:0)
[02:42:34.756] Timer tick, asking Buildbucket for the build status
[02:42:34.829] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:34.829] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:29:0) after 1m0s
[02:43:34.851] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:29:0)
[02:43:34.851] Timer tick, asking Buildbucket for the build status
[02:43:34.922] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:34.922] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:30:0) after 1m0s
[02:44:34.959] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:30:0)
[02:44:34.959] Timer tick, asking Buildbucket for the build status
[02:44:36.108] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:36.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:31:0) after 1m0s
[02:45:36.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:31:0)
[02:45:36.145] Timer tick, asking Buildbucket for the build status
[02:45:36.355] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:36.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:32:0) after 1m0s
[02:46:36.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:32:0)
[02:46:36.420] Timer tick, asking Buildbucket for the build status
[02:46:36.728] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:36.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:33:0) after 1m0s
[02:47:36.811] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:33:0)
[02:47:36.811] Timer tick, asking Buildbucket for the build status
[02:47:36.874] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:36.874] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:34:0) after 1m0s
[02:48:36.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:34:0)
[02:48:36.955] Timer tick, asking Buildbucket for the build status
[02:48:37.183] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:37.183] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:35:0) after 1m0s
[02:49:37.213] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:35:0)
[02:49:37.213] Timer tick, asking Buildbucket for the build status
[02:49:37.289] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:37.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:36:0) after 1m0s
[02:50:37.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:36:0)
[02:50:37.292] Timer tick, asking Buildbucket for the build status
[02:50:37.357] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:37.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:37:0) after 1m0s
[02:51:37.387] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:37:0)
[02:51:37.387] Timer tick, asking Buildbucket for the build status
[02:51:37.483] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:37.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:38:0) after 1m0s
[02:52:37.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:38:0)
[02:52:37.502] Timer tick, asking Buildbucket for the build status
[02:52:37.557] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:37.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:39:0) after 1m0s
[02:53:37.579] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:39:0)
[02:53:37.579] Timer tick, asking Buildbucket for the build status
[02:53:37.642] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:37.642] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:40:0) after 1m0s
[02:54:37.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:40:0)
[02:54:37.658] Timer tick, asking Buildbucket for the build status
[02:54:38.082] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:38.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:41:0) after 1m0s
[02:55:38.102] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:41:0)
[02:55:38.102] Timer tick, asking Buildbucket for the build status
[02:55:38.535] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:38.535] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:42:0) after 1m0s
[02:56:38.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:42:0)
[02:56:38.636] Timer tick, asking Buildbucket for the build status
[02:56:38.751] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:38.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:43:0) after 1m0s
[02:57:38.843] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:43:0)
[02:57:38.843] Timer tick, asking Buildbucket for the build status
[02:57:38.974] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:38.974] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:44:0) after 1m0s
[02:58:39.068] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:44:0)
[02:58:39.068] Timer tick, asking Buildbucket for the build status
[02:58:39.149] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:39.149] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:45:0) after 1m0s
[02:59:39.234] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:45:0)
[02:59:39.234] Timer tick, asking Buildbucket for the build status
[02:59:39.289] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:39.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:46:0) after 1m0s
[03:00:39.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:46:0)
[03:00:39.314] Timer tick, asking Buildbucket for the build status
[03:00:39.496] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:39.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:47:0) after 1m0s
[03:01:39.519] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:47:0)
[03:01:39.519] Timer tick, asking Buildbucket for the build status
[03:01:39.825] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:39.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:48:0) after 1m0s
[03:02:39.950] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:48:0)
[03:02:39.950] Timer tick, asking Buildbucket for the build status
[03:02:40.009] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:40.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:49:0) after 1m0s
[03:03:40.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:49:0)
[03:03:40.066] Timer tick, asking Buildbucket for the build status
[03:03:40.121] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:40.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:50:0) after 1m0s
[03:04:40.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:50:0)
[03:04:40.120] Timer tick, asking Buildbucket for the build status
[03:04:40.456] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:51:0) after 1m0s
[03:05:40.514] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:51:0)
[03:05:40.514] Timer tick, asking Buildbucket for the build status
[03:05:40.573] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:40.573] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:52:0) after 1m0s
[03:06:40.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:52:0)
[03:06:40.606] Timer tick, asking Buildbucket for the build status
[03:06:40.740] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:40.740] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:53:0) after 1m0s
[03:07:40.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:53:0)
[03:07:40.803] Timer tick, asking Buildbucket for the build status
[03:07:41.391] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:41.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:54:0) after 1m0s
[03:08:41.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:54:0)
[03:08:41.490] Timer tick, asking Buildbucket for the build status
[03:08:41.828] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:41.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:55:0) after 1m0s
[03:09:41.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:55:0)
[03:09:41.859] Timer tick, asking Buildbucket for the build status
[03:09:41.942] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:41.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:56:0) after 1m0s
[03:10:45.982] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:56:0)
[03:10:45.982] Timer tick, asking Buildbucket for the build status
[03:10:46.073] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:57:0) after 1m0s
[03:11:46.127] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:57:0)
[03:11:46.127] Timer tick, asking Buildbucket for the build status
[03:11:47.062] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:47.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:58:0) after 1m0s
[03:12:47.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:58:0)
[03:12:47.066] Timer tick, asking Buildbucket for the build status
[03:12:47.312] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:59:0) after 1m0s
[03:13:47.359] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:59:0)
[03:13:47.359] Timer tick, asking Buildbucket for the build status
[03:13:47.614] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:47.614] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:60:0) after 1m0s
[03:14:47.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:60:0)
[03:14:47.611] Timer tick, asking Buildbucket for the build status
[03:14:47.673] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:47.673] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:61:0) after 1m0s
[03:15:47.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:61:0)
[03:15:47.726] Timer tick, asking Buildbucket for the build status
[03:15:47.784] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:47.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:62:0) after 1m0s
[03:16:47.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:62:0)
[03:16:47.840] Timer tick, asking Buildbucket for the build status
[03:16:48.334] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:63:0) after 1m0s
[03:17:48.356] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:63:0)
[03:17:48.356] Timer tick, asking Buildbucket for the build status
[03:17:48.804] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:48.804] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:64:0) after 1m0s
[03:18:48.845] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:64:0)
[03:18:48.845] Timer tick, asking Buildbucket for the build status
[03:18:49.073] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:49.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:65:0) after 1m0s
[03:19:49.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:65:0)
[03:19:49.109] Timer tick, asking Buildbucket for the build status
[03:19:49.514] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:49.514] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:66:0) after 1m0s
[03:20:49.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:66:0)
[03:20:49.576] Timer tick, asking Buildbucket for the build status
[03:20:49.715] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:49.715] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:67:0) after 1m0s
[03:21:49.736] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:67:0)
[03:21:49.736] Timer tick, asking Buildbucket for the build status
[03:21:50.014] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:50.014] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:68:0) after 1m0s
[03:22:50.151] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:68:0)
[03:22:50.151] Timer tick, asking Buildbucket for the build status
[03:22:50.241] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:50.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:69:0) after 1m0s
[03:23:50.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:69:0)
[03:23:50.314] Timer tick, asking Buildbucket for the build status
[03:23:50.371] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:50.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:70:0) after 1m0s
[03:24:50.435] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:70:0)
[03:24:50.435] Timer tick, asking Buildbucket for the build status
[03:24:50.545] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:50.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:71:0) after 1m0s
[03:26:36.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:71:0)
[03:26:36.598] Timer tick, asking Buildbucket for the build status
[03:26:37.108] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:37.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:72:0) after 1m0s
[03:27:37.124] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:72:0)
[03:27:37.124] Timer tick, asking Buildbucket for the build status
[03:27:37.233] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:37.233] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:73:0) after 1m0s
[03:28:37.304] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:73:0)
[03:28:37.304] Timer tick, asking Buildbucket for the build status
[03:28:37.371] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:37.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:74:0) after 1m0s
[03:29:37.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:74:0)
[03:29:37.465] Timer tick, asking Buildbucket for the build status
[03:29:37.530] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:75:0) after 1m0s
[03:30:37.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:75:0)
[03:30:37.606] Timer tick, asking Buildbucket for the build status
[03:30:37.738] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:37.738] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:76:0) after 1m0s
[03:31:37.971] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:76:0)
[03:31:37.971] Timer tick, asking Buildbucket for the build status
[03:31:38.066] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:38.066] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:77:0) after 1m0s
[03:32:38.306] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:77:0)
[03:32:38.306] Timer tick, asking Buildbucket for the build status
[03:32:38.364] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:38.364] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:78:0) after 1m0s
[03:33:38.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:78:0)
[03:33:38.346] Timer tick, asking Buildbucket for the build status
[03:33:38.433] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.433] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:79:0) after 1m0s
[03:34:38.480] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:79:0)
[03:34:38.480] Timer tick, asking Buildbucket for the build status
[03:34:38.821] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:38.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:80:0) after 1m0s
[03:35:38.993] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:80:0)
[03:35:38.993] Timer tick, asking Buildbucket for the build status
[03:35:39.086] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:39.086] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:81:0) after 1m0s
[03:36:39.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:81:0)
[03:36:39.111] Timer tick, asking Buildbucket for the build status
[03:36:39.326] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:39.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:82:0) after 1m0s
[03:37:39.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:82:0)
[03:37:39.409] Timer tick, asking Buildbucket for the build status
[03:37:39.474] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:39.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:83:0) after 1m0s
[03:38:39.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:83:0)
[03:38:39.601] Timer tick, asking Buildbucket for the build status
[03:38:39.772] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:39.772] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:84:0) after 1m0s
[03:39:39.931] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:84:0)
[03:39:39.931] Timer tick, asking Buildbucket for the build status
[03:39:39.987] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:39.987] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:85:0) after 1m0s
[03:40:40.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:85:0)
[03:40:40.167] Timer tick, asking Buildbucket for the build status
[03:40:40.438] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:40.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:86:0) after 1m0s
[03:41:40.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:86:0)
[03:41:40.616] Timer tick, asking Buildbucket for the build status
[03:41:40.720] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:40.720] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:87:0) after 1m0s
[03:42:40.823] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:87:0)
[03:42:40.823] Timer tick, asking Buildbucket for the build status
[03:42:40.919] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:40.919] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:88:0) after 1m0s
[03:43:41.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:88:0)
[03:43:41.017] Timer tick, asking Buildbucket for the build status
[03:43:41.076] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:41.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:89:0) after 1m0s
[03:44:41.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:89:0)
[03:44:41.156] Timer tick, asking Buildbucket for the build status
[03:44:41.219] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:41.219] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:90:0) after 1m0s
[03:45:41.311] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:90:0)
[03:45:41.311] Timer tick, asking Buildbucket for the build status
[03:45:41.371] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:41.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:91:0) after 1m0s
[03:46:41.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:91:0)
[03:46:41.517] Timer tick, asking Buildbucket for the build status
[03:46:41.638] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:41.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:92:0) after 1m0s
[03:47:41.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:92:0)
[03:47:41.694] Timer tick, asking Buildbucket for the build status
[03:47:41.755] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:41.755] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:93:0) after 1m0s
[03:48:41.823] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:93:0)
[03:48:41.823] Timer tick, asking Buildbucket for the build status
[03:48:41.880] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:41.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:94:0) after 1m0s
[03:49:41.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:94:0)
[03:49:41.904] Timer tick, asking Buildbucket for the build status
[03:49:41.963] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:41.963] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:95:0) after 1m0s
[03:50:42.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:95:0)
[03:50:42.044] Timer tick, asking Buildbucket for the build status
[03:50:42.118] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:42.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:96:0) after 1m0s
[03:51:42.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:96:0)
[03:51:42.104] Timer tick, asking Buildbucket for the build status
[03:51:42.374] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:42.374] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:97:0) after 1m0s
[03:52:42.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:97:0)
[03:52:42.465] Timer tick, asking Buildbucket for the build status
[03:52:42.617] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:42.617] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:98:0) after 1m0s
[03:53:42.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:98:0)
[03:53:42.763] Timer tick, asking Buildbucket for the build status
[03:53:42.829] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:99:0) after 1m0s
[03:54:42.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:99:0)
[03:54:42.890] Timer tick, asking Buildbucket for the build status
[03:54:43.162] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:43.162] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:100:0) after 1m0s
[03:55:43.253] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:100:0)
[03:55:43.253] Timer tick, asking Buildbucket for the build status
[03:55:43.381] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:43.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:101:0) after 1m0s
[03:56:43.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:101:0)
[03:56:43.437] Timer tick, asking Buildbucket for the build status
[03:56:43.640] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:43.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:102:0) after 1m0s
[03:57:43.680] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:102:0)
[03:57:43.680] Timer tick, asking Buildbucket for the build status
[03:57:43.750] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:43.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:103:0) after 1m0s
[03:58:43.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:103:0)
[03:58:43.782] Timer tick, asking Buildbucket for the build status
[03:58:43.886] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:43.886] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:104:0) after 1m0s
[03:59:43.906] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:104:0)
[03:59:43.906] Timer tick, asking Buildbucket for the build status
[03:59:43.992] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:43.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:105:0) after 1m0s
[04:00:44.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:105:0)
[04:00:44.015] Timer tick, asking Buildbucket for the build status
[04:00:44.086] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:44.086] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:106:0) after 1m0s
[04:01:44.117] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:106:0)
[04:01:44.117] Timer tick, asking Buildbucket for the build status
[04:01:44.519] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:44.519] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:107:0) after 1m0s
[04:02:44.589] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:107:0)
[04:02:44.589] Timer tick, asking Buildbucket for the build status
[04:02:44.678] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:44.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:108:0) after 1m0s
[04:03:44.739] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:108:0)
[04:03:44.739] Timer tick, asking Buildbucket for the build status
[04:03:44.851] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:44.851] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:109:0) after 1m0s
[04:04:44.877] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:109:0)
[04:04:44.877] Timer tick, asking Buildbucket for the build status
[04:04:45.045] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:110:0) after 1m0s
[04:05:45.038] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:110:0)
[04:05:45.038] Timer tick, asking Buildbucket for the build status
[04:05:45.417] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:111:0) after 1m0s
[04:06:45.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:111:0)
[04:06:45.438] Timer tick, asking Buildbucket for the build status
[04:06:45.546] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:45.547] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:112:0) after 1m0s
[04:07:45.579] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:112:0)
[04:07:45.579] Timer tick, asking Buildbucket for the build status
[04:07:45.771] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:45.771] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:113:0) after 1m0s
[04:08:45.827] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:113:0)
[04:08:45.827] Timer tick, asking Buildbucket for the build status
[04:08:45.883] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:45.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:114:0) after 1m0s
[04:09:45.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:114:0)
[04:09:45.904] Timer tick, asking Buildbucket for the build status
[04:09:45.962] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:45.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:115:0) after 1m0s
[04:10:45.985] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:115:0)
[04:10:45.985] Timer tick, asking Buildbucket for the build status
[04:10:46.366] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:46.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:116:0) after 1m0s
[04:11:46.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:116:0)
[04:11:46.420] Timer tick, asking Buildbucket for the build status
[04:11:46.705] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:46.705] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:117:0) after 1m0s
[04:12:46.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:117:0)
[04:12:46.728] Timer tick, asking Buildbucket for the build status
[04:12:46.826] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:118:0) after 1m0s
[04:13:46.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:118:0)
[04:13:46.850] Timer tick, asking Buildbucket for the build status
[04:13:46.951] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.952] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:119:0) after 1m0s
[04:14:46.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:119:0)
[04:14:46.998] Timer tick, asking Buildbucket for the build status
[04:14:47.065] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:47.065] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:120:0) after 1m0s
[04:15:47.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:120:0)
[04:15:47.167] Timer tick, asking Buildbucket for the build status
[04:15:47.224] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:47.224] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:121:0) after 1m0s
[04:16:47.283] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:121:0)
[04:16:47.283] Timer tick, asking Buildbucket for the build status
[04:16:47.800] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:47.800] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:122:0) after 1m0s
[04:17:47.882] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:122:0)
[04:17:47.882] Timer tick, asking Buildbucket for the build status
[04:17:48.137] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:48.137] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:123:0) after 1m0s
[04:18:48.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:123:0)
[04:18:48.338] Timer tick, asking Buildbucket for the build status
[04:18:48.429] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:48.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:124:0) after 1m0s
[04:19:48.556] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:124:0)
[04:19:48.556] Timer tick, asking Buildbucket for the build status
[04:19:52.129] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:52.130] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:125:0) after 1m0s
[04:20:52.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:125:0)
[04:20:52.216] Timer tick, asking Buildbucket for the build status
[04:20:52.287] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:52.287] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:126:0) after 1m0s
[04:21:52.354] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:126:0)
[04:21:52.354] Timer tick, asking Buildbucket for the build status
[04:21:52.801] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:52.801] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:127:0) after 1m0s
[04:22:52.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:127:0)
[04:22:52.855] Timer tick, asking Buildbucket for the build status
[04:22:52.929] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:52.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:128:0) after 1m0s
[04:23:52.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:128:0)
[04:23:52.966] Timer tick, asking Buildbucket for the build status
[04:23:53.105] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:53.105] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:129:0) after 1m0s
[04:24:53.105] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:129:0)
[04:24:53.105] Timer tick, asking Buildbucket for the build status
[04:24:53.165] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:53.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:130:0) after 1m0s
[04:25:53.193] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:130:0)
[04:25:53.193] Timer tick, asking Buildbucket for the build status
[04:25:53.251] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:53.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:131:0) after 1m0s
[04:26:53.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:131:0)
[04:26:53.292] Timer tick, asking Buildbucket for the build status
[04:26:53.444] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:53.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:132:0) after 1m0s
[04:27:53.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:132:0)
[04:27:53.515] Timer tick, asking Buildbucket for the build status
[04:27:53.825] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:53.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:133:0) after 1m0s
[04:28:53.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:133:0)
[04:28:53.896] Timer tick, asking Buildbucket for the build status
[04:28:54.307] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:54.307] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:134:0) after 1m0s
[04:29:54.422] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:134:0)
[04:29:54.422] Timer tick, asking Buildbucket for the build status
[04:29:54.517] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:54.517] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:135:0) after 1m0s
[04:30:54.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:135:0)
[04:30:54.549] Timer tick, asking Buildbucket for the build status
[04:30:54.601] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:54.601] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:136:0) after 1m0s
[04:31:54.626] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:136:0)
[04:31:54.626] Timer tick, asking Buildbucket for the build status
[04:31:54.999] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:54.999] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:137:0) after 1m0s
[04:32:55.075] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:137:0)
[04:32:55.075] Timer tick, asking Buildbucket for the build status
[04:32:55.396] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:55.396] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:138:0) after 1m0s
[04:33:55.481] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:138:0)
[04:33:55.481] Timer tick, asking Buildbucket for the build status
[04:33:55.554] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:55.554] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:139:0) after 1m0s
[04:34:55.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:139:0)
[04:34:55.576] Timer tick, asking Buildbucket for the build status
[04:34:55.885] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:55.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:140:0) after 1m0s
[04:35:55.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:140:0)
[04:35:55.998] Timer tick, asking Buildbucket for the build status
[04:35:56.660] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:56.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:141:0) after 1m0s
[04:36:56.734] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:141:0)
[04:36:56.734] Timer tick, asking Buildbucket for the build status
[04:36:57.003] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:57.003] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:142:0) after 1m0s
[04:37:57.005] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:142:0)
[04:37:57.005] Timer tick, asking Buildbucket for the build status
[04:37:57.199] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:57.199] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:143:0) after 1m0s
[04:38:57.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:143:0)
[04:38:57.366] Timer tick, asking Buildbucket for the build status
[04:38:57.436] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:57.436] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:144:0) after 1m0s
[04:39:57.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:144:0)
[04:39:57.426] Timer tick, asking Buildbucket for the build status
[04:39:57.497] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:57.497] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:145:0) after 1m0s
[04:40:57.493] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:145:0)
[04:40:57.493] Timer tick, asking Buildbucket for the build status
[04:40:57.562] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:57.562] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:146:0) after 1m0s
[04:41:57.632] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:146:0)
[04:41:57.632] Timer tick, asking Buildbucket for the build status
[04:41:57.726] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:57.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:147:0) after 1m0s
[04:42:57.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:147:0)
[04:42:57.850] Timer tick, asking Buildbucket for the build status
[04:42:57.915] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:57.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:148:0) after 1m0s
[04:43:57.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:148:0)
[04:43:57.939] Timer tick, asking Buildbucket for the build status
[04:43:57.998] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:149:0) after 1m0s
[04:44:58.012] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:149:0)
[04:44:58.012] Timer tick, asking Buildbucket for the build status
[04:44:58.075] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:58.075] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:150:0) after 1m0s
[04:45:58.102] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:150:0)
[04:45:58.102] Timer tick, asking Buildbucket for the build status
[04:45:58.168] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.168] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:151:0) after 1m0s
[04:46:58.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:151:0)
[04:46:58.155] Timer tick, asking Buildbucket for the build status
[04:46:58.295] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:58.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:152:0) after 1m0s
[04:47:58.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:152:0)
[04:47:58.351] Timer tick, asking Buildbucket for the build status
[04:47:58.416] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:58.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:153:0) after 1m0s
[04:48:58.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:153:0)
[04:48:58.461] Timer tick, asking Buildbucket for the build status
[04:48:58.519] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:58.519] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:154:0) after 1m0s
[04:49:58.607] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:154:0)
[04:49:58.607] Timer tick, asking Buildbucket for the build status
[04:49:58.683] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:58.683] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:155:0) after 1m0s
[04:50:58.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:155:0)
[04:50:58.710] Timer tick, asking Buildbucket for the build status
[04:50:58.878] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:58.878] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:156:0) after 1m0s
[04:51:58.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:156:0)
[04:51:58.901] Timer tick, asking Buildbucket for the build status
[04:51:59.148] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:59.148] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:157:0) after 1m0s
[04:52:59.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:157:0)
[04:52:59.198] Timer tick, asking Buildbucket for the build status
[04:52:59.439] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:59.439] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:158:0) after 1m0s
[04:53:59.462] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:158:0)
[04:53:59.462] Timer tick, asking Buildbucket for the build status
[04:53:59.522] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:59.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:159:0) after 1m0s
[04:54:59.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:159:0)
[04:54:59.502] Timer tick, asking Buildbucket for the build status
[04:54:59.632] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:59.632] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:160:0) after 1m0s
[04:55:59.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:160:0)
[04:55:59.659] Timer tick, asking Buildbucket for the build status
[04:55:59.838] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:59.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:161:0) after 1m0s
[04:56:59.959] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:161:0)
[04:56:59.959] Timer tick, asking Buildbucket for the build status
[04:57:00.217] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:00.217] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:162:0) after 1m0s
[04:58:00.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:162:0)
[04:58:00.938] Timer tick, asking Buildbucket for the build status
[04:58:01.004] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:01.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:163:0) after 1m0s
[04:59:01.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:163:0)
[04:59:01.199] Timer tick, asking Buildbucket for the build status
[04:59:01.276] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:01.276] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:164:0) after 1m0s
[05:00:01.853] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:164:0)
[05:00:01.853] Timer tick, asking Buildbucket for the build status
[05:00:02.216] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:02.216] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:165:0) after 1m0s
[05:01:02.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:165:0)
[05:01:02.251] Timer tick, asking Buildbucket for the build status
[05:01:02.318] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:02.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:166:0) after 1m0s
[05:02:02.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:166:0)
[05:02:02.344] Timer tick, asking Buildbucket for the build status
[05:02:02.443] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:02.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:167:0) after 1m0s
[05:03:02.527] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:167:0)
[05:03:02.527] Timer tick, asking Buildbucket for the build status
[05:03:02.600] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:02.600] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:168:0) after 1m0s
[05:04:02.629] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:168:0)
[05:04:02.629] Timer tick, asking Buildbucket for the build status
[05:04:02.741] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:02.741] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:169:0) after 1m0s
[05:05:02.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:169:0)
[05:05:02.792] Timer tick, asking Buildbucket for the build status
[05:05:02.867] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:02.867] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:170:0) after 1m0s
[05:06:02.928] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:170:0)
[05:06:02.928] Timer tick, asking Buildbucket for the build status
[05:06:03.015] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:03.015] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:171:0) after 1m0s
[05:07:03.063] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:171:0)
[05:07:03.063] Timer tick, asking Buildbucket for the build status
[05:07:03.310] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:03.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:172:0) after 1m0s
[05:08:03.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:172:0)
[05:08:03.336] Timer tick, asking Buildbucket for the build status
[05:08:03.430] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:03.430] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:173:0) after 1m0s
[05:09:03.497] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:173:0)
[05:09:03.497] Timer tick, asking Buildbucket for the build status
[05:09:03.889] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:03.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:174:0) after 1m0s
[05:10:03.927] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:174:0)
[05:10:03.927] Timer tick, asking Buildbucket for the build status
[05:10:04.194] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:04.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:175:0) after 1m0s
[05:11:04.232] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:175:0)
[05:11:04.232] Timer tick, asking Buildbucket for the build status
[05:11:04.308] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:04.308] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:176:0) after 1m0s
[05:12:04.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:176:0)
[05:12:04.416] Timer tick, asking Buildbucket for the build status
[05:12:04.512] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:04.512] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:177:0) after 1m0s
[05:13:04.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:177:0)
[05:13:04.584] Timer tick, asking Buildbucket for the build status
[05:13:05.006] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:05.006] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:178:0) after 1m0s
[05:14:05.060] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:178:0)
[05:14:05.060] Timer tick, asking Buildbucket for the build status
[05:14:05.416] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:05.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:179:0) after 1m0s
[05:15:05.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:179:0)
[05:15:05.465] Timer tick, asking Buildbucket for the build status
[05:15:05.579] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:05.579] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:180:0) after 1m0s
[05:16:05.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:180:0)
[05:16:05.576] Timer tick, asking Buildbucket for the build status
[05:16:05.682] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:05.682] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:181:0) after 1m0s
[05:17:05.709] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:181:0)
[05:17:05.709] Timer tick, asking Buildbucket for the build status
[05:17:05.817] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:05.817] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:182:0) after 1m0s
[05:18:05.841] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:182:0)
[05:18:05.841] Timer tick, asking Buildbucket for the build status
[05:18:06.122] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:06.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:183:0) after 1m0s
[05:19:06.149] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:183:0)
[05:19:06.149] Timer tick, asking Buildbucket for the build status
[05:19:06.236] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:06.236] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:184:0) after 1m0s
[05:20:06.229] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:184:0)
[05:20:06.229] Timer tick, asking Buildbucket for the build status
[05:20:06.417] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:06.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:185:0) after 1m0s
[05:21:06.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:185:0)
[05:21:06.482] Timer tick, asking Buildbucket for the build status
[05:21:07.579] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:07.579] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:186:0) after 1m0s
[05:22:07.617] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:186:0)
[05:22:07.618] Timer tick, asking Buildbucket for the build status
[05:22:07.732] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:07.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:187:0) after 1m0s
[05:23:07.755] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:187:0)
[05:23:07.755] Timer tick, asking Buildbucket for the build status
[05:23:07.825] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:07.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:188:0) after 1m0s
[05:24:07.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:188:0)
[05:24:07.856] Timer tick, asking Buildbucket for the build status
[05:24:08.135] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:08.135] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:189:0) after 1m0s
[05:25:08.169] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:189:0)
[05:25:08.169] Timer tick, asking Buildbucket for the build status
[05:25:08.229] Build 8857714095680345344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:08.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023144157886304384:190:0) after 1m0s
[05:26:01.603] Received PubSub notification, asking Buildbucket for the build status
[05:26:01.658] Build 8857714095680345344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:26:01.658] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1611033959764396",
    "created_by": "project:chromium",
    "created_ts": "1611022587088580",
    "id": "8857714095680345344",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10687ef7fa39c560b4aa877fa60391c3c4876e48\"}}",
    "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\": \"10687ef7fa39c560b4aa877fa60391c3c4876e48\", \"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-8-fqoc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1366, \"got_angle_revision\": \"5635dbb91641a72f1f713aa7c179e2432674f9c3\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"10687ef7fa39c560b4aa877fa60391c3c4876e48\", \"got_revision_cp\": \"refs/heads/master@{#844646}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10687ef7fa39c560b4aa877fa60391c3c4876e48\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-fqoc\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5666-679c9bd\"], \"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": "1611023305156262",
    "status": "COMPLETED",
    "status_changed_ts": "1611033959985320",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1366",
      "builder:win32-official",
      "buildset:commit/git/10687ef7fa39c560b4aa877fa60391c3c4876e48",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10687ef7fa39c560b4aa877fa60391c3c4876e48",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023144157886304384",
      "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/8857714095680345344/+/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:51313f632ae89f10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611033959989391",
    "url": "https://ci.chromium.org/b/8857714095680345344",
    "utcnow_ts": "1611033961651592"
  }
}
[05:26:01.658] Invocation finished in 3h9m36.057559544s with status SUCCEEDED