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": "88.0.4285.3"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[13:22:21.865] New invocation is queued and will start shortly
[13:22:21.865] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[13:22:22.995] Starting the invocation (attempt 1)
[13:22:23.036] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:22:23.036] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:22:23.036] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9032433748262287488",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4285.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f7d644b1-3e18-4714-9c43-a27135c60f4a\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4285.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9032433748262287488",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[13:22:23.399] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1602163343145253",
    "id": "8867003686256842704",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4285.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f7d644b1-3e18-4714-9c43-a27135c60f4a\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4285.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1602163343283248",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9032433748262287488",
      "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/8867003686256842704/+/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": "1602163343283366",
    "url": "https://ci.chromium.org/b/8867003686256842704",
    "utcnow_ts": "1602163343391537"
  }
}
[13:22:23.399] Task URL: https://ci.chromium.org/b/8867003686256842704
[13:22:23.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:2:0) after 1m0s
[13:22:28.746] Received PubSub notification, asking Buildbucket for the build status
[13:22:28.864] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:23.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:2:0)
[13:23:23.505] Timer tick, asking Buildbucket for the build status
[13:23:23.627] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:23.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:4:0) after 1m0s
[13:24:23.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:4:0)
[13:24:23.685] Timer tick, asking Buildbucket for the build status
[13:24:24.082] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:24.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:5:0) after 1m0s
[13:25:24.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:5:0)
[13:25:24.209] Timer tick, asking Buildbucket for the build status
[13:25:24.419] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:24.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:6:0) after 1m0s
[13:26:24.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:6:0)
[13:26:24.474] Timer tick, asking Buildbucket for the build status
[13:26:24.547] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:24.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:7:0) after 1m0s
[13:27:24.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:7:0)
[13:27:24.549] Timer tick, asking Buildbucket for the build status
[13:27:24.678] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:24.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:8:0) after 1m0s
[13:28:24.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:8:0)
[13:28:24.773] Timer tick, asking Buildbucket for the build status
[13:28:24.897] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:24.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:9:0) after 1m0s
[13:29:24.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:9:0)
[13:29:24.913] Timer tick, asking Buildbucket for the build status
[13:29:24.969] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:24.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:10:0) after 1m0s
[13:30:25.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:10:0)
[13:30:25.032] Timer tick, asking Buildbucket for the build status
[13:30:25.107] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:25.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:11:0) after 1m0s
[13:31:25.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:11:0)
[13:31:25.111] Timer tick, asking Buildbucket for the build status
[13:31:25.180] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:25.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:12:0) after 1m0s
[13:32:25.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:12:0)
[13:32:25.256] Timer tick, asking Buildbucket for the build status
[13:32:25.365] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:25.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:13:0) after 1m0s
[13:33:25.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:13:0)
[13:33:25.427] Timer tick, asking Buildbucket for the build status
[13:33:25.506] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:25.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:14:0) after 1m0s
[13:34:25.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:14:0)
[13:34:25.511] Timer tick, asking Buildbucket for the build status
[13:34:25.574] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:25.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:15:0) after 1m0s
[13:35:25.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:15:0)
[13:35:25.657] Timer tick, asking Buildbucket for the build status
[13:35:25.725] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:25.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:16:0) after 1m0s
[13:36:25.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:16:0)
[13:36:25.801] Timer tick, asking Buildbucket for the build status
[13:36:25.952] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:25.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:17:0) after 1m0s
[13:37:25.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:17:0)
[13:37:25.999] Timer tick, asking Buildbucket for the build status
[13:37:26.108] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:26.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:18:0) after 1m0s
[13:38:26.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:18:0)
[13:38:26.133] Timer tick, asking Buildbucket for the build status
[13:38:26.307] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:26.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:19:0) after 1m0s
[13:39:26.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:19:0)
[13:39:26.488] Timer tick, asking Buildbucket for the build status
[13:39:26.551] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:26.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:20:0) after 1m0s
[13:40:26.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:20:0)
[13:40:26.785] Timer tick, asking Buildbucket for the build status
[13:40:26.847] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:26.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:21:0) after 1m0s
[13:41:27.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:21:0)
[13:41:27.055] Timer tick, asking Buildbucket for the build status
[13:41:27.112] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:27.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:22:0) after 1m0s
[13:42:27.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:22:0)
[13:42:27.169] Timer tick, asking Buildbucket for the build status
[13:42:27.309] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:27.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:23:0) after 1m0s
[13:43:27.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:23:0)
[13:43:27.402] Timer tick, asking Buildbucket for the build status
[13:43:27.472] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:27.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:24:0) after 1m0s
[13:44:27.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:24:0)
[13:44:27.574] Timer tick, asking Buildbucket for the build status
[13:44:27.656] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:27.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:25:0) after 1m0s
[13:45:27.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:25:0)
[13:45:27.789] Timer tick, asking Buildbucket for the build status
[13:45:27.857] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:27.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:26:0) after 1m0s
[13:46:28.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:26:0)
[13:46:28.117] Timer tick, asking Buildbucket for the build status
[13:46:28.249] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:28.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:27:0) after 1m0s
[13:47:28.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:27:0)
[13:47:28.298] Timer tick, asking Buildbucket for the build status
[13:47:28.421] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:28.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:28:0) after 1m0s
[13:48:28.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:28:0)
[13:48:28.589] Timer tick, asking Buildbucket for the build status
[13:48:28.662] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:28.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:29:0) after 1m0s
[13:49:28.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:29:0)
[13:49:28.723] Timer tick, asking Buildbucket for the build status
[13:49:28.781] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:28.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:30:0) after 1m0s
[13:50:29.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:30:0)
[13:50:29.055] Timer tick, asking Buildbucket for the build status
[13:50:29.202] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:29.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:31:0) after 1m0s
[13:51:29.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:31:0)
[13:51:29.337] Timer tick, asking Buildbucket for the build status
[13:51:29.408] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:29.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:32:0) after 1m0s
[13:52:29.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:32:0)
[13:52:29.446] Timer tick, asking Buildbucket for the build status
[13:52:29.528] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:29.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:33:0) after 1m0s
[13:53:29.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:33:0)
[13:53:29.566] Timer tick, asking Buildbucket for the build status
[13:53:29.712] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:29.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:34:0) after 1m0s
[13:54:29.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:34:0)
[13:54:29.754] Timer tick, asking Buildbucket for the build status
[13:54:29.818] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:29.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:35:0) after 1m0s
[13:55:29.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:35:0)
[13:55:29.999] Timer tick, asking Buildbucket for the build status
[13:55:30.058] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:30.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:36:0) after 1m0s
[13:56:30.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:36:0)
[13:56:30.094] Timer tick, asking Buildbucket for the build status
[13:56:30.403] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:30.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:37:0) after 1m0s
[13:57:30.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:37:0)
[13:57:30.437] Timer tick, asking Buildbucket for the build status
[13:57:30.587] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:30.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:38:0) after 1m0s
[13:58:30.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:38:0)
[13:58:30.635] Timer tick, asking Buildbucket for the build status
[13:58:30.705] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:30.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:39:0) after 1m0s
[13:59:31.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:39:0)
[13:59:31.419] Timer tick, asking Buildbucket for the build status
[13:59:31.534] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:31.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:40:0) after 1m0s
[14:00:31.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:40:0)
[14:00:31.591] Timer tick, asking Buildbucket for the build status
[14:00:31.897] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:31.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:41:0) after 1m0s
[14:01:31.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:41:0)
[14:01:31.930] Timer tick, asking Buildbucket for the build status
[14:01:32.000] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:32.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:42:0) after 1m0s
[14:02:32.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:42:0)
[14:02:32.106] Timer tick, asking Buildbucket for the build status
[14:02:32.596] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:32.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:43:0) after 1m0s
[14:03:32.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:43:0)
[14:03:32.741] Timer tick, asking Buildbucket for the build status
[14:03:32.833] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:32.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:44:0) after 1m0s
[14:04:32.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:44:0)
[14:04:32.864] Timer tick, asking Buildbucket for the build status
[14:04:32.935] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:32.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:45:0) after 1m0s
[14:05:32.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:45:0)
[14:05:32.967] Timer tick, asking Buildbucket for the build status
[14:05:33.147] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:33.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:46:0) after 1m0s
[14:06:33.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:46:0)
[14:06:33.206] Timer tick, asking Buildbucket for the build status
[14:06:33.487] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:33.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:47:0) after 1m0s
[14:07:33.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:47:0)
[14:07:33.543] Timer tick, asking Buildbucket for the build status
[14:07:33.642] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:33.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:48:0) after 1m0s
[14:08:33.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:48:0)
[14:08:33.741] Timer tick, asking Buildbucket for the build status
[14:08:33.805] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:33.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:49:0) after 1m0s
[14:09:33.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:49:0)
[14:09:33.966] Timer tick, asking Buildbucket for the build status
[14:09:34.222] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:34.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:50:0) after 1m0s
[14:10:34.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:50:0)
[14:10:34.284] Timer tick, asking Buildbucket for the build status
[14:10:34.339] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:34.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:51:0) after 1m0s
[14:11:34.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:51:0)
[14:11:34.389] Timer tick, asking Buildbucket for the build status
[14:11:34.577] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:34.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:52:0) after 1m0s
[14:12:34.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:52:0)
[14:12:34.706] Timer tick, asking Buildbucket for the build status
[14:12:35.010] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:35.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:53:0) after 1m0s
[14:13:35.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:53:0)
[14:13:35.157] Timer tick, asking Buildbucket for the build status
[14:13:35.234] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:35.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:54:0) after 1m0s
[14:14:35.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:54:0)
[14:14:35.314] Timer tick, asking Buildbucket for the build status
[14:14:35.387] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:35.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:55:0) after 1m0s
[14:15:35.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:55:0)
[14:15:35.382] Timer tick, asking Buildbucket for the build status
[14:15:35.458] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:35.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:56:0) after 1m0s
[14:16:35.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:56:0)
[14:16:35.578] Timer tick, asking Buildbucket for the build status
[14:16:35.637] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:35.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:57:0) after 1m0s
[14:17:35.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:57:0)
[14:17:35.644] Timer tick, asking Buildbucket for the build status
[14:17:35.735] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:35.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:58:0) after 1m0s
[14:18:35.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:58:0)
[14:18:35.780] Timer tick, asking Buildbucket for the build status
[14:18:35.846] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:35.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:59:0) after 1m0s
[14:19:35.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:59:0)
[14:19:35.906] Timer tick, asking Buildbucket for the build status
[14:19:36.126] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:36.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:60:0) after 1m0s
[14:20:36.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:60:0)
[14:20:36.140] Timer tick, asking Buildbucket for the build status
[14:20:36.201] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:36.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:61:0) after 1m0s
[14:21:36.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:61:0)
[14:21:36.521] Timer tick, asking Buildbucket for the build status
[14:21:36.574] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:36.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:62:0) after 1m0s
[14:22:36.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:62:0)
[14:22:36.641] Timer tick, asking Buildbucket for the build status
[14:22:36.814] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:36.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:63:0) after 1m0s
[14:23:37.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:63:0)
[14:23:37.004] Timer tick, asking Buildbucket for the build status
[14:23:37.058] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:37.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:64:0) after 1m0s
[14:24:37.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:64:0)
[14:24:37.250] Timer tick, asking Buildbucket for the build status
[14:24:37.409] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:37.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:65:0) after 1m0s
[14:25:37.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:65:0)
[14:25:37.487] Timer tick, asking Buildbucket for the build status
[14:25:37.546] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:37.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:66:0) after 1m0s
[14:26:37.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:66:0)
[14:26:37.595] Timer tick, asking Buildbucket for the build status
[14:26:38.429] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:38.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:67:0) after 1m0s
[14:27:38.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:67:0)
[14:27:38.615] Timer tick, asking Buildbucket for the build status
[14:27:38.719] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:38.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:68:0) after 1m0s
[14:28:38.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:68:0)
[14:28:38.842] Timer tick, asking Buildbucket for the build status
[14:28:39.022] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:39.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:69:0) after 1m0s
[14:29:39.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:69:0)
[14:29:39.088] Timer tick, asking Buildbucket for the build status
[14:29:39.146] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:39.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:70:0) after 1m0s
[14:30:39.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:70:0)
[14:30:39.228] Timer tick, asking Buildbucket for the build status
[14:30:39.329] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:39.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:71:0) after 1m0s
[14:31:39.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:71:0)
[14:31:39.439] Timer tick, asking Buildbucket for the build status
[14:31:39.522] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:39.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:72:0) after 1m0s
[14:32:39.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:72:0)
[14:32:39.623] Timer tick, asking Buildbucket for the build status
[14:32:39.995] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:39.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:73:0) after 1m0s
[14:33:40.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:73:0)
[14:33:40.031] Timer tick, asking Buildbucket for the build status
[14:33:40.094] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:40.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:74:0) after 1m0s
[14:34:40.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:74:0)
[14:34:40.134] Timer tick, asking Buildbucket for the build status
[14:34:40.199] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:40.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:75:0) after 1m0s
[14:35:40.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:75:0)
[14:35:40.305] Timer tick, asking Buildbucket for the build status
[14:35:40.365] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:40.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:76:0) after 1m0s
[14:36:40.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:76:0)
[14:36:40.409] Timer tick, asking Buildbucket for the build status
[14:36:40.511] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:40.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:77:0) after 1m0s
[14:37:40.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:77:0)
[14:37:40.537] Timer tick, asking Buildbucket for the build status
[14:37:40.661] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:40.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:78:0) after 1m0s
[14:38:42.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:78:0)
[14:38:42.892] Timer tick, asking Buildbucket for the build status
[14:38:42.969] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:42.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:79:0) after 1m0s
[14:39:43.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:79:0)
[14:39:43.036] Timer tick, asking Buildbucket for the build status
[14:39:43.136] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:43.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:80:0) after 1m0s
[14:40:43.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:80:0)
[14:40:43.163] Timer tick, asking Buildbucket for the build status
[14:40:43.216] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:43.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:81:0) after 1m0s
[14:41:43.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:81:0)
[14:41:43.223] Timer tick, asking Buildbucket for the build status
[14:41:43.412] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:43.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:82:0) after 1m0s
[14:42:43.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:82:0)
[14:42:43.443] Timer tick, asking Buildbucket for the build status
[14:42:43.679] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:43.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:83:0) after 1m0s
[14:43:43.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:83:0)
[14:43:43.700] Timer tick, asking Buildbucket for the build status
[14:43:43.768] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:43.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:84:0) after 1m0s
[14:44:43.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:84:0)
[14:44:43.790] Timer tick, asking Buildbucket for the build status
[14:44:43.879] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:43.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:85:0) after 1m0s
[14:45:44.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:85:0)
[14:45:44.102] Timer tick, asking Buildbucket for the build status
[14:45:44.284] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:44.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:86:0) after 1m0s
[14:46:44.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:86:0)
[14:46:44.470] Timer tick, asking Buildbucket for the build status
[14:46:44.572] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:44.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:87:0) after 1m0s
[14:47:44.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:87:0)
[14:47:44.655] Timer tick, asking Buildbucket for the build status
[14:47:44.798] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:44.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:88:0) after 1m0s
[14:48:44.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:88:0)
[14:48:44.971] Timer tick, asking Buildbucket for the build status
[14:48:45.362] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:45.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:89:0) after 1m0s
[14:49:45.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:89:0)
[14:49:45.442] Timer tick, asking Buildbucket for the build status
[14:49:45.506] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:45.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:90:0) after 1m0s
[14:50:45.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:90:0)
[14:50:45.566] Timer tick, asking Buildbucket for the build status
[14:50:45.633] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:45.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:91:0) after 1m0s
[14:51:45.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:91:0)
[14:51:45.655] Timer tick, asking Buildbucket for the build status
[14:51:45.801] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:45.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:92:0) after 1m0s
[14:52:46.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:92:0)
[14:52:46.009] Timer tick, asking Buildbucket for the build status
[14:52:46.579] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:46.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:93:0) after 1m0s
[14:53:46.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:93:0)
[14:53:46.595] Timer tick, asking Buildbucket for the build status
[14:53:46.650] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:46.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:94:0) after 1m0s
[14:54:46.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:94:0)
[14:54:46.696] Timer tick, asking Buildbucket for the build status
[14:54:47.024] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:47.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:95:0) after 1m0s
[14:55:47.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:95:0)
[14:55:47.037] Timer tick, asking Buildbucket for the build status
[14:55:47.439] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:47.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:96:0) after 1m0s
[14:56:47.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:96:0)
[14:56:47.495] Timer tick, asking Buildbucket for the build status
[14:56:47.575] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:47.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:97:0) after 1m0s
[14:57:47.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:97:0)
[14:57:47.679] Timer tick, asking Buildbucket for the build status
[14:57:48.066] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:48.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:98:0) after 1m0s
[14:58:48.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:98:0)
[14:58:48.098] Timer tick, asking Buildbucket for the build status
[14:58:48.161] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:48.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:99:0) after 1m0s
[14:59:48.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:99:0)
[14:59:48.279] Timer tick, asking Buildbucket for the build status
[14:59:48.346] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:48.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:100:0) after 1m0s
[15:00:48.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:100:0)
[15:00:48.479] Timer tick, asking Buildbucket for the build status
[15:00:48.553] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:48.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:101:0) after 1m0s
[15:01:48.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:101:0)
[15:01:48.575] Timer tick, asking Buildbucket for the build status
[15:01:48.760] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:48.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:102:0) after 1m0s
[15:02:48.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:102:0)
[15:02:48.927] Timer tick, asking Buildbucket for the build status
[15:02:49.045] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:49.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:103:0) after 1m0s
[15:03:49.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:103:0)
[15:03:49.116] Timer tick, asking Buildbucket for the build status
[15:03:49.195] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:49.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:104:0) after 1m0s
[15:04:49.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:104:0)
[15:04:49.182] Timer tick, asking Buildbucket for the build status
[15:04:49.518] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:49.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:105:0) after 1m0s
[15:05:49.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:105:0)
[15:05:49.542] Timer tick, asking Buildbucket for the build status
[15:05:49.610] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:49.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:106:0) after 1m0s
[15:06:49.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:106:0)
[15:06:49.620] Timer tick, asking Buildbucket for the build status
[15:06:49.693] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:49.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:107:0) after 1m0s
[15:07:49.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:107:0)
[15:07:49.737] Timer tick, asking Buildbucket for the build status
[15:07:49.839] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:49.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:108:0) after 1m0s
[15:08:49.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:108:0)
[15:08:49.878] Timer tick, asking Buildbucket for the build status
[15:08:49.973] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:49.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:109:0) after 1m0s
[15:09:50.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:109:0)
[15:09:50.042] Timer tick, asking Buildbucket for the build status
[15:09:50.395] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:50.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:110:0) after 1m0s
[15:10:50.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:110:0)
[15:10:50.512] Timer tick, asking Buildbucket for the build status
[15:10:50.690] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:50.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:111:0) after 1m0s
[15:11:50.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:111:0)
[15:11:50.759] Timer tick, asking Buildbucket for the build status
[15:11:50.826] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:50.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:112:0) after 1m0s
[15:12:50.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:112:0)
[15:12:50.901] Timer tick, asking Buildbucket for the build status
[15:12:51.022] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:51.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:113:0) after 1m0s
[15:13:51.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:113:0)
[15:13:51.094] Timer tick, asking Buildbucket for the build status
[15:13:51.189] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:51.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:114:0) after 1m0s
[15:14:51.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:114:0)
[15:14:51.237] Timer tick, asking Buildbucket for the build status
[15:14:51.309] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:51.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:115:0) after 1m0s
[15:15:51.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:115:0)
[15:15:51.361] Timer tick, asking Buildbucket for the build status
[15:15:51.591] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:51.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:116:0) after 1m0s
[15:16:51.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:116:0)
[15:16:51.654] Timer tick, asking Buildbucket for the build status
[15:16:51.861] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:51.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:117:0) after 1m0s
[15:17:51.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:117:0)
[15:17:51.920] Timer tick, asking Buildbucket for the build status
[15:17:52.050] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:52.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:118:0) after 1m0s
[15:18:52.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:118:0)
[15:18:52.131] Timer tick, asking Buildbucket for the build status
[15:18:52.992] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:52.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:119:0) after 1m0s
[15:19:53.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:119:0)
[15:19:53.128] Timer tick, asking Buildbucket for the build status
[15:19:53.219] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:53.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:120:0) after 1m0s
[15:20:53.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:120:0)
[15:20:53.284] Timer tick, asking Buildbucket for the build status
[15:20:53.444] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:53.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:121:0) after 1m0s
[15:21:53.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:121:0)
[15:21:53.531] Timer tick, asking Buildbucket for the build status
[15:21:53.605] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:53.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:122:0) after 1m0s
[15:22:53.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:122:0)
[15:22:53.609] Timer tick, asking Buildbucket for the build status
[15:22:53.710] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:53.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:123:0) after 1m0s
[15:23:53.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:123:0)
[15:23:53.723] Timer tick, asking Buildbucket for the build status
[15:23:53.783] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:53.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:124:0) after 1m0s
[15:24:53.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:124:0)
[15:24:53.859] Timer tick, asking Buildbucket for the build status
[15:24:54.091] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:54.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:125:0) after 1m0s
[15:25:54.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:125:0)
[15:25:54.233] Timer tick, asking Buildbucket for the build status
[15:25:54.301] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:54.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:126:0) after 1m0s
[15:26:54.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:126:0)
[15:26:54.333] Timer tick, asking Buildbucket for the build status
[15:26:55.480] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:55.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:127:0) after 1m0s
[15:27:55.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:127:0)
[15:27:55.535] Timer tick, asking Buildbucket for the build status
[15:27:55.618] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:55.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:128:0) after 1m0s
[15:28:55.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:128:0)
[15:28:55.690] Timer tick, asking Buildbucket for the build status
[15:28:55.768] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:55.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:129:0) after 1m0s
[15:29:55.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:129:0)
[15:29:55.802] Timer tick, asking Buildbucket for the build status
[15:29:55.858] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:55.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:130:0) after 1m0s
[15:30:55.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:130:0)
[15:30:55.922] Timer tick, asking Buildbucket for the build status
[15:30:55.985] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:55.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:131:0) after 1m0s
[15:31:56.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:131:0)
[15:31:56.056] Timer tick, asking Buildbucket for the build status
[15:31:56.122] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:56.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:132:0) after 1m0s
[15:32:56.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:132:0)
[15:32:56.194] Timer tick, asking Buildbucket for the build status
[15:32:56.363] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:56.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:133:0) after 1m0s
[15:33:56.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:133:0)
[15:33:56.410] Timer tick, asking Buildbucket for the build status
[15:33:56.473] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:56.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:134:0) after 1m0s
[15:34:57.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:134:0)
[15:34:57.153] Timer tick, asking Buildbucket for the build status
[15:34:57.218] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:57.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:135:0) after 1m0s
[15:35:57.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:135:0)
[15:35:57.279] Timer tick, asking Buildbucket for the build status
[15:35:57.525] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:57.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:136:0) after 1m0s
[15:36:57.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:136:0)
[15:36:57.517] Timer tick, asking Buildbucket for the build status
[15:36:57.593] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:57.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:137:0) after 1m0s
[15:37:57.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:137:0)
[15:37:57.666] Timer tick, asking Buildbucket for the build status
[15:37:57.774] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:57.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:138:0) after 1m0s
[15:38:57.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:138:0)
[15:38:57.822] Timer tick, asking Buildbucket for the build status
[15:38:57.932] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:57.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:139:0) after 1m0s
[15:39:57.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:139:0)
[15:39:57.940] Timer tick, asking Buildbucket for the build status
[15:39:58.018] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:58.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:140:0) after 1m0s
[15:40:58.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:140:0)
[15:40:58.076] Timer tick, asking Buildbucket for the build status
[15:40:58.147] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:58.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:141:0) after 1m0s
[15:41:58.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:141:0)
[15:41:58.174] Timer tick, asking Buildbucket for the build status
[15:41:58.244] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:58.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:142:0) after 1m0s
[15:42:58.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:142:0)
[15:42:58.292] Timer tick, asking Buildbucket for the build status
[15:42:58.898] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:58.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:143:0) after 1m0s
[15:43:58.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:143:0)
[15:43:58.929] Timer tick, asking Buildbucket for the build status
[15:43:59.042] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:59.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:144:0) after 1m0s
[15:44:59.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:144:0)
[15:44:59.137] Timer tick, asking Buildbucket for the build status
[15:44:59.226] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:59.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:145:0) after 1m0s
[15:45:59.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:145:0)
[15:45:59.336] Timer tick, asking Buildbucket for the build status
[15:45:59.411] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:59.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:146:0) after 1m0s
[15:46:59.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:146:0)
[15:46:59.461] Timer tick, asking Buildbucket for the build status
[15:46:59.520] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:59.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:147:0) after 1m0s
[15:47:59.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:147:0)
[15:47:59.604] Timer tick, asking Buildbucket for the build status
[15:47:59.727] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:59.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:148:0) after 1m0s
[15:48:59.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:148:0)
[15:48:59.752] Timer tick, asking Buildbucket for the build status
[15:48:59.872] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:59.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:149:0) after 1m0s
[15:49:59.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:149:0)
[15:49:59.895] Timer tick, asking Buildbucket for the build status
[15:49:59.966] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:59.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:150:0) after 1m0s
[15:51:00.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:150:0)
[15:51:00.028] Timer tick, asking Buildbucket for the build status
[15:51:00.344] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:00.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:151:0) after 1m0s
[15:52:00.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:151:0)
[15:52:00.377] Timer tick, asking Buildbucket for the build status
[15:52:00.534] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:00.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:152:0) after 1m0s
[15:53:00.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:152:0)
[15:53:00.605] Timer tick, asking Buildbucket for the build status
[15:53:00.709] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:00.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:153:0) after 1m0s
[15:54:00.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:153:0)
[15:54:00.846] Timer tick, asking Buildbucket for the build status
[15:54:00.916] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:00.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:154:0) after 1m0s
[15:55:01.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:154:0)
[15:55:01.587] Timer tick, asking Buildbucket for the build status
[15:55:01.650] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:01.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:155:0) after 1m0s
[15:56:02.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:155:0)
[15:56:02.188] Timer tick, asking Buildbucket for the build status
[15:56:02.258] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:02.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:156:0) after 1m0s
[15:57:02.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:156:0)
[15:57:02.298] Timer tick, asking Buildbucket for the build status
[15:57:02.361] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:02.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:157:0) after 1m0s
[15:58:02.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:157:0)
[15:58:02.386] Timer tick, asking Buildbucket for the build status
[15:58:02.503] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:02.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:158:0) after 1m0s
[15:59:03.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:158:0)
[15:59:03.361] Timer tick, asking Buildbucket for the build status
[15:59:03.444] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:03.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:159:0) after 1m0s
[16:00:03.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:159:0)
[16:00:03.559] Timer tick, asking Buildbucket for the build status
[16:00:03.630] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:03.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:160:0) after 1m0s
[16:01:03.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:160:0)
[16:01:03.714] Timer tick, asking Buildbucket for the build status
[16:01:04.026] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:04.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:161:0) after 1m0s
[16:02:04.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:161:0)
[16:02:04.110] Timer tick, asking Buildbucket for the build status
[16:02:04.200] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:04.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:162:0) after 1m0s
[16:03:04.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:162:0)
[16:03:04.343] Timer tick, asking Buildbucket for the build status
[16:03:04.556] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:04.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:163:0) after 1m0s
[16:04:04.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:163:0)
[16:04:04.626] Timer tick, asking Buildbucket for the build status
[16:04:04.699] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:04.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:164:0) after 1m0s
[16:05:04.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:164:0)
[16:05:04.771] Timer tick, asking Buildbucket for the build status
[16:05:04.963] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:04.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:165:0) after 1m0s
[16:06:04.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:165:0)
[16:06:04.971] Timer tick, asking Buildbucket for the build status
[16:06:05.049] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:05.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:166:0) after 1m0s
[16:07:05.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:166:0)
[16:07:05.402] Timer tick, asking Buildbucket for the build status
[16:07:05.762] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:05.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:167:0) after 1m0s
[16:08:05.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:167:0)
[16:08:05.910] Timer tick, asking Buildbucket for the build status
[16:08:06.144] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:06.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:168:0) after 1m0s
[16:09:06.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:168:0)
[16:09:06.175] Timer tick, asking Buildbucket for the build status
[16:09:06.243] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:06.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:169:0) after 1m0s
[16:10:06.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:169:0)
[16:10:06.383] Timer tick, asking Buildbucket for the build status
[16:10:06.453] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:06.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:170:0) after 1m0s
[16:11:06.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:170:0)
[16:11:06.810] Timer tick, asking Buildbucket for the build status
[16:11:07.082] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:07.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:171:0) after 1m0s
[16:12:07.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:171:0)
[16:12:07.175] Timer tick, asking Buildbucket for the build status
[16:12:07.240] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:07.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:172:0) after 1m0s
[16:13:07.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:172:0)
[16:13:07.344] Timer tick, asking Buildbucket for the build status
[16:13:07.538] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:07.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:173:0) after 1m0s
[16:14:07.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:173:0)
[16:14:07.813] Timer tick, asking Buildbucket for the build status
[16:14:07.889] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:07.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:174:0) after 1m0s
[16:15:08.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:174:0)
[16:15:08.055] Timer tick, asking Buildbucket for the build status
[16:15:08.117] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:08.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:175:0) after 1m0s
[16:16:08.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:175:0)
[16:16:08.218] Timer tick, asking Buildbucket for the build status
[16:16:08.279] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:08.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:176:0) after 1m0s
[16:17:08.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:176:0)
[16:17:08.388] Timer tick, asking Buildbucket for the build status
[16:17:08.456] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:08.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:177:0) after 1m0s
[16:18:08.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:177:0)
[16:18:08.521] Timer tick, asking Buildbucket for the build status
[16:18:08.723] Build 8867003686256842704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:08.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032433748262287488:178:0) after 1m0s
[16:18:45.140] Received PubSub notification, asking Buildbucket for the build status
[16:18:45.223] Build 8867003686256842704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:18:45.223] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1602173924194765",
    "created_by": "project:infra",
    "created_ts": "1602163343145253",
    "id": "8867003686256842704",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4285.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f7d644b1-3e18-4714-9c43-a27135c60f4a\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4285.3\"}}",
    "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-j22x\"], \"image\": [\"chrome-xenial-20100400-30cd36dae64\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1602163347662409",
    "status": "COMPLETED",
    "status_changed_ts": "1602173924757369",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9032433748262287488",
      "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/8867003686256842704/+/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:4f213208b065a910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1602173924770767",
    "url": "https://ci.chromium.org/b/8867003686256842704",
    "utcnow_ts": "1602173925214746"
  }
}
[16:18:45.223] Invocation finished in 2h56m23.373687664s with status SUCCEEDED