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": "7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3"
}

Incoming tags

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

Debug log (UTC)

[08:51:22.363] New invocation is queued and will start shortly
[08:51:23.856] Starting the invocation (attempt 1)
[08:51:23.910] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:51:23.910] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:51:23.910] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9027377367473862608",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9027377367473862608",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
    "gitiles_ref:refs/heads/master"
  ]
}
[08:51:24.833] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1606985484054606",
    "id": "8861947305030989168",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1606985484635952",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1044",
      "builder:win32-official",
      "buildset:commit/git/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9027377367473862608",
      "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/8861947305030989168/+/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": "1606985484636290",
    "url": "https://ci.chromium.org/b/8861947305030989168",
    "utcnow_ts": "1606985484826231"
  }
}
[08:51:24.833] Task URL: https://ci.chromium.org/b/8861947305030989168
[08:51:24.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:2:0) after 1m0s
[08:52:02.273] Received PubSub notification, asking Buildbucket for the build status
[08:52:02.479] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:24.876] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:2:0)
[08:52:24.876] Timer tick, asking Buildbucket for the build status
[08:52:24.996] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:4:0) after 1m0s
[08:53:25.054] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:4:0)
[08:53:25.054] Timer tick, asking Buildbucket for the build status
[08:53:25.152] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:25.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:5:0) after 1m0s
[08:54:25.215] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:5:0)
[08:54:25.215] Timer tick, asking Buildbucket for the build status
[08:54:26.089] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:26.089] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:6:0) after 1m0s
[08:55:26.114] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:6:0)
[08:55:26.114] Timer tick, asking Buildbucket for the build status
[08:55:26.207] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:26.207] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:7:0) after 1m0s
[08:56:26.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:7:0)
[08:56:26.227] Timer tick, asking Buildbucket for the build status
[08:56:26.605] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:26.605] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:8:0) after 1m0s
[08:57:26.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:8:0)
[08:57:26.633] Timer tick, asking Buildbucket for the build status
[08:57:26.837] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:26.837] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:9:0) after 1m0s
[08:58:26.887] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:9:0)
[08:58:26.888] Timer tick, asking Buildbucket for the build status
[08:58:27.274] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:27.274] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:10:0) after 1m0s
[08:59:27.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:10:0)
[08:59:27.329] Timer tick, asking Buildbucket for the build status
[08:59:27.402] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:27.402] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:11:0) after 1m0s
[09:00:27.395] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:11:0)
[09:00:27.395] Timer tick, asking Buildbucket for the build status
[09:00:27.494] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:27.494] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:12:0) after 1m0s
[09:01:27.545] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:12:0)
[09:01:27.545] Timer tick, asking Buildbucket for the build status
[09:01:27.657] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:27.657] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:13:0) after 1m0s
[09:02:27.678] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:13:0)
[09:02:27.678] Timer tick, asking Buildbucket for the build status
[09:02:28.000] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:28.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:14:0) after 1m0s
[09:03:28.031] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:14:0)
[09:03:28.031] Timer tick, asking Buildbucket for the build status
[09:03:28.241] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:28.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:15:0) after 1m0s
[09:04:28.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:15:0)
[09:04:28.273] Timer tick, asking Buildbucket for the build status
[09:04:28.356] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:28.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:16:0) after 1m0s
[09:05:28.413] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:16:0)
[09:05:28.413] Timer tick, asking Buildbucket for the build status
[09:05:34.852] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:34.852] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:17:0) after 1m0s
[09:06:34.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:17:0)
[09:06:34.875] Timer tick, asking Buildbucket for the build status
[09:06:34.981] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:34.981] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:18:0) after 1m0s
[09:07:35.040] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:18:0)
[09:07:35.040] Timer tick, asking Buildbucket for the build status
[09:07:35.422] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:35.422] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:19:0) after 1m0s
[09:08:35.403] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:19:0)
[09:08:35.403] Timer tick, asking Buildbucket for the build status
[09:08:35.531] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:35.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:20:0) after 1m0s
[09:09:35.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:20:0)
[09:09:35.588] Timer tick, asking Buildbucket for the build status
[09:09:35.674] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:35.674] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:21:0) after 1m0s
[09:10:35.703] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:21:0)
[09:10:35.703] Timer tick, asking Buildbucket for the build status
[09:10:37.032] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:37.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:22:0) after 1m0s
[09:11:37.081] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:22:0)
[09:11:37.081] Timer tick, asking Buildbucket for the build status
[09:11:37.208] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:23:0) after 1m0s
[09:12:37.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:23:0)
[09:12:37.293] Timer tick, asking Buildbucket for the build status
[09:12:37.405] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:37.405] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:24:0) after 1m0s
[09:13:37.542] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:24:0)
[09:13:37.542] Timer tick, asking Buildbucket for the build status
[09:13:37.742] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:37.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:25:0) after 1m0s
[09:14:37.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:25:0)
[09:14:37.762] Timer tick, asking Buildbucket for the build status
[09:14:38.044] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:38.044] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:26:0) after 1m0s
[09:15:38.070] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:26:0)
[09:15:38.070] Timer tick, asking Buildbucket for the build status
[09:15:38.141] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:38.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:27:0) after 1m0s
[09:16:38.164] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:27:0)
[09:16:38.164] Timer tick, asking Buildbucket for the build status
[09:16:38.292] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:38.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:28:0) after 1m0s
[09:17:38.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:28:0)
[09:17:38.338] Timer tick, asking Buildbucket for the build status
[09:17:38.431] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:38.431] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:29:0) after 1m0s
[09:18:38.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:29:0)
[09:18:38.492] Timer tick, asking Buildbucket for the build status
[09:18:38.558] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:38.558] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:30:0) after 1m0s
[09:19:38.673] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:30:0)
[09:19:38.673] Timer tick, asking Buildbucket for the build status
[09:19:38.743] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:38.743] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:31:0) after 1m0s
[09:20:38.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:31:0)
[09:20:38.771] Timer tick, asking Buildbucket for the build status
[09:20:38.871] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:38.871] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:32:0) after 1m0s
[09:21:38.915] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:32:0)
[09:21:38.915] Timer tick, asking Buildbucket for the build status
[09:21:39.213] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:39.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:33:0) after 1m0s
[09:22:39.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:33:0)
[09:22:39.314] Timer tick, asking Buildbucket for the build status
[09:22:39.561] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:39.561] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:34:0) after 1m0s
[09:23:39.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:34:0)
[09:23:39.595] Timer tick, asking Buildbucket for the build status
[09:23:39.669] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:39.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:35:0) after 1m0s
[09:24:39.727] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:35:0)
[09:24:39.727] Timer tick, asking Buildbucket for the build status
[09:24:39.821] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:39.821] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:36:0) after 1m0s
[09:25:39.943] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:36:0)
[09:25:39.943] Timer tick, asking Buildbucket for the build status
[09:25:40.082] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:40.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:37:0) after 1m0s
[09:26:40.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:37:0)
[09:26:40.158] Timer tick, asking Buildbucket for the build status
[09:26:40.302] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:38:0) after 1m0s
[09:27:40.370] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:38:0)
[09:27:40.370] Timer tick, asking Buildbucket for the build status
[09:27:41.052] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:41.052] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:39:0) after 1m0s
[09:28:41.350] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:39:0)
[09:28:41.350] Timer tick, asking Buildbucket for the build status
[09:28:41.428] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:41.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:40:0) after 1m0s
[09:29:41.520] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:40:0)
[09:29:41.520] Timer tick, asking Buildbucket for the build status
[09:29:41.584] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:41.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:41:0) after 1m0s
[09:30:41.671] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:41:0)
[09:30:41.671] Timer tick, asking Buildbucket for the build status
[09:30:41.748] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:41.748] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:42:0) after 1m0s
[09:31:42.163] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:42:0)
[09:31:42.163] Timer tick, asking Buildbucket for the build status
[09:31:42.545] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:42.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:43:0) after 1m0s
[09:32:42.634] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:43:0)
[09:32:42.634] Timer tick, asking Buildbucket for the build status
[09:32:42.708] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:42.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:44:0) after 1m0s
[09:33:42.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:44:0)
[09:33:42.829] Timer tick, asking Buildbucket for the build status
[09:33:42.878] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:42.878] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:45:0) after 1m0s
[09:34:43.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:45:0)
[09:34:43.017] Timer tick, asking Buildbucket for the build status
[09:34:43.108] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:43.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:46:0) after 1m0s
[09:35:43.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:46:0)
[09:35:43.224] Timer tick, asking Buildbucket for the build status
[09:35:43.334] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:43.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:47:0) after 1m0s
[09:36:43.392] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:47:0)
[09:36:43.392] Timer tick, asking Buildbucket for the build status
[09:36:43.617] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:43.617] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:48:0) after 1m0s
[09:37:43.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:48:0)
[09:37:43.695] Timer tick, asking Buildbucket for the build status
[09:37:44.320] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:44.320] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:49:0) after 1m0s
[09:38:44.521] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:49:0)
[09:38:44.521] Timer tick, asking Buildbucket for the build status
[09:38:46.022] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:46.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:50:0) after 1m0s
[09:39:46.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:50:0)
[09:39:46.145] Timer tick, asking Buildbucket for the build status
[09:39:46.253] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:46.253] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:51:0) after 1m0s
[09:40:46.428] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:51:0)
[09:40:46.428] Timer tick, asking Buildbucket for the build status
[09:40:46.523] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:52:0) after 1m0s
[09:41:46.643] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:52:0)
[09:41:46.643] Timer tick, asking Buildbucket for the build status
[09:41:47.261] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:47.261] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:53:0) after 1m0s
[09:42:47.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:53:0)
[09:42:47.464] Timer tick, asking Buildbucket for the build status
[09:42:47.541] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:47.541] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:54:0) after 1m0s
[09:43:47.629] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:54:0)
[09:43:47.629] Timer tick, asking Buildbucket for the build status
[09:43:47.708] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:47.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:55:0) after 1m0s
[09:44:47.760] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:55:0)
[09:44:47.760] Timer tick, asking Buildbucket for the build status
[09:44:47.844] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:47.844] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:56:0) after 1m0s
[09:45:47.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:56:0)
[09:45:47.948] Timer tick, asking Buildbucket for the build status
[09:45:48.035] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:48.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:57:0) after 1m0s
[09:46:48.183] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:57:0)
[09:46:48.183] Timer tick, asking Buildbucket for the build status
[09:46:48.458] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:48.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:58:0) after 1m0s
[09:47:48.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:58:0)
[09:47:48.516] Timer tick, asking Buildbucket for the build status
[09:47:48.647] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:48.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:59:0) after 1m0s
[09:48:48.704] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:59:0)
[09:48:48.704] Timer tick, asking Buildbucket for the build status
[09:48:48.758] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:48.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:60:0) after 1m0s
[09:49:48.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:60:0)
[09:49:48.881] Timer tick, asking Buildbucket for the build status
[09:49:49.650] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:49.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:61:0) after 1m0s
[09:50:49.813] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:61:0)
[09:50:49.813] Timer tick, asking Buildbucket for the build status
[09:50:50.424] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:50.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:62:0) after 1m0s
[09:51:50.521] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:62:0)
[09:51:50.521] Timer tick, asking Buildbucket for the build status
[09:51:50.825] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:50.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:63:0) after 1m0s
[09:52:50.975] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:63:0)
[09:52:50.975] Timer tick, asking Buildbucket for the build status
[09:52:51.067] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:51.067] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:64:0) after 1m0s
[09:53:51.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:64:0)
[09:53:51.145] Timer tick, asking Buildbucket for the build status
[09:53:51.213] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:51.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:65:0) after 1m0s
[09:54:51.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:65:0)
[09:54:51.202] Timer tick, asking Buildbucket for the build status
[09:54:53.843] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:53.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:66:0) after 1m0s
[09:55:54.108] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:66:0)
[09:55:54.108] Timer tick, asking Buildbucket for the build status
[09:55:54.909] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:54.909] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:67:0) after 1m0s
[09:56:55.164] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:67:0)
[09:56:55.164] Timer tick, asking Buildbucket for the build status
[09:56:55.380] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:55.380] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:68:0) after 1m0s
[09:57:55.435] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:68:0)
[09:57:55.435] Timer tick, asking Buildbucket for the build status
[09:57:55.564] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:55.564] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:69:0) after 1m0s
[09:58:55.605] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:69:0)
[09:58:55.605] Timer tick, asking Buildbucket for the build status
[09:58:55.758] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:70:0) after 1m0s
[09:59:55.882] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:70:0)
[09:59:55.882] Timer tick, asking Buildbucket for the build status
[09:59:55.950] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:55.950] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:71:0) after 1m0s
[10:00:55.982] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:71:0)
[10:00:55.982] Timer tick, asking Buildbucket for the build status
[10:00:56.790] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:56.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:72:0) after 1m0s
[10:01:56.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:72:0)
[10:01:56.949] Timer tick, asking Buildbucket for the build status
[10:01:57.117] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:57.117] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:73:0) after 1m0s
[10:02:57.163] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:73:0)
[10:02:57.163] Timer tick, asking Buildbucket for the build status
[10:02:57.332] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:57.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:74:0) after 1m0s
[10:03:57.350] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:74:0)
[10:03:57.350] Timer tick, asking Buildbucket for the build status
[10:03:57.508] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:57.508] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:75:0) after 1m0s
[10:04:57.607] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:75:0)
[10:04:57.607] Timer tick, asking Buildbucket for the build status
[10:04:57.717] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:57.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:76:0) after 1m0s
[10:05:57.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:76:0)
[10:05:57.990] Timer tick, asking Buildbucket for the build status
[10:05:58.431] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:58.431] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:77:0) after 1m0s
[10:06:58.552] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:77:0)
[10:06:58.552] Timer tick, asking Buildbucket for the build status
[10:06:58.657] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:58.657] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:78:0) after 1m0s
[10:07:58.715] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:78:0)
[10:07:58.715] Timer tick, asking Buildbucket for the build status
[10:07:58.796] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:58.796] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:79:0) after 1m0s
[10:08:58.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:79:0)
[10:08:58.866] Timer tick, asking Buildbucket for the build status
[10:08:58.957] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:58.957] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:80:0) after 1m0s
[10:09:59.070] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:80:0)
[10:09:59.070] Timer tick, asking Buildbucket for the build status
[10:09:59.137] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:59.137] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:81:0) after 1m0s
[10:10:59.209] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:81:0)
[10:10:59.209] Timer tick, asking Buildbucket for the build status
[10:10:59.762] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:59.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:82:0) after 1m0s
[10:11:59.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:82:0)
[10:11:59.792] Timer tick, asking Buildbucket for the build status
[10:12:00.146] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:00.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:83:0) after 1m0s
[10:13:00.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:83:0)
[10:13:00.218] Timer tick, asking Buildbucket for the build status
[10:13:00.302] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:00.302] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:84:0) after 1m0s
[10:14:00.331] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:84:0)
[10:14:00.331] Timer tick, asking Buildbucket for the build status
[10:14:00.400] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:00.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:85:0) after 1m0s
[10:15:00.417] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:85:0)
[10:15:00.417] Timer tick, asking Buildbucket for the build status
[10:15:00.479] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:00.479] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:86:0) after 1m0s
[10:16:00.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:86:0)
[10:16:00.515] Timer tick, asking Buildbucket for the build status
[10:16:00.580] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:00.580] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:87:0) after 1m0s
[10:17:00.643] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:87:0)
[10:17:00.643] Timer tick, asking Buildbucket for the build status
[10:17:02.258] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:02.258] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:88:0) after 1m0s
[10:18:04.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:88:0)
[10:18:04.066] Timer tick, asking Buildbucket for the build status
[10:18:04.279] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:04.279] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:89:0) after 1m0s
[10:19:04.495] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:89:0)
[10:19:04.495] Timer tick, asking Buildbucket for the build status
[10:19:04.659] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:04.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:90:0) after 1m0s
[10:20:04.686] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:90:0)
[10:20:04.686] Timer tick, asking Buildbucket for the build status
[10:20:04.917] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:04.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:91:0) after 1m0s
[10:21:05.223] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:91:0)
[10:21:05.223] Timer tick, asking Buildbucket for the build status
[10:21:05.328] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:05.328] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:92:0) after 1m0s
[10:22:05.509] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:92:0)
[10:22:05.509] Timer tick, asking Buildbucket for the build status
[10:22:05.627] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:05.627] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:93:0) after 1m0s
[10:23:05.849] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:93:0)
[10:23:05.849] Timer tick, asking Buildbucket for the build status
[10:23:09.403] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:94:0) after 1m0s
[10:24:09.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:94:0)
[10:24:09.586] Timer tick, asking Buildbucket for the build status
[10:24:09.692] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:09.692] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:95:0) after 1m0s
[10:25:09.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:95:0)
[10:25:09.782] Timer tick, asking Buildbucket for the build status
[10:25:09.865] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:09.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:96:0) after 1m0s
[10:26:10.075] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:96:0)
[10:26:10.075] Timer tick, asking Buildbucket for the build status
[10:26:10.255] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:10.255] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:97:0) after 1m0s
[10:27:10.386] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:97:0)
[10:27:10.386] Timer tick, asking Buildbucket for the build status
[10:27:10.725] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:98:0) after 1m0s
[10:28:10.766] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:98:0)
[10:28:10.766] Timer tick, asking Buildbucket for the build status
[10:28:10.858] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:10.858] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:99:0) after 1m0s
[10:29:10.882] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:99:0)
[10:29:10.882] Timer tick, asking Buildbucket for the build status
[10:29:11.131] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:11.131] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:100:0) after 1m0s
[10:30:11.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:100:0)
[10:30:11.192] Timer tick, asking Buildbucket for the build status
[10:30:11.995] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:11.995] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:101:0) after 1m0s
[10:31:12.074] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:101:0)
[10:31:12.074] Timer tick, asking Buildbucket for the build status
[10:31:12.152] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:102:0) after 1m0s
[10:32:12.186] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:102:0)
[10:32:12.186] Timer tick, asking Buildbucket for the build status
[10:32:12.416] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:12.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:103:0) after 1m0s
[10:33:12.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:103:0)
[10:33:12.747] Timer tick, asking Buildbucket for the build status
[10:33:12.896] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:12.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:104:0) after 1m0s
[10:34:12.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:104:0)
[10:34:12.918] Timer tick, asking Buildbucket for the build status
[10:34:13.163] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:13.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:105:0) after 1m0s
[10:35:13.159] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:105:0)
[10:35:13.159] Timer tick, asking Buildbucket for the build status
[10:35:13.534] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:13.534] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:106:0) after 1m0s
[10:36:13.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:106:0)
[10:36:13.658] Timer tick, asking Buildbucket for the build status
[10:36:13.732] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:13.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:107:0) after 1m0s
[10:37:13.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:107:0)
[10:37:13.716] Timer tick, asking Buildbucket for the build status
[10:37:13.858] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:13.858] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:108:0) after 1m0s
[10:38:13.987] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:108:0)
[10:38:13.987] Timer tick, asking Buildbucket for the build status
[10:38:14.196] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:14.196] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:109:0) after 1m0s
[10:39:14.247] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:109:0)
[10:39:14.247] Timer tick, asking Buildbucket for the build status
[10:39:14.336] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:14.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:110:0) after 1m0s
[10:40:14.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:110:0)
[10:40:14.468] Timer tick, asking Buildbucket for the build status
[10:40:14.567] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:111:0) after 1m0s
[10:41:14.646] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:111:0)
[10:41:14.646] Timer tick, asking Buildbucket for the build status
[10:41:14.728] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:14.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:112:0) after 1m0s
[10:42:14.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:112:0)
[10:42:14.840] Timer tick, asking Buildbucket for the build status
[10:42:14.965] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:113:0) after 1m0s
[10:43:14.992] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:113:0)
[10:43:14.992] Timer tick, asking Buildbucket for the build status
[10:43:15.078] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:15.078] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:114:0) after 1m0s
[10:44:15.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:114:0)
[10:44:15.104] Timer tick, asking Buildbucket for the build status
[10:44:15.179] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:15.179] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:115:0) after 1m0s
[10:45:15.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:115:0)
[10:45:15.268] Timer tick, asking Buildbucket for the build status
[10:45:16.663] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:16.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:116:0) after 1m0s
[10:46:16.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:116:0)
[10:46:16.762] Timer tick, asking Buildbucket for the build status
[10:46:16.838] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:16.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:117:0) after 1m0s
[10:47:16.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:117:0)
[10:47:16.939] Timer tick, asking Buildbucket for the build status
[10:47:17.056] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:17.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:118:0) after 1m0s
[10:48:17.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:118:0)
[10:48:17.150] Timer tick, asking Buildbucket for the build status
[10:48:17.211] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:17.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:119:0) after 1m0s
[10:49:17.271] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:119:0)
[10:49:17.271] Timer tick, asking Buildbucket for the build status
[10:49:17.393] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:17.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:120:0) after 1m0s
[10:50:17.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:120:0)
[10:50:17.391] Timer tick, asking Buildbucket for the build status
[10:50:17.801] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:17.801] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:121:0) after 1m0s
[10:51:17.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:121:0)
[10:51:17.871] Timer tick, asking Buildbucket for the build status
[10:51:17.945] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:17.946] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:122:0) after 1m0s
[10:52:17.995] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:122:0)
[10:52:17.995] Timer tick, asking Buildbucket for the build status
[10:52:18.124] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:18.124] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:123:0) after 1m0s
[10:53:18.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:123:0)
[10:53:18.156] Timer tick, asking Buildbucket for the build status
[10:53:18.643] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:18.643] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:124:0) after 1m0s
[10:54:18.743] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:124:0)
[10:54:18.743] Timer tick, asking Buildbucket for the build status
[10:54:18.935] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:125:0) after 1m0s
[10:55:18.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:125:0)
[10:55:18.972] Timer tick, asking Buildbucket for the build status
[10:55:19.043] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:19.043] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:126:0) after 1m0s
[10:56:19.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:126:0)
[10:56:19.122] Timer tick, asking Buildbucket for the build status
[10:56:19.332] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:19.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:127:0) after 1m0s
[10:57:19.506] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:127:0)
[10:57:19.506] Timer tick, asking Buildbucket for the build status
[10:57:19.735] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:19.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:128:0) after 1m0s
[10:58:19.958] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:128:0)
[10:58:19.958] Timer tick, asking Buildbucket for the build status
[10:58:20.046] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:20.046] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:129:0) after 1m0s
[10:59:20.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:129:0)
[10:59:20.227] Timer tick, asking Buildbucket for the build status
[10:59:20.322] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:20.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:130:0) after 1m0s
[11:00:20.454] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:130:0)
[11:00:20.454] Timer tick, asking Buildbucket for the build status
[11:00:20.538] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:20.538] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:131:0) after 1m0s
[11:01:20.766] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:131:0)
[11:01:20.766] Timer tick, asking Buildbucket for the build status
[11:01:20.868] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:20.868] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:132:0) after 1m0s
[11:02:21.000] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:132:0)
[11:02:21.000] Timer tick, asking Buildbucket for the build status
[11:02:21.151] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:21.151] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:133:0) after 1m0s
[11:03:21.339] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:133:0)
[11:03:21.340] Timer tick, asking Buildbucket for the build status
[11:03:22.126] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:22.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:134:0) after 1m0s
[11:04:22.256] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:134:0)
[11:04:22.256] Timer tick, asking Buildbucket for the build status
[11:04:22.389] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:22.389] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:135:0) after 1m0s
[11:05:22.556] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:135:0)
[11:05:22.556] Timer tick, asking Buildbucket for the build status
[11:05:22.634] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:22.634] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:136:0) after 1m0s
[11:06:22.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:136:0)
[11:06:22.707] Timer tick, asking Buildbucket for the build status
[11:06:23.406] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:23.406] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:137:0) after 1m0s
[11:07:23.451] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:137:0)
[11:07:23.451] Timer tick, asking Buildbucket for the build status
[11:07:23.578] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:23.578] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:138:0) after 1m0s
[11:08:24.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:138:0)
[11:08:24.227] Timer tick, asking Buildbucket for the build status
[11:08:24.712] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:24.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:139:0) after 1m0s
[11:09:25.154] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:139:0)
[11:09:25.154] Timer tick, asking Buildbucket for the build status
[11:09:25.221] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:25.221] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:140:0) after 1m0s
[11:10:25.307] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:140:0)
[11:10:25.307] Timer tick, asking Buildbucket for the build status
[11:10:25.531] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:141:0) after 1m0s
[11:11:25.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:141:0)
[11:11:25.620] Timer tick, asking Buildbucket for the build status
[11:11:25.718] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:25.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:142:0) after 1m0s
[11:12:25.785] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:142:0)
[11:12:25.785] Timer tick, asking Buildbucket for the build status
[11:12:25.903] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:25.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:143:0) after 1m0s
[11:13:26.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:143:0)
[11:13:26.001] Timer tick, asking Buildbucket for the build status
[11:13:26.108] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:26.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:144:0) after 1m0s
[11:14:26.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:144:0)
[11:14:26.179] Timer tick, asking Buildbucket for the build status
[11:14:26.275] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:26.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:145:0) after 1m0s
[11:15:26.327] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:145:0)
[11:15:26.327] Timer tick, asking Buildbucket for the build status
[11:15:26.443] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:26.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:146:0) after 1m0s
[11:16:26.491] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:146:0)
[11:16:26.491] Timer tick, asking Buildbucket for the build status
[11:16:26.580] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:26.580] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:147:0) after 1m0s
[11:17:26.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:147:0)
[11:17:26.737] Timer tick, asking Buildbucket for the build status
[11:17:28.054] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:28.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:148:0) after 1m0s
[11:18:28.080] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:148:0)
[11:18:28.080] Timer tick, asking Buildbucket for the build status
[11:18:28.178] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:28.178] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:149:0) after 1m0s
[11:19:28.217] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:149:0)
[11:19:28.217] Timer tick, asking Buildbucket for the build status
[11:19:28.292] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:28.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:150:0) after 1m0s
[11:20:28.277] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:150:0)
[11:20:28.277] Timer tick, asking Buildbucket for the build status
[11:20:28.384] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:28.384] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:151:0) after 1m0s
[11:21:28.514] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:151:0)
[11:21:28.514] Timer tick, asking Buildbucket for the build status
[11:21:28.777] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:28.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:152:0) after 1m0s
[11:22:28.900] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:152:0)
[11:22:28.900] Timer tick, asking Buildbucket for the build status
[11:22:29.022] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:29.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:153:0) after 1m0s
[11:23:29.106] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:153:0)
[11:23:29.106] Timer tick, asking Buildbucket for the build status
[11:23:29.215] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:29.215] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:154:0) after 1m0s
[11:24:29.309] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:154:0)
[11:24:29.309] Timer tick, asking Buildbucket for the build status
[11:24:29.381] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:29.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:155:0) after 1m0s
[11:25:29.383] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:155:0)
[11:25:29.384] Timer tick, asking Buildbucket for the build status
[11:25:29.526] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:29.526] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:156:0) after 1m0s
[11:26:29.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:156:0)
[11:26:29.620] Timer tick, asking Buildbucket for the build status
[11:26:29.688] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:157:0) after 1m0s
[11:27:29.749] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:157:0)
[11:27:29.749] Timer tick, asking Buildbucket for the build status
[11:27:29.932] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:29.932] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:158:0) after 1m0s
[11:28:30.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:158:0)
[11:28:30.053] Timer tick, asking Buildbucket for the build status
[11:28:30.414] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:30.414] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:159:0) after 1m0s
[11:29:30.498] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:159:0)
[11:29:30.498] Timer tick, asking Buildbucket for the build status
[11:29:30.605] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:30.605] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:160:0) after 1m0s
[11:30:30.694] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:160:0)
[11:30:30.694] Timer tick, asking Buildbucket for the build status
[11:30:30.799] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:30.799] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:161:0) after 1m0s
[11:31:30.847] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:161:0)
[11:31:30.847] Timer tick, asking Buildbucket for the build status
[11:31:30.991] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:30.991] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:162:0) after 1m0s
[11:32:31.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:162:0)
[11:32:31.084] Timer tick, asking Buildbucket for the build status
[11:32:31.201] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:31.201] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:163:0) after 1m0s
[11:33:31.262] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:163:0)
[11:33:31.262] Timer tick, asking Buildbucket for the build status
[11:33:31.332] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:31.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:164:0) after 1m0s
[11:34:31.393] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:164:0)
[11:34:31.393] Timer tick, asking Buildbucket for the build status
[11:34:31.713] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:165:0) after 1m0s
[11:35:31.745] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:165:0)
[11:35:31.745] Timer tick, asking Buildbucket for the build status
[11:35:31.818] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:166:0) after 1m0s
[11:36:31.812] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:166:0)
[11:36:31.812] Timer tick, asking Buildbucket for the build status
[11:36:31.961] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:31.961] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:167:0) after 1m0s
[11:37:31.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:167:0)
[11:37:31.998] Timer tick, asking Buildbucket for the build status
[11:37:32.108] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:32.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:168:0) after 1m0s
[11:38:32.203] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:168:0)
[11:38:32.203] Timer tick, asking Buildbucket for the build status
[11:38:32.457] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:32.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:169:0) after 1m0s
[11:39:32.500] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:169:0)
[11:39:32.500] Timer tick, asking Buildbucket for the build status
[11:39:32.636] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:32.636] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:170:0) after 1m0s
[11:40:32.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:170:0)
[11:40:32.668] Timer tick, asking Buildbucket for the build status
[11:40:32.764] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:32.764] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:171:0) after 1m0s
[11:41:32.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:171:0)
[11:41:32.794] Timer tick, asking Buildbucket for the build status
[11:41:32.983] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:32.983] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:172:0) after 1m0s
[11:42:33.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:172:0)
[11:42:33.013] Timer tick, asking Buildbucket for the build status
[11:42:33.125] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:33.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:173:0) after 1m0s
[11:43:33.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:173:0)
[11:43:33.199] Timer tick, asking Buildbucket for the build status
[11:43:33.563] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:33.563] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:174:0) after 1m0s
[11:44:33.589] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:174:0)
[11:44:33.589] Timer tick, asking Buildbucket for the build status
[11:44:33.683] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:33.683] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:175:0) after 1m0s
[11:45:33.771] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:175:0)
[11:45:33.771] Timer tick, asking Buildbucket for the build status
[11:45:34.075] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:34.075] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:176:0) after 1m0s
[11:46:34.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:176:0)
[11:46:34.155] Timer tick, asking Buildbucket for the build status
[11:46:34.412] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:34.412] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:177:0) after 1m0s
[11:47:34.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:177:0)
[11:47:34.436] Timer tick, asking Buildbucket for the build status
[11:47:34.574] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:34.574] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:178:0) after 1m0s
[11:48:34.609] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:178:0)
[11:48:34.609] Timer tick, asking Buildbucket for the build status
[11:48:34.756] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:34.756] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:179:0) after 1m0s
[11:49:34.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:179:0)
[11:49:34.783] Timer tick, asking Buildbucket for the build status
[11:49:35.140] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:35.140] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:180:0) after 1m0s
[11:50:35.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:180:0)
[11:50:35.250] Timer tick, asking Buildbucket for the build status
[11:50:37.993] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:37.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:181:0) after 1m0s
[11:51:38.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:181:0)
[11:51:38.089] Timer tick, asking Buildbucket for the build status
[11:51:38.219] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:38.219] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:182:0) after 1m0s
[11:52:38.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:182:0)
[11:52:38.300] Timer tick, asking Buildbucket for the build status
[11:52:38.650] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:38.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:183:0) after 1m0s
[11:53:38.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:183:0)
[11:53:38.684] Timer tick, asking Buildbucket for the build status
[11:53:38.796] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:38.796] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:184:0) after 1m0s
[11:54:38.888] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:184:0)
[11:54:38.888] Timer tick, asking Buildbucket for the build status
[11:54:38.953] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:38.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:185:0) after 1m0s
[11:55:39.021] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:185:0)
[11:55:39.021] Timer tick, asking Buildbucket for the build status
[11:55:39.092] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:39.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:186:0) after 1m0s
[11:56:39.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:186:0)
[11:56:39.076] Timer tick, asking Buildbucket for the build status
[11:56:39.248] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:39.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:187:0) after 1m0s
[11:57:39.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:187:0)
[11:57:39.266] Timer tick, asking Buildbucket for the build status
[11:57:39.469] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:39.469] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:188:0) after 1m0s
[11:58:39.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:188:0)
[11:58:39.508] Timer tick, asking Buildbucket for the build status
[11:58:39.726] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:39.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:189:0) after 1m0s
[11:59:39.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:189:0)
[11:59:39.770] Timer tick, asking Buildbucket for the build status
[11:59:39.873] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:39.873] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:190:0) after 1m0s
[12:00:39.932] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:190:0)
[12:00:39.932] Timer tick, asking Buildbucket for the build status
[12:00:43.800] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:43.800] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:191:0) after 1m0s
[12:01:43.883] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:191:0)
[12:01:43.883] Timer tick, asking Buildbucket for the build status
[12:01:44.735] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:44.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:192:0) after 1m0s
[12:02:44.765] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:192:0)
[12:02:44.765] Timer tick, asking Buildbucket for the build status
[12:02:45.091] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:45.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:193:0) after 1m0s
[12:03:45.145] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:193:0)
[12:03:45.145] Timer tick, asking Buildbucket for the build status
[12:03:45.231] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:45.231] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:194:0) after 1m0s
[12:04:45.384] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:194:0)
[12:04:45.384] Timer tick, asking Buildbucket for the build status
[12:04:45.453] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:45.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:195:0) after 1m0s
[12:05:45.487] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:195:0)
[12:05:45.487] Timer tick, asking Buildbucket for the build status
[12:05:45.700] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:45.700] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:196:0) after 1m0s
[12:06:45.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:196:0)
[12:06:45.737] Timer tick, asking Buildbucket for the build status
[12:06:45.879] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:45.879] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:197:0) after 1m0s
[12:07:45.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:197:0)
[12:07:45.859] Timer tick, asking Buildbucket for the build status
[12:07:45.991] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:45.991] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:198:0) after 1m0s
[12:08:46.054] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:198:0)
[12:08:46.054] Timer tick, asking Buildbucket for the build status
[12:08:46.147] Build 8861947305030989168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:46.147] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027377367473862608:199:0) after 1m0s
[12:09:14.793] Received PubSub notification, asking Buildbucket for the build status
[12:09:15.510] Build 8861947305030989168: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:09:15.510] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1606997353241447",
    "created_by": "project:chromium",
    "created_ts": "1606985484054606",
    "id": "8861947305030989168",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\"}}",
    "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\": \"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\", \"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-9t2s\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1044, \"got_angle_revision\": \"8670d6183a8439622e5f4527e4971bafb1a9ffa7\", \"got_dawn_revision\": \"3668d352bc5fe13af27dc178d203f67032537a7f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\", \"got_revision_cp\": \"refs/heads/master@{#833209}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"2c0399211ca667c8af5cd5e98bee65b180e356a2\", \"got_v8_revision_cp\": \"refs/heads/8.9.89@{#1}\", \"got_webrtc_revision\": \"6e7167456b5eba36c7985d6a74f1d191958d4e0f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32749}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3\"}, \"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-9t2s\"], \"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\": [\"5640-d0eb544\"], \"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": "1606985521328297",
    "status": "COMPLETED",
    "status_changed_ts": "1606997354515763",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1044",
      "builder:win32-official",
      "buildset:commit/git/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7711f40f0b107c5bb7c3ac1ac9ce0f5999ec45f3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9027377367473862608",
      "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/8861947305030989168/+/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:50409e12d9df5a10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1606997354519661",
    "url": "https://ci.chromium.org/b/8861947305030989168",
    "utcnow_ts": "1606997355459690"
  }
}
[12:09:15.510] Invocation finished in 3h17m53.168937133s with status SUCCEEDED