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

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[21:33:02.486] New invocation is queued and will start shortly
[21:33:03.570] Starting the invocation (attempt 1)
[21:33:03.609] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:33:03.609] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:33:03.609] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9017544975042587312",
  "parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Linux CFI",
    "scheduler_invocation_id:9017544975042587312",
    "scheduler_job_id:chromium/Linux CFI",
    "user_agent:luci-scheduler",
    "buildset:commit/git/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
    "gitiles_ref:refs/heads/master"
  ]
}
[21:33:04.304] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1616362383706784",
    "id": "8852114913101781520",
    "parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1616362384054149",
    "tags": [
      "build_address:luci.chromium.ci/Linux CFI/19973",
      "builder:Linux CFI",
      "buildset:commit/git/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9017544975042587312",
      "scheduler_job_id:chromium/Linux CFI",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852114913101781520/+/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": "1616362384055779",
    "url": "https://ci.chromium.org/b/8852114913101781520",
    "utcnow_ts": "1616362384284002"
  }
}
[21:33:04.304] Task URL: https://ci.chromium.org/b/8852114913101781520
[21:33:04.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:2:0) after 1m0s
[21:33:08.090] Received PubSub notification, asking Buildbucket for the build status
[21:33:08.115] Build status: STARTED
[21:34:04.367] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:2:0)
[21:34:04.367] Timer tick, asking Buildbucket for the build status
[21:34:04.505] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:04.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:4:0) after 1m0s
[21:35:04.594] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:4:0)
[21:35:04.594] Timer tick, asking Buildbucket for the build status
[21:35:04.680] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:04.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:5:0) after 1m0s
[21:36:04.808] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:5:0)
[21:36:04.896] Build status: STARTED
[21:36:04.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:6:0) after 4m35s
[21:40:39.911] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:6:0)
[21:40:39.936] Build status: STARTED
[21:40:39.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:7:0) after 1m32s
[21:42:12.022] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:7:0)
[21:42:12.022] Timer tick, asking Buildbucket for the build status
[21:42:12.187] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:12.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:8:0) after 1m0s
[21:43:12.202] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:8:0)
[21:43:12.239] Build status: STARTED
[21:43:12.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:9:0) after 4m31s
[21:47:43.282] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:9:0)
[21:47:43.348] Build status: STARTED
[21:47:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:10:0) after 2m30s
[21:50:13.645] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:10:0)
[21:50:13.645] Timer tick, asking Buildbucket for the build status
[21:50:13.720] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:13.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:11:0) after 1m0s
[21:51:13.736] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:11:0)
[21:51:13.736] Timer tick, asking Buildbucket for the build status
[21:51:13.833] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:13.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:12:0) after 1m0s
[21:52:14.261] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:12:0)
[21:52:14.261] Timer tick, asking Buildbucket for the build status
[21:52:14.480] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:14.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:13:0) after 1m0s
[21:53:14.836] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:13:0)
[21:53:14.861] Build status: STARTED
[21:53:14.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:14:0) after 7m17s
[22:00:31.879] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:14:0)
[22:00:31.879] Timer tick, asking Buildbucket for the build status
[22:00:32.446] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:32.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:15:0) after 1m0s
[22:01:32.464] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:15:0)
[22:01:32.464] Timer tick, asking Buildbucket for the build status
[22:01:32.544] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:16:0) after 1m0s
[22:02:33.443] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:16:0)
[22:02:33.473] Build status: STARTED
[22:02:33.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:17:0) after 4m21s
[22:06:54.489] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:17:0)
[22:06:54.489] Timer tick, asking Buildbucket for the build status
[22:06:54.559] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:54.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:18:0) after 1m0s
[22:07:54.577] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:18:0)
[22:07:54.607] Build status: STARTED
[22:07:54.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:19:0) after 4m31s
[22:12:25.676] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:19:0)
[22:12:25.711] Build status: STARTED
[22:12:25.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:20:0) after 8m56s
[22:21:22.138] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:20:0)
[22:21:22.167] Build status: STARTED
[22:21:22.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:21:0) after 6m19s
[22:27:41.525] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:21:0)
[22:27:41.525] Timer tick, asking Buildbucket for the build status
[22:27:41.650] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:41.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:22:0) after 1m0s
[22:28:41.668] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:22:0)
[22:28:41.700] Build status: STARTED
[22:28:41.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:23:0) after 3m38s
[22:32:20.016] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:23:0)
[22:32:20.043] Build status: STARTED
[22:32:20.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:24:0) after 5m52s
[22:38:12.069] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:24:0)
[22:38:12.069] Timer tick, asking Buildbucket for the build status
[22:38:12.152] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:25:0) after 1m0s
[22:39:12.173] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:25:0)
[22:39:12.199] Build status: STARTED
[22:39:12.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:26:0) after 3m45s
[22:42:57.223] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:26:0)
[22:42:57.223] Timer tick, asking Buildbucket for the build status
[22:42:57.298] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:57.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:27:0) after 1m0s
[22:43:57.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:27:0)
[22:43:57.709] Build status: STARTED
[22:43:57.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:28:0) after 7m34s
[22:51:31.701] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:28:0)
[22:51:31.747] Build status: STARTED
[22:51:31.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:29:0) after 3m44s
[22:55:15.764] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:29:0)
[22:55:15.764] Timer tick, asking Buildbucket for the build status
[22:55:16.439] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:16.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:30:0) after 1m0s
[22:56:16.457] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:30:0)
[22:56:16.457] Timer tick, asking Buildbucket for the build status
[22:56:16.603] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:16.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:31:0) after 1m0s
[22:57:28.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:31:0)
[22:57:28.248] Timer tick, asking Buildbucket for the build status
[22:57:28.334] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:28.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:32:0) after 1m0s
[22:58:28.350] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:32:0)
[22:58:28.379] Build status: STARTED
[22:58:28.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:33:0) after 1m14s
[22:59:42.408] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:33:0)
[22:59:42.435] Build status: STARTED
[22:59:42.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:34:0) after 2m42s
[23:02:24.429] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:34:0)
[23:02:24.429] Timer tick, asking Buildbucket for the build status
[23:02:24.599] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:24.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:35:0) after 1m0s
[23:03:24.716] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:35:0)
[23:03:24.744] Build status: STARTED
[23:03:24.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:36:0) after 7m50s
[23:11:15.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:36:0)
[23:11:15.123] Timer tick, asking Buildbucket for the build status
[23:11:15.307] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:15.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:37:0) after 1m0s
[23:12:15.327] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:37:0)
[23:12:15.327] Timer tick, asking Buildbucket for the build status
[23:12:15.700] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:15.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:38:0) after 1m0s
[23:13:15.722] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:38:0)
[23:13:15.722] Timer tick, asking Buildbucket for the build status
[23:13:15.799] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:15.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:39:0) after 1m0s
[23:14:16.011] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:39:0)
[23:14:16.038] Build status: STARTED
[23:14:16.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:40:0) after 1m12s
[23:15:28.765] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:40:0)
[23:15:28.999] Build status: STARTED
[23:15:28.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:41:0) after 1m28s
[23:16:57.015] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:41:0)
[23:16:57.039] Build status: STARTED
[23:16:57.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:42:0) after 2m37s
[23:19:34.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:42:0)
[23:19:34.200] Build status: STARTED
[23:19:34.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:43:0) after 9m42s
[23:29:16.229] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:43:0)
[23:29:16.229] Timer tick, asking Buildbucket for the build status
[23:29:16.694] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:16.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:44:0) after 1m0s
[23:30:16.782] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:44:0)
[23:30:16.806] Build status: STARTED
[23:30:16.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:45:0) after 9m57s
[23:40:13.876] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:45:0)
[23:40:13.903] Build status: STARTED
[23:40:13.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:46:0) after 1m46s
[23:41:59.923] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:46:0)
[23:41:59.923] Timer tick, asking Buildbucket for the build status
[23:42:00.065] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:00.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:47:0) after 1m0s
[23:43:00.084] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:47:0)
[23:43:00.118] Build status: STARTED
[23:43:00.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:48:0) after 3m44s
[23:46:44.094] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:48:0)
[23:46:44.094] Timer tick, asking Buildbucket for the build status
[23:46:44.203] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:44.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:49:0) after 1m0s
[23:47:44.308] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:49:0)
[23:47:44.308] Timer tick, asking Buildbucket for the build status
[23:47:44.395] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:44.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:50:0) after 1m0s
[23:48:44.417] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:50:0)
[23:48:44.417] Timer tick, asking Buildbucket for the build status
[23:48:44.578] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:44.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:51:0) after 1m0s
[23:49:44.601] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:51:0)
[23:49:44.601] Timer tick, asking Buildbucket for the build status
[23:49:44.690] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:44.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:52:0) after 1m0s
[23:50:44.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:52:0)
[23:50:44.736] Build status: STARTED
[23:50:44.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:53:0) after 8m4s
[23:58:48.744] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:53:0)
[23:58:48.744] Timer tick, asking Buildbucket for the build status
[23:58:49.138] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:49.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:54:0) after 1m0s
[23:59:49.356] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:54:0)
[23:59:49.384] Build status: STARTED
[23:59:49.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:55:0) after 2m57s
[00:02:46.401] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:55:0)
[00:02:46.401] Timer tick, asking Buildbucket for the build status
[00:02:46.508] Build 8852114913101781520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:46.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:56:0) after 1m0s
[00:03:46.527] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:56:0)
[00:03:46.561] Build status: STARTED
[00:03:46.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017544975042587312:57:0) after 2m30s
[00:03:48.193] Received PubSub notification, asking Buildbucket for the build status
[00:03:48.294] Build 8852114913101781520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:03:48.294] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1616371427350309",
    "created_by": "project:chromium",
    "created_ts": "1616362383706784",
    "id": "8852114913101781520",
    "parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-32-3-6hel\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19973, \"got_angle_revision\": \"90cf278c36871437c89b8f88d62e6a538b51501d\", \"got_dawn_revision\": \"6b80743d3f5bb389665590585c43eeb9cfa70a34\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\", \"got_revision_cp\": \"refs/heads/master@{#865005}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"8bf1cd1c665a538a366bce4770acbb990b025388\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33513}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7819a1106ce1fcfc7f2fa29df7090867bf2916bb\", \"swarm_hashes_refs/heads/master(at){#865005}_without_patch\": {\"absl_hardening_tests\": \"49d00aa6589126082aad84a1a2085ab3e6cff041\", \"accessibility_unittests\": \"0a57f6fa79f54d5924b3eb0274a2d387cc31fc21\", \"angle_unittests\": \"011ce6fc17b60031b63d45920e3cdee808a66fe7\", \"app_shell_unittests\": \"692f9deeb6426446a6fff6bcf0d0a9ff378dccfc\", \"aura_unittests\": \"f304a0a906dd09574bda9df85342d9ca76ad9e12\", \"base_unittests\": \"7b6084ac94d86feba458cbdbdaf194d6227d8309\", \"base_util_unittests\": \"48dd02a13432d0a0489b8a077a72edfec1ad4e09\", \"blink_common_unittests\": \"47d30d2f27df4864772414e903cd564ca2f18124\", \"blink_fuzzer_unittests\": \"fefb05c6ad7e7788c7427175b32563510b80f0be\", \"blink_heap_unittests\": \"7b312e26b7e6aad6133943407dd591ea2bcb57bb\", \"blink_platform_unittests\": \"1d35882948c15df2b9ff0c5dfdc3ee1c8e6ece3b\", \"blink_unittests\": \"eb13b12108b6a8ec23b5476c0a8dda234cbaeeec\", \"boringssl_crypto_tests\": \"760153551b3262dd87762472fbc8d7f07f19d2ce\", \"boringssl_ssl_tests\": \"36e581e372a00ce6dba70f8287990f14e3134648\", \"browser_tests\": \"50360c075a9d78dc4ded544b80e10901eded22f4\", \"capture_unittests\": \"7dcf5d1540eb68d3a5befe7d25328a07e10257b9\", \"cast_unittests\": \"81fdce1042d88d92fad5364901120f461bd53065\", \"cc_unittests\": \"2dceae2f54e5e45e07fbd9c440e2db4fd575f03b\", \"chrome_app_unittests\": \"c3185981463066099a94d430f7d15e0f8db6f4f2\", \"chromedriver_unittests\": \"cd2964bb0a108afc153edfa2ad3e763c81559631\", \"color_unittests\": \"ff5f237c3ce3ddcb55198f282593e0af22316fa8\", \"components_browsertests\": \"af99c95fa76c1911bd1475653d9bee79eb48f739\", \"components_unittests\": \"bc2bb7d2fc129a1d4dba6322dc2288fb8ec4c4d3\", \"compositor_unittests\": \"501abca1f46ba9c3f0ef761c6069f20718e0b168\", \"content_browsertests\": \"e446b01fda547cb11802c710f2b7ac26e53b202f\", \"content_unittests\": \"d53f0613e40e6c56cd762bab33aa8605db3f4772\", \"cronet_tests\": \"f16730aa008460d0d815c42eaa0401ef8d914246\", \"cronet_unittests\": \"20ee337110ac4401ae21eb8d2a8245a1a8feb44d\", \"crypto_unittests\": \"0cffe0d10f729722a20c6369514df853f26c05fc\", \"dbus_unittests\": \"47345a524b2cf8e4cd78db3daecf8a7320203c7f\", \"device_unittests\": \"33ea576f26a54c21f79c1d58800b9a129adbcae4\", \"display_unittests\": \"b04a3982e414cd9ae11f2655027e07acb1b7864a\", \"events_unittests\": \"0d7a6a1e8420aeb91d39fe9bdbe9b05422a01a58\", \"extensions_browsertests\": \"885eb6de5dca52af7516fb75ce6c56bdc432082d\", \"extensions_unittests\": \"dce7b5c1fef131f2d11517cc6d4c3108dac29673\", \"filesystem_service_unittests\": \"dc071e7374c8f8cec24523a7403210d24b2040c5\", \"gcm_unit_tests\": \"1567396f4889dc55ee388dd6da9e97c89bc7bdef\", \"gfx_unittests\": \"16679c4cbb0e7947311bab2830a324bbaa170c7e\", \"gin_unittests\": \"925eb9743e043a66e0dab53aa5d9e0425174e372\", \"gl_tests\": \"e131486914e890e81c763f883abfdaefd9a26e46\", \"gl_unittests\": \"508b6cabd97e935d04568400b9474e6b612441f3\", \"google_apis_unittests\": \"9866099f1543d65c31d723481296051b57ace2ff\", \"gpu_unittests\": \"922869ee51bba30f63f1d50c246d1c94990dfa5b\", \"gwp_asan_unittests\": \"ba1a2c3ce5a33a0fd4b814470c1a0406d2191cb4\", \"headless_browsertests\": \"4d3bdba5ab795e3ad784159e1e9bfa032e8832ac\", \"headless_unittests\": \"27e5c1f27a7a0cb5aa5c77476822d92c101204ea\", \"interactive_ui_tests\": \"3e866a8c7e30708abba8b686bc98e5328d16e1e7\", \"ipc_tests\": \"b1b726c8a705e605e3b96732218c2ddfbc079c06\", \"jingle_unittests\": \"a9fb109a5fafdce6f1df4241dd7e8ccd57bdc0fc\", \"latency_unittests\": \"eec236682b339167153ba37bf77eb70d53dd7b2f\", \"libjingle_xmpp_unittests\": \"c186890c34f5c7202a3d61a44f84307a67ee91ae\", \"liburlpattern_unittests\": \"8a7089381b8f28366c376f3ff709b47d07722587\", \"media_blink_unittests\": \"847e18c210ce52bf1d03b531a14ef8ee8000e97e\", \"media_unittests\": \"fb84d01ab61bd695619a495054cf748bc87d09e8\", \"message_center_unittests\": \"ce8fb835de4fc59dcb851a7580ac93a07fc95781\", \"midi_unittests\": \"979c648fbbc8b5d47bff6d3f01d82f75845ab119\", \"mojo_core_unittests\": \"a620b3d113601fbbc7362dd62f48eb6ef8770681\", \"mojo_unittests\": \"1577f13a8bc16da80bf20d7762d366675fde9b6b\", \"nacl_helper_nonsfi_unittests\": \"967d35de19a05afae766d543a5c0fe4faa806a52\", \"nacl_loader_unittests\": \"453b9b89966bc3564ebf40e4d53f2b421c4948cd\", \"native_theme_unittests\": \"c2a20e48f34719dd6f1459c60ebe61f5210e7ea3\", \"net_unittests\": \"377389d48a286cbfa23d8df9a980c5bce279c08b\", \"pdf_unittests\": \"b706764b19b9b1fe711cf2644871f3232f4ecee3\", \"perfetto_unittests\": \"6bab4120b49ed08d63389727a05ec3561d222d5b\", \"ppapi_unittests\": \"9dc0f57d9df23e94992931b7b9c9838ed3d7bba9\", \"printing_unittests\": \"5ed16694e67426dd5daa18d2e9fb7747fa90fa49\", \"remoting_unittests\": \"b10f6770061f5c0bda3ebc82bd774107223934db\", \"sandbox_linux_unittests\": \"12639eed00d58e5866cab6bd610d65d0fd568a5d\", \"service_manager_unittests\": \"99e732753dc90be4809e8d983b93672ef32c7686\", \"services_unittests\": \"09dbf61bb6d4c7fa80891f8bf9f130d983d9f7e2\", \"shell_dialogs_unittests\": \"5b51e4d42b9bce607eee124a25bfab8f1a0c6a20\", \"skia_unittests\": \"f77c5df7e1981bfcc7ec2b8237d25bfb300dfed3\", \"snapshot_unittests\": \"d14ed90df2301cc5f1d7f627869ab37760525e33\", \"sql_unittests\": \"73df1408a236ac1fd4d871497ad0391fdd216a50\", \"storage_unittests\": \"860816c2d762e0f04399f3d055e2965642c56c30\", \"sync_integration_tests\": \"3d13b25f1735542ebad21b77f01f526eecdea00b\", \"traffic_annotation_auditor_unittests\": \"0e6862e8ea0419e532f73244b4936b4e26185288\", \"ui_base_unittests\": \"968fe74a764978bef9970495d01c8f511e6d65af\", \"ui_touch_selection_unittests\": \"1396203365221fc8cb5f2245d30b245f72090065\", \"unit_tests\": \"b6215d566cbafa531eb2c2d45e4061339ba91a98\", \"url_unittests\": \"42460e98b1fb3282056e9895c28a17c07b2da5d0\", \"views_unittests\": \"7f1c40073f9aa24440f04901901353215588679e\", \"viz_unittests\": \"e21cc9eee36e26b8f9ece8db79bb931a0ffdd630\", \"vr_common_unittests\": \"eb9256fb0da9ae160951a504d8a75bd3a9e678c8\", \"vr_pixeltests\": \"61addbf4ec7bde48e8814711e82378f1e0caf7b1\", \"weblayer_browsertests\": \"c8288b101549732cdf969900b477456bf76ab0bf\", \"weblayer_unittests\": \"b48fe58690cca40492ae1e47d092b7b8ccdcd52e\", \"wm_unittests\": \"82cc91742a8843acc4172900e2bb659cd46b3f4c\", \"wtf_unittests\": \"937e4faa898f82751c31e636e9e85bfb65b17d68\", \"x11_unittests\": \"943f232017febb6bc2e92204a71b6fbfc0e0a251\", \"xr_browser_tests\": \"659107c967f52ac11b03d2cdb050a1a4258666fa\", \"zlib_unittests\": \"a4ee64f35fb1f00cf718d3b152db53fe445709bf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3805b8ba4abc77de369f5d4399a0a76b312e2fd8c5f804cd390624b9118dfa64_v2\", \"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_61e4d25dfd74628f421fe7d90da475349672e571b4dfd9a5326b66319dc94b9e_v2\", \"builder_80447164fd9128f57b299ad64704e89447e5656f4886183701c68086f26508e5_v2\", \"builder_abdad654d32c0904ec528c85d62eedf165d853d59ca684a9604e4daa5dc8955e_v2\", \"builder_d3d2610b5230a0e8818d022113159013c6345fba0843daf9ae715f6a2f1da36d_v2\", \"builder_dcfcb66b8d57b27a65bec4794b95b0b7d35e8289f8160d11b4e7f1c01ad595f0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-3-6hel\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1616362385742527",
    "status": "COMPLETED",
    "status_changed_ts": "1616371427739771",
    "tags": [
      "build_address:luci.chromium.ci/Linux CFI/19973",
      "builder:Linux CFI",
      "buildset:commit/git/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7819a1106ce1fcfc7f2fa29df7090867bf2916bb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9017544975042587312",
      "scheduler_job_id:chromium/Linux CFI",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852114913101781520/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:526f86352b09e410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1616371427744866",
    "url": "https://ci.chromium.org/b/8852114913101781520",
    "utcnow_ts": "1616371428280149"
  }
}
[00:03:48.294] Invocation finished in 2h30m45.82253828s with status SUCCEEDED