LUCI Scheduler :: chromium :: win32-official

Status: FAILED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

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

Incoming triggers

95203551c46881820289a2f25614a0d80145d200 (5 years ago)
c9104b5034be658973f3e3acc00cf189300e928e (5 years ago)
a6e21542f6204b31d23788dd2725441118a2deaa (5 years ago)
eedcb39c8de1ebaf4a15006dea8c95678525b3e6 (5 years ago)
97edd27e652381b238e906bcf025f9489d916964 (5 years ago)
d0a6277868f5fdb463bce2426aa38cc5739e08a5 (5 years ago)
1d58ac95d3cce86bb37fc79a60137a2112234a9c (5 years ago)
f402401ef9eb7258fffd26276eba96511ece2212 (5 years ago)
691aa166f13da9d6611c590bd0d9e03cc4861699 (5 years ago)
982c9d484e4ec1e24fa0b90a387ed66bae012505 (5 years ago)
e5e3d8d9c3e05af17bcbadd63f705a49e21e0ebd (5 years ago)
76cefb0c955a9af702818f4e33c3dbe6a23f8dbb (5 years ago)
1109a843cde42597ce841127c4472a1d881c4243 (5 years ago)
3abacde817303d69b91e5ca1af4f30dee2a1de38 (5 years ago)
b60ad67bda94686df7a4cd4d794e2858c0f43893 (5 years ago)
64aec9ffa89d9113395750cef325ffe4a8cbf5e1 (5 years ago)
f50cc9e69722102f8285fdec7f337af5c6c2e166 (5 years ago)
1d01bff05917c32e482ac2cb2988fc946c9c86a6 (5 years ago)
81090f98b8f3a213bf9c76f0ecec14f946452355 (5 years ago)
9856fdb71c986337c5940833664c8f176bd2a570 (5 years ago)
c3d5b68a4924d75fd40f5fc120780e4a34aa9665 (5 years ago)
78b2a5cef0d2e66e5d9e7b274a5b8d722befef95 (5 years ago)
beeda668a2d163cc87207e87e68c66007fe40e48 (5 years ago)
5129a5e714d67b384e0cf9a48506f8d86851e40d (5 years ago)
a86de9883a8ddde9130b1f9c44759e4f7723f199 (5 years ago)
81b7ac070bb24e2496ae1e0f7148d6607c52e83d (5 years ago)
3f200c0d7476ae6fd0112942bafc0280aa8e74fa (5 years ago)
6f8fafd4df63285826ef95f559828e41e7bc5f72 (5 years ago)
efdcb8407e0d9139e142aaf236cffb97b5e6d7f1 (5 years ago)
f669e3ee990bf1bba9d532ca31c4c248ae35c6c3 (5 years ago)
604cbb55e17d77e60269fa253bb936fbe2b0d00c (5 years ago)
e8010ea23b312323e14f298bc047ae260fb9d2bf (5 years ago)
da8336e74319d39fec2512f4683fc709ed7bb4b5 (5 years ago)
3047d95ffdd3087d368cf09d3b7799a2c9b29380 (5 years ago)
ea3f8b3261e354fc1037a5c099655b9db1e3c634 (5 years ago)
06db95be1850ac5cd946e83896a6947c47653afe (5 years ago)
29723fad53bd996eb97833cabd40fbaba7c62908 (5 years ago)
06c796f4f9f982e011b2c2ef527bc5f7aea3bf84 (5 years ago)
53e3e54502bf26552ab944aae1f6d5df659e4827 (5 years ago)
a31994e3da77c609e509528b246aac903f1387ae (5 years ago)
0e44669de17b2a69dcb94b994a1370c46d4ffce2 (5 years ago)
bbca2a0a59bb754f0fdb5ecdcb46209679445dd6 (5 years ago)
26908f4ef3ab5087b4f68373cd44dd89dd0fd305 (5 years ago)
986a78e44ae1ee2031524e0eb186bc06ce263ae3 (5 years ago)
c97ac465de1ca19b3d507793899bcec5fdb27c4f (5 years ago)
ab8811449c4326fb3874c75ce6a5b364b7d57285 (5 years ago)
a38606cd39ab6fc77977fb7879e5cb64c0a27068 (5 years ago)
9e99fa97fe36c5caef4395948b2c2fc6c96c9e30 (5 years ago)
21200700cc6689a1ac4948b43afe058447d20e0e (5 years ago)
8ee211096b8f9262b3b47634cbf540a19bde3816 (5 years ago)
c26e11e0944aa67f6c4633731fb5c03a6a50ca5f (5 years ago)
fd7e5facca0b59d7b49445a93544821f83f9e0e8 (5 years ago)
5df0990466f0fface74be04dbe0ec1c9956f09c0 (5 years ago)
4ba232fd85c53636023cfdbe6d37d32220c984e3 (5 years ago)
605798c406d090e5ae83681665b5eccc2e9a64e9 (5 years ago)
f153133e8b5319b25d2b574ae0387b3230698121 (5 years ago)
d08ceac7afccb16fc18e8e29d05f6cb9e1c5043d (5 years ago)
9009a36b9b759c03a4181bb45586846ddfc324c8 (5 years ago)
5e5cd4846745862daa99f806a88e0642679ab77b (5 years ago)
bbd3f0121d2182f4a72c93dae8c594d9ef86343e (5 years ago)
a68b8d70c0170fadb3f420b36cbcabb145d0594d (5 years ago)
91fce5c85999993162c93337a762bfb554d00681 (5 years ago)
eb6b897c38fcfda4499adbbbc6dd1acb3a40abe6 (5 years ago)
ba75d2d3f2291b5bc3407ac6cbb006b6f7ac26e2 (5 years ago)
0b29aa4558601ce49b536b98b6608bde0798a63b (5 years ago)
c4bd7d69518357e48468721f34fb05a829f42af3 (5 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[04:29:18.234] New invocation is queued and will start shortly
[04:29:19.334] Starting the invocation (attempt 1)
[04:29:19.369] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:29:19.369] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:29:19.369] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9022229828326564624",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4bd7d69518357e48468721f34fb05a829f42af3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9022229828326564624",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/c4bd7d69518357e48468721f34fb05a829f42af3",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4bd7d69518357e48468721f34fb05a829f42af3",
    "gitiles_ref:refs/heads/master"
  ]
}
[04:29:20.118] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1611894559505862",
    "id": "8856799766330261376",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4bd7d69518357e48468721f34fb05a829f42af3\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1611894559870285",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1437",
      "builder:win32-official",
      "buildset:commit/git/c4bd7d69518357e48468721f34fb05a829f42af3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4bd7d69518357e48468721f34fb05a829f42af3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022229828326564624",
      "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/8856799766330261376/+/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": "1611894559870418",
    "url": "https://ci.chromium.org/b/8856799766330261376",
    "utcnow_ts": "1611894560098234"
  }
}
[04:29:20.118] Task URL: https://ci.chromium.org/b/8856799766330261376
[04:29:20.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:2:0) after 1m0s
[04:29:49.970] Received PubSub notification, asking Buildbucket for the build status
[04:29:50.041] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:20.175] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:2:0)
[04:30:20.175] Timer tick, asking Buildbucket for the build status
[04:30:20.263] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:20.263] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:4:0) after 1m0s
[04:31:20.320] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:4:0)
[04:31:20.320] Timer tick, asking Buildbucket for the build status
[04:31:20.530] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:20.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:5:0) after 1m0s
[04:32:20.602] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:5:0)
[04:32:20.602] Timer tick, asking Buildbucket for the build status
[04:32:20.686] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:6:0) after 1m0s
[04:33:20.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:6:0)
[04:33:20.767] Timer tick, asking Buildbucket for the build status
[04:33:20.856] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:20.856] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:7:0) after 1m0s
[04:34:20.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:7:0)
[04:34:20.871] Timer tick, asking Buildbucket for the build status
[04:34:21.099] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:21.099] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:8:0) after 1m0s
[04:35:21.166] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:8:0)
[04:35:21.166] Timer tick, asking Buildbucket for the build status
[04:35:21.280] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:21.280] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:9:0) after 1m0s
[04:36:21.333] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:9:0)
[04:36:21.333] Timer tick, asking Buildbucket for the build status
[04:36:21.427] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:21.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:10:0) after 1m0s
[04:37:21.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:10:0)
[04:37:21.492] Timer tick, asking Buildbucket for the build status
[04:37:21.721] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:21.721] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:11:0) after 1m0s
[04:38:21.790] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:11:0)
[04:38:21.790] Timer tick, asking Buildbucket for the build status
[04:38:21.862] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:21.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:12:0) after 1m0s
[04:39:21.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:12:0)
[04:39:21.918] Timer tick, asking Buildbucket for the build status
[04:39:22.243] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:22.243] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:13:0) after 1m0s
[04:40:22.386] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:13:0)
[04:40:22.386] Timer tick, asking Buildbucket for the build status
[04:40:22.491] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:22.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:14:0) after 1m0s
[04:41:22.650] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:14:0)
[04:41:22.650] Timer tick, asking Buildbucket for the build status
[04:41:22.795] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:22.795] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:15:0) after 1m0s
[04:42:22.807] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:15:0)
[04:42:22.807] Timer tick, asking Buildbucket for the build status
[04:42:22.883] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:22.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:16:0) after 1m0s
[04:43:22.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:16:0)
[04:43:22.935] Timer tick, asking Buildbucket for the build status
[04:43:23.008] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:23.008] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:17:0) after 1m0s
[04:44:23.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:17:0)
[04:44:23.090] Timer tick, asking Buildbucket for the build status
[04:44:23.262] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:23.263] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:18:0) after 1m0s
[04:45:23.443] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:18:0)
[04:45:23.443] Timer tick, asking Buildbucket for the build status
[04:45:23.515] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:23.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:19:0) after 1m0s
[04:46:23.660] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:19:0)
[04:46:23.660] Timer tick, asking Buildbucket for the build status
[04:46:23.709] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:23.709] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:20:0) after 1m0s
[04:47:23.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:20:0)
[04:47:23.828] Timer tick, asking Buildbucket for the build status
[04:47:24.034] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:24.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:21:0) after 1m0s
[04:48:24.055] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:21:0)
[04:48:24.055] Timer tick, asking Buildbucket for the build status
[04:48:24.229] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:24.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:22:0) after 1m0s
[04:49:24.206] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:22:0)
[04:49:24.206] Timer tick, asking Buildbucket for the build status
[04:49:24.320] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:24.320] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:23:0) after 1m0s
[04:50:24.328] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:23:0)
[04:50:24.328] Timer tick, asking Buildbucket for the build status
[04:50:24.421] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:24.421] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:24:0) after 1m0s
[04:51:24.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:24:0)
[04:51:24.475] Timer tick, asking Buildbucket for the build status
[04:51:24.595] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:24.595] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:25:0) after 1m0s
[04:52:24.650] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:25:0)
[04:52:24.650] Timer tick, asking Buildbucket for the build status
[04:52:24.946] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:24.946] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:26:0) after 1m0s
[04:53:24.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:26:0)
[04:53:24.934] Timer tick, asking Buildbucket for the build status
[04:53:24.993] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:24.993] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:27:0) after 1m0s
[04:54:25.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:27:0)
[04:54:25.029] Timer tick, asking Buildbucket for the build status
[04:54:25.280] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:25.280] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:28:0) after 1m0s
[04:55:25.328] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:28:0)
[04:55:25.328] Timer tick, asking Buildbucket for the build status
[04:55:25.528] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:25.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:29:0) after 1m0s
[04:56:25.605] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:29:0)
[04:56:25.605] Timer tick, asking Buildbucket for the build status
[04:56:25.748] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:25.748] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:30:0) after 1m0s
[04:57:25.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:30:0)
[04:57:25.801] Timer tick, asking Buildbucket for the build status
[04:57:25.862] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:25.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:31:0) after 1m0s
[04:58:25.899] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:31:0)
[04:58:25.899] Timer tick, asking Buildbucket for the build status
[04:58:26.015] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:26.015] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:32:0) after 1m0s
[04:59:26.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:32:0)
[04:59:26.046] Timer tick, asking Buildbucket for the build status
[04:59:26.218] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:26.218] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:33:0) after 1m0s
[05:00:26.263] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:33:0)
[05:00:26.263] Timer tick, asking Buildbucket for the build status
[05:00:27.228] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:27.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:34:0) after 1m0s
[05:01:27.270] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:34:0)
[05:01:27.270] Timer tick, asking Buildbucket for the build status
[05:01:27.505] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:27.505] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:35:0) after 1m0s
[05:02:27.565] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:35:0)
[05:02:27.565] Timer tick, asking Buildbucket for the build status
[05:02:27.656] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:27.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:36:0) after 1m0s
[05:03:27.671] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:36:0)
[05:03:27.671] Timer tick, asking Buildbucket for the build status
[05:03:28.098] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:28.098] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:37:0) after 1m0s
[05:04:28.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:37:0)
[05:04:28.120] Timer tick, asking Buildbucket for the build status
[05:04:28.278] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:28.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:38:0) after 1m0s
[05:05:28.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:38:0)
[05:05:28.346] Timer tick, asking Buildbucket for the build status
[05:05:29.247] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:29.247] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:39:0) after 1m0s
[05:06:29.324] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:39:0)
[05:06:29.324] Timer tick, asking Buildbucket for the build status
[05:06:29.463] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:29.463] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:40:0) after 1m0s
[05:07:29.491] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:40:0)
[05:07:29.491] Timer tick, asking Buildbucket for the build status
[05:07:30.003] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:30.003] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:41:0) after 1m0s
[05:08:30.099] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:41:0)
[05:08:30.099] Timer tick, asking Buildbucket for the build status
[05:08:30.179] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:30.179] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:42:0) after 1m0s
[05:09:30.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:42:0)
[05:09:30.239] Timer tick, asking Buildbucket for the build status
[05:09:30.331] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:30.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:43:0) after 1m0s
[05:10:30.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:43:0)
[05:10:30.373] Timer tick, asking Buildbucket for the build status
[05:10:30.635] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:44:0) after 1m0s
[05:11:30.742] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:44:0)
[05:11:30.742] Timer tick, asking Buildbucket for the build status
[05:11:30.806] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:30.806] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:45:0) after 1m0s
[05:12:30.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:45:0)
[05:12:30.881] Timer tick, asking Buildbucket for the build status
[05:12:30.934] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:30.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:46:0) after 1m0s
[05:13:31.005] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:46:0)
[05:13:31.005] Timer tick, asking Buildbucket for the build status
[05:13:31.055] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:31.055] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:47:0) after 1m0s
[05:14:31.141] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:47:0)
[05:14:31.141] Timer tick, asking Buildbucket for the build status
[05:14:31.271] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:31.271] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:48:0) after 1m0s
[05:15:31.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:48:0)
[05:15:31.300] Timer tick, asking Buildbucket for the build status
[05:15:31.366] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:31.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:49:0) after 1m0s
[05:16:31.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:49:0)
[05:16:31.427] Timer tick, asking Buildbucket for the build status
[05:16:31.495] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:31.495] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:50:0) after 1m0s
[05:17:31.563] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:50:0)
[05:17:31.563] Timer tick, asking Buildbucket for the build status
[05:17:31.705] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:31.705] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:51:0) after 1m0s
[05:18:31.727] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:51:0)
[05:18:31.728] Timer tick, asking Buildbucket for the build status
[05:18:31.805] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:31.805] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:52:0) after 1m0s
[05:19:31.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:52:0)
[05:19:31.875] Timer tick, asking Buildbucket for the build status
[05:19:31.975] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:31.975] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:53:0) after 1m0s
[05:20:31.988] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:53:0)
[05:20:31.988] Timer tick, asking Buildbucket for the build status
[05:20:32.434] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:32.434] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:54:0) after 1m0s
[05:21:32.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:54:0)
[05:21:32.677] Timer tick, asking Buildbucket for the build status
[05:21:32.765] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:32.765] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:55:0) after 1m0s
[05:22:32.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:55:0)
[05:22:32.809] Timer tick, asking Buildbucket for the build status
[05:22:33.152] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:33.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:56:0) after 1m0s
[05:23:33.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:56:0)
[05:23:33.216] Timer tick, asking Buildbucket for the build status
[05:23:33.643] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:33.643] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:57:0) after 1m0s
[05:24:33.788] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:57:0)
[05:24:33.788] Timer tick, asking Buildbucket for the build status
[05:24:33.889] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:33.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:58:0) after 1m0s
[05:25:33.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:58:0)
[05:25:33.948] Timer tick, asking Buildbucket for the build status
[05:25:34.145] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:34.145] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:59:0) after 1m0s
[05:26:34.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:59:0)
[05:26:34.167] Timer tick, asking Buildbucket for the build status
[05:26:34.222] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:34.222] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:60:0) after 1m0s
[05:27:34.248] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:60:0)
[05:27:34.248] Timer tick, asking Buildbucket for the build status
[05:27:34.322] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:34.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:61:0) after 1m0s
[05:28:34.376] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:61:0)
[05:28:34.376] Timer tick, asking Buildbucket for the build status
[05:28:34.625] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:34.625] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:62:0) after 1m0s
[05:29:34.652] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:62:0)
[05:29:34.652] Timer tick, asking Buildbucket for the build status
[05:29:36.453] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:36.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:63:0) after 1m0s
[05:30:36.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:63:0)
[05:30:36.478] Timer tick, asking Buildbucket for the build status
[05:30:36.707] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:36.707] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:64:0) after 1m0s
[05:31:36.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:64:0)
[05:31:36.750] Timer tick, asking Buildbucket for the build status
[05:31:36.818] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:36.818] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:65:0) after 1m0s
[05:32:36.902] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:65:0)
[05:32:36.902] Timer tick, asking Buildbucket for the build status
[05:32:37.097] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:37.097] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:66:0) after 1m0s
[05:33:37.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:66:0)
[05:33:37.156] Timer tick, asking Buildbucket for the build status
[05:33:37.221] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:37.221] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:67:0) after 1m0s
[05:34:37.333] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:67:0)
[05:34:37.333] Timer tick, asking Buildbucket for the build status
[05:34:37.500] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:37.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:68:0) after 1m0s
[05:35:37.497] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:68:0)
[05:35:37.497] Timer tick, asking Buildbucket for the build status
[05:35:37.562] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:37.562] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:69:0) after 1m0s
[05:36:37.865] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:69:0)
[05:36:37.865] Timer tick, asking Buildbucket for the build status
[05:36:38.033] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:38.033] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:70:0) after 1m0s
[05:37:38.055] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:70:0)
[05:37:38.055] Timer tick, asking Buildbucket for the build status
[05:37:38.131] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:38.131] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:71:0) after 1m0s
[05:38:38.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:71:0)
[05:38:38.156] Timer tick, asking Buildbucket for the build status
[05:38:38.231] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:38.231] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:72:0) after 1m0s
[05:39:38.274] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:72:0)
[05:39:38.274] Timer tick, asking Buildbucket for the build status
[05:39:38.431] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:38.431] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:73:0) after 1m0s
[05:40:38.440] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:73:0)
[05:40:38.440] Timer tick, asking Buildbucket for the build status
[05:40:38.525] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:38.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:74:0) after 1m0s
[05:41:38.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:74:0)
[05:41:38.603] Timer tick, asking Buildbucket for the build status
[05:41:38.724] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:38.724] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:75:0) after 1m0s
[05:42:38.745] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:75:0)
[05:42:38.745] Timer tick, asking Buildbucket for the build status
[05:42:38.833] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:38.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:76:0) after 1m0s
[05:43:38.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:76:0)
[05:43:38.955] Timer tick, asking Buildbucket for the build status
[05:43:39.021] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:39.021] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:77:0) after 1m0s
[05:44:39.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:77:0)
[05:44:39.111] Timer tick, asking Buildbucket for the build status
[05:44:39.366] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:39.366] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:78:0) after 1m0s
[05:45:39.483] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:78:0)
[05:45:39.483] Timer tick, asking Buildbucket for the build status
[05:45:39.711] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:39.711] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:79:0) after 1m0s
[05:46:39.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:79:0)
[05:46:39.767] Timer tick, asking Buildbucket for the build status
[05:46:39.835] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:39.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:80:0) after 1m0s
[05:47:39.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:80:0)
[05:47:39.859] Timer tick, asking Buildbucket for the build status
[05:47:39.930] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:39.930] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:81:0) after 1m0s
[05:48:39.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:81:0)
[05:48:39.948] Timer tick, asking Buildbucket for the build status
[05:48:40.129] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:40.129] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:82:0) after 1m0s
[05:49:40.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:82:0)
[05:49:40.150] Timer tick, asking Buildbucket for the build status
[05:49:40.263] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:83:0) after 1m0s
[05:50:40.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:83:0)
[05:50:40.289] Timer tick, asking Buildbucket for the build status
[05:50:40.367] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:40.367] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:84:0) after 1m0s
[05:51:40.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:84:0)
[05:51:40.423] Timer tick, asking Buildbucket for the build status
[05:51:40.494] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:40.494] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:85:0) after 1m0s
[05:52:40.527] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:85:0)
[05:52:40.527] Timer tick, asking Buildbucket for the build status
[05:52:41.024] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:41.024] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:86:0) after 1m0s
[05:53:41.118] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:86:0)
[05:53:41.118] Timer tick, asking Buildbucket for the build status
[05:53:41.453] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:41.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:87:0) after 1m0s
[05:54:41.571] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:87:0)
[05:54:41.571] Timer tick, asking Buildbucket for the build status
[05:54:41.945] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:41.945] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:88:0) after 1m0s
[05:55:42.082] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:88:0)
[05:55:42.082] Timer tick, asking Buildbucket for the build status
[05:55:42.233] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:42.233] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:89:0) after 1m0s
[05:56:42.303] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:89:0)
[05:56:42.303] Timer tick, asking Buildbucket for the build status
[05:56:42.397] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:42.397] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:90:0) after 1m0s
[05:57:42.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:90:0)
[05:57:42.419] Timer tick, asking Buildbucket for the build status
[05:57:42.478] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:42.478] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:91:0) after 1m0s
[05:58:42.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:91:0)
[05:58:42.516] Timer tick, asking Buildbucket for the build status
[05:58:42.640] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:42.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:92:0) after 1m0s
[05:59:42.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:92:0)
[05:59:42.689] Timer tick, asking Buildbucket for the build status
[05:59:42.921] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:42.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:93:0) after 1m0s
[06:00:42.927] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:93:0)
[06:00:42.927] Timer tick, asking Buildbucket for the build status
[06:00:43.088] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:43.088] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:94:0) after 1m0s
[06:01:44.238] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:94:0)
[06:01:44.238] Timer tick, asking Buildbucket for the build status
[06:01:44.352] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:44.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:95:0) after 1m0s
[06:02:44.537] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:95:0)
[06:02:44.537] Timer tick, asking Buildbucket for the build status
[06:02:44.839] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:44.839] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:96:0) after 1m0s
[06:03:44.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:96:0)
[06:03:44.970] Timer tick, asking Buildbucket for the build status
[06:03:45.103] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:45.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:97:0) after 1m0s
[06:04:45.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:97:0)
[06:04:45.202] Timer tick, asking Buildbucket for the build status
[06:04:45.321] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:45.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:98:0) after 1m0s
[06:05:45.467] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:98:0)
[06:05:45.467] Timer tick, asking Buildbucket for the build status
[06:05:45.558] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:45.558] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:99:0) after 1m0s
[06:06:45.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:99:0)
[06:06:45.728] Timer tick, asking Buildbucket for the build status
[06:06:46.003] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:46.003] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:100:0) after 1m0s
[06:07:46.098] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:100:0)
[06:07:46.098] Timer tick, asking Buildbucket for the build status
[06:07:46.173] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:46.173] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:101:0) after 1m0s
[06:08:46.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:101:0)
[06:08:46.502] Timer tick, asking Buildbucket for the build status
[06:08:46.560] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:46.560] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:102:0) after 1m0s
[06:09:46.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:102:0)
[06:09:46.697] Timer tick, asking Buildbucket for the build status
[06:09:46.810] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:46.810] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:103:0) after 1m0s
[06:10:46.974] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:103:0)
[06:10:46.974] Timer tick, asking Buildbucket for the build status
[06:10:47.076] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:47.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:104:0) after 1m0s
[06:11:47.376] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:104:0)
[06:11:47.376] Timer tick, asking Buildbucket for the build status
[06:11:47.457] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:105:0) after 1m0s
[06:12:47.678] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:105:0)
[06:12:47.678] Timer tick, asking Buildbucket for the build status
[06:12:47.729] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:47.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:106:0) after 1m0s
[06:13:47.760] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:106:0)
[06:13:47.760] Timer tick, asking Buildbucket for the build status
[06:13:47.855] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:107:0) after 1m0s
[06:14:47.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:107:0)
[06:14:47.923] Timer tick, asking Buildbucket for the build status
[06:14:48.306] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:48.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:108:0) after 1m0s
[06:15:48.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:108:0)
[06:15:48.355] Timer tick, asking Buildbucket for the build status
[06:15:48.650] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:48.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:109:0) after 1m0s
[06:16:48.679] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:109:0)
[06:16:48.679] Timer tick, asking Buildbucket for the build status
[06:16:48.934] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:48.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:110:0) after 1m0s
[06:17:49.007] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:110:0)
[06:17:49.007] Timer tick, asking Buildbucket for the build status
[06:17:49.182] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:49.182] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:111:0) after 1m0s
[06:18:49.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:111:0)
[06:18:49.250] Timer tick, asking Buildbucket for the build status
[06:18:49.339] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:112:0) after 1m0s
[06:19:49.382] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:112:0)
[06:19:49.382] Timer tick, asking Buildbucket for the build status
[06:19:49.502] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.502] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:113:0) after 1m0s
[06:20:49.501] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:113:0)
[06:20:49.501] Timer tick, asking Buildbucket for the build status
[06:20:49.992] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:49.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:114:0) after 1m0s
[06:21:50.149] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:114:0)
[06:21:50.149] Timer tick, asking Buildbucket for the build status
[06:21:50.207] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:50.207] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:115:0) after 1m0s
[06:22:50.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:115:0)
[06:22:50.285] Timer tick, asking Buildbucket for the build status
[06:22:50.342] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:50.342] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:116:0) after 1m0s
[06:23:50.411] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:116:0)
[06:23:50.411] Timer tick, asking Buildbucket for the build status
[06:23:50.479] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:50.479] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:117:0) after 1m0s
[06:24:50.796] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:117:0)
[06:24:50.796] Timer tick, asking Buildbucket for the build status
[06:24:51.081] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:51.081] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:118:0) after 1m0s
[06:25:51.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:118:0)
[06:25:51.196] Timer tick, asking Buildbucket for the build status
[06:25:51.273] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:51.273] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:119:0) after 1m0s
[06:26:51.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:119:0)
[06:26:51.364] Timer tick, asking Buildbucket for the build status
[06:26:51.476] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:51.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:120:0) after 1m0s
[06:27:51.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:120:0)
[06:27:51.601] Timer tick, asking Buildbucket for the build status
[06:27:51.661] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:51.662] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:121:0) after 1m0s
[06:28:51.787] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:121:0)
[06:28:51.788] Timer tick, asking Buildbucket for the build status
[06:28:52.060] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:52.060] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:122:0) after 1m0s
[06:29:52.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:122:0)
[06:29:52.150] Timer tick, asking Buildbucket for the build status
[06:29:52.286] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:52.286] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:123:0) after 1m0s
[06:30:52.459] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:123:0)
[06:30:52.459] Timer tick, asking Buildbucket for the build status
[06:30:52.518] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:52.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:124:0) after 1m0s
[06:31:52.681] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:124:0)
[06:31:52.681] Timer tick, asking Buildbucket for the build status
[06:31:52.785] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:52.785] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:125:0) after 1m0s
[06:32:52.858] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:125:0)
[06:32:52.858] Timer tick, asking Buildbucket for the build status
[06:32:52.920] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:52.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:126:0) after 1m0s
[06:33:52.985] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:126:0)
[06:33:52.985] Timer tick, asking Buildbucket for the build status
[06:33:53.034] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:53.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:127:0) after 1m0s
[06:34:53.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:127:0)
[06:34:53.089] Timer tick, asking Buildbucket for the build status
[06:34:53.185] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:53.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:128:0) after 1m0s
[06:35:53.208] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:128:0)
[06:35:53.208] Timer tick, asking Buildbucket for the build status
[06:35:53.370] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:129:0) after 1m0s
[06:36:53.360] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:129:0)
[06:36:53.360] Timer tick, asking Buildbucket for the build status
[06:36:53.434] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:53.434] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:130:0) after 1m0s
[06:37:53.477] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:130:0)
[06:37:53.477] Timer tick, asking Buildbucket for the build status
[06:37:54.480] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:54.480] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:131:0) after 1m0s
[06:38:54.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:131:0)
[06:38:54.516] Timer tick, asking Buildbucket for the build status
[06:38:54.650] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:54.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:132:0) after 1m0s
[06:39:54.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:132:0)
[06:39:54.710] Timer tick, asking Buildbucket for the build status
[06:39:54.888] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:54.888] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:133:0) after 1m0s
[06:40:54.981] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:133:0)
[06:40:54.981] Timer tick, asking Buildbucket for the build status
[06:40:55.042] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:55.042] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:134:0) after 1m0s
[06:41:55.103] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:134:0)
[06:41:55.103] Timer tick, asking Buildbucket for the build status
[06:41:55.395] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:55.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:135:0) after 1m0s
[06:42:55.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:135:0)
[06:42:55.426] Timer tick, asking Buildbucket for the build status
[06:42:55.527] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:136:0) after 1m0s
[06:43:55.582] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:136:0)
[06:43:55.582] Timer tick, asking Buildbucket for the build status
[06:43:55.695] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:55.695] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:137:0) after 1m0s
[06:44:55.819] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:137:0)
[06:44:55.819] Timer tick, asking Buildbucket for the build status
[06:44:55.937] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:55.937] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:138:0) after 1m0s
[06:45:55.983] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:138:0)
[06:45:55.983] Timer tick, asking Buildbucket for the build status
[06:45:56.058] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:56.058] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:139:0) after 1m0s
[06:46:56.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:139:0)
[06:46:56.194] Timer tick, asking Buildbucket for the build status
[06:46:56.302] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:56.302] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:140:0) after 1m0s
[06:47:56.315] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:140:0)
[06:47:56.315] Timer tick, asking Buildbucket for the build status
[06:47:56.381] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:56.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:141:0) after 1m0s
[06:48:56.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:141:0)
[06:48:56.391] Timer tick, asking Buildbucket for the build status
[06:48:56.641] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:56.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:142:0) after 1m0s
[06:49:56.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:142:0)
[06:49:56.695] Timer tick, asking Buildbucket for the build status
[06:49:56.851] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:56.851] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:143:0) after 1m0s
[06:50:56.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:143:0)
[06:50:56.954] Timer tick, asking Buildbucket for the build status
[06:50:57.013] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:57.013] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:144:0) after 1m0s
[06:51:57.072] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:144:0)
[06:51:57.073] Timer tick, asking Buildbucket for the build status
[06:51:57.134] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:57.134] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:145:0) after 1m0s
[06:52:57.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:145:0)
[06:52:57.181] Timer tick, asking Buildbucket for the build status
[06:52:57.326] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:57.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:146:0) after 1m0s
[06:53:57.380] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:146:0)
[06:53:57.380] Timer tick, asking Buildbucket for the build status
[06:53:57.447] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:57.447] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:147:0) after 1m0s
[06:54:57.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:147:0)
[06:54:57.535] Timer tick, asking Buildbucket for the build status
[06:54:57.739] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:57.739] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:148:0) after 1m0s
[06:55:57.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:148:0)
[06:55:57.861] Timer tick, asking Buildbucket for the build status
[06:55:58.033] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:58.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:149:0) after 1m0s
[06:56:58.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:149:0)
[06:56:58.053] Timer tick, asking Buildbucket for the build status
[06:56:58.341] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:58.341] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:150:0) after 1m0s
[06:57:58.451] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:150:0)
[06:57:58.451] Timer tick, asking Buildbucket for the build status
[06:57:58.521] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:58.521] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:151:0) after 1m0s
[06:58:58.561] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:151:0)
[06:58:58.561] Timer tick, asking Buildbucket for the build status
[06:58:58.626] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:58.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:152:0) after 1m0s
[06:59:58.870] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:152:0)
[06:59:58.870] Timer tick, asking Buildbucket for the build status
[06:59:58.985] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:58.985] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:153:0) after 1m0s
[07:00:59.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:153:0)
[07:00:59.251] Timer tick, asking Buildbucket for the build status
[07:00:59.311] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:154:0) after 1m0s
[07:01:59.493] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:154:0)
[07:01:59.493] Timer tick, asking Buildbucket for the build status
[07:01:59.567] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:59.567] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:155:0) after 1m0s
[07:02:59.604] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:155:0)
[07:02:59.604] Timer tick, asking Buildbucket for the build status
[07:02:59.678] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:59.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:156:0) after 1m0s
[07:03:59.818] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:156:0)
[07:03:59.818] Timer tick, asking Buildbucket for the build status
[07:03:59.864] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:59.864] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:157:0) after 1m0s
[07:05:00.059] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:157:0)
[07:05:00.059] Timer tick, asking Buildbucket for the build status
[07:05:00.283] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:00.283] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:158:0) after 1m0s
[07:06:00.398] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:158:0)
[07:06:00.398] Timer tick, asking Buildbucket for the build status
[07:06:00.466] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:00.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:159:0) after 1m0s
[07:07:01.228] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:159:0)
[07:07:01.228] Timer tick, asking Buildbucket for the build status
[07:07:01.289] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:01.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:160:0) after 1m0s
[07:08:01.927] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:160:0)
[07:08:01.927] Timer tick, asking Buildbucket for the build status
[07:08:02.009] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:02.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:161:0) after 1m0s
[07:09:02.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:161:0)
[07:09:02.066] Timer tick, asking Buildbucket for the build status
[07:09:02.157] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:162:0) after 1m0s
[07:10:02.190] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:162:0)
[07:10:02.190] Timer tick, asking Buildbucket for the build status
[07:10:02.295] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:163:0) after 1m0s
[07:11:02.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:163:0)
[07:11:02.379] Timer tick, asking Buildbucket for the build status
[07:11:02.452] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:02.452] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:164:0) after 1m0s
[07:12:02.578] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:164:0)
[07:12:02.578] Timer tick, asking Buildbucket for the build status
[07:12:02.713] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:02.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:165:0) after 1m0s
[07:13:02.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:165:0)
[07:13:02.752] Timer tick, asking Buildbucket for the build status
[07:13:02.835] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:02.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:166:0) after 1m0s
[07:14:03.014] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:166:0)
[07:14:03.014] Timer tick, asking Buildbucket for the build status
[07:14:03.106] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:03.106] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:167:0) after 1m0s
[07:15:03.238] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:167:0)
[07:15:03.238] Timer tick, asking Buildbucket for the build status
[07:15:03.559] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:03.559] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:168:0) after 1m0s
[07:16:03.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:168:0)
[07:16:03.587] Timer tick, asking Buildbucket for the build status
[07:16:03.650] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:03.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:169:0) after 1m0s
[07:17:03.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:169:0)
[07:17:03.762] Timer tick, asking Buildbucket for the build status
[07:17:03.817] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:03.817] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:170:0) after 1m0s
[07:18:03.956] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:170:0)
[07:18:03.956] Timer tick, asking Buildbucket for the build status
[07:18:04.195] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:04.195] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:171:0) after 1m0s
[07:19:04.276] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:171:0)
[07:19:04.276] Timer tick, asking Buildbucket for the build status
[07:19:04.510] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:04.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:172:0) after 1m0s
[07:20:04.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:172:0)
[07:20:04.631] Timer tick, asking Buildbucket for the build status
[07:20:04.736] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:04.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:173:0) after 1m0s
[07:21:05.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:173:0)
[07:21:05.111] Timer tick, asking Buildbucket for the build status
[07:21:05.193] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:05.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:174:0) after 1m0s
[07:22:05.343] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:174:0)
[07:22:05.343] Timer tick, asking Buildbucket for the build status
[07:22:05.480] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:05.480] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:175:0) after 1m0s
[07:23:05.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:175:0)
[07:23:05.613] Timer tick, asking Buildbucket for the build status
[07:23:05.731] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:176:0) after 1m0s
[07:24:05.821] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:176:0)
[07:24:05.821] Timer tick, asking Buildbucket for the build status
[07:24:05.940] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:05.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:177:0) after 1m0s
[07:25:05.940] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:177:0)
[07:25:05.940] Timer tick, asking Buildbucket for the build status
[07:25:06.062] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:06.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:178:0) after 1m0s
[07:26:06.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:178:0)
[07:26:06.093] Timer tick, asking Buildbucket for the build status
[07:26:06.172] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:06.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:179:0) after 1m0s
[07:27:06.209] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:179:0)
[07:27:06.209] Timer tick, asking Buildbucket for the build status
[07:27:06.296] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:06.296] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:180:0) after 1m0s
[07:28:06.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:180:0)
[07:28:06.427] Timer tick, asking Buildbucket for the build status
[07:28:06.542] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:06.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:181:0) after 1m0s
[07:29:06.638] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:181:0)
[07:29:06.638] Timer tick, asking Buildbucket for the build status
[07:29:06.745] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:06.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:182:0) after 1m0s
[07:30:06.886] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:182:0)
[07:30:06.886] Timer tick, asking Buildbucket for the build status
[07:30:07.417] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:07.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:183:0) after 1m0s
[07:31:07.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:183:0)
[07:31:07.756] Timer tick, asking Buildbucket for the build status
[07:31:07.879] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:07.879] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:184:0) after 1m0s
[07:32:07.913] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:184:0)
[07:32:07.913] Timer tick, asking Buildbucket for the build status
[07:32:08.020] Build 8856799766330261376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:08.020] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9022229828326564624:185:0) after 1m0s
[07:32:35.555] Received PubSub notification, asking Buildbucket for the build status
[07:32:35.618] Build 8856799766330261376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:32:35.618] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1611905555138121",
    "created_by": "project:chromium",
    "created_ts": "1611894559505862",
    "failure_reason": "BUILD_FAILURE",
    "id": "8856799766330261376",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4bd7d69518357e48468721f34fb05a829f42af3\"}}",
    "project": "chromium",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"1 out of 5 aggregated steps failed: Step('postprocess_for_goma.upload_log') (retcode: 1)\"}, \"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\": \"c4bd7d69518357e48468721f34fb05a829f42af3\", \"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-z0bv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1437, \"got_angle_revision\": \"a685db2e9745b615987b1b514dc23cc2fafff7bd\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"c4bd7d69518357e48468721f34fb05a829f42af3\", \"got_revision_cp\": \"refs/heads/master@{#848407}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4bd7d69518357e48468721f34fb05a829f42af3\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_6189df0fcf2f4da824ec4ced1bd41f0cfe1729cc1e58ad3e88fe27fde5d63159_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-1-z0bv\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 out of 5 aggregated steps failed: Step('postprocess_for_goma.upload_log') (retcode: 1)\"}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1611894589071430",
    "status": "COMPLETED",
    "status_changed_ts": "1611894589717647",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1437",
      "builder:win32-official",
      "buildset:commit/git/c4bd7d69518357e48468721f34fb05a829f42af3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4bd7d69518357e48468721f34fb05a829f42af3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9022229828326564624",
      "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/8856799766330261376/+/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:5165389d8fd2f310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1611905555182823",
    "url": "https://ci.chromium.org/b/8856799766330261376",
    "utcnow_ts": "1611905555611724"
  }
}
[07:32:35.618] Invocation finished in 3h3m17.400641459s with status FAILED