LUCI Scheduler :: chromium :: win32-official

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

b51715ae4f01537ce649772f079f81381fecf0f1 (5 years ago)
51414bb27c417cf63960f8df0141ef1e1e195999 (5 years ago)
457c0c76978c5c383e0e79a6fca33eb343ec8f79 (5 years ago)
1515997b23f2668e346493f86f33a0b27b03b1ac (5 years ago)
182eef4342902714a9e76afd9f090b70ec6972f4 (5 years ago)
953e7e7dd5b947cb7baaf53959185ed965d994d4 (5 years ago)
247a8cb6672290eb23918ae40f6287c8310cb307 (5 years ago)
ece170fc77f0abc3ebad68996fe6323002c4bb62 (5 years ago)
1f23a58ad84d6f03871a71c79f99f596c49a7d16 (5 years ago)
8d6eb653fd4e4a67c888a52fbba8cd26eaa23187 (5 years ago)
811534f3a5de27fe73693e4e072e8d6d10499135 (5 years ago)
0c88f4f32dfcaa89755ebd5447682cfc23a19d33 (5 years ago)
9a8e0dd0330dd5f42a1e75a9fd8137f165878d10 (5 years ago)
83136454bcba31ed91a46d438c400db7b0579a46 (5 years ago)
42a16c7a4e9d9abb8a8d3909554052c437bdf8b7 (5 years ago)
5d89e271013b9493c98b85820292377d3d8ca6e6 (5 years ago)
ceac17ea03771c7320df3ceb4e7b7aa8869e92bb (5 years ago)
44172230eb503b8e7a62a7ef9d96e0408e2665a7 (5 years ago)
79a4138fca87bdd969e3bc5c2359e5d400ddbdbf (5 years ago)
0dd83ea79e8505d4f20a633d6750636ad9634300 (5 years ago)
b9a7e496b2caf9df3d0599dfbea585a455e7ab66 (5 years ago)
f178263e3ae92f0e81c659138b97d0593b2f8aad (5 years ago)
71d894f6ca1f3c32cd5bb14e01c0c994f2cb756b (5 years ago)
1895a56c5bb9753ce3e783e52574956b1f9190e9 (5 years ago)
290f44e6d970f3afeeb767cb1a0f79785eb9cc44 (5 years ago)
c0ba82a1490a77507af4978f7f2045d660926727 (5 years ago)
2a1345ae86e7fdf749be12cd216fc467942a0fbf (5 years ago)
9ceca1adad5e061ed286ad9a747114e12b87e685 (5 years ago)
f93e98311603b45a9e2642d4e928e41c0a8f242b (5 years ago)
e8d72602cddc21b1b7672b2638227d9aefcd6e1a (5 years ago)
9ceddb347cc246a72ed4869a27d693b534274d79 (5 years ago)
e1531764b72121c4b8c8d17d8b3f5f923b5c80ca (5 years ago)
960e954381bca5cef4762c300ce1f1d85065010e (5 years ago)
1b23aae29c5f60e973064b87c346da969deeddd4 (5 years ago)
298b5093f16fc3c81bf9d80e4027f357bf954426 (5 years ago)
d22f9bf8731d780c6a47d88664b5f6084fbf626c (5 years ago)
8729ad68c066d904c2a68abbcf54a7937708cb31 (5 years ago)
5ba08e9d323d0d53344197a605ff6c96df786b9f (5 years ago)
306e51dde972b7c3492fe3e75f699d3a8f2a295a (5 years ago)
d2da1542aeb3830f391ff12d5cada9a4d6d6fec1 (5 years ago)
6de88b2eeb632103b3bf7f6abf24f6ca2f388be8 (5 years ago)
c8fb7466bf6ba6f20eda3d11753e2a89eeae325a (5 years ago)
dd90480cb97ae36cd258d81d53219d7021504b3b (5 years ago)
d9b5c680b61cd4ee0b3f7638c56b2d3628c76f99 (5 years ago)
64b89833625c8c879323fc1195b5fa57d0572043 (5 years ago)
385197d4ca10000a12dda6804f9ccd6ca926c175 (5 years ago)
c48098df1dc3683dfd7760fb92c23ab94378d754 (5 years ago)
161156dd604ed2d1b48f6fff6c7e2ab24f5fe2b3 (5 years ago)
98387a87f7c13698bbc468c223c3032e27e12b33 (5 years ago)
223261187470dc635e7a330877995e845fafbd36 (5 years ago)
eb58a0e1c57bb71843ca2ccfeda2add3c018e140 (5 years ago)
5fccc25ee2793e967c0b6754c933433249c09496 (5 years ago)
c2503741db0d546a6df22842b540344ef78b8d94 (5 years ago)
302f608370704b6db59a0b6f7af88219bc1000d1 (5 years ago)
2eaf311e0da332ab52e903d63d79fe3b669059f4 (5 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[01:58:28.068] New invocation is queued and will start shortly
[01:58:29.205] Starting the invocation (attempt 1)
[01:58:29.246] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:58:29.248] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:58:29.248] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9025591405871093824",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2eaf311e0da332ab52e903d63d79fe3b669059f4\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9025591405871093824",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/2eaf311e0da332ab52e903d63d79fe3b669059f4",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2eaf311e0da332ab52e903d63d79fe3b669059f4",
    "gitiles_ref:refs/heads/master"
  ]
}
[01:58:29.923] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1608688709336071",
    "id": "8860161343877813072",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2eaf311e0da332ab52e903d63d79fe3b669059f4\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1608688709762631",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1172",
      "builder:win32-official",
      "buildset:commit/git/2eaf311e0da332ab52e903d63d79fe3b669059f4",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2eaf311e0da332ab52e903d63d79fe3b669059f4",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9025591405871093824",
      "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/8860161343877813072/+/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": "1608688709762790",
    "url": "https://ci.chromium.org/b/8860161343877813072",
    "utcnow_ts": "1608688709916731"
  }
}
[01:58:29.923] Task URL: https://ci.chromium.org/b/8860161343877813072
[01:58:29.923] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:2:0) after 1m0s
[01:58:50.966] Received PubSub notification, asking Buildbucket for the build status
[01:58:51.041] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:30.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:2:0)
[01:59:30.214] Timer tick, asking Buildbucket for the build status
[01:59:30.303] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:30.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:4:0) after 1m0s
[02:00:30.709] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:4:0)
[02:00:30.709] Timer tick, asking Buildbucket for the build status
[02:00:30.800] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:30.800] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:5:0) after 1m0s
[02:01:30.951] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:5:0)
[02:01:30.951] Timer tick, asking Buildbucket for the build status
[02:01:31.032] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:31.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:6:0) after 1m0s
[02:02:31.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:6:0)
[02:02:31.087] Timer tick, asking Buildbucket for the build status
[02:02:31.256] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:31.256] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:7:0) after 1m0s
[02:03:31.368] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:7:0)
[02:03:31.368] Timer tick, asking Buildbucket for the build status
[02:03:31.600] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.600] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:8:0) after 1m0s
[02:04:31.627] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:8:0)
[02:04:31.627] Timer tick, asking Buildbucket for the build status
[02:04:31.713] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:9:0) after 1m0s
[02:05:31.761] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:9:0)
[02:05:31.761] Timer tick, asking Buildbucket for the build status
[02:05:31.862] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:10:0) after 1m0s
[02:06:31.884] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:10:0)
[02:06:31.884] Timer tick, asking Buildbucket for the build status
[02:06:31.987] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:31.987] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:11:0) after 1m0s
[02:07:32.062] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:11:0)
[02:07:32.062] Timer tick, asking Buildbucket for the build status
[02:07:32.417] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:12:0) after 1m0s
[02:08:32.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:12:0)
[02:08:32.442] Timer tick, asking Buildbucket for the build status
[02:08:33.546] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:33.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:13:0) after 1m0s
[02:09:33.632] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:13:0)
[02:09:33.632] Timer tick, asking Buildbucket for the build status
[02:09:33.725] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:33.725] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:14:0) after 1m0s
[02:10:33.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:14:0)
[02:10:33.837] Timer tick, asking Buildbucket for the build status
[02:10:33.905] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.905] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:15:0) after 1m0s
[02:11:33.921] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:15:0)
[02:11:33.921] Timer tick, asking Buildbucket for the build status
[02:11:34.122] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:34.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:16:0) after 1m0s
[02:12:34.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:16:0)
[02:12:34.244] Timer tick, asking Buildbucket for the build status
[02:12:34.327] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:34.327] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:17:0) after 1m0s
[02:13:34.369] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:17:0)
[02:13:34.369] Timer tick, asking Buildbucket for the build status
[02:13:34.512] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:18:0) after 1m0s
[02:14:34.599] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:18:0)
[02:14:34.599] Timer tick, asking Buildbucket for the build status
[02:14:34.651] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.651] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:19:0) after 1m0s
[02:15:34.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:19:0)
[02:15:34.762] Timer tick, asking Buildbucket for the build status
[02:15:34.826] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:20:0) after 1m0s
[02:16:34.884] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:20:0)
[02:16:34.884] Timer tick, asking Buildbucket for the build status
[02:16:34.942] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:21:0) after 1m0s
[02:17:35.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:21:0)
[02:17:35.001] Timer tick, asking Buildbucket for the build status
[02:17:35.163] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:35.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:22:0) after 1m0s
[02:18:35.389] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:22:0)
[02:18:35.389] Timer tick, asking Buildbucket for the build status
[02:18:35.529] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:35.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:23:0) after 1m0s
[02:19:35.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:23:0)
[02:19:35.572] Timer tick, asking Buildbucket for the build status
[02:19:35.642] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.642] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:24:0) after 1m0s
[02:20:35.687] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:24:0)
[02:20:35.687] Timer tick, asking Buildbucket for the build status
[02:20:35.761] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.761] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:25:0) after 1m0s
[02:21:35.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:25:0)
[02:21:35.803] Timer tick, asking Buildbucket for the build status
[02:21:35.883] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:26:0) after 1m0s
[02:22:35.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:26:0)
[02:22:35.939] Timer tick, asking Buildbucket for the build status
[02:22:35.995] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.995] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:27:0) after 1m0s
[02:23:36.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:27:0)
[02:23:36.018] Timer tick, asking Buildbucket for the build status
[02:23:36.142] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:36.142] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:28:0) after 1m0s
[02:24:36.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:28:0)
[02:24:36.273] Timer tick, asking Buildbucket for the build status
[02:24:36.372] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.372] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:29:0) after 1m0s
[02:25:36.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:29:0)
[02:25:36.465] Timer tick, asking Buildbucket for the build status
[02:25:36.563] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.563] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:30:0) after 1m0s
[02:26:36.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:30:0)
[02:26:36.783] Timer tick, asking Buildbucket for the build status
[02:26:36.845] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:36.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:31:0) after 1m0s
[02:27:36.962] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:31:0)
[02:27:36.962] Timer tick, asking Buildbucket for the build status
[02:27:37.035] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:37.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:32:0) after 1m0s
[02:28:37.157] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:32:0)
[02:28:37.157] Timer tick, asking Buildbucket for the build status
[02:28:37.336] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:37.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:33:0) after 1m0s
[02:29:37.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:33:0)
[02:29:37.468] Timer tick, asking Buildbucket for the build status
[02:29:37.551] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:37.551] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:34:0) after 1m0s
[02:30:37.741] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:34:0)
[02:30:37.741] Timer tick, asking Buildbucket for the build status
[02:30:38.068] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.068] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:35:0) after 1m0s
[02:31:38.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:35:0)
[02:31:38.155] Timer tick, asking Buildbucket for the build status
[02:31:38.398] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.398] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:36:0) after 1m0s
[02:32:38.536] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:36:0)
[02:32:38.536] Timer tick, asking Buildbucket for the build status
[02:32:38.647] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:38.647] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:37:0) after 1m0s
[02:33:38.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:37:0)
[02:33:38.737] Timer tick, asking Buildbucket for the build status
[02:33:39.533] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:39.533] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:38:0) after 1m0s
[02:34:39.562] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:38:0)
[02:34:39.562] Timer tick, asking Buildbucket for the build status
[02:34:39.633] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:39:0) after 1m0s
[02:35:39.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:39:0)
[02:35:39.822] Timer tick, asking Buildbucket for the build status
[02:35:39.942] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:39.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:40:0) after 1m0s
[02:36:40.069] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:40:0)
[02:36:40.069] Timer tick, asking Buildbucket for the build status
[02:36:40.292] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.292] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:41:0) after 1m0s
[02:37:40.347] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:41:0)
[02:37:40.347] Timer tick, asking Buildbucket for the build status
[02:37:40.429] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:42:0) after 1m0s
[02:38:40.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:42:0)
[02:38:40.508] Timer tick, asking Buildbucket for the build status
[02:38:41.035] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:41.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:43:0) after 1m0s
[02:39:41.182] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:43:0)
[02:39:41.182] Timer tick, asking Buildbucket for the build status
[02:39:41.278] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:41.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:44:0) after 1m0s
[02:40:41.323] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:44:0)
[02:40:41.323] Timer tick, asking Buildbucket for the build status
[02:40:41.383] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.383] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:45:0) after 1m0s
[02:41:41.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:45:0)
[02:41:41.442] Timer tick, asking Buildbucket for the build status
[02:41:41.525] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:46:0) after 1m0s
[02:42:41.558] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:46:0)
[02:42:41.558] Timer tick, asking Buildbucket for the build status
[02:42:41.628] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:47:0) after 1m0s
[02:43:41.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:47:0)
[02:43:41.677] Timer tick, asking Buildbucket for the build status
[02:43:42.128] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.128] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:48:0) after 1m0s
[02:44:42.178] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:48:0)
[02:44:42.178] Timer tick, asking Buildbucket for the build status
[02:44:42.339] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:49:0) after 1m0s
[02:45:42.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:49:0)
[02:45:42.425] Timer tick, asking Buildbucket for the build status
[02:45:42.491] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:42.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:50:0) after 1m0s
[02:46:42.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:50:0)
[02:46:42.517] Timer tick, asking Buildbucket for the build status
[02:46:42.576] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:42.576] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:51:0) after 1m0s
[02:47:42.621] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:51:0)
[02:47:42.621] Timer tick, asking Buildbucket for the build status
[02:47:42.998] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:42.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:52:0) after 1m0s
[02:48:43.045] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:52:0)
[02:48:43.045] Timer tick, asking Buildbucket for the build status
[02:48:43.190] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.190] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:53:0) after 1m0s
[02:49:43.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:53:0)
[02:49:43.218] Timer tick, asking Buildbucket for the build status
[02:49:43.394] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:43.394] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:54:0) after 1m0s
[02:50:43.413] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:54:0)
[02:50:43.413] Timer tick, asking Buildbucket for the build status
[02:50:43.701] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:43.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:55:0) after 1m0s
[02:51:43.704] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:55:0)
[02:51:43.704] Timer tick, asking Buildbucket for the build status
[02:51:43.904] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:56:0) after 1m0s
[02:52:43.973] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:56:0)
[02:52:43.973] Timer tick, asking Buildbucket for the build status
[02:52:44.033] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:44.033] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:57:0) after 1m0s
[02:53:44.124] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:57:0)
[02:53:44.124] Timer tick, asking Buildbucket for the build status
[02:53:44.703] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:44.703] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:58:0) after 1m0s
[02:54:44.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:58:0)
[02:54:44.698] Timer tick, asking Buildbucket for the build status
[02:54:44.772] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:44.772] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:59:0) after 1m0s
[02:55:44.820] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:59:0)
[02:55:44.820] Timer tick, asking Buildbucket for the build status
[02:55:44.890] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:44.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:60:0) after 1m0s
[02:56:44.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:60:0)
[02:56:44.934] Timer tick, asking Buildbucket for the build status
[02:56:44.998] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:44.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:61:0) after 1m0s
[02:57:45.079] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:61:0)
[02:57:45.079] Timer tick, asking Buildbucket for the build status
[02:57:45.139] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.139] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:62:0) after 1m0s
[02:58:45.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:62:0)
[02:58:45.224] Timer tick, asking Buildbucket for the build status
[02:58:45.596] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:63:0) after 1m0s
[02:59:45.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:63:0)
[02:59:45.601] Timer tick, asking Buildbucket for the build status
[02:59:45.803] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:45.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:64:0) after 1m0s
[03:00:45.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:64:0)
[03:00:45.801] Timer tick, asking Buildbucket for the build status
[03:00:46.048] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:46.048] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:65:0) after 1m0s
[03:01:46.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:65:0)
[03:01:46.087] Timer tick, asking Buildbucket for the build status
[03:01:46.324] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:46.324] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:66:0) after 1m0s
[03:02:46.395] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:66:0)
[03:02:46.395] Timer tick, asking Buildbucket for the build status
[03:02:46.493] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:46.493] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:67:0) after 1m0s
[03:03:46.503] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:67:0)
[03:03:46.503] Timer tick, asking Buildbucket for the build status
[03:03:46.952] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:46.952] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:68:0) after 1m0s
[03:04:46.980] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:68:0)
[03:04:46.980] Timer tick, asking Buildbucket for the build status
[03:04:47.585] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:47.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:69:0) after 1m0s
[03:05:47.644] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:69:0)
[03:05:47.644] Timer tick, asking Buildbucket for the build status
[03:05:47.964] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:47.964] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:70:0) after 1m0s
[03:06:48.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:70:0)
[03:06:48.043] Timer tick, asking Buildbucket for the build status
[03:06:48.112] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.112] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:71:0) after 1m0s
[03:07:48.164] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:71:0)
[03:07:48.164] Timer tick, asking Buildbucket for the build status
[03:07:48.225] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.225] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:72:0) after 1m0s
[03:08:48.315] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:72:0)
[03:08:48.315] Timer tick, asking Buildbucket for the build status
[03:08:48.498] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.498] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:73:0) after 1m0s
[03:09:48.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:73:0)
[03:09:48.616] Timer tick, asking Buildbucket for the build status
[03:09:48.730] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.730] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:74:0) after 1m0s
[03:10:48.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:74:0)
[03:10:48.801] Timer tick, asking Buildbucket for the build status
[03:10:49.148] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.148] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:75:0) after 1m0s
[03:11:49.259] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:75:0)
[03:11:49.259] Timer tick, asking Buildbucket for the build status
[03:11:49.506] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:49.506] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:76:0) after 1m0s
[03:12:49.504] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:76:0)
[03:12:49.504] Timer tick, asking Buildbucket for the build status
[03:12:49.808] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.808] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:77:0) after 1m0s
[03:13:49.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:77:0)
[03:13:49.835] Timer tick, asking Buildbucket for the build status
[03:13:50.949] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:50.949] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:78:0) after 1m0s
[03:14:51.177] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:78:0)
[03:14:51.177] Timer tick, asking Buildbucket for the build status
[03:14:51.297] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:51.298] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:79:0) after 1m0s
[03:15:51.339] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:79:0)
[03:15:51.339] Timer tick, asking Buildbucket for the build status
[03:15:51.406] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:51.406] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:80:0) after 1m0s
[03:16:51.451] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:80:0)
[03:16:51.451] Timer tick, asking Buildbucket for the build status
[03:16:51.562] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:51.562] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:81:0) after 1m0s
[03:17:51.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:81:0)
[03:17:51.595] Timer tick, asking Buildbucket for the build status
[03:17:51.833] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:51.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:82:0) after 1m0s
[03:18:51.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:82:0)
[03:18:51.809] Timer tick, asking Buildbucket for the build status
[03:18:52.022] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:83:0) after 1m0s
[03:19:52.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:83:0)
[03:19:52.126] Timer tick, asking Buildbucket for the build status
[03:19:52.193] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:52.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:84:0) after 1m0s
[03:20:52.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:84:0)
[03:20:52.289] Timer tick, asking Buildbucket for the build status
[03:20:52.381] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:52.381] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:85:0) after 1m0s
[03:21:52.489] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:85:0)
[03:21:52.489] Timer tick, asking Buildbucket for the build status
[03:21:52.566] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:52.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:86:0) after 1m0s
[03:22:52.691] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:86:0)
[03:22:52.691] Timer tick, asking Buildbucket for the build status
[03:22:52.761] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:52.761] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:87:0) after 1m0s
[03:23:52.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:87:0)
[03:23:52.828] Timer tick, asking Buildbucket for the build status
[03:23:52.953] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:52.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:88:0) after 1m0s
[03:24:52.971] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:88:0)
[03:24:52.971] Timer tick, asking Buildbucket for the build status
[03:24:53.034] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:53.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:89:0) after 1m0s
[03:25:53.063] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:89:0)
[03:25:53.063] Timer tick, asking Buildbucket for the build status
[03:25:53.125] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:53.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:90:0) after 1m0s
[03:26:53.152] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:90:0)
[03:26:53.152] Timer tick, asking Buildbucket for the build status
[03:26:53.210] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:53.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:91:0) after 1m0s
[03:27:53.250] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:91:0)
[03:27:53.250] Timer tick, asking Buildbucket for the build status
[03:27:53.331] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:53.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:92:0) after 1m0s
[03:28:53.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:92:0)
[03:28:53.318] Timer tick, asking Buildbucket for the build status
[03:28:53.611] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:53.611] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:93:0) after 1m0s
[03:29:53.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:93:0)
[03:29:53.746] Timer tick, asking Buildbucket for the build status
[03:29:53.808] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.808] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:94:0) after 1m0s
[03:30:54.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:94:0)
[03:30:54.179] Timer tick, asking Buildbucket for the build status
[03:30:54.246] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:54.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:95:0) after 1m0s
[03:31:54.372] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:95:0)
[03:31:54.372] Timer tick, asking Buildbucket for the build status
[03:31:54.448] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:54.448] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:96:0) after 1m0s
[03:32:55.929] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:96:0)
[03:32:55.929] Timer tick, asking Buildbucket for the build status
[03:32:56.061] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:56.061] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:97:0) after 1m0s
[03:33:56.147] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:97:0)
[03:33:56.147] Timer tick, asking Buildbucket for the build status
[03:33:56.267] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:56.267] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:98:0) after 1m0s
[03:34:56.277] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:98:0)
[03:34:56.277] Timer tick, asking Buildbucket for the build status
[03:34:56.355] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:56.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:99:0) after 1m0s
[03:35:56.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:99:0)
[03:35:56.431] Timer tick, asking Buildbucket for the build status
[03:35:56.509] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:56.509] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:100:0) after 1m0s
[03:36:56.607] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:100:0)
[03:36:56.607] Timer tick, asking Buildbucket for the build status
[03:36:56.725] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:56.725] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:101:0) after 1m0s
[03:37:56.735] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:101:0)
[03:37:56.735] Timer tick, asking Buildbucket for the build status
[03:37:56.921] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:56.921] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:102:0) after 1m0s
[03:38:56.969] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:102:0)
[03:38:56.969] Timer tick, asking Buildbucket for the build status
[03:38:57.067] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:57.067] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:103:0) after 1m0s
[03:39:57.143] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:103:0)
[03:39:57.143] Timer tick, asking Buildbucket for the build status
[03:39:57.214] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:57.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:104:0) after 1m0s
[03:40:57.244] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:104:0)
[03:40:57.244] Timer tick, asking Buildbucket for the build status
[03:40:57.337] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:57.337] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:105:0) after 1m0s
[03:41:57.401] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:105:0)
[03:41:57.401] Timer tick, asking Buildbucket for the build status
[03:41:57.467] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:57.467] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:106:0) after 1m0s
[03:42:57.554] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:106:0)
[03:42:57.554] Timer tick, asking Buildbucket for the build status
[03:42:57.637] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:107:0) after 1m0s
[03:43:58.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:107:0)
[03:43:58.550] Timer tick, asking Buildbucket for the build status
[03:43:58.650] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:58.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:108:0) after 1m0s
[03:44:58.795] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:108:0)
[03:44:58.795] Timer tick, asking Buildbucket for the build status
[03:44:58.852] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:58.852] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:109:0) after 1m0s
[03:45:59.003] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:109:0)
[03:45:59.003] Timer tick, asking Buildbucket for the build status
[03:45:59.064] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:59.064] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:110:0) after 1m0s
[03:46:59.131] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:110:0)
[03:46:59.131] Timer tick, asking Buildbucket for the build status
[03:46:59.208] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:59.208] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:111:0) after 1m0s
[03:47:59.400] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:111:0)
[03:47:59.400] Timer tick, asking Buildbucket for the build status
[03:47:59.637] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:59.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:112:0) after 1m0s
[03:48:59.748] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:112:0)
[03:48:59.748] Timer tick, asking Buildbucket for the build status
[03:48:59.903] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:59.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:113:0) after 1m0s
[03:50:00.085] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:113:0)
[03:50:00.085] Timer tick, asking Buildbucket for the build status
[03:50:00.241] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:00.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:114:0) after 1m0s
[03:51:00.268] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:114:0)
[03:51:00.268] Timer tick, asking Buildbucket for the build status
[03:51:00.376] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:00.376] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:115:0) after 1m0s
[03:52:00.458] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:115:0)
[03:52:00.458] Timer tick, asking Buildbucket for the build status
[03:52:00.689] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:00.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:116:0) after 1m0s
[03:53:01.291] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:116:0)
[03:53:01.291] Timer tick, asking Buildbucket for the build status
[03:53:01.436] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:01.436] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:117:0) after 1m0s
[03:54:01.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:117:0)
[03:54:01.478] Timer tick, asking Buildbucket for the build status
[03:54:01.878] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:01.878] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:118:0) after 1m0s
[03:55:02.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:118:0)
[03:55:02.355] Timer tick, asking Buildbucket for the build status
[03:55:02.656] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:02.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:119:0) after 1m0s
[03:56:03.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:119:0)
[03:56:03.043] Timer tick, asking Buildbucket for the build status
[03:56:03.180] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:03.180] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:120:0) after 1m0s
[03:57:03.559] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:120:0)
[03:57:03.559] Timer tick, asking Buildbucket for the build status
[03:57:03.784] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:03.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:121:0) after 1m0s
[03:58:04.063] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:121:0)
[03:58:04.063] Timer tick, asking Buildbucket for the build status
[03:58:04.355] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:04.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:122:0) after 1m0s
[03:59:04.494] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:122:0)
[03:59:04.494] Timer tick, asking Buildbucket for the build status
[03:59:04.614] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:04.614] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:123:0) after 1m0s
[04:00:04.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:123:0)
[04:00:04.697] Timer tick, asking Buildbucket for the build status
[04:00:04.937] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:04.937] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:124:0) after 1m0s
[04:01:05.553] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:124:0)
[04:01:05.553] Timer tick, asking Buildbucket for the build status
[04:01:05.825] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:05.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:125:0) after 1m0s
[04:02:05.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:125:0)
[04:02:05.867] Timer tick, asking Buildbucket for the build status
[04:02:05.950] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:05.950] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:126:0) after 1m0s
[04:03:06.188] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:126:0)
[04:03:06.188] Timer tick, asking Buildbucket for the build status
[04:03:06.300] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:06.300] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:127:0) after 1m0s
[04:04:06.338] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:127:0)
[04:04:06.338] Timer tick, asking Buildbucket for the build status
[04:04:06.442] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:06.442] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:128:0) after 1m0s
[04:05:06.481] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:128:0)
[04:05:06.481] Timer tick, asking Buildbucket for the build status
[04:05:06.557] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:06.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:129:0) after 1m0s
[04:06:06.622] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:129:0)
[04:06:06.622] Timer tick, asking Buildbucket for the build status
[04:06:06.742] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:06.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:130:0) after 1m0s
[04:07:06.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:130:0)
[04:07:06.840] Timer tick, asking Buildbucket for the build status
[04:07:06.913] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:06.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:131:0) after 1m0s
[04:08:06.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:131:0)
[04:08:06.948] Timer tick, asking Buildbucket for the build status
[04:08:07.180] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:07.180] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:132:0) after 1m0s
[04:09:07.313] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:132:0)
[04:09:07.313] Timer tick, asking Buildbucket for the build status
[04:09:07.770] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:07.770] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:133:0) after 1m0s
[04:10:07.897] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:133:0)
[04:10:07.897] Timer tick, asking Buildbucket for the build status
[04:10:07.973] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:07.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:134:0) after 1m0s
[04:11:08.125] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:134:0)
[04:11:08.125] Timer tick, asking Buildbucket for the build status
[04:11:08.188] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:08.188] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:135:0) after 1m0s
[04:12:08.222] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:135:0)
[04:12:08.222] Timer tick, asking Buildbucket for the build status
[04:12:08.740] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:08.740] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:136:0) after 1m0s
[04:13:08.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:136:0)
[04:13:08.822] Timer tick, asking Buildbucket for the build status
[04:13:08.895] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:08.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:137:0) after 1m0s
[04:14:09.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:137:0)
[04:14:09.002] Timer tick, asking Buildbucket for the build status
[04:14:09.154] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:09.154] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:138:0) after 1m0s
[04:15:09.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:138:0)
[04:15:09.261] Timer tick, asking Buildbucket for the build status
[04:15:09.398] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:09.398] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:139:0) after 1m0s
[04:16:09.502] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:139:0)
[04:16:09.502] Timer tick, asking Buildbucket for the build status
[04:16:09.634] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:09.634] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:140:0) after 1m0s
[04:17:09.755] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:140:0)
[04:17:09.755] Timer tick, asking Buildbucket for the build status
[04:17:09.819] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:09.819] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:141:0) after 1m0s
[04:18:09.885] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:141:0)
[04:18:09.885] Timer tick, asking Buildbucket for the build status
[04:18:10.041] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:10.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:142:0) after 1m0s
[04:19:10.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:142:0)
[04:19:10.201] Timer tick, asking Buildbucket for the build status
[04:19:10.331] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:10.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:143:0) after 1m0s
[04:20:10.427] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:143:0)
[04:20:10.427] Timer tick, asking Buildbucket for the build status
[04:20:10.492] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:10.492] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:144:0) after 1m0s
[04:21:10.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:144:0)
[04:21:10.633] Timer tick, asking Buildbucket for the build status
[04:21:10.714] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:10.714] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:145:0) after 1m0s
[04:22:10.751] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:145:0)
[04:22:10.751] Timer tick, asking Buildbucket for the build status
[04:22:10.863] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:10.863] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:146:0) after 1m0s
[04:23:11.056] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:146:0)
[04:23:11.056] Timer tick, asking Buildbucket for the build status
[04:23:11.120] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:11.120] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:147:0) after 1m0s
[04:24:11.222] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:147:0)
[04:24:11.222] Timer tick, asking Buildbucket for the build status
[04:24:11.766] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:11.766] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:148:0) after 1m0s
[04:25:11.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:148:0)
[04:25:11.871] Timer tick, asking Buildbucket for the build status
[04:25:11.930] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:11.930] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:149:0) after 1m0s
[04:26:11.976] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:149:0)
[04:26:11.976] Timer tick, asking Buildbucket for the build status
[04:26:12.228] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:12.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:150:0) after 1m0s
[04:27:12.335] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:150:0)
[04:27:12.335] Timer tick, asking Buildbucket for the build status
[04:27:12.411] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:12.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:151:0) after 1m0s
[04:28:12.518] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:151:0)
[04:28:12.518] Timer tick, asking Buildbucket for the build status
[04:28:12.585] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:12.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:152:0) after 1m0s
[04:29:12.642] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:152:0)
[04:29:12.642] Timer tick, asking Buildbucket for the build status
[04:29:12.830] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:12.830] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:153:0) after 1m0s
[04:30:12.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:153:0)
[04:30:12.856] Timer tick, asking Buildbucket for the build status
[04:30:12.954] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:12.954] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:154:0) after 1m0s
[04:31:13.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:154:0)
[04:31:13.002] Timer tick, asking Buildbucket for the build status
[04:31:13.071] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:13.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:155:0) after 1m0s
[04:32:13.129] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:155:0)
[04:32:13.129] Timer tick, asking Buildbucket for the build status
[04:32:13.184] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:13.184] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:156:0) after 1m0s
[04:33:13.232] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:156:0)
[04:33:13.232] Timer tick, asking Buildbucket for the build status
[04:33:13.352] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:13.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:157:0) after 1m0s
[04:34:13.380] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:157:0)
[04:34:13.380] Timer tick, asking Buildbucket for the build status
[04:34:13.716] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:158:0) after 1m0s
[04:35:13.751] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:158:0)
[04:35:13.751] Timer tick, asking Buildbucket for the build status
[04:35:13.831] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:13.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:159:0) after 1m0s
[04:36:13.865] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:159:0)
[04:36:13.865] Timer tick, asking Buildbucket for the build status
[04:36:14.287] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:14.287] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:160:0) after 1m0s
[04:37:14.328] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:160:0)
[04:37:14.328] Timer tick, asking Buildbucket for the build status
[04:37:14.587] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:14.587] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:161:0) after 1m0s
[04:38:14.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:161:0)
[04:38:14.616] Timer tick, asking Buildbucket for the build status
[04:38:15.136] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:15.136] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:162:0) after 1m0s
[04:39:15.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:162:0)
[04:39:15.251] Timer tick, asking Buildbucket for the build status
[04:39:15.341] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:15.341] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:163:0) after 1m0s
[04:40:15.456] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:163:0)
[04:40:15.456] Timer tick, asking Buildbucket for the build status
[04:40:15.548] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:15.549] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:164:0) after 1m0s
[04:41:15.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:164:0)
[04:41:15.610] Timer tick, asking Buildbucket for the build status
[04:41:15.717] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:165:0) after 1m0s
[04:42:15.759] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:165:0)
[04:42:15.759] Timer tick, asking Buildbucket for the build status
[04:42:15.831] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:15.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:166:0) after 1m0s
[04:43:15.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:166:0)
[04:43:15.861] Timer tick, asking Buildbucket for the build status
[04:43:15.996] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:15.996] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:167:0) after 1m0s
[04:44:16.106] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:167:0)
[04:44:16.106] Timer tick, asking Buildbucket for the build status
[04:44:16.230] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:16.230] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:168:0) after 1m0s
[04:45:16.394] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:168:0)
[04:45:16.394] Timer tick, asking Buildbucket for the build status
[04:45:16.495] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:16.495] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:169:0) after 1m0s
[04:46:16.662] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:169:0)
[04:46:16.662] Timer tick, asking Buildbucket for the build status
[04:46:16.733] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:16.733] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:170:0) after 1m0s
[04:47:16.793] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:170:0)
[04:47:16.793] Timer tick, asking Buildbucket for the build status
[04:47:16.867] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:16.867] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:171:0) after 1m0s
[04:48:16.899] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:171:0)
[04:48:16.899] Timer tick, asking Buildbucket for the build status
[04:48:16.964] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:16.964] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:172:0) after 1m0s
[04:49:17.057] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:172:0)
[04:49:17.057] Timer tick, asking Buildbucket for the build status
[04:49:17.172] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:173:0) after 1m0s
[04:50:17.274] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:173:0)
[04:50:17.274] Timer tick, asking Buildbucket for the build status
[04:50:17.335] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:174:0) after 1m0s
[04:51:17.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:174:0)
[04:51:17.468] Timer tick, asking Buildbucket for the build status
[04:51:17.527] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:175:0) after 1m0s
[04:52:17.559] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:175:0)
[04:52:17.559] Timer tick, asking Buildbucket for the build status
[04:52:17.645] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:17.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:176:0) after 1m0s
[04:53:17.740] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:176:0)
[04:53:17.740] Timer tick, asking Buildbucket for the build status
[04:53:17.872] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:17.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:177:0) after 1m0s
[04:54:17.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:177:0)
[04:54:17.918] Timer tick, asking Buildbucket for the build status
[04:54:18.027] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:18.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:178:0) after 1m0s
[04:55:18.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:178:0)
[04:55:18.019] Timer tick, asking Buildbucket for the build status
[04:55:18.101] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:18.101] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:179:0) after 1m0s
[04:56:18.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:179:0)
[04:56:18.189] Timer tick, asking Buildbucket for the build status
[04:56:18.242] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:18.242] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:180:0) after 1m0s
[04:57:18.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:180:0)
[04:57:18.233] Timer tick, asking Buildbucket for the build status
[04:57:18.288] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:18.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:181:0) after 1m0s
[04:58:18.354] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:181:0)
[04:58:18.354] Timer tick, asking Buildbucket for the build status
[04:58:18.457] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:18.457] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:182:0) after 1m0s
[04:59:18.512] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:182:0)
[04:59:18.512] Timer tick, asking Buildbucket for the build status
[04:59:18.722] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:18.722] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:183:0) after 1m0s
[05:00:18.774] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:183:0)
[05:00:18.774] Timer tick, asking Buildbucket for the build status
[05:00:18.888] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:18.888] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:184:0) after 1m0s
[05:01:18.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:184:0)
[05:01:18.938] Timer tick, asking Buildbucket for the build status
[05:01:19.306] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:19.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:185:0) after 1m0s
[05:02:19.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:185:0)
[05:02:19.415] Timer tick, asking Buildbucket for the build status
[05:02:19.562] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:19.562] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:186:0) after 1m0s
[05:03:19.592] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:186:0)
[05:03:19.592] Timer tick, asking Buildbucket for the build status
[05:03:19.671] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:19.672] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:187:0) after 1m0s
[05:04:19.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:187:0)
[05:04:19.724] Timer tick, asking Buildbucket for the build status
[05:04:20.040] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:20.040] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:188:0) after 1m0s
[05:05:20.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:188:0)
[05:05:20.109] Timer tick, asking Buildbucket for the build status
[05:05:20.197] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:20.197] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:189:0) after 1m0s
[05:06:20.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:189:0)
[05:06:20.261] Timer tick, asking Buildbucket for the build status
[05:06:20.569] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:20.569] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:190:0) after 1m0s
[05:07:20.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:190:0)
[05:07:20.614] Timer tick, asking Buildbucket for the build status
[05:07:21.041] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:21.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:191:0) after 1m0s
[05:08:21.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:191:0)
[05:08:21.024] Timer tick, asking Buildbucket for the build status
[05:08:21.074] Build 8860161343877813072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:21.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9025591405871093824:192:0) after 1m0s
[05:09:13.480] Received PubSub notification, asking Buildbucket for the build status
[05:09:13.537] Build 8860161343877813072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:09:13.537] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1608700152286052",
    "created_by": "project:chromium",
    "created_ts": "1608688709336071",
    "id": "8860161343877813072",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2eaf311e0da332ab52e903d63d79fe3b669059f4\"}}",
    "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\": \"2eaf311e0da332ab52e903d63d79fe3b669059f4\", \"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-4-5ezj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1172, \"got_angle_revision\": \"74788951af42f8f4f360bb9471cb3906379bdb7c\", \"got_dawn_revision\": \"33bf309c1d45e4da80ba77913eab9dadfc8f5e26\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"2eaf311e0da332ab52e903d63d79fe3b669059f4\", \"got_revision_cp\": \"refs/heads/master@{#839031}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"407251b826bdb2683e639456c81b4a82de640240\", \"got_v8_revision_cp\": \"refs/heads/8.9.185@{#1}\", \"got_webrtc_revision\": \"c463a784c340874c75032da7602ec1fde43f75ed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32874}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2eaf311e0da332ab52e903d63d79fe3b669059f4\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_a69e6b6949245e742d9a022200655bac5124ee86184973d811510d142a3a53fc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-5ezj\"], \"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\": [\"5657-0417a3f\"], \"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": "1608688730404266",
    "status": "COMPLETED",
    "status_changed_ts": "1608700153131837",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1172",
      "builder:win32-official",
      "buildset:commit/git/2eaf311e0da332ab52e903d63d79fe3b669059f4",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2eaf311e0da332ab52e903d63d79fe3b669059f4",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9025591405871093824",
      "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/8860161343877813072/+/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:50a6233b26048d10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1608700153184588",
    "url": "https://ci.chromium.org/b/8860161343877813072",
    "utcnow_ts": "1608700153530804"
  }
}
[05:09:13.537] Invocation finished in 3h10m45.486397779s with status SUCCEEDED