buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.infra.cron"
  builder: "Build From Tarball"
>

• publish_tarball/0 (5 years ago by chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com)

{
  "version": "86.0.4236.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[07:55:05.385] New invocation is queued and will start shortly
[07:55:05.385] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:55:06.502] Starting the invocation (attempt 1)
[07:55:06.547] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:55:06.547] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:55:06.547] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9037165380858325712",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4236.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9add0219-50d8-444a-9d8f-2fe8b032d37e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4236.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9037165380858325712",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:55:07.174] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597650906693495",
    "id": "8871735318821625472",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4236.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9add0219-50d8-444a-9d8f-2fe8b032d37e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4236.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597650906978559",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037165380858325712",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8871735318821625472/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597650906978720",
    "url": "https://ci.chromium.org/b/8871735318821625472",
    "utcnow_ts": "1597650907153899"
  }
}
[07:55:07.174] Task URL: https://ci.chromium.org/b/8871735318821625472
[07:55:07.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:2:0) after 1m0s
[07:56:06.383] Received PubSub notification, asking Buildbucket for the build status
[07:56:06.510] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:07.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:2:0)
[07:56:07.238] Timer tick, asking Buildbucket for the build status
[07:56:07.415] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:07.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:4:0) after 1m0s
[07:57:07.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:4:0)
[07:57:07.586] Timer tick, asking Buildbucket for the build status
[07:57:07.787] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:07.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:5:0) after 1m0s
[07:58:07.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:5:0)
[07:58:07.939] Timer tick, asking Buildbucket for the build status
[07:58:08.453] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:08.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:6:0) after 1m0s
[07:59:08.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:6:0)
[07:59:08.571] Timer tick, asking Buildbucket for the build status
[07:59:08.721] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:08.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:7:0) after 1m0s
[08:00:08.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:7:0)
[08:00:08.848] Timer tick, asking Buildbucket for the build status
[08:00:09.147] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:09.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:8:0) after 1m0s
[08:01:09.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:8:0)
[08:01:09.218] Timer tick, asking Buildbucket for the build status
[08:01:09.386] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:09.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:9:0) after 1m0s
[08:02:09.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:9:0)
[08:02:09.514] Timer tick, asking Buildbucket for the build status
[08:02:09.825] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:09.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:10:0) after 1m0s
[08:03:09.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:10:0)
[08:03:09.859] Timer tick, asking Buildbucket for the build status
[08:03:10.114] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:10.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:11:0) after 1m0s
[08:04:10.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:11:0)
[08:04:10.242] Timer tick, asking Buildbucket for the build status
[08:04:10.432] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:10.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:12:0) after 1m0s
[08:05:10.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:12:0)
[08:05:10.560] Timer tick, asking Buildbucket for the build status
[08:05:10.919] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:10.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:13:0) after 1m0s
[08:06:10.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:13:0)
[08:06:10.935] Timer tick, asking Buildbucket for the build status
[08:06:11.048] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:11.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:14:0) after 1m0s
[08:07:11.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:14:0)
[08:07:11.096] Timer tick, asking Buildbucket for the build status
[08:07:11.224] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:11.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:15:0) after 1m0s
[08:08:11.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:15:0)
[08:08:11.283] Timer tick, asking Buildbucket for the build status
[08:08:11.380] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:11.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:16:0) after 1m0s
[08:09:11.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:16:0)
[08:09:11.626] Timer tick, asking Buildbucket for the build status
[08:09:11.788] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:11.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:17:0) after 1m0s
[08:10:11.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:17:0)
[08:10:11.958] Timer tick, asking Buildbucket for the build status
[08:10:12.413] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:12.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:18:0) after 1m0s
[08:11:12.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:18:0)
[08:11:12.627] Timer tick, asking Buildbucket for the build status
[08:11:12.804] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:12.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:19:0) after 1m0s
[08:12:12.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:19:0)
[08:12:12.894] Timer tick, asking Buildbucket for the build status
[08:12:13.010] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:13.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:20:0) after 1m0s
[08:13:13.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:20:0)
[08:13:13.185] Timer tick, asking Buildbucket for the build status
[08:13:13.456] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:13.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:21:0) after 1m0s
[08:14:13.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:21:0)
[08:14:13.537] Timer tick, asking Buildbucket for the build status
[08:14:13.629] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:13.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:22:0) after 1m0s
[08:15:13.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:22:0)
[08:15:13.687] Timer tick, asking Buildbucket for the build status
[08:15:13.937] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:13.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:23:0) after 1m0s
[08:16:14.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:23:0)
[08:16:14.238] Timer tick, asking Buildbucket for the build status
[08:16:14.329] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:14.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:24:0) after 1m0s
[08:17:14.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:24:0)
[08:17:14.538] Timer tick, asking Buildbucket for the build status
[08:17:14.627] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:14.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:25:0) after 1m0s
[08:18:14.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:25:0)
[08:18:14.770] Timer tick, asking Buildbucket for the build status
[08:18:14.950] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:14.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:26:0) after 1m0s
[08:19:15.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:26:0)
[08:19:15.224] Timer tick, asking Buildbucket for the build status
[08:19:15.662] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:15.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:27:0) after 1m0s
[08:20:15.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:27:0)
[08:20:15.763] Timer tick, asking Buildbucket for the build status
[08:20:16.137] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:16.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:28:0) after 1m0s
[08:21:16.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:28:0)
[08:21:16.161] Timer tick, asking Buildbucket for the build status
[08:21:16.312] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:16.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:29:0) after 1m0s
[08:22:16.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:29:0)
[08:22:16.377] Timer tick, asking Buildbucket for the build status
[08:22:16.512] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:16.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:30:0) after 1m0s
[08:23:16.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:30:0)
[08:23:16.570] Timer tick, asking Buildbucket for the build status
[08:23:16.719] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:16.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:31:0) after 1m0s
[08:24:16.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:31:0)
[08:24:16.744] Timer tick, asking Buildbucket for the build status
[08:24:16.820] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:32:0) after 1m0s
[08:25:16.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:32:0)
[08:25:16.922] Timer tick, asking Buildbucket for the build status
[08:25:17.293] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:17.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:33:0) after 1m0s
[08:26:17.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:33:0)
[08:26:17.356] Timer tick, asking Buildbucket for the build status
[08:26:17.538] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:34:0) after 1m0s
[08:27:17.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:34:0)
[08:27:17.559] Timer tick, asking Buildbucket for the build status
[08:27:17.620] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:35:0) after 1m0s
[08:28:17.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:35:0)
[08:28:17.649] Timer tick, asking Buildbucket for the build status
[08:28:17.737] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:17.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:36:0) after 1m0s
[08:29:17.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:36:0)
[08:29:17.742] Timer tick, asking Buildbucket for the build status
[08:29:17.828] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:17.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:37:0) after 1m0s
[08:30:17.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:37:0)
[08:30:17.883] Timer tick, asking Buildbucket for the build status
[08:30:18.250] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:18.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:38:0) after 1m0s
[08:31:18.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:38:0)
[08:31:18.306] Timer tick, asking Buildbucket for the build status
[08:31:18.604] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:18.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:39:0) after 1m0s
[08:32:18.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:39:0)
[08:32:18.638] Timer tick, asking Buildbucket for the build status
[08:32:18.708] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:40:0) after 1m0s
[08:33:18.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:40:0)
[08:33:18.745] Timer tick, asking Buildbucket for the build status
[08:33:18.849] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:18.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:41:0) after 1m0s
[08:34:18.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:41:0)
[08:34:18.883] Timer tick, asking Buildbucket for the build status
[08:34:19.088] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:42:0) after 1m0s
[08:35:19.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:42:0)
[08:35:19.132] Timer tick, asking Buildbucket for the build status
[08:35:19.337] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:19.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:43:0) after 1m0s
[08:36:19.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:43:0)
[08:36:19.369] Timer tick, asking Buildbucket for the build status
[08:36:19.492] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:19.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:44:0) after 1m0s
[08:37:19.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:44:0)
[08:37:19.597] Timer tick, asking Buildbucket for the build status
[08:37:19.871] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:19.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:45:0) after 1m0s
[08:38:19.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:45:0)
[08:38:19.907] Timer tick, asking Buildbucket for the build status
[08:38:20.131] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:46:0) after 1m0s
[08:39:20.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:46:0)
[08:39:20.171] Timer tick, asking Buildbucket for the build status
[08:39:20.310] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:20.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:47:0) after 1m0s
[08:40:20.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:47:0)
[08:40:20.350] Timer tick, asking Buildbucket for the build status
[08:40:20.499] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:20.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:48:0) after 1m0s
[08:41:20.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:48:0)
[08:41:20.573] Timer tick, asking Buildbucket for the build status
[08:41:23.097] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:23.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:49:0) after 1m0s
[08:42:23.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:49:0)
[08:42:23.137] Timer tick, asking Buildbucket for the build status
[08:42:23.292] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:23.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:50:0) after 1m0s
[08:43:23.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:50:0)
[08:43:23.348] Timer tick, asking Buildbucket for the build status
[08:43:23.415] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:23.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:51:0) after 1m0s
[08:44:23.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:51:0)
[08:44:23.474] Timer tick, asking Buildbucket for the build status
[08:44:23.577] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:23.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:52:0) after 1m0s
[08:45:23.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:52:0)
[08:45:23.634] Timer tick, asking Buildbucket for the build status
[08:45:23.915] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:23.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:53:0) after 1m0s
[08:46:23.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:53:0)
[08:46:23.931] Timer tick, asking Buildbucket for the build status
[08:46:24.068] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:24.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:54:0) after 1m0s
[08:47:24.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:54:0)
[08:47:24.101] Timer tick, asking Buildbucket for the build status
[08:47:24.175] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:24.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:55:0) after 1m0s
[08:48:24.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:55:0)
[08:48:24.200] Timer tick, asking Buildbucket for the build status
[08:48:24.421] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:24.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:56:0) after 1m0s
[08:49:24.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:56:0)
[08:49:24.479] Timer tick, asking Buildbucket for the build status
[08:49:24.549] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:24.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:57:0) after 1m0s
[08:50:24.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:57:0)
[08:50:24.608] Timer tick, asking Buildbucket for the build status
[08:50:24.808] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:24.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:58:0) after 1m0s
[08:51:24.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:58:0)
[08:51:24.913] Timer tick, asking Buildbucket for the build status
[08:51:25.443] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:25.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:59:0) after 1m0s
[08:52:25.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:59:0)
[08:52:25.462] Timer tick, asking Buildbucket for the build status
[08:52:25.567] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:25.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:60:0) after 1m0s
[08:53:25.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:60:0)
[08:53:25.620] Timer tick, asking Buildbucket for the build status
[08:53:25.688] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:25.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:61:0) after 1m0s
[08:54:25.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:61:0)
[08:54:25.717] Timer tick, asking Buildbucket for the build status
[08:54:25.801] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:25.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:62:0) after 1m0s
[08:55:25.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:62:0)
[08:55:25.823] Timer tick, asking Buildbucket for the build status
[08:55:26.219] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:26.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:63:0) after 1m0s
[08:56:26.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:63:0)
[08:56:26.271] Timer tick, asking Buildbucket for the build status
[08:56:26.403] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:26.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:64:0) after 1m0s
[08:57:26.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:64:0)
[08:57:26.428] Timer tick, asking Buildbucket for the build status
[08:57:26.708] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:26.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:65:0) after 1m0s
[08:58:26.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:65:0)
[08:58:26.738] Timer tick, asking Buildbucket for the build status
[08:58:26.821] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:26.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:66:0) after 1m0s
[08:59:26.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:66:0)
[08:59:26.853] Timer tick, asking Buildbucket for the build status
[08:59:26.986] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:26.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:67:0) after 1m0s
[09:00:27.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:67:0)
[09:00:27.047] Timer tick, asking Buildbucket for the build status
[09:00:27.922] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:27.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:68:0) after 1m0s
[09:01:27.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:68:0)
[09:01:27.933] Timer tick, asking Buildbucket for the build status
[09:01:28.827] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:28.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:69:0) after 1m0s
[09:02:28.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:69:0)
[09:02:28.874] Timer tick, asking Buildbucket for the build status
[09:02:28.935] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:28.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:70:0) after 1m0s
[09:03:28.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:70:0)
[09:03:28.957] Timer tick, asking Buildbucket for the build status
[09:03:29.054] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:29.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:71:0) after 1m0s
[09:04:29.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:71:0)
[09:04:29.091] Timer tick, asking Buildbucket for the build status
[09:04:29.200] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:29.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:72:0) after 1m0s
[09:05:29.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:72:0)
[09:05:29.341] Timer tick, asking Buildbucket for the build status
[09:05:29.612] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:29.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:73:0) after 1m0s
[09:06:29.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:73:0)
[09:06:29.638] Timer tick, asking Buildbucket for the build status
[09:06:30.602] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:30.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:74:0) after 1m0s
[09:07:30.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:74:0)
[09:07:30.667] Timer tick, asking Buildbucket for the build status
[09:07:30.773] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:30.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:75:0) after 1m0s
[09:08:30.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:75:0)
[09:08:30.759] Timer tick, asking Buildbucket for the build status
[09:08:30.837] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:30.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:76:0) after 1m0s
[09:09:30.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:76:0)
[09:09:30.885] Timer tick, asking Buildbucket for the build status
[09:09:30.983] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:30.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:77:0) after 1m0s
[09:10:31.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:77:0)
[09:10:31.017] Timer tick, asking Buildbucket for the build status
[09:10:31.129] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:31.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:78:0) after 1m0s
[09:11:31.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:78:0)
[09:11:31.154] Timer tick, asking Buildbucket for the build status
[09:11:31.515] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:31.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:79:0) after 1m0s
[09:12:31.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:79:0)
[09:12:31.625] Timer tick, asking Buildbucket for the build status
[09:12:31.713] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:31.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:80:0) after 1m0s
[09:13:31.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:80:0)
[09:13:31.749] Timer tick, asking Buildbucket for the build status
[09:13:31.831] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:31.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:81:0) after 1m0s
[09:14:31.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:81:0)
[09:14:31.886] Timer tick, asking Buildbucket for the build status
[09:14:32.610] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:32.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:82:0) after 1m0s
[09:15:32.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:82:0)
[09:15:32.655] Timer tick, asking Buildbucket for the build status
[09:15:32.785] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:32.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:83:0) after 1m0s
[09:16:32.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:83:0)
[09:16:32.844] Timer tick, asking Buildbucket for the build status
[09:16:32.945] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:32.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:84:0) after 1m0s
[09:17:33.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:84:0)
[09:17:33.014] Timer tick, asking Buildbucket for the build status
[09:17:33.083] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:85:0) after 1m0s
[09:18:33.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:85:0)
[09:18:33.193] Timer tick, asking Buildbucket for the build status
[09:18:33.257] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:33.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:86:0) after 1m0s
[09:19:33.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:86:0)
[09:19:33.317] Timer tick, asking Buildbucket for the build status
[09:19:33.378] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:33.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:87:0) after 1m0s
[09:20:33.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:87:0)
[09:20:33.393] Timer tick, asking Buildbucket for the build status
[09:20:33.594] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:33.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:88:0) after 1m0s
[09:21:33.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:88:0)
[09:21:33.619] Timer tick, asking Buildbucket for the build status
[09:21:33.871] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:33.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:89:0) after 1m0s
[09:22:33.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:89:0)
[09:22:33.922] Timer tick, asking Buildbucket for the build status
[09:22:34.050] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:34.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:90:0) after 1m0s
[09:23:34.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:90:0)
[09:23:34.108] Timer tick, asking Buildbucket for the build status
[09:23:34.225] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:34.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:91:0) after 1m0s
[09:24:34.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:91:0)
[09:24:34.272] Timer tick, asking Buildbucket for the build status
[09:24:34.412] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:34.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:92:0) after 1m0s
[09:25:34.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:92:0)
[09:25:34.476] Timer tick, asking Buildbucket for the build status
[09:25:34.680] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:34.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:93:0) after 1m0s
[09:26:34.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:93:0)
[09:26:34.710] Timer tick, asking Buildbucket for the build status
[09:26:34.910] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:34.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:94:0) after 1m0s
[09:27:34.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:94:0)
[09:27:34.959] Timer tick, asking Buildbucket for the build status
[09:27:35.082] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:35.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:95:0) after 1m0s
[09:28:35.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:95:0)
[09:28:35.118] Timer tick, asking Buildbucket for the build status
[09:28:35.233] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:35.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:96:0) after 1m0s
[09:29:35.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:96:0)
[09:29:35.304] Timer tick, asking Buildbucket for the build status
[09:29:35.522] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:35.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:97:0) after 1m0s
[09:30:35.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:97:0)
[09:30:35.553] Timer tick, asking Buildbucket for the build status
[09:30:36.014] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:36.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:98:0) after 1m0s
[09:31:36.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:98:0)
[09:31:36.059] Timer tick, asking Buildbucket for the build status
[09:31:36.187] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:36.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:99:0) after 1m0s
[09:32:36.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:99:0)
[09:32:36.212] Timer tick, asking Buildbucket for the build status
[09:32:36.282] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:36.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:100:0) after 1m0s
[09:33:36.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:100:0)
[09:33:36.306] Timer tick, asking Buildbucket for the build status
[09:33:36.360] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:36.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:101:0) after 1m0s
[09:34:36.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:101:0)
[09:34:36.412] Timer tick, asking Buildbucket for the build status
[09:34:36.540] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:36.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:102:0) after 1m0s
[09:35:36.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:102:0)
[09:35:36.523] Timer tick, asking Buildbucket for the build status
[09:35:36.754] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:36.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:103:0) after 1m0s
[09:36:36.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:103:0)
[09:36:36.785] Timer tick, asking Buildbucket for the build status
[09:36:37.467] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:37.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:104:0) after 1m0s
[09:37:37.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:104:0)
[09:37:37.502] Timer tick, asking Buildbucket for the build status
[09:37:37.813] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:37.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:105:0) after 1m0s
[09:38:37.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:105:0)
[09:38:37.873] Timer tick, asking Buildbucket for the build status
[09:38:38.104] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:38.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:106:0) after 1m0s
[09:39:38.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:106:0)
[09:39:38.144] Timer tick, asking Buildbucket for the build status
[09:39:38.236] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:38.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:107:0) after 1m0s
[09:40:38.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:107:0)
[09:40:38.234] Timer tick, asking Buildbucket for the build status
[09:40:38.379] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:38.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:108:0) after 1m0s
[09:41:38.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:108:0)
[09:41:38.486] Timer tick, asking Buildbucket for the build status
[09:41:38.588] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:38.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:109:0) after 1m0s
[09:42:38.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:109:0)
[09:42:38.629] Timer tick, asking Buildbucket for the build status
[09:42:38.827] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:38.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:110:0) after 1m0s
[09:43:38.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:110:0)
[09:43:38.897] Timer tick, asking Buildbucket for the build status
[09:43:39.062] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:39.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:111:0) after 1m0s
[09:44:39.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:111:0)
[09:44:39.111] Timer tick, asking Buildbucket for the build status
[09:44:39.208] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:39.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:112:0) after 1m0s
[09:45:39.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:112:0)
[09:45:39.351] Timer tick, asking Buildbucket for the build status
[09:45:39.750] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:39.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:113:0) after 1m0s
[09:46:39.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:113:0)
[09:46:39.787] Timer tick, asking Buildbucket for the build status
[09:46:40.044] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:40.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:114:0) after 1m0s
[09:47:40.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:114:0)
[09:47:40.078] Timer tick, asking Buildbucket for the build status
[09:47:40.147] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:40.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:115:0) after 1m0s
[09:48:40.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:115:0)
[09:48:40.232] Timer tick, asking Buildbucket for the build status
[09:48:40.317] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:40.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:116:0) after 1m0s
[09:49:40.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:116:0)
[09:49:40.351] Timer tick, asking Buildbucket for the build status
[09:49:40.432] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:40.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:117:0) after 1m0s
[09:50:40.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:117:0)
[09:50:40.442] Timer tick, asking Buildbucket for the build status
[09:50:40.705] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:40.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:118:0) after 1m0s
[09:51:40.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:118:0)
[09:51:40.746] Timer tick, asking Buildbucket for the build status
[09:51:40.854] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:40.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:119:0) after 1m0s
[09:52:40.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:119:0)
[09:52:40.886] Timer tick, asking Buildbucket for the build status
[09:52:40.965] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:40.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:120:0) after 1m0s
[09:53:41.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:120:0)
[09:53:41.048] Timer tick, asking Buildbucket for the build status
[09:53:41.121] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:41.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:121:0) after 1m0s
[09:54:41.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:121:0)
[09:54:41.296] Timer tick, asking Buildbucket for the build status
[09:54:41.514] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:122:0) after 1m0s
[09:55:41.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:122:0)
[09:55:41.599] Timer tick, asking Buildbucket for the build status
[09:55:42.093] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:42.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:123:0) after 1m0s
[09:56:42.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:123:0)
[09:56:42.132] Timer tick, asking Buildbucket for the build status
[09:56:42.254] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:42.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:124:0) after 1m0s
[09:57:42.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:124:0)
[09:57:42.391] Timer tick, asking Buildbucket for the build status
[09:57:42.706] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:42.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:125:0) after 1m0s
[09:58:43.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:125:0)
[09:58:43.108] Timer tick, asking Buildbucket for the build status
[09:58:43.199] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:43.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:126:0) after 1m0s
[09:59:43.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:126:0)
[09:59:43.307] Timer tick, asking Buildbucket for the build status
[09:59:43.429] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:43.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:127:0) after 1m0s
[10:00:43.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:127:0)
[10:00:43.471] Timer tick, asking Buildbucket for the build status
[10:00:44.292] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:44.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:128:0) after 1m0s
[10:01:44.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:128:0)
[10:01:44.396] Timer tick, asking Buildbucket for the build status
[10:01:44.810] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:44.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:129:0) after 1m0s
[10:02:44.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:129:0)
[10:02:44.895] Timer tick, asking Buildbucket for the build status
[10:02:44.977] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:44.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:130:0) after 1m0s
[10:03:45.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:130:0)
[10:03:45.032] Timer tick, asking Buildbucket for the build status
[10:03:45.238] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:45.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:131:0) after 1m0s
[10:04:45.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:131:0)
[10:04:45.402] Timer tick, asking Buildbucket for the build status
[10:04:45.635] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:45.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:132:0) after 1m0s
[10:05:45.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:132:0)
[10:05:45.672] Timer tick, asking Buildbucket for the build status
[10:05:46.131] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:46.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:133:0) after 1m0s
[10:06:46.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:133:0)
[10:06:46.187] Timer tick, asking Buildbucket for the build status
[10:06:46.288] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:46.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:134:0) after 1m0s
[10:07:46.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:134:0)
[10:07:46.386] Timer tick, asking Buildbucket for the build status
[10:07:46.528] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:46.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:135:0) after 1m0s
[10:08:46.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:135:0)
[10:08:46.542] Timer tick, asking Buildbucket for the build status
[10:08:46.617] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:46.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:136:0) after 1m0s
[10:09:46.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:136:0)
[10:09:46.708] Timer tick, asking Buildbucket for the build status
[10:09:46.838] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:46.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:137:0) after 1m0s
[10:10:47.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:137:0)
[10:10:47.394] Timer tick, asking Buildbucket for the build status
[10:10:47.621] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:47.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:138:0) after 1m0s
[10:11:47.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:138:0)
[10:11:47.882] Timer tick, asking Buildbucket for the build status
[10:11:49.960] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:49.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:139:0) after 1m0s
[10:12:50.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:139:0)
[10:12:50.083] Timer tick, asking Buildbucket for the build status
[10:12:50.184] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:50.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:140:0) after 1m0s
[10:13:50.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:140:0)
[10:13:50.317] Timer tick, asking Buildbucket for the build status
[10:13:50.411] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:50.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:141:0) after 1m0s
[10:14:50.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:141:0)
[10:14:50.495] Timer tick, asking Buildbucket for the build status
[10:14:50.720] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:50.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:142:0) after 1m0s
[10:15:50.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:142:0)
[10:15:50.786] Timer tick, asking Buildbucket for the build status
[10:15:51.136] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:51.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:143:0) after 1m0s
[10:16:51.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:143:0)
[10:16:51.167] Timer tick, asking Buildbucket for the build status
[10:16:51.299] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:51.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:144:0) after 1m0s
[10:17:51.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:144:0)
[10:17:51.430] Timer tick, asking Buildbucket for the build status
[10:17:51.496] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:51.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:145:0) after 1m0s
[10:18:51.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:145:0)
[10:18:51.592] Timer tick, asking Buildbucket for the build status
[10:18:51.675] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:51.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:146:0) after 1m0s
[10:19:51.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:146:0)
[10:19:51.701] Timer tick, asking Buildbucket for the build status
[10:19:51.791] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:51.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:147:0) after 1m0s
[10:20:51.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:147:0)
[10:20:51.876] Timer tick, asking Buildbucket for the build status
[10:20:52.398] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:52.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:148:0) after 1m0s
[10:21:52.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:148:0)
[10:21:52.475] Timer tick, asking Buildbucket for the build status
[10:21:52.574] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:52.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:149:0) after 1m0s
[10:22:52.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:149:0)
[10:22:52.684] Timer tick, asking Buildbucket for the build status
[10:22:52.768] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:52.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:150:0) after 1m0s
[10:23:52.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:150:0)
[10:23:52.851] Timer tick, asking Buildbucket for the build status
[10:23:52.923] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:52.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:151:0) after 1m0s
[10:24:53.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:151:0)
[10:24:53.066] Timer tick, asking Buildbucket for the build status
[10:24:53.191] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:53.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:152:0) after 1m0s
[10:25:53.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:152:0)
[10:25:53.287] Timer tick, asking Buildbucket for the build status
[10:25:53.589] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:53.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:153:0) after 1m0s
[10:26:53.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:153:0)
[10:26:53.638] Timer tick, asking Buildbucket for the build status
[10:26:53.722] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:53.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:154:0) after 1m0s
[10:27:53.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:154:0)
[10:27:53.770] Timer tick, asking Buildbucket for the build status
[10:27:53.943] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:53.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:155:0) after 1m0s
[10:28:53.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:155:0)
[10:28:53.972] Timer tick, asking Buildbucket for the build status
[10:28:54.165] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:54.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:156:0) after 1m0s
[10:29:54.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:156:0)
[10:29:54.231] Timer tick, asking Buildbucket for the build status
[10:29:54.395] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:54.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:157:0) after 1m0s
[10:30:54.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:157:0)
[10:30:54.458] Timer tick, asking Buildbucket for the build status
[10:30:54.593] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:54.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:158:0) after 1m0s
[10:31:54.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:158:0)
[10:31:54.639] Timer tick, asking Buildbucket for the build status
[10:31:54.764] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:54.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:159:0) after 1m0s
[10:32:54.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:159:0)
[10:32:54.842] Timer tick, asking Buildbucket for the build status
[10:32:55.581] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:55.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:160:0) after 1m0s
[10:33:55.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:160:0)
[10:33:55.623] Timer tick, asking Buildbucket for the build status
[10:33:57.104] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:57.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:161:0) after 1m0s
[10:34:57.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:161:0)
[10:34:57.132] Timer tick, asking Buildbucket for the build status
[10:34:57.333] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:57.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:162:0) after 1m0s
[10:35:57.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:162:0)
[10:35:57.416] Timer tick, asking Buildbucket for the build status
[10:35:57.599] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:57.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:163:0) after 1m0s
[10:36:57.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:163:0)
[10:36:57.742] Timer tick, asking Buildbucket for the build status
[10:36:58.201] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:58.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:164:0) after 1m0s
[10:37:58.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:164:0)
[10:37:58.329] Timer tick, asking Buildbucket for the build status
[10:37:58.441] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:58.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:165:0) after 1m0s
[10:38:58.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:165:0)
[10:38:58.454] Timer tick, asking Buildbucket for the build status
[10:38:58.637] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:58.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:166:0) after 1m0s
[10:39:58.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:166:0)
[10:39:58.741] Timer tick, asking Buildbucket for the build status
[10:39:58.947] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:58.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:167:0) after 1m0s
[10:40:59.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:167:0)
[10:40:59.054] Timer tick, asking Buildbucket for the build status
[10:40:59.189] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:59.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:168:0) after 1m0s
[10:41:59.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:168:0)
[10:41:59.251] Timer tick, asking Buildbucket for the build status
[10:41:59.346] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:59.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:169:0) after 1m0s
[10:42:59.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:169:0)
[10:42:59.385] Timer tick, asking Buildbucket for the build status
[10:42:59.474] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:59.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:170:0) after 1m0s
[10:43:59.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:170:0)
[10:43:59.526] Timer tick, asking Buildbucket for the build status
[10:43:59.593] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:59.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:171:0) after 1m0s
[10:44:59.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:171:0)
[10:44:59.630] Timer tick, asking Buildbucket for the build status
[10:44:59.731] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:59.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:172:0) after 1m0s
[10:45:59.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:172:0)
[10:45:59.757] Timer tick, asking Buildbucket for the build status
[10:46:01.368] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:01.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:173:0) after 1m0s
[10:47:01.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:173:0)
[10:47:01.520] Timer tick, asking Buildbucket for the build status
[10:47:01.586] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:01.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:174:0) after 1m0s
[10:48:01.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:174:0)
[10:48:01.974] Timer tick, asking Buildbucket for the build status
[10:48:02.081] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:02.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:175:0) after 1m0s
[10:49:03.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:175:0)
[10:49:03.226] Timer tick, asking Buildbucket for the build status
[10:49:03.491] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:03.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:176:0) after 1m0s
[10:50:03.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:176:0)
[10:50:03.522] Timer tick, asking Buildbucket for the build status
[10:50:03.612] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:03.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:177:0) after 1m0s
[10:51:03.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:177:0)
[10:51:03.624] Timer tick, asking Buildbucket for the build status
[10:51:03.843] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:03.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:178:0) after 1m0s
[10:52:03.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:178:0)
[10:52:03.866] Timer tick, asking Buildbucket for the build status
[10:52:03.997] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:179:0) after 1m0s
[10:53:04.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:179:0)
[10:53:04.048] Timer tick, asking Buildbucket for the build status
[10:53:04.144] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:04.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:180:0) after 1m0s
[10:54:04.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:180:0)
[10:54:04.310] Timer tick, asking Buildbucket for the build status
[10:54:04.422] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:04.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:181:0) after 1m0s
[10:55:04.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:181:0)
[10:55:04.520] Timer tick, asking Buildbucket for the build status
[10:55:04.599] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:182:0) after 1m0s
[10:56:04.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:182:0)
[10:56:04.785] Timer tick, asking Buildbucket for the build status
[10:56:05.131] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:05.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:183:0) after 1m0s
[10:57:05.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:183:0)
[10:57:05.374] Timer tick, asking Buildbucket for the build status
[10:57:06.000] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:06.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:184:0) after 1m0s
[10:58:06.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:184:0)
[10:58:06.113] Timer tick, asking Buildbucket for the build status
[10:58:06.235] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:06.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:185:0) after 1m0s
[10:59:06.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:185:0)
[10:59:06.330] Timer tick, asking Buildbucket for the build status
[10:59:06.604] Build 8871735318821625472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:06.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037165380858325712:186:0) after 1m0s
[10:59:57.240] Received PubSub notification, asking Buildbucket for the build status
[10:59:57.339] Build 8871735318821625472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:59:57.339] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597661996535797",
    "created_by": "project:infra",
    "created_ts": "1597650906693495",
    "id": "8871735318821625472",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4236.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9add0219-50d8-444a-9d8f-2fe8b032d37e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4236.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-hb44\"], \"image\": [\"chrome-xenial-20081300-1358d8153ce\"], \"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.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597650965627345",
    "status": "COMPLETED",
    "status_changed_ts": "1597661996950407",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037165380858325712",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8871735318821625472/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:4e143bbe3907e610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597661996969674",
    "url": "https://ci.chromium.org/b/8871735318821625472",
    "utcnow_ts": "1597661997328003"
  }
}
[10:59:57.339] Invocation finished in 3h4m51.971576678s with status SUCCEEDED