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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:56:20.953] New invocation is queued and will start shortly
[07:56:20.953] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:56:22.101] Starting the invocation (attempt 1)
[07:56:22.149] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:56:22.154] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:56:22.154] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9037255898585254592",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4235.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"792d7916-80b4-4464-aced-923c1f64a0cd\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4235.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:9037255898585254592",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:56:22.799] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597564582248146",
    "id": "8871825836563305984",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4235.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"792d7916-80b4-4464-aced-923c1f64a0cd\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4235.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597564582541829",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037255898585254592",
      "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/8871825836563305984/+/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": "1597564582542027",
    "url": "https://ci.chromium.org/b/8871825836563305984",
    "utcnow_ts": "1597564582784355"
  }
}
[07:56:22.799] Task URL: https://ci.chromium.org/b/8871825836563305984
[07:56:22.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:2:0) after 1m0s
[07:56:55.392] Received PubSub notification, asking Buildbucket for the build status
[07:56:55.464] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:22.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:2:0)
[07:57:22.930] Timer tick, asking Buildbucket for the build status
[07:57:23.045] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:23.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:4:0) after 1m0s
[07:58:23.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:4:0)
[07:58:23.215] Timer tick, asking Buildbucket for the build status
[07:58:23.366] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:23.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:5:0) after 1m0s
[07:59:23.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:5:0)
[07:59:23.437] Timer tick, asking Buildbucket for the build status
[07:59:23.817] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:23.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:6:0) after 1m0s
[08:00:23.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:6:0)
[08:00:23.945] Timer tick, asking Buildbucket for the build status
[08:00:24.230] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:24.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:7:0) after 1m0s
[08:01:24.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:7:0)
[08:01:24.331] Timer tick, asking Buildbucket for the build status
[08:01:24.455] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:24.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:8:0) after 1m0s
[08:02:24.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:8:0)
[08:02:24.532] Timer tick, asking Buildbucket for the build status
[08:02:24.871] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:24.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:9:0) after 1m0s
[08:03:25.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:9:0)
[08:03:25.004] Timer tick, asking Buildbucket for the build status
[08:03:25.245] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:25.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:10:0) after 1m0s
[08:04:25.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:10:0)
[08:04:25.469] Timer tick, asking Buildbucket for the build status
[08:04:25.569] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:25.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:11:0) after 1m0s
[08:05:25.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:11:0)
[08:05:25.692] Timer tick, asking Buildbucket for the build status
[08:05:25.782] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:25.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:12:0) after 1m0s
[08:06:25.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:12:0)
[08:06:25.951] Timer tick, asking Buildbucket for the build status
[08:06:26.127] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:26.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:13:0) after 1m0s
[08:07:26.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:13:0)
[08:07:26.214] Timer tick, asking Buildbucket for the build status
[08:07:26.273] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:26.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:14:0) after 1m0s
[08:08:26.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:14:0)
[08:08:26.309] Timer tick, asking Buildbucket for the build status
[08:08:26.642] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:26.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:15:0) after 1m0s
[08:09:26.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:15:0)
[08:09:26.654] Timer tick, asking Buildbucket for the build status
[08:09:26.739] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:26.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:16:0) after 1m0s
[08:10:26.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:16:0)
[08:10:26.767] Timer tick, asking Buildbucket for the build status
[08:10:26.907] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:26.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:17:0) after 1m0s
[08:11:26.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:17:0)
[08:11:26.937] Timer tick, asking Buildbucket for the build status
[08:11:27.068] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:27.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:18:0) after 1m0s
[08:12:27.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:18:0)
[08:12:27.108] Timer tick, asking Buildbucket for the build status
[08:12:27.251] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:27.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:19:0) after 1m0s
[08:13:27.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:19:0)
[08:13:27.315] Timer tick, asking Buildbucket for the build status
[08:13:27.542] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:27.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:20:0) after 1m0s
[08:14:27.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:20:0)
[08:14:27.602] Timer tick, asking Buildbucket for the build status
[08:14:27.692] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:27.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:21:0) after 1m0s
[08:15:27.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:21:0)
[08:15:27.861] Timer tick, asking Buildbucket for the build status
[08:15:27.952] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:27.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:22:0) after 1m0s
[08:16:28.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:22:0)
[08:16:28.017] Timer tick, asking Buildbucket for the build status
[08:16:28.611] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:28.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:23:0) after 1m0s
[08:17:28.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:23:0)
[08:17:28.744] Timer tick, asking Buildbucket for the build status
[08:17:28.839] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:28.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:24:0) after 1m0s
[08:18:28.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:24:0)
[08:18:28.823] Timer tick, asking Buildbucket for the build status
[08:18:28.948] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:28.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:25:0) after 1m0s
[08:19:29.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:25:0)
[08:19:29.024] Timer tick, asking Buildbucket for the build status
[08:19:29.222] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:29.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:26:0) after 1m0s
[08:20:29.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:26:0)
[08:20:29.271] Timer tick, asking Buildbucket for the build status
[08:20:29.348] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:29.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:27:0) after 1m0s
[08:21:29.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:27:0)
[08:21:29.397] Timer tick, asking Buildbucket for the build status
[08:21:29.790] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:29.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:28:0) after 1m0s
[08:22:29.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:28:0)
[08:22:29.787] Timer tick, asking Buildbucket for the build status
[08:22:29.838] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:29.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:29:0) after 1m0s
[08:23:29.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:29:0)
[08:23:29.858] Timer tick, asking Buildbucket for the build status
[08:23:29.931] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:29.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:30:0) after 1m0s
[08:24:29.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:30:0)
[08:24:29.952] Timer tick, asking Buildbucket for the build status
[08:24:30.037] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:30.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:31:0) after 1m0s
[08:25:30.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:31:0)
[08:25:30.115] Timer tick, asking Buildbucket for the build status
[08:25:30.370] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:30.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:32:0) after 1m0s
[08:26:30.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:32:0)
[08:26:30.447] Timer tick, asking Buildbucket for the build status
[08:26:30.783] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:30.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:33:0) after 1m0s
[08:27:30.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:33:0)
[08:27:30.814] Timer tick, asking Buildbucket for the build status
[08:27:30.888] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:30.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:34:0) after 1m0s
[08:28:30.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:34:0)
[08:28:30.939] Timer tick, asking Buildbucket for the build status
[08:28:31.129] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:31.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:35:0) after 1m0s
[08:29:31.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:35:0)
[08:29:31.139] Timer tick, asking Buildbucket for the build status
[08:29:31.231] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:31.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:36:0) after 1m0s
[08:30:31.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:36:0)
[08:30:31.257] Timer tick, asking Buildbucket for the build status
[08:30:31.315] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:31.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:37:0) after 1m0s
[08:31:31.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:37:0)
[08:31:31.344] Timer tick, asking Buildbucket for the build status
[08:31:31.676] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:31.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:38:0) after 1m0s
[08:32:31.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:38:0)
[08:32:31.750] Timer tick, asking Buildbucket for the build status
[08:32:32.014] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:32.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:39:0) after 1m0s
[08:33:31.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:39:0)
[08:33:31.999] Timer tick, asking Buildbucket for the build status
[08:33:32.092] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:32.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:40:0) after 1m0s
[08:34:32.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:40:0)
[08:34:32.168] Timer tick, asking Buildbucket for the build status
[08:34:32.266] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:32.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:41:0) after 1m0s
[08:35:32.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:41:0)
[08:35:32.311] Timer tick, asking Buildbucket for the build status
[08:35:32.416] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:32.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:42:0) after 1m0s
[08:36:32.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:42:0)
[08:36:32.445] Timer tick, asking Buildbucket for the build status
[08:36:32.898] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:32.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:43:0) after 1m0s
[08:37:32.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:43:0)
[08:37:32.933] Timer tick, asking Buildbucket for the build status
[08:37:33.095] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:33.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:44:0) after 1m0s
[08:38:33.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:44:0)
[08:38:33.137] Timer tick, asking Buildbucket for the build status
[08:38:33.433] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:33.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:45:0) after 1m0s
[08:39:33.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:45:0)
[08:39:33.477] Timer tick, asking Buildbucket for the build status
[08:39:33.551] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:33.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:46:0) after 1m0s
[08:40:33.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:46:0)
[08:40:33.619] Timer tick, asking Buildbucket for the build status
[08:40:33.686] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:33.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:47:0) after 1m0s
[08:41:33.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:47:0)
[08:41:33.707] Timer tick, asking Buildbucket for the build status
[08:41:33.833] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:33.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:48:0) after 1m0s
[08:42:33.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:48:0)
[08:42:33.922] Timer tick, asking Buildbucket for the build status
[08:42:33.981] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:33.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:49:0) after 1m0s
[08:43:34.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:49:0)
[08:43:34.045] Timer tick, asking Buildbucket for the build status
[08:43:34.403] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:34.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:50:0) after 1m0s
[08:44:34.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:50:0)
[08:44:34.467] Timer tick, asking Buildbucket for the build status
[08:44:34.794] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:34.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:51:0) after 1m0s
[08:45:34.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:51:0)
[08:45:34.819] Timer tick, asking Buildbucket for the build status
[08:45:35.099] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:35.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:52:0) after 1m0s
[08:46:35.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:52:0)
[08:46:35.123] Timer tick, asking Buildbucket for the build status
[08:46:35.257] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:35.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:53:0) after 1m0s
[08:47:35.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:53:0)
[08:47:35.344] Timer tick, asking Buildbucket for the build status
[08:47:35.413] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:35.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:54:0) after 1m0s
[08:48:35.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:54:0)
[08:48:35.453] Timer tick, asking Buildbucket for the build status
[08:48:35.553] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:35.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:55:0) after 1m0s
[08:49:35.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:55:0)
[08:49:35.648] Timer tick, asking Buildbucket for the build status
[08:49:35.896] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:35.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:56:0) after 1m0s
[08:50:36.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:56:0)
[08:50:36.021] Timer tick, asking Buildbucket for the build status
[08:50:36.235] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:36.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:57:0) after 1m0s
[08:51:36.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:57:0)
[08:51:36.285] Timer tick, asking Buildbucket for the build status
[08:51:36.491] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:36.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:58:0) after 1m0s
[08:52:36.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:58:0)
[08:52:36.620] Timer tick, asking Buildbucket for the build status
[08:52:36.683] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:36.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:59:0) after 1m0s
[08:53:36.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:59:0)
[08:53:36.700] Timer tick, asking Buildbucket for the build status
[08:53:36.794] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:36.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:60:0) after 1m0s
[08:54:36.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:60:0)
[08:54:36.819] Timer tick, asking Buildbucket for the build status
[08:54:36.940] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:36.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:61:0) after 1m0s
[08:55:37.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:61:0)
[08:55:37.059] Timer tick, asking Buildbucket for the build status
[08:55:37.440] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:37.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:62:0) after 1m0s
[08:56:37.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:62:0)
[08:56:37.464] Timer tick, asking Buildbucket for the build status
[08:56:37.584] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:37.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:63:0) after 1m0s
[08:57:37.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:63:0)
[08:57:37.607] Timer tick, asking Buildbucket for the build status
[08:57:37.699] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:37.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:64:0) after 1m0s
[08:58:37.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:64:0)
[08:58:37.817] Timer tick, asking Buildbucket for the build status
[08:58:37.926] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:37.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:65:0) after 1m0s
[08:59:38.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:65:0)
[08:59:38.023] Timer tick, asking Buildbucket for the build status
[08:59:38.081] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:38.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:66:0) after 1m0s
[09:00:38.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:66:0)
[09:00:38.124] Timer tick, asking Buildbucket for the build status
[09:00:38.202] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:38.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:67:0) after 1m0s
[09:01:38.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:67:0)
[09:01:38.306] Timer tick, asking Buildbucket for the build status
[09:01:38.628] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:38.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:68:0) after 1m0s
[09:02:38.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:68:0)
[09:02:38.647] Timer tick, asking Buildbucket for the build status
[09:02:38.733] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:38.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:69:0) after 1m0s
[09:03:38.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:69:0)
[09:03:38.862] Timer tick, asking Buildbucket for the build status
[09:03:38.943] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:38.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:70:0) after 1m0s
[09:04:38.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:70:0)
[09:04:38.966] Timer tick, asking Buildbucket for the build status
[09:04:39.037] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:39.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:71:0) after 1m0s
[09:05:40.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:71:0)
[09:05:40.045] Timer tick, asking Buildbucket for the build status
[09:05:40.356] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:40.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:72:0) after 1m0s
[09:06:40.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:72:0)
[09:06:40.962] Timer tick, asking Buildbucket for the build status
[09:06:41.439] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:41.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:73:0) after 1m0s
[09:07:41.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:73:0)
[09:07:41.586] Timer tick, asking Buildbucket for the build status
[09:07:41.718] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:41.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:74:0) after 1m0s
[09:08:41.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:74:0)
[09:08:41.828] Timer tick, asking Buildbucket for the build status
[09:08:41.906] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:75:0) after 1m0s
[09:09:42.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:75:0)
[09:09:42.055] Timer tick, asking Buildbucket for the build status
[09:09:42.168] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:42.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:76:0) after 1m0s
[09:10:42.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:76:0)
[09:10:42.309] Timer tick, asking Buildbucket for the build status
[09:10:42.394] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:42.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:77:0) after 1m0s
[09:11:42.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:77:0)
[09:11:42.536] Timer tick, asking Buildbucket for the build status
[09:11:42.663] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:42.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:78:0) after 1m0s
[09:12:42.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:78:0)
[09:12:42.950] Timer tick, asking Buildbucket for the build status
[09:12:43.027] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:43.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:79:0) after 1m0s
[09:13:43.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:79:0)
[09:13:43.263] Timer tick, asking Buildbucket for the build status
[09:13:43.406] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:43.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:80:0) after 1m0s
[09:14:43.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:80:0)
[09:14:43.653] Timer tick, asking Buildbucket for the build status
[09:14:43.913] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:43.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:81:0) after 1m0s
[09:15:44.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:81:0)
[09:15:44.096] Timer tick, asking Buildbucket for the build status
[09:15:44.167] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:82:0) after 1m0s
[09:16:44.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:82:0)
[09:16:44.450] Timer tick, asking Buildbucket for the build status
[09:16:44.608] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:83:0) after 1m0s
[09:17:44.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:83:0)
[09:17:44.657] Timer tick, asking Buildbucket for the build status
[09:17:44.736] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:44.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:84:0) after 1m0s
[09:18:45.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:84:0)
[09:18:45.036] Timer tick, asking Buildbucket for the build status
[09:18:45.319] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:85:0) after 1m0s
[09:19:45.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:85:0)
[09:19:45.323] Timer tick, asking Buildbucket for the build status
[09:19:45.395] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:45.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:86:0) after 1m0s
[09:20:45.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:86:0)
[09:20:45.472] Timer tick, asking Buildbucket for the build status
[09:20:45.619] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:45.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:87:0) after 1m0s
[09:21:45.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:87:0)
[09:21:45.720] Timer tick, asking Buildbucket for the build status
[09:21:45.829] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:45.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:88:0) after 1m0s
[09:22:46.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:88:0)
[09:22:46.078] Timer tick, asking Buildbucket for the build status
[09:22:46.245] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:46.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:89:0) after 1m0s
[09:23:46.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:89:0)
[09:23:46.576] Timer tick, asking Buildbucket for the build status
[09:23:46.665] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:46.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:90:0) after 1m0s
[09:24:46.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:90:0)
[09:24:46.842] Timer tick, asking Buildbucket for the build status
[09:24:46.967] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:91:0) after 1m0s
[09:25:47.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:91:0)
[09:25:47.498] Timer tick, asking Buildbucket for the build status
[09:25:47.561] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:47.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:92:0) after 1m0s
[09:26:49.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:92:0)
[09:26:49.273] Timer tick, asking Buildbucket for the build status
[09:26:49.432] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:49.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:93:0) after 1m0s
[09:27:49.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:93:0)
[09:27:49.753] Timer tick, asking Buildbucket for the build status
[09:27:49.942] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:49.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:94:0) after 1m0s
[09:28:50.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:94:0)
[09:28:50.025] Timer tick, asking Buildbucket for the build status
[09:28:50.113] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:50.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:95:0) after 1m0s
[09:29:50.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:95:0)
[09:29:50.152] Timer tick, asking Buildbucket for the build status
[09:29:50.416] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:50.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:96:0) after 1m0s
[09:30:50.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:96:0)
[09:30:50.530] Timer tick, asking Buildbucket for the build status
[09:30:50.705] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:50.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:97:0) after 1m0s
[09:31:50.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:97:0)
[09:31:50.791] Timer tick, asking Buildbucket for the build status
[09:31:50.942] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:50.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:98:0) after 1m0s
[09:32:51.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:98:0)
[09:32:51.017] Timer tick, asking Buildbucket for the build status
[09:32:51.287] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:51.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:99:0) after 1m0s
[09:33:51.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:99:0)
[09:33:51.393] Timer tick, asking Buildbucket for the build status
[09:33:51.459] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:51.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:100:0) after 1m0s
[09:34:51.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:100:0)
[09:34:51.654] Timer tick, asking Buildbucket for the build status
[09:34:51.724] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:51.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:101:0) after 1m0s
[09:35:51.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:101:0)
[09:35:51.813] Timer tick, asking Buildbucket for the build status
[09:35:52.013] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:52.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:102:0) after 1m0s
[09:36:52.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:102:0)
[09:36:52.089] Timer tick, asking Buildbucket for the build status
[09:36:52.259] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:52.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:103:0) after 1m0s
[09:37:52.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:103:0)
[09:37:52.419] Timer tick, asking Buildbucket for the build status
[09:37:52.489] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:52.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:104:0) after 1m0s
[09:38:52.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:104:0)
[09:38:52.530] Timer tick, asking Buildbucket for the build status
[09:38:52.618] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:52.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:105:0) after 1m0s
[09:39:52.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:105:0)
[09:39:52.822] Timer tick, asking Buildbucket for the build status
[09:39:52.891] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:52.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:106:0) after 1m0s
[09:40:52.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:106:0)
[09:40:52.980] Timer tick, asking Buildbucket for the build status
[09:40:53.078] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:53.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:107:0) after 1m0s
[09:41:53.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:107:0)
[09:41:53.209] Timer tick, asking Buildbucket for the build status
[09:41:53.541] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:53.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:108:0) after 1m0s
[09:42:53.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:108:0)
[09:42:53.635] Timer tick, asking Buildbucket for the build status
[09:42:53.738] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:53.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:109:0) after 1m0s
[09:43:53.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:109:0)
[09:43:53.845] Timer tick, asking Buildbucket for the build status
[09:43:53.917] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:53.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:110:0) after 1m0s
[09:44:54.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:110:0)
[09:44:54.176] Timer tick, asking Buildbucket for the build status
[09:44:54.248] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:54.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:111:0) after 1m0s
[09:45:54.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:111:0)
[09:45:54.414] Timer tick, asking Buildbucket for the build status
[09:45:54.697] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:112:0) after 1m0s
[09:46:54.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:112:0)
[09:46:54.717] Timer tick, asking Buildbucket for the build status
[09:46:54.827] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:54.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:113:0) after 1m0s
[09:47:54.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:113:0)
[09:47:54.899] Timer tick, asking Buildbucket for the build status
[09:47:55.009] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:55.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:114:0) after 1m0s
[09:48:55.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:114:0)
[09:48:55.038] Timer tick, asking Buildbucket for the build status
[09:48:55.158] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:55.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:115:0) after 1m0s
[09:49:55.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:115:0)
[09:49:55.209] Timer tick, asking Buildbucket for the build status
[09:49:55.301] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:55.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:116:0) after 1m0s
[09:50:55.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:116:0)
[09:50:55.337] Timer tick, asking Buildbucket for the build status
[09:50:55.406] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:55.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:117:0) after 1m0s
[09:51:55.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:117:0)
[09:51:55.420] Timer tick, asking Buildbucket for the build status
[09:51:55.685] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:55.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:118:0) after 1m0s
[09:52:55.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:118:0)
[09:52:55.718] Timer tick, asking Buildbucket for the build status
[09:52:55.804] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:55.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:119:0) after 1m0s
[09:53:55.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:119:0)
[09:53:55.833] Timer tick, asking Buildbucket for the build status
[09:53:56.013] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:56.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:120:0) after 1m0s
[09:54:56.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:120:0)
[09:54:56.037] Timer tick, asking Buildbucket for the build status
[09:54:56.123] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:56.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:121:0) after 1m0s
[09:55:56.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:121:0)
[09:55:56.247] Timer tick, asking Buildbucket for the build status
[09:55:56.323] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:122:0) after 1m0s
[09:56:56.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:122:0)
[09:56:56.460] Timer tick, asking Buildbucket for the build status
[09:56:56.608] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:56.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:123:0) after 1m0s
[09:57:56.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:123:0)
[09:57:56.636] Timer tick, asking Buildbucket for the build status
[09:57:56.821] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:56.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:124:0) after 1m0s
[09:58:56.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:124:0)
[09:58:56.906] Timer tick, asking Buildbucket for the build status
[09:58:56.980] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:56.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:125:0) after 1m0s
[09:59:57.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:125:0)
[09:59:57.005] Timer tick, asking Buildbucket for the build status
[09:59:57.085] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:57.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:126:0) after 1m0s
[10:00:57.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:126:0)
[10:00:57.143] Timer tick, asking Buildbucket for the build status
[10:00:57.208] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:57.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:127:0) after 1m0s
[10:01:57.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:127:0)
[10:01:57.301] Timer tick, asking Buildbucket for the build status
[10:01:57.448] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:57.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:128:0) after 1m0s
[10:02:57.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:128:0)
[10:02:57.590] Timer tick, asking Buildbucket for the build status
[10:02:57.652] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:57.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:129:0) after 1m0s
[10:03:57.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:129:0)
[10:03:57.755] Timer tick, asking Buildbucket for the build status
[10:03:57.834] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:57.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:130:0) after 1m0s
[10:04:57.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:130:0)
[10:04:57.921] Timer tick, asking Buildbucket for the build status
[10:04:57.978] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:57.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:131:0) after 1m0s
[10:05:58.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:131:0)
[10:05:58.018] Timer tick, asking Buildbucket for the build status
[10:05:58.088] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:58.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:132:0) after 1m0s
[10:06:58.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:132:0)
[10:06:58.121] Timer tick, asking Buildbucket for the build status
[10:06:58.279] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:58.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:133:0) after 1m0s
[10:07:58.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:133:0)
[10:07:58.301] Timer tick, asking Buildbucket for the build status
[10:07:58.379] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:58.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:134:0) after 1m0s
[10:08:58.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:134:0)
[10:08:58.421] Timer tick, asking Buildbucket for the build status
[10:08:58.507] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:58.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:135:0) after 1m0s
[10:09:58.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:135:0)
[10:09:58.552] Timer tick, asking Buildbucket for the build status
[10:09:58.659] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:58.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:136:0) after 1m0s
[10:10:58.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:136:0)
[10:10:58.773] Timer tick, asking Buildbucket for the build status
[10:10:59.107] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:59.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:137:0) after 1m0s
[10:11:59.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:137:0)
[10:11:59.238] Timer tick, asking Buildbucket for the build status
[10:11:59.410] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:59.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:138:0) after 1m0s
[10:12:59.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:138:0)
[10:12:59.499] Timer tick, asking Buildbucket for the build status
[10:12:59.559] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:59.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:139:0) after 1m0s
[10:13:59.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:139:0)
[10:13:59.595] Timer tick, asking Buildbucket for the build status
[10:13:59.701] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:59.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:140:0) after 1m0s
[10:14:59.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:140:0)
[10:14:59.733] Timer tick, asking Buildbucket for the build status
[10:14:59.808] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:59.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:141:0) after 1m0s
[10:15:59.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:141:0)
[10:15:59.844] Timer tick, asking Buildbucket for the build status
[10:15:59.910] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:59.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:142:0) after 1m0s
[10:16:59.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:142:0)
[10:16:59.937] Timer tick, asking Buildbucket for the build status
[10:17:00.213] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:00.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:143:0) after 1m0s
[10:18:01.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:143:0)
[10:18:01.177] Timer tick, asking Buildbucket for the build status
[10:18:01.285] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:01.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:144:0) after 1m0s
[10:19:01.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:144:0)
[10:19:01.348] Timer tick, asking Buildbucket for the build status
[10:19:01.627] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:01.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:145:0) after 1m0s
[10:20:01.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:145:0)
[10:20:01.960] Timer tick, asking Buildbucket for the build status
[10:20:02.038] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:02.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:146:0) after 1m0s
[10:21:02.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:146:0)
[10:21:02.095] Timer tick, asking Buildbucket for the build status
[10:21:02.347] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:02.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:147:0) after 1m0s
[10:22:02.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:147:0)
[10:22:02.374] Timer tick, asking Buildbucket for the build status
[10:22:02.686] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:02.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:148:0) after 1m0s
[10:23:02.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:148:0)
[10:23:02.712] Timer tick, asking Buildbucket for the build status
[10:23:02.804] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:02.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:149:0) after 1m0s
[10:24:02.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:149:0)
[10:24:02.820] Timer tick, asking Buildbucket for the build status
[10:24:03.177] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:03.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:150:0) after 1m0s
[10:25:03.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:150:0)
[10:25:03.206] Timer tick, asking Buildbucket for the build status
[10:25:03.287] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:03.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:151:0) after 1m0s
[10:26:03.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:151:0)
[10:26:03.341] Timer tick, asking Buildbucket for the build status
[10:26:03.428] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:03.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:152:0) after 1m0s
[10:27:03.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:152:0)
[10:27:03.557] Timer tick, asking Buildbucket for the build status
[10:27:03.691] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:03.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:153:0) after 1m0s
[10:28:03.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:153:0)
[10:28:03.763] Timer tick, asking Buildbucket for the build status
[10:28:03.825] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:03.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:154:0) after 1m0s
[10:29:03.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:154:0)
[10:29:03.912] Timer tick, asking Buildbucket for the build status
[10:29:03.978] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:03.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:155:0) after 1m0s
[10:30:04.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:155:0)
[10:30:04.047] Timer tick, asking Buildbucket for the build status
[10:30:04.344] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:04.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:156:0) after 1m0s
[10:31:04.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:156:0)
[10:31:04.489] Timer tick, asking Buildbucket for the build status
[10:31:05.682] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:05.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:157:0) after 1m0s
[10:32:05.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:157:0)
[10:32:05.746] Timer tick, asking Buildbucket for the build status
[10:32:06.295] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:158:0) after 1m0s
[10:33:06.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:158:0)
[10:33:06.319] Timer tick, asking Buildbucket for the build status
[10:33:06.487] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:06.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:159:0) after 1m0s
[10:34:06.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:159:0)
[10:34:06.550] Timer tick, asking Buildbucket for the build status
[10:34:06.650] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:06.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:160:0) after 1m0s
[10:35:06.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:160:0)
[10:35:06.793] Timer tick, asking Buildbucket for the build status
[10:35:07.034] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:07.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:161:0) after 1m0s
[10:36:07.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:161:0)
[10:36:07.149] Timer tick, asking Buildbucket for the build status
[10:36:07.214] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:07.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:162:0) after 1m0s
[10:37:07.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:162:0)
[10:37:07.242] Timer tick, asking Buildbucket for the build status
[10:37:07.697] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:07.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:163:0) after 1m0s
[10:38:07.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:163:0)
[10:38:07.733] Timer tick, asking Buildbucket for the build status
[10:38:07.821] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:07.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:164:0) after 1m0s
[10:39:07.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:164:0)
[10:39:07.893] Timer tick, asking Buildbucket for the build status
[10:39:07.991] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:07.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:165:0) after 1m0s
[10:40:08.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:165:0)
[10:40:08.079] Timer tick, asking Buildbucket for the build status
[10:40:08.148] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:08.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:166:0) after 1m0s
[10:41:08.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:166:0)
[10:41:08.221] Timer tick, asking Buildbucket for the build status
[10:41:08.291] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:08.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:167:0) after 1m0s
[10:42:08.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:167:0)
[10:42:08.337] Timer tick, asking Buildbucket for the build status
[10:42:08.642] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:08.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:168:0) after 1m0s
[10:43:08.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:168:0)
[10:43:08.698] Timer tick, asking Buildbucket for the build status
[10:43:08.787] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:08.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:169:0) after 1m0s
[10:44:08.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:169:0)
[10:44:08.814] Timer tick, asking Buildbucket for the build status
[10:44:09.041] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:09.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:170:0) after 1m0s
[10:45:09.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:170:0)
[10:45:09.089] Timer tick, asking Buildbucket for the build status
[10:45:09.172] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:09.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:171:0) after 1m0s
[10:46:09.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:171:0)
[10:46:09.184] Timer tick, asking Buildbucket for the build status
[10:46:09.245] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:09.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:172:0) after 1m0s
[10:47:09.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:172:0)
[10:47:09.292] Timer tick, asking Buildbucket for the build status
[10:47:09.730] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:09.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:173:0) after 1m0s
[10:48:09.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:173:0)
[10:48:09.769] Timer tick, asking Buildbucket for the build status
[10:48:09.913] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:09.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:174:0) after 1m0s
[10:49:09.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:174:0)
[10:49:09.946] Timer tick, asking Buildbucket for the build status
[10:49:10.113] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:10.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:175:0) after 1m0s
[10:50:10.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:175:0)
[10:50:10.166] Timer tick, asking Buildbucket for the build status
[10:50:10.429] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:10.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:176:0) after 1m0s
[10:51:10.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:176:0)
[10:51:10.498] Timer tick, asking Buildbucket for the build status
[10:51:10.597] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:10.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:177:0) after 1m0s
[10:52:10.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:177:0)
[10:52:10.629] Timer tick, asking Buildbucket for the build status
[10:52:11.226] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:11.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:178:0) after 1m0s
[10:53:11.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:178:0)
[10:53:11.253] Timer tick, asking Buildbucket for the build status
[10:53:11.725] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:11.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:179:0) after 1m0s
[10:54:11.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:179:0)
[10:54:11.816] Timer tick, asking Buildbucket for the build status
[10:54:11.903] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:11.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:180:0) after 1m0s
[10:55:11.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:180:0)
[10:55:11.934] Timer tick, asking Buildbucket for the build status
[10:55:12.033] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:12.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:181:0) after 1m0s
[10:56:12.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:181:0)
[10:56:12.071] Timer tick, asking Buildbucket for the build status
[10:56:12.245] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:12.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:182:0) after 1m0s
[10:57:12.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:182:0)
[10:57:12.270] Timer tick, asking Buildbucket for the build status
[10:57:12.372] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:12.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:183:0) after 1m0s
[10:58:12.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:183:0)
[10:58:12.528] Timer tick, asking Buildbucket for the build status
[10:58:12.688] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:12.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:184:0) after 1m0s
[10:59:12.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:184:0)
[10:59:12.730] Timer tick, asking Buildbucket for the build status
[10:59:12.935] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:12.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:185:0) after 1m0s
[11:00:12.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:185:0)
[11:00:12.976] Timer tick, asking Buildbucket for the build status
[11:00:13.100] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:13.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:186:0) after 1m0s
[11:01:13.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:186:0)
[11:01:13.179] Timer tick, asking Buildbucket for the build status
[11:01:13.423] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:13.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:187:0) after 1m0s
[11:02:13.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:187:0)
[11:02:13.462] Timer tick, asking Buildbucket for the build status
[11:02:13.616] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:13.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:188:0) after 1m0s
[11:03:13.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:188:0)
[11:03:13.647] Timer tick, asking Buildbucket for the build status
[11:03:13.840] Build 8871825836563305984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:13.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9037255898585254592:189:0) after 1m0s
[11:03:40.960] Received PubSub notification, asking Buildbucket for the build status
[11:03:41.045] Build 8871825836563305984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:03:41.045] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597575820055105",
    "created_by": "project:infra",
    "created_ts": "1597564582248146",
    "id": "8871825836563305984",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4235.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"792d7916-80b4-4464-aced-923c1f64a0cd\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4235.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-taw3\"], \"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": "1597564614317848",
    "status": "COMPLETED",
    "status_changed_ts": "1597575820432892",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9037255898585254592",
      "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/8871825836563305984/+/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:4e0f1685e968b910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597575820521273",
    "url": "https://ci.chromium.org/b/8871825836563305984",
    "utcnow_ts": "1597575821030952"
  }
}
[11:03:41.045] Invocation finished in 3h7m20.109324379s with status SUCCEEDED