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.4230.0"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[11:25:50.123] New invocation is queued and will start shortly
[11:25:50.123] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[11:25:51.281] Starting the invocation (attempt 1)
[11:25:51.320] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:25:51.320] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:25:51.320] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9037695703686710512",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4230.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"444dc443-1799-4d13-bc62-2cdeb705abeb\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4230.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:9037695703686710512",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[11:25:51.995] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597145151408720",
    "id": "8872265641675904368",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4230.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"444dc443-1799-4d13-bc62-2cdeb705abeb\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4230.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597145151750055",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037695703686710512",
      "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/8872265641675904368/+/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": "1597145151750419",
    "url": "https://ci.chromium.org/b/8872265641675904368",
    "utcnow_ts": "1597145151977098"
  }
}
[11:25:51.995] Task URL: https://ci.chromium.org/b/8872265641675904368
[11:25:51.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:2:0) after 1m0s
[11:25:53.987] Received PubSub notification, asking Buildbucket for the build status
[11:25:54.143] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:52.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:2:0)
[11:26:52.071] Timer tick, asking Buildbucket for the build status
[11:26:52.234] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:52.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:4:0) after 1m0s
[11:27:52.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:4:0)
[11:27:52.301] Timer tick, asking Buildbucket for the build status
[11:27:52.508] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:52.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:5:0) after 1m0s
[11:28:52.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:5:0)
[11:28:52.516] Timer tick, asking Buildbucket for the build status
[11:28:52.959] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:52.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:6:0) after 1m0s
[11:29:52.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:6:0)
[11:29:52.983] Timer tick, asking Buildbucket for the build status
[11:29:53.059] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:53.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:7:0) after 1m0s
[11:30:53.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:7:0)
[11:30:53.078] Timer tick, asking Buildbucket for the build status
[11:30:53.227] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:53.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:8:0) after 1m0s
[11:31:53.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:8:0)
[11:31:53.477] Timer tick, asking Buildbucket for the build status
[11:31:53.617] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:53.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:9:0) after 1m0s
[11:32:54.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:9:0)
[11:32:54.116] Timer tick, asking Buildbucket for the build status
[11:32:54.183] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:54.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:10:0) after 1m0s
[11:33:54.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:10:0)
[11:33:54.388] Timer tick, asking Buildbucket for the build status
[11:33:54.482] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:54.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:11:0) after 1m0s
[11:34:54.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:11:0)
[11:34:54.652] Timer tick, asking Buildbucket for the build status
[11:34:54.756] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:54.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:12:0) after 1m0s
[11:35:54.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:12:0)
[11:35:54.944] Timer tick, asking Buildbucket for the build status
[11:35:55.087] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:55.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:13:0) after 1m0s
[11:36:55.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:13:0)
[11:36:55.312] Timer tick, asking Buildbucket for the build status
[11:36:55.384] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:55.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:14:0) after 1m0s
[11:37:55.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:14:0)
[11:37:55.502] Timer tick, asking Buildbucket for the build status
[11:37:55.581] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:55.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:15:0) after 1m0s
[11:38:56.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:15:0)
[11:38:56.253] Timer tick, asking Buildbucket for the build status
[11:38:56.350] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:56.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:16:0) after 1m0s
[11:39:56.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:16:0)
[11:39:56.442] Timer tick, asking Buildbucket for the build status
[11:39:56.622] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:56.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:17:0) after 1m0s
[11:40:56.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:17:0)
[11:40:56.644] Timer tick, asking Buildbucket for the build status
[11:40:56.953] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:56.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:18:0) after 1m0s
[11:41:56.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:18:0)
[11:41:56.941] Timer tick, asking Buildbucket for the build status
[11:41:57.130] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:57.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:19:0) after 1m0s
[11:42:57.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:19:0)
[11:42:57.128] Timer tick, asking Buildbucket for the build status
[11:42:57.203] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:57.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:20:0) after 1m0s
[11:43:57.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:20:0)
[11:43:57.367] Timer tick, asking Buildbucket for the build status
[11:43:57.444] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:57.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:21:0) after 1m0s
[11:44:57.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:21:0)
[11:44:57.543] Timer tick, asking Buildbucket for the build status
[11:44:57.753] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:57.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:22:0) after 1m0s
[11:45:57.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:22:0)
[11:45:57.749] Timer tick, asking Buildbucket for the build status
[11:45:58.382] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:58.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:23:0) after 1m0s
[11:46:58.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:23:0)
[11:46:58.408] Timer tick, asking Buildbucket for the build status
[11:46:58.582] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:58.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:24:0) after 1m0s
[11:47:58.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:24:0)
[11:47:58.704] Timer tick, asking Buildbucket for the build status
[11:47:59.026] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:59.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:25:0) after 1m0s
[11:48:59.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:25:0)
[11:48:59.069] Timer tick, asking Buildbucket for the build status
[11:48:59.155] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:59.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:26:0) after 1m0s
[11:49:59.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:26:0)
[11:49:59.179] Timer tick, asking Buildbucket for the build status
[11:49:59.285] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:59.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:27:0) after 1m0s
[11:50:59.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:27:0)
[11:50:59.484] Timer tick, asking Buildbucket for the build status
[11:51:00.535] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:00.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:28:0) after 1m0s
[11:52:00.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:28:0)
[11:52:00.546] Timer tick, asking Buildbucket for the build status
[11:52:00.630] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:00.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:29:0) after 1m0s
[11:53:00.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:29:0)
[11:53:00.697] Timer tick, asking Buildbucket for the build status
[11:53:00.799] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:00.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:30:0) after 1m0s
[11:54:01.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:30:0)
[11:54:01.502] Timer tick, asking Buildbucket for the build status
[11:54:01.580] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:01.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:31:0) after 1m0s
[11:55:01.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:31:0)
[11:55:01.599] Timer tick, asking Buildbucket for the build status
[11:55:01.913] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:01.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:32:0) after 1m0s
[11:56:02.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:32:0)
[11:56:02.609] Timer tick, asking Buildbucket for the build status
[11:56:02.823] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:02.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:33:0) after 1m0s
[11:57:02.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:33:0)
[11:57:02.893] Timer tick, asking Buildbucket for the build status
[11:57:03.088] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:34:0) after 1m0s
[11:58:03.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:34:0)
[11:58:03.143] Timer tick, asking Buildbucket for the build status
[11:58:03.277] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:03.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:35:0) after 1m0s
[11:59:03.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:35:0)
[11:59:03.298] Timer tick, asking Buildbucket for the build status
[11:59:03.392] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:03.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:36:0) after 1m0s
[12:00:03.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:36:0)
[12:00:03.454] Timer tick, asking Buildbucket for the build status
[12:00:03.585] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:03.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:37:0) after 1m0s
[12:01:05.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:37:0)
[12:01:05.038] Timer tick, asking Buildbucket for the build status
[12:01:05.196] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:05.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:38:0) after 1m0s
[12:02:05.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:38:0)
[12:02:05.284] Timer tick, asking Buildbucket for the build status
[12:02:05.457] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:05.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:39:0) after 1m0s
[12:03:05.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:39:0)
[12:03:05.588] Timer tick, asking Buildbucket for the build status
[12:03:05.713] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:05.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:40:0) after 1m0s
[12:04:05.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:40:0)
[12:04:05.779] Timer tick, asking Buildbucket for the build status
[12:04:05.845] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:05.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:41:0) after 1m0s
[12:05:05.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:41:0)
[12:05:05.913] Timer tick, asking Buildbucket for the build status
[12:05:06.151] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:06.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:42:0) after 1m0s
[12:06:06.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:42:0)
[12:06:06.178] Timer tick, asking Buildbucket for the build status
[12:06:06.349] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:06.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:43:0) after 1m0s
[12:07:06.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:43:0)
[12:07:06.343] Timer tick, asking Buildbucket for the build status
[12:07:06.439] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:06.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:44:0) after 1m0s
[12:08:06.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:44:0)
[12:08:06.550] Timer tick, asking Buildbucket for the build status
[12:08:06.737] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:45:0) after 1m0s
[12:09:06.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:45:0)
[12:09:06.990] Timer tick, asking Buildbucket for the build status
[12:09:07.209] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:46:0) after 1m0s
[12:10:07.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:46:0)
[12:10:07.273] Timer tick, asking Buildbucket for the build status
[12:10:07.343] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:47:0) after 1m0s
[12:11:07.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:47:0)
[12:11:07.395] Timer tick, asking Buildbucket for the build status
[12:11:07.525] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:48:0) after 1m0s
[12:12:07.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:48:0)
[12:12:07.584] Timer tick, asking Buildbucket for the build status
[12:12:07.695] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:49:0) after 1m0s
[12:13:07.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:49:0)
[12:13:07.749] Timer tick, asking Buildbucket for the build status
[12:13:07.835] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:07.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:50:0) after 1m0s
[12:14:07.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:50:0)
[12:14:07.958] Timer tick, asking Buildbucket for the build status
[12:14:08.124] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:08.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:51:0) after 1m0s
[12:15:08.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:51:0)
[12:15:08.151] Timer tick, asking Buildbucket for the build status
[12:15:08.526] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:08.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:52:0) after 1m0s
[12:16:08.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:52:0)
[12:16:08.568] Timer tick, asking Buildbucket for the build status
[12:16:09.011] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:09.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:53:0) after 1m0s
[12:17:09.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:53:0)
[12:17:09.012] Timer tick, asking Buildbucket for the build status
[12:17:09.096] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:09.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:54:0) after 1m0s
[12:18:09.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:54:0)
[12:18:09.347] Timer tick, asking Buildbucket for the build status
[12:18:09.599] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:09.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:55:0) after 1m0s
[12:19:09.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:55:0)
[12:19:09.644] Timer tick, asking Buildbucket for the build status
[12:19:09.746] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:56:0) after 1m0s
[12:20:09.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:56:0)
[12:20:09.775] Timer tick, asking Buildbucket for the build status
[12:20:09.851] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:09.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:57:0) after 1m0s
[12:21:09.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:57:0)
[12:21:09.881] Timer tick, asking Buildbucket for the build status
[12:21:10.199] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:10.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:58:0) after 1m0s
[12:22:10.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:58:0)
[12:22:10.323] Timer tick, asking Buildbucket for the build status
[12:22:10.655] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:10.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:59:0) after 1m0s
[12:23:10.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:59:0)
[12:23:10.691] Timer tick, asking Buildbucket for the build status
[12:23:10.826] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:60:0) after 1m0s
[12:24:10.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:60:0)
[12:24:10.839] Timer tick, asking Buildbucket for the build status
[12:24:11.074] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:11.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:61:0) after 1m0s
[12:25:11.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:61:0)
[12:25:11.067] Timer tick, asking Buildbucket for the build status
[12:25:11.191] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:11.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:62:0) after 1m0s
[12:26:11.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:62:0)
[12:26:11.330] Timer tick, asking Buildbucket for the build status
[12:26:11.552] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:11.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:63:0) after 1m0s
[12:27:11.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:63:0)
[12:27:11.596] Timer tick, asking Buildbucket for the build status
[12:27:11.788] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:11.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:64:0) after 1m0s
[12:28:11.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:64:0)
[12:28:11.839] Timer tick, asking Buildbucket for the build status
[12:28:12.015] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:12.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:65:0) after 1m0s
[12:29:12.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:65:0)
[12:29:12.033] Timer tick, asking Buildbucket for the build status
[12:29:14.599] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:14.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:66:0) after 1m0s
[12:30:14.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:66:0)
[12:30:14.679] Timer tick, asking Buildbucket for the build status
[12:30:15.103] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:67:0) after 1m0s
[12:31:15.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:67:0)
[12:31:15.192] Timer tick, asking Buildbucket for the build status
[12:31:16.364] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:68:0) after 1m0s
[12:32:16.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:68:0)
[12:32:16.440] Timer tick, asking Buildbucket for the build status
[12:32:16.620] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:69:0) after 1m0s
[12:33:16.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:69:0)
[12:33:16.664] Timer tick, asking Buildbucket for the build status
[12:33:16.805] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:16.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:70:0) after 1m0s
[12:34:16.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:70:0)
[12:34:16.868] Timer tick, asking Buildbucket for the build status
[12:34:16.958] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:16.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:71:0) after 1m0s
[12:35:17.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:71:0)
[12:35:17.075] Timer tick, asking Buildbucket for the build status
[12:35:17.159] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:17.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:72:0) after 1m0s
[12:36:17.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:72:0)
[12:36:17.189] Timer tick, asking Buildbucket for the build status
[12:36:17.336] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:17.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:73:0) after 1m0s
[12:37:17.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:73:0)
[12:37:17.377] Timer tick, asking Buildbucket for the build status
[12:37:17.453] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:17.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:74:0) after 1m0s
[12:38:17.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:74:0)
[12:38:17.468] Timer tick, asking Buildbucket for the build status
[12:38:17.574] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:17.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:75:0) after 1m0s
[12:39:17.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:75:0)
[12:39:17.658] Timer tick, asking Buildbucket for the build status
[12:39:17.738] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:17.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:76:0) after 1m0s
[12:40:17.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:76:0)
[12:40:17.840] Timer tick, asking Buildbucket for the build status
[12:40:18.054] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:18.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:77:0) after 1m0s
[12:41:18.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:77:0)
[12:41:18.137] Timer tick, asking Buildbucket for the build status
[12:41:19.702] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:19.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:78:0) after 1m0s
[12:42:19.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:78:0)
[12:42:19.773] Timer tick, asking Buildbucket for the build status
[12:42:21.982] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:21.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:79:0) after 1m0s
[12:43:21.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:79:0)
[12:43:21.986] Timer tick, asking Buildbucket for the build status
[12:43:22.065] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:22.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:80:0) after 1m0s
[12:44:22.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:80:0)
[12:44:22.202] Timer tick, asking Buildbucket for the build status
[12:44:22.277] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:22.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:81:0) after 1m0s
[12:45:22.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:81:0)
[12:45:22.446] Timer tick, asking Buildbucket for the build status
[12:45:22.545] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:22.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:82:0) after 1m0s
[12:46:22.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:82:0)
[12:46:22.652] Timer tick, asking Buildbucket for the build status
[12:46:22.920] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:22.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:83:0) after 1m0s
[12:47:23.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:83:0)
[12:47:23.215] Timer tick, asking Buildbucket for the build status
[12:47:23.332] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:23.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:84:0) after 1m0s
[12:48:23.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:84:0)
[12:48:23.359] Timer tick, asking Buildbucket for the build status
[12:48:23.495] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:23.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:85:0) after 1m0s
[12:49:23.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:85:0)
[12:49:23.589] Timer tick, asking Buildbucket for the build status
[12:49:23.672] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:23.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:86:0) after 1m0s
[12:50:23.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:86:0)
[12:50:23.710] Timer tick, asking Buildbucket for the build status
[12:50:23.816] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:23.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:87:0) after 1m0s
[12:51:23.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:87:0)
[12:51:23.886] Timer tick, asking Buildbucket for the build status
[12:51:24.166] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:24.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:88:0) after 1m0s
[12:52:24.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:88:0)
[12:52:24.209] Timer tick, asking Buildbucket for the build status
[12:52:24.294] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:24.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:89:0) after 1m0s
[12:53:24.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:89:0)
[12:53:24.385] Timer tick, asking Buildbucket for the build status
[12:53:24.631] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:24.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:90:0) after 1m0s
[12:54:24.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:90:0)
[12:54:24.748] Timer tick, asking Buildbucket for the build status
[12:54:24.871] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:24.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:91:0) after 1m0s
[12:55:25.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:91:0)
[12:55:25.268] Timer tick, asking Buildbucket for the build status
[12:55:25.451] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:25.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:92:0) after 1m0s
[12:56:25.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:92:0)
[12:56:25.559] Timer tick, asking Buildbucket for the build status
[12:56:25.678] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:25.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:93:0) after 1m0s
[12:57:25.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:93:0)
[12:57:25.739] Timer tick, asking Buildbucket for the build status
[12:57:25.856] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:25.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:94:0) after 1m0s
[12:58:25.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:94:0)
[12:58:25.869] Timer tick, asking Buildbucket for the build status
[12:58:26.088] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:26.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:95:0) after 1m0s
[12:59:26.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:95:0)
[12:59:26.145] Timer tick, asking Buildbucket for the build status
[12:59:26.227] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:26.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:96:0) after 1m0s
[13:00:26.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:96:0)
[13:00:26.374] Timer tick, asking Buildbucket for the build status
[13:00:26.563] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:26.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:97:0) after 1m0s
[13:01:26.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:97:0)
[13:01:26.768] Timer tick, asking Buildbucket for the build status
[13:01:27.472] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:27.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:98:0) after 1m0s
[13:02:27.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:98:0)
[13:02:27.628] Timer tick, asking Buildbucket for the build status
[13:02:27.703] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:27.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:99:0) after 1m0s
[13:03:27.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:99:0)
[13:03:27.868] Timer tick, asking Buildbucket for the build status
[13:03:28.220] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:28.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:100:0) after 1m0s
[13:04:28.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:100:0)
[13:04:28.349] Timer tick, asking Buildbucket for the build status
[13:04:28.451] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:28.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:101:0) after 1m0s
[13:05:28.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:101:0)
[13:05:28.547] Timer tick, asking Buildbucket for the build status
[13:05:28.652] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:28.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:102:0) after 1m0s
[13:06:28.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:102:0)
[13:06:28.683] Timer tick, asking Buildbucket for the build status
[13:06:29.234] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:29.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:103:0) after 1m0s
[13:07:29.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:103:0)
[13:07:29.262] Timer tick, asking Buildbucket for the build status
[13:07:29.380] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:104:0) after 1m0s
[13:08:29.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:104:0)
[13:08:29.443] Timer tick, asking Buildbucket for the build status
[13:08:29.726] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:29.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:105:0) after 1m0s
[13:09:29.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:105:0)
[13:09:29.839] Timer tick, asking Buildbucket for the build status
[13:09:29.953] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:29.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:106:0) after 1m0s
[13:10:30.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:106:0)
[13:10:30.009] Timer tick, asking Buildbucket for the build status
[13:10:30.136] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:30.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:107:0) after 1m0s
[13:11:30.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:107:0)
[13:11:30.173] Timer tick, asking Buildbucket for the build status
[13:11:30.352] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:30.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:108:0) after 1m0s
[13:12:30.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:108:0)
[13:12:30.391] Timer tick, asking Buildbucket for the build status
[13:12:30.696] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:30.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:109:0) after 1m0s
[13:13:30.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:109:0)
[13:13:30.746] Timer tick, asking Buildbucket for the build status
[13:13:30.855] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:30.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:110:0) after 1m0s
[13:14:30.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:110:0)
[13:14:30.891] Timer tick, asking Buildbucket for the build status
[13:14:30.981] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:30.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:111:0) after 1m0s
[13:15:31.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:111:0)
[13:15:31.009] Timer tick, asking Buildbucket for the build status
[13:15:31.294] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:31.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:112:0) after 1m0s
[13:16:31.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:112:0)
[13:16:31.670] Timer tick, asking Buildbucket for the build status
[13:16:31.836] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:31.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:113:0) after 1m0s
[13:17:31.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:113:0)
[13:17:31.969] Timer tick, asking Buildbucket for the build status
[13:17:32.069] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:32.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:114:0) after 1m0s
[13:18:32.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:114:0)
[13:18:32.305] Timer tick, asking Buildbucket for the build status
[13:18:32.448] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:32.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:115:0) after 1m0s
[13:19:32.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:115:0)
[13:19:32.673] Timer tick, asking Buildbucket for the build status
[13:19:32.898] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:32.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:116:0) after 1m0s
[13:20:32.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:116:0)
[13:20:32.925] Timer tick, asking Buildbucket for the build status
[13:20:33.007] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:33.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:117:0) after 1m0s
[13:21:33.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:117:0)
[13:21:33.080] Timer tick, asking Buildbucket for the build status
[13:21:33.403] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:33.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:118:0) after 1m0s
[13:22:33.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:118:0)
[13:22:33.603] Timer tick, asking Buildbucket for the build status
[13:22:33.715] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:33.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:119:0) after 1m0s
[13:23:33.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:119:0)
[13:23:33.841] Timer tick, asking Buildbucket for the build status
[13:23:34.105] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:34.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:120:0) after 1m0s
[13:24:34.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:120:0)
[13:24:34.131] Timer tick, asking Buildbucket for the build status
[13:24:34.334] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:34.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:121:0) after 1m0s
[13:25:34.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:121:0)
[13:25:34.391] Timer tick, asking Buildbucket for the build status
[13:25:34.538] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:34.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:122:0) after 1m0s
[13:26:34.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:122:0)
[13:26:34.608] Timer tick, asking Buildbucket for the build status
[13:26:35.338] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:35.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:123:0) after 1m0s
[13:27:35.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:123:0)
[13:27:35.449] Timer tick, asking Buildbucket for the build status
[13:27:35.534] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:35.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:124:0) after 1m0s
[13:28:35.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:124:0)
[13:28:35.589] Timer tick, asking Buildbucket for the build status
[13:28:35.745] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:35.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:125:0) after 1m0s
[13:29:35.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:125:0)
[13:29:35.777] Timer tick, asking Buildbucket for the build status
[13:29:36.016] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:36.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:126:0) after 1m0s
[13:30:36.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:126:0)
[13:30:36.113] Timer tick, asking Buildbucket for the build status
[13:30:36.323] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:36.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:127:0) after 1m0s
[13:31:36.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:127:0)
[13:31:36.478] Timer tick, asking Buildbucket for the build status
[13:31:36.813] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:36.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:128:0) after 1m0s
[13:32:36.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:128:0)
[13:32:36.895] Timer tick, asking Buildbucket for the build status
[13:32:36.984] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:36.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:129:0) after 1m0s
[13:33:37.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:129:0)
[13:33:37.225] Timer tick, asking Buildbucket for the build status
[13:33:37.316] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:37.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:130:0) after 1m0s
[13:34:37.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:130:0)
[13:34:37.395] Timer tick, asking Buildbucket for the build status
[13:34:40.089] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:40.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:131:0) after 1m0s
[13:35:40.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:131:0)
[13:35:40.152] Timer tick, asking Buildbucket for the build status
[13:35:40.238] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:40.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:132:0) after 1m0s
[13:36:40.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:132:0)
[13:36:40.517] Timer tick, asking Buildbucket for the build status
[13:36:40.628] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:40.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:133:0) after 1m0s
[13:37:40.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:133:0)
[13:37:40.914] Timer tick, asking Buildbucket for the build status
[13:37:41.244] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:41.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:134:0) after 1m0s
[13:38:41.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:134:0)
[13:38:41.312] Timer tick, asking Buildbucket for the build status
[13:38:41.389] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:41.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:135:0) after 1m0s
[13:39:41.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:135:0)
[13:39:41.450] Timer tick, asking Buildbucket for the build status
[13:39:41.552] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:41.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:136:0) after 1m0s
[13:40:41.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:136:0)
[13:40:41.590] Timer tick, asking Buildbucket for the build status
[13:40:41.726] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:41.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:137:0) after 1m0s
[13:41:41.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:137:0)
[13:41:41.801] Timer tick, asking Buildbucket for the build status
[13:41:41.975] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:41.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:138:0) after 1m0s
[13:42:42.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:138:0)
[13:42:42.105] Timer tick, asking Buildbucket for the build status
[13:42:42.214] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:42.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:139:0) after 1m0s
[13:43:42.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:139:0)
[13:43:42.207] Timer tick, asking Buildbucket for the build status
[13:43:42.297] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:42.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:140:0) after 1m0s
[13:44:42.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:140:0)
[13:44:42.334] Timer tick, asking Buildbucket for the build status
[13:44:42.820] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:42.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:141:0) after 1m0s
[13:45:42.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:141:0)
[13:45:42.957] Timer tick, asking Buildbucket for the build status
[13:45:43.402] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:142:0) after 1m0s
[13:46:43.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:142:0)
[13:46:43.463] Timer tick, asking Buildbucket for the build status
[13:46:43.991] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:43.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:143:0) after 1m0s
[13:47:44.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:143:0)
[13:47:44.039] Timer tick, asking Buildbucket for the build status
[13:47:44.226] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:44.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:144:0) after 1m0s
[13:48:44.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:144:0)
[13:48:44.291] Timer tick, asking Buildbucket for the build status
[13:48:44.607] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:44.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:145:0) after 1m0s
[13:49:44.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:145:0)
[13:49:44.751] Timer tick, asking Buildbucket for the build status
[13:49:44.852] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:44.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:146:0) after 1m0s
[13:50:45.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:146:0)
[13:50:45.033] Timer tick, asking Buildbucket for the build status
[13:50:45.342] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:45.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:147:0) after 1m0s
[13:51:45.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:147:0)
[13:51:45.418] Timer tick, asking Buildbucket for the build status
[13:51:45.776] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:45.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:148:0) after 1m0s
[13:52:45.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:148:0)
[13:52:45.833] Timer tick, asking Buildbucket for the build status
[13:52:46.191] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:46.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:149:0) after 1m0s
[13:53:46.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:149:0)
[13:53:46.170] Timer tick, asking Buildbucket for the build status
[13:53:46.410] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:46.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:150:0) after 1m0s
[13:54:46.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:150:0)
[13:54:46.496] Timer tick, asking Buildbucket for the build status
[13:54:46.573] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:46.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:151:0) after 1m0s
[13:55:46.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:151:0)
[13:55:46.629] Timer tick, asking Buildbucket for the build status
[13:55:46.840] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:152:0) after 1m0s
[13:56:46.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:152:0)
[13:56:46.901] Timer tick, asking Buildbucket for the build status
[13:56:47.143] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:47.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:153:0) after 1m0s
[13:57:47.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:153:0)
[13:57:47.322] Timer tick, asking Buildbucket for the build status
[13:57:47.405] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:47.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:154:0) after 1m0s
[13:58:47.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:154:0)
[13:58:47.766] Timer tick, asking Buildbucket for the build status
[13:58:47.836] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:155:0) after 1m0s
[13:59:47.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:155:0)
[13:59:47.898] Timer tick, asking Buildbucket for the build status
[13:59:48.027] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:48.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:156:0) after 1m0s
[14:00:48.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:156:0)
[14:00:48.193] Timer tick, asking Buildbucket for the build status
[14:00:48.269] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:48.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:157:0) after 1m0s
[14:01:48.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:157:0)
[14:01:48.473] Timer tick, asking Buildbucket for the build status
[14:01:49.142] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:49.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:158:0) after 1m0s
[14:02:49.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:158:0)
[14:02:49.261] Timer tick, asking Buildbucket for the build status
[14:02:49.509] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:49.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:159:0) after 1m0s
[14:03:49.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:159:0)
[14:03:49.543] Timer tick, asking Buildbucket for the build status
[14:03:49.727] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:49.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:160:0) after 1m0s
[14:04:49.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:160:0)
[14:04:49.756] Timer tick, asking Buildbucket for the build status
[14:04:49.936] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:49.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:161:0) after 1m0s
[14:05:49.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:161:0)
[14:05:49.959] Timer tick, asking Buildbucket for the build status
[14:05:50.059] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:50.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:162:0) after 1m0s
[14:06:50.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:162:0)
[14:06:50.085] Timer tick, asking Buildbucket for the build status
[14:06:50.423] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:50.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:163:0) after 1m0s
[14:07:50.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:163:0)
[14:07:50.457] Timer tick, asking Buildbucket for the build status
[14:07:51.013] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:51.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:164:0) after 1m0s
[14:08:51.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:164:0)
[14:08:51.083] Timer tick, asking Buildbucket for the build status
[14:08:51.159] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:51.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:165:0) after 1m0s
[14:09:51.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:165:0)
[14:09:51.190] Timer tick, asking Buildbucket for the build status
[14:09:51.378] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:51.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:166:0) after 1m0s
[14:10:51.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:166:0)
[14:10:51.440] Timer tick, asking Buildbucket for the build status
[14:10:51.511] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:51.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:167:0) after 1m0s
[14:11:51.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:167:0)
[14:11:51.536] Timer tick, asking Buildbucket for the build status
[14:11:51.696] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:51.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:168:0) after 1m0s
[14:12:51.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:168:0)
[14:12:51.718] Timer tick, asking Buildbucket for the build status
[14:12:51.791] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:51.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:169:0) after 1m0s
[14:13:51.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:169:0)
[14:13:51.839] Timer tick, asking Buildbucket for the build status
[14:13:51.950] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:51.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:170:0) after 1m0s
[14:14:51.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:170:0)
[14:14:51.979] Timer tick, asking Buildbucket for the build status
[14:14:52.092] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:52.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:171:0) after 1m0s
[14:15:52.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:171:0)
[14:15:52.145] Timer tick, asking Buildbucket for the build status
[14:15:52.235] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:52.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:172:0) after 1m0s
[14:16:52.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:172:0)
[14:16:52.298] Timer tick, asking Buildbucket for the build status
[14:16:52.845] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:52.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:173:0) after 1m0s
[14:17:52.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:173:0)
[14:17:52.923] Timer tick, asking Buildbucket for the build status
[14:17:53.008] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:53.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:174:0) after 1m0s
[14:18:53.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:174:0)
[14:18:53.041] Timer tick, asking Buildbucket for the build status
[14:18:53.221] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:175:0) after 1m0s
[14:19:53.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:175:0)
[14:19:53.538] Timer tick, asking Buildbucket for the build status
[14:19:53.849] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:53.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:176:0) after 1m0s
[14:20:53.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:176:0)
[14:20:53.975] Timer tick, asking Buildbucket for the build status
[14:20:54.152] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:54.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:177:0) after 1m0s
[14:21:54.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:177:0)
[14:21:54.168] Timer tick, asking Buildbucket for the build status
[14:21:54.388] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:54.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:178:0) after 1m0s
[14:22:55.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:178:0)
[14:22:55.505] Timer tick, asking Buildbucket for the build status
[14:22:55.572] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:55.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:179:0) after 1m0s
[14:23:55.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:179:0)
[14:23:55.734] Timer tick, asking Buildbucket for the build status
[14:23:56.121] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:56.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:180:0) after 1m0s
[14:24:56.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:180:0)
[14:24:56.223] Timer tick, asking Buildbucket for the build status
[14:24:56.330] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:56.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:181:0) after 1m0s
[14:25:56.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:181:0)
[14:25:56.435] Timer tick, asking Buildbucket for the build status
[14:25:56.533] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:56.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:182:0) after 1m0s
[14:26:56.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:182:0)
[14:26:56.540] Timer tick, asking Buildbucket for the build status
[14:26:57.043] Build 8872265641675904368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:57.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037695703686710512:183:0) after 1m0s
[14:27:27.557] Received PubSub notification, asking Buildbucket for the build status
[14:27:27.649] Build 8872265641675904368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:27:27.649] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597156046244331",
    "created_by": "project:infra",
    "created_ts": "1597145151408720",
    "id": "8872265641675904368",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4230.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"444dc443-1799-4d13-bc62-2cdeb705abeb\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4230.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_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-infra-cron-xenial-large-0-lzpi\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5480-a98aa12\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597145153128660",
    "status": "COMPLETED",
    "status_changed_ts": "1597156046780741",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037695703686710512",
      "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/8872265641675904368/+/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:4df616831ee59f10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597156046879733",
    "url": "https://ci.chromium.org/b/8872265641675904368",
    "utcnow_ts": "1597156047637925"
  }
}
[14:27:27.650] Invocation finished in 3h1m37.543937859s with status SUCCEEDED